2024-08-05 07:42:59.113926 | Job console starting...
2024-08-05 07:42:59.123700 | Updating repositories
2024-08-05 07:42:59.243651 | Preparing job workspace
2024-08-05 07:43:03.558296 | Running Ansible setup...
2024-08-05 07:43:08.616876 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2024-08-05 07:43:09.173963 | 
2024-08-05 07:43:09.174081 | PLAY [localhost]
2024-08-05 07:43:09.181566 | 
2024-08-05 07:43:09.181639 | TASK [Gathering Facts]
2024-08-05 07:43:10.107427 | localhost | ok
2024-08-05 07:43:10.133602 | 
2024-08-05 07:43:10.133751 | TASK [Setup log path fact]
2024-08-05 07:43:10.155866 | localhost | ok
2024-08-05 07:43:10.183079 | 
2024-08-05 07:43:10.183172 | TASK [set-zuul-log-path-fact : Set log path for a change]
2024-08-05 07:43:10.233955 | localhost | ok
2024-08-05 07:43:10.241740 | 
2024-08-05 07:43:10.241878 | TASK [set-zuul-log-path-fact : Set log path for a ref update]
2024-08-05 07:43:10.277832 | localhost | skipping: Conditional result was False
2024-08-05 07:43:10.286456 | 
2024-08-05 07:43:10.286598 | TASK [set-zuul-log-path-fact : Set log path for a periodic job]
2024-08-05 07:43:10.321838 | localhost | skipping: Conditional result was False
2024-08-05 07:43:10.331788 | 
2024-08-05 07:43:10.331987 | TASK [set-zuul-log-path-fact : Set log path for a change]
2024-08-05 07:43:10.357801 | localhost | skipping: Conditional result was False
2024-08-05 07:43:10.366840 | 
2024-08-05 07:43:10.367047 | TASK [set-zuul-log-path-fact : Set log path for a ref update]
2024-08-05 07:43:10.393189 | localhost | skipping: Conditional result was False
2024-08-05 07:43:10.402459 | 
2024-08-05 07:43:10.402606 | TASK [set-zuul-log-path-fact : Set log path for a periodic job]
2024-08-05 07:43:10.427441 | localhost | skipping: Conditional result was False
2024-08-05 07:43:10.448831 | 
2024-08-05 07:43:10.449030 | TASK [emit-job-header : Print job information]
2024-08-05 07:43:10.492731 | # Job Information
2024-08-05 07:43:10.492983 | Ansible Version: 2.15.12
2024-08-05 07:43:10.493046 | Job: integration-amazon.aws-1
2024-08-05 07:43:10.493086 | Pipeline: check
2024-08-05 07:43:10.493124 | Executor: ze04.softwarefactory-project.io
2024-08-05 07:43:10.493160 | Triggered by: https://github.com/ansible-collections/amazon.aws/pull/2211
2024-08-05 07:43:10.493204 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/11/2211/fd522070620168012fe4afade452eaf434f4e3e4/check/integration-amazon.aws-1/2cd1ff0/
2024-08-05 07:43:10.493242 | Event ID: bb4963c0-52fc-11ef-846b-647cb6279cb0
2024-08-05 07:43:10.500171 | 
2024-08-05 07:43:10.500298 | LOOP [emit-job-header : Print node information]
2024-08-05 07:43:10.598516 | localhost | ok:
2024-08-05 07:43:10.598739 | localhost | # Node Information
2024-08-05 07:43:10.598792 | localhost | Inventory Hostname: controller
2024-08-05 07:43:10.598831 | localhost | Hostname: ip-172-16-95-216
2024-08-05 07:43:10.598866 | localhost | Username: zuul-worker
2024-08-05 07:43:10.598936 | localhost | Distro: Fedora 36
2024-08-05 07:43:10.598973 | localhost | Provider: ansible-us-east-2
2024-08-05 07:43:10.599006 | localhost | Label: ansible-fedora-36-1vcpu
2024-08-05 07:43:10.599056 | localhost | Interface IP: 18.221.89.233
2024-08-05 07:43:10.613785 | 
2024-08-05 07:43:10.613966 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2024-08-05 07:43:10.964072 | localhost -> localhost | changed
2024-08-05 07:43:10.969055 | 
2024-08-05 07:43:10.969124 | TASK [log-inventory : Copy ansible inventory to logs dir]
2024-08-05 07:43:11.804595 | localhost -> localhost | changed
2024-08-05 07:43:11.842605 | 
2024-08-05 07:43:11.842737 | PLAY [all:!appliance*]
2024-08-05 07:43:11.870406 | 
2024-08-05 07:43:11.870485 | TASK [include_role : start-zuul-console]
2024-08-05 07:43:11.890195 | controller | ok
2024-08-05 07:43:11.905826 | 
2024-08-05 07:43:11.905922 | TASK [start-zuul-console : Start zuul_console daemon.]
2024-08-05 07:43:12.648077 | controller | ok
2024-08-05 07:43:12.669158 | 
2024-08-05 07:43:12.669325 | TASK [use-our-mirror : Retrieve the IP address]
2024-08-05 07:43:14.578426 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2024-08-05 07:43:14.592084 | 
2024-08-05 07:43:14.592246 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2024-08-05 07:43:14.752100 | controller | skipping: Conditional result was False
2024-08-05 07:43:14.764371 | 
2024-08-05 07:43:14.764543 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2024-08-05 07:43:14.789658 | controller | skipping: Conditional result was False
2024-08-05 07:43:14.801348 | 
2024-08-05 07:43:14.801559 | TASK [use-our-mirror : Create the podman configuration directory]
2024-08-05 07:43:14.826831 | controller | skipping: Conditional result was False
2024-08-05 07:43:14.839709 | 
2024-08-05 07:43:14.839868 | TASK [use-our-mirror : Copy the podman configuration]
2024-08-05 07:43:14.864998 | controller | skipping: Conditional result was False
2024-08-05 07:43:14.875978 | 
2024-08-05 07:43:14.876126 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2024-08-05 07:43:14.901197 | controller | skipping: Conditional result was False
2024-08-05 07:43:14.912439 | 
2024-08-05 07:43:14.912575 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2024-08-05 07:43:14.937510 | controller | skipping: Conditional result was False
2024-08-05 07:43:14.957323 | 
2024-08-05 07:43:14.957474 | TASK [Disable Fedora Modular]
2024-08-05 07:43:15.856117 | controller | changed
2024-08-05 07:43:15.867949 | 
2024-08-05 07:43:15.868111 | TASK [Enable EPEL]
2024-08-05 07:43:15.893595 | controller | skipping: Conditional result was False
2024-08-05 07:43:15.904551 | 
2024-08-05 07:43:15.904685 | TASK [Register the RHEL node]
2024-08-05 07:43:16.075241 | 
2024-08-05 07:43:16.075511 | TASK [Show the subscription-manager status]
2024-08-05 07:43:16.261950 | controller | skipping: Conditional result was False
2024-08-05 07:43:16.273950 | 
2024-08-05 07:43:16.274077 | TASK [Enable EPEL on RHEL]
2024-08-05 07:43:16.432079 | controller | skipping: Conditional result was False
2024-08-05 07:43:16.445334 | 
2024-08-05 07:43:16.445508 | TASK [Install git and tox]
2024-08-05 07:45:22.748229 | controller | changed
2024-08-05 07:45:22.754187 | 
2024-08-05 07:45:22.754245 | TASK [include_role : prepare-workspace]
2024-08-05 07:45:22.782252 | controller | ok
2024-08-05 07:45:22.800947 | 
2024-08-05 07:45:22.801026 | TASK [prepare-workspace : Start zuul_console daemon.]
2024-08-05 07:45:23.277512 | controller | ok
2024-08-05 07:45:23.286697 | 
2024-08-05 07:45:23.286780 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2024-08-05 07:45:42.485173 | controller | Output suppressed because no_log was given
2024-08-05 07:45:42.493714 | 
2024-08-05 07:45:42.493783 | TASK [include_role : prepare-workspace-openshift]
2024-08-05 07:45:42.510552 | controller | skipping: Conditional result was False
2024-08-05 07:45:42.530053 | 
2024-08-05 07:45:42.530134 | PLAY [all:!appliance]
2024-08-05 07:45:42.544713 | 
2024-08-05 07:45:42.544790 | TASK [Run add-build-sshkey role (RSA)]
2024-08-05 07:45:42.564400 | controller | ok
2024-08-05 07:45:42.578346 | 
2024-08-05 07:45:42.578428 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2024-08-05 07:45:42.827328 | controller -> localhost | ok
2024-08-05 07:45:42.841346 | 
2024-08-05 07:45:42.841485 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2024-08-05 07:45:42.877555 | controller | ok
2024-08-05 07:45:42.900640 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2024-08-05 07:45:42.908381 | 
2024-08-05 07:45:42.908465 | TASK [add-build-sshkey : Create Temp SSH key]
2024-08-05 07:45:43.421113 | controller -> localhost | Generating public/private rsa key pair.
2024-08-05 07:45:43.421441 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/2cd1ff0d017e46de8a26858d97a96309_id_rsa.
2024-08-05 07:45:43.421514 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/2cd1ff0d017e46de8a26858d97a96309_id_rsa.pub.
2024-08-05 07:45:43.421564 | controller -> localhost | The key fingerprint is:
2024-08-05 07:45:43.421605 | controller -> localhost | SHA256:ugMt0jbFN2p9VdtTPlfRtF2aq+jBN2jh15rX4ZlbRDM zuul-build-sshkey
2024-08-05 07:45:43.421644 | controller -> localhost | The key's randomart image is:
2024-08-05 07:45:43.421681 | controller -> localhost | +---[RSA 2048]----+
2024-08-05 07:45:43.421716 | controller -> localhost | |               o=|
2024-08-05 07:45:43.421753 | controller -> localhost | |              .oB|
2024-08-05 07:45:43.421789 | controller -> localhost | |     .       .oE=|
2024-08-05 07:45:43.421824 | controller -> localhost | |      o o   . .=*|
2024-08-05 07:45:43.421859 | controller -> localhost | |   . o +S...  . =|
2024-08-05 07:45:43.421928 | controller -> localhost | |  . * +..o.+ o o |
2024-08-05 07:45:43.421966 | controller -> localhost | |   o =.  .B = o.=|
2024-08-05 07:45:43.422000 | controller -> localhost | |      .. o + +.+o|
2024-08-05 07:45:43.422035 | controller -> localhost | |      ..  . o. ..|
2024-08-05 07:45:43.422069 | controller -> localhost | +----[SHA256]-----+
2024-08-05 07:45:43.422152 | controller -> localhost | ok: Runtime: 0:00:00.123489
2024-08-05 07:45:43.435052 | 
2024-08-05 07:45:43.435183 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2024-08-05 07:45:43.478586 | controller | ok
2024-08-05 07:45:43.497128 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2024-08-05 07:45:43.510305 | 
2024-08-05 07:45:43.510401 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2024-08-05 07:45:43.535562 | controller | skipping: Conditional result was False
2024-08-05 07:45:43.543518 | 
2024-08-05 07:45:43.543607 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2024-08-05 07:45:44.299925 | controller | changed
2024-08-05 07:45:44.307155 | 
2024-08-05 07:45:44.307220 | TASK [add-build-sshkey : Make sure user has a .ssh]
2024-08-05 07:45:44.658291 | controller | ok
2024-08-05 07:45:44.666260 | 
2024-08-05 07:45:44.666348 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2024-08-05 07:45:46.233432 | controller | changed
2024-08-05 07:45:46.238629 | 
2024-08-05 07:45:46.238692 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2024-08-05 07:45:47.734720 | controller | changed
2024-08-05 07:45:47.742687 | 
2024-08-05 07:45:47.742834 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2024-08-05 07:45:47.768170 | controller | skipping: Conditional result was False
2024-08-05 07:45:47.776215 | 
2024-08-05 07:45:47.776568 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2024-08-05 07:45:48.106588 | controller -> localhost | changed
2024-08-05 07:45:48.116994 | 
2024-08-05 07:45:48.117066 | TASK [add-build-sshkey : Add back temp key]
2024-08-05 07:45:48.386389 | controller -> localhost | Identity added: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/2cd1ff0d017e46de8a26858d97a96309_id_rsa (zuul-build-sshkey)
2024-08-05 07:45:48.386955 | controller -> localhost | ok: Runtime: 0:00:00.010536
2024-08-05 07:45:48.399656 | 
2024-08-05 07:45:48.399786 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2024-08-05 07:45:48.891920 | controller | ok
2024-08-05 07:45:48.902203 | 
2024-08-05 07:45:48.902337 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2024-08-05 07:45:48.938181 | controller | skipping: Conditional result was False
2024-08-05 07:45:48.960808 | 
2024-08-05 07:45:48.960980 | TASK [Run add-build-sshkey role (ECDSA)]
2024-08-05 07:45:48.996094 | controller | ok
2024-08-05 07:45:49.025143 | 
2024-08-05 07:45:49.025259 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2024-08-05 07:45:49.257059 | controller -> localhost | ok
2024-08-05 07:45:49.270525 | 
2024-08-05 07:45:49.270714 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2024-08-05 07:45:49.297681 | controller | ok
2024-08-05 07:45:49.319236 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2024-08-05 07:45:49.328286 | 
2024-08-05 07:45:49.328417 | TASK [add-build-sshkey : Create Temp SSH key]
2024-08-05 07:45:49.607963 | controller -> localhost | Generating public/private ecdsa key pair.
2024-08-05 07:45:49.608203 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/2cd1ff0d017e46de8a26858d97a96309_id_ecdsa.
2024-08-05 07:45:49.608255 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/2cd1ff0d017e46de8a26858d97a96309_id_ecdsa.pub.
2024-08-05 07:45:49.608294 | controller -> localhost | The key fingerprint is:
2024-08-05 07:45:49.608338 | controller -> localhost | SHA256:pvGDEnXO4h99WACFGGcyTAg6f/CsZTYxKEzNfAkoexA zuul-build-sshkey
2024-08-05 07:45:49.608375 | controller -> localhost | The key's randomart image is:
2024-08-05 07:45:49.608409 | controller -> localhost | +---[ECDSA 521]---+
2024-08-05 07:45:49.608442 | controller -> localhost | |Eo*o.+*o+o.      |
2024-08-05 07:45:49.608478 | controller -> localhost | |=o =.oo=..       |
2024-08-05 07:45:49.608511 | controller -> localhost | |=+o + . . .      |
2024-08-05 07:45:49.608543 | controller -> localhost | |.+.+ + +   .     |
2024-08-05 07:45:49.608573 | controller -> localhost | | .. X o S   .    |
2024-08-05 07:45:49.608605 | controller -> localhost | |   * + B . o     |
2024-08-05 07:45:49.608639 | controller -> localhost | |  . . + + o .    |
2024-08-05 07:45:49.608673 | controller -> localhost | |     . . o .     |
2024-08-05 07:45:49.608706 | controller -> localhost | |        .        |
2024-08-05 07:45:49.608739 | controller -> localhost | +----[SHA256]-----+
2024-08-05 07:45:49.608809 | controller -> localhost | ok: Runtime: 0:00:00.006659
2024-08-05 07:45:49.619318 | 
2024-08-05 07:45:49.619417 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2024-08-05 07:45:49.642282 | controller | ok
2024-08-05 07:45:49.653300 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2024-08-05 07:45:49.664501 | 
2024-08-05 07:45:49.664569 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2024-08-05 07:45:49.679429 | controller | skipping: Conditional result was False
2024-08-05 07:45:49.689616 | 
2024-08-05 07:45:49.689738 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2024-08-05 07:45:50.226466 | controller | changed
2024-08-05 07:45:50.238548 | 
2024-08-05 07:45:50.238727 | TASK [add-build-sshkey : Make sure user has a .ssh]
2024-08-05 07:45:50.591503 | controller | ok
2024-08-05 07:45:50.602787 | 
2024-08-05 07:45:50.602951 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2024-08-05 07:45:52.084646 | controller | changed
2024-08-05 07:45:52.091523 | 
2024-08-05 07:45:52.091619 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2024-08-05 07:45:53.511771 | controller | changed
2024-08-05 07:45:53.530459 | 
2024-08-05 07:45:53.530784 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2024-08-05 07:45:53.546022 | controller | skipping: Conditional result was False
2024-08-05 07:45:53.558497 | 
2024-08-05 07:45:53.558680 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2024-08-05 07:45:53.765433 | controller -> localhost | changed
2024-08-05 07:45:53.787947 | 
2024-08-05 07:45:53.788080 | TASK [add-build-sshkey : Add back temp key]
2024-08-05 07:45:54.016099 | controller -> localhost | Identity added: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/2cd1ff0d017e46de8a26858d97a96309_id_ecdsa (zuul-build-sshkey)
2024-08-05 07:45:54.016324 | controller -> localhost | ok: Runtime: 0:00:00.005876
2024-08-05 07:45:54.024340 | 
2024-08-05 07:45:54.024416 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2024-08-05 07:45:54.385953 | controller | ok
2024-08-05 07:45:54.396922 | 
2024-08-05 07:45:54.397073 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2024-08-05 07:45:54.432768 | controller | skipping: Conditional result was False
2024-08-05 07:45:54.456145 | 
2024-08-05 07:45:54.456434 | TASK [include_role : remove-zuul-sshkey]
2024-08-05 07:45:54.481538 | controller | skipping: Conditional result was False
2024-08-05 07:45:54.493651 | 
2024-08-05 07:45:54.493778 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2024-08-05 07:45:54.848642 | controller | ok: "logs"
2024-08-05 07:45:54.848947 | controller | ok: All items complete
2024-08-05 07:45:54.848990 | 
2024-08-05 07:45:55.214957 | controller | ok: "artifacts"
2024-08-05 07:45:55.512483 | controller | ok: "docs"
2024-08-05 07:45:55.529614 | 
2024-08-05 07:45:55.529792 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2024-08-05 07:45:55.924934 | controller | changed: "logs"
2024-08-05 07:45:56.451504 | controller | changed: "artifacts"
2024-08-05 07:45:56.847522 | controller | changed: "docs"
2024-08-05 07:45:56.896693 | 
2024-08-05 07:45:56.896780 | PLAY RECAP
2024-08-05 07:45:56.896824 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2024-08-05 07:45:56.896849 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2024-08-05 07:45:56.896868 | 
2024-08-05 07:45:57.032621 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2024-08-05 07:45:57.034050 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/ansible-core-ci/pre.yaml@master]
2024-08-05 07:45:57.543958 | 
2024-08-05 07:45:57.544080 | PLAY [controller]
2024-08-05 07:45:57.562934 | 
2024-08-05 07:45:57.563032 | TASK [Prepare the aws/sts session]
2024-08-05 07:45:57.584411 | controller | ok
2024-08-05 07:45:57.602276 | 
2024-08-05 07:45:57.602463 | TASK [ansible-core-ci-session : Ensure create_core_ci_session_key is set]
2024-08-05 07:45:57.673453 | controller | Output suppressed because no_log was given
2024-08-05 07:45:57.678528 | 
2024-08-05 07:45:57.678608 | TASK [ansible-core-ci-session : Create a new session]
2024-08-05 07:46:00.416663 | controller | Output suppressed because no_log was given
2024-08-05 07:46:00.460323 | 
2024-08-05 07:46:00.460450 | PLAY RECAP
2024-08-05 07:46:00.460506 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2024-08-05 07:46:00.460535 | 
2024-08-05 07:46:00.559578 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/ansible-core-ci/pre.yaml@master]
2024-08-05 07:46:00.561672 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2024-08-05 07:46:01.113864 | 
2024-08-05 07:46:01.114000 | PLAY [controller]
2024-08-05 07:46:01.133592 | 
2024-08-05 07:46:01.133734 | TASK [Create the /root directory]
2024-08-05 07:46:01.776282 | controller | ok
2024-08-05 07:46:01.784933 | 
2024-08-05 07:46:01.785061 | TASK [Install glibc-langpack-en]
2024-08-05 07:46:08.781339 | controller | ok: Nothing to do
2024-08-05 07:46:08.792705 | 
2024-08-05 07:46:08.792839 | TASK [Ensure controller directory exists]
2024-08-05 07:46:09.205301 | controller | changed
2024-08-05 07:46:09.217116 | 
2024-08-05 07:46:09.217308 | TASK [Install container runtime]
2024-08-05 07:46:09.273879 | controller | skipping: Conditional result was False
2024-08-05 07:46:09.290441 | 
2024-08-05 07:46:09.290652 | TASK [Ensure python3.8 is present]
2024-08-05 07:46:09.316612 | controller | skipping: Conditional result was False
2024-08-05 07:46:09.328358 | 
2024-08-05 07:46:09.328516 | TASK [Run our-ensure-python role (Fedora only for now)]
2024-08-05 07:46:09.355082 | controller | ok
2024-08-05 07:46:09.386565 | 
2024-08-05 07:46:09.386706 | TASK [our-ensure-python : Install the right Python version (rpm)]
2024-08-05 07:46:11.880044 | controller | ok: Nothing to do
2024-08-05 07:46:11.891333 | 
2024-08-05 07:46:11.891478 | TASK [our-ensure-python : Also install python3-devel]
2024-08-05 07:46:28.583401 | controller | changed
2024-08-05 07:46:28.602701 | 
2024-08-05 07:46:28.602974 | TASK [Run ensure-virtualenv role]
2024-08-05 07:46:28.626370 | controller | ok
2024-08-05 07:46:28.664639 | 
2024-08-05 07:46:28.664791 | TASK [ensure-virtualenv : Check if virtualenv is installed]
2024-08-05 07:46:29.206603 | controller | /usr/bin/virtualenv
2024-08-05 07:46:29.316082 | controller | ok: Runtime: 0:00:00.004493
2024-08-05 07:46:29.322612 | 
2024-08-05 07:46:29.322732 | LOOP [ensure-virtualenv : Install virtualenv package]
2024-08-05 07:46:29.343530 | controller | skipping: Conditional result was False
2024-08-05 07:46:29.368654 | 
2024-08-05 07:46:29.368773 | TASK [Setup base virtualenv_options]
2024-08-05 07:46:29.387679 | controller | ok
2024-08-05 07:46:29.392118 | 
2024-08-05 07:46:29.392194 | TASK [Create virtualenv for ansible-test]
2024-08-05 07:46:31.096727 | controller | created virtual environment CPython3.11.3.final.0-64 in 915ms
2024-08-05 07:46:31.141546 | controller |   creator CPython3Posix(dest=/home/zuul-worker/venv, clear=False, no_vcs_ignore=False, global=False)
2024-08-05 07:46:31.141605 | 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)
2024-08-05 07:46:31.141621 | controller |     added seed packages: pip==21.3.1, setuptools==59.6.0, wheel==0.37.1
2024-08-05 07:46:31.141631 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2024-08-05 07:46:31.534908 | controller | ok: Runtime: 0:00:01.251982
2024-08-05 07:46:31.541085 | 
2024-08-05 07:46:31.541154 | TASK [Set selinux package]
2024-08-05 07:46:31.569747 | controller | ok
2024-08-05 07:46:31.574734 | 
2024-08-05 07:46:31.574795 | TASK [Set selinux package (Fedora)]
2024-08-05 07:46:31.613014 | controller | ok
2024-08-05 07:46:31.617864 | 
2024-08-05 07:46:31.617937 | TASK [Install selinux into virtualenv]
2024-08-05 07:46:34.888205 | controller | Collecting selinux-please-lie-to-me
2024-08-05 07:46:35.051289 | controller |   Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB)
2024-08-05 07:46:35.922204 | controller | Collecting setuptools<50.0.0
2024-08-05 07:46:35.935571 | controller |   Downloading setuptools-49.6.0-py3-none-any.whl (803 kB)
2024-08-05 07:46:36.221671 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me
2024-08-05 07:46:36.221719 | controller |   Attempting uninstall: setuptools
2024-08-05 07:46:36.222034 | controller |     Found existing installation: setuptools 59.6.0
2024-08-05 07:46:36.284625 | controller |     Uninstalling setuptools-59.6.0:
2024-08-05 07:46:36.297095 | controller |       Successfully uninstalled setuptools-59.6.0
2024-08-05 07:46:37.177607 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0
2024-08-05 07:46:37.570749 | controller | WARNING: You are using pip version 21.3.1; however, version 24.2 is available.
2024-08-05 07:46:37.845329 | controller | You should consider upgrading via the '/home/zuul-worker/venv/bin/python -m pip install --upgrade pip' command.
2024-08-05 07:46:38.287282 | controller | ok: Runtime: 0:00:05.694251
2024-08-05 07:46:38.296636 | 
2024-08-05 07:46:38.296739 | TASK [Install pytest-forked into virtualenv]
2024-08-05 07:46:39.736146 | controller | Collecting pytest-forked
2024-08-05 07:46:39.890349 | controller |   Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB)
2024-08-05 07:46:39.977672 | controller | Collecting py
2024-08-05 07:46:39.990404 | controller |   Downloading py-1.11.0-py2.py3-none-any.whl (98 kB)
2024-08-05 07:46:40.353042 | controller | Collecting pytest>=3.10
2024-08-05 07:46:40.365659 | controller |   Downloading pytest-8.3.2-py3-none-any.whl (341 kB)
2024-08-05 07:46:40.605014 | controller | Collecting pluggy<2,>=1.5
2024-08-05 07:46:40.620455 | controller |   Downloading pluggy-1.5.0-py3-none-any.whl (20 kB)
2024-08-05 07:46:40.723871 | controller | Collecting packaging
2024-08-05 07:46:40.736551 | controller |   Downloading packaging-24.1-py3-none-any.whl (53 kB)
2024-08-05 07:46:40.778169 | controller | Collecting iniconfig
2024-08-05 07:46:40.792261 | controller |   Downloading iniconfig-2.0.0-py3-none-any.whl (5.9 kB)
2024-08-05 07:46:40.914358 | controller | Installing collected packages: pluggy, packaging, iniconfig, pytest, py, pytest-forked
2024-08-05 07:46:41.951770 | controller | Successfully installed iniconfig-2.0.0 packaging-24.1 pluggy-1.5.0 py-1.11.0 pytest-8.3.2 pytest-forked-1.6.0
2024-08-05 07:46:41.956512 | controller | WARNING: You are using pip version 21.3.1; however, version 24.2 is available.
2024-08-05 07:46:42.118228 | controller | You should consider upgrading via the '/home/zuul-worker/venv/bin/python -m pip install --upgrade pip' command.
2024-08-05 07:46:42.488425 | controller | ok: Runtime: 0:00:03.258111
2024-08-05 07:46:42.500668 | 
2024-08-05 07:46:42.500848 | TASK [Update pip]
2024-08-05 07:46:43.774372 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (21.3.1)
2024-08-05 07:46:44.134110 | controller | Collecting pip
2024-08-05 07:46:44.282336 | controller |   Downloading pip-24.2-py3-none-any.whl (1.8 MB)
2024-08-05 07:46:44.624925 | controller | Installing collected packages: pip
2024-08-05 07:46:44.625097 | controller |   Attempting uninstall: pip
2024-08-05 07:46:44.625512 | controller |     Found existing installation: pip 21.3.1
2024-08-05 07:46:44.879556 | controller |     Uninstalling pip-21.3.1:
2024-08-05 07:46:44.904798 | controller |       Successfully uninstalled pip-21.3.1
2024-08-05 07:46:47.182717 | controller | Successfully installed pip-24.2
2024-08-05 07:46:47.690980 | controller | ok: Runtime: 0:00:04.194387
2024-08-05 07:46:47.697640 | 
2024-08-05 07:46:47.697725 | TASK [Ensure pip temp directory exists in /var/tmp]
2024-08-05 07:46:48.205396 | controller | changed
2024-08-05 07:46:48.210365 | 
2024-08-05 07:46:48.210429 | TASK [Install ansible into virtualenv]
2024-08-05 07:46:49.445473 | controller | Processing ./src/github.com/ansible/ansible
2024-08-05 07:46:49.450188 | controller |   Installing build dependencies: started
2024-08-05 07:46:53.745636 | controller |   Installing build dependencies: finished with status 'done'
2024-08-05 07:46:54.764311 | controller |   Getting requirements to build wheel: started
2024-08-05 07:46:54.764375 | controller |   Getting requirements to build wheel: finished with status 'done'
2024-08-05 07:46:54.764849 | controller |   Preparing metadata (pyproject.toml): started
2024-08-05 07:46:55.794321 | controller |   Preparing metadata (pyproject.toml): finished with status 'done'
2024-08-05 07:46:56.045790 | controller | Collecting jinja2>=3.0.0 (from ansible-core==2.18.0.dev0)
2024-08-05 07:46:56.183616 | controller |   Downloading jinja2-3.1.4-py3-none-any.whl.metadata (2.6 kB)
2024-08-05 07:46:56.373513 | controller | Collecting PyYAML>=5.1 (from ansible-core==2.18.0.dev0)
2024-08-05 07:46:56.386902 | controller |   Downloading PyYAML-6.0.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (2.1 kB)
2024-08-05 07:46:56.829919 | controller | Collecting cryptography (from ansible-core==2.18.0.dev0)
2024-08-05 07:46:56.843280 | controller |   Downloading cryptography-43.0.0-cp39-abi3-manylinux_2_28_x86_64.whl.metadata (5.4 kB)
2024-08-05 07:46:56.936832 | controller | Requirement already satisfied: packaging in ./venv/lib/python3.11/site-packages (from ansible-core==2.18.0.dev0) (24.1)
2024-08-05 07:46:56.959989 | controller | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core==2.18.0.dev0)
2024-08-05 07:46:56.973273 | controller |   Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB)
2024-08-05 07:46:57.085438 | controller | Collecting MarkupSafe>=2.0 (from jinja2>=3.0.0->ansible-core==2.18.0.dev0)
2024-08-05 07:46:57.098561 | controller |   Downloading MarkupSafe-2.1.5-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (3.0 kB)
2024-08-05 07:46:57.411271 | controller | Collecting cffi>=1.12 (from cryptography->ansible-core==2.18.0.dev0)
2024-08-05 07:46:57.424508 | controller |   Downloading cffi-1.16.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB)
2024-08-05 07:46:57.539710 | controller | Collecting pycparser (from cffi>=1.12->cryptography->ansible-core==2.18.0.dev0)
2024-08-05 07:46:57.552409 | controller |   Downloading pycparser-2.22-py3-none-any.whl.metadata (943 bytes)
2024-08-05 07:46:57.576788 | controller | Downloading jinja2-3.1.4-py3-none-any.whl (133 kB)
2024-08-05 07:46:57.615970 | controller | Downloading PyYAML-6.0.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (757 kB)
2024-08-05 07:46:57.659187 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 757.7/757.7 kB 21.3 MB/s eta 0:00:00
2024-08-05 07:46:57.671843 | controller | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB)
2024-08-05 07:46:57.761303 | controller | Downloading cryptography-43.0.0-cp39-abi3-manylinux_2_28_x86_64.whl (4.0 MB)
2024-08-05 07:46:57.811176 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.0/4.0 MB 81.2 MB/s eta 0:00:00
2024-08-05 07:46:57.823573 | controller | Downloading cffi-1.16.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (464 kB)
2024-08-05 07:46:57.845992 | controller | Downloading MarkupSafe-2.1.5-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (28 kB)
2024-08-05 07:46:57.864635 | controller | Downloading pycparser-2.22-py3-none-any.whl (117 kB)
2024-08-05 07:46:57.989690 | controller | Building wheels for collected packages: ansible-core
2024-08-05 07:46:57.990660 | controller |   Building wheel for ansible-core (pyproject.toml): started
2024-08-05 07:46:59.645843 | controller |   Building wheel for ansible-core (pyproject.toml): finished with status 'done'
2024-08-05 07:46:59.654436 | controller |   Created wheel for ansible-core: filename=ansible_core-2.18.0.dev0-py3-none-any.whl size=2195076 sha256=c2971f50e32c237742407b0b2002db348bc6eb01d44df57cd5f6787e80ac7546
2024-08-05 07:46:59.654662 | controller |   Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-385jrf2i/wheels/4b/c7/fb/211bc3e71c1fd5de14b0b3794e0cabbc9c22afc0f39ed5cae6
2024-08-05 07:46:59.664051 | controller | Successfully built ansible-core
2024-08-05 07:46:59.692660 | controller | Installing collected packages: resolvelib, PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible-core
2024-08-05 07:47:03.996057 | controller | Successfully installed MarkupSafe-2.1.5 PyYAML-6.0.1 ansible-core-2.18.0.dev0 cffi-1.16.0 cryptography-43.0.0 jinja2-3.1.4 pycparser-2.22 resolvelib-1.0.1
2024-08-05 07:47:04.907952 | controller | ok: Runtime: 0:00:15.906176
2024-08-05 07:47:04.921477 | 
2024-08-05 07:47:04.921621 | TASK [Setup download-artifact-fork role]
2024-08-05 07:47:04.947840 | controller | ok
2024-08-05 07:47:04.983632 | 
2024-08-05 07:47:04.983773 | TASK [download-artifact-fork : Parse inventory response]
2024-08-05 07:47:05.035204 | controller | ok
2024-08-05 07:47:05.043334 | 
2024-08-05 07:47:05.043418 | TASK [download-artifact-fork : Fetch info from Zuul API]
2024-08-05 07:47:05.077824 | controller | skipping: Conditional result was False
2024-08-05 07:47:05.085781 | 
2024-08-05 07:47:05.085913 | TASK [download-artifact-fork : Parse build response]
2024-08-05 07:47:05.121120 | controller | skipping: Conditional result was False
2024-08-05 07:47:05.129403 | 
2024-08-05 07:47:05.129499 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2024-08-05 07:47:05.741565 | controller | changed
2024-08-05 07:47:05.749135 | 
2024-08-05 07:47:05.749237 | LOOP [download-artifact-fork : Download archive by type]
2024-08-05 07:47:05.795930 | controller | skipping: Conditional result was False
2024-08-05 07:47:05.796134 | 
2024-08-05 07:47:08.194145 | controller | changed: OK (2721927 bytes)
2024-08-05 07:47:09.827568 | controller | changed: OK (651877 bytes)
2024-08-05 07:47:12.003100 | controller | changed: OK (965872 bytes)
2024-08-05 07:47:13.754852 | controller | changed: OK (518395 bytes)
2024-08-05 07:47:15.408679 | controller | changed: OK (282703 bytes)
2024-08-05 07:47:16.804143 | controller | changed: OK (257790 bytes)
2024-08-05 07:47:18.305923 | controller | changed: OK (1099523 bytes)
2024-08-05 07:47:18.307920 | controller | skipping: Conditional result was False
2024-08-05 07:47:18.354907 | 
2024-08-05 07:47:18.355069 | TASK [deploy-artifacts : define __collections]
2024-08-05 07:47:18.386747 | controller | ok
2024-08-05 07:47:18.393821 | 
2024-08-05 07:47:18.393941 | LOOP [deploy-artifacts : Create list of collections]
2024-08-05 07:47:18.419028 | controller | skipping: Conditional result was False
2024-08-05 07:47:18.457070 | controller | ok:
2024-08-05 07:47:18.457193 | controller | {
2024-08-05 07:47:18.457226 | controller |   "branch": "main",
2024-08-05 07:47:18.457249 | controller |   "change": "2211",
2024-08-05 07:47:18.457271 | controller |   "job": "build-ansible-collection",
2024-08-05 07:47:18.457292 | controller |   "metadata": {
2024-08-05 07:47:18.457313 | controller |     "type": "ansible_collection",
2024-08-05 07:47:18.457334 | controller |     "version": "9.3.0"
2024-08-05 07:47:18.457354 | controller |   },
2024-08-05 07:47:18.457374 | controller |   "name": "community.general",
2024-08-05 07:47:18.457393 | controller |   "patchset": "fd522070620168012fe4afade452eaf434f4e3e4",
2024-08-05 07:47:18.457414 | controller |   "project": "ansible-collections/amazon.aws",
2024-08-05 07:47:18.457433 | controller |   "url": "https://7bfdacb47bb654aea4bb-f0b3b31045509da0c58e888320d2c820.ssl.cf5.rackcdn.com/2211/fd522070620168012fe4afade452eaf434f4e3e4/check/build-ansible-collection/0dc3b7f/artifacts/community-general-9.3.0.tar.gz"
2024-08-05 07:47:18.457454 | controller | }
2024-08-05 07:47:18.466784 | controller | ok:
2024-08-05 07:47:18.466859 | controller | {
2024-08-05 07:47:18.466921 | controller |   "branch": "main",
2024-08-05 07:47:18.466956 | controller |   "change": "2211",
2024-08-05 07:47:18.466977 | controller |   "job": "build-ansible-collection",
2024-08-05 07:47:18.466995 | controller |   "metadata": {
2024-08-05 07:47:18.467012 | controller |     "type": "ansible_collection",
2024-08-05 07:47:18.467047 | controller |     "version": "2.22.0"
2024-08-05 07:47:18.467065 | controller |   },
2024-08-05 07:47:18.467082 | controller |   "name": "community.crypto",
2024-08-05 07:47:18.467098 | controller |   "patchset": "fd522070620168012fe4afade452eaf434f4e3e4",
2024-08-05 07:47:18.467113 | controller |   "project": "ansible-collections/amazon.aws",
2024-08-05 07:47:18.467129 | controller |   "url": "https://7bfdacb47bb654aea4bb-f0b3b31045509da0c58e888320d2c820.ssl.cf5.rackcdn.com/2211/fd522070620168012fe4afade452eaf434f4e3e4/check/build-ansible-collection/0dc3b7f/artifacts/community-crypto-2.22.0.tar.gz"
2024-08-05 07:47:18.467145 | controller | }
2024-08-05 07:47:18.472199 | controller | ok:
2024-08-05 07:47:18.472360 | controller | {
2024-08-05 07:47:18.472400 | controller |   "branch": "main",
2024-08-05 07:47:18.472427 | controller |   "change": "2211",
2024-08-05 07:47:18.472451 | controller |   "job": "build-ansible-collection",
2024-08-05 07:47:18.472476 | controller |   "metadata": {
2024-08-05 07:47:18.472502 | controller |     "type": "ansible_collection",
2024-08-05 07:47:18.472528 | controller |     "version": "9.0.0"
2024-08-05 07:47:18.472552 | controller |   },
2024-08-05 07:47:18.472576 | controller |   "name": "community.aws",
2024-08-05 07:47:18.472598 | controller |   "patchset": "fd522070620168012fe4afade452eaf434f4e3e4",
2024-08-05 07:47:18.472632 | controller |   "project": "ansible-collections/amazon.aws",
2024-08-05 07:47:18.472656 | controller |   "url": "https://7bfdacb47bb654aea4bb-f0b3b31045509da0c58e888320d2c820.ssl.cf5.rackcdn.com/2211/fd522070620168012fe4afade452eaf434f4e3e4/check/build-ansible-collection/0dc3b7f/artifacts/community-aws-9.0.0.tar.gz"
2024-08-05 07:47:18.472680 | controller | }
2024-08-05 07:47:18.481521 | controller | ok:
2024-08-05 07:47:18.481628 | controller | {
2024-08-05 07:47:18.481661 | controller |   "branch": "main",
2024-08-05 07:47:18.481689 | controller |   "change": "2211",
2024-08-05 07:47:18.481715 | controller |   "job": "build-ansible-collection",
2024-08-05 07:47:18.481741 | controller |   "metadata": {
2024-08-05 07:47:18.481766 | controller |     "type": "ansible_collection",
2024-08-05 07:47:18.481792 | controller |     "version": "2.5.0"
2024-08-05 07:47:18.481817 | controller |   },
2024-08-05 07:47:18.481842 | controller |   "name": "ansible.windows",
2024-08-05 07:47:18.481868 | controller |   "patchset": "fd522070620168012fe4afade452eaf434f4e3e4",
2024-08-05 07:47:18.481918 | controller |   "project": "ansible-collections/amazon.aws",
2024-08-05 07:47:18.481947 | controller |   "url": "https://7bfdacb47bb654aea4bb-f0b3b31045509da0c58e888320d2c820.ssl.cf5.rackcdn.com/2211/fd522070620168012fe4afade452eaf434f4e3e4/check/build-ansible-collection/0dc3b7f/artifacts/ansible-windows-2.5.0.tar.gz"
2024-08-05 07:47:18.481974 | controller | }
2024-08-05 07:47:18.488699 | controller | ok:
2024-08-05 07:47:18.488793 | controller | {
2024-08-05 07:47:18.488825 | controller |   "branch": "main",
2024-08-05 07:47:18.488852 | controller |   "change": "2211",
2024-08-05 07:47:18.488877 | controller |   "job": "build-ansible-collection",
2024-08-05 07:47:18.488926 | controller |   "metadata": {
2024-08-05 07:47:18.488955 | controller |     "type": "ansible_collection",
2024-08-05 07:47:18.488980 | controller |     "version": "5.1.0"
2024-08-05 07:47:18.489004 | controller |   },
2024-08-05 07:47:18.489028 | controller |   "name": "ansible.utils",
2024-08-05 07:47:18.489053 | controller |   "patchset": "fd522070620168012fe4afade452eaf434f4e3e4",
2024-08-05 07:47:18.489078 | controller |   "project": "ansible-collections/amazon.aws",
2024-08-05 07:47:18.489103 | controller |   "url": "https://7bfdacb47bb654aea4bb-f0b3b31045509da0c58e888320d2c820.ssl.cf5.rackcdn.com/2211/fd522070620168012fe4afade452eaf434f4e3e4/check/build-ansible-collection/0dc3b7f/artifacts/ansible-utils-5.1.0.tar.gz"
2024-08-05 07:47:18.489128 | controller | }
2024-08-05 07:47:18.495670 | controller | ok:
2024-08-05 07:47:18.495739 | controller | {
2024-08-05 07:47:18.495770 | controller |   "branch": "main",
2024-08-05 07:47:18.495797 | controller |   "change": "2211",
2024-08-05 07:47:18.495823 | controller |   "job": "build-ansible-collection",
2024-08-05 07:47:18.495849 | controller |   "metadata": {
2024-08-05 07:47:18.495875 | controller |     "type": "ansible_collection",
2024-08-05 07:47:18.495925 | controller |     "version": "7.0.1-dev5"
2024-08-05 07:47:18.495955 | controller |   },
2024-08-05 07:47:18.495981 | controller |   "name": "ansible.netcommon",
2024-08-05 07:47:18.496006 | controller |   "patchset": "fd522070620168012fe4afade452eaf434f4e3e4",
2024-08-05 07:47:18.496032 | controller |   "project": "ansible-collections/amazon.aws",
2024-08-05 07:47:18.496058 | controller |   "url": "https://7bfdacb47bb654aea4bb-f0b3b31045509da0c58e888320d2c820.ssl.cf5.rackcdn.com/2211/fd522070620168012fe4afade452eaf434f4e3e4/check/build-ansible-collection/0dc3b7f/artifacts/ansible-netcommon-7.0.1-dev5.tar.gz"
2024-08-05 07:47:18.496084 | controller | }
2024-08-05 07:47:18.502586 | controller | ok:
2024-08-05 07:47:18.502648 | controller | {
2024-08-05 07:47:18.502680 | controller |   "branch": "main",
2024-08-05 07:47:18.502707 | controller |   "change": "2211",
2024-08-05 07:47:18.502733 | controller |   "job": "build-ansible-collection",
2024-08-05 07:47:18.502760 | controller |   "metadata": {
2024-08-05 07:47:18.502785 | controller |     "type": "ansible_collection",
2024-08-05 07:47:18.502820 | controller |     "version": "9.0.0"
2024-08-05 07:47:18.502847 | controller |   },
2024-08-05 07:47:18.502871 | controller |   "name": "amazon.aws",
2024-08-05 07:47:18.502920 | controller |   "patchset": "fd522070620168012fe4afade452eaf434f4e3e4",
2024-08-05 07:47:18.502949 | controller |   "project": "ansible-collections/amazon.aws",
2024-08-05 07:47:18.502974 | controller |   "url": "https://7bfdacb47bb654aea4bb-f0b3b31045509da0c58e888320d2c820.ssl.cf5.rackcdn.com/2211/fd522070620168012fe4afade452eaf434f4e3e4/check/build-ansible-collection/0dc3b7f/artifacts/amazon-aws-9.0.0.tar.gz"
2024-08-05 07:47:18.502997 | controller | }
2024-08-05 07:47:18.503600 | controller | skipping: Conditional result was False
2024-08-05 07:47:18.510939 | 
2024-08-05 07:47:18.511047 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2024-08-05 07:47:19.572052 | controller | [WARNING]: You are running the development version of Ansible. You should only
2024-08-05 07:47:27.352666 | controller | run Ansible from "devel" if you are modifying the Ansible engine, or trying out
2024-08-05 07:47:27.352719 | controller | features under development. This is a rapidly changing source of code and can
2024-08-05 07:47:27.352730 | controller | become unstable at any point.
2024-08-05 07:47:27.352747 | controller | Starting galaxy collection install process
2024-08-05 07:47:27.431457 | controller | Process install dependency map
2024-08-05 07:47:27.431509 | controller | Starting collection install process
2024-08-05 07:47:27.431525 | controller | Installing 'community.general:9.3.0' to '/home/zuul-worker/.ansible/collections/ansible_collections/community/general'
2024-08-05 07:47:27.431602 | controller | community.general:9.3.0 was installed successfully
2024-08-05 07:47:27.431613 | controller | Installing 'community.crypto:2.22.0' to '/home/zuul-worker/.ansible/collections/ansible_collections/community/crypto'
2024-08-05 07:47:27.431620 | controller | community.crypto:2.22.0 was installed successfully
2024-08-05 07:47:27.431626 | controller | Installing 'community.aws:9.0.0' to '/home/zuul-worker/.ansible/collections/ansible_collections/community/aws'
2024-08-05 07:47:27.431631 | controller | community.aws:9.0.0 was installed successfully
2024-08-05 07:47:27.431636 | controller | Installing 'ansible.windows:2.5.0' to '/home/zuul-worker/.ansible/collections/ansible_collections/ansible/windows'
2024-08-05 07:47:27.431641 | controller | ansible.windows:2.5.0 was installed successfully
2024-08-05 07:47:27.431647 | controller | Installing 'ansible.utils:5.1.0' to '/home/zuul-worker/.ansible/collections/ansible_collections/ansible/utils'
2024-08-05 07:47:27.431652 | controller | ansible.utils:5.1.0 was installed successfully
2024-08-05 07:47:27.431657 | controller | Installing 'ansible.netcommon:7.0.1-dev5' to '/home/zuul-worker/.ansible/collections/ansible_collections/ansible/netcommon'
2024-08-05 07:47:27.431662 | controller | ansible.netcommon:7.0.1-dev5 was installed successfully
2024-08-05 07:47:27.431667 | controller | Installing 'amazon.aws:9.0.0' to '/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws'
2024-08-05 07:47:27.431672 | controller | amazon.aws:9.0.0 was installed successfully
2024-08-05 07:47:27.705720 | controller | ok: Runtime: 0:00:08.419177
2024-08-05 07:47:27.734845 | 
2024-08-05 07:47:27.735069 | TASK [podman may need iptables kernel modules]
2024-08-05 07:47:28.885947 | controller | ok: Runtime: 0:00:00.092959
2024-08-05 07:47:28.928188 | 
2024-08-05 07:47:28.928357 | PLAY RECAP
2024-08-05 07:47:28.928439 | controller | ok: 22 changed: 13 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2024-08-05 07:47:28.928481 | 
2024-08-05 07:47:29.054698 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2024-08-05 07:47:29.055768 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-cloud/aws/pre.yaml@master]
2024-08-05 07:47:29.611521 | 
2024-08-05 07:47:29.611649 | PLAY [controller]
2024-08-05 07:47:29.630293 | 
2024-08-05 07:47:29.630429 | TASK [Install binary dependencies]
2024-08-05 07:47:29.651817 | controller | ok
2024-08-05 07:47:29.671526 | 
2024-08-05 07:47:29.671645 | TASK [bindep : Include find tasks]
2024-08-05 07:47:29.700382 | controller | ok
2024-08-05 07:47:29.708079 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2024-08-05 07:47:29.714901 | 
2024-08-05 07:47:29.714969 | TASK [bindep : Look for bindep.txt]
2024-08-05 07:47:30.489817 | controller | ok
2024-08-05 07:47:30.496146 | 
2024-08-05 07:47:30.496228 | TASK [bindep : Define bindep_file fact]
2024-08-05 07:47:30.525990 | controller | ok
2024-08-05 07:47:30.531343 | 
2024-08-05 07:47:30.531410 | TASK [bindep : Look for other-requirements.txt]
2024-08-05 07:47:30.554983 | controller | skipping: Conditional result was False
2024-08-05 07:47:30.560863 | 
2024-08-05 07:47:30.560942 | TASK [bindep : Define bindep_file fact]
2024-08-05 07:47:30.594593 | controller | skipping: Conditional result was False
2024-08-05 07:47:30.601540 | 
2024-08-05 07:47:30.601615 | TASK [bindep : Look for bindep fallback file]
2024-08-05 07:47:30.635783 | controller | skipping: Conditional result was False
2024-08-05 07:47:30.642135 | 
2024-08-05 07:47:30.642207 | TASK [bindep : Define bindep_file fact]
2024-08-05 07:47:30.665985 | controller | skipping: Conditional result was False
2024-08-05 07:47:30.678440 | 
2024-08-05 07:47:30.678579 | TASK [bindep : Include bindep tasks]
2024-08-05 07:47:30.714318 | controller | ok
2024-08-05 07:47:30.729349 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find-bindep.yaml
2024-08-05 07:47:30.743480 | 
2024-08-05 07:47:30.743701 | TASK [bindep : Look for bindep command]
2024-08-05 07:47:30.777966 | controller | skipping: Conditional result was False
2024-08-05 07:47:30.787757 | 
2024-08-05 07:47:30.787861 | TASK [bindep : Check for system bindep]
2024-08-05 07:47:31.931781 | controller | ok: Runtime: 0:00:00.013039
2024-08-05 07:47:31.944623 | 
2024-08-05 07:47:31.944805 | TASK [bindep : Define bindep_command fact]
2024-08-05 07:47:31.981349 | controller | skipping: Conditional result was False
2024-08-05 07:47:31.993723 | 
2024-08-05 07:47:31.993865 | TASK [bindep : Include install tasks]
2024-08-05 07:47:32.039275 | controller | ok
2024-08-05 07:47:32.054268 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/install.yaml
2024-08-05 07:47:32.070473 | 
2024-08-05 07:47:32.070554 | TASK [bindep : Create temp dir for bindep]
2024-08-05 07:47:32.733808 | controller | changed
2024-08-05 07:47:32.748402 | 
2024-08-05 07:47:32.748561 | TASK [Ensure we have pip dependencies]
2024-08-05 07:47:32.776321 | controller | ok
2024-08-05 07:47:32.818361 | 
2024-08-05 07:47:32.818501 | TASK [ensure-pip : Check if pip is installed]
2024-08-05 07:47:33.361819 | controller | /usr/bin/pip3
2024-08-05 07:47:33.389346 | controller | /usr/bin/python3: No module named wheel
2024-08-05 07:47:33.468135 | controller | ok: Runtime: 0:00:00.040484
2024-08-05 07:47:33.480325 | 
2024-08-05 07:47:33.480462 | LOOP [ensure-pip : Install pip from packages]
2024-08-05 07:47:33.526385 | controller | ok: "/var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml"
2024-08-05 07:47:33.589775 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml
2024-08-05 07:47:33.604137 | 
2024-08-05 07:47:33.604226 | TASK [ensure-pip : Install Python 3 pip]
2024-08-05 07:47:39.319580 | controller | changed
2024-08-05 07:47:39.332410 | 
2024-08-05 07:47:39.332610 | TASK [ensure-pip : Check for EPEL repository]
2024-08-05 07:47:39.390832 | controller | skipping: Conditional result was False
2024-08-05 07:47:39.404507 | 
2024-08-05 07:47:39.404717 | TASK [ensure-pip : Fail with instructions when EPEL is not installed]
2024-08-05 07:47:39.453491 | controller | skipping: Conditional result was False
2024-08-05 07:47:39.468924 | 
2024-08-05 07:47:39.469132 | TASK [ensure-pip : Install Python 2 pip]
2024-08-05 07:47:39.515843 | controller | skipping: Conditional result was False
2024-08-05 07:47:39.528499 | 
2024-08-05 07:47:39.528670 | TASK [ensure-pip : Ensure setuptools]
2024-08-05 07:47:39.546350 | controller | skipping: Conditional result was False
2024-08-05 07:47:39.560342 | 
2024-08-05 07:47:39.560635 | TASK [ensure-pip : Check for ensurepip module]
2024-08-05 07:47:39.711947 | controller | skipping: Conditional result was False
2024-08-05 07:47:39.725426 | 
2024-08-05 07:47:39.725577 | TASK [ensure-pip : Ensure python3-venv]
2024-08-05 07:47:39.751237 | controller | skipping: Conditional result was False
2024-08-05 07:47:39.765004 | 
2024-08-05 07:47:39.765187 | TASK [ensure-pip : Install pip from source]
2024-08-05 07:47:39.792919 | controller | skipping: Conditional result was False
2024-08-05 07:47:39.806397 | 
2024-08-05 07:47:39.806673 | TASK [ensure-pip : Probe for venv python full path]
2024-08-05 07:47:40.328831 | controller | /usr/bin/python3
2024-08-05 07:47:40.459420 | controller | ok: Runtime: 0:00:00.006500
2024-08-05 07:47:40.468853 | 
2024-08-05 07:47:40.469008 | TASK [ensure-pip : Set host default]
2024-08-05 07:47:40.552688 | controller | ok
2024-08-05 07:47:40.566820 | 
2024-08-05 07:47:40.567030 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2024-08-05 07:47:40.619976 | controller | ok
2024-08-05 07:47:40.634312 | 
2024-08-05 07:47:40.634400 | TASK [bindep : Install bindep into temporary venv]
2024-08-05 07:47:50.827112 | controller | changed
2024-08-05 07:47:50.839377 | 
2024-08-05 07:47:50.839520 | TASK [bindep : Define bindep_command]
2024-08-05 07:47:50.876455 | controller | ok
2024-08-05 07:47:50.887690 | 
2024-08-05 07:47:50.887824 | LOOP [bindep : Include package tasks]
2024-08-05 07:47:50.953080 | controller | ok: "src/github.com/ansible-collections/amazon.aws/bindep.txt"
2024-08-05 07:47:50.953301 | controller | ok: All items complete
2024-08-05 07:47:50.953329 | 
2024-08-05 07:47:50.972008 | controller | included: /var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/packages.yaml
2024-08-05 07:47:50.998112 | 
2024-08-05 07:47:50.998223 | TASK [bindep : Define bindep_run fact]
2024-08-05 07:47:51.019803 | controller | ok
2024-08-05 07:47:51.026791 | 
2024-08-05 07:47:51.026896 | TASK [bindep : Get list of packages to install from bindep]
2024-08-05 07:47:52.676104 | controller | ok: Runtime: 0:00:01.149941
2024-08-05 07:47:52.687868 | 
2024-08-05 07:47:52.688040 | TASK [bindep : Install distro packages from bindep]
2024-08-05 07:47:52.713202 | controller | skipping: Conditional result was False
2024-08-05 07:47:52.725253 | 
2024-08-05 07:47:52.725403 | TASK [bindep : Check that packages are installed]
2024-08-05 07:47:54.924127 | controller | ok: Runtime: 0:00:01.536851
2024-08-05 07:47:54.935952 | 
2024-08-05 07:47:54.936091 | TASK [bindep : Fail if we cannot install all packages]
2024-08-05 07:47:54.971952 | controller | skipping: Conditional result was False
2024-08-05 07:47:54.987138 | 
2024-08-05 07:47:54.987245 | TASK [Fetch the aws_session file from the controller]
2024-08-05 07:47:55.931617 | controller | changed
2024-08-05 07:47:55.937311 | 
2024-08-05 07:47:55.937399 | TASK [ansible-test-provider : Config the provider for ansible-test]
2024-08-05 07:47:58.199393 | controller | changed
2024-08-05 07:47:58.238939 | 
2024-08-05 07:47:58.239053 | TASK [bindep : Remove bindep temp dir]
2024-08-05 07:47:58.845327 | controller | ok
2024-08-05 07:47:58.868695 | 
2024-08-05 07:47:58.868847 | PLAY RECAP
2024-08-05 07:47:58.868972 | controller | ok: 22 changed: 7 unreachable: 0 failed: 0 skipped: 15 rescued: 0 ignored: 0
2024-08-05 07:47:58.869020 | 
2024-08-05 07:47:58.981155 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-cloud/aws/pre.yaml@master]
2024-08-05 07:47:58.983145 | RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2024-08-05 07:47:59.566187 | 
2024-08-05 07:47:59.566327 | PLAY [controller]
2024-08-05 07:47:59.588349 | 
2024-08-05 07:47:59.588475 | TASK [Copy the galaxy.yml on the controller]
2024-08-05 07:48:00.821784 | controller | changed
2024-08-05 07:48:00.833217 | 
2024-08-05 07:48:00.833370 | TASK [Load information from galaxy.yml]
2024-08-05 07:48:00.869118 | controller | ok
2024-08-05 07:48:00.879821 | 
2024-08-05 07:48:00.879991 | LOOP [Enable FIPS mode]
2024-08-05 07:48:00.917600 | 
2024-08-05 07:48:00.917861 | LOOP [ansible-test : Include branch specific variables.]
2024-08-05 07:48:00.964135 | controller | ok: "/var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/untrusted/project_0/github.com/ansible/ansible-zuul-jobs/roles/ansible-test/vars/default.yaml"
2024-08-05 07:48:00.965842 | 
2024-08-05 07:48:00.989659 | 
2024-08-05 07:48:00.989827 | TASK [ansible-test : Setup --skip-tags for test_options]
2024-08-05 07:48:01.046682 | controller | ok
2024-08-05 07:48:01.057261 | 
2024-08-05 07:48:01.057389 | TASK [ansible-test : Enable --inventory for network-integration]
2024-08-05 07:48:01.082964 | controller | skipping: Conditional result was False
2024-08-05 07:48:01.094393 | 
2024-08-05 07:48:01.094527 | TASK [ansible-test : Enable --retry-on-error]
2024-08-05 07:48:01.139786 | controller | ok
2024-08-05 07:48:01.150376 | 
2024-08-05 07:48:01.150511 | TASK [ansible-test : Enable --continue-on-error]
2024-08-05 07:48:01.195807 | controller | ok
2024-08-05 07:48:01.208234 | 
2024-08-05 07:48:01.208364 | TASK [ansible-test : Enable --requirements]
2024-08-05 07:48:01.253318 | controller | ok
2024-08-05 07:48:01.263795 | 
2024-08-05 07:48:01.263958 | TASK [ansible-test : Adjust options for unit tests]
2024-08-05 07:48:01.289760 | controller | skipping: Conditional result was False
2024-08-05 07:48:01.302085 | 
2024-08-05 07:48:01.302252 | TASK [ansible-test : Install requirements with unit tests]
2024-08-05 07:48:01.327425 | controller | skipping: Conditional result was False
2024-08-05 07:48:01.339362 | 
2024-08-05 07:48:01.339488 | TASK [ansible-test : Set --skip-test]
2024-08-05 07:48:01.364607 | controller | skipping: Conditional result was False
2024-08-05 07:48:01.376083 | 
2024-08-05 07:48:01.376213 | TASK [ansible-test : Reduce verbosity]
2024-08-05 07:48:01.401531 | controller | skipping: Conditional result was False
2024-08-05 07:48:01.408637 | 
2024-08-05 07:48:01.408698 | TASK [ansible-test : Setup --python option]
2024-08-05 07:48:01.549368 | controller | ok
2024-08-05 07:48:01.555868 | 
2024-08-05 07:48:01.555980 | TASK [ansible-test : Setup --docker option]
2024-08-05 07:48:01.580025 | controller | skipping: Conditional result was False
2024-08-05 07:48:01.588122 | 
2024-08-05 07:48:01.588221 | TASK [ansible-test : check if MANIFEST.json exists]
2024-08-05 07:48:02.407207 | controller | ok
2024-08-05 07:48:02.412249 | 
2024-08-05 07:48:02.412369 | TASK [ansible-test : Copy the MANIFEST.json on the controller]
2024-08-05 07:48:02.436311 | controller | skipping: Conditional result was False
2024-08-05 07:48:02.448670 | 
2024-08-05 07:48:02.448818 | TASK [ansible-test : Load information from MANIFEST.json]
2024-08-05 07:48:02.474817 | controller | skipping: Conditional result was False
2024-08-05 07:48:02.489751 | 
2024-08-05 07:48:02.489934 | TASK [ansible-test : Setup location of project for integration tests]
2024-08-05 07:48:02.515413 | controller | skipping: Conditional result was False
2024-08-05 07:48:02.527765 | 
2024-08-05 07:48:02.527927 | TASK [ansible-test : Copy the galaxy.yml on the controller]
2024-08-05 07:48:03.218436 | controller | ok
2024-08-05 07:48:03.229349 | 
2024-08-05 07:48:03.229477 | TASK [ansible-test : Load information from galaxy.yml]
2024-08-05 07:48:03.265233 | controller | ok
2024-08-05 07:48:03.279308 | 
2024-08-05 07:48:03.279441 | TASK [ansible-test : Setup location of project for integration tests]
2024-08-05 07:48:03.324834 | controller | ok
2024-08-05 07:48:03.335959 | 
2024-08-05 07:48:03.336102 | TASK [ansible-test : Setup minimum test requirements]
2024-08-05 07:48:03.384049 | controller | ok
2024-08-05 07:48:03.394814 | 
2024-08-05 07:48:03.394980 | TASK [ansible-test : Ensure pip temp directory exists in /var/tmp]
2024-08-05 07:48:04.001148 | controller | ok
2024-08-05 07:48:04.014216 | 
2024-08-05 07:48:04.014362 | TASK [ansible-test : Install python requirements]
2024-08-05 07:48:05.853184 | controller | Collecting botocore>=1.29.0 (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/requirements.txt (line 5))
2024-08-05 07:48:05.953884 | controller |   Downloading botocore-1.29.0-py3-none-any.whl.metadata (5.9 kB)
2024-08-05 07:48:06.482932 | controller | Collecting boto3>=1.26.0 (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/requirements.txt (line 6))
2024-08-05 07:48:06.495521 | controller |   Downloading boto3-1.26.0-py3-none-any.whl.metadata (7.0 kB)
2024-08-05 07:48:06.852421 | controller | Collecting coverage==4.5.4 (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 4))
2024-08-05 07:48:06.864691 | controller |   Downloading coverage-4.5.4.tar.gz (385 kB)
2024-08-05 07:48:07.025669 | controller |   Preparing metadata (setup.py): started
2024-08-05 07:48:07.324990 | controller |   Preparing metadata (setup.py): finished with status 'done'
2024-08-05 07:48:07.362410 | controller | Collecting placebo (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 5))
2024-08-05 07:48:07.375231 | controller |   Downloading placebo-0.10.0.tar.gz (15 kB)
2024-08-05 07:48:07.389617 | controller |   Preparing metadata (setup.py): started
2024-08-05 07:48:07.619664 | controller |   Preparing metadata (setup.py): finished with status 'done'
2024-08-05 07:48:07.644976 | controller | Collecting mock (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 6))
2024-08-05 07:48:07.656896 | controller |   Downloading mock-5.1.0-py3-none-any.whl.metadata (3.0 kB)
2024-08-05 07:48:07.664861 | controller | Requirement already satisfied: pytest in ./venv/lib/python3.11/site-packages (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 7)) (8.3.2)
2024-08-05 07:48:07.665358 | controller | Requirement already satisfied: pytest-forked in ./venv/lib/python3.11/site-packages (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 8)) (1.6.0)
2024-08-05 07:48:07.698298 | controller | Collecting pytest-mock (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 9))
2024-08-05 07:48:07.710583 | controller |   Downloading pytest_mock-3.14.0-py3-none-any.whl.metadata (3.8 kB)
2024-08-05 07:48:07.762471 | controller | Collecting pytest-xdist (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 10))
2024-08-05 07:48:07.774534 | controller |   Downloading pytest_xdist-3.6.1-py3-none-any.whl.metadata (4.3 kB)
2024-08-05 07:48:07.831306 | controller | Collecting pytest-ansible (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11))
2024-08-05 07:48:07.844208 | controller |   Downloading pytest_ansible-24.7.0-py3-none-any.whl.metadata (22 kB)
2024-08-05 07:48:07.884468 | controller | Collecting netaddr (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 14))
2024-08-05 07:48:07.896910 | controller |   Downloading netaddr-1.3.0-py3-none-any.whl.metadata (5.0 kB)
2024-08-05 07:48:08.686370 | controller | Collecting awscli (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 16))
2024-08-05 07:48:08.698810 | controller |   Downloading awscli-1.27.0-py3-none-any.whl.metadata (11 kB)
2024-08-05 07:48:08.709871 | controller | Requirement already satisfied: cryptography in ./venv/lib64/python3.11/site-packages (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 18)) (43.0.0)
2024-08-05 07:48:08.855741 | controller | Collecting virtualenv (from -r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/requirements.txt (line 7))
2024-08-05 07:48:08.868033 | controller |   Downloading virtualenv-20.26.3-py3-none-any.whl.metadata (4.5 kB)
2024-08-05 07:48:08.899873 | controller | Collecting jmespath<2.0.0,>=0.7.1 (from botocore>=1.29.0->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/requirements.txt (line 5))
2024-08-05 07:48:08.911771 | controller |   Downloading jmespath-1.0.1-py3-none-any.whl.metadata (7.6 kB)
2024-08-05 07:48:08.941874 | controller | Collecting python-dateutil<3.0.0,>=2.1 (from botocore>=1.29.0->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/requirements.txt (line 5))
2024-08-05 07:48:08.953932 | controller |   Downloading python_dateutil-2.9.0.post0-py2.py3-none-any.whl.metadata (8.4 kB)
2024-08-05 07:48:09.012966 | controller | Collecting urllib3<1.27,>=1.25.4 (from botocore>=1.29.0->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/requirements.txt (line 5))
2024-08-05 07:48:09.025077 | controller |   Downloading urllib3-1.26.19-py2.py3-none-any.whl.metadata (49 kB)
2024-08-05 07:48:09.241862 | controller | Collecting s3transfer<0.7.0,>=0.6.0 (from boto3>=1.26.0->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/requirements.txt (line 6))
2024-08-05 07:48:09.257844 | controller |   Downloading s3transfer-0.6.2-py3-none-any.whl.metadata (1.8 kB)
2024-08-05 07:48:09.270410 | controller | Requirement already satisfied: iniconfig in ./venv/lib/python3.11/site-packages (from pytest->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 7)) (2.0.0)
2024-08-05 07:48:09.270966 | controller | Requirement already satisfied: packaging in ./venv/lib/python3.11/site-packages (from pytest->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 7)) (24.1)
2024-08-05 07:48:09.271523 | controller | Requirement already satisfied: pluggy<2,>=1.5 in ./venv/lib/python3.11/site-packages (from pytest->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 7)) (1.5.0)
2024-08-05 07:48:09.272880 | controller | Requirement already satisfied: py in ./venv/lib/python3.11/site-packages (from pytest-forked->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 8)) (1.11.0)
2024-08-05 07:48:09.294533 | controller | Collecting execnet>=2.1 (from pytest-xdist->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 10))
2024-08-05 07:48:09.306526 | controller |   Downloading execnet-2.1.1-py3-none-any.whl.metadata (2.9 kB)
2024-08-05 07:48:09.317341 | controller | Requirement already satisfied: ansible-core>=2.14 in ./venv/lib/python3.11/site-packages (from pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11)) (2.18.0.dev0)
2024-08-05 07:48:09.344565 | controller | Collecting ansible-compat>=4.1.11 (from pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11))
2024-08-05 07:48:09.356656 | controller |   Downloading ansible_compat-24.7.0-py3-none-any.whl.metadata (2.9 kB)
2024-08-05 07:48:09.395753 | controller | Collecting docutils<0.17,>=0.10 (from awscli->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 16))
2024-08-05 07:48:09.407617 | controller |   Downloading docutils-0.16-py2.py3-none-any.whl.metadata (2.7 kB)
2024-08-05 07:48:09.455838 | controller | Collecting PyYAML<5.5,>=3.10 (from awscli->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 16))
2024-08-05 07:48:09.467964 | controller |   Downloading PyYAML-5.3.1.tar.gz (269 kB)
2024-08-05 07:48:09.627179 | controller |   Preparing metadata (setup.py): started
2024-08-05 07:48:09.901477 | controller |   Preparing metadata (setup.py): finished with status 'done'
2024-08-05 07:48:09.938580 | controller | Collecting colorama<0.4.5,>=0.2.5 (from awscli->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 16))
2024-08-05 07:48:09.951146 | controller |   Downloading colorama-0.4.4-py2.py3-none-any.whl.metadata (14 kB)
2024-08-05 07:48:09.997057 | controller | Collecting rsa<4.8,>=3.1.2 (from awscli->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 16))
2024-08-05 07:48:10.010753 | controller |   Downloading rsa-4.7.2-py3-none-any.whl.metadata (3.6 kB)
2024-08-05 07:48:10.027232 | controller | Requirement already satisfied: cffi>=1.12 in ./venv/lib64/python3.11/site-packages (from cryptography->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 18)) (1.16.0)
2024-08-05 07:48:10.049230 | controller | Collecting distlib<1,>=0.3.7 (from virtualenv->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/requirements.txt (line 7))
2024-08-05 07:48:10.061471 | controller |   Downloading distlib-0.3.8-py2.py3-none-any.whl.metadata (5.1 kB)
2024-08-05 07:48:10.118344 | controller | Collecting filelock<4,>=3.12.2 (from virtualenv->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/requirements.txt (line 7))
2024-08-05 07:48:10.131481 | controller |   Downloading filelock-3.15.4-py3-none-any.whl.metadata (2.9 kB)
2024-08-05 07:48:10.184388 | controller | Collecting platformdirs<5,>=3.9.1 (from virtualenv->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/requirements.txt (line 7))
2024-08-05 07:48:10.196611 | controller |   Downloading platformdirs-4.2.2-py3-none-any.whl.metadata (11 kB)
2024-08-05 07:48:10.228502 | controller | Collecting subprocess-tee>=0.4.1 (from ansible-compat>=4.1.11->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11))
2024-08-05 07:48:10.241753 | controller |   Downloading subprocess_tee-0.4.2-py3-none-any.whl.metadata (3.3 kB)
2024-08-05 07:48:10.339742 | controller | Collecting jsonschema>=4.6.0 (from ansible-compat>=4.1.11->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11))
2024-08-05 07:48:10.353158 | controller |   Downloading jsonschema-4.23.0-py3-none-any.whl.metadata (7.9 kB)
2024-08-05 07:48:10.370926 | controller | Requirement already satisfied: jinja2>=3.0.0 in ./venv/lib/python3.11/site-packages (from ansible-core>=2.14->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11)) (3.1.4)
2024-08-05 07:48:10.373790 | controller | Requirement already satisfied: resolvelib<1.1.0,>=0.5.3 in ./venv/lib/python3.11/site-packages (from ansible-core>=2.14->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11)) (1.0.1)
2024-08-05 07:48:10.377071 | controller | Requirement already satisfied: pycparser in ./venv/lib/python3.11/site-packages (from cffi>=1.12->cryptography->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 18)) (2.22)
2024-08-05 07:48:10.415474 | controller | Collecting six>=1.5 (from python-dateutil<3.0.0,>=2.1->botocore>=1.29.0->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/requirements.txt (line 5))
2024-08-05 07:48:10.428100 | controller |   Downloading six-1.16.0-py2.py3-none-any.whl.metadata (1.8 kB)
2024-08-05 07:48:10.488459 | controller | Collecting pyasn1>=0.1.3 (from rsa<4.8,>=3.1.2->awscli->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 16))
2024-08-05 07:48:10.501071 | controller |   Downloading pyasn1-0.6.0-py2.py3-none-any.whl.metadata (8.3 kB)
2024-08-05 07:48:10.831447 | controller | Requirement already satisfied: MarkupSafe>=2.0 in ./venv/lib64/python3.11/site-packages (from jinja2>=3.0.0->ansible-core>=2.14->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11)) (2.1.5)
2024-08-05 07:48:10.862737 | controller | Collecting attrs>=22.2.0 (from jsonschema>=4.6.0->ansible-compat>=4.1.11->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11))
2024-08-05 07:48:10.875092 | controller |   Downloading attrs-24.1.0-py3-none-any.whl.metadata (14 kB)
2024-08-05 07:48:10.922741 | controller | Collecting jsonschema-specifications>=2023.03.6 (from jsonschema>=4.6.0->ansible-compat>=4.1.11->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11))
2024-08-05 07:48:10.936558 | controller |   Downloading jsonschema_specifications-2023.12.1-py3-none-any.whl.metadata (3.0 kB)
2024-08-05 07:48:11.001730 | controller | Collecting referencing>=0.28.4 (from jsonschema>=4.6.0->ansible-compat>=4.1.11->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11))
2024-08-05 07:48:11.014000 | controller |   Downloading referencing-0.35.1-py3-none-any.whl.metadata (2.8 kB)
2024-08-05 07:48:11.584719 | controller | Collecting rpds-py>=0.7.1 (from jsonschema>=4.6.0->ansible-compat>=4.1.11->pytest-ansible->-r /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/test-requirements.txt (line 11))
2024-08-05 07:48:11.601858 | controller |   Downloading rpds_py-0.19.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (4.2 kB)
2024-08-05 07:48:11.750100 | controller | Downloading botocore-1.29.0-py3-none-any.whl (9.8 MB)
2024-08-05 07:48:12.160649 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 9.8/9.8 MB 24.8 MB/s eta 0:00:00
2024-08-05 07:48:12.173148 | controller | Downloading boto3-1.26.0-py3-none-any.whl (132 kB)
2024-08-05 07:48:12.193373 | controller | Downloading mock-5.1.0-py3-none-any.whl (30 kB)
2024-08-05 07:48:12.213107 | controller | Downloading pytest_mock-3.14.0-py3-none-any.whl (9.9 kB)
2024-08-05 07:48:12.235770 | controller | Downloading pytest_xdist-3.6.1-py3-none-any.whl (46 kB)
2024-08-05 07:48:12.256632 | controller | Downloading pytest_ansible-24.7.0-py3-none-any.whl (29 kB)
2024-08-05 07:48:12.276956 | controller | Downloading netaddr-1.3.0-py3-none-any.whl (2.3 MB)
2024-08-05 07:48:12.333275 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.3/2.3 MB 39.1 MB/s eta 0:00:00
2024-08-05 07:48:12.347537 | controller | Downloading awscli-1.27.0-py3-none-any.whl (3.9 MB)
2024-08-05 07:48:12.423574 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.9/3.9 MB 51.8 MB/s eta 0:00:00
2024-08-05 07:48:12.438003 | controller | Downloading virtualenv-20.26.3-py3-none-any.whl (5.7 MB)
2024-08-05 07:48:12.538421 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.7/5.7 MB 56.9 MB/s eta 0:00:00
2024-08-05 07:48:12.550956 | controller | Downloading ansible_compat-24.7.0-py3-none-any.whl (23 kB)
2024-08-05 07:48:12.570304 | controller | Downloading colorama-0.4.4-py2.py3-none-any.whl (16 kB)
2024-08-05 07:48:12.591345 | controller | Downloading distlib-0.3.8-py2.py3-none-any.whl (468 kB)
2024-08-05 07:48:12.616966 | controller | Downloading docutils-0.16-py2.py3-none-any.whl (548 kB)
2024-08-05 07:48:12.633552 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 548.2/548.2 kB 22.7 MB/s eta 0:00:00
2024-08-05 07:48:12.645831 | controller | Downloading execnet-2.1.1-py3-none-any.whl (40 kB)
2024-08-05 07:48:12.665876 | controller | Downloading filelock-3.15.4-py3-none-any.whl (16 kB)
2024-08-05 07:48:12.684138 | controller | Downloading jmespath-1.0.1-py3-none-any.whl (20 kB)
2024-08-05 07:48:12.710109 | controller | Downloading platformdirs-4.2.2-py3-none-any.whl (18 kB)
2024-08-05 07:48:12.730917 | controller | Downloading python_dateutil-2.9.0.post0-py2.py3-none-any.whl (229 kB)
2024-08-05 07:48:12.756073 | controller | Downloading rsa-4.7.2-py3-none-any.whl (34 kB)
2024-08-05 07:48:12.776563 | controller | Downloading s3transfer-0.6.2-py3-none-any.whl (79 kB)
2024-08-05 07:48:12.798328 | controller | Downloading urllib3-1.26.19-py2.py3-none-any.whl (143 kB)
2024-08-05 07:48:12.819503 | controller | Downloading jsonschema-4.23.0-py3-none-any.whl (88 kB)
2024-08-05 07:48:12.844987 | controller | Downloading pyasn1-0.6.0-py2.py3-none-any.whl (85 kB)
2024-08-05 07:48:12.869561 | controller | Downloading six-1.16.0-py2.py3-none-any.whl (11 kB)
2024-08-05 07:48:12.896553 | controller | Downloading subprocess_tee-0.4.2-py3-none-any.whl (5.2 kB)
2024-08-05 07:48:12.916798 | controller | Downloading attrs-24.1.0-py3-none-any.whl (63 kB)
2024-08-05 07:48:12.937825 | controller | Downloading jsonschema_specifications-2023.12.1-py3-none-any.whl (18 kB)
2024-08-05 07:48:12.957932 | controller | Downloading referencing-0.35.1-py3-none-any.whl (26 kB)
2024-08-05 07:48:12.979767 | controller | Downloading rpds_py-0.19.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (355 kB)
2024-08-05 07:48:13.324314 | controller | Building wheels for collected packages: coverage, placebo, PyYAML
2024-08-05 07:48:13.325193 | controller |   Building wheel for coverage (setup.py): started
2024-08-05 07:48:14.629599 | controller |   Building wheel for coverage (setup.py): finished with status 'done'
2024-08-05 07:48:14.631947 | controller |   Created wheel for coverage: filename=coverage-4.5.4-py3-none-any.whl size=170504 sha256=bf3da5dc965d3709d0d34c137430f2a9a7c3640690db6e1b05500ee274ccd96d
2024-08-05 07:48:14.632194 | controller |   Stored in directory: /home/zuul-worker/.cache/pip/wheels/6f/f1/7c/629d0a1f7e793d844bc1a53616036d92ab487e752d6c1425fb
2024-08-05 07:48:14.638070 | controller |   Building wheel for placebo (setup.py): started
2024-08-05 07:48:15.005624 | controller |   Building wheel for placebo (setup.py): finished with status 'done'
2024-08-05 07:48:15.006572 | controller |   Created wheel for placebo: filename=placebo-0.10.0-py3-none-any.whl size=14904 sha256=76b841c608d67fc7c4937f79d74c49c09b450367c3aaee9e4bd079e5e8ceb8a7
2024-08-05 07:48:15.006997 | controller |   Stored in directory: /home/zuul-worker/.cache/pip/wheels/e0/cd/b4/ed89ff73b0954631a484fbbf40946d7eadba00e9282c973f92
2024-08-05 07:48:15.010458 | controller |   Building wheel for PyYAML (setup.py): started
2024-08-05 07:48:15.544292 | controller |   Building wheel for PyYAML (setup.py): finished with status 'done'
2024-08-05 07:48:15.545283 | controller |   Created wheel for PyYAML: filename=PyYAML-5.3.1-cp311-cp311-linux_x86_64.whl size=44620 sha256=a8642a5d499275bb2de79f09aec21f45dd45be5516e2b3032ebce917bb7f0cf7
2024-08-05 07:48:15.545743 | controller |   Stored in directory: /home/zuul-worker/.cache/pip/wheels/93/d0/25/0923993e11f9273a21be3d272ca3dfe97c757a255a55c56bad
2024-08-05 07:48:15.548098 | controller | Successfully built coverage placebo PyYAML
2024-08-05 07:48:15.693149 | controller | Installing collected packages: placebo, distlib, urllib3, subprocess-tee, six, rpds-py, PyYAML, pyasn1, platformdirs, netaddr, mock, jmespath, filelock, execnet, docutils, coverage, colorama, attrs, virtualenv, rsa, referencing, python-dateutil, pytest-xdist, pytest-mock, jsonschema-specifications, botocore, s3transfer, jsonschema, boto3, awscli, ansible-compat, pytest-ansible
2024-08-05 07:48:16.039437 | controller |   Attempting uninstall: PyYAML
2024-08-05 07:48:16.041909 | controller |     Found existing installation: PyYAML 6.0.1
2024-08-05 07:48:16.046324 | controller |     Uninstalling PyYAML-6.0.1:
2024-08-05 07:48:16.047843 | controller |       Successfully uninstalled PyYAML-6.0.1
2024-08-05 07:48:21.218983 | controller | Successfully installed PyYAML-5.3.1 ansible-compat-24.7.0 attrs-24.1.0 awscli-1.27.0 boto3-1.26.0 botocore-1.29.0 colorama-0.4.4 coverage-4.5.4 distlib-0.3.8 docutils-0.16 execnet-2.1.1 filelock-3.15.4 jmespath-1.0.1 jsonschema-4.23.0 jsonschema-specifications-2023.12.1 mock-5.1.0 netaddr-1.3.0 placebo-0.10.0 platformdirs-4.2.2 pyasn1-0.6.0 pytest-ansible-24.7.0 pytest-mock-3.14.0 pytest-xdist-3.6.1 python-dateutil-2.9.0.post0 referencing-0.35.1 rpds-py-0.19.1 rsa-4.7.2 s3transfer-0.6.2 six-1.16.0 subprocess-tee-0.4.2 urllib3-1.26.19 virtualenv-20.26.3
2024-08-05 07:48:22.197540 | controller | ok: Runtime: 0:00:17.365522
2024-08-05 07:48:22.211949 | 
2024-08-05 07:48:22.212088 | TASK [ansible-test : Copy potential cloud provider configuration for ansible-test in the collection]
2024-08-05 07:48:22.783177 | controller | '/home/zuul-worker/src/github.com/ansible/ansible/test/integration/cloud-config-aws.ini' -> '/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/cloud-config-aws.ini'
2024-08-05 07:48:22.873340 | controller | ok: Runtime: 0:00:00.008146
2024-08-05 07:48:22.885441 | 
2024-08-05 07:48:22.885581 | TASK [ansible-test : Enable persistent connection logging]
2024-08-05 07:48:23.574955 | controller | changed: section and option added
2024-08-05 07:48:23.586774 | 
2024-08-05 07:48:23.586938 | TASK [ansible-test : Set persistent ssh_type value]
2024-08-05 07:48:24.123573 | controller | changed: option added
2024-08-05 07:48:24.135968 | 
2024-08-05 07:48:24.136105 | TASK [ansible-test : Set ansible log path]
2024-08-05 07:48:24.662279 | controller | changed: section and option added
2024-08-05 07:48:24.675417 | 
2024-08-05 07:48:24.675561 | TASK [ansible-test : Identify the changed targets]
2024-08-05 07:48:24.830580 | controller | skipping: Conditional result was False
2024-08-05 07:48:24.843113 | 
2024-08-05 07:48:24.843262 | TASK [ansible-test : set_fact]
2024-08-05 07:48:24.879744 | controller | skipping: Conditional result was False
2024-08-05 07:48:24.893391 | 
2024-08-05 07:48:24.893526 | TASK [ansible-test : Set the targets]
2024-08-05 07:48:24.929235 | controller | ok
2024-08-05 07:48:24.939944 | 
2024-08-05 07:48:24.940122 | TASK [ansible-test : set_fact]
2024-08-05 07:48:24.966724 | controller | skipping: Conditional result was False
2024-08-05 07:48:24.979977 | 
2024-08-05 07:48:24.980132 | TASK [ansible-test : List the targets]
2024-08-05 07:48:25.119065 | controller | skipping: Conditional result was False
2024-08-05 07:48:25.169021 | 
2024-08-05 07:48:25.169170 | TASK [ansible-test : set_fact]
2024-08-05 07:48:25.182755 | controller | skipping: Conditional result was False
2024-08-05 07:48:25.191177 | 
2024-08-05 07:48:25.191278 | TASK [ansible-test : set_fact]
2024-08-05 07:48:25.204957 | controller | skipping: Conditional result was False
2024-08-05 07:48:25.212830 | 
2024-08-05 07:48:25.212946 | LOOP [ansible-test : set_fact]
2024-08-05 07:48:25.254543 | 
2024-08-05 07:48:25.254695 | TASK [ansible-test : set_fact]
2024-08-05 07:48:25.268623 | controller | skipping: Conditional result was False
2024-08-05 07:48:25.276494 | 
2024-08-05 07:48:25.276585 | TASK [ansible-test : debug]
2024-08-05 07:48:25.290336 | controller | skipping: Conditional result was False
2024-08-05 07:48:25.297962 | 
2024-08-05 07:48:25.298046 | TASK [ansible-test : debug]
2024-08-05 07:48:25.328066 | About to run: ansible-test integration --diff --no-temp-workdir --skip-tags False --retry-on-error --continue-on-error --requirements --python 3.11 -vvvv lookup_secretsmanager_secret
2024-08-05 07:48:25.337614 | 
2024-08-05 07:48:25.337709 | TASK [ansible-test : Run the test suite]
2024-08-05 07:48:26.523194 | controller | Configured locale: en_US.UTF-8
2024-08-05 07:48:26.523325 | controller | RLIMIT_NOFILE: (1024, 524288)
2024-08-05 07:48:26.523375 | controller | Falling back to tests in "tests/integration/targets/" because "roles/test/" was not found.
2024-08-05 07:48:26.566652 | controller | Detected architecture x86_64 for Python interpreter: /home/zuul-worker/venv/bin/python
2024-08-05 07:48:26.572070 | controller | Run command: ssh-keygen -m PEM -q -t rsa -N '' -f /home/zuul-worker/.ansible/test/id_rsa
2024-08-05 07:48:26.572157 | controller | Working directory: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws
2024-08-05 07:48:26.572458 | controller | Program found: /usr/bin/ssh-keygen
2024-08-05 07:48:26.572506 | controller | HOME=/home/zuul-worker
2024-08-05 07:48:26.572534 | controller | LC_ALL=en_US.UTF-8
2024-08-05 07:48:26.572565 | controller | PATH=/home/zuul-worker/venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2024-08-05 07:48:28.114318 | controller | Command exited with status 0 after 1.541567087173462 seconds.
2024-08-05 07:48:28.117548 | controller | Using existing aws cloud config: tests/integration/cloud-config-aws.ini
2024-08-05 07:48:28.119336 | controller | Creating container database.
2024-08-05 07:48:28.121280 | controller | >>> Container Database
2024-08-05 07:48:28.121322 | controller | {}
2024-08-05 07:48:28.121340 | controller | >>> Requirements Commands
2024-08-05 07:48:28.121350 | controller | [
2024-08-05 07:48:28.121360 | controller |     [
2024-08-05 07:48:28.121370 | controller |         "install",
2024-08-05 07:48:28.121379 | controller |         {
2024-08-05 07:48:28.121452 | controller |             "requirements": [
2024-08-05 07:48:28.121467 | controller |                 [
2024-08-05 07:48:28.121478 | controller |                     "requirements/ansible.txt",
2024-08-05 07:48:28.121489 | controller |                     "# Note: this requirements.txt file is used to specify what dependencies are\n# needed to make the package run rather than for deployment of a tested set of\n# packages.  Thus, this should be the loosest set possible (only required\n# packages, not optional ones, and with the widest range of versions that could\n# be suitable)\njinja2 >= 3.0.0\nPyYAML >= 5.1  # PyYAML 5.1 is required for Python 3.8+ support\ncryptography\npackaging\n# NOTE: resolvelib 0.x version bumps should be considered major/breaking\n# NOTE: and we should update the upper cap with care, at least until 1.0\n# NOTE: Ref: https://github.com/sarugaku/resolvelib/issues/69\n# NOTE: When updating the upper bound, also update the latest version used\n# NOTE: in the ansible-galaxy-collection test suite.\nresolvelib >= 0.5.3, < 1.1.0  # dependency resolver used by ansible-galaxy\n"
2024-08-05 07:48:28.121507 | controller |                 ]
2024-08-05 07:48:28.121517 | controller |             ],
2024-08-05 07:48:28.121526 | controller |             "constraints": [
2024-08-05 07:48:28.121535 | controller |                 [
2024-08-05 07:48:28.121545 | controller |                     "requirements/constraints.txt",
2024-08-05 07:48:28.121555 | controller |                     "# do not add a cryptography or pyopenssl constraint to this file, they require special handling, see get_cryptography_requirements in python_requirements.py\n# do not add a coverage constraint to this file, it is handled internally by ansible-test\npypsrp < 1.0.0  # in case the next major version is too big of a change\npywinrm >= 0.4.3  # support for Python 3.11\npytest >= 4.5.0  # pytest 4.5.0 added support for --strict-markers\nntlm-auth >= 1.3.0 # message encryption support using cryptography\nrequests-ntlm >= 1.1.0 # message encryption support\nrequests-credssp >= 0.1.0 # message encryption support\nmock >= 2.0.0 # needed for features backported from Python 3.6 unittest.mock (assert_called, assert_called_once...)\npytest-mock >= 1.4.0 # needed for mock_use_standalone_module pytest option\ncffi == 1.17.0rc1 ; python_version >= '3.13' # temporary hack to support Python 3.13\npyyaml == 6.0.2rc1 ; python_version >= '3.13' # temporary hack to support Python 3.13\n"
2024-08-05 07:48:28.121571 | controller |                 ]
2024-08-05 07:48:28.121580 | controller |             ],
2024-08-05 07:48:28.121592 | controller |             "packages": []
2024-08-05 07:48:28.121601 | controller |         }
2024-08-05 07:48:28.121611 | controller |     ],
2024-08-05 07:48:28.121620 | controller |     [
2024-08-05 07:48:28.121683 | controller |         "install",
2024-08-05 07:48:28.121699 | controller |         {
2024-08-05 07:48:28.121711 | controller |             "requirements": [
2024-08-05 07:48:28.121721 | controller |                 [
2024-08-05 07:48:28.121731 | controller |                     "tests/integration/requirements.txt",
2024-08-05 07:48:28.121745 | controller |                     "# Our code is based on the AWS SDKs\nboto3\nbotocore\n\n# netaddr is needed for ansible.utils.ipv6\nnetaddr\nvirtualenv\n# Sometimes needed where we don't have features we need in modules\nawscli\n# Used for comparing SSH Public keys to the Amazon fingerprints\ncryptography\n"
2024-08-05 07:48:28.121756 | controller |                 ]
2024-08-05 07:48:28.121765 | controller |             ],
2024-08-05 07:48:28.121774 | controller |             "constraints": [
2024-08-05 07:48:28.121783 | controller |                 [
2024-08-05 07:48:28.121793 | controller |                     "tests/integration/constraints.txt",
2024-08-05 07:48:28.121802 | controller |                     "# Specifically run tests against the oldest versions that we support\nbotocore==1.29.0\nboto3==1.26.0\n\n# AWS CLI has `botocore==` dependencies, provide the one that matches botocore\n# to avoid needing to download over a years worth of awscli wheels.\nawscli==1.27.0\n\n# AWS CLI depends on PyYAML <5.5,>=3.10; the latest PyYAML release in that range, 5.4.1, fails to install.\n# Use a version in that range that is known to work (https://github.com/yaml/pyyaml/issues/736)\nPyYAML==5.3.1\n"
2024-08-05 07:48:28.121812 | controller |                 ],
2024-08-05 07:48:28.121823 | controller |                 [
2024-08-05 07:48:28.121832 | controller |                     "requirements/constraints.txt",
2024-08-05 07:48:28.121850 | controller |                     "# do not add a cryptography or pyopenssl constraint to this file, they require special handling, see get_cryptography_requirements in python_requirements.py\n# do not add a coverage constraint to this file, it is handled internally by ansible-test\npypsrp < 1.0.0  # in case the next major version is too big of a change\npywinrm >= 0.4.3  # support for Python 3.11\npytest >= 4.5.0  # pytest 4.5.0 added support for --strict-markers\nntlm-auth >= 1.3.0 # message encryption support using cryptography\nrequests-ntlm >= 1.1.0 # message encryption support\nrequests-credssp >= 0.1.0 # message encryption support\nmock >= 2.0.0 # needed for features backported from Python 3.6 unittest.mock (assert_called, assert_called_once...)\npytest-mock >= 1.4.0 # needed for mock_use_standalone_module pytest option\ncffi == 1.17.0rc1 ; python_version >= '3.13' # temporary hack to support Python 3.13\npyyaml == 6.0.2rc1 ; python_version >= '3.13' # temporary hack to support Python 3.13\n"
2024-08-05 07:48:28.121861 | controller |                 ]
2024-08-05 07:48:28.121870 | controller |             ],
2024-08-05 07:48:28.121879 | controller |             "packages": []
2024-08-05 07:48:28.121888 | controller |         }
2024-08-05 07:48:28.121897 | controller |     ]
2024-08-05 07:48:28.121906 | controller | ]
2024-08-05 07:48:28.121915 | controller | >>> Python Script from Template (/home/zuul-worker/venv/lib/python3.11/site-packages/ansible_test/_util/target/setup/requirements.py)
2024-08-05 07:48:28.121925 | controller | """A tool for installing test requirements on the controller and target host."""
2024-08-05 07:48:28.121935 | controller | from __future__ import annotations
2024-08-05 07:48:28.121944 | controller |
2024-08-05 07:48:28.121953 | controller | # pylint: disable=wrong-import-position
2024-08-05 07:48:28.121963 | controller |
2024-08-05 07:48:28.121972 | controller | import resource
2024-08-05 07:48:28.121981 | controller |
2024-08-05 07:48:28.121990 | controller | # Setting a low soft RLIMIT_NOFILE value will improve the performance of subprocess.Popen on Python 2.x when close_fds=True.
2024-08-05 07:48:28.122000 | controller | # This will affect all Python subprocesses. It will also affect the current Python process if set before subprocess is imported for the first time.
2024-08-05 07:48:28.122010 | controller | SOFT_RLIMIT_NOFILE = 1024
2024-08-05 07:48:28.122019 | controller |
2024-08-05 07:48:28.122028 | controller | CURRENT_RLIMIT_NOFILE = resource.getrlimit(resource.RLIMIT_NOFILE)
2024-08-05 07:48:28.122037 | controller | DESIRED_RLIMIT_NOFILE = (SOFT_RLIMIT_NOFILE, CURRENT_RLIMIT_NOFILE[1])
2024-08-05 07:48:28.122046 | controller |
2024-08-05 07:48:28.122055 | controller | if DESIRED_RLIMIT_NOFILE < CURRENT_RLIMIT_NOFILE:
2024-08-05 07:48:28.122069 | controller |     resource.setrlimit(resource.RLIMIT_NOFILE, DESIRED_RLIMIT_NOFILE)
2024-08-05 07:48:28.122078 | controller |     CURRENT_RLIMIT_NOFILE = DESIRED_RLIMIT_NOFILE
2024-08-05 07:48:28.122088 | controller |
2024-08-05 07:48:28.122097 | controller | import base64
2024-08-05 07:48:28.122106 | controller | import contextlib
2024-08-05 07:48:28.122115 | controller | import errno
2024-08-05 07:48:28.122124 | controller | import io
2024-08-05 07:48:28.122133 | controller | import json
2024-08-05 07:48:28.122142 | controller | import os
2024-08-05 07:48:28.122151 | controller | import shlex
2024-08-05 07:48:28.122160 | controller | import shutil
2024-08-05 07:48:28.122169 | controller | import subprocess
2024-08-05 07:48:28.122178 | controller | import sys
2024-08-05 07:48:28.122187 | controller | import tempfile
2024-08-05 07:48:28.122196 | controller | import typing as t
2024-08-05 07:48:28.122205 | controller | import urllib.request
2024-08-05 07:48:28.122214 | controller |
2024-08-05 07:48:28.122224 | controller | ENCODING = 'utf-8'
2024-08-05 07:48:28.122233 | controller |
2024-08-05 07:48:28.122837 | controller | Text = type(u'')
2024-08-05 07:48:28.122867 | controller |
2024-08-05 07:48:28.122878 | controller | VERBOSITY = 0
2024-08-05 07:48:28.122911 | controller | CONSOLE = sys.stderr
2024-08-05 07:48:28.122922 | controller |
2024-08-05 07:48:28.122930 | controller |
2024-08-05 07:48:28.122939 | controller | def main():  # type: () -> None
2024-08-05 07:48:28.122948 | controller |     """Main program entry point."""
2024-08-05 07:48:28.122958 | controller |     global VERBOSITY  # pylint: disable=global-statement
2024-08-05 07:48:28.122967 | controller |
2024-08-05 07:48:28.123053 | controller |     payload = json.loads(to_text(base64.b64decode(PAYLOAD)))
2024-08-05 07:48:28.123089 | controller |
2024-08-05 07:48:28.123099 | controller |     VERBOSITY = payload['verbosity']
2024-08-05 07:48:28.123107 | controller |
2024-08-05 07:48:28.123116 | controller |     script = payload['script']
2024-08-05 07:48:28.123127 | controller |     commands = payload['commands']
2024-08-05 07:48:28.123144 | controller |
2024-08-05 07:48:28.123179 | controller |     with tempfile.NamedTemporaryFile(prefix='ansible-test-', suffix='-pip.py') as pip:
2024-08-05 07:48:28.123188 | controller |         pip.write(to_bytes(script))
2024-08-05 07:48:28.123198 | controller |         pip.flush()
2024-08-05 07:48:28.123207 | controller |
2024-08-05 07:48:28.123216 | controller |         for name, options in commands:
2024-08-05 07:48:28.123225 | controller |             try:
2024-08-05 07:48:28.123273 | controller |                 globals()[name](pip.name, options)
2024-08-05 07:48:28.123294 | controller |             except ApplicationError as ex:
2024-08-05 07:48:28.123303 | controller |                 print(ex)
2024-08-05 07:48:28.123312 | controller |                 sys.exit(1)
2024-08-05 07:48:28.123320 | controller |
2024-08-05 07:48:28.123354 | controller |
2024-08-05 07:48:28.123363 | controller | # noinspection PyUnusedLocal
2024-08-05 07:48:28.123371 | controller | def bootstrap(pip, options):  # type: (str, t.Dict[str, t.Any]) -> None
2024-08-05 07:48:28.123380 | controller |     """Bootstrap pip and related packages in an empty virtual environment."""
2024-08-05 07:48:28.123524 | controller |     pip_version = options['pip_version']
2024-08-05 07:48:28.123567 | controller |     packages = options['packages']
2024-08-05 07:48:28.123578 | controller |
2024-08-05 07:48:28.123588 | controller |     url = 'https://ci-files.testing.ansible.com/ansible-test/get-pip-%s.py' % pip_version
2024-08-05 07:48:28.123597 | controller |     cache_path = os.path.expanduser('~/.ansible/test/cache/get_pip_%s.py' % pip_version.replace(".", "_"))
2024-08-05 07:48:28.123607 | controller |     temp_path = cache_path + '.download'
2024-08-05 07:48:28.123616 | controller |
2024-08-05 07:48:28.123625 | controller |     if os.path.exists(cache_path):
2024-08-05 07:48:28.123635 | controller |         log('Using cached pip %s bootstrap script: %s' % (pip_version, cache_path))
2024-08-05 07:48:28.123645 | controller |     else:
2024-08-05 07:48:28.123654 | controller |         log('Downloading pip %s bootstrap script: %s' % (pip_version, url))
2024-08-05 07:48:28.123663 | controller |
2024-08-05 07:48:28.123673 | controller |         make_dirs(os.path.dirname(cache_path))
2024-08-05 07:48:28.123682 | controller |
2024-08-05 07:48:28.123691 | controller |         try:
2024-08-05 07:48:28.123700 | controller |             download_file(url, temp_path)
2024-08-05 07:48:28.123709 | controller |         except Exception as ex:
2024-08-05 07:48:28.123719 | controller |             raise ApplicationError(('''
2024-08-05 07:48:28.123728 | controller | Download failed: %s
2024-08-05 07:48:28.123737 | controller |
2024-08-05 07:48:28.123746 | controller | The bootstrap script can be manually downloaded and saved to: %s
2024-08-05 07:48:28.123763 | controller |
2024-08-05 07:48:28.123773 | controller | If you're behind a proxy, consider commenting on the following GitHub issue:
2024-08-05 07:48:28.123783 | controller |
2024-08-05 07:48:28.123792 | controller | https://github.com/ansible/ansible/issues/77304
2024-08-05 07:48:28.123801 | controller | ''' % (ex, cache_path)).strip())
2024-08-05 07:48:28.123810 | controller |
2024-08-05 07:48:28.123819 | controller |         shutil.move(temp_path, cache_path)
2024-08-05 07:48:28.123829 | controller |
2024-08-05 07:48:28.123838 | controller |         log('Cached pip %s bootstrap script: %s' % (pip_version, cache_path))
2024-08-05 07:48:28.123847 | controller |
2024-08-05 07:48:28.123856 | controller |     env = common_pip_environment()
2024-08-05 07:48:28.123865 | controller |     env.update(GET_PIP=cache_path)
2024-08-05 07:48:28.123875 | controller |
2024-08-05 07:48:28.123884 | controller |     options = common_pip_options()
2024-08-05 07:48:28.123893 | controller |     options.extend(packages)
2024-08-05 07:48:28.123902 | controller |
2024-08-05 07:48:28.123912 | controller |     command = [sys.executable, pip] + options
2024-08-05 07:48:28.123921 | controller |
2024-08-05 07:48:28.123930 | controller |     execute_command(command, env=env)
2024-08-05 07:48:28.123939 | controller |
2024-08-05 07:48:28.123948 | controller |
2024-08-05 07:48:28.123957 | controller | def install(pip, options):  # type: (str, t.Dict[str, t.Any]) -> None
2024-08-05 07:48:28.123966 | controller |     """Perform a pip install."""
2024-08-05 07:48:28.123976 | controller |     requirements = options['requirements']
2024-08-05 07:48:28.123985 | controller |     constraints = options['constraints']
2024-08-05 07:48:28.123994 | controller |     packages = options['packages']
2024-08-05 07:48:28.124004 | controller |
2024-08-05 07:48:28.124013 | controller |     tempdir = tempfile.mkdtemp(prefix='ansible-test-', suffix='-requirements')
2024-08-05 07:48:28.124022 | controller |
2024-08-05 07:48:28.124031 | controller |     try:
2024-08-05 07:48:28.124065 | controller |         options = common_pip_options()
2024-08-05 07:48:28.124078 | controller |         options.extend(packages)
2024-08-05 07:48:28.124087 | controller |
2024-08-05 07:48:28.124347 | controller |         for path, content in requirements:
2024-08-05 07:48:28.124452 | controller |             if path.split(os.sep)[0] in ('test', 'requirements'):
2024-08-05 07:48:28.124466 | controller |                 # Support for pre-build is currently limited to requirements embedded in ansible-test and those used by ansible-core.
2024-08-05 07:48:28.124500 | controller |                 # Requirements from ansible-core can be found in the 'test' and 'requirements' directories.
2024-08-05 07:48:28.124513 | controller |                 # This feature will probably be extended to support collections after further testing.
2024-08-05 07:48:28.124522 | controller |                 # Requirements from collections can be found in the 'tests' directory.
2024-08-05 07:48:28.124531 | controller |                 for pre_build in parse_pre_build_instructions(content):
2024-08-05 07:48:28.124541 | controller |                     pre_build.execute(pip)
2024-08-05 07:48:28.124631 | controller |
2024-08-05 07:48:28.124644 | controller |             write_text_file(os.path.join(tempdir, path), content, True)
2024-08-05 07:48:28.124678 | controller |             options.extend(['-r', path])
2024-08-05 07:48:28.124688 | controller |
2024-08-05 07:48:28.124697 | controller |         for path, content in constraints:
2024-08-05 07:48:28.124706 | controller |             write_text_file(os.path.join(tempdir, path), content, True)
2024-08-05 07:48:28.124715 | controller |             options.extend(['-c', path])
2024-08-05 07:48:28.124725 | controller |
2024-08-05 07:48:28.124734 | controller |         command = [sys.executable, pip, 'install'] + options
2024-08-05 07:48:28.124743 | controller |
2024-08-05 07:48:28.124752 | controller |         env = common_pip_environment()
2024-08-05 07:48:28.124762 | controller |
2024-08-05 07:48:28.124771 | controller |         execute_command(command, env=env, cwd=tempdir)
2024-08-05 07:48:28.124788 | controller |     finally:
2024-08-05 07:48:28.124798 | controller |         remove_tree(tempdir)
2024-08-05 07:48:28.124807 | controller |
2024-08-05 07:48:28.124816 | controller |
2024-08-05 07:48:28.124825 | controller | class PreBuild:
2024-08-05 07:48:28.124835 | controller |     """Parsed pre-build instructions."""
2024-08-05 07:48:28.124844 | controller |
2024-08-05 07:48:28.124853 | controller |     def __init__(self, requirement):  # type: (str) -> None
2024-08-05 07:48:28.124862 | controller |         self.requirement = requirement
2024-08-05 07:48:28.124871 | controller |         self.constraints = []  # type: list[str]
2024-08-05 07:48:28.124885 | controller |
2024-08-05 07:48:28.124895 | controller |     def execute(self, pip):  # type: (str) -> None
2024-08-05 07:48:28.124905 | controller |         """Execute these pre-build instructions."""
2024-08-05 07:48:28.124914 | controller |         tempdir = tempfile.mkdtemp(prefix='ansible-test-', suffix='-pre-build')
2024-08-05 07:48:28.124924 | controller |
2024-08-05 07:48:28.124933 | controller |         try:
2024-08-05 07:48:28.124942 | controller |             options = common_pip_options()
2024-08-05 07:48:28.124951 | controller |             options.append(self.requirement)
2024-08-05 07:48:28.124960 | controller |
2024-08-05 07:48:28.124969 | controller |             constraints = '\n'.join(self.constraints) + '\n'
2024-08-05 07:48:28.124978 | controller |             constraints_path = os.path.join(tempdir, 'constraints.txt')
2024-08-05 07:48:28.124987 | controller |
2024-08-05 07:48:28.124997 | controller |             write_text_file(constraints_path, constraints, True)
2024-08-05 07:48:28.125006 | controller |
2024-08-05 07:48:28.125015 | controller |             env = common_pip_environment()
2024-08-05 07:48:28.125025 | controller |             env.update(PIP_CONSTRAINT=constraints_path)
2024-08-05 07:48:28.125034 | controller |
2024-08-05 07:48:28.125043 | controller |             command = [sys.executable, pip, 'wheel'] + options
2024-08-05 07:48:28.125052 | controller |
2024-08-05 07:48:28.125061 | controller |             execute_command(command, env=env, cwd=tempdir)
2024-08-05 07:48:28.125070 | controller |         finally:
2024-08-05 07:48:28.125080 | controller |             remove_tree(tempdir)
2024-08-05 07:48:28.125089 | controller |
2024-08-05 07:48:28.125098 | controller |
2024-08-05 07:48:28.125107 | controller | def parse_pre_build_instructions(requirements):  # type: (str) -> list[PreBuild]
2024-08-05 07:48:28.125116 | controller |     """Parse the given pip requirements and return a list of extracted pre-build instructions."""
2024-08-05 07:48:28.125126 | controller |     # CAUTION: This code must be kept in sync with the sanity test hashing code in:
2024-08-05 07:48:28.125135 | controller |     #          test/lib/ansible_test/_internal/commands/sanity/__init__.py
2024-08-05 07:48:28.125144 | controller |
2024-08-05 07:48:28.125153 | controller |     pre_build_prefix = '# pre-build '
2024-08-05 07:48:28.125162 | controller |     pre_build_requirement_prefix = pre_build_prefix + 'requirement: '
2024-08-05 07:48:28.125172 | controller |     pre_build_constraint_prefix = pre_build_prefix + 'constraint: '
2024-08-05 07:48:28.125181 | controller |
2024-08-05 07:48:28.125190 | controller |     lines = requirements.splitlines()
2024-08-05 07:48:28.125200 | controller |     pre_build_lines = [line for line in lines if line.startswith(pre_build_prefix)]
2024-08-05 07:48:28.125208 | controller |
2024-08-05 07:48:28.125218 | controller |     instructions = []  # type: list[PreBuild]
2024-08-05 07:48:28.125227 | controller |
2024-08-05 07:48:28.125236 | controller |     for line in pre_build_lines:
2024-08-05 07:48:28.125260 | controller |         if line.startswith(pre_build_requirement_prefix):
2024-08-05 07:48:28.125270 | controller |             instructions.append(PreBuild(line[len(pre_build_requirement_prefix):]))
2024-08-05 07:48:28.125279 | controller |         elif line.startswith(pre_build_constraint_prefix):
2024-08-05 07:48:28.125288 | controller |             instructions[-1].constraints.append(line[len(pre_build_constraint_prefix):])
2024-08-05 07:48:28.125297 | controller |         else:
2024-08-05 07:48:28.125307 | controller |             raise RuntimeError('Unsupported pre-build comment: ' + line)
2024-08-05 07:48:28.125316 | controller |
2024-08-05 07:48:28.125325 | controller |     return instructions
2024-08-05 07:48:28.125398 | controller |
2024-08-05 07:48:28.125408 | controller |
2024-08-05 07:48:28.125417 | controller | def uninstall(pip, options):  # type: (str, t.Dict[str, t.Any]) -> None
2024-08-05 07:48:28.125426 | controller |     """Perform a pip uninstall."""
2024-08-05 07:48:28.125436 | controller |     packages = options['packages']
2024-08-05 07:48:28.125445 | controller |     ignore_errors = options['ignore_errors']
2024-08-05 07:48:28.125454 | controller |
2024-08-05 07:48:28.125464 | controller |     options = common_pip_options()
2024-08-05 07:48:28.125473 | controller |     options.extend(packages)
2024-08-05 07:48:28.125482 | controller |
2024-08-05 07:48:28.125492 | controller |     command = [sys.executable, pip, 'uninstall', '-y'] + options
2024-08-05 07:48:28.125501 | controller |
2024-08-05 07:48:28.125510 | controller |     env = common_pip_environment()
2024-08-05 07:48:28.125520 | controller |
2024-08-05 07:48:28.125529 | controller |     try:
2024-08-05 07:48:28.125538 | controller |         execute_command(command, env=env, capture=True)
2024-08-05 07:48:28.125552 | controller |     except SubprocessError:
2024-08-05 07:48:28.125562 | controller |         if not ignore_errors:
2024-08-05 07:48:28.125571 | controller |             raise
2024-08-05 07:48:28.125580 | controller |
2024-08-05 07:48:28.125589 | controller |
2024-08-05 07:48:28.125599 | controller | # noinspection PyUnusedLocal
2024-08-05 07:48:28.125608 | controller | def version(pip, options):  # type: (str, t.Dict[str, t.Any]) -> None
2024-08-05 07:48:28.125617 | controller |     """Report the pip version."""
2024-08-05 07:48:28.125627 | controller |     del options
2024-08-05 07:48:28.125671 | controller |
2024-08-05 07:48:28.125686 | controller |     options = common_pip_options()
2024-08-05 07:48:28.125698 | controller |
2024-08-05 07:48:28.125707 | controller |     command = [sys.executable, pip, '-V'] + options
2024-08-05 07:48:28.125717 | controller |
2024-08-05 07:48:28.125726 | controller |     env = common_pip_environment()
2024-08-05 07:48:28.125736 | controller |
2024-08-05 07:48:28.125745 | controller |     execute_command(command, env=env, capture=True)
2024-08-05 07:48:28.125754 | controller |
2024-08-05 07:48:28.125763 | controller |
2024-08-05 07:48:28.125782 | controller | def common_pip_environment():  # type: () -> t.Dict[str, str]
2024-08-05 07:48:28.125792 | controller |     """Return common environment variables used to run pip."""
2024-08-05 07:48:28.125801 | controller |     env = os.environ.copy()
2024-08-05 07:48:28.125810 | controller |
2024-08-05 07:48:28.125819 | controller |     # When ansible-test installs requirements outside a virtual environment, it does so under one of two conditions:
2024-08-05 07:48:28.125828 | controller |     # 1) The environment is an ephemeral one provisioned by ansible-test.
2024-08-05 07:48:28.125837 | controller |     # 2) The user has provided the `--requirements` option to force installation of requirements.
2024-08-05 07:48:28.125847 | controller |     # It seems reasonable to bypass PEP 668 checks in both of these cases.
2024-08-05 07:48:28.125856 | controller |     # Doing so with an environment variable allows it to work under any version of pip which supports it, without breaking older versions.
2024-08-05 07:48:28.125866 | controller |     # NOTE: pip version 23.0 enforces PEP 668 but does not support the override, in which case upgrading pip is required.
2024-08-05 07:48:28.125875 | controller |     env.update(PIP_BREAK_SYSTEM_PACKAGES='1')
2024-08-05 07:48:28.125884 | controller |
2024-08-05 07:48:28.125893 | controller |     return env
2024-08-05 07:48:28.125906 | controller |
2024-08-05 07:48:28.125915 | controller |
2024-08-05 07:48:28.125924 | controller | def common_pip_options():  # type: () -> t.List[str]
2024-08-05 07:48:28.125934 | controller |     """Return a list of common pip options."""
2024-08-05 07:48:28.125948 | controller |     return [
2024-08-05 07:48:28.125957 | controller |         '--disable-pip-version-check',
2024-08-05 07:48:28.125966 | controller |     ]
2024-08-05 07:48:28.125976 | controller |
2024-08-05 07:48:28.125985 | controller |
2024-08-05 07:48:28.125994 | controller | def devnull():  # type: () -> t.IO[bytes]
2024-08-05 07:48:28.126003 | controller |     """Return a file object that references devnull."""
2024-08-05 07:48:28.126012 | controller |     try:
2024-08-05 07:48:28.126021 | controller |         return devnull.file
2024-08-05 07:48:28.126031 | controller |     except AttributeError:
2024-08-05 07:48:28.126040 | controller |         devnull.file = open(os.devnull, 'w+b')  # pylint: disable=consider-using-with
2024-08-05 07:48:28.126049 | controller |
2024-08-05 07:48:28.126058 | controller |     return devnull.file
2024-08-05 07:48:28.126068 | controller |
2024-08-05 07:48:28.126077 | controller |
2024-08-05 07:48:28.126086 | controller | def download_file(url, path):  # type: (str, str) -> None
2024-08-05 07:48:28.126097 | controller |     """Download the given URL to the specified file path."""
2024-08-05 07:48:28.126106 | controller |     with open(to_bytes(path), 'wb') as saved_file:
2024-08-05 07:48:28.126115 | controller |         with contextlib.closing(urllib.request.urlopen(url)) as download:
2024-08-05 07:48:28.126125 | controller |             shutil.copyfileobj(download, saved_file)
2024-08-05 07:48:28.126134 | controller |
2024-08-05 07:48:28.126143 | controller |
2024-08-05 07:48:28.126152 | controller | class ApplicationError(Exception):
2024-08-05 07:48:28.126165 | controller |     """Base class for application exceptions."""
2024-08-05 07:48:28.126175 | controller |
2024-08-05 07:48:28.126184 | controller |
2024-08-05 07:48:28.126193 | controller | class SubprocessError(ApplicationError):
2024-08-05 07:48:28.126202 | controller |     """A command returned a non-zero status."""
2024-08-05 07:48:28.126211 | controller |     def __init__(self, cmd, status, stdout, stderr):  # type: (t.List[str], int, str, str) -> None
2024-08-05 07:48:28.126224 | controller |         message = 'A command failed with status %d: %s' % (status, shlex.join(cmd))
2024-08-05 07:48:28.126234 | controller |
2024-08-05 07:48:28.126255 | controller |         if stderr:
2024-08-05 07:48:28.126265 | controller |             message += '\n>>> Standard Error\n%s' % stderr.strip()
2024-08-05 07:48:28.126275 | controller |
2024-08-05 07:48:28.126284 | controller |         if stdout:
2024-08-05 07:48:28.126293 | controller |             message += '\n>>> Standard Output\n%s' % stdout.strip()
2024-08-05 07:48:28.126302 | controller |
2024-08-05 07:48:28.126311 | controller |         super(SubprocessError, self).__init__(message)
2024-08-05 07:48:28.126320 | controller |
2024-08-05 07:48:28.126329 | controller |
2024-08-05 07:48:28.126338 | controller | def log(message, verbosity=0):  # type: (str, int) -> None
2024-08-05 07:48:28.126348 | controller |     """Log a message to the console if the verbosity is high enough."""
2024-08-05 07:48:28.126356 | controller |     if verbosity > VERBOSITY:
2024-08-05 07:48:28.126424 | controller |         return
2024-08-05 07:48:28.126513 | controller |
2024-08-05 07:48:28.126531 | controller |     print(message, file=CONSOLE)
2024-08-05 07:48:28.126543 | controller |     CONSOLE.flush()
2024-08-05 07:48:28.126552 | controller |
2024-08-05 07:48:28.126561 | controller |
2024-08-05 07:48:28.126571 | controller | def execute_command(cmd, cwd=None, capture=False, env=None):  # type: (t.List[str], t.Optional[str], bool, t.Optional[t.Dict[str, str]]) -> None
2024-08-05 07:48:28.126581 | controller |     """Execute the specified command."""
2024-08-05 07:48:28.126590 | controller |     log('Execute command: %s' % shlex.join(cmd), verbosity=1)
2024-08-05 07:48:28.126600 | controller |
2024-08-05 07:48:28.126609 | controller |     cmd_bytes = [to_bytes(c) for c in cmd]
2024-08-05 07:48:28.126618 | controller |
2024-08-05 07:48:28.126627 | controller |     if capture:
2024-08-05 07:48:28.126636 | controller |         stdout = subprocess.PIPE
2024-08-05 07:48:28.126645 | controller |         stderr = subprocess.PIPE
2024-08-05 07:48:28.126655 | controller |     else:
2024-08-05 07:48:28.126664 | controller |         stdout = None
2024-08-05 07:48:28.126673 | controller |         stderr = None
2024-08-05 07:48:28.126682 | controller |
2024-08-05 07:48:28.126691 | controller |     cwd_bytes = to_optional_bytes(cwd)
2024-08-05 07:48:28.126700 | controller |     process = subprocess.Popen(cmd_bytes, cwd=cwd_bytes, stdin=devnull(), stdout=stdout, stderr=stderr, env=env)  # pylint: disable=consider-using-with
2024-08-05 07:48:28.126714 | controller |     stdout_bytes, stderr_bytes = process.communicate()
2024-08-05 07:48:28.126723 | controller |     stdout_text = to_optional_text(stdout_bytes) or u''
2024-08-05 07:48:28.126733 | controller |     stderr_text = to_optional_text(stderr_bytes) or u''
2024-08-05 07:48:28.126742 | controller |
2024-08-05 07:48:28.126752 | controller |     if process.returncode != 0:
2024-08-05 07:48:28.126761 | controller |         raise SubprocessError(cmd, process.returncode, stdout_text, stderr_text)
2024-08-05 07:48:28.126770 | controller |
2024-08-05 07:48:28.126779 | controller |
2024-08-05 07:48:28.126789 | controller | def write_text_file(path, content, create_directories=False):  # type: (str, str, bool) -> None
2024-08-05 07:48:28.126798 | controller |     """Write the given text content to the specified path, optionally creating missing directories."""
2024-08-05 07:48:28.126807 | controller |     if create_directories:
2024-08-05 07:48:28.126816 | controller |         make_dirs(os.path.dirname(path))
2024-08-05 07:48:28.126825 | controller |
2024-08-05 07:48:28.126834 | controller |     with open_binary_file(path, 'wb') as file_obj:
2024-08-05 07:48:28.126843 | controller |         file_obj.write(to_bytes(content))
2024-08-05 07:48:28.126852 | controller |
2024-08-05 07:48:28.126861 | controller |
2024-08-05 07:48:28.126870 | controller | def remove_tree(path):  # type: (str) -> None
2024-08-05 07:48:28.126880 | controller |     """Remove the specified directory tree."""
2024-08-05 07:48:28.126889 | controller |     try:
2024-08-05 07:48:28.126898 | controller |         shutil.rmtree(to_bytes(path))
2024-08-05 07:48:28.126908 | controller |     except OSError as ex:
2024-08-05 07:48:28.126917 | controller |         if ex.errno != errno.ENOENT:
2024-08-05 07:48:28.126926 | controller |             raise
2024-08-05 07:48:28.126935 | controller |
2024-08-05 07:48:28.126944 | controller |
2024-08-05 07:48:28.126953 | controller | def make_dirs(path):  # type: (str) -> None
2024-08-05 07:48:28.126963 | controller |     """Create a directory at path, including any necessary parent directories."""
2024-08-05 07:48:28.126981 | controller |     try:
2024-08-05 07:48:28.126991 | controller |         os.makedirs(to_bytes(path))
2024-08-05 07:48:28.127000 | controller |     except OSError as ex:
2024-08-05 07:48:28.127010 | controller |         if ex.errno != errno.EEXIST:
2024-08-05 07:48:28.127019 | controller |             raise
2024-08-05 07:48:28.127028 | controller |
2024-08-05 07:48:28.127037 | controller |
2024-08-05 07:48:28.127055 | controller | def open_binary_file(path, mode='rb'):  # type: (str, str) -> t.IO[bytes]
2024-08-05 07:48:28.127064 | controller |     """Open the given path for binary access."""
2024-08-05 07:48:28.127074 | controller |     if 'b' not in mode:
2024-08-05 07:48:28.127083 | controller |         raise Exception('mode must include "b" for binary files: %s' % mode)
2024-08-05 07:48:28.127092 | controller |
2024-08-05 07:48:28.127101 | controller |     return io.open(to_bytes(path), mode)  # pylint: disable=consider-using-with,unspecified-encoding
2024-08-05 07:48:28.127110 | controller |
2024-08-05 07:48:28.127120 | controller |
2024-08-05 07:48:28.127129 | controller | def to_optional_bytes(value, errors='strict'):  # type: (t.Optional[t.AnyStr], str) -> t.Optional[bytes]
2024-08-05 07:48:28.127138 | controller |     """Return the given value as bytes encoded using UTF-8 if not already bytes, or None if the value is None."""
2024-08-05 07:48:28.127148 | controller |     return None if value is None else to_bytes(value, errors)
2024-08-05 07:48:28.127157 | controller |
2024-08-05 07:48:28.127166 | controller |
2024-08-05 07:48:28.127176 | controller | def to_optional_text(value, errors='strict'):  # type: (t.Optional[t.AnyStr], str) -> t.Optional[t.Text]
2024-08-05 07:48:28.127185 | controller |     """Return the given value as text decoded using UTF-8 if not already text, or None if the value is None."""
2024-08-05 07:48:28.127195 | controller |     return None if value is None else to_text(value, errors)
2024-08-05 07:48:28.127204 | controller |
2024-08-05 07:48:28.127213 | controller |
2024-08-05 07:48:28.127225 | controller | def to_bytes(value, errors='strict'):  # type: (t.AnyStr, str) -> bytes
2024-08-05 07:48:28.127234 | controller |     """Return the given value as bytes encoded using UTF-8 if not already bytes."""
2024-08-05 07:48:28.127257 | controller |     if isinstance(value, bytes):
2024-08-05 07:48:28.127264 | controller |         return value
2024-08-05 07:48:28.127272 | controller |
2024-08-05 07:48:28.127280 | controller |     if isinstance(value, Text):
2024-08-05 07:48:28.127288 | controller |         return value.encode(ENCODING, errors)
2024-08-05 07:48:28.127297 | controller |
2024-08-05 07:48:28.127305 | controller |     raise Exception('value is not bytes or text: %s' % type(value))
2024-08-05 07:48:28.127315 | controller |
2024-08-05 07:48:28.127324 | controller |
2024-08-05 07:48:28.127333 | controller | def to_text(value, errors='strict'):  # type: (t.AnyStr, str) -> t.Text
2024-08-05 07:48:28.127342 | controller |     """Return the given value as text decoded using UTF-8 if not already text."""
2024-08-05 07:48:28.127351 | controller |     if isinstance(value, bytes):
2024-08-05 07:48:28.127360 | controller |         return value.decode(ENCODING, errors)
2024-08-05 07:48:28.127369 | controller |
2024-08-05 07:48:28.127378 | controller |     if isinstance(value, Text):
2024-08-05 07:48:28.127387 | controller |         return value
2024-08-05 07:48:28.127396 | controller |
2024-08-05 07:48:28.127406 | controller |     raise Exception('value is not bytes or text: %s' % type(value))
2024-08-05 07:48:28.127414 | controller |
2024-08-05 07:48:28.127424 | controller |
2024-08-05 07:48:28.127468 | controller | PAYLOAD = b'eyJzY3JpcHQiOiAiXCJcIlwiQ3VzdG9tIGVudHJ5LXBvaW50IGZvciBwaXAgdGhhdCBmaWx0ZXJzIG91dCB1bndhbnRlZCBsb2dnaW5nIGFuZCB3YXJuaW5ncy5cIlwiXCJcbmZyb20gX19mdXR1cmVfXyBpbXBvcnQgYW5ub3RhdGlvbnNcblxuaW1wb3J0IGxvZ2dpbmdcbmltcG9ydCBvc1xuaW1wb3J0IHJlXG5pbXBvcnQgcnVucHlcbmltcG9ydCBzeXNcblxuQlVJTFRJTl9GSUxURVJFUl9GSUxURVIgPSBsb2dnaW5nLkZpbHRlcmVyLmZpbHRlclxuXG5MT0dHSU5HX01FU1NBR0VfRklMVEVSID0gcmUuY29tcGlsZShcIl4oXCJcbiAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgIFwiLipSdW5uaW5nIHBpcCBpbnN0YWxsIHdpdGggcm9vdCBwcml2aWxlZ2VzIGlzIGdlbmVyYWxseSBub3QgYSBnb29kIGlkZWEuKnxcIiAgIyBjdXN0b20gRmVkb3JhIHBhdGNoIFsxXVxuICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgXCIuKlJ1bm5pbmcgcGlwIGFzIHRoZSAncm9vdCcgdXNlciBjYW4gcmVzdWx0IGluIGJyb2tlbiBwZXJtaXNzaW9ucyAuKnxcIiAgIyBwaXAgMjEuMVxuICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgXCJJZ25vcmluZyAuKjogbWFya2VycyAuKiBkb24ndCBtYXRjaCB5b3VyIGVudmlyb25tZW50fFwiXG4gICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICBcIkxvb2tpbmcgaW4gaW5kZXhlczogLip8XCIgICMgcHlwaS10ZXN0LWNvbnRhaW5lclxuICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgXCJSZXF1aXJlbWVudCBhbHJlYWR5IHNhdGlzZmllZC4qXCJcbiAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgICAgIFwiKSRcIilcblxuIyBbMV0gaHR0cHM6Ly9zcmMuZmVkb3JhcHJvamVjdC5vcmcvcnBtcy9weXRob24tcGlwL2Jsb2IvZjM0L2YvZW1pdC1hLXdhcm5pbmctd2hlbi1ydW5uaW5nLXdpdGgtcm9vdC1wcml2aWxlZ2VzLnBhdGNoXG5cblxuZGVmIGN1c3RvbV9maWx0ZXJlcl9maWx0ZXIoc2VsZiwgcmVjb3JkKTpcbiAgICBcIlwiXCJHbG9iYWxseSBvbWl0IGxvZ2dpbmcgb2YgdW53YW50ZWQgbWVzc2FnZXMuXCJcIlwiXG4gICAgaWYgTE9HR0lOR19NRVNTQUdFX0ZJTFRFUi5zZWFyY2gocmVjb3JkLmdldE1lc3NhZ2UoKSk6XG4gICAgICAgIHJldHVybiAwXG5cbiAgICByZXR1cm4gQlVJTFRJTl9GSUxURVJFUl9GSUxURVIoc2VsZiwgcmVjb3JkKVxuXG5cbmRlZiBtYWluKCk6XG4gICAgXCJcIlwiTWFpbiBwcm9ncmFtIGVudHJ5IHBvaW50LlwiXCJcIlxuICAgICMgRmlsdGVyaW5nIGxvZ2dpbmcgb3V0cHV0IGdsb2JhbGx5IGF2b2lkcyBoYXZpbmcgdG8gaW50ZXJjZXB0IHN0ZG91dC9zdGRlcnIuXG4gICAgIyBJdCBhbHNvIGF2b2lkcyBwcm9ibGVtcyB3aXRoIGxvc3Mgb2YgY29sb3Igb3V0cHV0IGFuZCBtaXhpbmcgdXAgdGhlIG9yZGVyIG9mIHN0ZG91dC9zdGRlcnIgbWVzc2FnZXMuXG4gICAgbG9nZ2luZy5GaWx0ZXJlci5maWx0ZXIgPSBjdXN0b21fZmlsdGVyZXJfZmlsdGVyXG5cbiAgICBnZXRfcGlwID0gb3MuZW52aXJvbi5nZXQoJ0dFVF9QSVAnKVxuXG4gICAgdHJ5OlxuICAgICAgICBpZiBnZXRfcGlwOlxuICAgICAgICAgICAgZGlyZWN0b3J5LCBmaWxlbmFtZSA9IG9zLnBhdGguc3BsaXQoZ2V0X3BpcClcbiAgICAgICAgICAgIG1vZHVsZSA9IG9zLnBhdGguc3BsaXRleHQoZmlsZW5hbWUpWzBdXG4gICAgICAgICAgICBzeXMucGF0aC5pbnNlcnQoMCwgZGlyZWN0b3J5KVxuICAgICAgICAgICAgcnVucHkucnVuX21vZHVsZShtb2R1bGUsIHJ1bl9uYW1lPSdfX21haW5fXycsIGFsdGVyX3N5cz1UcnVlKVxuICAgICAgICBlbHNlOlxuICAgICAgICAgICAgcnVucHkucnVuX21vZHVsZSgncGlwLl9fbWFpbl9fJywgcnVuX25hbWU9J19fbWFpbl9fJywgYWx0ZXJfc3lzPVRydWUpXG4gICAgZXhjZXB0IEltcG9ydEVycm9yIGFzIGV4OlxuICAgICAgICBwcmludCgncGlwIGlzIHVuYXZhaWxhYmxlOiAlcycgJSBleClcbiAgICAgICAgc3lzLmV4aXQoMSlcblxuXG5pZiBfX25hbWVfXyA9PSAnX19tYWluX18nOlxuICAgIG1haW4oKVxuIiwgInZlcmJvc2l0eSI6IDQsICJjb21tYW5kcyI6IFtbImluc3RhbGwiLCB7InJlcXVpcmVtZW50cyI6IFtbInJlcXVpcmVtZW50cy9hbnNpYmxlLnR4dCIsICIjIE5vdGU6IHRoaXMgcmVxdWlyZW1lbnRzLnR4dCBmaWxlIGlzIHVzZWQgdG8gc3BlY2lmeSB3aGF0IGRlcGVuZGVuY2llcyBhcmVcbiMgbmVlZGVkIHRvIG1ha2UgdGhlIHBhY2thZ2UgcnVuIHJhdGhlciB0aGFuIGZvciBkZXBsb3ltZW50IG9mIGEgdGVzdGVkIHNldCBvZlxuIyBwYWNrYWdlcy4gIFRodXMsIHRoaXMgc2hvdWxkIGJlIHRoZSBsb29zZXN0IHNldCBwb3NzaWJsZSAob25seSByZXF1aXJlZFxuIyBwYWNrYWdlcywgbm90IG9wdGlvbmFsIG9uZXMsIGFuZCB3aXRoIHRoZSB3aWRlc3QgcmFuZ2Ugb2YgdmVyc2lvbnMgdGhhdCBjb3VsZFxuIyBiZSBzdWl0YWJsZSlcbmppbmphMiA+PSAzLjAuMFxuUHlZQU1MID49IDUuMSAgIyBQeVlBTUwgNS4xIGlzIHJlcXVpcmVkIGZvciBQeXRob24gMy44KyBzdXBwb3J0XG5jcnlwdG9ncmFwaHlcbnBhY2thZ2luZ1xuIyBOT1RFOiByZXNvbHZlbGliIDAueCB2ZXJzaW9uIGJ1bXBzIHNob3VsZCBiZSBjb25zaWRlcmVkIG1ham9yL2JyZWFraW5nXG4jIE5PVEU6IGFuZCB3ZSBzaG91bGQgdXBkYXRlIHRoZSB1cHBlciBjYXAgd2l0aCBjYXJlLCBhdCBsZWFzdCB1bnRpbCAxLjBcbiMgTk9URTogUmVmOiBodHRwczovL2dpdGh1Yi5jb20vc2FydWdha3UvcmVzb2x2ZWxpYi9pc3N1ZXMvNjlcbiMgTk9URTogV2hlbiB1cGRhdGluZyB0aGUgdXBwZXIgYm91bmQsIGFsc28gdXBkYXRlIHRoZSBsYXRlc3QgdmVyc2lvbiB1c2VkXG4jIE5PVEU6IGluIHRoZSBhbnNpYmxlLWdhbGF4eS1jb2xsZWN0aW9uIHRlc3Qgc3VpdGUuXG5yZXNvbHZlbGliID49IDAuNS4zLCA8IDEuMS4wICAjIGRlcGVuZGVuY3kgcmVzb2x2ZXIgdXNlZCBieSBhbnNpYmxlLWdhbGF4eVxuIl1dLCAiY29uc3RyYWludHMiOiBbWyJyZXF1aXJlbWVudHMvY29uc3RyYWludHMudHh0IiwgIiMgZG8gbm90IGFkZCBhIGNyeXB0b2dyYXBoeSBvciBweW9wZW5zc2wgY29uc3RyYWludCB0byB0aGlzIGZpbGUsIHRoZXkgcmVxdWlyZSBzcGVjaWFsIGhhbmRsaW5nLCBzZWUgZ2V0X2NyeXB0b2dyYXBoeV9yZXF1aXJlbWVudHMgaW4gcHl0aG9uX3JlcXVpcmVtZW50cy5weVxuIyBkbyBub3QgYWRkIGEgY292ZXJhZ2UgY29uc3RyYWludCB0byB0aGlzIGZpbGUsIGl0IGlzIGhhbmRsZWQgaW50ZXJuYWxseSBieSBhbnNpYmxlLXRlc3RcbnB5cHNycCA8IDEuMC4wICAjIGluIGNhc2UgdGhlIG5leHQgbWFqb3IgdmVyc2lvbiBpcyB0b28gYmlnIG9mIGEgY2hhbmdlXG5weXdpbnJtID49IDAuNC4zICAjIHN1cHBvcnQgZm9yIFB5dGhvbiAzLjExXG5weXRlc3QgPj0gNC41LjAgICMgcHl0ZXN0IDQuNS4wIGFkZGVkIHN1cHBvcnQgZm9yIC0tc3RyaWN0LW1hcmtlcnNcbm50bG0tYXV0aCA+PSAxLjMuMCAjIG1lc3NhZ2UgZW5jcnlwdGlvbiBzdXBwb3J0IHVzaW5nIGNyeXB0b2dyYXBoeVxucmVxdWVzdHMtbnRsbSA+PSAxLjEuMCAjIG1lc3NhZ2UgZW5jcnlwdGlvbiBzdXBwb3J0XG5yZXF1ZXN0cy1jcmVkc3NwID49IDAuMS4wICMgbWVzc2FnZSBlbmNyeXB0aW9uIHN1cHBvcnRcbm1vY2sgPj0gMi4wLjAgIyBuZWVkZWQgZm9yIGZlYXR1cmVzIGJhY2twb3J0ZWQgZnJvbSBQeXRob24gMy42IHVuaXR0ZXN0Lm1vY2sgKGFzc2VydF9jYWxsZWQsIGFzc2VydF9jYWxsZWRfb25jZS4uLilcbnB5dGVzdC1tb2NrID49IDEuNC4wICMgbmVlZGVkIGZvciBtb2NrX3VzZV9zdGFuZGFsb25lX21vZHVsZSBweXRlc3Qgb3B0aW9uXG5jZmZpID09IDEuMTcuMHJjMSA7IHB5dGhvbl92ZXJzaW9uID49ICczLjEzJyAjIHRlbXBvcmFyeSBoYWNrIHRvIHN1cHBvcnQgUHl0aG9uIDMuMTNcbnB5eWFtbCA9PSA2LjAuMnJjMSA7IHB5dGhvbl92ZXJzaW9uID49ICczLjEzJyAjIHRlbXBvcmFyeSBoYWNrIHRvIHN1cHBvcnQgUHl0aG9uIDMuMTNcbiJdXSwgInBhY2thZ2VzIjogW119XSwgWyJpbnN0YWxsIiwgeyJyZXF1aXJlbWVudHMiOiBbWyJ0ZXN0cy9pbnRlZ3JhdGlvbi9yZXF1aXJlbWVudHMudHh0IiwgIiMgT3VyIGNvZGUgaXMgYmFzZWQgb24gdGhlIEFXUyBTREtzXG5ib3RvM1xuYm90b2NvcmVcblxuIyBuZXRhZGRyIGlzIG5lZWRlZCBmb3IgYW5zaWJsZS51dGlscy5pcHY2XG5uZXRhZGRyXG52aXJ0dWFsZW52XG4jIFNvbWV0aW1lcyBuZWVkZWQgd2hlcmUgd2UgZG9uJ3QgaGF2ZSBmZWF0dXJlcyB3ZSBuZWVkIGluIG1vZHVsZXNcbmF3c2NsaVxuIyBVc2VkIGZvciBjb21wYXJpbmcgU1NIIFB1YmxpYyBrZXlzIHRvIHRoZSBBbWF6b24gZmluZ2VycHJpbnRzXG5jcnlwdG9ncmFwaHlcbiJdXSwgImNvbnN0cmFpbnRzIjogW1sidGVzdHMvaW50ZWdyYXRpb24vY29uc3RyYWludHMudHh0IiwgIiMgU3BlY2lmaWNhbGx5IHJ1biB0ZXN0cyBhZ2FpbnN0IHRoZSBvbGRlc3QgdmVyc2lvbnMgdGhhdCB3ZSBzdXBwb3J0XG5ib3RvY29yZT09MS4yOS4wXG5ib3RvMz09MS4yNi4wXG5cbiMgQVdTIENMSSBoYXMgYGJvdG9jb3JlPT1gIGRlcGVuZGVuY2llcywgcHJvdmlkZSB0aGUgb25lIHRoYXQgbWF0Y2hlcyBib3RvY29yZVxuIyB0byBhdm9pZCBuZWVkaW5nIHRvIGRvd25sb2FkIG92ZXIgYSB5ZWFycyB3b3J0aCBvZiBhd3NjbGkgd2hlZWxzLlxuYXdzY2xpPT0xLjI3LjBcblxuIyBBV1MgQ0xJIGRlcGVuZHMgb24gUHlZQU1MIDw1LjUsPj0zLjEwOyB0aGUgbGF0ZXN0IFB5WUFNTCByZWxlYXNlIGluIHRoYXQgcmFuZ2UsIDUuNC4xLCBmYWlscyB0byBpbnN0YWxsLlxuIyBVc2UgYSB2ZXJzaW9uIGluIHRoYXQgcmFuZ2UgdGhhdCBpcyBrbm93biB0byB3b3JrIChodHRwczovL2dpdGh1Yi5jb20veWFtbC9weXlhbWwvaXNzdWVzLzczNilcblB5WUFNTD09NS4zLjFcbiJdLCBbInJlcXVpcmVtZW50cy9jb25zdHJhaW50cy50eHQiLCAiIyBkbyBub3QgYWRkIGEgY3J5cHRvZ3JhcGh5IG9yIHB5b3BlbnNzbCBjb25zdHJhaW50IHRvIHRoaXMgZmlsZSwgdGhleSByZXF1aXJlIHNwZWNpYWwgaGFuZGxpbmcsIHNlZSBnZXRfY3J5cHRvZ3JhcGh5X3JlcXVpcmVtZW50cyBpbiBweXRob25fcmVxdWlyZW1lbnRzLnB5XG4jIGRvIG5vdCBhZGQgYSBjb3ZlcmFnZSBjb25zdHJhaW50IHRvIHRoaXMgZmlsZSwgaXQgaXMgaGFuZGxlZCBpbnRlcm5hbGx5IGJ5IGFuc2libGUtdGVzdFxucHlwc3JwIDwgMS4wLjAgICMgaW4gY2FzZSB0aGUgbmV4dCBtYWpvciB2ZXJzaW9uIGlzIHRvbyBiaWcgb2YgYSBjaGFuZ2VcbnB5d2lucm0gPj0gMC40LjMgICMgc3VwcG9ydCBmb3IgUHl0aG9uIDMuMTFcbnB5dGVzdCA+PSA0LjUuMCAgIyBweXRlc3QgNC41LjAgYWRkZWQgc3VwcG9ydCBmb3IgLS1zdHJpY3QtbWFya2Vyc1xubnRsbS1hdXRoID49IDEuMy4wICMgbWVzc2FnZSBlbmNyeXB0aW9uIHN1cHBvcnQgdXNpbmcgY3J5cHRvZ3JhcGh5XG5yZXF1ZXN0cy1udGxtID49IDEuMS4wICMgbWVzc2FnZSBlbmNyeXB0aW9uIHN1cHBvcnRcbnJlcXVlc3RzLWNyZWRzc3AgPj0gMC4xLjAgIyBtZXNzYWdlIGVuY3J5cHRpb24gc3VwcG9ydFxubW9jayA+PSAyLjAuMCAjIG5lZWRlZCBmb3IgZmVhdHVyZXMgYmFja3BvcnRlZCBmcm9tIFB5dGhvbiAzLjYgdW5pdHRlc3QubW9jayAoYXNzZXJ0X2NhbGxlZCwgYXNzZXJ0X2NhbGxlZF9vbmNlLi4uKVxucHl0ZXN0LW1vY2sgPj0gMS40LjAgIyBuZWVkZWQgZm9yIG1vY2tfdXNlX3N0YW5kYWxvbmVfbW9kdWxlIHB5dGVzdCBvcHRpb25cbmNmZmkgPT0gMS4xNy4wcmMxIDsgcHl0aG9uX3ZlcnNpb24gPj0gJzMuMTMnICMgdGVtcG9yYXJ5IGhhY2sgdG8gc3VwcG9ydCBQeXRob24gMy4xM1xucHl5YW1sID09IDYuMC4ycmMxIDsgcHl0aG9uX3ZlcnNpb24gPj0gJzMuMTMnICMgdGVtcG9yYXJ5IGhhY2sgdG8gc3VwcG9ydCBQeXRob24gMy4xM1xuIl1dLCAicGFja2FnZXMiOiBbXX1dXX0='  # base-64 encoded JSON payload which will be populated before this script is executed
2024-08-05 07:48:28.271996 | controller |
2024-08-05 07:48:28.272047 | controller | if __name__ == '__main__':
2024-08-05 07:48:28.272059 | controller |     main()
2024-08-05 07:48:28.272069 | controller | Installing requirements for Python 3.11 (controller)
2024-08-05 07:48:28.272080 | controller | Stream command with data: /home/zuul-worker/venv/bin/python
2024-08-05 07:48:28.272090 | controller | Working directory: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws
2024-08-05 07:48:28.272100 | controller | Program found: /home/zuul-worker/venv/bin/python
2024-08-05 07:48:28.272122 | controller | HOME=/home/zuul-worker
2024-08-05 07:48:28.272131 | controller | LC_ALL=en_US.UTF-8
2024-08-05 07:48:28.272142 | controller | PATH=/home/zuul-worker/venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2024-08-05 07:48:28.272161 | controller | Execute command: /home/zuul-worker/venv/bin/python /tmp/ansible-test-i31aewif-pip.py install --disable-pip-version-check -r requirements/ansible.txt -c requirements/constraints.txt
2024-08-05 07:48:29.625354 | controller | Execute command: /home/zuul-worker/venv/bin/python /tmp/ansible-test-i31aewif-pip.py install --disable-pip-version-check -r tests/integration/requirements.txt -c tests/integration/constraints.txt -c requirements/constraints.txt
2024-08-05 07:48:31.043146 | controller | Command exited with status 0 after 2.9215190410614014 seconds.
2024-08-05 07:48:31.142851 | controller | Run command: /home/zuul-worker/venv/bin/python /home/zuul-worker/venv/lib/python3.11/site-packages/ansible_test/_util/target/tools/yamlcheck.py
2024-08-05 07:48:31.142904 | controller | Working directory: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws
2024-08-05 07:48:31.142916 | controller | Program found: /home/zuul-worker/venv/bin/python
2024-08-05 07:48:31.142926 | controller | HOME=/home/zuul-worker
2024-08-05 07:48:31.142936 | controller | LC_ALL=en_US.UTF-8
2024-08-05 07:48:31.142946 | controller | PATH=/home/zuul-worker/venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2024-08-05 07:48:31.142964 | controller | Command exited with status 0 after 0.0996248722076416 seconds.
2024-08-05 07:48:31.144283 | controller | WARNING: PyYAML will be slow due to installation without libyaml support for interpreter: /home/zuul-worker/venv/bin/python
2024-08-05 07:48:31.144328 | controller | Configuring controller inventory.
2024-08-05 07:48:31.146303 | controller | >>> Inventory
2024-08-05 07:48:31.148456 | controller | [testgroup]
2024-08-05 07:48:31.148490 | controller | testhost ansible_connection="local" ansible_pipelining="yes" ansible_python_interpreter="/home/zuul-worker/venv/bin/python"
2024-08-05 07:48:31.148502 | controller | Running lookup_secretsmanager_secret integration test role
2024-08-05 07:48:31.148512 | controller | >>> Environment Config
2024-08-05 07:48:31.148521 | controller | {
2024-08-05 07:48:31.148531 | controller |     "ansible_vars": {
2024-08-05 07:48:31.148540 | controller |         "aws_access_key": "ASIA6CCDWXDOFIBKOECE",
2024-08-05 07:48:31.148550 | controller |         "aws_cleanup": true,
2024-08-05 07:48:31.148559 | controller |         "aws_region": "us-east-1",
2024-08-05 07:48:31.148569 | controller |         "aws_secret_key": "****************************************",
2024-08-05 07:48:31.148579 | controller |         "ec2_access_key": "{{ aws_access_key }}",
2024-08-05 07:48:31.148589 | controller |         "ec2_region": "{{ aws_region }}",
2024-08-05 07:48:31.148598 | controller |         "ec2_secret_key": "{{ aws_secret_key }}",
2024-08-05 07:48:31.148607 | controller |         "resource_prefix": "ansible-test-31971987-ip-172-16-95-216",
2024-08-05 07:48:31.148617 | controller |         "security_token": "********************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************",
2024-08-05 07:48:31.148628 | controller |         "tiny_prefix": "70e78cda4380"
2024-08-05 07:48:31.148637 | controller |     },
2024-08-05 07:48:31.148646 | controller |     "callback_plugins": [
2024-08-05 07:48:31.148655 | controller |         "aws_resource_actions"
2024-08-05 07:48:31.148665 | controller |     ],
2024-08-05 07:48:31.148674 | controller |     "env_vars": {
2024-08-05 07:48:31.148683 | controller |         "ANSIBLE_DEBUG_BOTOCORE_LOGS": "True"
2024-08-05 07:48:31.148692 | controller |     },
2024-08-05 07:48:31.148701 | controller |     "module_defaults": null
2024-08-05 07:48:31.148710 | controller | }
2024-08-05 07:48:31.148720 | controller | WARNING: Disabling the temp work dir is a temporary debugging feature that may be removed in the future without notice.
2024-08-05 07:48:31.148729 | controller | >>> Playbook: lookup_secretsmanager_secret-np7xcnu6.yml
2024-08-05 07:48:31.148738 | controller | [
2024-08-05 07:48:31.148747 | controller |     {
2024-08-05 07:48:31.148756 | controller |         "environment": {
2024-08-05 07:48:31.148765 | controller |             "ANSIBLE_DEBUG_BOTOCORE_LOGS": "True"
2024-08-05 07:48:31.148775 | controller |         },
2024-08-05 07:48:31.148784 | controller |         "gather_facts": true,
2024-08-05 07:48:31.148793 | controller |         "hosts": "testhost",
2024-08-05 07:48:31.148802 | controller |         "module_defaults": null,
2024-08-05 07:48:31.148811 | controller |         "roles": [
2024-08-05 07:48:31.148820 | controller |             "lookup_secretsmanager_secret"
2024-08-05 07:48:31.148829 | controller |         ],
2024-08-05 07:48:31.148838 | controller |         "vars": {
2024-08-05 07:48:31.148856 | controller |             "aws_access_key": "ASIA6CCDWXDOFIBKOECE",
2024-08-05 07:48:31.148867 | controller |             "aws_cleanup": true,
2024-08-05 07:48:31.148876 | controller |             "aws_region": "us-east-1",
2024-08-05 07:48:31.148885 | controller |             "aws_secret_key": "****************************************",
2024-08-05 07:48:31.148894 | controller |             "ec2_access_key": "{{ aws_access_key }}",
2024-08-05 07:48:31.148903 | controller |             "ec2_region": "{{ aws_region }}",
2024-08-05 07:48:31.148912 | controller |             "ec2_secret_key": "{{ aws_secret_key }}",
2024-08-05 07:48:31.148922 | controller |             "output_dir": "/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/output/.tmp/output_dir",
2024-08-05 07:48:31.148931 | controller |             "resource_prefix": "ansible-test-31971987-ip-172-16-95-216",
2024-08-05 07:48:31.148942 | controller |             "security_token": "********************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************",
2024-08-05 07:48:31.148952 | controller |             "tiny_prefix": "70e78cda4380"
2024-08-05 07:48:31.148961 | controller |         },
2024-08-05 07:48:31.148970 | controller |         "vars_files": []
2024-08-05 07:48:31.148979 | controller |     }
2024-08-05 07:48:31.148989 | controller | ]
2024-08-05 07:48:31.149005 | controller | Initializing "/tmp/ansible-test-eff20ij0-injector" as the temporary injector directory.
2024-08-05 07:48:31.149541 | controller | Injecting "/tmp/python-5nw0pgna-ansible/python" as a execv wrapper for the "/home/zuul-worker/venv/bin/python" interpreter.
2024-08-05 07:48:31.149844 | controller | Stream command: ansible-playbook lookup_secretsmanager_secret-np7xcnu6.yml -i inventory --skip-tags False --diff -vvvv
2024-08-05 07:48:31.149884 | controller | Working directory: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration
2024-08-05 07:48:31.149962 | controller | Program found: /tmp/ansible-test-eff20ij0-injector/ansible-playbook
2024-08-05 07:48:31.150001 | controller | ANSIBLE_CALLBACKS_ENABLED=aws_resource_actions,junit
2024-08-05 07:48:31.150029 | controller | ANSIBLE_COLLECTIONS_PATH=/home/zuul-worker/.ansible/collections
2024-08-05 07:48:31.150055 | controller | ANSIBLE_CONFIG=/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/integration.cfg
2024-08-05 07:48:31.150081 | controller | ANSIBLE_DEBUG_BOTOCORE_LOGS=True
2024-08-05 07:48:31.150107 | controller | ANSIBLE_DEPRECATION_WARNINGS=false
2024-08-05 07:48:31.150132 | controller | ANSIBLE_DEVEL_WARNING=false
2024-08-05 07:48:31.150157 | controller | ANSIBLE_FORCE_COLOR=false
2024-08-05 07:48:31.150182 | controller | ANSIBLE_FORCE_HANDLERS=true
2024-08-05 07:48:31.150207 | controller | ANSIBLE_HOST_KEY_CHECKING=false
2024-08-05 07:48:31.150232 | controller | ANSIBLE_HOST_PATTERN_MISMATCH=error
2024-08-05 07:48:31.150283 | controller | ANSIBLE_INVENTORY=/dev/null
2024-08-05 07:48:31.150309 | controller | ANSIBLE_LIBRARY=/dev/null
2024-08-05 07:48:31.150334 | controller | ANSIBLE_PLAYBOOK_DIR=/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration
2024-08-05 07:48:31.150361 | controller | ANSIBLE_PYTHON_INTERPRETER=/set/ansible_python_interpreter/in/inventory
2024-08-05 07:48:31.150387 | controller | ANSIBLE_PYTHON_MODULE_RLIMIT_NOFILE=1024
2024-08-05 07:48:31.150414 | controller | ANSIBLE_RETRY_FILES_ENABLED=false
2024-08-05 07:48:31.150439 | controller | ANSIBLE_ROLES_PATH=/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets
2024-08-05 07:48:31.150465 | controller | ANSIBLE_TEST_ANSIBLE_LIB_ROOT=/home/zuul-worker/venv/lib/python3.11/site-packages/ansible
2024-08-05 07:48:31.150490 | controller | ANSIBLE_TEST_CI=
2024-08-05 07:48:31.150516 | controller | ANSIBLE_TEST_COVERAGE=
2024-08-05 07:48:31.150541 | controller | ANSIBLE_TEST_PYTHON_INTERPRETER=/home/zuul-worker/venv/bin/python
2024-08-05 07:48:31.150566 | controller | ANSIBLE_TEST_PYTHON_VERSION=3.11
2024-08-05 07:48:31.150591 | controller | ANSIBLE_WORKER_SHUTDOWN_POLL_COUNT=100
2024-08-05 07:48:31.150617 | controller | ANSIBLE_WORKER_SHUTDOWN_POLL_DELAY=0.1
2024-08-05 07:48:31.150642 | controller | HOME=/home/zuul-worker
2024-08-05 07:48:31.150667 | controller | INVENTORY_PATH=/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/inventory
2024-08-05 07:48:31.150699 | controller | JUNIT_OUTPUT_DIR=/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/output/junit
2024-08-05 07:48:31.150725 | controller | JUNIT_REPLACE_OUT_OF_TREE_PATH=out-of-tree:
2024-08-05 07:48:31.150920 | controller | JUNIT_TASK_RELATIVE_PATH=/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws
2024-08-05 07:48:31.150968 | controller | LC_ALL=en_US.UTF-8
2024-08-05 07:48:31.151004 | controller | OUTPUT_DIR=/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/output/.tmp/output_dir
2024-08-05 07:48:31.151031 | controller | PAGER=/bin/cat
2024-08-05 07:48:31.151067 | controller | PATH=/tmp/ansible-test-eff20ij0-injector:/tmp/python-5nw0pgna-ansible:/tmp/ansible-test-jb82gi4u-bin:/home/zuul-worker/venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2024-08-05 07:48:31.151095 | controller | PYTHONPATH=/tmp/ansible-test-a7am02x0
2024-08-05 07:48:34.560352 | controller | ansible-playbook [core 2.18.0.dev0]
2024-08-05 07:48:34.560415 | controller |   config file = /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/integration.cfg
2024-08-05 07:48:34.560440 | controller |   configured module search path = ['/dev/null']
2024-08-05 07:48:34.560464 | controller |   ansible python module location = /tmp/ansible-test-a7am02x0/ansible
2024-08-05 07:48:34.560570 | controller |   ansible collection location = /home/zuul-worker/.ansible/collections
2024-08-05 07:48:34.560598 | controller |   executable location = /tmp/ansible-test-jb82gi4u-bin/ansible-playbook
2024-08-05 07:48:34.560621 | controller |   python version = 3.11.3 (main, Apr  5 2023, 00:00:00) [GCC 12.2.1 20221121 (Red Hat 12.2.1-4)] (/home/zuul-worker/venv/bin/python)
2024-08-05 07:48:34.560644 | controller |   jinja version = 3.1.4
2024-08-05 07:48:34.560665 | controller |   libyaml = False
2024-08-05 07:48:34.560687 | controller | Using /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/integration.cfg as config file
2024-08-05 07:48:34.560708 | controller | Loading collection amazon.aws from /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws
2024-08-05 07:48:34.560729 | controller | setting up inventory plugins
2024-08-05 07:48:34.560750 | controller | Loading collection ansible.builtin from
2024-08-05 07:48:34.560780 | controller | host_list declined parsing /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/inventory as it did not pass its verify_file() method
2024-08-05 07:48:34.560806 | controller | script declined parsing /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/inventory as it did not pass its verify_file() method
2024-08-05 07:48:34.560827 | controller | auto declined parsing /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/inventory as it did not pass its verify_file() method
2024-08-05 07:48:34.560848 | controller | Parsed /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/inventory inventory source with ini plugin
2024-08-05 07:48:34.560873 | controller | running playbook inside collection amazon.aws
2024-08-05 07:48:34.560897 | controller | redirecting (type: modules) amazon.aws.aws_s3 to amazon.aws.s3_object
2024-08-05 07:48:34.560918 | controller | redirecting (type: action) amazon.aws.aws_s3 to amazon.aws.s3_object
2024-08-05 07:48:34.560939 | controller | redirecting (type: modules) amazon.aws.aws_s3_bucket_info to amazon.aws.s3_bucket_info
2024-08-05 07:48:34.560961 | controller | redirecting (type: modules) amazon.aws.ec2_elb_lb to amazon.aws.elb_classic_lb
2024-08-05 07:48:34.560982 | controller | redirecting (type: modules) amazon.aws.ec2_group to amazon.aws.ec2_security_group
2024-08-05 07:48:34.561002 | controller | redirecting (type: modules) amazon.aws.ec2_group_info to amazon.aws.ec2_security_group_info
2024-08-05 07:48:34.561023 | controller | redirecting (type: modules) amazon.aws.execute_lambda to amazon.aws.lambda_execute
2024-08-05 07:48:34.561043 | controller | redirecting (type: modules) amazon.aws.rds_param_group to amazon.aws.rds_instance_param_group
2024-08-05 07:48:34.561064 | controller | Loading collection community.aws from /home/zuul-worker/.ansible/collections/ansible_collections/community/aws
2024-08-05 07:48:34.561092 | controller | redirecting (type: modules) community.aws.aws_acm to community.aws.acm_certificate
2024-08-05 07:48:34.561114 | controller | redirecting (type: modules) community.aws.aws_acm_info to community.aws.acm_certificate_info
2024-08-05 07:48:34.561135 | controller | redirecting (type: modules) community.aws.aws_api_gateway to community.aws.api_gateway
2024-08-05 07:48:34.561156 | controller | redirecting (type: modules) community.aws.aws_api_gateway_domain to community.aws.api_gateway_domain
2024-08-05 07:48:34.561177 | controller | redirecting (type: modules) community.aws.aws_application_scaling_policy to community.aws.application_autoscaling_policy
2024-08-05 07:48:34.561198 | controller | redirecting (type: modules) community.aws.aws_batch_compute_environment to community.aws.batch_compute_environment
2024-08-05 07:48:34.561219 | controller | redirecting (type: modules) community.aws.aws_batch_job_definition to community.aws.batch_job_definition
2024-08-05 07:48:34.561251 | controller | redirecting (type: modules) community.aws.aws_batch_job_queue to community.aws.batch_job_queue
2024-08-05 07:48:34.561277 | controller | redirecting (type: modules) community.aws.aws_codebuild to community.aws.codebuild_project
2024-08-05 07:48:34.561298 | controller | redirecting (type: modules) community.aws.aws_codecommit to community.aws.codecommit_repository
2024-08-05 07:48:34.561319 | controller | redirecting (type: modules) community.aws.aws_codepipeline to community.aws.codepipeline
2024-08-05 07:48:34.561340 | controller | redirecting (type: modules) community.aws.aws_config_aggregation_authorization to community.aws.config_aggregation_authorization
2024-08-05 07:48:34.561361 | controller | redirecting (type: modules) community.aws.aws_config_aggregator to community.aws.config_aggregator
2024-08-05 07:48:34.561382 | controller | redirecting (type: modules) community.aws.aws_config_delivery_channel to community.aws.config_delivery_channel
2024-08-05 07:48:34.561403 | controller | redirecting (type: modules) community.aws.aws_config_recorder to community.aws.config_recorder
2024-08-05 07:48:34.561423 | controller | redirecting (type: modules) community.aws.aws_config_rule to community.aws.config_rule
2024-08-05 07:48:34.561443 | controller | redirecting (type: modules) community.aws.aws_direct_connect_confirm_connection to community.aws.directconnect_confirm_connection
2024-08-05 07:48:34.561475 | controller | redirecting (type: modules) community.aws.aws_direct_connect_connection to community.aws.directconnect_connection
2024-08-05 07:48:34.561496 | controller | redirecting (type: modules) community.aws.aws_direct_connect_gateway to community.aws.directconnect_gateway
2024-08-05 07:48:34.561517 | controller | redirecting (type: modules) community.aws.aws_direct_connect_link_aggregation_group to community.aws.directconnect_link_aggregation_group
2024-08-05 07:48:34.561538 | controller | redirecting (type: modules) community.aws.aws_direct_connect_virtual_interface to community.aws.directconnect_virtual_interface
2024-08-05 07:48:34.561559 | controller | redirecting (type: modules) community.aws.aws_eks_cluster to community.aws.eks_cluster
2024-08-05 07:48:34.561580 | controller | redirecting (type: modules) community.aws.aws_elasticbeanstalk_app to community.aws.elasticbeanstalk_app
2024-08-05 07:48:34.561600 | controller | redirecting (type: modules) community.aws.aws_glue_connection to community.aws.glue_connection
2024-08-05 07:48:34.561745 | controller | redirecting (type: modules) community.aws.aws_glue_crawler to community.aws.glue_crawler
2024-08-05 07:48:34.561782 | controller | redirecting (type: modules) community.aws.aws_glue_job to community.aws.glue_job
2024-08-05 07:48:34.561805 | controller | redirecting (type: modules) community.aws.aws_inspector_target to community.aws.inspector_target
2024-08-05 07:48:34.561827 | controller | redirecting (type: modules) community.aws.aws_msk_cluster to community.aws.msk_cluster
2024-08-05 07:48:34.561848 | controller | redirecting (type: modules) community.aws.aws_msk_config to community.aws.msk_config
2024-08-05 07:48:34.561870 | controller | redirecting (type: modules) community.aws.aws_region_info to amazon.aws.aws_region_info
2024-08-05 07:48:34.561891 | controller | redirecting (type: modules) community.aws.aws_s3_cors to community.aws.s3_cors
2024-08-05 07:48:34.561913 | controller | redirecting (type: modules) community.aws.aws_secret to community.aws.secretsmanager_secret
2024-08-05 07:48:34.561944 | controller | redirecting (type: modules) community.aws.aws_ses_identity to community.aws.ses_identity
2024-08-05 07:48:34.561966 | controller | redirecting (type: modules) community.aws.aws_ses_identity_policy to community.aws.ses_identity_policy
2024-08-05 07:48:34.561988 | controller | redirecting (type: modules) community.aws.aws_ses_rule_set to community.aws.ses_rule_set
2024-08-05 07:48:34.562009 | controller | redirecting (type: modules) community.aws.aws_sgw_info to community.aws.storagegateway_info
2024-08-05 07:48:34.562030 | controller | redirecting (type: modules) community.aws.aws_ssm_parameter_store to community.aws.ssm_parameter
2024-08-05 07:48:34.562052 | controller | redirecting (type: modules) community.aws.aws_step_functions_state_machine to community.aws.stepfunctions_state_machine
2024-08-05 07:48:34.562074 | controller | redirecting (type: modules) community.aws.aws_step_functions_state_machine_execution to community.aws.stepfunctions_state_machine_execution
2024-08-05 07:48:34.562095 | controller | redirecting (type: modules) community.aws.aws_waf_condition to community.aws.waf_condition
2024-08-05 07:48:34.562116 | controller | redirecting (type: modules) community.aws.aws_waf_info to community.aws.waf_info
2024-08-05 07:48:34.562138 | controller | redirecting (type: modules) community.aws.aws_waf_rule to community.aws.waf_rule
2024-08-05 07:48:34.562159 | controller | redirecting (type: modules) community.aws.aws_waf_web_acl to community.aws.waf_web_acl
2024-08-05 07:48:34.562180 | controller | redirecting (type: modules) community.aws.cloudfront_info to community.aws.cloudfront_distribution_info
2024-08-05 07:48:34.562202 | controller | redirecting (type: modules) community.aws.ec2_asg to amazon.aws.autoscaling_group
2024-08-05 07:48:34.562223 | controller | redirecting (type: modules) community.aws.ec2_asg_info to amazon.aws.autoscaling_group_info
2024-08-05 07:48:34.562256 | controller | redirecting (type: modules) community.aws.ec2_asg_instance_refresh to community.aws.autoscaling_instance_refresh
2024-08-05 07:48:34.562283 | controller | redirecting (type: modules) community.aws.ec2_asg_instance_refresh_info to community.aws.autoscaling_instance_refresh_info
2024-08-05 07:48:34.562307 | controller | redirecting (type: modules) community.aws.ec2_asg_lifecycle_hook to community.aws.autoscaling_lifecycle_hook
2024-08-05 07:48:34.562372 | controller | redirecting (type: modules) community.aws.ec2_asg_scheduled_action to community.aws.autoscaling_scheduled_action
2024-08-05 07:48:34.562394 | controller | redirecting (type: modules) community.aws.ec2_elb to community.aws.elb_instance
2024-08-05 07:48:34.562410 | controller | redirecting (type: modules) community.aws.ec2_lc to community.aws.autoscaling_launch_config
2024-08-05 07:48:34.562428 | controller | redirecting (type: modules) community.aws.ec2_lc_find to community.aws.autoscaling_launch_config_find
2024-08-05 07:48:34.562445 | controller | redirecting (type: modules) community.aws.ec2_lc_info to community.aws.autoscaling_launch_config_info
2024-08-05 07:48:34.562462 | controller | redirecting (type: modules) community.aws.ec2_metric_alarm to amazon.aws.cloudwatch_metric_alarm
2024-08-05 07:48:34.562479 | controller | redirecting (type: modules) community.aws.ec2_scaling_policy to community.aws.autoscaling_policy
2024-08-05 07:48:34.562495 | controller | redirecting (type: modules) community.aws.elb_classic_lb to amazon.aws.ec2_elb_lb
2024-08-05 07:48:34.562513 | controller | redirecting (type: modules) amazon.aws.ec2_elb_lb to amazon.aws.elb_classic_lb
2024-08-05 07:48:34.665918 | controller | Loading callback plugin default of type stdout, v2.0 from /tmp/ansible-test-a7am02x0/ansible/plugins/callback/default.py
2024-08-05 07:48:34.665974 | controller | redirecting (type: callback) ansible.builtin.aws_resource_actions to amazon.aws.aws_resource_actions
2024-08-05 07:48:34.665993 | controller | Skipping callback 'default', as we already have a stdout callback.
2024-08-05 07:48:34.666017 | controller | Loading callback plugin junit of type aggregate, v2.0 from /tmp/ansible-test-a7am02x0/ansible/plugins/callback/junit.py
2024-08-05 07:48:34.666033 | controller | Skipping callback 'minimal', as we already have a stdout callback.
2024-08-05 07:48:34.666048 | controller | Skipping callback 'oneline', as we already have a stdout callback.
2024-08-05 07:48:34.666070 | controller | Loading callback plugin amazon.aws.aws_resource_actions of type aggregate, v2.8 from /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/plugins/callback/aws_resource_actions.py
2024-08-05 07:48:34.666091 | controller |
2024-08-05 07:48:34.666109 | controller | PLAYBOOK: lookup_secretsmanager_secret-np7xcnu6.yml ****************************
2024-08-05 07:48:34.666125 | controller | Positional arguments: lookup_secretsmanager_secret-np7xcnu6.yml
2024-08-05 07:48:34.666141 | controller | verbosity: 4
2024-08-05 07:48:34.666157 | controller | connection: ssh
2024-08-05 07:48:34.666173 | controller | force_handlers: True
2024-08-05 07:48:34.666188 | controller | become_method: sudo
2024-08-05 07:48:34.666206 | controller | tags: ('all',)
2024-08-05 07:48:34.666224 | controller | skip_tags: ('False',)
2024-08-05 07:48:34.666259 | controller | diff: True
2024-08-05 07:48:34.666280 | controller | inventory: ('/home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/inventory',)
2024-08-05 07:48:34.666298 | controller | forks: 5
2024-08-05 07:48:34.666320 | controller | 1 plays in lookup_secretsmanager_secret-np7xcnu6.yml
2024-08-05 07:48:34.666335 | controller |
2024-08-05 07:48:34.666350 | controller | PLAY [testhost] ****************************************************************
2024-08-05 07:48:34.666367 | controller |
2024-08-05 07:48:34.666383 | controller | TASK [Gathering Facts] *********************************************************
2024-08-05 07:48:35.861323 | controller | Using module file /tmp/ansible-test-a7am02x0/ansible/modules/setup.py
2024-08-05 07:48:35.889993 | controller | Pipelining is enabled.
2024-08-05 07:48:35.890037 | controller | <testhost> ESTABLISH LOCAL CONNECTION FOR USER: zuul-worker
2024-08-05 07:48:35.890046 | controller | <testhost> EXEC /bin/sh -c 'ANSIBLE_DEBUG_BOTOCORE_LOGS=True /home/zuul-worker/venv/bin/python && sleep 0'
2024-08-05 07:48:35.890053 | controller | ok: [testhost]
2024-08-05 07:48:35.890060 | controller |
2024-08-05 07:48:35.890067 | controller | TASK [lookup_secretsmanager_secret : ansible.builtin.set_fact] *****************
2024-08-05 07:48:35.890075 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:2
2024-08-05 07:48:35.890089 | controller | ok: [testhost] => {
2024-08-05 07:48:35.931253 | controller |     "censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result",
2024-08-05 07:48:35.931300 | controller |     "changed": false
2024-08-05 07:48:35.931309 | controller | }
2024-08-05 07:48:35.931317 | controller |
2024-08-05 07:48:35.931324 | controller | TASK [lookup_secretsmanager_secret : define secret name] ***********************
2024-08-05 07:48:35.931331 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:21
2024-08-05 07:48:35.931346 | controller | ok: [testhost] => {
2024-08-05 07:48:36.311453 | controller |     "ansible_facts": {
2024-08-05 07:48:36.311501 | controller |         "secret_name": "ansible-test-70e78cda4380-secret",
2024-08-05 07:48:36.311510 | controller |         "secret_value": "kqm+/}6>+-dy!$-<",
2024-08-05 07:48:36.311517 | controller |         "skip": "skip",
2024-08-05 07:48:36.311525 | controller |         "warn": "warn"
2024-08-05 07:48:36.311532 | controller |     },
2024-08-05 07:48:36.311539 | controller |     "changed": false
2024-08-05 07:48:36.311546 | controller | }
2024-08-05 07:48:36.311554 | controller |
2024-08-05 07:48:36.311561 | controller | TASK [lookup_secretsmanager_secret : lookup missing secret (skip)] *************
2024-08-05 07:48:36.311569 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:28
2024-08-05 07:48:36.311583 | controller | ok: [testhost] => {
2024-08-05 07:48:36.348215 | controller |     "ansible_facts": {
2024-08-05 07:48:36.348279 | controller |         "missing_secret": []
2024-08-05 07:48:36.348288 | controller |     },
2024-08-05 07:48:36.348295 | controller |     "changed": false
2024-08-05 07:48:36.348302 | controller | }
2024-08-05 07:48:36.348310 | controller |
2024-08-05 07:48:36.348317 | controller | TASK [lookup_secretsmanager_secret : assert that missing_secret is defined] ****
2024-08-05 07:48:36.348325 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:32
2024-08-05 07:48:36.348340 | controller | ok: [testhost] => {
2024-08-05 07:48:36.686740 | controller |     "changed": false,
2024-08-05 07:48:36.686785 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:36.686797 | controller | }
2024-08-05 07:48:36.686805 | controller |
2024-08-05 07:48:36.686814 | controller | TASK [lookup_secretsmanager_secret : lookup missing secret (warn)] *************
2024-08-05 07:48:36.686823 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:38
2024-08-05 07:48:36.686840 | controller | [WARNING]: Skipping, did not find secret ansible-test-70e78cda4380-secret
2024-08-05 07:48:36.698626 | controller | ok: [testhost] => {
2024-08-05 07:48:36.735165 | controller |     "ansible_facts": {
2024-08-05 07:48:36.735208 | controller |         "missing_secret": []
2024-08-05 07:48:36.735216 | controller |     },
2024-08-05 07:48:36.735223 | controller |     "changed": false
2024-08-05 07:48:36.735230 | controller | }
2024-08-05 07:48:36.735252 | controller |
2024-08-05 07:48:36.735261 | controller | TASK [lookup_secretsmanager_secret : assert that missing_secret is defined] ****
2024-08-05 07:48:36.735268 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:42
2024-08-05 07:48:36.735284 | controller | ok: [testhost] => {
2024-08-05 07:48:37.091201 | controller |     "changed": false,
2024-08-05 07:48:37.091266 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:37.091277 | controller | }
2024-08-05 07:48:37.091285 | controller |
2024-08-05 07:48:37.091292 | controller | TASK [lookup_secretsmanager_secret : lookup missing secret (error)] ************
2024-08-05 07:48:37.091300 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:48
2024-08-05 07:48:37.091315 | controller | fatal: [testhost]: FAILED! => {
2024-08-05 07:48:37.126839 | controller |     "msg": "Failed to find secret ansible-test-70e78cda4380-secret (ResourceNotFound)"
2024-08-05 07:48:37.126883 | controller | }
2024-08-05 07:48:37.126892 | controller | ...ignoring
2024-08-05 07:48:37.126899 | controller |
2024-08-05 07:48:37.126906 | controller | TASK [lookup_secretsmanager_secret : assert that setting the missing_secret failed] ***
2024-08-05 07:48:37.126914 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:54
2024-08-05 07:48:37.126930 | controller | ok: [testhost] => {
2024-08-05 07:48:38.346399 | controller |     "changed": false,
2024-08-05 07:48:38.346446 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:38.346455 | controller | }
2024-08-05 07:48:38.346462 | controller |
2024-08-05 07:48:38.346470 | controller | TASK [lookup_secretsmanager_secret : create secret "ansible-test-70e78cda4380-secret"] ***
2024-08-05 07:48:38.346478 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:59
2024-08-05 07:48:38.346492 | controller | Using module file /home/zuul-worker/.ansible/collections/ansible_collections/community/aws/plugins/modules/secretsmanager_secret.py
2024-08-05 07:48:38.843019 | controller | Pipelining is enabled.
2024-08-05 07:48:38.843157 | controller | <testhost> ESTABLISH LOCAL CONNECTION FOR USER: zuul-worker
2024-08-05 07:48:38.843169 | controller | <testhost> EXEC /bin/sh -c 'ANSIBLE_DEBUG_BOTOCORE_LOGS=True /home/zuul-worker/venv/bin/python && sleep 0'
2024-08-05 07:48:38.843177 | controller | changed: [testhost] => {
2024-08-05 07:48:38.843186 | controller |     "changed": true,
2024-08-05 07:48:38.843193 | controller |     "invocation": {
2024-08-05 07:48:38.843200 | controller |         "module_args": {
2024-08-05 07:48:38.843207 | controller |             "access_key": "ASIA6CCDWXDOFIBKOECE",
2024-08-05 07:48:38.843215 | controller |             "aws_ca_bundle": null,
2024-08-05 07:48:38.843222 | controller |             "aws_config": null,
2024-08-05 07:48:38.843229 | controller |             "debug_botocore_endpoint_logs": true,
2024-08-05 07:48:38.843236 | controller |             "description": "",
2024-08-05 07:48:38.843259 | controller |             "endpoint_url": null,
2024-08-05 07:48:38.843267 | controller |             "json_secret": null,
2024-08-05 07:48:38.843274 | controller |             "kms_key_id": null,
2024-08-05 07:48:38.843281 | controller |             "name": "ansible-test-70e78cda4380-secret",
2024-08-05 07:48:38.843288 | controller |             "overwrite": true,
2024-08-05 07:48:38.843299 | controller |             "profile": null,
2024-08-05 07:48:38.843308 | controller |             "purge_tags": true,
2024-08-05 07:48:38.843315 | controller |             "recovery_window": 30,
2024-08-05 07:48:38.843322 | controller |             "region": "us-east-1",
2024-08-05 07:48:38.843329 | controller |             "replica": null,
2024-08-05 07:48:38.843336 | controller |             "resource_policy": null,
2024-08-05 07:48:38.843345 | controller |             "rotation_interval": 30,
2024-08-05 07:48:38.843353 | controller |             "rotation_lambda": null,
2024-08-05 07:48:38.843361 | controller |             "secret": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:38.843368 | controller |             "secret_key": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:38.843376 | controller |             "secret_type": "string",
2024-08-05 07:48:38.843383 | controller |             "session_token": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:38.843390 | controller |             "state": "present",
2024-08-05 07:48:38.843398 | controller |             "tags": {
2024-08-05 07:48:38.843405 | controller |                 "ansible-test": "aws-tests-integration"
2024-08-05 07:48:38.843412 | controller |             },
2024-08-05 07:48:38.843420 | controller |             "validate_certs": true
2024-08-05 07:48:38.843428 | controller |         }
2024-08-05 07:48:38.843435 | controller |     },
2024-08-05 07:48:38.843442 | controller |     "resource_actions": [
2024-08-05 07:48:38.843450 | controller |         "secretsmanager:CreateSecret",
2024-08-05 07:48:38.843457 | controller |         "secretsmanager:DescribeSecret"
2024-08-05 07:48:38.843464 | controller |     ],
2024-08-05 07:48:38.843470 | controller |     "secret": {
2024-08-05 07:48:38.843478 | controller |         "arn": "arn:aws:secretsmanager:us-east-1:966509639900:secret:ansible-test-70e78cda4380-secret-FLAzbn",
2024-08-05 07:48:38.843485 | controller |         "created_date": "2024-08-05T07:48:38.081000+00:00",
2024-08-05 07:48:38.843492 | controller |         "last_changed_date": "2024-08-05T07:48:38.119000+00:00",
2024-08-05 07:48:38.843499 | controller |         "name": "ansible-test-70e78cda4380-secret",
2024-08-05 07:48:38.843506 | controller |         "tags": [
2024-08-05 07:48:38.843513 | controller |             {
2024-08-05 07:48:38.843520 | controller |                 "key": "ansible-test",
2024-08-05 07:48:38.843527 | controller |                 "value": "aws-tests-integration"
2024-08-05 07:48:38.843716 | controller |             }
2024-08-05 07:48:38.843730 | controller |         ],
2024-08-05 07:48:38.843737 | controller |         "tags_dict": {
2024-08-05 07:48:38.843744 | controller |             "ansible-test": "aws-tests-integration"
2024-08-05 07:48:38.843752 | controller |         },
2024-08-05 07:48:38.843758 | controller |         "version_ids_to_stages": {
2024-08-05 07:48:38.843765 | controller |             "aeba4699-2015-42c8-8d0f-1e3a150d8cf0": [
2024-08-05 07:48:38.843772 | controller |                 "AWSCURRENT"
2024-08-05 07:48:38.843788 | controller |             ]
2024-08-05 07:48:38.843795 | controller |         }
2024-08-05 07:48:38.843802 | controller |     }
2024-08-05 07:48:38.843809 | controller | }
2024-08-05 07:48:38.843817 | controller |
2024-08-05 07:48:38.843824 | controller | TASK [lookup_secretsmanager_secret : read secret value] ************************
2024-08-05 07:48:38.843831 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:68
2024-08-05 07:48:38.843849 | controller | ok: [testhost] => {
2024-08-05 07:48:38.894447 | controller |     "ansible_facts": {
2024-08-05 07:48:38.894492 | controller |         "look_secret": "kqm+/}6>+-dy!$-<"
2024-08-05 07:48:38.894501 | controller |     },
2024-08-05 07:48:38.894508 | controller |     "changed": false
2024-08-05 07:48:38.894515 | controller | }
2024-08-05 07:48:38.894522 | controller |
2024-08-05 07:48:38.894529 | controller | TASK [lookup_secretsmanager_secret : assert that secret was successfully retrieved] ***
2024-08-05 07:48:38.894537 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:72
2024-08-05 07:48:38.894551 | controller | ok: [testhost] => {
2024-08-05 07:48:39.462975 | controller |     "changed": false,
2024-08-05 07:48:39.463019 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:39.463028 | controller | }
2024-08-05 07:48:39.463036 | controller |
2024-08-05 07:48:39.463043 | controller | TASK [lookup_secretsmanager_secret : read secret value (by ARN)] ***************
2024-08-05 07:48:39.463050 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:77
2024-08-05 07:48:39.463070 | controller | ok: [testhost] => {
2024-08-05 07:48:39.510799 | controller |     "ansible_facts": {
2024-08-05 07:48:39.510846 | controller |         "look_secret_by_arn": "kqm+/}6>+-dy!$-<"
2024-08-05 07:48:39.510855 | controller |     },
2024-08-05 07:48:39.510863 | controller |     "changed": false
2024-08-05 07:48:39.510870 | controller | }
2024-08-05 07:48:39.510877 | controller |
2024-08-05 07:48:39.510884 | controller | TASK [lookup_secretsmanager_secret : assert that secret was successfully retrieved] ***
2024-08-05 07:48:39.510892 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:81
2024-08-05 07:48:39.510907 | controller | ok: [testhost] => {
2024-08-05 07:48:40.626168 | controller |     "changed": false,
2024-08-05 07:48:40.626216 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:40.626227 | controller | }
2024-08-05 07:48:40.626235 | controller |
2024-08-05 07:48:40.626258 | controller | TASK [lookup_secretsmanager_secret : delete secret] ****************************
2024-08-05 07:48:40.626267 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:86
2024-08-05 07:48:40.626294 | controller | Using module file /home/zuul-worker/.ansible/collections/ansible_collections/community/aws/plugins/modules/secretsmanager_secret.py
2024-08-05 07:48:41.211339 | controller | Pipelining is enabled.
2024-08-05 07:48:41.211384 | controller | <testhost> ESTABLISH LOCAL CONNECTION FOR USER: zuul-worker
2024-08-05 07:48:41.211394 | controller | <testhost> EXEC /bin/sh -c 'ANSIBLE_DEBUG_BOTOCORE_LOGS=True /home/zuul-worker/venv/bin/python && sleep 0'
2024-08-05 07:48:41.211401 | controller | changed: [testhost] => {
2024-08-05 07:48:41.211408 | controller |     "changed": true,
2024-08-05 07:48:41.211416 | controller |     "invocation": {
2024-08-05 07:48:41.211422 | controller |         "module_args": {
2024-08-05 07:48:41.211429 | controller |             "access_key": "ASIA6CCDWXDOFIBKOECE",
2024-08-05 07:48:41.211436 | controller |             "aws_ca_bundle": null,
2024-08-05 07:48:41.211443 | controller |             "aws_config": null,
2024-08-05 07:48:41.211450 | controller |             "debug_botocore_endpoint_logs": true,
2024-08-05 07:48:41.211457 | controller |             "description": "",
2024-08-05 07:48:41.211464 | controller |             "endpoint_url": null,
2024-08-05 07:48:41.211471 | controller |             "json_secret": null,
2024-08-05 07:48:41.211479 | controller |             "kms_key_id": null,
2024-08-05 07:48:41.211486 | controller |             "name": "ansible-test-70e78cda4380-secret",
2024-08-05 07:48:41.211493 | controller |             "overwrite": true,
2024-08-05 07:48:41.211499 | controller |             "profile": null,
2024-08-05 07:48:41.211506 | controller |             "purge_tags": true,
2024-08-05 07:48:41.211513 | controller |             "recovery_window": 7,
2024-08-05 07:48:41.211520 | controller |             "region": "us-east-1",
2024-08-05 07:48:41.211527 | controller |             "replica": null,
2024-08-05 07:48:41.211534 | controller |             "resource_policy": null,
2024-08-05 07:48:41.211541 | controller |             "rotation_interval": 30,
2024-08-05 07:48:41.211548 | controller |             "rotation_lambda": null,
2024-08-05 07:48:41.211555 | controller |             "secret": "",
2024-08-05 07:48:41.211561 | controller |             "secret_key": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:41.211568 | controller |             "secret_type": "string",
2024-08-05 07:48:41.211575 | controller |             "session_token": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:41.211582 | controller |             "state": "absent",
2024-08-05 07:48:41.211589 | controller |             "tags": null,
2024-08-05 07:48:41.211596 | controller |             "validate_certs": true
2024-08-05 07:48:41.211603 | controller |         }
2024-08-05 07:48:41.211612 | controller |     },
2024-08-05 07:48:41.211619 | controller |     "resource_actions": [
2024-08-05 07:48:41.211627 | controller |         "secretsmanager:DeleteSecret",
2024-08-05 07:48:41.211634 | controller |         "secretsmanager:DescribeSecret"
2024-08-05 07:48:41.211641 | controller |     ],
2024-08-05 07:48:41.211648 | controller |     "secret": {
2024-08-05 07:48:41.211655 | controller |         "arn": "arn:aws:secretsmanager:us-east-1:966509639900:secret:ansible-test-70e78cda4380-secret-FLAzbn",
2024-08-05 07:48:41.211662 | controller |         "deletion_date": "2024-08-12T07:48:40.420000+00:00",
2024-08-05 07:48:41.211674 | controller |         "name": "ansible-test-70e78cda4380-secret",
2024-08-05 07:48:41.211682 | controller |         "response_metadata": {
2024-08-05 07:48:41.211691 | controller |             "http_headers": {
2024-08-05 07:48:41.211698 | controller |                 "content-length": "175",
2024-08-05 07:48:41.211705 | controller |                 "content-type": "application/x-amz-json-1.1",
2024-08-05 07:48:41.211712 | controller |                 "date": "Mon, 05 Aug 2024 07:48:39 GMT",
2024-08-05 07:48:41.211719 | controller |                 "x-amzn-requestid": "b23427cc-3a5d-4f67-a127-df3b106deeae"
2024-08-05 07:48:41.211726 | controller |             },
2024-08-05 07:48:41.211733 | controller |             "http_status_code": 200,
2024-08-05 07:48:41.211740 | controller |             "request_id": "b23427cc-3a5d-4f67-a127-df3b106deeae",
2024-08-05 07:48:41.211747 | controller |             "retry_attempts": 0
2024-08-05 07:48:41.211754 | controller |         }
2024-08-05 07:48:41.211760 | controller |     }
2024-08-05 07:48:41.211767 | controller | }
2024-08-05 07:48:41.211774 | controller |
2024-08-05 07:48:41.211781 | controller | TASK [lookup_secretsmanager_secret : lookup deleted secret (skip)] *************
2024-08-05 07:48:41.211789 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:92
2024-08-05 07:48:41.211804 | controller | ok: [testhost] => {
2024-08-05 07:48:41.273614 | controller |     "ansible_facts": {
2024-08-05 07:48:41.273683 | controller |         "deleted_secret": []
2024-08-05 07:48:41.273691 | controller |     },
2024-08-05 07:48:41.273699 | controller |     "changed": false
2024-08-05 07:48:41.273747 | controller | }
2024-08-05 07:48:41.273760 | controller |
2024-08-05 07:48:41.273768 | controller | TASK [lookup_secretsmanager_secret : assert that deleted_secret is defined] ****
2024-08-05 07:48:41.273776 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:96
2024-08-05 07:48:41.273798 | controller | ok: [testhost] => {
2024-08-05 07:48:41.779346 | controller |     "changed": false,
2024-08-05 07:48:41.779393 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:41.779403 | controller | }
2024-08-05 07:48:41.779412 | controller |
2024-08-05 07:48:41.779420 | controller | TASK [lookup_secretsmanager_secret : lookup deleted secret (warn)] *************
2024-08-05 07:48:41.779428 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:102
2024-08-05 07:48:41.779450 | controller | [WARNING]: Skipping, did not find secret (marked for deletion) ansible-
2024-08-05 07:48:41.795784 | controller | test-70e78cda4380-secret
2024-08-05 07:48:41.795844 | controller | ok: [testhost] => {
2024-08-05 07:48:41.849393 | controller |     "ansible_facts": {
2024-08-05 07:48:41.849438 | controller |         "deleted_secret": []
2024-08-05 07:48:41.849447 | controller |     },
2024-08-05 07:48:41.849454 | controller |     "changed": false
2024-08-05 07:48:41.849461 | controller | }
2024-08-05 07:48:41.849468 | controller |
2024-08-05 07:48:41.849476 | controller | TASK [lookup_secretsmanager_secret : assert that deleted_secret is defined] ****
2024-08-05 07:48:41.849483 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:106
2024-08-05 07:48:41.849503 | controller | ok: [testhost] => {
2024-08-05 07:48:42.415154 | controller |     "changed": false,
2024-08-05 07:48:42.415268 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:42.415351 | controller | }
2024-08-05 07:48:42.415361 | controller |
2024-08-05 07:48:42.415368 | controller | TASK [lookup_secretsmanager_secret : lookup deleted secret (error)] ************
2024-08-05 07:48:42.415376 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:112
2024-08-05 07:48:42.415392 | controller | fatal: [testhost]: FAILED! => {
2024-08-05 07:48:42.465785 | controller |     "msg": "Failed to find secret ansible-test-70e78cda4380-secret (marked for deletion)"
2024-08-05 07:48:42.465829 | controller | }
2024-08-05 07:48:42.465837 | controller | ...ignoring
2024-08-05 07:48:42.465844 | controller |
2024-08-05 07:48:42.465851 | controller | TASK [lookup_secretsmanager_secret : assert that setting the deleted_secret failed] ***
2024-08-05 07:48:42.465862 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:118
2024-08-05 07:48:42.465879 | controller | ok: [testhost] => {
2024-08-05 07:48:42.516486 | controller |     "changed": false,
2024-08-05 07:48:42.516608 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:42.516618 | controller | }
2024-08-05 07:48:42.516626 | controller |
2024-08-05 07:48:42.516634 | controller | TASK [lookup_secretsmanager_secret : include_tasks] ****************************
2024-08-05 07:48:42.516641 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:124
2024-08-05 07:48:42.516657 | controller | included: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml for testhost
2024-08-05 07:48:43.630995 | controller |
2024-08-05 07:48:43.631042 | controller | TASK [lookup_secretsmanager_secret : create secret "ansible-test-70e78cda4380-secret-json"] ***
2024-08-05 07:48:43.631052 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:6
2024-08-05 07:48:43.631075 | controller | Using module file /home/zuul-worker/.ansible/collections/ansible_collections/community/aws/plugins/modules/secretsmanager_secret.py
2024-08-05 07:48:44.065552 | controller | Pipelining is enabled.
2024-08-05 07:48:44.065596 | controller | <testhost> ESTABLISH LOCAL CONNECTION FOR USER: zuul-worker
2024-08-05 07:48:44.065606 | controller | <testhost> EXEC /bin/sh -c 'ANSIBLE_DEBUG_BOTOCORE_LOGS=True /home/zuul-worker/venv/bin/python && sleep 0'
2024-08-05 07:48:44.065616 | controller | changed: [testhost] => {
2024-08-05 07:48:44.065623 | controller |     "changed": true,
2024-08-05 07:48:44.065630 | controller |     "invocation": {
2024-08-05 07:48:44.065636 | controller |         "module_args": {
2024-08-05 07:48:44.065643 | controller |             "access_key": "ASIA6CCDWXDOFIBKOECE",
2024-08-05 07:48:44.065651 | controller |             "aws_ca_bundle": null,
2024-08-05 07:48:44.065658 | controller |             "aws_config": null,
2024-08-05 07:48:44.065665 | controller |             "debug_botocore_endpoint_logs": true,
2024-08-05 07:48:44.065672 | controller |             "description": "",
2024-08-05 07:48:44.065679 | controller |             "endpoint_url": null,
2024-08-05 07:48:44.065690 | controller |             "json_secret": null,
2024-08-05 07:48:44.065697 | controller |             "kms_key_id": null,
2024-08-05 07:48:44.065705 | controller |             "name": "ansible-test-70e78cda4380-secret-json",
2024-08-05 07:48:44.065712 | controller |             "overwrite": true,
2024-08-05 07:48:44.065719 | controller |             "profile": null,
2024-08-05 07:48:44.065726 | controller |             "purge_tags": true,
2024-08-05 07:48:44.065733 | controller |             "recovery_window": 30,
2024-08-05 07:48:44.065821 | controller |             "region": "us-east-1",
2024-08-05 07:48:44.065890 | controller |             "replica": null,
2024-08-05 07:48:44.065900 | controller |             "resource_policy": null,
2024-08-05 07:48:44.065908 | controller |             "rotation_interval": 30,
2024-08-05 07:48:44.065915 | controller |             "rotation_lambda": null,
2024-08-05 07:48:44.065922 | controller |             "secret": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:44.065931 | controller |             "secret_key": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:44.065939 | controller |             "secret_type": "string",
2024-08-05 07:48:44.065946 | controller |             "session_token": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:44.065954 | controller |             "state": "present",
2024-08-05 07:48:44.065961 | controller |             "tags": null,
2024-08-05 07:48:44.065968 | controller |             "validate_certs": true
2024-08-05 07:48:44.066173 | controller |         }
2024-08-05 07:48:44.066284 | controller |     },
2024-08-05 07:48:44.066306 | controller |     "resource_actions": [
2024-08-05 07:48:44.066315 | controller |         "secretsmanager:CreateSecret",
2024-08-05 07:48:44.066322 | controller |         "secretsmanager:DescribeSecret"
2024-08-05 07:48:44.066329 | controller |     ],
2024-08-05 07:48:44.066336 | controller |     "secret": {
2024-08-05 07:48:44.066344 | controller |         "arn": "arn:aws:secretsmanager:us-east-1:966509639900:secret:ansible-test-70e78cda4380-secret-json-DQR3ZO",
2024-08-05 07:48:44.066355 | controller |         "created_date": "2024-08-05T07:48:43.426000+00:00",
2024-08-05 07:48:44.066364 | controller |         "last_changed_date": "2024-08-05T07:48:43.463000+00:00",
2024-08-05 07:48:44.066371 | controller |         "name": "ansible-test-70e78cda4380-secret-json",
2024-08-05 07:48:44.066378 | controller |         "version_ids_to_stages": {
2024-08-05 07:48:44.066385 | controller |             "31cdf6ba-6ee3-45b5-9899-38fe0086e39e": [
2024-08-05 07:48:44.066392 | controller |                 "AWSCURRENT"
2024-08-05 07:48:44.066399 | controller |             ]
2024-08-05 07:48:44.066406 | controller |         }
2024-08-05 07:48:44.066413 | controller |     }
2024-08-05 07:48:44.066420 | controller | }
2024-08-05 07:48:44.066428 | controller |
2024-08-05 07:48:44.066435 | controller | TASK [lookup_secretsmanager_secret : Validate nested secret value] *************
2024-08-05 07:48:44.066443 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:12
2024-08-05 07:48:44.066459 | controller | ok: [testhost] => {
2024-08-05 07:48:44.492780 | controller |     "changed": false,
2024-08-05 07:48:44.492824 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:44.492833 | controller | }
2024-08-05 07:48:44.492841 | controller |
2024-08-05 07:48:44.492848 | controller | TASK [lookup_secretsmanager_secret : Read missing secret variable using 'on_missing==error'] ***
2024-08-05 07:48:44.492856 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:17
2024-08-05 07:48:44.492871 | controller | fatal: [testhost]: FAILED! => {
2024-08-05 07:48:44.539512 | controller |     "msg": "Successfully retrieved secret but there exists no key missing_err_secret in the secret"
2024-08-05 07:48:44.539553 | controller | }
2024-08-05 07:48:44.539562 | controller | ...ignoring
2024-08-05 07:48:44.539569 | controller |
2024-08-05 07:48:44.539576 | controller | TASK [lookup_secretsmanager_secret : Ensure the lookup raised an error] ********
2024-08-05 07:48:44.539586 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:23
2024-08-05 07:48:44.539599 | controller | ok: [testhost] => {
2024-08-05 07:48:44.950904 | controller |     "changed": false,
2024-08-05 07:48:44.950948 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:44.950957 | controller | }
2024-08-05 07:48:44.950964 | controller |
2024-08-05 07:48:44.950971 | controller | TASK [lookup_secretsmanager_secret : Read missing secret variable using 'on_missing==error'] ***
2024-08-05 07:48:44.950979 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:30
2024-08-05 07:48:44.951000 | controller | fatal: [testhost]: FAILED! => {
2024-08-05 07:48:44.992578 | controller |     "msg": "Successfully retrieved secret but there exists no key resource_prefix.child in the secret"
2024-08-05 07:48:44.992623 | controller | }
2024-08-05 07:48:44.992634 | controller | ...ignoring
2024-08-05 07:48:44.992641 | controller |
2024-08-05 07:48:44.992648 | controller | TASK [lookup_secretsmanager_secret : Ensure the lookup raised an error] ********
2024-08-05 07:48:44.992655 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:36
2024-08-05 07:48:44.992670 | controller | ok: [testhost] => {
2024-08-05 07:48:45.389336 | controller |     "changed": false,
2024-08-05 07:48:45.389382 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:45.389392 | controller | }
2024-08-05 07:48:45.389401 | controller |
2024-08-05 07:48:45.389409 | controller | TASK [lookup_secretsmanager_secret : Read missing secret variable using 'on_missing==warn'] ***
2024-08-05 07:48:45.389417 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:43
2024-08-05 07:48:45.389433 | controller | [WARNING]: Skipping, Successfully retrieved secret but there exists no key
2024-08-05 07:48:45.403892 | controller | missing_wrn_secret in the secret
2024-08-05 07:48:45.403945 | controller | ok: [testhost] => {
2024-08-05 07:48:45.443429 | controller |     "ansible_facts": {
2024-08-05 07:48:45.443471 | controller |         "missing_wrn_secret": []
2024-08-05 07:48:45.443479 | controller |     },
2024-08-05 07:48:45.443491 | controller |     "changed": false
2024-08-05 07:48:45.443500 | controller | }
2024-08-05 07:48:45.443507 | controller |
2024-08-05 07:48:45.443514 | controller | TASK [lookup_secretsmanager_secret : Ensure that the variable has not been defined] ***
2024-08-05 07:48:45.443521 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:47
2024-08-05 07:48:45.443536 | controller | ok: [testhost] => {
2024-08-05 07:48:46.223257 | controller |     "changed": false,
2024-08-05 07:48:46.223303 | controller |     "msg": "All assertions passed"
2024-08-05 07:48:46.223312 | controller | }
2024-08-05 07:48:46.223321 | controller |
2024-08-05 07:48:46.223328 | controller | TASK [lookup_secretsmanager_secret : Delete secret 'ansible-test-70e78cda4380-secret-json'] ***
2024-08-05 07:48:46.223336 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/nested.yaml:54
2024-08-05 07:48:46.223351 | controller | Using module file /home/zuul-worker/.ansible/collections/ansible_collections/community/aws/plugins/modules/secretsmanager_secret.py
2024-08-05 07:48:47.228881 | controller | Pipelining is enabled.
2024-08-05 07:48:47.228927 | controller | <testhost> ESTABLISH LOCAL CONNECTION FOR USER: zuul-worker
2024-08-05 07:48:47.228939 | controller | <testhost> EXEC /bin/sh -c 'ANSIBLE_DEBUG_BOTOCORE_LOGS=True /home/zuul-worker/venv/bin/python && sleep 0'
2024-08-05 07:48:47.228947 | controller | changed: [testhost] => {
2024-08-05 07:48:47.228954 | controller |     "changed": true,
2024-08-05 07:48:47.228962 | controller |     "invocation": {
2024-08-05 07:48:47.228969 | controller |         "module_args": {
2024-08-05 07:48:47.229018 | controller |             "access_key": "ASIA6CCDWXDOFIBKOECE",
2024-08-05 07:48:47.229027 | controller |             "aws_ca_bundle": null,
2024-08-05 07:48:47.229035 | controller |             "aws_config": null,
2024-08-05 07:48:47.229042 | controller |             "debug_botocore_endpoint_logs": true,
2024-08-05 07:48:47.229050 | controller |             "description": "",
2024-08-05 07:48:47.229057 | controller |             "endpoint_url": null,
2024-08-05 07:48:47.229065 | controller |             "json_secret": null,
2024-08-05 07:48:47.229072 | controller |             "kms_key_id": null,
2024-08-05 07:48:47.229080 | controller |             "name": "ansible-test-70e78cda4380-secret-json",
2024-08-05 07:48:47.229087 | controller |             "overwrite": true,
2024-08-05 07:48:47.229094 | controller |             "profile": null,
2024-08-05 07:48:47.229102 | controller |             "purge_tags": true,
2024-08-05 07:48:47.229115 | controller |             "recovery_window": 0,
2024-08-05 07:48:47.229122 | controller |             "region": "us-east-1",
2024-08-05 07:48:47.229129 | controller |             "replica": null,
2024-08-05 07:48:47.229137 | controller |             "resource_policy": null,
2024-08-05 07:48:47.229144 | controller |             "rotation_interval": 30,
2024-08-05 07:48:47.229151 | controller |             "rotation_lambda": null,
2024-08-05 07:48:47.229159 | controller |             "secret": "",
2024-08-05 07:48:47.229167 | controller |             "secret_key": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:47.229174 | controller |             "secret_type": "string",
2024-08-05 07:48:47.229182 | controller |             "session_token": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:47.229190 | controller |             "state": "absent",
2024-08-05 07:48:47.229198 | controller |             "tags": null,
2024-08-05 07:48:47.229205 | controller |             "validate_certs": true
2024-08-05 07:48:47.229213 | controller |         }
2024-08-05 07:48:47.229221 | controller |     },
2024-08-05 07:48:47.229228 | controller |     "resource_actions": [
2024-08-05 07:48:47.229235 | controller |         "secretsmanager:DescribeSecret",
2024-08-05 07:48:47.229270 | controller |         "secretsmanager:DeleteSecret"
2024-08-05 07:48:47.229279 | controller |     ],
2024-08-05 07:48:47.229286 | controller |     "secret": {
2024-08-05 07:48:47.229294 | controller |         "arn": "arn:aws:secretsmanager:us-east-1:966509639900:secret:ansible-test-70e78cda4380-secret-json-DQR3ZO",
2024-08-05 07:48:47.229302 | controller |         "deletion_date": "2024-08-05T07:48:46.082000+00:00",
2024-08-05 07:48:47.229310 | controller |         "name": "ansible-test-70e78cda4380-secret-json",
2024-08-05 07:48:47.229317 | controller |         "response_metadata": {
2024-08-05 07:48:47.229325 | controller |             "http_headers": {
2024-08-05 07:48:47.229332 | controller |                 "content-length": "186",
2024-08-05 07:48:47.229346 | controller |                 "content-type": "application/x-amz-json-1.1",
2024-08-05 07:48:47.229355 | controller |                 "date": "Mon, 05 Aug 2024 07:48:45 GMT",
2024-08-05 07:48:47.229362 | controller |                 "x-amzn-requestid": "359a1bc6-3e1e-414b-ac40-f7d4015ff73a"
2024-08-05 07:48:47.229370 | controller |             },
2024-08-05 07:48:47.229377 | controller |             "http_status_code": 200,
2024-08-05 07:48:47.229384 | controller |             "request_id": "359a1bc6-3e1e-414b-ac40-f7d4015ff73a",
2024-08-05 07:48:47.229391 | controller |             "retry_attempts": 0
2024-08-05 07:48:47.229399 | controller |         }
2024-08-05 07:48:47.229406 | controller |     }
2024-08-05 07:48:47.229414 | controller | }
2024-08-05 07:48:47.229421 | controller |
2024-08-05 07:48:47.229429 | controller | TASK [lookup_secretsmanager_secret : delete secret] ****************************
2024-08-05 07:48:47.229436 | controller | task path: /home/zuul-worker/.ansible/collections/ansible_collections/amazon/aws/tests/integration/targets/lookup_secretsmanager_secret/tasks/main.yaml:128
2024-08-05 07:48:47.229454 | controller | Using module file /home/zuul-worker/.ansible/collections/ansible_collections/community/aws/plugins/modules/secretsmanager_secret.py
2024-08-05 07:48:47.425395 | controller | Pipelining is enabled.
2024-08-05 07:48:47.425443 | controller | <testhost> ESTABLISH LOCAL CONNECTION FOR USER: zuul-worker
2024-08-05 07:48:47.425456 | controller | <testhost> EXEC /bin/sh -c 'ANSIBLE_DEBUG_BOTOCORE_LOGS=True /home/zuul-worker/venv/bin/python && sleep 0'
2024-08-05 07:48:47.425591 | controller | changed: [testhost] => {
2024-08-05 07:48:47.425602 | controller |     "changed": true,
2024-08-05 07:48:47.425610 | controller |     "invocation": {
2024-08-05 07:48:47.425621 | controller |         "module_args": {
2024-08-05 07:48:47.425629 | controller |             "access_key": "ASIA6CCDWXDOFIBKOECE",
2024-08-05 07:48:47.425637 | controller |             "aws_ca_bundle": null,
2024-08-05 07:48:47.425645 | controller |             "aws_config": null,
2024-08-05 07:48:47.425653 | controller |             "debug_botocore_endpoint_logs": true,
2024-08-05 07:48:47.425661 | controller |             "description": "",
2024-08-05 07:48:47.425668 | controller |             "endpoint_url": null,
2024-08-05 07:48:47.425724 | controller |             "json_secret": null,
2024-08-05 07:48:47.425733 | controller |             "kms_key_id": null,
2024-08-05 07:48:47.425740 | controller |             "name": "ansible-test-70e78cda4380-secret",
2024-08-05 07:48:47.425748 | controller |             "overwrite": true,
2024-08-05 07:48:47.425756 | controller |             "profile": null,
2024-08-05 07:48:47.425763 | controller |             "purge_tags": true,
2024-08-05 07:48:47.425769 | controller |             "recovery_window": 0,
2024-08-05 07:48:47.425776 | controller |             "region": "us-east-1",
2024-08-05 07:48:47.425783 | controller |             "replica": null,
2024-08-05 07:48:47.425790 | controller |             "resource_policy": null,
2024-08-05 07:48:47.425797 | controller |             "rotation_interval": 30,
2024-08-05 07:48:47.425804 | controller |             "rotation_lambda": null,
2024-08-05 07:48:47.425812 | controller |             "secret": "",
2024-08-05 07:48:47.425819 | controller |             "secret_key": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:47.425826 | controller |             "secret_type": "string",
2024-08-05 07:48:47.425835 | controller |             "session_token": "VALUE_SPECIFIED_IN_NO_LOG_PARAMETER",
2024-08-05 07:48:47.425843 | controller |             "state": "absent",
2024-08-05 07:48:47.425851 | controller |             "tags": null,
2024-08-05 07:48:47.425858 | controller |             "validate_certs": true
2024-08-05 07:48:47.425866 | controller |         }
2024-08-05 07:48:47.425874 | controller |     },
2024-08-05 07:48:47.425881 | controller |     "resource_actions": [
2024-08-05 07:48:47.425889 | controller |         "secretsmanager:DeleteSecret",
2024-08-05 07:48:47.425897 | controller |         "secretsmanager:DescribeSecret"
2024-08-05 07:48:47.425904 | controller |     ],
2024-08-05 07:48:47.425911 | controller |     "secret": {
2024-08-05 07:48:47.425920 | controller |         "arn": "arn:aws:secretsmanager:us-east-1:966509639900:secret:ansible-test-70e78cda4380-secret-FLAzbn",
2024-08-05 07:48:47.425928 | controller |         "deletion_date": "2024-08-05T07:48:47.044000+00:00",
2024-08-05 07:48:47.425937 | controller |         "name": "ansible-test-70e78cda4380-secret",
2024-08-05 07:48:47.425945 | controller |         "response_metadata": {
2024-08-05 07:48:47.425952 | controller |             "http_headers": {
2024-08-05 07:48:47.425973 | controller |                 "content-length": "176",
2024-08-05 07:48:47.425981 | controller |                 "content-type": "application/x-amz-json-1.1",
2024-08-05 07:48:47.425988 | controller |                 "date": "Mon, 05 Aug 2024 07:48:46 GMT",
2024-08-05 07:48:47.425995 | controller |                 "x-amzn-requestid": "6d0a4982-f4c8-4905-93d7-597496bfec74"
2024-08-05 07:48:47.426003 | controller |             },
2024-08-05 07:48:47.426084 | controller |             "http_status_code": 200,
2024-08-05 07:48:47.426094 | controller |             "request_id": "6d0a4982-f4c8-4905-93d7-597496bfec74",
2024-08-05 07:48:47.426174 | controller |             "retry_attempts": 0
2024-08-05 07:48:47.426186 | controller |         }
2024-08-05 07:48:47.426193 | controller |     }
2024-08-05 07:48:47.426201 | controller | }
2024-08-05 07:48:47.426209 | controller |
2024-08-05 07:48:47.426216 | controller | PLAY RECAP *********************************************************************
2024-08-05 07:48:47.426225 | controller | testhost                   : ok=32   changed=5    unreachable=0    failed=0    skipped=0    rescued=0    ignored=4
2024-08-05 07:48:47.426233 | controller |
2024-08-05 07:48:47.426255 | controller | AWS ACTIONS: ['secretsmanager:CreateSecret', 'secretsmanager:DeleteSecret', 'secretsmanager:DescribeSecret']
2024-08-05 07:48:47.426276 | controller | Command exited with status 0 after 16.274201154708862 seconds.
2024-08-05 07:48:47.426508 | controller | WARNING: Reviewing previous 2 warning(s):
2024-08-05 07:48:47.426525 | controller | WARNING: PyYAML will be slow due to installation without libyaml support for interpreter: /home/zuul-worker/venv/bin/python
2024-08-05 07:48:47.426532 | controller | WARNING: Disabling the temp work dir is a temporary debugging feature that may be removed in the future without notice.
2024-08-05 07:48:47.426542 | controller | Cleaning up temporary python directory: /tmp/python-5nw0pgna-ansible
2024-08-05 07:48:47.619143 | controller | ok: Runtime: 0:00:21.585815
2024-08-05 07:48:47.682574 | 
2024-08-05 07:48:47.682742 | PLAY RECAP
2024-08-05 07:48:47.682821 | controller | ok: 22 changed: 7 unreachable: 0 failed: 0 skipped: 19 rescued: 0 ignored: 0
2024-08-05 07:48:47.682863 | 
2024-08-05 07:48:47.791662 | RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2024-08-05 07:48:47.794027 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2024-08-05 07:48:48.318329 | 
2024-08-05 07:48:48.318459 | PLAY [all:!appliance*]
2024-08-05 07:48:48.339072 | 
2024-08-05 07:48:48.339199 | TASK [unregister the node]
2024-08-05 07:48:48.475180 | controller | skipping: Conditional result was False
2024-08-05 07:48:48.487250 | 
2024-08-05 07:48:48.487410 | TASK [include_role : fetch-output]
2024-08-05 07:48:48.533363 | controller | ok
2024-08-05 07:48:48.572045 | 
2024-08-05 07:48:48.572184 | TASK [fetch-output : Set log path for multiple nodes]
2024-08-05 07:48:48.637215 | controller | skipping: Conditional result was False
2024-08-05 07:48:48.649072 | 
2024-08-05 07:48:48.649226 | TASK [fetch-output : Set log path for single node]
2024-08-05 07:48:48.685635 | controller | ok
2024-08-05 07:48:48.697698 | 
2024-08-05 07:48:48.697853 | LOOP [fetch-output : Ensure local output dirs]
2024-08-05 07:48:49.083050 | controller -> localhost | ok: "/var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/logs"
2024-08-05 07:48:49.338065 | controller -> localhost | changed: "/var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/artifacts"
2024-08-05 07:48:49.569646 | controller -> localhost | changed: "/var/lib/zuul/builds/2cd1ff0d017e46de8a26858d97a96309/work/docs"
2024-08-05 07:48:49.588139 | 
2024-08-05 07:48:49.588270 | LOOP [fetch-output : Collect logs, artifacts and docs]
2024-08-05 07:48:50.785404 | controller | changed:
2024-08-05 07:48:50.785746 | controller | .d..t...... ./
2024-08-05 07:48:50.785817 | controller | cd+++++++++ controller/
2024-08-05 07:48:50.785925 | controller | changed: All items complete
2024-08-05 07:48:50.785991 | 
2024-08-05 07:48:51.710963 | controller | changed: .d..t...... ./
2024-08-05 07:48:52.662620 | controller | changed: .d..t...... ./
2024-08-05 07:48:52.688965 | 
2024-08-05 07:48:52.689182 | TASK [include_role : fetch-output-openshift]
2024-08-05 07:48:52.705675 | controller | skipping: Conditional result was False
2024-08-05 07:48:52.717667 | 
2024-08-05 07:48:52.717844 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2024-08-05 07:48:53.112408 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008673
2024-08-05 07:48:53.369211 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007926
2024-08-05 07:48:53.395077 | 
2024-08-05 07:48:53.395190 | PLAY [localhost]
2024-08-05 07:48:53.406920 | 
2024-08-05 07:48:53.406985 | TASK [Run Zuul manifest role]
2024-08-05 07:48:53.423469 | localhost | ok
2024-08-05 07:48:53.434959 | 
2024-08-05 07:48:53.435024 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2024-08-05 07:48:53.776870 | localhost | changed
2024-08-05 07:48:53.782793 | 
2024-08-05 07:48:53.782924 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2024-08-05 07:48:53.826563 | localhost | ok
2024-08-05 07:48:53.845387 | 
2024-08-05 07:48:53.845570 | TASK [Set zuul-log-path fact]
2024-08-05 07:48:53.866374 | localhost | ok
2024-08-05 07:48:53.890049 | 
2024-08-05 07:48:53.890189 | TASK [set-zuul-log-path-fact : Set log path for a change]
2024-08-05 07:48:53.914872 | localhost | skipping: Conditional result was False
2024-08-05 07:48:53.923767 | 
2024-08-05 07:48:53.923956 | TASK [set-zuul-log-path-fact : Set log path for a ref update]
2024-08-05 07:48:53.949969 | localhost | skipping: Conditional result was False
2024-08-05 07:48:53.959121 | 
2024-08-05 07:48:53.959264 | TASK [set-zuul-log-path-fact : Set log path for a periodic job]
2024-08-05 07:48:53.985186 | localhost | skipping: Conditional result was False
2024-08-05 07:48:53.991702 | 
2024-08-05 07:48:53.991798 | TASK [set-zuul-log-path-fact : Set log path for a change]
2024-08-05 07:48:54.042619 | localhost | ok
2024-08-05 07:48:54.048296 | 
2024-08-05 07:48:54.048406 | TASK [set-zuul-log-path-fact : Set log path for a ref update]
2024-08-05 07:48:54.073274 | localhost | skipping: Conditional result was False
2024-08-05 07:48:54.079795 | 
2024-08-05 07:48:54.079917 | TASK [set-zuul-log-path-fact : Set log path for a periodic job]
2024-08-05 07:48:54.107025 | localhost | skipping: Conditional result was False
2024-08-05 07:48:54.116172 | 
2024-08-05 07:48:54.116276 | LOOP [Run upload-logs-swift role]
2024-08-05 07:48:54.181140 | localhost | Output suppressed because no_log was given
2024-08-05 07:48:54.218292 | 
2024-08-05 07:48:54.218428 | TASK [Set zuul-log-path fact]
2024-08-05 07:48:54.242806 | localhost | skipping: Conditional result was False
2024-08-05 07:48:54.249588 | 
2024-08-05 07:48:54.249683 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2024-08-05 07:48:54.509911 | localhost -> localhost | ok: Runtime: 0:00:00.004955
2024-08-05 07:48:54.516639 | 
2024-08-05 07:48:54.516756 | TASK [upload-logs-swift : Upload logs to swift]