2026-02-27 00:23:48.475367 | Job console starting...
2026-02-27 00:23:48.487417 | Updating repositories
2026-02-27 00:23:48.651861 | Preparing job workspace
2026-02-27 00:23:53.920346 | Running Ansible setup...
2026-02-27 00:24:01.699363 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-27 00:24:02.390220 | 
2026-02-27 00:24:02.390382 | PLAY [localhost]
2026-02-27 00:24:02.412210 | 
2026-02-27 00:24:02.412351 | TASK [Gathering Facts]
2026-02-27 00:24:03.530827 | localhost | ok
2026-02-27 00:24:03.546444 | 
2026-02-27 00:24:03.546561 | TASK [Setup log path fact]
2026-02-27 00:24:03.583626 | localhost | ok
2026-02-27 00:24:03.621530 | 
2026-02-27 00:24:03.621672 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-27 00:24:03.685706 | localhost | ok
2026-02-27 00:24:03.697290 | 
2026-02-27 00:24:03.697426 | TASK [emit-job-header : Print job information]
2026-02-27 00:24:03.743786 | # Job Information
2026-02-27 00:24:03.743989 | Ansible Version: 2.15.12
2026-02-27 00:24:03.744054 | Job: ansible-test-sanity-docker-stable-2.9
2026-02-27 00:24:03.744079 | Pipeline: periodic
2026-02-27 00:24:03.744098 | Executor: ze03.softwarefactory-project.io
2026-02-27 00:24:03.744115 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-02-27 00:24:03.744135 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/a8f/ansible/a8f483601f764dd3af4f00a704fb9cc5/
2026-02-27 00:24:03.744154 | Event ID: c66414a510e648d9aec75995eff050a1
2026-02-27 00:24:03.749219 | 
2026-02-27 00:24:03.749312 | LOOP [emit-job-header : Print node information]
2026-02-27 00:24:03.868096 | localhost | ok:
2026-02-27 00:24:03.868300 | localhost | # Node Information
2026-02-27 00:24:03.868327 | localhost | Inventory Hostname: controller
2026-02-27 00:24:03.868345 | localhost | Hostname: np0005632251
2026-02-27 00:24:03.868363 | localhost | Username: zuul
2026-02-27 00:24:03.868387 | localhost | Distro: Fedora 37
2026-02-27 00:24:03.868405 | localhost | Provider: ansible-vexxhost-ams1
2026-02-27 00:24:03.868422 | localhost | Region: ams1
2026-02-27 00:24:03.868438 | localhost | Label: ansible-fedora-37-1vcpu
2026-02-27 00:24:03.868454 | localhost | Product Name: OpenStack Nova
2026-02-27 00:24:03.868470 | localhost | Interface IP: 38.129.16.109
2026-02-27 00:24:03.878305 | 
2026-02-27 00:24:03.878460 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-27 00:24:04.312645 | localhost -> localhost | changed
2026-02-27 00:24:04.323606 | 
2026-02-27 00:24:04.323764 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-27 00:24:05.330233 | localhost -> localhost | changed
2026-02-27 00:24:05.362549 | 
2026-02-27 00:24:05.362657 | PLAY [all:!appliance*]
2026-02-27 00:24:05.383142 | 
2026-02-27 00:24:05.383313 | TASK [include_role : start-zuul-console]
2026-02-27 00:24:05.409362 | controller | ok
2026-02-27 00:24:05.428222 | 
2026-02-27 00:24:05.428337 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-02-27 00:24:06.495697 | controller | ok
2026-02-27 00:24:06.518399 | 
2026-02-27 00:24:06.518525 | TASK [use-our-mirror : Retrieve the IP address]
2026-02-27 00:24:08.809488 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-02-27 00:24:08.819257 | 
2026-02-27 00:24:08.819455 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-02-27 00:24:09.209377 | controller | skipping: Conditional result was False
2026-02-27 00:24:09.217250 | 
2026-02-27 00:24:09.217374 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-02-27 00:24:09.242855 | controller | skipping: Conditional result was False
2026-02-27 00:24:09.251413 | 
2026-02-27 00:24:09.251553 | TASK [use-our-mirror : Create the podman configuration directory]
2026-02-27 00:24:09.286387 | controller | skipping: Conditional result was False
2026-02-27 00:24:09.297082 | 
2026-02-27 00:24:09.297251 | TASK [use-our-mirror : Copy the podman configuration]
2026-02-27 00:24:09.325374 | controller | skipping: Conditional result was False
2026-02-27 00:24:09.337887 | 
2026-02-27 00:24:09.338054 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-02-27 00:24:09.377599 | controller | skipping: Conditional result was False
2026-02-27 00:24:09.392656 | 
2026-02-27 00:24:09.392876 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-02-27 00:24:09.419894 | controller | skipping: Conditional result was False
2026-02-27 00:24:09.440541 | 
2026-02-27 00:24:09.440670 | TASK [Disable Fedora Modular]
2026-02-27 00:24:10.555243 | controller | changed
2026-02-27 00:24:10.563832 | 
2026-02-27 00:24:10.563925 | TASK [Enable EPEL]
2026-02-27 00:24:10.588043 | controller | skipping: Conditional result was False
2026-02-27 00:24:10.594649 | 
2026-02-27 00:24:10.594790 | TASK [Register the RHEL node]
2026-02-27 00:24:11.012418 | 
2026-02-27 00:24:11.012613 | TASK [Show the subscription-manager status]
2026-02-27 00:24:11.372210 | controller | skipping: Conditional result was False
2026-02-27 00:24:11.392834 | 
2026-02-27 00:24:11.392991 | TASK [Enable EPEL on RHEL]
2026-02-27 00:24:11.781124 | controller | skipping: Conditional result was False
2026-02-27 00:24:11.789370 | 
2026-02-27 00:24:11.789515 | TASK [Install git and tox]
2026-02-27 00:26:32.383277 | controller | changed
2026-02-27 00:26:32.393482 | 
2026-02-27 00:26:32.393601 | TASK [include_role : prepare-workspace]
2026-02-27 00:26:32.414986 | controller | ok
2026-02-27 00:26:32.642180 | 
2026-02-27 00:26:32.642280 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-27 00:26:44.386716 | controller | ok
2026-02-27 00:26:44.675981 | 
2026-02-27 00:26:44.676120 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-27 00:27:33.374684 | controller | Output suppressed because no_log was given
2026-02-27 00:27:33.399374 | 
2026-02-27 00:27:33.399535 | TASK [include_role : prepare-workspace-openshift]
2026-02-27 00:27:33.445220 | controller | skipping: Conditional result was False
2026-02-27 00:27:33.491589 | 
2026-02-27 00:27:33.491692 | PLAY [all:!appliance]
2026-02-27 00:27:33.529006 | 
2026-02-27 00:27:33.529203 | TASK [Run add-build-sshkey role (RSA)]
2026-02-27 00:27:33.569013 | controller | ok
2026-02-27 00:27:33.586440 | 
2026-02-27 00:27:33.586541 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-27 00:27:33.854963 | controller -> localhost | ok
2026-02-27 00:27:33.868276 | 
2026-02-27 00:27:33.868431 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-27 00:27:33.903621 | controller | ok
2026-02-27 00:27:33.921379 | controller | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-27 00:27:33.928677 | 
2026-02-27 00:27:33.928782 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-27 00:27:34.661922 | controller -> localhost | Generating public/private rsa key pair.
2026-02-27 00:27:34.662150 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/a8f483601f764dd3af4f00a704fb9cc5_id_rsa.
2026-02-27 00:27:34.662181 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/a8f483601f764dd3af4f00a704fb9cc5_id_rsa.pub.
2026-02-27 00:27:34.662201 | controller -> localhost | The key fingerprint is:
2026-02-27 00:27:34.662220 | controller -> localhost | SHA256:oldId8pmHk5k1zgzk3e1QVaX2656tXMP/lMwgjC7ZyY zuul-build-sshkey
2026-02-27 00:27:34.662238 | controller -> localhost | The key's randomart image is:
2026-02-27 00:27:34.662255 | controller -> localhost | +---[RSA 2048]----+
2026-02-27 00:27:34.662272 | controller -> localhost | |              .+*|
2026-02-27 00:27:34.662290 | controller -> localhost | |        o  +  .o+|
2026-02-27 00:27:34.662307 | controller -> localhost | |      . ++X.o ..o|
2026-02-27 00:27:34.662323 | controller -> localhost | |     . *.+.*..o..|
2026-02-27 00:27:34.662340 | controller -> localhost | |      o S.   . + |
2026-02-27 00:27:34.662367 | controller -> localhost | |     . OE.+     +|
2026-02-27 00:27:34.662394 | controller -> localhost | |    . . o=    .oo|
2026-02-27 00:27:34.662433 | controller -> localhost | |     .       .o=.|
2026-02-27 00:27:34.662457 | controller -> localhost | |            .o..B|
2026-02-27 00:27:34.662479 | controller -> localhost | +----[SHA256]-----+
2026-02-27 00:27:34.662535 | controller -> localhost | ok: Runtime: 0:00:00.258505
2026-02-27 00:27:34.670397 | 
2026-02-27 00:27:34.670510 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-27 00:27:34.701121 | controller | ok
2026-02-27 00:27:34.712292 | controller | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-27 00:27:34.721427 | 
2026-02-27 00:27:34.721508 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-27 00:27:34.735931 | controller | skipping: Conditional result was False
2026-02-27 00:27:34.743263 | 
2026-02-27 00:27:34.743375 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-27 00:27:35.986593 | controller | changed
2026-02-27 00:27:36.003569 | 
2026-02-27 00:27:36.003809 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-27 00:27:36.829480 | controller | ok
2026-02-27 00:27:36.844648 | 
2026-02-27 00:27:36.844807 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-27 00:27:40.203425 | controller | changed
2026-02-27 00:27:40.222557 | 
2026-02-27 00:27:40.222781 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-27 00:27:44.207171 | controller | changed
2026-02-27 00:27:44.221229 | 
2026-02-27 00:27:44.221456 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-27 00:27:44.251045 | controller | skipping: Conditional result was False
2026-02-27 00:27:44.259291 | 
2026-02-27 00:27:44.259393 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-27 00:27:44.641965 | controller -> localhost | changed
2026-02-27 00:27:44.670377 | 
2026-02-27 00:27:44.670542 | TASK [add-build-sshkey : Add back temp key]
2026-02-27 00:27:44.942835 | controller -> localhost | Identity added: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/a8f483601f764dd3af4f00a704fb9cc5_id_rsa (zuul-build-sshkey)
2026-02-27 00:27:44.943256 | controller -> localhost | ok: Runtime: 0:00:00.008064
2026-02-27 00:27:44.958418 | 
2026-02-27 00:27:44.958584 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-27 00:27:45.997397 | controller | ok
2026-02-27 00:27:46.012102 | 
2026-02-27 00:27:46.012290 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-27 00:27:46.049979 | controller | skipping: Conditional result was False
2026-02-27 00:27:46.066587 | 
2026-02-27 00:27:46.066702 | TASK [Run add-build-sshkey role (ECDSA)]
2026-02-27 00:27:46.099886 | controller | ok
2026-02-27 00:27:46.123265 | 
2026-02-27 00:27:46.123398 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-27 00:27:46.417797 | controller -> localhost | ok
2026-02-27 00:27:46.434967 | 
2026-02-27 00:27:46.435087 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-27 00:27:46.474565 | controller | ok
2026-02-27 00:27:46.493704 | controller | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-27 00:27:46.503664 | 
2026-02-27 00:27:46.503845 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-27 00:27:46.787199 | controller -> localhost | Generating public/private ecdsa key pair.
2026-02-27 00:27:46.787508 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/a8f483601f764dd3af4f00a704fb9cc5_id_ecdsa.
2026-02-27 00:27:46.787550 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/a8f483601f764dd3af4f00a704fb9cc5_id_ecdsa.pub.
2026-02-27 00:27:46.787590 | controller -> localhost | The key fingerprint is:
2026-02-27 00:27:46.787619 | controller -> localhost | SHA256:LwePnTDTVpioefu6BnCTQzNyx1by8s3W11B/lgIAXXU zuul-build-sshkey
2026-02-27 00:27:46.787646 | controller -> localhost | The key's randomart image is:
2026-02-27 00:27:46.787672 | controller -> localhost | +---[ECDSA 521]---+
2026-02-27 00:27:46.787698 | controller -> localhost | |       o+o+o.. E.|
2026-02-27 00:27:46.787741 | controller -> localhost | |    . = += o. ..o|
2026-02-27 00:27:46.787772 | controller -> localhost | |     + *o + ....+|
2026-02-27 00:27:46.787797 | controller -> localhost | |    . =o + + ..oo|
2026-02-27 00:27:46.787822 | controller -> localhost | |     oooS + + . o|
2026-02-27 00:27:46.787845 | controller -> localhost | |      .. % o   . |
2026-02-27 00:27:46.787869 | controller -> localhost | |       .+ *      |
2026-02-27 00:27:46.787893 | controller -> localhost | |        .+       |
2026-02-27 00:27:46.787916 | controller -> localhost | |       .oo.      |
2026-02-27 00:27:46.787941 | controller -> localhost | +----[SHA256]-----+
2026-02-27 00:27:46.788012 | controller -> localhost | ok: Runtime: 0:00:00.012534
2026-02-27 00:27:46.799613 | 
2026-02-27 00:27:46.799780 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-27 00:27:46.835207 | controller | ok
2026-02-27 00:27:46.846670 | controller | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-27 00:27:46.860403 | 
2026-02-27 00:27:46.860517 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-27 00:27:46.876586 | controller | skipping: Conditional result was False
2026-02-27 00:27:46.884221 | 
2026-02-27 00:27:46.884313 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-27 00:27:48.026462 | controller | changed
2026-02-27 00:27:48.039577 | 
2026-02-27 00:27:48.039718 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-27 00:27:49.033215 | controller | ok
2026-02-27 00:27:49.046464 | 
2026-02-27 00:27:49.046628 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-27 00:27:55.953283 | controller | changed
2026-02-27 00:27:55.967134 | 
2026-02-27 00:27:55.967435 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-27 00:28:00.252484 | controller | changed
2026-02-27 00:28:00.269399 | 
2026-02-27 00:28:00.269574 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-27 00:28:00.299144 | controller | skipping: Conditional result was False
2026-02-27 00:28:00.317143 | 
2026-02-27 00:28:00.317336 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-27 00:28:00.840112 | controller -> localhost | changed
2026-02-27 00:28:00.853762 | 
2026-02-27 00:28:00.853848 | TASK [add-build-sshkey : Add back temp key]
2026-02-27 00:28:01.195787 | controller -> localhost | Identity added: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/a8f483601f764dd3af4f00a704fb9cc5_id_ecdsa (zuul-build-sshkey)
2026-02-27 00:28:01.196036 | controller -> localhost | ok: Runtime: 0:00:00.009447
2026-02-27 00:28:01.205053 | 
2026-02-27 00:28:01.205149 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-27 00:28:02.053102 | controller | ok
2026-02-27 00:28:02.067568 | 
2026-02-27 00:28:02.067762 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-27 00:28:02.108966 | controller | skipping: Conditional result was False
2026-02-27 00:28:02.178861 | 
2026-02-27 00:28:02.179088 | TASK [include_role : remove-zuul-sshkey]
2026-02-27 00:28:02.205849 | controller | skipping: Conditional result was False
2026-02-27 00:28:02.213941 | 
2026-02-27 00:28:02.214021 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-27 00:28:03.024004 | controller | ok: "logs"
2026-02-27 00:28:03.024582 | controller | ok: All items complete
2026-02-27 00:28:03.024651 | 
2026-02-27 00:28:03.717491 | controller | ok: "artifacts"
2026-02-27 00:28:04.441925 | controller | ok: "docs"
2026-02-27 00:28:04.451590 | 
2026-02-27 00:28:04.451695 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-27 00:28:05.277132 | controller | changed: "logs"
2026-02-27 00:28:06.007529 | controller | changed: "artifacts"
2026-02-27 00:28:06.731085 | controller | changed: "docs"
2026-02-27 00:28:06.797939 | 
2026-02-27 00:28:06.798071 | PLAY RECAP
2026-02-27 00:28:06.798136 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-02-27 00:28:06.798171 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-27 00:28:06.798195 | 
2026-02-27 00:28:06.981458 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-27 00:28:06.982590 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-27 00:28:07.631916 | 
2026-02-27 00:28:07.632298 | PLAY [all]
2026-02-27 00:28:07.662401 | 
2026-02-27 00:28:07.662553 | TASK [Install binary dependencies]
2026-02-27 00:28:07.754329 | controller | ok
2026-02-27 00:28:07.792894 | 
2026-02-27 00:28:07.793104 | TASK [bindep : Include find tasks]
2026-02-27 00:28:07.837983 | controller | ok
2026-02-27 00:28:07.850244 | controller | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-27 00:28:07.859478 | 
2026-02-27 00:28:07.859568 | TASK [bindep : Look for bindep.txt]
2026-02-27 00:28:08.801147 | controller | ok
2026-02-27 00:28:08.808974 | 
2026-02-27 00:28:08.809065 | TASK [bindep : Define bindep_file fact]
2026-02-27 00:28:08.837639 | controller | skipping: Conditional result was False
2026-02-27 00:28:08.848017 | 
2026-02-27 00:28:08.848148 | TASK [bindep : Look for other-requirements.txt]
2026-02-27 00:28:09.628356 | controller | ok
2026-02-27 00:28:09.637043 | 
2026-02-27 00:28:09.637142 | TASK [bindep : Define bindep_file fact]
2026-02-27 00:28:09.674003 | controller | skipping: Conditional result was False
2026-02-27 00:28:09.684204 | 
2026-02-27 00:28:09.684324 | TASK [bindep : Look for bindep fallback file]
2026-02-27 00:28:09.719890 | controller | skipping: Conditional result was False
2026-02-27 00:28:09.729315 | 
2026-02-27 00:28:09.729442 | TASK [bindep : Define bindep_file fact]
2026-02-27 00:28:09.756075 | controller | skipping: Conditional result was False
2026-02-27 00:28:09.765491 | 
2026-02-27 00:28:09.765596 | TASK [bindep : Include bindep tasks]
2026-02-27 00:28:09.791704 | controller | skipping: Conditional result was False
2026-02-27 00:28:09.802168 | 
2026-02-27 00:28:09.802309 | TASK [bindep : Include install tasks]
2026-02-27 00:28:09.829647 | controller | skipping: Conditional result was False
2026-02-27 00:28:09.840761 | 
2026-02-27 00:28:09.840890 | LOOP [bindep : Include package tasks]
2026-02-27 00:28:09.911598 | 
2026-02-27 00:28:09.911793 | TASK [Run test-setup role]
2026-02-27 00:28:09.935671 | controller | ok
2026-02-27 00:28:09.968628 | 
2026-02-27 00:28:09.968954 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-27 00:28:10.871478 | controller | ok
2026-02-27 00:28:10.880709 | 
2026-02-27 00:28:10.880845 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-27 00:28:11.253365 | controller | skipping: Conditional result was False
2026-02-27 00:28:11.299451 | 
2026-02-27 00:28:11.299604 | PLAY RECAP
2026-02-27 00:28:11.299683 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-27 00:28:11.299783 | 
2026-02-27 00:28:11.452333 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-27 00:28:11.453201 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-27 00:28:12.035125 | 
2026-02-27 00:28:12.035317 | PLAY [controller]
2026-02-27 00:28:12.056912 | 
2026-02-27 00:28:12.057022 | TASK [Create the /root directory]
2026-02-27 00:28:13.159022 | controller | ok
2026-02-27 00:28:13.173621 | 
2026-02-27 00:28:13.173831 | TASK [Install glibc-langpack-en]
2026-02-27 00:28:21.876578 | controller | ok: Nothing to do
2026-02-27 00:28:21.892430 | 
2026-02-27 00:28:21.892628 | TASK [Ensure controller directory exists]
2026-02-27 00:28:22.709775 | controller | changed
2026-02-27 00:28:22.724169 | 
2026-02-27 00:28:22.724339 | TASK [Install container runtime]
2026-02-27 00:28:22.780296 | controller | ok
2026-02-27 00:28:22.830565 | 
2026-02-27 00:28:22.830703 | LOOP [ensure-docker : Gather variables for each operating system]
2026-02-27 00:28:22.898235 | controller | ok: "/var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml"
2026-02-27 00:28:22.929927 | 
2026-02-27 00:28:22.930153 | TASK [ensure-docker : Sanity check for distro selection]
2026-02-27 00:28:22.958065 | controller | skipping: Conditional result was False
2026-02-27 00:28:22.969632 | 
2026-02-27 00:28:22.969926 | TASK [ensure-docker : Sanity check for distro install]
2026-02-27 00:28:23.006807 | controller | skipping: Conditional result was False
2026-02-27 00:28:23.018213 | 
2026-02-27 00:28:23.018370 | TASK [ensure-docker : Sanity check for upstream install]
2026-02-27 00:28:23.056081 | controller | skipping: Conditional result was False
2026-02-27 00:28:23.067024 | 
2026-02-27 00:28:23.067189 | TASK [ensure-docker : Sanity check for upstream install mirrors]
2026-02-27 00:28:23.104768 | controller | skipping: Conditional result was False
2026-02-27 00:28:23.114893 | 
2026-02-27 00:28:23.115028 | TASK [ensure-docker : Include tasks for docker install]
2026-02-27 00:28:23.150777 | controller | ok
2026-02-27 00:28:23.166034 | controller | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml
2026-02-27 00:28:23.178345 | 
2026-02-27 00:28:23.178455 | TASK [ensure-docker : Not Implemented]
2026-02-27 00:28:23.205453 | controller | skipping: Conditional result was False
2026-02-27 00:28:23.214789 | 
2026-02-27 00:28:23.214992 | TASK [Set up docker mirrors]
2026-02-27 00:28:23.240171 | controller | ok
2026-02-27 00:28:23.263904 | 
2026-02-27 00:28:23.264052 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info]
2026-02-27 00:28:23.300835 | controller | skipping: Conditional result was False
2026-02-27 00:28:23.347677 | 
2026-02-27 00:28:23.347862 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info]
2026-02-27 00:28:23.393986 | controller | skipping: Conditional result was False
2026-02-27 00:28:23.402430 | 
2026-02-27 00:28:23.402521 | TASK [use-docker-mirror : Set docker_mirror fact]
2026-02-27 00:28:23.448902 | controller | skipping: Conditional result was False
2026-02-27 00:28:23.456970 | 
2026-02-27 00:28:23.457061 | TASK [use-docker-mirror : Set up docker mirrors]
2026-02-27 00:28:23.493058 | controller | skipping: Conditional result was False
2026-02-27 00:28:23.507013 | 
2026-02-27 00:28:23.507134 | TASK [Add all repositories]
2026-02-27 00:28:23.538854 | controller | ok
2026-02-27 00:28:23.569349 | 
2026-02-27 00:28:23.569606 | LOOP [ensure-package-repositories : Install repositories]
2026-02-27 00:28:23.626356 | controller | ok: "/var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml"
2026-02-27 00:28:23.626607 | controller | ok: All items complete
2026-02-27 00:28:23.626637 | 
2026-02-27 00:28:23.647474 | controller | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml
2026-02-27 00:28:23.656950 | 
2026-02-27 00:28:23.657116 | TASK [ensure-package-repositories : Create GPG key temp directory]
2026-02-27 00:28:24.599299 | controller | changed
2026-02-27 00:28:24.617166 | 
2026-02-27 00:28:24.617336 | LOOP [ensure-package-repositories : Upload GPG keys]
2026-02-27 00:28:28.168716 | controller | changed:
2026-02-27 00:28:28.169065 | controller | {
2026-02-27 00:28:28.169121 | controller |   "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n"
2026-02-27 00:28:28.169168 | controller | }
2026-02-27 00:28:28.193696 | 
2026-02-27 00:28:28.193916 | LOOP [ensure-package-repositories : Import GPG keys]
2026-02-27 00:28:29.766345 | controller | changed:
2026-02-27 00:28:29.766771 | controller | {
2026-02-27 00:28:29.766849 | controller |   "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n"
2026-02-27 00:28:29.766905 | controller | }
2026-02-27 00:28:29.766968 | controller | changed: All items complete
2026-02-27 00:28:29.767011 | 
2026-02-27 00:28:29.791921 | 
2026-02-27 00:28:29.792126 | TASK [ensure-package-repositories : Remove GPG temp directory]
2026-02-27 00:28:30.723261 | controller | changed
2026-02-27 00:28:30.737244 | 
2026-02-27 00:28:30.737424 | LOOP [ensure-package-repositories : Add repositories]
2026-02-27 00:28:31.690150 | controller | changed:
2026-02-27 00:28:31.690596 | controller | {
2026-02-27 00:28:31.690669 | controller |   "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable",
2026-02-27 00:28:31.690720 | controller |   "description": "Docker CE Stable - $basearch",
2026-02-27 00:28:31.690806 | controller |   "gpgcheck": true,
2026-02-27 00:28:31.690850 | controller |   "name": "docker-ce-stable"
2026-02-27 00:28:31.690899 | controller | }
2026-02-27 00:28:31.730775 | 
2026-02-27 00:28:31.730966 | TASK [ensure-docker : Install pre-reqs]
2026-02-27 00:28:37.638684 | controller | ok: Nothing to do
2026-02-27 00:28:37.652167 | 
2026-02-27 00:28:37.652350 | TASK [ensure-docker : Remove packages]
2026-02-27 00:28:41.349839 | controller | ok: Nothing to do
2026-02-27 00:28:41.364618 | 
2026-02-27 00:28:41.364904 | TASK [ensure-docker : Install upstream docker using package]
2026-02-27 00:30:11.504762 | controller | changed
2026-02-27 00:30:11.513938 | 
2026-02-27 00:30:11.514163 | TASK [ensure-docker : Setup docker]
2026-02-27 00:30:11.544805 | controller | ok
2026-02-27 00:30:11.569628 | controller | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml
2026-02-27 00:30:11.594696 | 
2026-02-27 00:30:11.594861 | TASK [ensure-docker : Ensure "docker" group exists]
2026-02-27 00:30:12.637683 | controller | ok
2026-02-27 00:30:12.646942 | 
2026-02-27 00:30:12.647054 | TASK [ensure-docker : Add user to docker group]
2026-02-27 00:30:13.838902 | controller | changed
2026-02-27 00:30:13.848420 | 
2026-02-27 00:30:13.848544 | TASK [Update docker daemon proxy configuration]
2026-02-27 00:30:13.885878 | controller | skipping: Conditional result was False
2026-02-27 00:30:13.896527 | 
2026-02-27 00:30:13.896643 | TASK [Lower default MTU]
2026-02-27 00:30:13.923206 | controller | skipping: Conditional result was False
2026-02-27 00:30:13.934624 | 
2026-02-27 00:30:13.934791 | TASK [ensure-docker : Get the status of the docket.socket unit]
2026-02-27 00:30:14.794993 | controller | inactive
2026-02-27 00:30:15.309400 | controller | ok: Runtime: 0:00:00.019072
2026-02-27 00:30:15.316662 | 
2026-02-27 00:30:15.316767 | TASK [ensure-docker : Get the status of the docket unit]
2026-02-27 00:30:16.103262 | controller | inactive
2026-02-27 00:30:16.672140 | controller | ok: Runtime: 0:00:00.025860
2026-02-27 00:30:16.681487 | 
2026-02-27 00:30:16.681626 | TASK [ensure-docker : Restart docker]
2026-02-27 00:30:16.736527 | Trigger a Docker restart
2026-02-27 00:30:16.744583 | 
2026-02-27 00:30:16.744683 | TASK [ensure-docker : Reset ssh connection to pick up docker group]
2026-02-27 00:30:16.795558 | 
2026-02-27 00:30:16.795707 | TASK [ensure-docker : Install docker-compose]
2026-02-27 00:30:16.821778 | controller | skipping: Conditional result was False
2026-02-27 00:30:16.833713 | 
2026-02-27 00:30:16.833875 | TASK [ensure-docker : Flush handlers before role exit]
2026-02-27 00:30:16.849635 | 
2026-02-27 00:30:16.849782 | TASK [ensure-docker : Stop docker.socket to avoid any conflict]
2026-02-27 00:30:20.310655 | controller | changed
2026-02-27 00:30:20.323249 | 
2026-02-27 00:30:20.323393 | TASK [ensure-docker : Assure docker service is running]
2026-02-27 00:30:23.857830 | controller | changed
2026-02-27 00:30:23.882969 | 
2026-02-27 00:30:23.883207 | TASK [ensure-docker : Assure docker.socket service is running]
2026-02-27 00:30:25.689691 | controller | ok
2026-02-27 00:30:25.697857 | 
2026-02-27 00:30:25.697946 | TASK [ensure-docker : Correct group ownership on docker sock]
2026-02-27 00:30:26.618051 | controller | ok
2026-02-27 00:30:26.627064 | 
2026-02-27 00:30:26.627200 | TASK [ensure-docker : Validate ability to talk with docker]
2026-02-27 00:30:27.261163 | controller | CONTAINER ID   IMAGE     COMMAND   CREATED   STATUS    PORTS     NAMES
2026-02-27 00:30:27.494967 | controller | ok: Runtime: 0:00:00.034710
2026-02-27 00:30:27.508041 | 
2026-02-27 00:30:27.508178 | TASK [ensure-docker : Get version details]
2026-02-27 00:30:28.210649 | controller | Client: Docker Engine - Community
2026-02-27 00:30:28.210851 | controller |  Version:           24.0.7
2026-02-27 00:30:28.210867 | controller |  API version:       1.43
2026-02-27 00:30:28.210875 | controller |  Go version:        go1.20.10
2026-02-27 00:30:28.210892 | controller |  Git commit:        afdd53b
2026-02-27 00:30:28.210900 | controller |  Built:             Thu Oct 26 09:09:39 2023
2026-02-27 00:30:28.210907 | controller |  OS/Arch:           linux/amd64
2026-02-27 00:30:28.210916 | controller |  Context:           default
2026-02-27 00:30:28.210925 | controller |
2026-02-27 00:30:28.210931 | controller | Server: Docker Engine - Community
2026-02-27 00:30:28.210938 | controller |  Engine:
2026-02-27 00:30:28.210944 | controller |   Version:          24.0.7
2026-02-27 00:30:28.210950 | controller |   API version:      1.43 (minimum version 1.12)
2026-02-27 00:30:28.210957 | controller |   Go version:       go1.20.10
2026-02-27 00:30:28.210963 | controller |   Git commit:       311b9ff
2026-02-27 00:30:28.210969 | controller |   Built:            Thu Oct 26 09:08:11 2023
2026-02-27 00:30:28.210976 | controller |   OS/Arch:          linux/amd64
2026-02-27 00:30:28.210982 | controller |   Experimental:     false
2026-02-27 00:30:28.210988 | controller |  containerd:
2026-02-27 00:30:28.210998 | controller |   Version:          1.6.25
2026-02-27 00:30:28.215409 | controller |   GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f
2026-02-27 00:30:28.215513 | controller |  runc:
2026-02-27 00:30:28.215543 | controller |   Version:          1.1.10
2026-02-27 00:30:28.215550 | controller |   GitCommit:        v1.1.10-0-g18a0cb0
2026-02-27 00:30:28.215559 | controller |  docker-init:
2026-02-27 00:30:28.215565 | controller |   Version:          0.19.0
2026-02-27 00:30:28.215572 | controller |   GitCommit:        de40ad0
2026-02-27 00:30:28.386216 | controller | ok: Runtime: 0:00:00.049947
2026-02-27 00:30:28.395488 | 
2026-02-27 00:30:28.395585 | TASK [ensure-docker : Dump installed docker details]
2026-02-27 00:30:28.454659 | {'changed': True, 'stdout': 'Client: Docker Engine - Community\n Version:           24.0.7\n API version:       1.43\n Go version:        go1.20.10\n Git commit:        afdd53b\n Built:             Thu Oct 26 09:09:39 2023\n OS/Arch:           linux/amd64\n Context:           default\n\nServer: Docker Engine - Community\n Engine:\n  Version:          24.0.7\n  API version:      1.43 (minimum version 1.12)\n  Go version:       go1.20.10\n  Git commit:       311b9ff\n  Built:            Thu Oct 26 09:08:11 2023\n  OS/Arch:          linux/amd64\n  Experimental:     false\n containerd:\n  Version:          1.6.25\n  GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f\n runc:\n  Version:          1.1.10\n  GitCommit:        v1.1.10-0-g18a0cb0\n docker-init:\n  Version:          0.19.0\n  GitCommit:        de40ad0', 'stderr': '', 'rc': 0, 'cmd': ['docker', 'version'], 'start': '2026-02-27 00:30:28.165910', 'end': '2026-02-27 00:30:28.215857', 'delta': '0:00:00.049947', 'msg': '', 'zuul_log_id': 'fa163ef9-e89a-0fee-7865-000000000061-1-controller', 'stdout_lines': ['Client: Docker Engine - Community', ' Version:           24.0.7', ' API version:       1.43', ' Go version:        go1.20.10', ' Git commit:        afdd53b', ' Built:             Thu Oct 26 09:09:39 2023', ' OS/Arch:           linux/amd64', ' Context:           default', '', 'Server: Docker Engine - Community', ' Engine:', '  Version:          24.0.7', '  API version:      1.43 (minimum version 1.12)', '  Go version:       go1.20.10', '  Git commit:       311b9ff', '  Built:            Thu Oct 26 09:08:11 2023', '  OS/Arch:          linux/amd64', '  Experimental:     false', ' containerd:', '  Version:          1.6.25', '  GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f', ' runc:', '  Version:          1.1.10', '  GitCommit:        v1.1.10-0-g18a0cb0', ' docker-init:', '  Version:          0.19.0', '  GitCommit:        de40ad0'], 'stderr_lines': [], 'failed': False}
2026-02-27 00:30:28.463347 | 
2026-02-27 00:30:28.463438 | TASK [Use buildset registry]
2026-02-27 00:30:28.478857 | controller | skipping: Conditional result was False
2026-02-27 00:30:28.506694 | 
2026-02-27 00:30:28.506910 | TASK [Ensure python3.8 is present]
2026-02-27 00:30:28.524396 | controller | skipping: Conditional result was False
2026-02-27 00:30:28.531313 | 
2026-02-27 00:30:28.531403 | TASK [Run our-ensure-python role (Fedora only for now)]
2026-02-27 00:30:28.551470 | controller | ok
2026-02-27 00:30:28.574026 | 
2026-02-27 00:30:28.574145 | TASK [our-ensure-python : Install the right Python version (rpm)]
2026-02-27 00:30:34.144081 | controller | ok: Nothing to do
2026-02-27 00:30:34.158059 | 
2026-02-27 00:30:34.158199 | TASK [our-ensure-python : Also install python3-devel]
2026-02-27 00:30:51.325488 | controller | changed
2026-02-27 00:30:51.350204 | 
2026-02-27 00:30:51.350382 | TASK [Run ensure-virtualenv role]
2026-02-27 00:30:51.377478 | controller | ok
2026-02-27 00:30:51.406792 | 
2026-02-27 00:30:51.407009 | TASK [ensure-virtualenv : Check if virtualenv is installed]
2026-02-27 00:30:52.175952 | controller | /usr/bin/virtualenv
2026-02-27 00:30:52.792692 | controller | ok: Runtime: 0:00:00.004996
2026-02-27 00:30:52.798936 | 
2026-02-27 00:30:52.799011 | LOOP [ensure-virtualenv : Install virtualenv package]
2026-02-27 00:30:52.818510 | controller | skipping: Conditional result was False
2026-02-27 00:30:52.818830 | controller | changed: All items complete
2026-02-27 00:30:52.818865 | 
2026-02-27 00:30:52.834576 | 
2026-02-27 00:30:52.834652 | TASK [Find the full path of the Python interpreter]
2026-02-27 00:30:53.624554 | controller | /usr/bin/python3.8
2026-02-27 00:30:54.189486 | controller | ok
2026-02-27 00:30:54.202777 | 
2026-02-27 00:30:54.202957 | TASK [Create virtualenv for ansible-test with a specific interpreter]
2026-02-27 00:30:56.788659 | controller | created virtual environment CPython3.8.18.final.0-64 in 1243ms
2026-02-27 00:30:56.906812 | controller |   creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False)
2026-02-27 00:30:56.906870 | controller |   seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv)
2026-02-27 00:30:56.906885 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2026-02-27 00:30:56.906904 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2026-02-27 00:30:57.097813 | controller | changed
2026-02-27 00:30:57.112095 | 
2026-02-27 00:30:57.112239 | TASK [Set selinux package]
2026-02-27 00:30:57.182023 | controller | ok
2026-02-27 00:30:57.188550 | 
2026-02-27 00:30:57.188654 | TASK [Set selinux package (Fedora)]
2026-02-27 00:30:57.220468 | controller | ok
2026-02-27 00:30:57.227003 | 
2026-02-27 00:30:57.227098 | TASK [Install selinux into virtualenv]
2026-02-27 00:31:03.480934 | controller | Collecting selinux-please-lie-to-me
2026-02-27 00:31:03.805964 | controller |   Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB)
2026-02-27 00:31:04.711697 | controller | Collecting setuptools<50.0.0
2026-02-27 00:31:04.801788 | controller |   Downloading setuptools-49.6.0-py3-none-any.whl (803 kB)
2026-02-27 00:31:05.195193 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 2.1 MB/s eta 0:00:00
2026-02-27 00:31:05.365288 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me
2026-02-27 00:31:05.365486 | controller |   Attempting uninstall: setuptools
2026-02-27 00:31:05.366836 | controller |     Found existing installation: setuptools 62.6.0
2026-02-27 00:31:05.498429 | controller |     Uninstalling setuptools-62.6.0:
2026-02-27 00:31:05.520109 | controller |       Successfully uninstalled setuptools-62.6.0
2026-02-27 00:31:06.337825 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0
2026-02-27 00:31:06.832057 | controller |
2026-02-27 00:31:07.344747 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2026-02-27 00:31:07.344834 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2026-02-27 00:31:07.618418 | controller | ok: Runtime: 0:00:08.781603
2026-02-27 00:31:07.633358 | 
2026-02-27 00:31:07.633535 | TASK [Install pytest-forked into virtualenv]
2026-02-27 00:31:09.809970 | controller | Collecting pytest-forked
2026-02-27 00:31:10.127649 | controller |   Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB)
2026-02-27 00:31:10.529181 | controller | Collecting pytest>=3.10
2026-02-27 00:31:10.619610 | controller |   Downloading pytest-8.3.5-py3-none-any.whl (343 kB)
2026-02-27 00:31:10.910823 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 343.6/343.6 kB 1.2 MB/s eta 0:00:00
2026-02-27 00:31:11.061245 | controller | Collecting py
2026-02-27 00:31:11.150152 | controller |   Downloading py-1.11.0-py2.py3-none-any.whl (98 kB)
2026-02-27 00:31:11.174199 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 4.8 MB/s eta 0:00:00
2026-02-27 00:31:11.317135 | controller | Collecting iniconfig
2026-02-27 00:31:11.406612 | controller |   Downloading iniconfig-2.1.0-py3-none-any.whl (6.0 kB)
2026-02-27 00:31:11.583746 | controller | Collecting packaging
2026-02-27 00:31:11.676479 | controller |   Downloading packaging-26.0-py3-none-any.whl (74 kB)
2026-02-27 00:31:11.697786 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 4.8 MB/s eta 0:00:00
2026-02-27 00:31:11.849063 | controller | Collecting exceptiongroup>=1.0.0rc8
2026-02-27 00:31:11.939629 | controller |   Downloading exceptiongroup-1.3.1-py3-none-any.whl (16 kB)
2026-02-27 00:31:12.130882 | controller | Collecting tomli>=1
2026-02-27 00:31:12.222505 | controller |   Downloading tomli-2.4.0-py3-none-any.whl (14 kB)
2026-02-27 00:31:12.377099 | controller | Collecting pluggy<2,>=1.5
2026-02-27 00:31:12.468840 | controller |   Downloading pluggy-1.5.0-py3-none-any.whl (20 kB)
2026-02-27 00:31:12.658730 | controller | Collecting typing-extensions>=4.6.0
2026-02-27 00:31:12.753892 | controller |   Downloading typing_extensions-4.13.2-py3-none-any.whl (45 kB)
2026-02-27 00:31:12.773622 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.8/45.8 kB 4.7 MB/s eta 0:00:00
2026-02-27 00:31:12.890804 | controller | Installing collected packages: typing-extensions, tomli, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked
2026-02-27 00:31:13.820803 | controller | Successfully installed exceptiongroup-1.3.1 iniconfig-2.1.0 packaging-26.0 pluggy-1.5.0 py-1.11.0 pytest-8.3.5 pytest-forked-1.6.0 tomli-2.4.0 typing-extensions-4.13.2
2026-02-27 00:31:13.825928 | controller |
2026-02-27 00:31:14.046802 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2026-02-27 00:31:14.046833 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2026-02-27 00:31:14.519236 | controller | ok: Runtime: 0:00:05.539408
2026-02-27 00:31:14.526255 | 
2026-02-27 00:31:14.526335 | TASK [Update pip]
2026-02-27 00:31:16.844098 | controller | Requirement already satisfied: pip in ./venv/lib/python3.8/site-packages (22.2.2)
2026-02-27 00:31:17.523405 | controller | Collecting pip
2026-02-27 00:31:17.859055 | controller |   Downloading pip-25.0.1-py3-none-any.whl (1.8 MB)
2026-02-27 00:31:18.318500 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 4.1 MB/s eta 0:00:00
2026-02-27 00:31:18.423360 | controller | Installing collected packages: pip
2026-02-27 00:31:18.423760 | controller |   Attempting uninstall: pip
2026-02-27 00:31:18.424809 | controller |     Found existing installation: pip 22.2.2
2026-02-27 00:31:18.749290 | controller |     Uninstalling pip-22.2.2:
2026-02-27 00:31:18.783969 | controller |       Successfully uninstalled pip-22.2.2
2026-02-27 00:31:20.811323 | controller | Successfully installed pip-25.0.1
2026-02-27 00:31:21.407077 | controller | ok: Runtime: 0:00:05.492395
2026-02-27 00:31:21.417422 | 
2026-02-27 00:31:21.417580 | TASK [Ensure pip temp directory exists in /var/tmp]
2026-02-27 00:31:22.549835 | controller | changed
2026-02-27 00:31:22.563665 | 
2026-02-27 00:31:22.563868 | TASK [Install ansible into virtualenv]
2026-02-27 00:31:24.618107 | controller | Processing ./src/github.com/ansible/ansible
2026-02-27 00:31:24.619632 | controller |   Preparing metadata (setup.py): started
2026-02-27 00:31:26.589396 | controller |   Preparing metadata (setup.py): finished with status 'done'
2026-02-27 00:31:26.899733 | controller | Collecting jinja2 (from ansible==2.9.27.post0)
2026-02-27 00:31:27.170650 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB)
2026-02-27 00:31:27.448450 | controller | Collecting PyYAML (from ansible==2.9.27.post0)
2026-02-27 00:31:27.541558 | controller |   Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.1 kB)
2026-02-27 00:31:28.258332 | controller | Collecting cryptography (from ansible==2.9.27.post0)
2026-02-27 00:31:28.351835 | controller |   Downloading cryptography-46.0.5-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB)
2026-02-27 00:31:28.717384 | controller | Collecting cffi>=1.14 (from cryptography->ansible==2.9.27.post0)
2026-02-27 00:31:28.810105 | controller |   Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB)
2026-02-27 00:31:28.825083 | controller | Requirement already satisfied: typing-extensions>=4.13.2 in ./venv/lib/python3.8/site-packages (from cryptography->ansible==2.9.27.post0) (4.13.2)
2026-02-27 00:31:29.032698 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible==2.9.27.post0)
2026-02-27 00:31:29.127099 | controller |   Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (3.0 kB)
2026-02-27 00:31:29.244697 | controller | Collecting pycparser (from cffi>=1.14->cryptography->ansible==2.9.27.post0)
2026-02-27 00:31:29.335083 | controller |   Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes)
2026-02-27 00:31:29.441460 | controller | Downloading cryptography-46.0.5-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2026-02-27 00:31:30.054048 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 12.1 MB/s eta 0:00:00
2026-02-27 00:31:30.144951 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2026-02-27 00:31:30.265415 | controller | Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB)
2026-02-27 00:31:30.288980 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.0/806.0 kB 32.9 MB/s eta 0:00:00
2026-02-27 00:31:30.385466 | controller | Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB)
2026-02-27 00:31:30.502066 | controller | Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (26 kB)
2026-02-27 00:31:30.602550 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB)
2026-02-27 00:31:30.648819 | controller | Building wheels for collected packages: ansible
2026-02-27 00:31:30.649670 | controller |   Building wheel for ansible (setup.py): started
2026-02-27 00:31:41.231909 | controller |   Building wheel for ansible (setup.py): finished with status 'done'
2026-02-27 00:31:41.255812 | controller |   Created wheel for ansible: filename=ansible-2.9.27.post0-py3-none-any.whl size=16207514 sha256=3280af74c19ea72aaf85720622dd0c937ad156dc34dc56a44a1849ca7edc9e28
2026-02-27 00:31:41.258364 | controller |   Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-qgu2ci3t/wheels/a5/4b/fa/b6deaae105422b0b3b92831e0369d44bf7fca5bb3413d79be7
2026-02-27 00:31:41.347472 | controller | Successfully built ansible
2026-02-27 00:31:41.557959 | controller | Installing collected packages: PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible
2026-02-27 00:31:58.140258 | controller | Successfully installed MarkupSafe-2.1.5 PyYAML-6.0.3 ansible-2.9.27.post0 cffi-1.17.1 cryptography-46.0.5 jinja2-3.1.6 pycparser-2.23
2026-02-27 00:31:58.961238 | controller | ok: Runtime: 0:00:34.830768
2026-02-27 00:31:58.970031 | 
2026-02-27 00:31:58.970146 | TASK [Setup download-artifact-fork role]
2026-02-27 00:31:58.990235 | controller | ok
2026-02-27 00:31:59.009837 | 
2026-02-27 00:31:59.009959 | TASK [download-artifact-fork : Parse inventory response]
2026-02-27 00:31:59.052396 | controller | ok
2026-02-27 00:31:59.060865 | 
2026-02-27 00:31:59.061006 | TASK [download-artifact-fork : Fetch info from Zuul API]
2026-02-27 00:31:59.087057 | controller | skipping: Conditional result was False
2026-02-27 00:31:59.096070 | 
2026-02-27 00:31:59.096169 | TASK [download-artifact-fork : Parse build response]
2026-02-27 00:31:59.132161 | controller | skipping: Conditional result was False
2026-02-27 00:31:59.140397 | 
2026-02-27 00:31:59.140510 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2026-02-27 00:32:00.031082 | controller | changed
2026-02-27 00:32:00.038950 | 
2026-02-27 00:32:00.039085 | LOOP [download-artifact-fork : Download archive by type]
2026-02-27 00:32:00.077833 | controller | skipping: Conditional result was False
2026-02-27 00:32:00.078547 | 
2026-02-27 00:32:02.092485 | controller | changed: OK (20207 bytes)
2026-02-27 00:32:02.164396 | 
2026-02-27 00:32:02.164536 | TASK [deploy-artifacts : define __collections]
2026-02-27 00:32:02.189948 | controller | ok
2026-02-27 00:32:02.198237 | 
2026-02-27 00:32:02.198358 | LOOP [deploy-artifacts : Create list of collections]
2026-02-27 00:32:02.244894 | controller | skipping: Conditional result was False
2026-02-27 00:32:02.255539 | controller | ok:
2026-02-27 00:32:02.255640 | controller | {
2026-02-27 00:32:02.255673 | controller |   "branch": "main",
2026-02-27 00:32:02.255702 | controller |   "job": "build-ansible-collection",
2026-02-27 00:32:02.255752 | controller |   "metadata": {
2026-02-27 00:32:02.255784 | controller |     "type": "ansible_collection",
2026-02-27 00:32:02.255810 | controller |     "version": "5.0.0"
2026-02-27 00:32:02.255853 | controller |   },
2026-02-27 00:32:02.255881 | controller |   "name": "ansible.network",
2026-02-27 00:32:02.255904 | controller |   "project": "ansible-collections/ansible.network",
2026-02-27 00:32:02.255928 | controller |   "url": "https://379e96246a6f0d8bbef5-52309d2d94fb7db8f721d2dba96edb59.ssl.cf5.rackcdn.com/ansible/35d413d323674ff19fa144cb7562d841/artifacts/ansible-network-5.0.0.tar.gz"
2026-02-27 00:32:02.255961 | controller | }
2026-02-27 00:32:02.270545 | 
2026-02-27 00:32:02.270716 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2026-02-27 00:32:03.523906 | controller | Process install dependency map
2026-02-27 00:32:50.906939 | controller | |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/Starting collection install process
2026-02-27 00:32:51.009506 | controller | |Installing 'ansible.network:5.0.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/network'
2026-02-27 00:32:51.009746 | controller | Installing 'ansible.netcommon:8.4.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-02-27 00:32:52.617551 | controller | /-\|/-\|/-\|/-\|Installing 'ansible.utils:6.0.1' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-02-27 00:32:54.327158 | controller | /-\|/-\|/-\|/-\|/Installing 'arista.eos:12.0.1' to '/home/zuul/.ansible/collections/ansible_collections/arista/eos'
2026-02-27 00:32:57.050671 | controller | -\|/-\|/-\|/-\|/-\|/-\|/-\|Installing 'cisco.ios:11.3.0' to '/home/zuul/.ansible/collections/ansible_collections/cisco/ios'
2026-02-27 00:33:00.074020 | controller | /-\|/-\|/-\|/-\|/-\|/-\|/-\|/-Installing 'cisco.iosxr:12.1.1' to '/home/zuul/.ansible/collections/ansible_collections/cisco/iosxr'
2026-02-27 00:33:02.890751 | controller | \|/-\|/-\|/-\|/-\|/-\|/-\|/-Installing 'cisco.nxos:11.1.3' to '/home/zuul/.ansible/collections/ansible_collections/cisco/nxos'
2026-02-27 00:33:06.975504 | controller | \|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-Installing 'junipernetworks.junos:11.0.0' to '/home/zuul/.ansible/collections/ansible_collections/junipernetworks/junos'
2026-02-27 00:33:10.185411 | controller | ok: Runtime: 0:01:06.709835
2026-02-27 00:33:10.213550 | 
2026-02-27 00:33:10.213807 | TASK [podman may need iptables kernel modules]
2026-02-27 00:33:11.586974 | controller | ok: Runtime: 0:00:00.007478
2026-02-27 00:33:11.635236 | 
2026-02-27 00:33:11.635350 | PLAY RECAP
2026-02-27 00:33:11.635405 | controller | ok: 46 changed: 26 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0
2026-02-27 00:33:11.635432 | 
2026-02-27 00:33:11.769563 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-27 00:33:11.771116 | RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2026-02-27 00:33:12.441309 | 
2026-02-27 00:33:12.441458 | PLAY [controller]
2026-02-27 00:33:12.467926 | 
2026-02-27 00:33:12.468058 | TASK [Copy the galaxy.yml on the controller]
2026-02-27 00:33:16.099033 | controller | changed
2026-02-27 00:33:16.112624 | 
2026-02-27 00:33:16.112932 | TASK [Load information from galaxy.yml]
2026-02-27 00:33:16.155642 | controller | ok
2026-02-27 00:33:16.172570 | 
2026-02-27 00:33:16.172801 | LOOP [Enable FIPS mode]
2026-02-27 00:33:16.208055 | 
2026-02-27 00:33:16.208263 | LOOP [ansible-test : Include branch specific variables.]
2026-02-27 00:33:16.251296 | controller | ok: "/var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/untrusted/project_2/github.com/ansible/ansible-zuul-jobs/roles/ansible-test/vars/default.yaml"
2026-02-27 00:33:16.251587 | 
2026-02-27 00:33:16.262242 | 
2026-02-27 00:33:16.262427 | TASK [ansible-test : Setup --skip-tags for test_options]
2026-02-27 00:33:16.297823 | controller | ok
2026-02-27 00:33:16.315862 | 
2026-02-27 00:33:16.315993 | TASK [ansible-test : Enable --inventory for network-integration]
2026-02-27 00:33:16.348218 | controller | skipping: Conditional result was False
2026-02-27 00:33:16.355605 | 
2026-02-27 00:33:16.355674 | TASK [ansible-test : Enable --retry-on-error]
2026-02-27 00:33:16.370826 | controller | skipping: Conditional result was False
2026-02-27 00:33:16.378476 | 
2026-02-27 00:33:16.378576 | TASK [ansible-test : Enable --continue-on-error]
2026-02-27 00:33:16.423823 | controller | ok
2026-02-27 00:33:16.436849 | 
2026-02-27 00:33:16.436980 | TASK [ansible-test : Enable --requirements]
2026-02-27 00:33:16.451297 | controller | skipping: Conditional result was False
2026-02-27 00:33:16.458774 | 
2026-02-27 00:33:16.458854 | TASK [ansible-test : Adjust options for unit tests]
2026-02-27 00:33:16.472654 | controller | skipping: Conditional result was False
2026-02-27 00:33:16.480407 | 
2026-02-27 00:33:16.480482 | TASK [ansible-test : Install requirements with unit tests]
2026-02-27 00:33:16.511136 | controller | ok
2026-02-27 00:33:16.542543 | 
2026-02-27 00:33:16.542664 | TASK [ansible-test : Set --skip-test]
2026-02-27 00:33:16.596942 | controller | skipping: Conditional result was False
2026-02-27 00:33:16.607222 | 
2026-02-27 00:33:16.607338 | TASK [ansible-test : Reduce verbosity]
2026-02-27 00:33:16.650269 | controller | ok
2026-02-27 00:33:16.660878 | 
2026-02-27 00:33:16.660990 | TASK [ansible-test : Setup --python option]
2026-02-27 00:33:16.686391 | controller | skipping: Conditional result was False
2026-02-27 00:33:16.695858 | 
2026-02-27 00:33:16.695993 | TASK [ansible-test : Setup --docker option]
2026-02-27 00:33:16.728894 | controller | ok
2026-02-27 00:33:16.739753 | 
2026-02-27 00:33:16.739882 | TASK [ansible-test : check if MANIFEST.json exists]
2026-02-27 00:33:17.720715 | controller | ok
2026-02-27 00:33:17.726633 | 
2026-02-27 00:33:17.726697 | TASK [ansible-test : Copy the MANIFEST.json on the controller]
2026-02-27 00:33:17.750932 | controller | skipping: Conditional result was False
2026-02-27 00:33:17.760202 | 
2026-02-27 00:33:17.760328 | TASK [ansible-test : Load information from MANIFEST.json]
2026-02-27 00:33:17.794647 | controller | skipping: Conditional result was False
2026-02-27 00:33:17.801140 | 
2026-02-27 00:33:17.801215 | TASK [ansible-test : Setup location of project for integration tests]
2026-02-27 00:33:17.825688 | controller | skipping: Conditional result was False
2026-02-27 00:33:17.833347 | 
2026-02-27 00:33:17.833514 | TASK [ansible-test : Copy the galaxy.yml on the controller]
2026-02-27 00:33:19.008361 | controller | ok
2026-02-27 00:33:19.015933 | 
2026-02-27 00:33:19.016023 | TASK [ansible-test : Load information from galaxy.yml]
2026-02-27 00:33:19.050381 | controller | ok
2026-02-27 00:33:19.059300 | 
2026-02-27 00:33:19.059390 | TASK [ansible-test : Setup location of project for integration tests]
2026-02-27 00:33:19.102286 | controller | ok
2026-02-27 00:33:19.109878 | 
2026-02-27 00:33:19.109983 | TASK [ansible-test : Setup minimum test requirements]
2026-02-27 00:33:19.144136 | controller | ok
2026-02-27 00:33:19.152280 | 
2026-02-27 00:33:19.152389 | TASK [ansible-test : Ensure pip temp directory exists in /var/tmp]
2026-02-27 00:33:20.359158 | controller | ok
2026-02-27 00:33:20.374045 | 
2026-02-27 00:33:20.374210 | TASK [ansible-test : Install python requirements]
2026-02-27 00:33:22.152374 | controller | Collecting yamllint (from -r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2026-02-27 00:33:22.415643 | controller |   Downloading yamllint-1.35.1-py3-none-any.whl.metadata (4.2 kB)
2026-02-27 00:33:22.548542 | controller | Collecting pathspec>=0.5.3 (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2026-02-27 00:33:22.637452 | controller |   Downloading pathspec-0.12.1-py3-none-any.whl.metadata (21 kB)
2026-02-27 00:33:22.666373 | controller | Requirement already satisfied: pyyaml in ./venv/lib64/python3.8/site-packages (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1)) (6.0.3)
2026-02-27 00:33:22.759714 | controller | Downloading yamllint-1.35.1-py3-none-any.whl (66 kB)
2026-02-27 00:33:22.949651 | controller | Downloading pathspec-0.12.1-py3-none-any.whl (31 kB)
2026-02-27 00:33:23.020613 | controller | Installing collected packages: pathspec, yamllint
2026-02-27 00:33:23.115357 | controller | Successfully installed pathspec-0.12.1 yamllint-1.35.1
2026-02-27 00:33:23.744785 | controller | ok: Runtime: 0:00:01.982581
2026-02-27 00:33:23.761467 | 
2026-02-27 00:33:23.761665 | TASK [ansible-test : Copy the integration_config.yml file from the controller]
2026-02-27 00:33:24.623371 | controller | cp: cannot stat '/tmp/integration_config.yml': No such file or directory
2026-02-27 00:33:25.149261 | controller | ERROR
2026-02-27 00:33:25.149565 | controller | {
2026-02-27 00:33:25.149630 | controller |   "delta": "0:00:00.006932",
2026-02-27 00:33:25.149673 | controller |   "end": "2026-02-27 00:33:24.623609",
2026-02-27 00:33:25.149717 | controller |   "msg": "non-zero return code",
2026-02-27 00:33:25.149823 | controller |   "rc": 1,
2026-02-27 00:33:25.149865 | controller |   "start": "2026-02-27 00:33:24.616677"
2026-02-27 00:33:25.149900 | controller | }
2026-02-27 00:33:25.149968 | controller | ERROR: Ignoring Errors
2026-02-27 00:33:25.165535 | 
2026-02-27 00:33:25.165903 | TASK [ansible-test : Copy potential cloud provider configuration for ansible-test in the collection]
2026-02-27 00:33:25.546243 | controller | skipping: Conditional result was False
2026-02-27 00:33:25.562931 | 
2026-02-27 00:33:25.563110 | TASK [ansible-test : Enable persistent connection logging]
2026-02-27 00:33:26.923422 | controller | changed: section and option added
2026-02-27 00:33:26.935568 | 
2026-02-27 00:33:26.935703 | TASK [ansible-test : Set persistent ssh_type value]
2026-02-27 00:33:28.152057 | controller | changed: option added
2026-02-27 00:33:28.157881 | 
2026-02-27 00:33:28.157948 | TASK [ansible-test : Set ansible log path]
2026-02-27 00:33:29.495475 | controller | changed: section and option added
2026-02-27 00:33:29.501471 | 
2026-02-27 00:33:29.501537 | TASK [ansible-test : Identify the changed targets]
2026-02-27 00:33:29.862166 | controller | skipping: Conditional result was False
2026-02-27 00:33:29.870720 | 
2026-02-27 00:33:29.870839 | TASK [ansible-test : set_fact]
2026-02-27 00:33:29.976788 | controller | skipping: Conditional result was False
2026-02-27 00:33:30.023277 | 
2026-02-27 00:33:30.023871 | TASK [ansible-test : Set the targets]
2026-02-27 00:33:30.071239 | controller | ok
2026-02-27 00:33:30.077276 | 
2026-02-27 00:33:30.077346 | TASK [ansible-test : set_fact]
2026-02-27 00:33:30.092281 | controller | skipping: Conditional result was False
2026-02-27 00:33:30.099992 | 
2026-02-27 00:33:30.100073 | TASK [ansible-test : List the targets]
2026-02-27 00:33:30.467335 | controller | skipping: Conditional result was False
2026-02-27 00:33:30.477572 | 
2026-02-27 00:33:30.477696 | TASK [ansible-test : set_fact]
2026-02-27 00:33:30.504536 | controller | skipping: Conditional result was False
2026-02-27 00:33:30.519136 | 
2026-02-27 00:33:30.519292 | TASK [ansible-test : set_fact]
2026-02-27 00:33:30.564676 | controller | skipping: Conditional result was False
2026-02-27 00:33:30.574400 | 
2026-02-27 00:33:30.574495 | LOOP [ansible-test : set_fact]
2026-02-27 00:33:30.639347 | 
2026-02-27 00:33:30.639654 | TASK [ansible-test : set_fact]
2026-02-27 00:33:30.674918 | controller | skipping: Conditional result was False
2026-02-27 00:33:30.682166 | 
2026-02-27 00:33:30.682250 | TASK [ansible-test : debug]
2026-02-27 00:33:30.716712 | controller | skipping: Conditional result was False
2026-02-27 00:33:30.723641 | 
2026-02-27 00:33:30.723713 | TASK [ansible-test : debug]
2026-02-27 00:33:30.753986 | About to run: ansible-test sanity --requirements --docker -v
2026-02-27 00:33:30.760415 | 
2026-02-27 00:33:30.760493 | TASK [ansible-test : Run the test suite]
2026-02-27 00:33:32.585196 | controller | Run command: docker images quay.io/ansible/default-test-container:1.10.1 --format '{{json .}}'
2026-02-27 00:33:32.632849 | controller | Run command: docker pull quay.io/ansible/default-test-container:1.10.1
2026-02-27 00:33:34.346811 | controller | 1.10.1: Pulling from ansible/default-test-container
2026-02-27 00:33:34.346968 | controller | [DEPRECATION NOTICE] Docker Image Format v1, and Docker Image manifest version 2, schema 1 support will be removed in an upcoming release. Suggest the author of quay.io/ansible/default-test-container:1.10.1 to upgrade the image to the OCI Format, or Docker Image manifest v2, schema 2. More information at https://docs.docker.com/go/deprecated-image-specs/
2026-02-27 00:33:34.346995 | controller | 5667fdb72017: Pulling fs layer
2026-02-27 00:33:34.347004 | controller | d83811f270d5: Pulling fs layer
2026-02-27 00:33:34.347011 | controller | ee671aafb583: Pulling fs layer
2026-02-27 00:33:34.347020 | controller | 7fc152dfb3a6: Pulling fs layer
2026-02-27 00:33:34.347041 | controller | 3fb967a6fd03: Pulling fs layer
2026-02-27 00:33:34.347058 | controller | b3e63023ca5f: Pulling fs layer
2026-02-27 00:33:34.347064 | controller | 653cb3e65dbf: Pulling fs layer
2026-02-27 00:33:34.347070 | controller | f4712b586375: Pulling fs layer
2026-02-27 00:33:34.347076 | controller | d696ed7812f8: Pulling fs layer
2026-02-27 00:33:34.347082 | controller | 29bf28764f14: Pulling fs layer
2026-02-27 00:33:34.347088 | controller | 47d7edb3c2b7: Pulling fs layer
2026-02-27 00:33:34.347094 | controller | 07550ad4f6e4: Pulling fs layer
2026-02-27 00:33:34.347100 | controller | 7e79526e64c5: Pulling fs layer
2026-02-27 00:33:34.347107 | controller | 4fffb32882b7: Pulling fs layer
2026-02-27 00:33:34.347113 | controller | fc7a38b06f4e: Pulling fs layer
2026-02-27 00:33:34.347119 | controller | 6d9d912e060e: Pulling fs layer
2026-02-27 00:33:34.347135 | controller | 5dd542dd28d9: Pulling fs layer
2026-02-27 00:33:34.347142 | controller | cef8beb99552: Pulling fs layer
2026-02-27 00:33:34.347148 | controller | bd5557e101ad: Pulling fs layer
2026-02-27 00:33:34.347154 | controller | e057c20fabdd: Pulling fs layer
2026-02-27 00:33:34.347170 | controller | d16059cdae2e: Pulling fs layer
2026-02-27 00:33:34.347176 | controller | 431e42d906a3: Pulling fs layer
2026-02-27 00:33:34.347182 | controller | 7a0fd3b1d7c3: Pulling fs layer
2026-02-27 00:33:34.347188 | controller | aacdb6db0c8c: Pulling fs layer
2026-02-27 00:33:34.347193 | controller | 2e7f04ae8c8b: Pulling fs layer
2026-02-27 00:33:34.347199 | controller | 4cd343027a44: Pulling fs layer
2026-02-27 00:33:34.347205 | controller | 0b4379883f90: Pulling fs layer
2026-02-27 00:33:34.347211 | controller | 3d9d6d9dfc91: Pulling fs layer
2026-02-27 00:33:34.347220 | controller | 57d6314bd293: Pulling fs layer
2026-02-27 00:33:34.347226 | controller | 774036afeb7f: Pulling fs layer
2026-02-27 00:33:34.347231 | controller | 54b10f0e1645: Pulling fs layer
2026-02-27 00:33:34.347237 | controller | 78cf439d9fdb: Pulling fs layer
2026-02-27 00:33:34.347243 | controller | 36e5e20969c7: Pulling fs layer
2026-02-27 00:33:34.347249 | controller | 4b19ac3f17a8: Pulling fs layer
2026-02-27 00:33:34.347255 | controller | 5dd542dd28d9: Waiting
2026-02-27 00:33:34.347261 | controller | cef8beb99552: Waiting
2026-02-27 00:33:34.347269 | controller | bd5557e101ad: Waiting
2026-02-27 00:33:34.347275 | controller | e057c20fabdd: Waiting
2026-02-27 00:33:34.347280 | controller | d16059cdae2e: Waiting
2026-02-27 00:33:34.347298 | controller | 431e42d906a3: Waiting
2026-02-27 00:33:34.347304 | controller | 7a0fd3b1d7c3: Waiting
2026-02-27 00:33:34.347310 | controller | aacdb6db0c8c: Waiting
2026-02-27 00:33:34.347316 | controller | 2e7f04ae8c8b: Waiting
2026-02-27 00:33:34.347322 | controller | 4cd343027a44: Waiting
2026-02-27 00:33:34.347328 | controller | 0b4379883f90: Waiting
2026-02-27 00:33:34.347333 | controller | 3d9d6d9dfc91: Waiting
2026-02-27 00:33:34.347339 | controller | 57d6314bd293: Waiting
2026-02-27 00:33:34.347353 | controller | 774036afeb7f: Waiting
2026-02-27 00:33:34.347362 | controller | 54b10f0e1645: Waiting
2026-02-27 00:33:34.347368 | controller | 78cf439d9fdb: Waiting
2026-02-27 00:33:34.347374 | controller | 36e5e20969c7: Waiting
2026-02-27 00:33:34.347379 | controller | 4b19ac3f17a8: Waiting
2026-02-27 00:33:34.347385 | controller | d696ed7812f8: Waiting
2026-02-27 00:33:34.347391 | controller | 29bf28764f14: Waiting
2026-02-27 00:33:34.347397 | controller | 47d7edb3c2b7: Waiting
2026-02-27 00:33:34.347404 | controller | 07550ad4f6e4: Waiting
2026-02-27 00:33:34.347410 | controller | 7e79526e64c5: Waiting
2026-02-27 00:33:34.347415 | controller | 4fffb32882b7: Waiting
2026-02-27 00:33:34.347421 | controller | fc7a38b06f4e: Waiting
2026-02-27 00:33:34.347427 | controller | 6d9d912e060e: Waiting
2026-02-27 00:33:34.347439 | controller | b3e63023ca5f: Waiting
2026-02-27 00:33:35.129110 | controller | 7fc152dfb3a6: Waiting
2026-02-27 00:33:35.129164 | controller | 653cb3e65dbf: Waiting
2026-02-27 00:33:35.129174 | controller | f4712b586375: Waiting
2026-02-27 00:33:35.129181 | controller | 3fb967a6fd03: Waiting
2026-02-27 00:33:35.129195 | controller | ee671aafb583: Verifying Checksum
2026-02-27 00:33:35.289373 | controller | ee671aafb583: Download complete
2026-02-27 00:33:35.289444 | controller | d83811f270d5: Verifying Checksum
2026-02-27 00:33:36.003097 | controller | d83811f270d5: Download complete
2026-02-27 00:33:36.003153 | controller | 7fc152dfb3a6: Verifying Checksum
2026-02-27 00:33:36.815139 | controller | 7fc152dfb3a6: Download complete
2026-02-27 00:33:36.815206 | controller | b3e63023ca5f: Verifying Checksum
2026-02-27 00:33:37.552976 | controller | b3e63023ca5f: Download complete
2026-02-27 00:33:37.553025 | controller | 653cb3e65dbf: Verifying Checksum
2026-02-27 00:33:41.560704 | controller | 653cb3e65dbf: Download complete
2026-02-27 00:33:41.560770 | controller | 5667fdb72017: Verifying Checksum
2026-02-27 00:33:41.560803 | controller | 5667fdb72017: Download complete
2026-02-27 00:33:42.429325 | controller | d696ed7812f8: Verifying Checksum
2026-02-27 00:33:43.050821 | controller | d696ed7812f8: Download complete
2026-02-27 00:33:43.050879 | controller | 3fb967a6fd03: Verifying Checksum
2026-02-27 00:33:43.218763 | controller | 3fb967a6fd03: Download complete
2026-02-27 00:33:43.218833 | controller | 29bf28764f14: Verifying Checksum
2026-02-27 00:33:43.963410 | controller | 29bf28764f14: Download complete
2026-02-27 00:33:43.963483 | controller | 07550ad4f6e4: Verifying Checksum
2026-02-27 00:33:44.384090 | controller | 07550ad4f6e4: Download complete
2026-02-27 00:33:44.384172 | controller | 5667fdb72017: Pull complete
2026-02-27 00:33:44.408331 | controller | 47d7edb3c2b7: Verifying Checksum
2026-02-27 00:33:44.408381 | controller | 47d7edb3c2b7: Download complete
2026-02-27 00:33:44.458122 | controller | d83811f270d5: Pull complete
2026-02-27 00:33:44.503238 | controller | ee671aafb583: Pull complete
2026-02-27 00:33:44.554814 | controller | 7fc152dfb3a6: Pull complete
2026-02-27 00:33:44.911467 | controller | 7e79526e64c5: Verifying Checksum
2026-02-27 00:33:45.282857 | controller | 7e79526e64c5: Download complete
2026-02-27 00:33:45.282952 | controller | 4fffb32882b7: Verifying Checksum
2026-02-27 00:33:45.745296 | controller | 4fffb32882b7: Download complete
2026-02-27 00:33:45.745363 | controller | 3fb967a6fd03: Pull complete
2026-02-27 00:33:45.772318 | controller | b3e63023ca5f: Pull complete
2026-02-27 00:33:45.809900 | controller | 653cb3e65dbf: Pull complete
2026-02-27 00:33:46.115834 | controller | 6d9d912e060e: Verifying Checksum
2026-02-27 00:33:46.239639 | controller | 6d9d912e060e: Download complete
2026-02-27 00:33:46.239741 | controller | fc7a38b06f4e: Verifying Checksum
2026-02-27 00:33:46.893680 | controller | fc7a38b06f4e: Download complete
2026-02-27 00:33:46.893807 | controller | 5dd542dd28d9: Verifying Checksum
2026-02-27 00:33:46.896219 | controller | 5dd542dd28d9: Download complete
2026-02-27 00:33:47.660833 | controller | bd5557e101ad: Verifying Checksum
2026-02-27 00:33:48.548562 | controller | bd5557e101ad: Download complete
2026-02-27 00:33:48.548664 | controller | e057c20fabdd: Verifying Checksum
2026-02-27 00:33:49.289134 | controller | e057c20fabdd: Download complete
2026-02-27 00:33:49.289236 | controller | d16059cdae2e: Verifying Checksum
2026-02-27 00:33:49.289386 | controller | d16059cdae2e: Download complete
2026-02-27 00:33:51.472655 | controller | 431e42d906a3: Verifying Checksum
2026-02-27 00:33:51.472735 | controller | 431e42d906a3: Download complete
2026-02-27 00:33:53.137947 | controller | 7a0fd3b1d7c3: Download complete
2026-02-27 00:33:54.692001 | controller | aacdb6db0c8c: Verifying Checksum
2026-02-27 00:33:54.692819 | controller | aacdb6db0c8c: Download complete
2026-02-27 00:33:55.435912 | controller | 2e7f04ae8c8b: Download complete
2026-02-27 00:33:56.167864 | controller | 4cd343027a44: Verifying Checksum
2026-02-27 00:33:56.167927 | controller | 4cd343027a44: Download complete
2026-02-27 00:33:56.952623 | controller | 0b4379883f90: Download complete
2026-02-27 00:33:57.701734 | controller | 3d9d6d9dfc91: Verifying Checksum
2026-02-27 00:33:57.701939 | controller | 3d9d6d9dfc91: Download complete
2026-02-27 00:34:02.583150 | controller | f4712b586375: Verifying Checksum
2026-02-27 00:34:13.930834 | controller | f4712b586375: Download complete
2026-02-27 00:34:13.930929 | controller | 57d6314bd293: Verifying Checksum
2026-02-27 00:34:18.895684 | controller | 57d6314bd293: Download complete
2026-02-27 00:34:18.895784 | controller | cef8beb99552: Verifying Checksum
2026-02-27 00:34:18.895912 | controller | cef8beb99552: Download complete
2026-02-27 00:34:20.061628 | controller | 774036afeb7f: Verifying Checksum
2026-02-27 00:34:20.061896 | controller | 774036afeb7f: Download complete
2026-02-27 00:34:24.229380 | controller | 54b10f0e1645: Verifying Checksum
2026-02-27 00:34:28.987583 | controller | 54b10f0e1645: Download complete
2026-02-27 00:34:28.987705 | controller | 78cf439d9fdb: Verifying Checksum
2026-02-27 00:34:28.987747 | controller | 78cf439d9fdb: Download complete
2026-02-27 00:34:30.578448 | controller | f4712b586375: Pull complete
2026-02-27 00:34:30.637450 | controller | d696ed7812f8: Pull complete
2026-02-27 00:34:30.712093 | controller | 29bf28764f14: Pull complete
2026-02-27 00:34:30.720470 | controller | 36e5e20969c7: Verifying Checksum
2026-02-27 00:34:30.720581 | controller | 36e5e20969c7: Download complete
2026-02-27 00:34:30.797284 | controller | 47d7edb3c2b7: Pull complete
2026-02-27 00:34:30.831627 | controller | 07550ad4f6e4: Pull complete
2026-02-27 00:34:30.878723 | controller | 7e79526e64c5: Pull complete
2026-02-27 00:34:30.923340 | controller | 4fffb32882b7: Pull complete
2026-02-27 00:34:31.014718 | controller | fc7a38b06f4e: Pull complete
2026-02-27 00:34:31.067299 | controller | 6d9d912e060e: Pull complete
2026-02-27 00:34:31.142172 | controller | 5dd542dd28d9: Pull complete
2026-02-27 00:34:32.004589 | controller | 4b19ac3f17a8: Verifying Checksum
2026-02-27 00:34:32.004713 | controller | 4b19ac3f17a8: Download complete
2026-02-27 00:34:55.000828 | controller | cef8beb99552: Pull complete
2026-02-27 00:34:55.031742 | controller | bd5557e101ad: Pull complete
2026-02-27 00:34:55.075635 | controller | e057c20fabdd: Pull complete
2026-02-27 00:34:55.115412 | controller | d16059cdae2e: Pull complete
2026-02-27 00:34:57.377538 | controller | 431e42d906a3: Pull complete
2026-02-27 00:34:57.457128 | controller | 7a0fd3b1d7c3: Pull complete
2026-02-27 00:34:57.529577 | controller | aacdb6db0c8c: Pull complete
2026-02-27 00:34:57.569468 | controller | 2e7f04ae8c8b: Pull complete
2026-02-27 00:34:57.609150 | controller | 4cd343027a44: Pull complete
2026-02-27 00:34:57.660032 | controller | 0b4379883f90: Pull complete
2026-02-27 00:34:57.720127 | controller | 3d9d6d9dfc91: Pull complete
2026-02-27 00:35:04.054255 | controller | 57d6314bd293: Pull complete
2026-02-27 00:35:27.707230 | controller | 774036afeb7f: Pull complete
2026-02-27 00:35:57.935759 | controller | 54b10f0e1645: Pull complete
2026-02-27 00:36:23.958247 | controller | 78cf439d9fdb: Pull complete
2026-02-27 00:36:55.044033 | controller | 36e5e20969c7: Pull complete
2026-02-27 00:37:22.091562 | controller | 4b19ac3f17a8: Pull complete
2026-02-27 00:37:22.106769 | controller | Digest: sha256:954c4edffb0905df64e23c8611b1c4a62db9af13062f51cad5b658e727238d41
2026-02-27 00:37:22.110289 | controller | Status: Downloaded newer image for quay.io/ansible/default-test-container:1.10.1
2026-02-27 00:37:22.119987 | controller | quay.io/ansible/default-test-container:1.10.1
2026-02-27 00:37:22.125656 | controller | Run command: docker images quay.io/ansible/pypi-test-container:1.0.0 --format '{{json .}}'
2026-02-27 00:37:22.174622 | controller | Run command: docker pull quay.io/ansible/pypi-test-container:1.0.0
2026-02-27 00:37:23.629191 | controller | 1.0.0: Pulling from ansible/pypi-test-container
2026-02-27 00:37:23.629385 | controller | 04a5f4cda3ee: Pulling fs layer
2026-02-27 00:37:23.629405 | controller | ff496a88c8ed: Pulling fs layer
2026-02-27 00:37:23.629415 | controller | 0ce83f459fe7: Pulling fs layer
2026-02-27 00:37:23.629422 | controller | 2e5170e1f099: Pulling fs layer
2026-02-27 00:37:23.629430 | controller | 7641eb41b08c: Pulling fs layer
2026-02-27 00:37:23.629437 | controller | ad15fa9da398: Pulling fs layer
2026-02-27 00:37:23.629445 | controller | 087d91352424: Pulling fs layer
2026-02-27 00:37:23.629983 | controller | 8b92efd6a100: Pulling fs layer
2026-02-27 00:37:23.630004 | controller | 2e5170e1f099: Waiting
2026-02-27 00:37:23.630124 | controller | 7641eb41b08c: Waiting
2026-02-27 00:37:23.630151 | controller | ad15fa9da398: Waiting
2026-02-27 00:37:23.630161 | controller | 087d91352424: Waiting
2026-02-27 00:37:24.007357 | controller | 8b92efd6a100: Waiting
2026-02-27 00:37:24.007432 | controller | 0ce83f459fe7: Verifying Checksum
2026-02-27 00:37:24.024485 | controller | 0ce83f459fe7: Download complete
2026-02-27 00:37:24.024577 | controller | ff496a88c8ed: Verifying Checksum
2026-02-27 00:37:24.247418 | controller | ff496a88c8ed: Download complete
2026-02-27 00:37:24.247482 | controller | 04a5f4cda3ee: Download complete
2026-02-27 00:37:24.416922 | controller | 7641eb41b08c: Download complete
2026-02-27 00:37:24.631666 | controller | ad15fa9da398: Verifying Checksum
2026-02-27 00:37:24.681590 | controller | ad15fa9da398: Download complete
2026-02-27 00:37:24.681636 | controller | 2e5170e1f099: Verifying Checksum
2026-02-27 00:37:24.681730 | controller | 2e5170e1f099: Download complete
2026-02-27 00:37:24.941687 | controller | 087d91352424: Verifying Checksum
2026-02-27 00:37:24.988563 | controller | 087d91352424: Download complete
2026-02-27 00:37:24.988645 | controller | 8b92efd6a100: Verifying Checksum
2026-02-27 00:37:26.531958 | controller | 8b92efd6a100: Download complete
2026-02-27 00:37:26.532041 | controller | 04a5f4cda3ee: Pull complete
2026-02-27 00:37:26.559559 | controller | ff496a88c8ed: Pull complete
2026-02-27 00:37:26.585644 | controller | 0ce83f459fe7: Pull complete
2026-02-27 00:37:29.036590 | controller | 2e5170e1f099: Pull complete
2026-02-27 00:37:29.067682 | controller | 7641eb41b08c: Pull complete
2026-02-27 00:37:29.094302 | controller | ad15fa9da398: Pull complete
2026-02-27 00:37:30.265734 | controller | 087d91352424: Pull complete
2026-02-27 00:37:30.291831 | controller | 8b92efd6a100: Pull complete
2026-02-27 00:37:30.322905 | controller | Digest: sha256:71042ab0a14971b5608fe75706de54f367fc31db573e3b3955182037f73cadb6
2026-02-27 00:37:30.326414 | controller | Status: Downloaded newer image for quay.io/ansible/pypi-test-container:1.0.0
2026-02-27 00:37:30.341310 | controller | quay.io/ansible/pypi-test-container:1.0.0
2026-02-27 00:37:30.343747 | controller | Run command: docker run --detach quay.io/ansible/pypi-test-container:1.0.0
2026-02-27 00:37:40.538323 | controller | Run command: docker inspect 572b9f7804a3d867b2208fb9554a422dfa6969d0dcdfa8953f088f11eb1aa94b
2026-02-27 00:37:40.776411 | controller | Scanning collection root: /home/zuul/.ansible/collections/ansible_collections
2026-02-27 00:37:40.789365 | controller | Including collection: ansible.netcommon (278 files)
2026-02-27 00:37:40.800848 | controller | Including collection: ansible.network (23 files)
2026-02-27 00:37:40.800919 | controller | Including collection: ansible.utils (441 files)
2026-02-27 00:37:40.845624 | controller | Including collection: arista.eos (1031 files)
2026-02-27 00:37:40.898844 | controller | Including collection: cisco.ios (1215 files)
2026-02-27 00:37:40.944719 | controller | Including collection: cisco.iosxr (1044 files)
2026-02-27 00:37:41.030114 | controller | Including collection: cisco.nxos (1687 files)
2026-02-27 00:37:41.073740 | controller | Including collection: junipernetworks.junos (963 files)
2026-02-27 00:37:41.117239 | controller | Creating a payload archive containing 8419 files...
2026-02-27 00:37:43.630608 | controller | Created a 6949115 byte payload archive containing 8419 files in 2 seconds.
2026-02-27 00:37:43.635237 | controller | Assuming Docker is available on localhost.
2026-02-27 00:37:43.635709 | controller | Run command: docker run --detach --volume /sys/fs/cgroup:/sys/fs/cgroup:ro --privileged=false --security-opt seccomp=unconfined --volume /var/run/docker.sock:/var/run/docker.sock quay.io/ansible/default-test-container:1.10.1
2026-02-27 00:37:44.222467 | controller | Run command: docker exec -i 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc dd of=/root/docker.sh bs=65536
2026-02-27 00:37:44.310620 | controller | Run command: docker exec 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc /bin/bash /root/docker.sh
2026-02-27 00:37:44.398815 | controller | Run command: docker exec -i 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc dd of=/root/ansible.tgz bs=65536
2026-02-27 00:37:44.502362 | controller | Run command: docker exec 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc mkdir /root/ansible
2026-02-27 00:37:44.580780 | controller | Run command: docker exec 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc tar oxzf /root/ansible.tgz -C /root/ansible
2026-02-27 00:37:45.823606 | controller | Run command: docker exec 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc /usr/bin/env ANSIBLE_TEST_CONTENT_ROOT=/root/ansible/ansible_collections/ansible/network LC_ALL=en_US.UTF-8 /usr/bin/python3.6 /root/ansible/bin/ansible-test sanity -v --metadata metadata-jc02ycei.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/
2026-02-27 00:37:46.368710 | controller | Injecting custom PyPI hosts entries: /etc/hosts
2026-02-27 00:37:46.368775 | controller | Injecting custom PyPI config: /root/.pip/pip.conf
2026-02-27 00:37:46.369228 | controller | Injecting custom PyPI config: /root/.pydistutils.cfg
2026-02-27 00:37:46.371234 | controller | Run command: /usr/bin/python3.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-27 00:37:46.465231 | controller | Running sanity test 'action-plugin-docs' with Python 3.6
2026-02-27 00:37:46.471204 | controller | Read 0 sanity test ignore line(s) for Ansible 2.9 from: tests/sanity/ignore-2.9.txt
2026-02-27 00:37:46.482624 | controller | No tests applicable.
2026-02-27 00:37:46.482914 | controller | Running sanity test 'ansible-doc' with Python 3.6
2026-02-27 00:37:46.483279 | controller | No tests applicable.
2026-02-27 00:37:46.483756 | controller | Run command: /usr/bin/python2.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-27 00:37:46.571634 | controller | Running sanity test 'compile' with Python 2.6
2026-02-27 00:37:46.572321 | controller | No tests applicable.
2026-02-27 00:37:46.572868 | controller | Run command: /usr/bin/python2.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-27 00:37:46.772176 | controller | Running sanity test 'compile' with Python 2.7
2026-02-27 00:37:46.772459 | controller | No tests applicable.
2026-02-27 00:37:46.772926 | controller | Run command: /usr/bin/python3.5 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-27 00:37:46.905185 | controller | Running sanity test 'compile' with Python 3.5
2026-02-27 00:37:46.905746 | controller | No tests applicable.
2026-02-27 00:37:46.905976 | controller | Running sanity test 'compile' with Python 3.6
2026-02-27 00:37:46.905993 | controller | No tests applicable.
2026-02-27 00:37:46.906352 | controller | Run command: /usr/bin/python3.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-27 00:37:47.017562 | controller | Running sanity test 'compile' with Python 3.7
2026-02-27 00:37:47.018156 | controller | No tests applicable.
2026-02-27 00:37:47.018680 | controller | Run command: /usr/bin/python3.8 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-27 00:37:47.136167 | controller | Running sanity test 'compile' with Python 3.8
2026-02-27 00:37:47.136678 | controller | No tests applicable.
2026-02-27 00:37:47.136854 | controller | Running sanity test 'empty-init' with Python 3.6
2026-02-27 00:37:47.137122 | controller | No tests applicable.
2026-02-27 00:37:47.137384 | controller | Running sanity test 'future-import-boilerplate' with Python 3.6
2026-02-27 00:37:47.137401 | controller | No tests applicable.
2026-02-27 00:37:47.138957 | controller | Running sanity test 'ignores'
2026-02-27 00:37:47.138996 | controller | Run command: /usr/bin/python3.6 -m pip.__main__ install --disable-pip-version-check -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt
2026-02-27 00:37:47.924639 | controller | Ignoring packaging: markers 'python_version < "3.6"' don't match your environment
2026-02-27 00:37:47.928119 | controller | Ignoring coverage: markers 'python_version > "3.7"' don't match your environment
2026-02-27 00:37:47.929495 | controller | Ignoring cryptography: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.932317 | controller | Ignoring deepdiff: markers 'python_version < "3"' don't match your environment
2026-02-27 00:37:47.933933 | controller | Ignoring jinja2: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.938413 | controller | Ignoring urllib3: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.941825 | controller | Ignoring sphinx: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.946220 | controller | Ignoring wheel: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.947707 | controller | Ignoring yamllint: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.952124 | controller | Ignoring paramiko: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.954678 | controller | Ignoring pytest: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.956400 | controller | Ignoring pytest: markers 'python_version == "2.7"' don't match your environment
2026-02-27 00:37:47.957825 | controller | Ignoring pytest-forked: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.961500 | controller | Ignoring requests: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.969329 | controller | Ignoring virtualenv: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.970837 | controller | Ignoring pathspec: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.972231 | controller | Ignoring pyopenssl: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.975858 | controller | Ignoring pyyaml: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.977302 | controller | Ignoring pycparser: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.980636 | controller | Ignoring xmltodict: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.982024 | controller | Ignoring lxml: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.983579 | controller | Ignoring pyvmomi: markers 'python_version < "2.7"' don't match your environment
2026-02-27 00:37:47.985831 | controller | Ignoring MarkupSafe: markers 'python_version < "3.6"' don't match your environment
2026-02-27 00:37:47.991302 | controller | Ignoring setuptools: markers 'python_version <= "2.7"' don't match your environment
2026-02-27 00:37:47.995212 | controller | Ignoring websocket-client: markers 'python_version < "3"' don't match your environment
2026-02-27 00:37:47.996557 | controller | Ignoring certifi: markers 'python_version < "3"' don't match your environment
2026-02-27 00:37:48.015933 | controller | Looking in indexes: http://172.17.0.2:3141/root/pypi/+simple/
2026-02-27 00:37:48.017114 | controller | Requirement already satisfied: cryptography<3.4 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (2.7)
2026-02-27 00:37:48.047112 | controller | Requirement already satisfied: rstcheck==3.3.1 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 12)) (3.3.1)
2026-02-27 00:37:48.050653 | controller | Requirement already satisfied: voluptuous>=0.11.0 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 30)) (0.11.7)
2026-02-27 00:37:48.054097 | controller | Requirement already satisfied: cffi!=1.14.4 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 49)) (1.13.0)
2026-02-27 00:37:48.056570 | controller | Requirement already satisfied: pylint==2.3.1 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 58)) (2.3.1)
2026-02-27 00:37:48.062626 | controller | Requirement already satisfied: jinja2 in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 2)) (2.10.3)
2026-02-27 00:37:48.066274 | controller | Requirement already satisfied: pycodestyle in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 3)) (2.5.0)
2026-02-27 00:37:48.071385 | controller | Requirement already satisfied: pyyaml in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 5)) (5.1.2)
2026-02-27 00:37:48.073313 | controller | Requirement already satisfied: virtualenv in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 7)) (16.7.5)
2026-02-27 00:37:48.092396 | controller | Requirement already satisfied: yamllint in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 9)) (1.18.0)
2026-02-27 00:37:48.096244 | controller | Requirement already satisfied: asn1crypto>=0.21.0 in /usr/local/lib/python3.6/dist-packages (from cryptography<3.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (1.1.0)
2026-02-27 00:37:48.101434 | controller | Requirement already satisfied: six>=1.4.1 in /usr/local/lib/python3.6/dist-packages (from cryptography<3.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (1.12.0)
2026-02-27 00:37:48.103305 | controller | Requirement already satisfied: docutils>=0.7 in /usr/local/lib/python3.6/dist-packages (from rstcheck==3.3.1->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 12)) (0.15.2)
2026-02-27 00:37:48.105431 | controller | Requirement already satisfied: pycparser in /usr/local/lib/python3.6/dist-packages (from cffi!=1.14.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 49)) (2.19)
2026-02-27 00:37:48.107959 | controller | Collecting isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55))
2026-02-27 00:38:03.116274 | controller |   WARNING: Retrying (Retry(total=4, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-27 00:38:18.624029 | controller |   WARNING: Retrying (Retry(total=3, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-27 00:38:34.642455 | controller |   WARNING: Retrying (Retry(total=2, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-27 00:38:51.660845 | controller |   WARNING: Retrying (Retry(total=1, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-27 00:39:10.682839 | controller |   WARNING: Retrying (Retry(total=0, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-27 00:39:25.701075 | controller |   ERROR: Could not find a version that satisfies the requirement isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55)) (from versions: none)
2026-02-27 00:39:25.702172 | controller | ERROR: No matching distribution found for isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55))
2026-02-27 00:39:25.830083 | controller | Removing custom PyPI config: /root/.pydistutils.cfg
2026-02-27 00:39:25.830722 | controller | ERROR: Command "/usr/bin/python3.6 -m pip.__main__ install --disable-pip-version-check -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt" returned exit status 1.
2026-02-27 00:39:25.830749 | controller | Removing custom PyPI config: /root/.pip/pip.conf
2026-02-27 00:39:25.830904 | controller | Removing custom PyPI hosts entries: /etc/hosts
2026-02-27 00:39:25.885660 | controller | Run command: docker exec 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc tar czf /root/output.tgz --exclude .tmp -C /root/ansible/ansible_collections/ansible/network/tests output
2026-02-27 00:39:25.982429 | controller | Run command: docker exec -i 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc dd if=/root/output.tgz bs=65536
2026-02-27 00:39:26.087918 | controller | Run command: tar oxzf /tmp/ansible-result-wjetfjma.tgz -C /home/zuul/.ansible/collections/ansible_collections/ansible/network/tests
2026-02-27 00:39:26.106584 | controller | Run command: docker rm -f 572b9f7804a3d867b2208fb9554a422dfa6969d0dcdfa8953f088f11eb1aa94b
2026-02-27 00:39:26.413572 | controller | Run command: docker rm -f 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc
2026-02-27 00:39:27.267763 | controller | ERROR: Command "docker exec 52ff53bacb9600cbb804fe683f30f6ad4791e4bc86137824db987710efba5bfc /usr/bin/env ANSIBLE_TEST_CONTENT_ROOT=/root/ansible/ansible_collections/ansible/network LC_ALL=en_US.UTF-8 /usr/bin/python3.6 /root/ansible/bin/ansible-test sanity -v --metadata metadata-jc02ycei.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/" returned exit status 1.
2026-02-27 00:39:27.918591 | controller | ERROR
2026-02-27 00:39:27.918989 | controller | {
2026-02-27 00:39:27.919062 | controller |   "delta": "0:05:55.057495",
2026-02-27 00:39:27.919109 | controller |   "end": "2026-02-27 00:39:27.342122",
2026-02-27 00:39:27.919168 | controller |   "msg": "non-zero return code",
2026-02-27 00:39:27.919231 | controller |   "rc": 1,
2026-02-27 00:39:27.919280 | controller |   "start": "2026-02-27 00:33:32.284627"
2026-02-27 00:39:27.919319 | controller | }
failure
2026-02-27 00:39:27.927487 | 
2026-02-27 00:39:27.927606 | PLAY RECAP
2026-02-27 00:39:27.927696 | controller | ok: 21 changed: 6 unreachable: 0 failed: 1 skipped: 20 rescued: 0 ignored: 1
2026-02-27 00:39:27.927834 | 
2026-02-27 00:39:28.055227 | RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2026-02-27 00:39:28.057252 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-27 00:39:28.669571 | 
2026-02-27 00:39:28.669714 | PLAY [all]
2026-02-27 00:39:28.693007 | 
2026-02-27 00:39:28.693149 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-27 00:39:31.746835 | controller | changed: non-zero return code
2026-02-27 00:39:31.756383 | 
2026-02-27 00:39:31.756574 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-02-27 00:39:31.782015 | controller | skipping: Conditional result was False
2026-02-27 00:39:31.790964 | 
2026-02-27 00:39:31.791074 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-02-27 00:39:31.832691 | 
2026-02-27 00:39:31.833027 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-02-27 00:39:31.867256 | 
2026-02-27 00:39:31.867460 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-02-27 00:39:31.891911 | controller | skipping: Conditional result was False
2026-02-27 00:39:31.901089 | 
2026-02-27 00:39:31.901194 | LOOP [fetch-subunit-output : Generate subunit file]
2026-02-27 00:39:31.935034 | 
2026-02-27 00:39:31.935249 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-02-27 00:39:31.960297 | controller | skipping: Conditional result was False
2026-02-27 00:39:31.970814 | 
2026-02-27 00:39:31.970919 | TASK [fetch-subunit-output : Remove the temporary file]
2026-02-27 00:39:31.995236 | controller | skipping: Conditional result was False
2026-02-27 00:39:32.004647 | 
2026-02-27 00:39:32.004797 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-02-27 00:39:32.029129 | controller | skipping: Conditional result was False
2026-02-27 00:39:32.066492 | 
2026-02-27 00:39:32.066611 | PLAY RECAP
2026-02-27 00:39:32.066663 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-27 00:39:32.066692 | 
2026-02-27 00:39:32.176087 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-27 00:39:32.176975 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-02-27 00:39:32.781116 | 
2026-02-27 00:39:32.781230 | PLAY [all:!appliance*]
2026-02-27 00:39:32.802679 | 
2026-02-27 00:39:32.802809 | TASK [unregister the node]
2026-02-27 00:39:33.158496 | controller | skipping: Conditional result was False
2026-02-27 00:39:33.170876 | 
2026-02-27 00:39:33.171043 | TASK [include_role : fetch-output]
2026-02-27 00:39:33.229340 | controller | ok
2026-02-27 00:39:33.272421 | 
2026-02-27 00:39:33.272608 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-27 00:39:33.348994 | controller | skipping: Conditional result was False
2026-02-27 00:39:33.357612 | 
2026-02-27 00:39:33.357722 | TASK [fetch-output : Set log path for single node]
2026-02-27 00:39:33.400484 | controller | ok
2026-02-27 00:39:33.408621 | 
2026-02-27 00:39:33.408720 | LOOP [fetch-output : Ensure local output dirs]
2026-02-27 00:39:33.846025 | controller -> localhost | ok: "/var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/logs"
2026-02-27 00:39:34.099314 | controller -> localhost | changed: "/var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/artifacts"
2026-02-27 00:39:34.369639 | controller -> localhost | changed: "/var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/work/docs"
2026-02-27 00:39:34.387865 | 
2026-02-27 00:39:34.388031 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-27 00:39:36.701795 | controller | changed:
2026-02-27 00:39:36.702201 | controller | .d..t...... ./
2026-02-27 00:39:36.702269 | controller | cd+++++++++ controller/
2026-02-27 00:39:36.702344 | controller | changed: All items complete
2026-02-27 00:39:36.702393 | 
2026-02-27 00:39:38.806090 | controller | changed: .d..t...... ./
2026-02-27 00:39:40.924454 | controller | changed: .d..t...... ./
2026-02-27 00:39:40.954936 | 
2026-02-27 00:39:40.955132 | TASK [include_role : fetch-output-openshift]
2026-02-27 00:39:40.982782 | controller | skipping: Conditional result was False
2026-02-27 00:39:41.001060 | 
2026-02-27 00:39:41.001214 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-27 00:39:41.055225 | controller | skipping: Conditional result was False
2026-02-27 00:39:41.068922 | controller | skipping: Conditional result was False
2026-02-27 00:39:41.122911 | 
2026-02-27 00:39:41.123052 | PLAY [localhost]
2026-02-27 00:39:41.141491 | 
2026-02-27 00:39:41.141589 | TASK [Run Zuul manifest role]
2026-02-27 00:39:41.161754 | localhost | ok
2026-02-27 00:39:41.180125 | 
2026-02-27 00:39:41.180214 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-27 00:39:41.611557 | localhost | changed
2026-02-27 00:39:41.622102 | 
2026-02-27 00:39:41.622417 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-27 00:39:41.670229 | localhost | ok
2026-02-27 00:39:41.691254 | 
2026-02-27 00:39:41.691400 | TASK [Set zuul-log-path fact]
2026-02-27 00:39:41.746837 | localhost | ok
2026-02-27 00:39:41.762970 | 
2026-02-27 00:39:41.763067 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-27 00:39:41.804374 | localhost | ok
2026-02-27 00:39:41.815645 | 
2026-02-27 00:39:41.815801 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-02-27 00:39:41.865126 | localhost | ok:
2026-02-27 00:39:41.865340 | localhost | {
2026-02-27 00:39:41.865376 | localhost |   "auth": {
2026-02-27 00:39:41.865408 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-02-27 00:39:41.865432 | localhost |     "username": "9LF91O0RK7JU"
2026-02-27 00:39:41.865455 | localhost |   },
2026-02-27 00:39:41.865479 | localhost |   "profile": "rackspace",
2026-02-27 00:39:41.865501 | localhost |   "region_name": "IAD"
2026-02-27 00:39:41.865521 | localhost | }
2026-02-27 00:39:41.865553 | 
2026-02-27 00:39:41.873417 | 
2026-02-27 00:39:41.873542 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-02-27 00:39:41.896420 | localhost | Output suppressed because no_log was given
2026-02-27 00:39:41.915967 | 
2026-02-27 00:39:41.916085 | TASK [upload-logs-failover : Initialize control vars]
2026-02-27 00:39:41.947635 | localhost | ok
2026-02-27 00:39:41.954524 | 
2026-02-27 00:39:41.954614 | LOOP [upload-logs-failover : Perform log upload]
2026-02-27 00:39:41.989598 | localhost | Output suppressed because no_log was given
2026-02-27 00:39:41.998834 | localhost | included: /var/lib/zuul/builds/a8f483601f764dd3af4f00a704fb9cc5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-02-27 00:39:42.008229 | 
2026-02-27 00:39:42.008323 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-02-27 00:39:42.118133 | localhost | Output suppressed because no_log was given
2026-02-27 00:39:42.124873 | 
2026-02-27 00:39:42.124966 | TASK [Upload logs to swift]
2026-02-27 00:39:42.156982 | localhost | ok
2026-02-27 00:39:42.194016 | 
2026-02-27 00:39:42.194135 | TASK [Set zuul-log-path fact]
2026-02-27 00:39:42.229159 | localhost | skipping: Conditional result was False
2026-02-27 00:39:42.236608 | 
2026-02-27 00:39:42.236699 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-02-27 00:39:42.690763 | localhost -> localhost | ok: Runtime: 0:00:00.005229
2026-02-27 00:39:42.704869 | 
2026-02-27 00:39:42.705034 | TASK [upload-logs-swift : Upload logs to swift]