2026-03-11 00:21:53.308386 | Job console starting...
2026-03-11 00:21:53.317332 | Updating repositories
2026-03-11 00:21:53.446493 | Preparing job workspace
2026-03-11 00:21:58.488677 | Running Ansible setup...
2026-03-11 00:22:06.473413 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-11 00:22:07.087005 | 
2026-03-11 00:22:07.087144 | PLAY [localhost]
2026-03-11 00:22:07.096383 | 
2026-03-11 00:22:07.096491 | TASK [Gathering Facts]
2026-03-11 00:22:08.013790 | localhost | ok
2026-03-11 00:22:08.034686 | 
2026-03-11 00:22:08.034867 | TASK [Setup log path fact]
2026-03-11 00:22:08.054055 | localhost | ok
2026-03-11 00:22:08.067412 | 
2026-03-11 00:22:08.067535 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-11 00:22:08.097470 | localhost | ok
2026-03-11 00:22:08.106506 | 
2026-03-11 00:22:08.106626 | TASK [emit-job-header : Print job information]
2026-03-11 00:22:08.137169 | # Job Information
2026-03-11 00:22:08.137325 | Ansible Version: 2.15.12
2026-03-11 00:22:08.137357 | Job: ansible-test-sanity-docker-stable-2.9
2026-03-11 00:22:08.137379 | Pipeline: periodic
2026-03-11 00:22:08.137398 | Executor: ze03.softwarefactory-project.io
2026-03-11 00:22:08.137417 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-03-11 00:22:08.137439 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/d1a/ansible/d1ac4c9a074547a380fd7d24655b21dd/
2026-03-11 00:22:08.137459 | Event ID: 40713765c1114cc8a875c507b350dc3b
2026-03-11 00:22:08.141251 | 
2026-03-11 00:22:08.141324 | LOOP [emit-job-header : Print node information]
2026-03-11 00:22:08.260222 | localhost | ok:
2026-03-11 00:22:08.260384 | localhost | # Node Information
2026-03-11 00:22:08.260416 | localhost | Inventory Hostname: controller
2026-03-11 00:22:08.260441 | localhost | Hostname: np0005643880
2026-03-11 00:22:08.260466 | localhost | Username: zuul
2026-03-11 00:22:08.260490 | localhost | Distro: Fedora 37
2026-03-11 00:22:08.260512 | localhost | Provider: ansible-vexxhost-ams1
2026-03-11 00:22:08.260532 | localhost | Region: ams1
2026-03-11 00:22:08.260557 | localhost | Label: ansible-fedora-37-1vcpu
2026-03-11 00:22:08.260586 | localhost | Product Name: OpenStack Nova
2026-03-11 00:22:08.260609 | localhost | Interface IP: 38.129.16.36
2026-03-11 00:22:08.269936 | 
2026-03-11 00:22:08.270062 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-11 00:22:08.662669 | localhost -> localhost | changed
2026-03-11 00:22:08.670051 | 
2026-03-11 00:22:08.670165 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-11 00:22:09.557682 | localhost -> localhost | changed
2026-03-11 00:22:09.600723 | 
2026-03-11 00:22:09.600867 | PLAY [all:!appliance*]
2026-03-11 00:22:09.619568 | 
2026-03-11 00:22:09.619730 | TASK [include_role : start-zuul-console]
2026-03-11 00:22:09.638659 | controller | ok
2026-03-11 00:22:09.654374 | 
2026-03-11 00:22:09.654493 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-03-11 00:22:10.706930 | controller | ok
2026-03-11 00:22:10.732408 | 
2026-03-11 00:22:10.732593 | TASK [use-our-mirror : Retrieve the IP address]
2026-03-11 00:22:13.592411 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-03-11 00:22:13.603827 | 
2026-03-11 00:22:13.603991 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-03-11 00:22:13.998241 | controller | skipping: Conditional result was False
2026-03-11 00:22:14.005316 | 
2026-03-11 00:22:14.005414 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-03-11 00:22:14.029847 | controller | skipping: Conditional result was False
2026-03-11 00:22:14.040808 | 
2026-03-11 00:22:14.040956 | TASK [use-our-mirror : Create the podman configuration directory]
2026-03-11 00:22:14.056297 | controller | skipping: Conditional result was False
2026-03-11 00:22:14.064120 | 
2026-03-11 00:22:14.064247 | TASK [use-our-mirror : Copy the podman configuration]
2026-03-11 00:22:14.078440 | controller | skipping: Conditional result was False
2026-03-11 00:22:14.089346 | 
2026-03-11 00:22:14.089521 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-03-11 00:22:14.104537 | controller | skipping: Conditional result was False
2026-03-11 00:22:14.114601 | 
2026-03-11 00:22:14.114768 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-03-11 00:22:14.130041 | controller | skipping: Conditional result was False
2026-03-11 00:22:14.149842 | 
2026-03-11 00:22:14.150007 | TASK [Disable Fedora Modular]
2026-03-11 00:22:15.227601 | controller | changed
2026-03-11 00:22:15.241380 | 
2026-03-11 00:22:15.241529 | TASK [Enable EPEL]
2026-03-11 00:22:15.258231 | controller | skipping: Conditional result was False
2026-03-11 00:22:15.268117 | 
2026-03-11 00:22:15.268261 | TASK [Register the RHEL node]
2026-03-11 00:22:15.701229 | 
2026-03-11 00:22:15.701455 | TASK [Show the subscription-manager status]
2026-03-11 00:22:16.093896 | controller | skipping: Conditional result was False
2026-03-11 00:22:16.104460 | 
2026-03-11 00:22:16.104592 | TASK [Enable EPEL on RHEL]
2026-03-11 00:22:16.502303 | controller | skipping: Conditional result was False
2026-03-11 00:22:16.513407 | 
2026-03-11 00:22:16.513557 | TASK [Install git and tox]
2026-03-11 00:24:21.971343 | controller | changed
2026-03-11 00:24:21.978451 | 
2026-03-11 00:24:21.978556 | TASK [include_role : prepare-workspace]
2026-03-11 00:24:22.002844 | controller | ok
2026-03-11 00:24:22.032825 | 
2026-03-11 00:24:22.032980 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-11 00:24:23.474269 | controller | ok
2026-03-11 00:24:23.486929 | 
2026-03-11 00:24:23.487075 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-11 00:24:44.337975 | controller | Output suppressed because no_log was given
2026-03-11 00:24:44.350293 | 
2026-03-11 00:24:44.350409 | TASK [include_role : prepare-workspace-openshift]
2026-03-11 00:24:44.375166 | controller | skipping: Conditional result was False
2026-03-11 00:24:44.402955 | 
2026-03-11 00:24:44.403074 | PLAY [all:!appliance]
2026-03-11 00:24:44.423496 | 
2026-03-11 00:24:44.423663 | TASK [Run add-build-sshkey role (RSA)]
2026-03-11 00:24:44.455043 | controller | ok
2026-03-11 00:24:44.472918 | 
2026-03-11 00:24:44.473032 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-11 00:24:44.742457 | controller -> localhost | ok
2026-03-11 00:24:44.766399 | 
2026-03-11 00:24:44.766605 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-11 00:24:44.802301 | controller | ok
2026-03-11 00:24:44.820085 | controller | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-11 00:24:44.827467 | 
2026-03-11 00:24:44.827532 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-11 00:24:45.394929 | controller -> localhost | Generating public/private rsa key pair.
2026-03-11 00:24:45.395159 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/d1ac4c9a074547a380fd7d24655b21dd_id_rsa.
2026-03-11 00:24:45.395215 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/d1ac4c9a074547a380fd7d24655b21dd_id_rsa.pub.
2026-03-11 00:24:45.395246 | controller -> localhost | The key fingerprint is:
2026-03-11 00:24:45.395270 | controller -> localhost | SHA256:RO6fvbNAJSINwJUZ2o5/PTHvK0uco2NGoUj0Z7/R3e4 zuul-build-sshkey
2026-03-11 00:24:45.395293 | controller -> localhost | The key's randomart image is:
2026-03-11 00:24:45.395330 | controller -> localhost | +---[RSA 2048]----+
2026-03-11 00:24:45.395352 | controller -> localhost | |   ..o++.        |
2026-03-11 00:24:45.395375 | controller -> localhost | |    ooo=         |
2026-03-11 00:24:45.395396 | controller -> localhost | |   ...o = . .    |
2026-03-11 00:24:45.395418 | controller -> localhost | |    .o.++. o     |
2026-03-11 00:24:45.395439 | controller -> localhost | |   ....+So+. . . |
2026-03-11 00:24:45.395469 | controller -> localhost | |    ... .=oB. . .|
2026-03-11 00:24:45.395497 | controller -> localhost | |      ... @oo  . |
2026-03-11 00:24:45.395521 | controller -> localhost | |       .+oo=..  .|
2026-03-11 00:24:45.395543 | controller -> localhost | |       o...o=+ .E|
2026-03-11 00:24:45.395567 | controller -> localhost | +----[SHA256]-----+
2026-03-11 00:24:45.395624 | controller -> localhost | ok: Runtime: 0:00:00.150615
2026-03-11 00:24:45.403647 | 
2026-03-11 00:24:45.403776 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-11 00:24:45.428439 | controller | ok
2026-03-11 00:24:45.442274 | controller | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-11 00:24:45.455612 | 
2026-03-11 00:24:45.455770 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-11 00:24:45.482603 | controller | skipping: Conditional result was False
2026-03-11 00:24:45.490306 | 
2026-03-11 00:24:45.490408 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-11 00:24:46.991975 | controller | changed
2026-03-11 00:24:47.005874 | 
2026-03-11 00:24:47.006030 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-11 00:24:48.085890 | controller | ok
2026-03-11 00:24:48.092454 | 
2026-03-11 00:24:48.092585 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-11 00:24:51.755053 | controller | changed
2026-03-11 00:24:51.769345 | 
2026-03-11 00:24:51.769496 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-11 00:24:55.367588 | controller | changed
2026-03-11 00:24:55.380625 | 
2026-03-11 00:24:55.380847 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-11 00:24:55.409328 | controller | skipping: Conditional result was False
2026-03-11 00:24:55.420086 | 
2026-03-11 00:24:55.420227 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-11 00:24:55.773587 | controller -> localhost | changed
2026-03-11 00:24:55.804413 | 
2026-03-11 00:24:55.804604 | TASK [add-build-sshkey : Add back temp key]
2026-03-11 00:24:56.089107 | controller -> localhost | Identity added: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/d1ac4c9a074547a380fd7d24655b21dd_id_rsa (zuul-build-sshkey)
2026-03-11 00:24:56.089420 | controller -> localhost | ok: Runtime: 0:00:00.011031
2026-03-11 00:24:56.099555 | 
2026-03-11 00:24:56.099669 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-11 00:24:57.073343 | controller | ok
2026-03-11 00:24:57.083386 | 
2026-03-11 00:24:57.083518 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-11 00:24:57.119945 | controller | skipping: Conditional result was False
2026-03-11 00:24:57.136927 | 
2026-03-11 00:24:57.137063 | TASK [Run add-build-sshkey role (ECDSA)]
2026-03-11 00:24:57.158262 | controller | ok
2026-03-11 00:24:57.176006 | 
2026-03-11 00:24:57.176130 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-11 00:24:57.394062 | controller -> localhost | ok
2026-03-11 00:24:57.406417 | 
2026-03-11 00:24:57.406581 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-11 00:24:57.446018 | controller | ok
2026-03-11 00:24:57.468494 | controller | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-11 00:24:57.477815 | 
2026-03-11 00:24:57.477911 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-11 00:24:57.779284 | controller -> localhost | Generating public/private ecdsa key pair.
2026-03-11 00:24:57.779500 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/d1ac4c9a074547a380fd7d24655b21dd_id_ecdsa.
2026-03-11 00:24:57.779530 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/d1ac4c9a074547a380fd7d24655b21dd_id_ecdsa.pub.
2026-03-11 00:24:57.779561 | controller -> localhost | The key fingerprint is:
2026-03-11 00:24:57.779581 | controller -> localhost | SHA256:f3Tr5vWayDrrTDR1TGx/cVsp9h303gIdn2AO+OXmqcY zuul-build-sshkey
2026-03-11 00:24:57.779603 | controller -> localhost | The key's randomart image is:
2026-03-11 00:24:57.779621 | controller -> localhost | +---[ECDSA 521]---+
2026-03-11 00:24:57.779639 | controller -> localhost | |          .. ++..|
2026-03-11 00:24:57.779657 | controller -> localhost | |         .  +B+*=|
2026-03-11 00:24:57.779675 | controller -> localhost | |          . *o*oX|
2026-03-11 00:24:57.779693 | controller -> localhost | |           o = +=|
2026-03-11 00:24:57.779713 | controller -> localhost | |        S o + + +|
2026-03-11 00:24:57.779768 | controller -> localhost | |         o o + o |
2026-03-11 00:24:57.779791 | controller -> localhost | |          + o . .|
2026-03-11 00:24:57.779810 | controller -> localhost | |         o.E o.o.|
2026-03-11 00:24:57.779828 | controller -> localhost | |         .*+oo=..|
2026-03-11 00:24:57.779846 | controller -> localhost | +----[SHA256]-----+
2026-03-11 00:24:57.779894 | controller -> localhost | ok: Runtime: 0:00:00.010699
2026-03-11 00:24:57.786712 | 
2026-03-11 00:24:57.786846 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-11 00:24:57.821287 | controller | ok
2026-03-11 00:24:57.833502 | controller | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-11 00:24:57.848612 | 
2026-03-11 00:24:57.848806 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-11 00:24:57.874198 | controller | skipping: Conditional result was False
2026-03-11 00:24:57.881179 | 
2026-03-11 00:24:57.881270 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-11 00:24:58.901082 | controller | changed
2026-03-11 00:24:58.907616 | 
2026-03-11 00:24:58.907687 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-11 00:24:59.736645 | controller | ok
2026-03-11 00:24:59.744050 | 
2026-03-11 00:24:59.744166 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-11 00:25:03.190763 | controller | changed
2026-03-11 00:25:03.211946 | 
2026-03-11 00:25:03.212093 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-11 00:25:06.518272 | controller | changed
2026-03-11 00:25:06.532842 | 
2026-03-11 00:25:06.533049 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-11 00:25:06.562873 | controller | skipping: Conditional result was False
2026-03-11 00:25:06.580534 | 
2026-03-11 00:25:06.580814 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-11 00:25:06.907780 | controller -> localhost | changed
2026-03-11 00:25:06.935992 | 
2026-03-11 00:25:06.936193 | TASK [add-build-sshkey : Add back temp key]
2026-03-11 00:25:07.300474 | controller -> localhost | Identity added: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/d1ac4c9a074547a380fd7d24655b21dd_id_ecdsa (zuul-build-sshkey)
2026-03-11 00:25:07.300777 | controller -> localhost | ok: Runtime: 0:00:00.015412
2026-03-11 00:25:07.309375 | 
2026-03-11 00:25:07.309525 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-11 00:25:08.123207 | controller | ok
2026-03-11 00:25:08.136576 | 
2026-03-11 00:25:08.136815 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-11 00:25:08.174458 | controller | skipping: Conditional result was False
2026-03-11 00:25:08.193454 | 
2026-03-11 00:25:08.193604 | TASK [include_role : remove-zuul-sshkey]
2026-03-11 00:25:08.220072 | controller | skipping: Conditional result was False
2026-03-11 00:25:08.231206 | 
2026-03-11 00:25:08.231357 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-11 00:25:09.023249 | controller | ok: "logs"
2026-03-11 00:25:09.023763 | controller | ok: All items complete
2026-03-11 00:25:09.023840 | 
2026-03-11 00:25:09.754809 | controller | ok: "artifacts"
2026-03-11 00:25:10.487191 | controller | ok: "docs"
2026-03-11 00:25:10.505413 | 
2026-03-11 00:25:10.505604 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-11 00:25:11.315711 | controller | changed: "logs"
2026-03-11 00:25:11.967305 | controller | changed: "artifacts"
2026-03-11 00:25:12.612800 | controller | changed: "docs"
2026-03-11 00:25:12.657162 | 
2026-03-11 00:25:12.657286 | PLAY RECAP
2026-03-11 00:25:12.657342 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-03-11 00:25:12.657378 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-11 00:25:12.657403 | 
2026-03-11 00:25:12.811629 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-11 00:25:12.812467 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-11 00:25:13.467888 | 
2026-03-11 00:25:13.468002 | PLAY [all]
2026-03-11 00:25:13.491582 | 
2026-03-11 00:25:13.491716 | TASK [Install binary dependencies]
2026-03-11 00:25:13.563165 | controller | ok
2026-03-11 00:25:13.582910 | 
2026-03-11 00:25:13.583038 | TASK [bindep : Include find tasks]
2026-03-11 00:25:13.613756 | controller | ok
2026-03-11 00:25:13.621422 | controller | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-03-11 00:25:13.627628 | 
2026-03-11 00:25:13.627690 | TASK [bindep : Look for bindep.txt]
2026-03-11 00:25:14.575037 | controller | ok
2026-03-11 00:25:14.581168 | 
2026-03-11 00:25:14.581267 | TASK [bindep : Define bindep_file fact]
2026-03-11 00:25:14.605497 | controller | skipping: Conditional result was False
2026-03-11 00:25:14.619430 | 
2026-03-11 00:25:14.619631 | TASK [bindep : Look for other-requirements.txt]
2026-03-11 00:25:15.266634 | controller | ok
2026-03-11 00:25:15.273308 | 
2026-03-11 00:25:15.273421 | TASK [bindep : Define bindep_file fact]
2026-03-11 00:25:15.297696 | controller | skipping: Conditional result was False
2026-03-11 00:25:15.304112 | 
2026-03-11 00:25:15.304216 | TASK [bindep : Look for bindep fallback file]
2026-03-11 00:25:15.329117 | controller | skipping: Conditional result was False
2026-03-11 00:25:15.336007 | 
2026-03-11 00:25:15.336148 | TASK [bindep : Define bindep_file fact]
2026-03-11 00:25:15.360910 | controller | skipping: Conditional result was False
2026-03-11 00:25:15.367127 | 
2026-03-11 00:25:15.367231 | TASK [bindep : Include bindep tasks]
2026-03-11 00:25:15.391425 | controller | skipping: Conditional result was False
2026-03-11 00:25:15.399079 | 
2026-03-11 00:25:15.399225 | TASK [bindep : Include install tasks]
2026-03-11 00:25:15.423129 | controller | skipping: Conditional result was False
2026-03-11 00:25:15.432198 | 
2026-03-11 00:25:15.432357 | LOOP [bindep : Include package tasks]
2026-03-11 00:25:15.513344 | 
2026-03-11 00:25:15.513566 | TASK [Run test-setup role]
2026-03-11 00:25:15.538688 | controller | ok
2026-03-11 00:25:15.562483 | 
2026-03-11 00:25:15.562629 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-03-11 00:25:16.294154 | controller | ok
2026-03-11 00:25:16.302958 | 
2026-03-11 00:25:16.303096 | TASK [test-setup : Run tools/test-setup.sh]
2026-03-11 00:25:16.683432 | controller | skipping: Conditional result was False
2026-03-11 00:25:16.723825 | 
2026-03-11 00:25:16.723997 | PLAY RECAP
2026-03-11 00:25:16.724058 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-11 00:25:16.724088 | 
2026-03-11 00:25:16.867531 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-11 00:25:16.869273 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-11 00:25:17.484862 | 
2026-03-11 00:25:17.485007 | PLAY [controller]
2026-03-11 00:25:17.506246 | 
2026-03-11 00:25:17.506381 | TASK [Create the /root directory]
2026-03-11 00:25:18.638984 | controller | ok
2026-03-11 00:25:18.647226 | 
2026-03-11 00:25:18.647385 | TASK [Install glibc-langpack-en]
2026-03-11 00:25:27.000540 | controller | ok: Nothing to do
2026-03-11 00:25:27.016119 | 
2026-03-11 00:25:27.016335 | TASK [Ensure controller directory exists]
2026-03-11 00:25:27.849866 | controller | changed
2026-03-11 00:25:27.856016 | 
2026-03-11 00:25:27.856131 | TASK [Install container runtime]
2026-03-11 00:25:27.917362 | controller | ok
2026-03-11 00:25:27.962495 | 
2026-03-11 00:25:27.962644 | LOOP [ensure-docker : Gather variables for each operating system]
2026-03-11 00:25:28.016565 | controller | ok: "/var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml"
2026-03-11 00:25:28.035037 | 
2026-03-11 00:25:28.035699 | TASK [ensure-docker : Sanity check for distro selection]
2026-03-11 00:25:28.060549 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.069219 | 
2026-03-11 00:25:28.069392 | TASK [ensure-docker : Sanity check for distro install]
2026-03-11 00:25:28.101966 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.111371 | 
2026-03-11 00:25:28.111545 | TASK [ensure-docker : Sanity check for upstream install]
2026-03-11 00:25:28.137058 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.146977 | 
2026-03-11 00:25:28.147133 | TASK [ensure-docker : Sanity check for upstream install mirrors]
2026-03-11 00:25:28.173310 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.180584 | 
2026-03-11 00:25:28.180717 | TASK [ensure-docker : Include tasks for docker install]
2026-03-11 00:25:28.210657 | controller | ok
2026-03-11 00:25:28.220588 | controller | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml
2026-03-11 00:25:28.232385 | 
2026-03-11 00:25:28.232543 | TASK [ensure-docker : Not Implemented]
2026-03-11 00:25:28.246648 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.256315 | 
2026-03-11 00:25:28.256449 | TASK [Set up docker mirrors]
2026-03-11 00:25:28.278900 | controller | ok
2026-03-11 00:25:28.307146 | 
2026-03-11 00:25:28.307291 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info]
2026-03-11 00:25:28.342719 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.353545 | 
2026-03-11 00:25:28.353696 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info]
2026-03-11 00:25:28.429891 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.477951 | 
2026-03-11 00:25:28.478088 | TASK [use-docker-mirror : Set docker_mirror fact]
2026-03-11 00:25:28.523545 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.532360 | 
2026-03-11 00:25:28.532465 | TASK [use-docker-mirror : Set up docker mirrors]
2026-03-11 00:25:28.557571 | controller | skipping: Conditional result was False
2026-03-11 00:25:28.571160 | 
2026-03-11 00:25:28.571280 | TASK [Add all repositories]
2026-03-11 00:25:28.592841 | controller | ok
2026-03-11 00:25:28.627950 | 
2026-03-11 00:25:28.628092 | LOOP [ensure-package-repositories : Install repositories]
2026-03-11 00:25:28.664456 | controller | ok: "/var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml"
2026-03-11 00:25:28.664810 | controller | ok: All items complete
2026-03-11 00:25:28.664850 | 
2026-03-11 00:25:28.686888 | controller | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml
2026-03-11 00:25:28.695942 | 
2026-03-11 00:25:28.696043 | TASK [ensure-package-repositories : Create GPG key temp directory]
2026-03-11 00:25:29.813528 | controller | changed
2026-03-11 00:25:29.823651 | 
2026-03-11 00:25:29.823885 | LOOP [ensure-package-repositories : Upload GPG keys]
2026-03-11 00:25:33.077472 | controller | changed:
2026-03-11 00:25:33.077672 | controller | {
2026-03-11 00:25:33.077708 | 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-03-11 00:25:33.078164 | controller | }
2026-03-11 00:25:33.098641 | 
2026-03-11 00:25:33.098819 | LOOP [ensure-package-repositories : Import GPG keys]
2026-03-11 00:25:34.365286 | controller | changed:
2026-03-11 00:25:34.365502 | controller | {
2026-03-11 00:25:34.365546 | 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-03-11 00:25:34.365580 | controller | }
2026-03-11 00:25:34.365621 | controller | changed: All items complete
2026-03-11 00:25:34.365650 | 
2026-03-11 00:25:34.382067 | 
2026-03-11 00:25:34.382249 | TASK [ensure-package-repositories : Remove GPG temp directory]
2026-03-11 00:25:35.096995 | controller | changed
2026-03-11 00:25:35.113601 | 
2026-03-11 00:25:35.113829 | LOOP [ensure-package-repositories : Add repositories]
2026-03-11 00:25:36.095510 | controller | changed:
2026-03-11 00:25:36.095679 | controller | {
2026-03-11 00:25:36.095740 | controller |   "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable",
2026-03-11 00:25:36.095776 | controller |   "description": "Docker CE Stable - $basearch",
2026-03-11 00:25:36.095800 | controller |   "gpgcheck": true,
2026-03-11 00:25:36.095817 | controller |   "name": "docker-ce-stable"
2026-03-11 00:25:36.095832 | controller | }
2026-03-11 00:25:36.115574 | 
2026-03-11 00:25:36.115707 | TASK [ensure-docker : Install pre-reqs]
2026-03-11 00:25:40.928380 | controller | ok: Nothing to do
2026-03-11 00:25:40.934556 | 
2026-03-11 00:25:40.934657 | TASK [ensure-docker : Remove packages]
2026-03-11 00:25:43.911523 | controller | ok: Nothing to do
2026-03-11 00:25:43.926293 | 
2026-03-11 00:25:43.926824 | TASK [ensure-docker : Install upstream docker using package]
2026-03-11 00:27:04.824242 | controller | changed
2026-03-11 00:27:04.832397 | 
2026-03-11 00:27:04.832487 | TASK [ensure-docker : Setup docker]
2026-03-11 00:27:04.853660 | controller | ok
2026-03-11 00:27:04.866702 | controller | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml
2026-03-11 00:27:04.913229 | 
2026-03-11 00:27:04.913358 | TASK [ensure-docker : Ensure "docker" group exists]
2026-03-11 00:27:05.895132 | controller | ok
2026-03-11 00:27:05.900990 | 
2026-03-11 00:27:05.901076 | TASK [ensure-docker : Add user to docker group]
2026-03-11 00:27:06.861283 | controller | changed
2026-03-11 00:27:06.877043 | 
2026-03-11 00:27:06.877289 | TASK [Update docker daemon proxy configuration]
2026-03-11 00:27:06.915825 | controller | skipping: Conditional result was False
2026-03-11 00:27:06.933192 | 
2026-03-11 00:27:06.933382 | TASK [Lower default MTU]
2026-03-11 00:27:06.961219 | controller | skipping: Conditional result was False
2026-03-11 00:27:06.979367 | 
2026-03-11 00:27:06.979554 | TASK [ensure-docker : Get the status of the docket.socket unit]
2026-03-11 00:27:07.829553 | controller | inactive
2026-03-11 00:27:08.372368 | controller | ok: Runtime: 0:00:00.016827
2026-03-11 00:27:08.388782 | 
2026-03-11 00:27:08.389003 | TASK [ensure-docker : Get the status of the docket unit]
2026-03-11 00:27:09.244099 | controller | inactive
2026-03-11 00:27:09.790057 | controller | ok: Runtime: 0:00:00.023249
2026-03-11 00:27:09.797281 | 
2026-03-11 00:27:09.797393 | TASK [ensure-docker : Restart docker]
2026-03-11 00:27:09.849346 | Trigger a Docker restart
2026-03-11 00:27:09.855692 | 
2026-03-11 00:27:09.855830 | TASK [ensure-docker : Reset ssh connection to pick up docker group]
2026-03-11 00:27:09.893759 | 
2026-03-11 00:27:09.893898 | TASK [ensure-docker : Install docker-compose]
2026-03-11 00:27:09.920156 | controller | skipping: Conditional result was False
2026-03-11 00:27:09.929118 | 
2026-03-11 00:27:09.929239 | TASK [ensure-docker : Flush handlers before role exit]
2026-03-11 00:27:09.945400 | 
2026-03-11 00:27:09.945545 | TASK [ensure-docker : Stop docker.socket to avoid any conflict]
2026-03-11 00:27:13.265588 | controller | changed
2026-03-11 00:27:13.285442 | 
2026-03-11 00:27:13.285644 | TASK [ensure-docker : Assure docker service is running]
2026-03-11 00:27:17.097531 | controller | changed
2026-03-11 00:27:17.115521 | 
2026-03-11 00:27:17.115717 | TASK [ensure-docker : Assure docker.socket service is running]
2026-03-11 00:27:18.815464 | controller | ok
2026-03-11 00:27:18.823253 | 
2026-03-11 00:27:18.823342 | TASK [ensure-docker : Correct group ownership on docker sock]
2026-03-11 00:27:19.659329 | controller | ok
2026-03-11 00:27:19.672359 | 
2026-03-11 00:27:19.672493 | TASK [ensure-docker : Validate ability to talk with docker]
2026-03-11 00:27:20.307912 | controller | CONTAINER ID   IMAGE     COMMAND   CREATED   STATUS    PORTS     NAMES
2026-03-11 00:27:20.557435 | controller | ok: Runtime: 0:00:00.036027
2026-03-11 00:27:20.574357 | 
2026-03-11 00:27:20.574577 | TASK [ensure-docker : Get version details]
2026-03-11 00:27:21.391033 | controller | Client: Docker Engine - Community
2026-03-11 00:27:21.391346 | controller |  Version:           24.0.7
2026-03-11 00:27:21.391410 | controller |  API version:       1.43
2026-03-11 00:27:21.391478 | controller |  Go version:        go1.20.10
2026-03-11 00:27:21.391560 | controller |  Git commit:        afdd53b
2026-03-11 00:27:21.391627 | controller |  Built:             Thu Oct 26 09:09:39 2023
2026-03-11 00:27:21.391690 | controller |  OS/Arch:           linux/amd64
2026-03-11 00:27:21.391766 | controller |  Context:           default
2026-03-11 00:27:21.391791 | controller |
2026-03-11 00:27:21.391863 | controller | Server: Docker Engine - Community
2026-03-11 00:27:21.391937 | controller |  Engine:
2026-03-11 00:27:21.392131 | controller |   Version:          24.0.7
2026-03-11 00:27:21.392196 | controller |   API version:      1.43 (minimum version 1.12)
2026-03-11 00:27:21.392286 | controller |   Go version:       go1.20.10
2026-03-11 00:27:21.392366 | controller |   Git commit:       311b9ff
2026-03-11 00:27:21.392434 | controller |   Built:            Thu Oct 26 09:08:11 2023
2026-03-11 00:27:21.392495 | controller |   OS/Arch:          linux/amd64
2026-03-11 00:27:21.392567 | controller |   Experimental:     false
2026-03-11 00:27:21.392598 | controller |  containerd:
2026-03-11 00:27:21.392754 | controller |   Version:          1.6.25
2026-03-11 00:27:21.392823 | controller |   GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f
2026-03-11 00:27:21.392853 | controller |  runc:
2026-03-11 00:27:21.392971 | controller |   Version:          1.1.10
2026-03-11 00:27:21.393026 | controller |   GitCommit:        v1.1.10-0-g18a0cb0
2026-03-11 00:27:21.393069 | controller |  docker-init:
2026-03-11 00:27:21.393166 | controller |   Version:          0.19.0
2026-03-11 00:27:21.393218 | controller |   GitCommit:        de40ad0
2026-03-11 00:27:22.011777 | controller | ok: Runtime: 0:00:00.044696
2026-03-11 00:27:22.018623 | 
2026-03-11 00:27:22.018717 | TASK [ensure-docker : Dump installed docker details]
2026-03-11 00:27:22.050908 | {'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-03-11 00:27:21.350713', 'end': '2026-03-11 00:27:21.395409', 'delta': '0:00:00.044696', 'msg': '', 'zuul_log_id': 'fa163ef9-e89a-31fc-90f2-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-03-11 00:27:22.060346 | 
2026-03-11 00:27:22.060476 | TASK [Use buildset registry]
2026-03-11 00:27:22.076270 | controller | skipping: Conditional result was False
2026-03-11 00:27:22.089639 | 
2026-03-11 00:27:22.089767 | TASK [Ensure python3.8 is present]
2026-03-11 00:27:22.113900 | controller | skipping: Conditional result was False
2026-03-11 00:27:22.120368 | 
2026-03-11 00:27:22.120451 | TASK [Run our-ensure-python role (Fedora only for now)]
2026-03-11 00:27:22.140172 | controller | ok
2026-03-11 00:27:22.161160 | 
2026-03-11 00:27:22.161271 | TASK [our-ensure-python : Install the right Python version (rpm)]
2026-03-11 00:27:29.349902 | controller | ok: Nothing to do
2026-03-11 00:27:29.360025 | 
2026-03-11 00:27:29.360179 | TASK [our-ensure-python : Also install python3-devel]
2026-03-11 00:27:44.397778 | controller | changed
2026-03-11 00:27:44.416926 | 
2026-03-11 00:27:44.417073 | TASK [Run ensure-virtualenv role]
2026-03-11 00:27:44.438871 | controller | ok
2026-03-11 00:27:44.460437 | 
2026-03-11 00:27:44.460570 | TASK [ensure-virtualenv : Check if virtualenv is installed]
2026-03-11 00:27:45.220941 | controller | /usr/bin/virtualenv
2026-03-11 00:27:45.838815 | controller | ok: Runtime: 0:00:00.004344
2026-03-11 00:27:45.847983 | 
2026-03-11 00:27:45.848130 | LOOP [ensure-virtualenv : Install virtualenv package]
2026-03-11 00:27:45.872807 | controller | skipping: Conditional result was False
2026-03-11 00:27:45.873109 | controller | changed: All items complete
2026-03-11 00:27:45.873146 | 
2026-03-11 00:27:45.891539 | 
2026-03-11 00:27:45.891672 | TASK [Find the full path of the Python interpreter]
2026-03-11 00:27:46.660270 | controller | /usr/bin/python3.8
2026-03-11 00:27:47.262491 | controller | ok
2026-03-11 00:27:47.271746 | 
2026-03-11 00:27:47.271875 | TASK [Create virtualenv for ansible-test with a specific interpreter]
2026-03-11 00:27:49.944415 | controller | created virtual environment CPython3.8.18.final.0-64 in 1281ms
2026-03-11 00:27:50.062972 | controller |   creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False)
2026-03-11 00:27:50.063129 | controller |   seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv)
2026-03-11 00:27:50.063146 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2026-03-11 00:27:50.063165 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2026-03-11 00:27:50.662270 | controller | changed
2026-03-11 00:27:50.668676 | 
2026-03-11 00:27:50.668806 | TASK [Set selinux package]
2026-03-11 00:27:50.699112 | controller | ok
2026-03-11 00:27:50.704909 | 
2026-03-11 00:27:50.705032 | TASK [Set selinux package (Fedora)]
2026-03-11 00:27:50.738164 | controller | ok
2026-03-11 00:27:50.746464 | 
2026-03-11 00:27:50.746592 | TASK [Install selinux into virtualenv]
2026-03-11 00:27:56.945538 | controller | Collecting selinux-please-lie-to-me
2026-03-11 00:27:57.071294 | controller |   Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB)
2026-03-11 00:27:57.773218 | controller | Collecting setuptools<50.0.0
2026-03-11 00:27:57.882631 | controller |   Downloading setuptools-49.6.0-py3-none-any.whl (803 kB)
2026-03-11 00:27:57.981215 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 10.5 MB/s eta 0:00:00
2026-03-11 00:27:58.126453 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me
2026-03-11 00:27:58.126806 | controller |   Attempting uninstall: setuptools
2026-03-11 00:27:58.128007 | controller |     Found existing installation: setuptools 62.6.0
2026-03-11 00:27:58.258466 | controller |     Uninstalling setuptools-62.6.0:
2026-03-11 00:27:58.273327 | controller |       Successfully uninstalled setuptools-62.6.0
2026-03-11 00:27:58.993169 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0
2026-03-11 00:27:59.211930 | controller |
2026-03-11 00:27:59.478270 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2026-03-11 00:27:59.478326 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2026-03-11 00:27:59.641927 | controller | ok: Runtime: 0:00:07.670436
2026-03-11 00:27:59.658875 | 
2026-03-11 00:27:59.659100 | TASK [Install pytest-forked into virtualenv]
2026-03-11 00:28:01.468455 | controller | Collecting pytest-forked
2026-03-11 00:28:01.532031 | controller |   Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB)
2026-03-11 00:28:01.735891 | controller | Collecting pytest>=3.10
2026-03-11 00:28:01.745510 | controller |   Downloading pytest-8.3.5-py3-none-any.whl (343 kB)
2026-03-11 00:28:01.798610 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 343.6/343.6 kB 7.2 MB/s eta 0:00:00
2026-03-11 00:28:01.867763 | controller | Collecting py
2026-03-11 00:28:01.874613 | controller |   Downloading py-1.11.0-py2.py3-none-any.whl (98 kB)
2026-03-11 00:28:01.891322 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 9.6 MB/s eta 0:00:00
2026-03-11 00:28:01.959240 | controller | Collecting iniconfig
2026-03-11 00:28:01.969167 | controller |   Downloading iniconfig-2.1.0-py3-none-any.whl (6.0 kB)
2026-03-11 00:28:02.038296 | controller | Collecting pluggy<2,>=1.5
2026-03-11 00:28:02.045047 | controller |   Downloading pluggy-1.5.0-py3-none-any.whl (20 kB)
2026-03-11 00:28:02.148720 | controller | Collecting tomli>=1
2026-03-11 00:28:02.155216 | controller |   Downloading tomli-2.4.0-py3-none-any.whl (14 kB)
2026-03-11 00:28:02.235381 | controller | Collecting packaging
2026-03-11 00:28:02.241620 | controller |   Downloading packaging-26.0-py3-none-any.whl (74 kB)
2026-03-11 00:28:02.260258 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 5.8 MB/s eta 0:00:00
2026-03-11 00:28:02.315717 | controller | Collecting exceptiongroup>=1.0.0rc8
2026-03-11 00:28:02.322252 | controller |   Downloading exceptiongroup-1.3.1-py3-none-any.whl (16 kB)
2026-03-11 00:28:02.431313 | controller | Collecting typing-extensions>=4.6.0
2026-03-11 00:28:02.438873 | controller |   Downloading typing_extensions-4.13.2-py3-none-any.whl (45 kB)
2026-03-11 00:28:02.450215 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.8/45.8 kB 4.8 MB/s eta 0:00:00
2026-03-11 00:28:02.562063 | controller | Installing collected packages: typing-extensions, tomli, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked
2026-03-11 00:28:03.492267 | 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-03-11 00:28:03.498085 | controller |
2026-03-11 00:28:03.723670 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2026-03-11 00:28:03.723721 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2026-03-11 00:28:04.066466 | controller | ok: Runtime: 0:00:03.004271
2026-03-11 00:28:04.073357 | 
2026-03-11 00:28:04.073461 | TASK [Update pip]
2026-03-11 00:28:06.355938 | controller | Requirement already satisfied: pip in ./venv/lib/python3.8/site-packages (22.2.2)
2026-03-11 00:28:06.782802 | controller | Collecting pip
2026-03-11 00:28:06.902404 | controller |   Downloading pip-25.0.1-py3-none-any.whl (1.8 MB)
2026-03-11 00:28:07.042588 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 14.1 MB/s eta 0:00:00
2026-03-11 00:28:07.176553 | controller | Installing collected packages: pip
2026-03-11 00:28:07.176907 | controller |   Attempting uninstall: pip
2026-03-11 00:28:07.180177 | controller |     Found existing installation: pip 22.2.2
2026-03-11 00:28:07.713216 | controller |     Uninstalling pip-22.2.2:
2026-03-11 00:28:07.745685 | controller |       Successfully uninstalled pip-22.2.2
2026-03-11 00:28:10.351799 | controller | Successfully installed pip-25.0.1
2026-03-11 00:28:10.952317 | controller | ok: Runtime: 0:00:05.306676
2026-03-11 00:28:10.959084 | 
2026-03-11 00:28:10.959198 | TASK [Ensure pip temp directory exists in /var/tmp]
2026-03-11 00:28:12.183820 | controller | changed
2026-03-11 00:28:12.194941 | 
2026-03-11 00:28:12.195086 | TASK [Install ansible into virtualenv]
2026-03-11 00:28:14.099675 | controller | Processing ./src/github.com/ansible/ansible
2026-03-11 00:28:14.108565 | controller |   Preparing metadata (setup.py): started
2026-03-11 00:28:16.010802 | controller |   Preparing metadata (setup.py): finished with status 'done'
2026-03-11 00:28:16.086392 | controller | Collecting jinja2 (from ansible==2.9.27.post0)
2026-03-11 00:28:16.101993 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB)
2026-03-11 00:28:16.198502 | controller | Collecting PyYAML (from ansible==2.9.27.post0)
2026-03-11 00:28:16.207247 | 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-03-11 00:28:16.704430 | controller | Collecting cryptography (from ansible==2.9.27.post0)
2026-03-11 00:28:16.709541 | controller |   Downloading cryptography-46.0.5-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB)
2026-03-11 00:28:16.991006 | controller | Collecting cffi>=1.14 (from cryptography->ansible==2.9.27.post0)
2026-03-11 00:28:16.997901 | controller |   Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB)
2026-03-11 00:28:17.011381 | 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-03-11 00:28:17.145379 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible==2.9.27.post0)
2026-03-11 00:28:17.151173 | controller |   Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (3.0 kB)
2026-03-11 00:28:17.189546 | controller | Collecting pycparser (from cffi>=1.14->cryptography->ansible==2.9.27.post0)
2026-03-11 00:28:17.194660 | controller |   Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes)
2026-03-11 00:28:17.222990 | controller | Downloading cryptography-46.0.5-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2026-03-11 00:28:17.275455 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 97.4 MB/s eta 0:00:00
2026-03-11 00:28:17.282935 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2026-03-11 00:28:17.298808 | 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-03-11 00:28:17.324599 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.0/806.0 kB 29.8 MB/s eta 0:00:00
2026-03-11 00:28:17.330804 | controller | Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB)
2026-03-11 00:28:17.349329 | controller | Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (26 kB)
2026-03-11 00:28:17.363346 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB)
2026-03-11 00:28:17.394559 | controller | Building wheels for collected packages: ansible
2026-03-11 00:28:17.395556 | controller |   Building wheel for ansible (setup.py): started
2026-03-11 00:28:28.044928 | controller |   Building wheel for ansible (setup.py): finished with status 'done'
2026-03-11 00:28:28.064544 | controller |   Created wheel for ansible: filename=ansible-2.9.27.post0-py3-none-any.whl size=16207514 sha256=04186a9059d65ea5312cc46ec3859c52a869b9f9bc154e6e96c4603b2923a7d5
2026-03-11 00:28:28.064837 | controller |   Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-h7cirkli/wheels/a5/4b/fa/b6deaae105422b0b3b92831e0369d44bf7fca5bb3413d79be7
2026-03-11 00:28:28.155900 | controller | Successfully built ansible
2026-03-11 00:28:28.365469 | controller | Installing collected packages: PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible
2026-03-11 00:28:43.155477 | 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-03-11 00:28:43.603582 | controller | ok: Runtime: 0:00:30.238594
2026-03-11 00:28:43.624138 | 
2026-03-11 00:28:43.624294 | TASK [Setup download-artifact-fork role]
2026-03-11 00:28:43.652791 | controller | ok
2026-03-11 00:28:43.672235 | 
2026-03-11 00:28:43.672354 | TASK [download-artifact-fork : Parse inventory response]
2026-03-11 00:28:43.791371 | controller | ok
2026-03-11 00:28:43.798150 | 
2026-03-11 00:28:43.798274 | TASK [download-artifact-fork : Fetch info from Zuul API]
2026-03-11 00:28:43.823027 | controller | skipping: Conditional result was False
2026-03-11 00:28:43.830467 | 
2026-03-11 00:28:43.830597 | TASK [download-artifact-fork : Parse build response]
2026-03-11 00:28:43.861270 | controller | skipping: Conditional result was False
2026-03-11 00:28:43.867908 | 
2026-03-11 00:28:43.868031 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2026-03-11 00:28:44.688550 | controller | changed
2026-03-11 00:28:44.698392 | 
2026-03-11 00:28:44.698525 | LOOP [download-artifact-fork : Download archive by type]
2026-03-11 00:28:44.720170 | controller | skipping: Conditional result was False
2026-03-11 00:28:44.720429 | 
2026-03-11 00:28:46.712855 | controller | changed: OK (20189 bytes)
2026-03-11 00:28:46.750634 | 
2026-03-11 00:28:46.750828 | TASK [deploy-artifacts : define __collections]
2026-03-11 00:28:46.788889 | controller | ok
2026-03-11 00:28:46.796471 | 
2026-03-11 00:28:46.796578 | LOOP [deploy-artifacts : Create list of collections]
2026-03-11 00:28:46.830626 | controller | skipping: Conditional result was False
2026-03-11 00:28:46.838623 | controller | ok:
2026-03-11 00:28:46.838745 | controller | {
2026-03-11 00:28:46.838774 | controller |   "branch": "main",
2026-03-11 00:28:46.838792 | controller |   "job": "build-ansible-collection",
2026-03-11 00:28:46.838808 | controller |   "metadata": {
2026-03-11 00:28:46.838823 | controller |     "type": "ansible_collection",
2026-03-11 00:28:46.838838 | controller |     "version": "5.0.0"
2026-03-11 00:28:46.838853 | controller |   },
2026-03-11 00:28:46.838868 | controller |   "name": "ansible.network",
2026-03-11 00:28:46.838882 | controller |   "project": "ansible-collections/ansible.network",
2026-03-11 00:28:46.838897 | controller |   "url": "https://37f1f611bbcccb1ca6d6-e153684ff55fae4c7d964a09e1b76db7.ssl.cf2.rackcdn.com/ansible/e7ecb319ab9b4d389d8158db765ef5b6/artifacts/ansible-network-5.0.0.tar.gz"
2026-03-11 00:28:46.838919 | controller | }
2026-03-11 00:28:46.849416 | 
2026-03-11 00:28:46.849549 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2026-03-11 00:28:47.897034 | controller | Process install dependency map
2026-03-11 00:29:33.185055 | controller | |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|Starting collection install process
2026-03-11 00:29:33.286203 | controller | |Installing 'ansible.network:5.0.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/network'
2026-03-11 00:29:33.386673 | controller | Installing 'ansible.netcommon:8.4.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-03-11 00:29:34.894297 | controller | /-\|/-\|/-\|/-\|Installing 'ansible.utils:6.0.1' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-03-11 00:29:36.704298 | controller | /-\|/-\|/-\|/-\|/-Installing 'arista.eos:12.0.1' to '/home/zuul/.ansible/collections/ansible_collections/arista/eos'
2026-03-11 00:29:39.216175 | controller | \|/-\|/-\|/-\|/-\|/-\|/-\Installing 'cisco.ios:11.3.0' to '/home/zuul/.ansible/collections/ansible_collections/cisco/ios'
2026-03-11 00:29:42.230175 | controller | |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/Installing 'cisco.iosxr:12.1.1' to '/home/zuul/.ansible/collections/ansible_collections/cisco/iosxr'
2026-03-11 00:29:44.986954 | controller | -\|/-\|/-\|/-\|/-\|/-\|/-\|Installing 'cisco.nxos:11.1.3' to '/home/zuul/.ansible/collections/ansible_collections/cisco/nxos'
2026-03-11 00:29:49.377464 | controller | /-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\Installing 'junipernetworks.junos:11.1.1' to '/home/zuul/.ansible/collections/ansible_collections/junipernetworks/junos'
2026-03-11 00:29:51.522480 | controller | |/-\|/-\|/-\|/-\|/-\|Installing 'juniper.device:2.0.1' to '/home/zuul/.ansible/collections/ansible_collections/juniper/device'
2026-03-11 00:29:53.771332 | controller | ok: Runtime: 0:01:06.127545
2026-03-11 00:29:53.782623 | 
2026-03-11 00:29:53.782709 | TASK [podman may need iptables kernel modules]
2026-03-11 00:29:55.153469 | controller | ok: Runtime: 0:00:00.006009
2026-03-11 00:29:55.207112 | 
2026-03-11 00:29:55.207237 | PLAY RECAP
2026-03-11 00:29:55.207307 | controller | ok: 46 changed: 26 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0
2026-03-11 00:29:55.207344 | 
2026-03-11 00:29:55.342200 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-11 00:29:55.343110 | RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2026-03-11 00:29:56.039710 | 
2026-03-11 00:29:56.039841 | PLAY [controller]
2026-03-11 00:29:56.062230 | 
2026-03-11 00:29:56.062342 | TASK [Copy the galaxy.yml on the controller]
2026-03-11 00:29:59.879665 | controller | changed
2026-03-11 00:29:59.894153 | 
2026-03-11 00:29:59.894297 | TASK [Load information from galaxy.yml]
2026-03-11 00:29:59.927296 | controller | ok
2026-03-11 00:29:59.935419 | 
2026-03-11 00:29:59.935506 | LOOP [Enable FIPS mode]
2026-03-11 00:29:59.959654 | 
2026-03-11 00:29:59.959843 | LOOP [ansible-test : Include branch specific variables.]
2026-03-11 00:29:59.996492 | controller | ok: "/var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/untrusted/project_2/github.com/ansible/ansible-zuul-jobs/roles/ansible-test/vars/default.yaml"
2026-03-11 00:29:59.996848 | 
2026-03-11 00:30:00.015745 | 
2026-03-11 00:30:00.015874 | TASK [ansible-test : Setup --skip-tags for test_options]
2026-03-11 00:30:00.058110 | controller | ok
2026-03-11 00:30:00.065541 | 
2026-03-11 00:30:00.065740 | TASK [ansible-test : Enable --inventory for network-integration]
2026-03-11 00:30:00.090422 | controller | skipping: Conditional result was False
2026-03-11 00:30:00.099822 | 
2026-03-11 00:30:00.099925 | TASK [ansible-test : Enable --retry-on-error]
2026-03-11 00:30:00.114558 | controller | skipping: Conditional result was False
2026-03-11 00:30:00.123322 | 
2026-03-11 00:30:00.123440 | TASK [ansible-test : Enable --continue-on-error]
2026-03-11 00:30:00.155163 | controller | ok
2026-03-11 00:30:00.162878 | 
2026-03-11 00:30:00.162967 | TASK [ansible-test : Enable --requirements]
2026-03-11 00:30:00.177583 | controller | skipping: Conditional result was False
2026-03-11 00:30:00.186765 | 
2026-03-11 00:30:00.186874 | TASK [ansible-test : Adjust options for unit tests]
2026-03-11 00:30:00.202195 | controller | skipping: Conditional result was False
2026-03-11 00:30:00.212678 | 
2026-03-11 00:30:00.212818 | TASK [ansible-test : Install requirements with unit tests]
2026-03-11 00:30:00.277187 | controller | ok
2026-03-11 00:30:00.284456 | 
2026-03-11 00:30:00.284538 | TASK [ansible-test : Set --skip-test]
2026-03-11 00:30:00.328956 | controller | skipping: Conditional result was False
2026-03-11 00:30:00.335932 | 
2026-03-11 00:30:00.336025 | TASK [ansible-test : Reduce verbosity]
2026-03-11 00:30:00.368562 | controller | ok
2026-03-11 00:30:00.375549 | 
2026-03-11 00:30:00.375682 | TASK [ansible-test : Setup --python option]
2026-03-11 00:30:00.400999 | controller | skipping: Conditional result was False
2026-03-11 00:30:00.407793 | 
2026-03-11 00:30:00.407906 | TASK [ansible-test : Setup --docker option]
2026-03-11 00:30:00.460928 | controller | ok
2026-03-11 00:30:00.468386 | 
2026-03-11 00:30:00.468517 | TASK [ansible-test : check if MANIFEST.json exists]
2026-03-11 00:30:01.486237 | controller | ok
2026-03-11 00:30:01.501515 | 
2026-03-11 00:30:01.501718 | TASK [ansible-test : Copy the MANIFEST.json on the controller]
2026-03-11 00:30:01.519495 | controller | skipping: Conditional result was False
2026-03-11 00:30:01.529644 | 
2026-03-11 00:30:01.529805 | TASK [ansible-test : Load information from MANIFEST.json]
2026-03-11 00:30:01.556774 | controller | skipping: Conditional result was False
2026-03-11 00:30:01.567016 | 
2026-03-11 00:30:01.567167 | TASK [ansible-test : Setup location of project for integration tests]
2026-03-11 00:30:01.592465 | controller | skipping: Conditional result was False
2026-03-11 00:30:01.605266 | 
2026-03-11 00:30:01.605660 | TASK [ansible-test : Copy the galaxy.yml on the controller]
2026-03-11 00:30:02.970263 | controller | ok
2026-03-11 00:30:02.977046 | 
2026-03-11 00:30:02.977161 | TASK [ansible-test : Load information from galaxy.yml]
2026-03-11 00:30:03.018384 | controller | ok
2026-03-11 00:30:03.027125 | 
2026-03-11 00:30:03.027252 | TASK [ansible-test : Setup location of project for integration tests]
2026-03-11 00:30:03.068034 | controller | ok
2026-03-11 00:30:03.074901 | 
2026-03-11 00:30:03.074996 | TASK [ansible-test : Setup minimum test requirements]
2026-03-11 00:30:03.105492 | controller | ok
2026-03-11 00:30:03.112001 | 
2026-03-11 00:30:03.112120 | TASK [ansible-test : Ensure pip temp directory exists in /var/tmp]
2026-03-11 00:30:04.131859 | controller | ok
2026-03-11 00:30:04.151165 | 
2026-03-11 00:30:04.151360 | TASK [ansible-test : Install python requirements]
2026-03-11 00:30:05.668141 | controller | Collecting yamllint (from -r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2026-03-11 00:30:05.683025 | controller |   Downloading yamllint-1.35.1-py3-none-any.whl.metadata (4.2 kB)
2026-03-11 00:30:05.725553 | controller | Collecting pathspec>=0.5.3 (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2026-03-11 00:30:05.730446 | controller |   Downloading pathspec-0.12.1-py3-none-any.whl.metadata (21 kB)
2026-03-11 00:30:05.742055 | 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-03-11 00:30:05.748655 | controller | Downloading yamllint-1.35.1-py3-none-any.whl (66 kB)
2026-03-11 00:30:05.766182 | controller | Downloading pathspec-0.12.1-py3-none-any.whl (31 kB)
2026-03-11 00:30:05.833590 | controller | Installing collected packages: pathspec, yamllint
2026-03-11 00:30:05.926962 | controller | Successfully installed pathspec-0.12.1 yamllint-1.35.1
2026-03-11 00:30:06.538034 | controller | ok: Runtime: 0:00:01.033636
2026-03-11 00:30:06.556285 | 
2026-03-11 00:30:06.556669 | TASK [ansible-test : Copy the integration_config.yml file from the controller]
2026-03-11 00:30:07.429177 | controller | cp: cannot stat '/tmp/integration_config.yml': No such file or directory
2026-03-11 00:30:08.015003 | controller | ERROR
2026-03-11 00:30:08.015434 | controller | {
2026-03-11 00:30:08.015525 | controller |   "delta": "0:00:00.006722",
2026-03-11 00:30:08.015584 | controller |   "end": "2026-03-11 00:30:07.429431",
2026-03-11 00:30:08.015626 | controller |   "msg": "non-zero return code",
2026-03-11 00:30:08.015665 | controller |   "rc": 1,
2026-03-11 00:30:08.015702 | controller |   "start": "2026-03-11 00:30:07.422709"
2026-03-11 00:30:08.015788 | controller | }
2026-03-11 00:30:08.015844 | controller | ERROR: Ignoring Errors
2026-03-11 00:30:08.033464 | 
2026-03-11 00:30:08.033622 | TASK [ansible-test : Copy potential cloud provider configuration for ansible-test in the collection]
2026-03-11 00:30:08.766123 | controller | skipping: Conditional result was False
2026-03-11 00:30:08.774736 | 
2026-03-11 00:30:08.774842 | TASK [ansible-test : Enable persistent connection logging]
2026-03-11 00:30:11.395094 | controller | changed: section and option added
2026-03-11 00:30:11.401876 | 
2026-03-11 00:30:11.401972 | TASK [ansible-test : Set persistent ssh_type value]
2026-03-11 00:30:12.495717 | controller | changed: option added
2026-03-11 00:30:12.509081 | 
2026-03-11 00:30:12.509215 | TASK [ansible-test : Set ansible log path]
2026-03-11 00:30:13.644164 | controller | changed: section and option added
2026-03-11 00:30:13.658356 | 
2026-03-11 00:30:13.658530 | TASK [ansible-test : Identify the changed targets]
2026-03-11 00:30:14.048949 | controller | skipping: Conditional result was False
2026-03-11 00:30:14.055402 | 
2026-03-11 00:30:14.055512 | TASK [ansible-test : set_fact]
2026-03-11 00:30:14.151921 | controller | skipping: Conditional result was False
2026-03-11 00:30:14.191145 | 
2026-03-11 00:30:14.191266 | TASK [ansible-test : Set the targets]
2026-03-11 00:30:14.221297 | controller | ok
2026-03-11 00:30:14.227627 | 
2026-03-11 00:30:14.227771 | TASK [ansible-test : set_fact]
2026-03-11 00:30:14.251901 | controller | skipping: Conditional result was False
2026-03-11 00:30:14.258911 | 
2026-03-11 00:30:14.259030 | TASK [ansible-test : List the targets]
2026-03-11 00:30:14.641214 | controller | skipping: Conditional result was False
2026-03-11 00:30:14.649768 | 
2026-03-11 00:30:14.649906 | TASK [ansible-test : set_fact]
2026-03-11 00:30:14.674532 | controller | skipping: Conditional result was False
2026-03-11 00:30:14.681552 | 
2026-03-11 00:30:14.681685 | TASK [ansible-test : set_fact]
2026-03-11 00:30:14.697696 | controller | skipping: Conditional result was False
2026-03-11 00:30:14.705844 | 
2026-03-11 00:30:14.705978 | LOOP [ansible-test : set_fact]
2026-03-11 00:30:14.757413 | 
2026-03-11 00:30:14.757583 | TASK [ansible-test : set_fact]
2026-03-11 00:30:14.771852 | controller | skipping: Conditional result was False
2026-03-11 00:30:14.782801 | 
2026-03-11 00:30:14.782923 | TASK [ansible-test : debug]
2026-03-11 00:30:14.807367 | controller | skipping: Conditional result was False
2026-03-11 00:30:14.814594 | 
2026-03-11 00:30:14.814706 | TASK [ansible-test : debug]
2026-03-11 00:30:14.861811 | About to run: ansible-test sanity --requirements --docker -v
2026-03-11 00:30:14.881559 | 
2026-03-11 00:30:14.881695 | TASK [ansible-test : Run the test suite]
2026-03-11 00:30:16.678192 | controller | Run command: docker images quay.io/ansible/default-test-container:1.10.1 --format '{{json .}}'
2026-03-11 00:30:16.736303 | controller | Run command: docker pull quay.io/ansible/default-test-container:1.10.1
2026-03-11 00:30:18.456347 | controller | 1.10.1: Pulling from ansible/default-test-container
2026-03-11 00:30:18.457821 | 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-03-11 00:30:18.457859 | controller | 5667fdb72017: Pulling fs layer
2026-03-11 00:30:18.457868 | controller | d83811f270d5: Pulling fs layer
2026-03-11 00:30:18.457875 | controller | ee671aafb583: Pulling fs layer
2026-03-11 00:30:18.457890 | controller | 7fc152dfb3a6: Pulling fs layer
2026-03-11 00:30:18.458978 | controller | 3fb967a6fd03: Pulling fs layer
2026-03-11 00:30:18.458995 | controller | b3e63023ca5f: Pulling fs layer
2026-03-11 00:30:18.459001 | controller | 653cb3e65dbf: Pulling fs layer
2026-03-11 00:30:18.459008 | controller | f4712b586375: Pulling fs layer
2026-03-11 00:30:18.459014 | controller | d696ed7812f8: Pulling fs layer
2026-03-11 00:30:18.459020 | controller | 29bf28764f14: Pulling fs layer
2026-03-11 00:30:18.459027 | controller | 47d7edb3c2b7: Pulling fs layer
2026-03-11 00:30:18.459033 | controller | 07550ad4f6e4: Pulling fs layer
2026-03-11 00:30:18.459039 | controller | 7e79526e64c5: Pulling fs layer
2026-03-11 00:30:18.459046 | controller | 4fffb32882b7: Pulling fs layer
2026-03-11 00:30:18.459052 | controller | 7fc152dfb3a6: Waiting
2026-03-11 00:30:18.459058 | controller | fc7a38b06f4e: Pulling fs layer
2026-03-11 00:30:18.459064 | controller | 6d9d912e060e: Pulling fs layer
2026-03-11 00:30:18.459070 | controller | 3fb967a6fd03: Waiting
2026-03-11 00:30:18.459077 | controller | 5dd542dd28d9: Pulling fs layer
2026-03-11 00:30:18.459083 | controller | b3e63023ca5f: Waiting
2026-03-11 00:30:18.459093 | controller | cef8beb99552: Pulling fs layer
2026-03-11 00:30:18.459099 | controller | 653cb3e65dbf: Waiting
2026-03-11 00:30:18.459105 | controller | bd5557e101ad: Pulling fs layer
2026-03-11 00:30:18.459111 | controller | e057c20fabdd: Pulling fs layer
2026-03-11 00:30:18.459117 | controller | f4712b586375: Waiting
2026-03-11 00:30:18.459122 | controller | d16059cdae2e: Pulling fs layer
2026-03-11 00:30:18.459129 | controller | d696ed7812f8: Waiting
2026-03-11 00:30:18.459134 | controller | 431e42d906a3: Pulling fs layer
2026-03-11 00:30:18.459143 | controller | 7a0fd3b1d7c3: Pulling fs layer
2026-03-11 00:30:18.459149 | controller | 29bf28764f14: Waiting
2026-03-11 00:30:18.459155 | controller | aacdb6db0c8c: Pulling fs layer
2026-03-11 00:30:18.459161 | controller | 47d7edb3c2b7: Waiting
2026-03-11 00:30:18.459167 | controller | 2e7f04ae8c8b: Pulling fs layer
2026-03-11 00:30:18.459173 | controller | 07550ad4f6e4: Waiting
2026-03-11 00:30:18.459179 | controller | 7e79526e64c5: Waiting
2026-03-11 00:30:18.459185 | controller | 4fffb32882b7: Waiting
2026-03-11 00:30:18.459193 | controller | fc7a38b06f4e: Waiting
2026-03-11 00:30:18.459199 | controller | 6d9d912e060e: Waiting
2026-03-11 00:30:18.459204 | controller | 5dd542dd28d9: Waiting
2026-03-11 00:30:18.459210 | controller | cef8beb99552: Waiting
2026-03-11 00:30:18.459216 | controller | bd5557e101ad: Waiting
2026-03-11 00:30:18.459245 | controller | e057c20fabdd: Waiting
2026-03-11 00:30:18.459253 | controller | d16059cdae2e: Waiting
2026-03-11 00:30:18.459259 | controller | 431e42d906a3: Waiting
2026-03-11 00:30:18.459265 | controller | 7a0fd3b1d7c3: Waiting
2026-03-11 00:30:18.459271 | controller | aacdb6db0c8c: Waiting
2026-03-11 00:30:18.459282 | controller | 4cd343027a44: Pulling fs layer
2026-03-11 00:30:19.272742 | controller | 0b4379883f90: Pulling fs layer
2026-03-11 00:30:19.272906 | controller | 2e7f04ae8c8b: Waiting
2026-03-11 00:30:19.272920 | controller | 3d9d6d9dfc91: Pulling fs layer
2026-03-11 00:30:19.272927 | controller | 57d6314bd293: Pulling fs layer
2026-03-11 00:30:19.272933 | controller | 774036afeb7f: Pulling fs layer
2026-03-11 00:30:19.272939 | controller | 54b10f0e1645: Pulling fs layer
2026-03-11 00:30:19.272945 | controller | 78cf439d9fdb: Pulling fs layer
2026-03-11 00:30:19.272951 | controller | 4cd343027a44: Waiting
2026-03-11 00:30:19.272957 | controller | 36e5e20969c7: Pulling fs layer
2026-03-11 00:30:19.272963 | controller | 4b19ac3f17a8: Pulling fs layer
2026-03-11 00:30:19.273022 | controller | 0b4379883f90: Waiting
2026-03-11 00:30:19.273030 | controller | 54b10f0e1645: Waiting
2026-03-11 00:30:19.273036 | controller | 3d9d6d9dfc91: Waiting
2026-03-11 00:30:19.273045 | controller | 57d6314bd293: Waiting
2026-03-11 00:30:19.273064 | controller | 774036afeb7f: Waiting
2026-03-11 00:30:19.273072 | controller | 78cf439d9fdb: Waiting
2026-03-11 00:30:19.273078 | controller | 36e5e20969c7: Waiting
2026-03-11 00:30:19.273109 | controller | 4b19ac3f17a8: Waiting
2026-03-11 00:30:19.273146 | controller | ee671aafb583: Verifying Checksum
2026-03-11 00:30:19.441626 | controller | ee671aafb583: Download complete
2026-03-11 00:30:19.441684 | controller | d83811f270d5: Verifying Checksum
2026-03-11 00:30:20.034305 | controller | d83811f270d5: Download complete
2026-03-11 00:30:20.034355 | controller | 7fc152dfb3a6: Verifying Checksum
2026-03-11 00:30:20.851823 | controller | 7fc152dfb3a6: Download complete
2026-03-11 00:30:20.851875 | controller | b3e63023ca5f: Verifying Checksum
2026-03-11 00:30:21.701278 | controller | b3e63023ca5f: Download complete
2026-03-11 00:30:21.701358 | controller | 653cb3e65dbf: Verifying Checksum
2026-03-11 00:30:25.758189 | controller | 653cb3e65dbf: Download complete
2026-03-11 00:30:25.758275 | controller | 3fb967a6fd03: Verifying Checksum
2026-03-11 00:30:25.758855 | controller | 3fb967a6fd03: Download complete
2026-03-11 00:30:26.564834 | controller | d696ed7812f8: Verifying Checksum
2026-03-11 00:30:26.564885 | controller | d696ed7812f8: Download complete
2026-03-11 00:30:26.799559 | controller | 5667fdb72017: Verifying Checksum
2026-03-11 00:30:26.799610 | controller | 5667fdb72017: Download complete
2026-03-11 00:30:27.352588 | controller | 29bf28764f14: Verifying Checksum
2026-03-11 00:30:27.352634 | controller | 29bf28764f14: Download complete
2026-03-11 00:30:28.113246 | controller | 07550ad4f6e4: Verifying Checksum
2026-03-11 00:30:28.115384 | controller | 07550ad4f6e4: Download complete
2026-03-11 00:30:28.115435 | controller | 47d7edb3c2b7: Verifying Checksum
2026-03-11 00:30:28.115462 | controller | 47d7edb3c2b7: Download complete
2026-03-11 00:30:28.920514 | controller | 7e79526e64c5: Verifying Checksum
2026-03-11 00:30:28.967007 | controller | 7e79526e64c5: Download complete
2026-03-11 00:30:28.967069 | controller | 4fffb32882b7: Verifying Checksum
2026-03-11 00:30:29.612736 | controller | 4fffb32882b7: Download complete
2026-03-11 00:30:29.612797 | controller | 5667fdb72017: Pull complete
2026-03-11 00:30:29.656311 | controller | d83811f270d5: Pull complete
2026-03-11 00:30:29.697377 | controller | ee671aafb583: Pull complete
2026-03-11 00:30:29.698460 | controller | 6d9d912e060e: Verifying Checksum
2026-03-11 00:30:29.744019 | controller | 6d9d912e060e: Download complete
2026-03-11 00:30:29.744083 | controller | 7fc152dfb3a6: Pull complete
2026-03-11 00:30:30.341796 | controller | fc7a38b06f4e: Verifying Checksum
2026-03-11 00:30:30.501657 | controller | fc7a38b06f4e: Download complete
2026-03-11 00:30:30.501713 | controller | 5dd542dd28d9: Verifying Checksum
2026-03-11 00:30:30.834812 | controller | 5dd542dd28d9: Download complete
2026-03-11 00:30:30.834871 | controller | 3fb967a6fd03: Pull complete
2026-03-11 00:30:30.866932 | controller | b3e63023ca5f: Pull complete
2026-03-11 00:30:30.895257 | controller | 653cb3e65dbf: Pull complete
2026-03-11 00:30:31.297764 | controller | bd5557e101ad: Verifying Checksum
2026-03-11 00:30:32.059090 | controller | bd5557e101ad: Download complete
2026-03-11 00:30:32.059197 | controller | e057c20fabdd: Verifying Checksum
2026-03-11 00:30:32.842562 | controller | e057c20fabdd: Download complete
2026-03-11 00:30:32.842633 | controller | d16059cdae2e: Verifying Checksum
2026-03-11 00:30:34.532995 | controller | d16059cdae2e: Download complete
2026-03-11 00:30:34.533066 | controller | 431e42d906a3: Verifying Checksum
2026-03-11 00:30:36.309304 | controller | 431e42d906a3: Download complete
2026-03-11 00:30:36.309379 | controller | 7a0fd3b1d7c3: Verifying Checksum
2026-03-11 00:30:37.825713 | controller | 7a0fd3b1d7c3: Download complete
2026-03-11 00:30:37.825815 | controller | aacdb6db0c8c: Verifying Checksum
2026-03-11 00:30:37.826985 | controller | aacdb6db0c8c: Download complete
2026-03-11 00:30:38.591765 | controller | 2e7f04ae8c8b: Verifying Checksum
2026-03-11 00:30:38.591874 | controller | 2e7f04ae8c8b: Download complete
2026-03-11 00:30:39.420627 | controller | 4cd343027a44: Verifying Checksum
2026-03-11 00:30:39.421697 | controller | 4cd343027a44: Download complete
2026-03-11 00:30:40.219898 | controller | 0b4379883f90: Verifying Checksum
2026-03-11 00:30:40.220210 | controller | 0b4379883f90: Download complete
2026-03-11 00:30:41.066990 | controller | 3d9d6d9dfc91: Verifying Checksum
2026-03-11 00:30:41.067105 | controller | 3d9d6d9dfc91: Download complete
2026-03-11 00:30:47.611250 | controller | f4712b586375: Verifying Checksum
2026-03-11 00:30:47.614202 | controller | f4712b586375: Download complete
2026-03-11 00:30:56.100552 | controller | 57d6314bd293: Verifying Checksum
2026-03-11 00:31:05.996032 | controller | 57d6314bd293: Download complete
2026-03-11 00:31:05.996102 | controller | cef8beb99552: Verifying Checksum
2026-03-11 00:31:06.241446 | controller | cef8beb99552: Download complete
2026-03-11 00:31:06.241506 | controller | 774036afeb7f: Verifying Checksum
2026-03-11 00:31:06.872725 | controller | 774036afeb7f: Download complete
2026-03-11 00:31:06.872786 | controller | 54b10f0e1645: Verifying Checksum
2026-03-11 00:31:10.508594 | controller | 54b10f0e1645: Download complete
2026-03-11 00:31:10.508677 | controller | f4712b586375: Pull complete
2026-03-11 00:31:10.543883 | controller | d696ed7812f8: Pull complete
2026-03-11 00:31:10.565708 | controller | 29bf28764f14: Pull complete
2026-03-11 00:31:10.624095 | controller | 47d7edb3c2b7: Pull complete
2026-03-11 00:31:10.650383 | controller | 07550ad4f6e4: Pull complete
2026-03-11 00:31:10.682130 | controller | 7e79526e64c5: Pull complete
2026-03-11 00:31:10.712587 | controller | 4fffb32882b7: Pull complete
2026-03-11 00:31:10.796340 | controller | fc7a38b06f4e: Pull complete
2026-03-11 00:31:10.824567 | controller | 6d9d912e060e: Pull complete
2026-03-11 00:31:10.853045 | controller | 5dd542dd28d9: Pull complete
2026-03-11 00:31:14.435905 | controller | 4b19ac3f17a8: Verifying Checksum
2026-03-11 00:31:14.436017 | controller | 4b19ac3f17a8: Download complete
2026-03-11 00:31:22.635383 | controller | 36e5e20969c7: Verifying Checksum
2026-03-11 00:31:22.635455 | controller | 36e5e20969c7: Download complete
2026-03-11 00:31:24.585517 | controller | 78cf439d9fdb: Verifying Checksum
2026-03-11 00:31:24.585566 | controller | 78cf439d9fdb: Download complete
2026-03-11 00:31:34.863670 | controller | cef8beb99552: Pull complete
2026-03-11 00:31:34.937108 | controller | bd5557e101ad: Pull complete
2026-03-11 00:31:35.040309 | controller | e057c20fabdd: Pull complete
2026-03-11 00:31:35.129146 | controller | d16059cdae2e: Pull complete
2026-03-11 00:31:38.461358 | controller | 431e42d906a3: Pull complete
2026-03-11 00:31:38.522672 | controller | 7a0fd3b1d7c3: Pull complete
2026-03-11 00:31:38.588335 | controller | aacdb6db0c8c: Pull complete
2026-03-11 00:31:38.641517 | controller | 2e7f04ae8c8b: Pull complete
2026-03-11 00:31:38.679641 | controller | 4cd343027a44: Pull complete
2026-03-11 00:31:38.728800 | controller | 0b4379883f90: Pull complete
2026-03-11 00:31:38.768151 | controller | 3d9d6d9dfc91: Pull complete
2026-03-11 00:31:44.162845 | controller | 57d6314bd293: Pull complete
2026-03-11 00:32:06.260529 | controller | 774036afeb7f: Pull complete
2026-03-11 00:32:35.044986 | controller | 54b10f0e1645: Pull complete
2026-03-11 00:32:59.871988 | controller | 78cf439d9fdb: Pull complete
2026-03-11 00:33:28.948634 | controller | 36e5e20969c7: Pull complete
2026-03-11 00:33:55.349964 | controller | 4b19ac3f17a8: Pull complete
2026-03-11 00:33:55.364431 | controller | Digest: sha256:954c4edffb0905df64e23c8611b1c4a62db9af13062f51cad5b658e727238d41
2026-03-11 00:33:55.368247 | controller | Status: Downloaded newer image for quay.io/ansible/default-test-container:1.10.1
2026-03-11 00:33:55.374351 | controller | quay.io/ansible/default-test-container:1.10.1
2026-03-11 00:33:55.378632 | controller | Run command: docker images quay.io/ansible/pypi-test-container:1.0.0 --format '{{json .}}'
2026-03-11 00:33:55.404311 | controller | Run command: docker pull quay.io/ansible/pypi-test-container:1.0.0
2026-03-11 00:33:56.879650 | controller | 1.0.0: Pulling from ansible/pypi-test-container
2026-03-11 00:33:56.879813 | controller | 04a5f4cda3ee: Pulling fs layer
2026-03-11 00:33:56.879904 | controller | ff496a88c8ed: Pulling fs layer
2026-03-11 00:33:56.879975 | controller | 0ce83f459fe7: Pulling fs layer
2026-03-11 00:33:56.880056 | controller | 2e5170e1f099: Pulling fs layer
2026-03-11 00:33:56.880125 | controller | 7641eb41b08c: Pulling fs layer
2026-03-11 00:33:56.880207 | controller | ad15fa9da398: Pulling fs layer
2026-03-11 00:33:56.880317 | controller | 087d91352424: Pulling fs layer
2026-03-11 00:33:56.880406 | controller | 8b92efd6a100: Pulling fs layer
2026-03-11 00:33:56.880938 | controller | 2e5170e1f099: Waiting
2026-03-11 00:33:56.881051 | controller | 7641eb41b08c: Waiting
2026-03-11 00:33:56.881130 | controller | ad15fa9da398: Waiting
2026-03-11 00:33:56.881213 | controller | 087d91352424: Waiting
2026-03-11 00:33:56.883808 | controller | 8b92efd6a100: Waiting
2026-03-11 00:33:57.276085 | controller | 0ce83f459fe7: Verifying Checksum
2026-03-11 00:33:57.276212 | controller | 0ce83f459fe7: Download complete
2026-03-11 00:33:57.317785 | controller | ff496a88c8ed: Verifying Checksum
2026-03-11 00:33:57.731676 | controller | ff496a88c8ed: Download complete
2026-03-11 00:33:57.731732 | controller | 7641eb41b08c: Verifying Checksum
2026-03-11 00:33:57.731830 | controller | 7641eb41b08c: Download complete
2026-03-11 00:33:58.096123 | controller | ad15fa9da398: Verifying Checksum
2026-03-11 00:33:58.096256 | controller | ad15fa9da398: Download complete
2026-03-11 00:33:58.585719 | controller | 087d91352424: Verifying Checksum
2026-03-11 00:33:58.984000 | controller | 087d91352424: Download complete
2026-03-11 00:33:58.984088 | controller | 8b92efd6a100: Verifying Checksum
2026-03-11 00:33:58.984128 | controller | 8b92efd6a100: Download complete
2026-03-11 00:33:59.189817 | controller | 04a5f4cda3ee: Verifying Checksum
2026-03-11 00:33:59.189936 | controller | 04a5f4cda3ee: Download complete
2026-03-11 00:33:59.296356 | controller | 2e5170e1f099: Verifying Checksum
2026-03-11 00:33:59.296435 | controller | 2e5170e1f099: Download complete
2026-03-11 00:34:01.120263 | controller | 04a5f4cda3ee: Pull complete
2026-03-11 00:34:01.151866 | controller | ff496a88c8ed: Pull complete
2026-03-11 00:34:01.177563 | controller | 0ce83f459fe7: Pull complete
2026-03-11 00:34:02.635181 | controller | 2e5170e1f099: Pull complete
2026-03-11 00:34:02.659568 | controller | 7641eb41b08c: Pull complete
2026-03-11 00:34:02.688712 | controller | ad15fa9da398: Pull complete
2026-03-11 00:34:03.675789 | controller | 087d91352424: Pull complete
2026-03-11 00:34:04.031649 | controller | 8b92efd6a100: Pull complete
2026-03-11 00:34:04.059701 | controller | Digest: sha256:71042ab0a14971b5608fe75706de54f367fc31db573e3b3955182037f73cadb6
2026-03-11 00:34:04.064591 | controller | Status: Downloaded newer image for quay.io/ansible/pypi-test-container:1.0.0
2026-03-11 00:34:04.074881 | controller | quay.io/ansible/pypi-test-container:1.0.0
2026-03-11 00:34:04.078781 | controller | Run command: docker run --detach quay.io/ansible/pypi-test-container:1.0.0
2026-03-11 00:34:10.866344 | controller | Run command: docker inspect ea5b407a2d67f8c9e5858580cc7fd2b2e9af1498052ff60b6de3daffdee20691
2026-03-11 00:34:11.120580 | controller | Scanning collection root: /home/zuul/.ansible/collections/ansible_collections
2026-03-11 00:34:11.139464 | controller | Including collection: ansible.netcommon (278 files)
2026-03-11 00:34:11.139544 | controller | Including collection: ansible.network (23 files)
2026-03-11 00:34:11.151694 | controller | Including collection: ansible.utils (441 files)
2026-03-11 00:34:11.200328 | controller | Including collection: arista.eos (1031 files)
2026-03-11 00:34:11.254589 | controller | Including collection: cisco.ios (1215 files)
2026-03-11 00:34:11.307407 | controller | Including collection: cisco.iosxr (1044 files)
2026-03-11 00:34:11.397153 | controller | Including collection: cisco.nxos (1687 files)
2026-03-11 00:34:11.416998 | controller | Including collection: juniper.device (391 files)
2026-03-11 00:34:11.447565 | controller | Including collection: junipernetworks.junos (700 files)
2026-03-11 00:34:11.493592 | controller | Creating a payload archive containing 8547 files...
2026-03-11 00:34:13.926736 | controller | Created a 7130531 byte payload archive containing 8547 files in 2 seconds.
2026-03-11 00:34:13.931119 | controller | Assuming Docker is available on localhost.
2026-03-11 00:34:13.931633 | 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-03-11 00:34:14.502332 | controller | Run command: docker exec -i 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 dd of=/root/docker.sh bs=65536
2026-03-11 00:34:14.600809 | controller | Run command: docker exec 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 /bin/bash /root/docker.sh
2026-03-11 00:34:14.692588 | controller | Run command: docker exec -i 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 dd of=/root/ansible.tgz bs=65536
2026-03-11 00:34:14.818309 | controller | Run command: docker exec 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 mkdir /root/ansible
2026-03-11 00:34:14.891392 | controller | Run command: docker exec 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 tar oxzf /root/ansible.tgz -C /root/ansible
2026-03-11 00:34:16.161403 | controller | Run command: docker exec 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 /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-7owmrqbz.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/
2026-03-11 00:34:16.732272 | controller | Injecting custom PyPI hosts entries: /etc/hosts
2026-03-11 00:34:16.732752 | controller | Injecting custom PyPI config: /root/.pip/pip.conf
2026-03-11 00:34:16.733270 | controller | Injecting custom PyPI config: /root/.pydistutils.cfg
2026-03-11 00:34:16.736585 | controller | Run command: /usr/bin/python3.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-03-11 00:34:16.817717 | controller | Running sanity test 'action-plugin-docs' with Python 3.6
2026-03-11 00:34:16.822875 | controller | Read 0 sanity test ignore line(s) for Ansible 2.9 from: tests/sanity/ignore-2.9.txt
2026-03-11 00:34:16.832111 | controller | No tests applicable.
2026-03-11 00:34:16.832334 | controller | Running sanity test 'ansible-doc' with Python 3.6
2026-03-11 00:34:16.832658 | controller | No tests applicable.
2026-03-11 00:34:16.833055 | controller | Run command: /usr/bin/python2.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-03-11 00:34:16.925296 | controller | Running sanity test 'compile' with Python 2.6
2026-03-11 00:34:16.925842 | controller | No tests applicable.
2026-03-11 00:34:16.926330 | controller | Run command: /usr/bin/python2.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-03-11 00:34:17.153620 | controller | Running sanity test 'compile' with Python 2.7
2026-03-11 00:34:17.154029 | controller | No tests applicable.
2026-03-11 00:34:17.154540 | controller | Run command: /usr/bin/python3.5 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-03-11 00:34:17.302880 | controller | Running sanity test 'compile' with Python 3.5
2026-03-11 00:34:17.303278 | controller | No tests applicable.
2026-03-11 00:34:17.303483 | controller | Running sanity test 'compile' with Python 3.6
2026-03-11 00:34:17.303500 | controller | No tests applicable.
2026-03-11 00:34:17.303915 | controller | Run command: /usr/bin/python3.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-03-11 00:34:17.428035 | controller | Running sanity test 'compile' with Python 3.7
2026-03-11 00:34:17.428346 | controller | No tests applicable.
2026-03-11 00:34:17.431096 | controller | Run command: /usr/bin/python3.8 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-03-11 00:34:17.550812 | controller | Running sanity test 'compile' with Python 3.8
2026-03-11 00:34:17.551686 | controller | No tests applicable.
2026-03-11 00:34:17.551959 | controller | Running sanity test 'empty-init' with Python 3.6
2026-03-11 00:34:17.551979 | controller | No tests applicable.
2026-03-11 00:34:17.552414 | controller | Running sanity test 'future-import-boilerplate' with Python 3.6
2026-03-11 00:34:17.552436 | controller | No tests applicable.
2026-03-11 00:34:17.552525 | controller | Running sanity test 'ignores'
2026-03-11 00:34:17.555034 | 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-03-11 00:34:18.373650 | controller | Ignoring packaging: markers 'python_version < "3.6"' don't match your environment
2026-03-11 00:34:18.378339 | controller | Ignoring coverage: markers 'python_version > "3.7"' don't match your environment
2026-03-11 00:34:18.379864 | controller | Ignoring cryptography: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.382863 | controller | Ignoring deepdiff: markers 'python_version < "3"' don't match your environment
2026-03-11 00:34:18.384513 | controller | Ignoring jinja2: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.386276 | controller | Ignoring urllib3: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.389397 | controller | Ignoring sphinx: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.395674 | controller | Ignoring wheel: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.397276 | controller | Ignoring yamllint: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.401828 | controller | Ignoring paramiko: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.405593 | controller | Ignoring pytest: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.407362 | controller | Ignoring pytest: markers 'python_version == "2.7"' don't match your environment
2026-03-11 00:34:18.408847 | controller | Ignoring pytest-forked: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.412846 | controller | Ignoring requests: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.424500 | controller | Ignoring virtualenv: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.425202 | controller | Ignoring pathspec: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.426672 | controller | Ignoring pyopenssl: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.429300 | controller | Ignoring pyyaml: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.430692 | controller | Ignoring pycparser: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.437859 | controller | Ignoring xmltodict: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.439383 | controller | Ignoring lxml: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.441742 | controller | Ignoring pyvmomi: markers 'python_version < "2.7"' don't match your environment
2026-03-11 00:34:18.443857 | controller | Ignoring MarkupSafe: markers 'python_version < "3.6"' don't match your environment
2026-03-11 00:34:18.448447 | controller | Ignoring setuptools: markers 'python_version <= "2.7"' don't match your environment
2026-03-11 00:34:18.452383 | controller | Ignoring websocket-client: markers 'python_version < "3"' don't match your environment
2026-03-11 00:34:18.453848 | controller | Ignoring certifi: markers 'python_version < "3"' don't match your environment
2026-03-11 00:34:18.470987 | controller | Looking in indexes: http://172.17.0.2:3141/root/pypi/+simple/
2026-03-11 00:34:18.472079 | 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-03-11 00:34:18.498670 | 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-03-11 00:34:18.502287 | 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-03-11 00:34:18.505629 | 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-03-11 00:34:18.508109 | 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-03-11 00:34:18.515544 | 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-03-11 00:34:18.518813 | 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-03-11 00:34:18.522817 | 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-03-11 00:34:18.524847 | 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-03-11 00:34:18.545279 | 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-03-11 00:34:18.548921 | 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-03-11 00:34:18.551119 | 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-03-11 00:34:18.553548 | 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-03-11 00:34:18.555782 | 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-03-11 00:34:18.558405 | controller | Collecting isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55))
2026-03-11 00:34:33.586437 | 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-03-11 00:34:49.103487 | 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-03-11 00:35:05.109820 | 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-03-11 00:35:22.128431 | 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-03-11 00:35:41.147614 | 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-03-11 00:35:56.164970 | 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-03-11 00:35:56.165888 | 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-03-11 00:35:56.291685 | controller | Removing custom PyPI config: /root/.pydistutils.cfg
2026-03-11 00:35:56.291818 | controller | Removing custom PyPI config: /root/.pip/pip.conf
2026-03-11 00:35:56.291830 | controller | Removing custom PyPI hosts entries: /etc/hosts
2026-03-11 00:35:56.291841 | 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-03-11 00:35:56.335344 | controller | Run command: docker exec 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 tar czf /root/output.tgz --exclude .tmp -C /root/ansible/ansible_collections/ansible/network/tests output
2026-03-11 00:35:56.417337 | controller | Run command: docker exec -i 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 dd if=/root/output.tgz bs=65536
2026-03-11 00:35:56.492320 | controller | Run command: tar oxzf /tmp/ansible-result-bmumra1k.tgz -C /home/zuul/.ansible/collections/ansible_collections/ansible/network/tests
2026-03-11 00:35:56.506974 | controller | Run command: docker rm -f ea5b407a2d67f8c9e5858580cc7fd2b2e9af1498052ff60b6de3daffdee20691
2026-03-11 00:35:56.811722 | controller | Run command: docker rm -f 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99
2026-03-11 00:35:57.611361 | controller | ERROR: Command "docker exec 2d9d4979d1a22f51ec92afadbe23e245062dfe5c3b5e31fae2c0d56435b3da99 /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-7owmrqbz.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/" returned exit status 1.
2026-03-11 00:35:58.014587 | controller | ERROR
2026-03-11 00:35:58.015068 | controller | {
2026-03-11 00:35:58.015156 | controller |   "delta": "0:05:41.405215",
2026-03-11 00:35:58.015202 | controller |   "end": "2026-03-11 00:35:57.668919",
2026-03-11 00:35:58.015240 | controller |   "msg": "non-zero return code",
2026-03-11 00:35:58.015276 | controller |   "rc": 1,
2026-03-11 00:35:58.015314 | controller |   "start": "2026-03-11 00:30:16.263704"
2026-03-11 00:35:58.015351 | controller | }
failure
2026-03-11 00:35:58.023820 | 
2026-03-11 00:35:58.023937 | PLAY RECAP
2026-03-11 00:35:58.024017 | controller | ok: 21 changed: 6 unreachable: 0 failed: 1 skipped: 20 rescued: 0 ignored: 1
2026-03-11 00:35:58.024064 | 
2026-03-11 00:35:58.188352 | RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2026-03-11 00:35:58.189286 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-11 00:35:58.786745 | 
2026-03-11 00:35:58.786876 | PLAY [all]
2026-03-11 00:35:58.810523 | 
2026-03-11 00:35:58.810672 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-03-11 00:36:01.979379 | controller | changed: non-zero return code
2026-03-11 00:36:01.985121 | 
2026-03-11 00:36:01.985196 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-03-11 00:36:02.009091 | controller | skipping: Conditional result was False
2026-03-11 00:36:02.015387 | 
2026-03-11 00:36:02.015489 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-03-11 00:36:02.050421 | 
2026-03-11 00:36:02.050628 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-03-11 00:36:02.087420 | 
2026-03-11 00:36:02.087646 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-03-11 00:36:02.113267 | controller | skipping: Conditional result was False
2026-03-11 00:36:02.123538 | 
2026-03-11 00:36:02.123648 | LOOP [fetch-subunit-output : Generate subunit file]
2026-03-11 00:36:02.157567 | 
2026-03-11 00:36:02.157806 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-03-11 00:36:02.173984 | controller | skipping: Conditional result was False
2026-03-11 00:36:02.193325 | 
2026-03-11 00:36:02.193535 | TASK [fetch-subunit-output : Remove the temporary file]
2026-03-11 00:36:02.222463 | controller | skipping: Conditional result was False
2026-03-11 00:36:02.237605 | 
2026-03-11 00:36:02.237793 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-03-11 00:36:02.266666 | controller | skipping: Conditional result was False
2026-03-11 00:36:02.318743 | 
2026-03-11 00:36:02.318903 | PLAY RECAP
2026-03-11 00:36:02.318961 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-11 00:36:02.318990 | 
2026-03-11 00:36:02.515121 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-11 00:36:02.516955 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-03-11 00:36:03.150669 | 
2026-03-11 00:36:03.150839 | PLAY [all:!appliance*]
2026-03-11 00:36:03.179149 | 
2026-03-11 00:36:03.179259 | TASK [unregister the node]
2026-03-11 00:36:03.548337 | controller | skipping: Conditional result was False
2026-03-11 00:36:03.561780 | 
2026-03-11 00:36:03.562016 | TASK [include_role : fetch-output]
2026-03-11 00:36:03.614977 | controller | ok
2026-03-11 00:36:03.662015 | 
2026-03-11 00:36:03.662151 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-11 00:36:03.707926 | controller | skipping: Conditional result was False
2026-03-11 00:36:03.718345 | 
2026-03-11 00:36:03.718481 | TASK [fetch-output : Set log path for single node]
2026-03-11 00:36:03.752108 | controller | ok
2026-03-11 00:36:03.760834 | 
2026-03-11 00:36:03.760968 | LOOP [fetch-output : Ensure local output dirs]
2026-03-11 00:36:04.220262 | controller -> localhost | ok: "/var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/logs"
2026-03-11 00:36:04.470435 | controller -> localhost | changed: "/var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/artifacts"
2026-03-11 00:36:04.718142 | controller -> localhost | changed: "/var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/work/docs"
2026-03-11 00:36:04.738282 | 
2026-03-11 00:36:04.738430 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-11 00:36:07.026237 | controller | changed:
2026-03-11 00:36:07.026520 | controller | .d..t...... ./
2026-03-11 00:36:07.026566 | controller | cd+++++++++ controller/
2026-03-11 00:36:07.026615 | controller | changed: All items complete
2026-03-11 00:36:07.026647 | 
2026-03-11 00:36:09.114136 | controller | changed: .d..t...... ./
2026-03-11 00:36:11.267270 | controller | changed: .d..t...... ./
2026-03-11 00:36:11.288951 | 
2026-03-11 00:36:11.289066 | TASK [include_role : fetch-output-openshift]
2026-03-11 00:36:11.303699 | controller | skipping: Conditional result was False
2026-03-11 00:36:11.312986 | 
2026-03-11 00:36:11.313178 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-11 00:36:11.370482 | controller | skipping: Conditional result was False
2026-03-11 00:36:11.371365 | controller | skipping: Conditional result was False
2026-03-11 00:36:11.409400 | 
2026-03-11 00:36:11.409506 | PLAY [localhost]
2026-03-11 00:36:11.423945 | 
2026-03-11 00:36:11.424057 | TASK [Run Zuul manifest role]
2026-03-11 00:36:11.442581 | localhost | ok
2026-03-11 00:36:11.459361 | 
2026-03-11 00:36:11.459496 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-11 00:36:11.864865 | localhost | changed
2026-03-11 00:36:11.879331 | 
2026-03-11 00:36:11.879549 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-11 00:36:11.913344 | localhost | ok
2026-03-11 00:36:11.928706 | 
2026-03-11 00:36:11.928898 | TASK [Set zuul-log-path fact]
2026-03-11 00:36:11.987539 | localhost | ok
2026-03-11 00:36:12.002677 | 
2026-03-11 00:36:12.002806 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-11 00:36:12.032180 | localhost | ok
2026-03-11 00:36:12.040262 | 
2026-03-11 00:36:12.040354 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-03-11 00:36:12.071935 | localhost | ok:
2026-03-11 00:36:12.072222 | localhost | {
2026-03-11 00:36:12.072259 | localhost |   "auth": {
2026-03-11 00:36:12.072292 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-03-11 00:36:12.072318 | localhost |     "username": "9LF91O0RK7JU"
2026-03-11 00:36:12.072342 | localhost |   },
2026-03-11 00:36:12.072366 | localhost |   "profile": "rackspace",
2026-03-11 00:36:12.072390 | localhost |   "region_name": "IAD"
2026-03-11 00:36:12.072414 | localhost | }
2026-03-11 00:36:12.072449 | 
2026-03-11 00:36:12.081549 | 
2026-03-11 00:36:12.081681 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-03-11 00:36:12.100208 | localhost | Output suppressed because no_log was given
2026-03-11 00:36:12.115843 | 
2026-03-11 00:36:12.115944 | TASK [upload-logs-failover : Initialize control vars]
2026-03-11 00:36:12.136042 | localhost | ok
2026-03-11 00:36:12.140523 | 
2026-03-11 00:36:12.140600 | LOOP [upload-logs-failover : Perform log upload]
2026-03-11 00:36:12.165708 | localhost | Output suppressed because no_log was given
2026-03-11 00:36:12.174850 | localhost | included: /var/lib/zuul/builds/d1ac4c9a074547a380fd7d24655b21dd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-03-11 00:36:12.185197 | 
2026-03-11 00:36:12.185342 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-03-11 00:36:12.261220 | localhost | Output suppressed because no_log was given
2026-03-11 00:36:12.269446 | 
2026-03-11 00:36:12.269554 | TASK [Upload logs to swift]
2026-03-11 00:36:12.292348 | localhost | ok
2026-03-11 00:36:12.335160 | 
2026-03-11 00:36:12.335311 | TASK [Set zuul-log-path fact]
2026-03-11 00:36:12.360481 | localhost | skipping: Conditional result was False
2026-03-11 00:36:12.365877 | 
2026-03-11 00:36:12.365948 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-03-11 00:36:12.726573 | localhost -> localhost | ok: Runtime: 0:00:00.009031
2026-03-11 00:36:12.740116 | 
2026-03-11 00:36:12.740272 | TASK [upload-logs-swift : Upload logs to swift]