2025-11-28 00:19:46.463828 | Job console starting...
2025-11-28 00:19:46.473362 | Updating repositories
2025-11-28 00:19:46.627217 | Preparing job workspace
2025-11-28 00:19:51.816073 | Running Ansible setup...
2025-11-28 00:19:58.991275 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-11-28 00:19:59.745383 | 
2025-11-28 00:19:59.745708 | PLAY [localhost]
2025-11-28 00:19:59.758648 | 
2025-11-28 00:19:59.758804 | TASK [Gathering Facts]
2025-11-28 00:20:00.817790 | localhost | ok
2025-11-28 00:20:00.848173 | 
2025-11-28 00:20:00.848380 | TASK [Setup log path fact]
2025-11-28 00:20:00.871887 | localhost | ok
2025-11-28 00:20:00.891878 | 
2025-11-28 00:20:00.892051 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-11-28 00:20:00.933497 | localhost | ok
2025-11-28 00:20:00.944838 | 
2025-11-28 00:20:00.944965 | TASK [emit-job-header : Print job information]
2025-11-28 00:20:00.996925 | # Job Information
2025-11-28 00:20:00.997137 | Ansible Version: 2.15.12
2025-11-28 00:20:00.997183 | Job: ansible-test-sanity-docker-stable-2.9
2025-11-28 00:20:00.997214 | Pipeline: periodic
2025-11-28 00:20:00.997240 | Executor: ze01.softwarefactory-project.io
2025-11-28 00:20:00.997266 | Triggered by: https://github.com/ansible-collections/ansible.network
2025-11-28 00:20:00.997297 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/501/ansible/501aeb0b4e1e4d64b56694b19fa1ce52/
2025-11-28 00:20:00.997324 | Event ID: a5b225c8756b453caa3f2f71389276ab
2025-11-28 00:20:01.003070 | 
2025-11-28 00:20:01.003177 | LOOP [emit-job-header : Print node information]
2025-11-28 00:20:01.125100 | localhost | ok:
2025-11-28 00:20:01.125573 | localhost | # Node Information
2025-11-28 00:20:01.125645 | localhost | Inventory Hostname: controller
2025-11-28 00:20:01.125693 | localhost | Hostname: np0005538409
2025-11-28 00:20:01.125750 | localhost | Username: zuul
2025-11-28 00:20:01.125811 | localhost | Distro: Fedora 37
2025-11-28 00:20:01.125854 | localhost | Provider: ansible-vexxhost-ams1
2025-11-28 00:20:01.125894 | localhost | Region: ams1
2025-11-28 00:20:01.125932 | localhost | Label: ansible-fedora-37-1vcpu
2025-11-28 00:20:01.125968 | localhost | Product Name: OpenStack Nova
2025-11-28 00:20:01.126005 | localhost | Interface IP: 38.129.16.50
2025-11-28 00:20:01.144303 | 
2025-11-28 00:20:01.144469 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-11-28 00:20:01.582910 | localhost -> localhost | changed
2025-11-28 00:20:01.588469 | 
2025-11-28 00:20:01.588540 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-11-28 00:20:03.146942 | localhost -> localhost | changed
2025-11-28 00:20:03.192328 | 
2025-11-28 00:20:03.192430 | PLAY [all:!appliance*]
2025-11-28 00:20:03.222073 | 
2025-11-28 00:20:03.222209 | TASK [include_role : start-zuul-console]
2025-11-28 00:20:03.248246 | controller | ok
2025-11-28 00:20:03.269710 | 
2025-11-28 00:20:03.269800 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-11-28 00:20:04.286948 | controller | ok
2025-11-28 00:20:04.304553 | 
2025-11-28 00:20:04.304692 | TASK [use-our-mirror : Retrieve the IP address]
2025-11-28 00:20:06.806836 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2025-11-28 00:20:06.822758 | 
2025-11-28 00:20:06.822921 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2025-11-28 00:20:07.199776 | controller | skipping: Conditional result was False
2025-11-28 00:20:07.219985 | 
2025-11-28 00:20:07.220341 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2025-11-28 00:20:07.249703 | controller | skipping: Conditional result was False
2025-11-28 00:20:07.260248 | 
2025-11-28 00:20:07.260400 | TASK [use-our-mirror : Create the podman configuration directory]
2025-11-28 00:20:07.296265 | controller | skipping: Conditional result was False
2025-11-28 00:20:07.306343 | 
2025-11-28 00:20:07.306478 | TASK [use-our-mirror : Copy the podman configuration]
2025-11-28 00:20:07.331718 | controller | skipping: Conditional result was False
2025-11-28 00:20:07.340555 | 
2025-11-28 00:20:07.340842 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2025-11-28 00:20:07.355258 | controller | skipping: Conditional result was False
2025-11-28 00:20:07.362536 | 
2025-11-28 00:20:07.362631 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2025-11-28 00:20:07.376582 | controller | skipping: Conditional result was False
2025-11-28 00:20:07.390585 | 
2025-11-28 00:20:07.390701 | TASK [Disable Fedora Modular]
2025-11-28 00:20:08.440534 | controller | changed
2025-11-28 00:20:08.447521 | 
2025-11-28 00:20:08.447624 | TASK [Enable EPEL]
2025-11-28 00:20:08.472270 | controller | skipping: Conditional result was False
2025-11-28 00:20:08.479440 | 
2025-11-28 00:20:08.479536 | TASK [Register the RHEL node]
2025-11-28 00:20:08.870637 | 
2025-11-28 00:20:08.870833 | TASK [Show the subscription-manager status]
2025-11-28 00:20:09.237204 | controller | skipping: Conditional result was False
2025-11-28 00:20:09.247417 | 
2025-11-28 00:20:09.247572 | TASK [Enable EPEL on RHEL]
2025-11-28 00:20:09.641217 | controller | skipping: Conditional result was False
2025-11-28 00:20:09.650582 | 
2025-11-28 00:20:09.650727 | TASK [Install git and tox]
2025-11-28 00:21:55.527370 | controller | changed
2025-11-28 00:21:55.539538 | 
2025-11-28 00:21:55.539666 | TASK [include_role : prepare-workspace]
2025-11-28 00:21:55.560570 | controller | ok
2025-11-28 00:21:55.590159 | 
2025-11-28 00:21:55.590307 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-11-28 00:21:56.379066 | controller | ok
2025-11-28 00:21:56.390046 | 
2025-11-28 00:21:56.390172 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-11-28 00:22:15.937619 | controller | Output suppressed because no_log was given
2025-11-28 00:22:15.954608 | 
2025-11-28 00:22:15.954757 | TASK [include_role : prepare-workspace-openshift]
2025-11-28 00:22:16.001926 | controller | skipping: Conditional result was False
2025-11-28 00:22:16.041880 | 
2025-11-28 00:22:16.042002 | PLAY [all:!appliance]
2025-11-28 00:22:16.064987 | 
2025-11-28 00:22:16.065164 | TASK [Run add-build-sshkey role (RSA)]
2025-11-28 00:22:16.086885 | controller | ok
2025-11-28 00:22:16.105471 | 
2025-11-28 00:22:16.105629 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-11-28 00:22:16.378683 | controller -> localhost | ok
2025-11-28 00:22:16.398003 | 
2025-11-28 00:22:16.398194 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-11-28 00:22:16.431609 | controller | ok
2025-11-28 00:22:16.452262 | controller | included: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-11-28 00:22:16.461343 | 
2025-11-28 00:22:16.461441 | TASK [add-build-sshkey : Create Temp SSH key]
2025-11-28 00:22:16.967909 | controller -> localhost | Generating public/private rsa key pair.
2025-11-28 00:22:16.968127 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/501aeb0b4e1e4d64b56694b19fa1ce52_id_rsa.
2025-11-28 00:22:16.968156 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/501aeb0b4e1e4d64b56694b19fa1ce52_id_rsa.pub.
2025-11-28 00:22:16.968178 | controller -> localhost | The key fingerprint is:
2025-11-28 00:22:16.968198 | controller -> localhost | SHA256:nNQFveXAxd2Yq5wDNA82JTD0+5qIRQTucgsDb5AdcsE zuul-build-sshkey
2025-11-28 00:22:16.968217 | controller -> localhost | The key's randomart image is:
2025-11-28 00:22:16.968236 | controller -> localhost | +---[RSA 2048]----+
2025-11-28 00:22:16.968254 | controller -> localhost | |  ..+...+.o=oo.+.|
2025-11-28 00:22:16.968273 | controller -> localhost | |   =Eo . +*o+ = o|
2025-11-28 00:22:16.968291 | controller -> localhost | |  + . . ooo= = . |
2025-11-28 00:22:16.968309 | controller -> localhost | |   + . + ...o o  |
2025-11-28 00:22:16.968327 | controller -> localhost | |    * o S .o o   |
2025-11-28 00:22:16.968361 | controller -> localhost | |   . = o   .=    |
2025-11-28 00:22:16.968383 | controller -> localhost | |      . .   ..   |
2025-11-28 00:22:16.968402 | controller -> localhost | |       o . o     |
2025-11-28 00:22:16.968421 | controller -> localhost | |      . . o      |
2025-11-28 00:22:16.968441 | controller -> localhost | +----[SHA256]-----+
2025-11-28 00:22:16.968489 | controller -> localhost | ok: Runtime: 0:00:00.068266
2025-11-28 00:22:16.975731 | 
2025-11-28 00:22:16.975855 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-11-28 00:22:17.007703 | controller | ok
2025-11-28 00:22:17.023746 | controller | included: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-11-28 00:22:17.040321 | 
2025-11-28 00:22:17.040469 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-11-28 00:22:17.065714 | controller | skipping: Conditional result was False
2025-11-28 00:22:17.072507 | 
2025-11-28 00:22:17.072608 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-11-28 00:22:18.120328 | controller | changed
2025-11-28 00:22:18.132752 | 
2025-11-28 00:22:18.132922 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-11-28 00:22:18.746316 | controller | ok
2025-11-28 00:22:18.752753 | 
2025-11-28 00:22:18.752841 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-11-28 00:22:21.653730 | controller | changed
2025-11-28 00:22:21.662761 | 
2025-11-28 00:22:21.662903 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-11-28 00:22:24.563660 | controller | changed
2025-11-28 00:22:24.576904 | 
2025-11-28 00:22:24.577108 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-11-28 00:22:24.605063 | controller | skipping: Conditional result was False
2025-11-28 00:22:24.621996 | 
2025-11-28 00:22:24.622346 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-11-28 00:22:25.021244 | controller -> localhost | changed
2025-11-28 00:22:25.050500 | 
2025-11-28 00:22:25.050676 | TASK [add-build-sshkey : Add back temp key]
2025-11-28 00:22:25.376251 | controller -> localhost | Identity added: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/501aeb0b4e1e4d64b56694b19fa1ce52_id_rsa (zuul-build-sshkey)
2025-11-28 00:22:25.376711 | controller -> localhost | ok: Runtime: 0:00:00.008057
2025-11-28 00:22:25.396298 | 
2025-11-28 00:22:25.396486 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-11-28 00:22:26.254908 | controller | ok
2025-11-28 00:22:26.265985 | 
2025-11-28 00:22:26.266192 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-11-28 00:22:26.313869 | controller | skipping: Conditional result was False
2025-11-28 00:22:26.334486 | 
2025-11-28 00:22:26.334651 | TASK [Run add-build-sshkey role (ECDSA)]
2025-11-28 00:22:26.367005 | controller | ok
2025-11-28 00:22:26.383793 | 
2025-11-28 00:22:26.383879 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-11-28 00:22:26.651453 | controller -> localhost | ok
2025-11-28 00:22:26.658655 | 
2025-11-28 00:22:26.658743 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-11-28 00:22:26.689677 | controller | ok
2025-11-28 00:22:26.701120 | controller | included: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-11-28 00:22:26.707916 | 
2025-11-28 00:22:26.707985 | TASK [add-build-sshkey : Create Temp SSH key]
2025-11-28 00:22:27.018358 | controller -> localhost | Generating public/private ecdsa key pair.
2025-11-28 00:22:27.018696 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/501aeb0b4e1e4d64b56694b19fa1ce52_id_ecdsa.
2025-11-28 00:22:27.018805 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/501aeb0b4e1e4d64b56694b19fa1ce52_id_ecdsa.pub.
2025-11-28 00:22:27.018885 | controller -> localhost | The key fingerprint is:
2025-11-28 00:22:27.018937 | controller -> localhost | SHA256:PPnCIGC6ZEMvtJUgwkel106IENVcc72TGPmCOke5m/s zuul-build-sshkey
2025-11-28 00:22:27.018981 | controller -> localhost | The key's randomart image is:
2025-11-28 00:22:27.019064 | controller -> localhost | +---[ECDSA 521]---+
2025-11-28 00:22:27.019110 | controller -> localhost | |+++o+..o .o      |
2025-11-28 00:22:27.019154 | controller -> localhost | |o.o.+oo oo .     |
2025-11-28 00:22:27.019193 | controller -> localhost | | o+= o oo + o    |
2025-11-28 00:22:27.019235 | controller -> localhost | |oo+.. o= + =     |
2025-11-28 00:22:27.019276 | controller -> localhost | |.* .. +.S . .    |
2025-11-28 00:22:27.019316 | controller -> localhost | |o.o  + = o       |
2025-11-28 00:22:27.019357 | controller -> localhost | |.     o = .      |
2025-11-28 00:22:27.019398 | controller -> localhost | |       o .       |
2025-11-28 00:22:27.019436 | controller -> localhost | |       .oE       |
2025-11-28 00:22:27.019477 | controller -> localhost | +----[SHA256]-----+
2025-11-28 00:22:27.019644 | controller -> localhost | ok: Runtime: 0:00:00.008761
2025-11-28 00:22:27.037104 | 
2025-11-28 00:22:27.037280 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-11-28 00:22:27.065363 | controller | ok
2025-11-28 00:22:27.078588 | controller | included: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-11-28 00:22:27.093502 | 
2025-11-28 00:22:27.093638 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-11-28 00:22:27.109301 | controller | skipping: Conditional result was False
2025-11-28 00:22:27.118105 | 
2025-11-28 00:22:27.118221 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-11-28 00:22:27.964118 | controller | changed
2025-11-28 00:22:27.972249 | 
2025-11-28 00:22:27.972346 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-11-28 00:22:28.589495 | controller | ok
2025-11-28 00:22:28.598807 | 
2025-11-28 00:22:28.598948 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-11-28 00:22:31.529620 | controller | changed
2025-11-28 00:22:31.544167 | 
2025-11-28 00:22:31.544368 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-11-28 00:22:34.513987 | controller | changed
2025-11-28 00:22:34.529550 | 
2025-11-28 00:22:34.529718 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-11-28 00:22:34.557569 | controller | skipping: Conditional result was False
2025-11-28 00:22:34.574477 | 
2025-11-28 00:22:34.574707 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-11-28 00:22:34.848768 | controller -> localhost | changed
2025-11-28 00:22:34.876795 | 
2025-11-28 00:22:34.876973 | TASK [add-build-sshkey : Add back temp key]
2025-11-28 00:22:35.169621 | controller -> localhost | Identity added: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/501aeb0b4e1e4d64b56694b19fa1ce52_id_ecdsa (zuul-build-sshkey)
2025-11-28 00:22:35.169917 | controller -> localhost | ok: Runtime: 0:00:00.012945
2025-11-28 00:22:35.179838 | 
2025-11-28 00:22:35.179954 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-11-28 00:22:35.880699 | controller | ok
2025-11-28 00:22:35.897138 | 
2025-11-28 00:22:35.897327 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-11-28 00:22:35.937597 | controller | skipping: Conditional result was False
2025-11-28 00:22:35.964257 | 
2025-11-28 00:22:35.964404 | TASK [include_role : remove-zuul-sshkey]
2025-11-28 00:22:35.991315 | controller | skipping: Conditional result was False
2025-11-28 00:22:36.002440 | 
2025-11-28 00:22:36.002574 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-11-28 00:22:36.649431 | controller | ok: "logs"
2025-11-28 00:22:36.649918 | controller | ok: All items complete
2025-11-28 00:22:36.649983 | 
2025-11-28 00:22:37.252223 | controller | ok: "artifacts"
2025-11-28 00:22:37.842540 | controller | ok: "docs"
2025-11-28 00:22:37.864508 | 
2025-11-28 00:22:37.864714 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-11-28 00:22:38.508305 | controller | changed: "logs"
2025-11-28 00:22:39.090269 | controller | changed: "artifacts"
2025-11-28 00:22:39.675325 | controller | changed: "docs"
2025-11-28 00:22:39.740921 | 
2025-11-28 00:22:39.741125 | PLAY RECAP
2025-11-28 00:22:39.741215 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2025-11-28 00:22:39.741270 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-11-28 00:22:39.741309 | 
2025-11-28 00:22:39.895301 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-11-28 00:22:39.897495 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-11-28 00:22:40.470118 | 
2025-11-28 00:22:40.470240 | PLAY [all]
2025-11-28 00:22:40.492819 | 
2025-11-28 00:22:40.492949 | TASK [Install binary dependencies]
2025-11-28 00:22:40.577833 | controller | ok
2025-11-28 00:22:40.607442 | 
2025-11-28 00:22:40.607609 | TASK [bindep : Include find tasks]
2025-11-28 00:22:40.641472 | controller | ok
2025-11-28 00:22:40.652885 | controller | included: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2025-11-28 00:22:40.662788 | 
2025-11-28 00:22:40.662938 | TASK [bindep : Look for bindep.txt]
2025-11-28 00:22:41.576571 | controller | ok
2025-11-28 00:22:41.593488 | 
2025-11-28 00:22:41.593630 | TASK [bindep : Define bindep_file fact]
2025-11-28 00:22:41.608837 | controller | skipping: Conditional result was False
2025-11-28 00:22:41.620328 | 
2025-11-28 00:22:41.620468 | TASK [bindep : Look for other-requirements.txt]
2025-11-28 00:22:42.217784 | controller | ok
2025-11-28 00:22:42.233154 | 
2025-11-28 00:22:42.233323 | TASK [bindep : Define bindep_file fact]
2025-11-28 00:22:42.260332 | controller | skipping: Conditional result was False
2025-11-28 00:22:42.274251 | 
2025-11-28 00:22:42.274491 | TASK [bindep : Look for bindep fallback file]
2025-11-28 00:22:42.303252 | controller | skipping: Conditional result was False
2025-11-28 00:22:42.317730 | 
2025-11-28 00:22:42.317912 | TASK [bindep : Define bindep_file fact]
2025-11-28 00:22:42.345431 | controller | skipping: Conditional result was False
2025-11-28 00:22:42.359044 | 
2025-11-28 00:22:42.359193 | TASK [bindep : Include bindep tasks]
2025-11-28 00:22:42.386244 | controller | skipping: Conditional result was False
2025-11-28 00:22:42.400110 | 
2025-11-28 00:22:42.400264 | TASK [bindep : Include install tasks]
2025-11-28 00:22:42.427461 | controller | skipping: Conditional result was False
2025-11-28 00:22:42.442784 | 
2025-11-28 00:22:42.442976 | LOOP [bindep : Include package tasks]
2025-11-28 00:22:42.530658 | 
2025-11-28 00:22:42.530936 | TASK [Run test-setup role]
2025-11-28 00:22:42.561319 | controller | ok
2025-11-28 00:22:42.594998 | 
2025-11-28 00:22:42.595182 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2025-11-28 00:22:43.186594 | controller | ok
2025-11-28 00:22:43.193107 | 
2025-11-28 00:22:43.193202 | TASK [test-setup : Run tools/test-setup.sh]
2025-11-28 00:22:43.554193 | controller | skipping: Conditional result was False
2025-11-28 00:22:43.582276 | 
2025-11-28 00:22:43.582384 | PLAY RECAP
2025-11-28 00:22:43.582427 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-11-28 00:22:43.582448 | 
2025-11-28 00:22:43.705004 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-11-28 00:22:43.705894 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2025-11-28 00:22:44.303792 | 
2025-11-28 00:22:44.303943 | PLAY [controller]
2025-11-28 00:22:44.326922 | 
2025-11-28 00:22:44.327071 | TASK [Create the /root directory]
2025-11-28 00:22:45.332941 | controller | ok
2025-11-28 00:22:45.353533 | 
2025-11-28 00:22:45.353751 | TASK [Install glibc-langpack-en]
2025-11-28 00:22:52.320160 | controller | ok: Nothing to do
2025-11-28 00:22:52.334002 | 
2025-11-28 00:22:52.334204 | TASK [Ensure controller directory exists]
2025-11-28 00:22:53.122438 | controller | changed
2025-11-28 00:22:53.130317 | 
2025-11-28 00:22:53.130584 | TASK [Install container runtime]
2025-11-28 00:22:53.209307 | controller | ok
2025-11-28 00:22:53.276981 | 
2025-11-28 00:22:53.277118 | LOOP [ensure-docker : Gather variables for each operating system]
2025-11-28 00:22:53.332940 | controller | ok: "/var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml"
2025-11-28 00:22:53.339896 | 
2025-11-28 00:22:53.339966 | TASK [ensure-docker : Sanity check for distro selection]
2025-11-28 00:22:53.354088 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.360920 | 
2025-11-28 00:22:53.360991 | TASK [ensure-docker : Sanity check for distro install]
2025-11-28 00:22:53.385250 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.391970 | 
2025-11-28 00:22:53.392103 | TASK [ensure-docker : Sanity check for upstream install]
2025-11-28 00:22:53.426841 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.435215 | 
2025-11-28 00:22:53.435329 | TASK [ensure-docker : Sanity check for upstream install mirrors]
2025-11-28 00:22:53.460400 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.469343 | 
2025-11-28 00:22:53.469494 | TASK [ensure-docker : Include tasks for docker install]
2025-11-28 00:22:53.502643 | controller | ok
2025-11-28 00:22:53.514386 | controller | included: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml
2025-11-28 00:22:53.526741 | 
2025-11-28 00:22:53.526913 | TASK [ensure-docker : Not Implemented]
2025-11-28 00:22:53.553246 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.560289 | 
2025-11-28 00:22:53.560397 | TASK [Set up docker mirrors]
2025-11-28 00:22:53.583179 | controller | ok
2025-11-28 00:22:53.605938 | 
2025-11-28 00:22:53.606111 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info]
2025-11-28 00:22:53.641294 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.649392 | 
2025-11-28 00:22:53.649517 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info]
2025-11-28 00:22:53.694978 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.701987 | 
2025-11-28 00:22:53.702145 | TASK [use-docker-mirror : Set docker_mirror fact]
2025-11-28 00:22:53.747225 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.753769 | 
2025-11-28 00:22:53.753856 | TASK [use-docker-mirror : Set up docker mirrors]
2025-11-28 00:22:53.788674 | controller | skipping: Conditional result was False
2025-11-28 00:22:53.831639 | 
2025-11-28 00:22:53.831761 | TASK [Add all repositories]
2025-11-28 00:22:53.851817 | controller | ok
2025-11-28 00:22:53.878577 | 
2025-11-28 00:22:53.878710 | LOOP [ensure-package-repositories : Install repositories]
2025-11-28 00:22:53.911029 | controller | ok: "/var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml"
2025-11-28 00:22:53.911189 | controller | ok: All items complete
2025-11-28 00:22:53.911215 | 
2025-11-28 00:22:53.922498 | controller | included: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml
2025-11-28 00:22:53.929181 | 
2025-11-28 00:22:53.929259 | TASK [ensure-package-repositories : Create GPG key temp directory]
2025-11-28 00:22:54.856981 | controller | changed
2025-11-28 00:22:54.872454 | 
2025-11-28 00:22:54.872632 | LOOP [ensure-package-repositories : Upload GPG keys]
2025-11-28 00:22:57.972009 | controller | changed:
2025-11-28 00:22:57.972365 | controller | {
2025-11-28 00:22:57.972423 | 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"
2025-11-28 00:22:57.972482 | controller | }
2025-11-28 00:22:57.992864 | 
2025-11-28 00:22:57.993124 | LOOP [ensure-package-repositories : Import GPG keys]
2025-11-28 00:22:59.217941 | controller | changed:
2025-11-28 00:22:59.218157 | controller | {
2025-11-28 00:22:59.218186 | 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"
2025-11-28 00:22:59.218209 | controller | }
2025-11-28 00:22:59.218242 | controller | changed: All items complete
2025-11-28 00:22:59.218262 | 
2025-11-28 00:22:59.230689 | 
2025-11-28 00:22:59.230825 | TASK [ensure-package-repositories : Remove GPG temp directory]
2025-11-28 00:22:59.870059 | controller | changed
2025-11-28 00:22:59.884408 | 
2025-11-28 00:22:59.884589 | LOOP [ensure-package-repositories : Add repositories]
2025-11-28 00:23:00.650216 | controller | changed:
2025-11-28 00:23:00.651050 | controller | {
2025-11-28 00:23:00.651159 | controller |   "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable",
2025-11-28 00:23:00.651230 | controller |   "description": "Docker CE Stable - $basearch",
2025-11-28 00:23:00.651291 | controller |   "gpgcheck": true,
2025-11-28 00:23:00.651351 | controller |   "name": "docker-ce-stable"
2025-11-28 00:23:00.651408 | controller | }
2025-11-28 00:23:00.686876 | 
2025-11-28 00:23:00.687109 | TASK [ensure-docker : Install pre-reqs]
2025-11-28 00:23:04.960919 | controller | ok: Nothing to do
2025-11-28 00:23:04.973677 | 
2025-11-28 00:23:04.973850 | TASK [ensure-docker : Remove packages]
2025-11-28 00:23:08.563755 | controller | ok: Nothing to do
2025-11-28 00:23:08.570786 | 
2025-11-28 00:23:08.571222 | TASK [ensure-docker : Install upstream docker using package]
2025-11-28 00:24:28.581760 | controller | changed
2025-11-28 00:24:28.590206 | 
2025-11-28 00:24:28.590320 | TASK [ensure-docker : Setup docker]
2025-11-28 00:24:28.626365 | controller | ok
2025-11-28 00:24:28.641503 | controller | included: /var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml
2025-11-28 00:24:28.657821 | 
2025-11-28 00:24:28.657971 | TASK [ensure-docker : Ensure "docker" group exists]
2025-11-28 00:24:29.677630 | controller | ok
2025-11-28 00:24:29.692906 | 
2025-11-28 00:24:29.693106 | TASK [ensure-docker : Add user to docker group]
2025-11-28 00:24:30.714847 | controller | changed
2025-11-28 00:24:30.721428 | 
2025-11-28 00:24:30.721551 | TASK [Update docker daemon proxy configuration]
2025-11-28 00:24:30.757603 | controller | skipping: Conditional result was False
2025-11-28 00:24:30.765894 | 
2025-11-28 00:24:30.766083 | TASK [Lower default MTU]
2025-11-28 00:24:30.791441 | controller | skipping: Conditional result was False
2025-11-28 00:24:30.799879 | 
2025-11-28 00:24:30.800030 | TASK [ensure-docker : Get the status of the docket.socket unit]
2025-11-28 00:24:31.566763 | controller | inactive
2025-11-28 00:24:32.162474 | controller | ok: Runtime: 0:00:00.018437
2025-11-28 00:24:32.177736 | 
2025-11-28 00:24:32.177911 | TASK [ensure-docker : Get the status of the docket unit]
2025-11-28 00:24:32.906577 | controller | inactive
2025-11-28 00:24:33.060277 | controller | ok: Runtime: 0:00:00.017278
2025-11-28 00:24:33.074409 | 
2025-11-28 00:24:33.074576 | TASK [ensure-docker : Restart docker]
2025-11-28 00:24:33.129957 | Trigger a Docker restart
2025-11-28 00:24:33.138595 | 
2025-11-28 00:24:33.138694 | TASK [ensure-docker : Reset ssh connection to pick up docker group]
2025-11-28 00:24:33.180783 | 
2025-11-28 00:24:33.180933 | TASK [ensure-docker : Install docker-compose]
2025-11-28 00:24:33.206292 | controller | skipping: Conditional result was False
2025-11-28 00:24:33.216865 | 
2025-11-28 00:24:33.216958 | TASK [ensure-docker : Flush handlers before role exit]
2025-11-28 00:24:33.231063 | 
2025-11-28 00:24:33.231253 | TASK [ensure-docker : Stop docker.socket to avoid any conflict]
2025-11-28 00:24:36.480124 | controller | changed
2025-11-28 00:24:36.488200 | 
2025-11-28 00:24:36.488299 | TASK [ensure-docker : Assure docker service is running]
2025-11-28 00:24:40.217454 | controller | changed
2025-11-28 00:24:40.238654 | 
2025-11-28 00:24:40.238883 | TASK [ensure-docker : Assure docker.socket service is running]
2025-11-28 00:24:42.292802 | controller | ok
2025-11-28 00:24:42.309246 | 
2025-11-28 00:24:42.309375 | TASK [ensure-docker : Correct group ownership on docker sock]
2025-11-28 00:24:43.172489 | controller | ok
2025-11-28 00:24:43.185498 | 
2025-11-28 00:24:43.185670 | TASK [ensure-docker : Validate ability to talk with docker]
2025-11-28 00:24:43.799562 | controller | CONTAINER ID   IMAGE     COMMAND   CREATED   STATUS    PORTS     NAMES
2025-11-28 00:24:44.059776 | controller | ok: Runtime: 0:00:00.043277
2025-11-28 00:24:44.073220 | 
2025-11-28 00:24:44.073422 | TASK [ensure-docker : Get version details]
2025-11-28 00:24:44.822522 | controller | Client: Docker Engine - Community
2025-11-28 00:24:44.822623 | controller |  Version:           24.0.7
2025-11-28 00:24:44.822640 | controller |  API version:       1.43
2025-11-28 00:24:44.822648 | controller |  Go version:        go1.20.10
2025-11-28 00:24:44.822705 | controller |  Git commit:        afdd53b
2025-11-28 00:24:44.822715 | controller |  Built:             Thu Oct 26 09:09:39 2023
2025-11-28 00:24:44.822722 | controller |  OS/Arch:           linux/amd64
2025-11-28 00:24:44.822731 | controller |  Context:           default
2025-11-28 00:24:44.822739 | controller |
2025-11-28 00:24:44.822746 | controller | Server: Docker Engine - Community
2025-11-28 00:24:44.822752 | controller |  Engine:
2025-11-28 00:24:44.822758 | controller |   Version:          24.0.7
2025-11-28 00:24:44.822763 | controller |   API version:      1.43 (minimum version 1.12)
2025-11-28 00:24:44.822774 | controller |   Go version:       go1.20.10
2025-11-28 00:24:44.822781 | controller |   Git commit:       311b9ff
2025-11-28 00:24:44.822787 | controller |   Built:            Thu Oct 26 09:08:11 2023
2025-11-28 00:24:44.822793 | controller |   OS/Arch:          linux/amd64
2025-11-28 00:24:44.822801 | controller |   Experimental:     false
2025-11-28 00:24:44.822807 | controller |  containerd:
2025-11-28 00:24:44.822822 | controller |   Version:          1.6.25
2025-11-28 00:24:44.822828 | controller |   GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f
2025-11-28 00:24:44.822834 | controller |  runc:
2025-11-28 00:24:44.822843 | controller |   Version:          1.1.10
2025-11-28 00:24:44.824479 | controller |   GitCommit:        v1.1.10-0-g18a0cb0
2025-11-28 00:24:44.824499 | controller |  docker-init:
2025-11-28 00:24:44.824506 | controller |   Version:          0.19.0
2025-11-28 00:24:44.824512 | controller |   GitCommit:        de40ad0
2025-11-28 00:24:44.971758 | controller | ok: Runtime: 0:00:00.044267
2025-11-28 00:24:45.022372 | 
2025-11-28 00:24:45.022516 | TASK [ensure-docker : Dump installed docker details]
2025-11-28 00:24:45.055921 | {'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': '2025-11-28 00:24:44.780758', 'end': '2025-11-28 00:24:44.825025', 'delta': '0:00:00.044267', 'msg': '', 'zuul_log_id': 'fa163ec2-ffbe-5bf9-60ec-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}
2025-11-28 00:24:45.064391 | 
2025-11-28 00:24:45.064479 | TASK [Use buildset registry]
2025-11-28 00:24:45.079627 | controller | skipping: Conditional result was False
2025-11-28 00:24:45.098254 | 
2025-11-28 00:24:45.098393 | TASK [Ensure python3.8 is present]
2025-11-28 00:24:45.113505 | controller | skipping: Conditional result was False
2025-11-28 00:24:45.122709 | 
2025-11-28 00:24:45.122824 | TASK [Run our-ensure-python role (Fedora only for now)]
2025-11-28 00:24:45.150960 | controller | ok
2025-11-28 00:24:45.178776 | 
2025-11-28 00:24:45.178896 | TASK [our-ensure-python : Install the right Python version (rpm)]
2025-11-28 00:24:52.940390 | controller | ok: Nothing to do
2025-11-28 00:24:52.952785 | 
2025-11-28 00:24:52.952923 | TASK [our-ensure-python : Also install python3-devel]
2025-11-28 00:25:06.701619 | controller | changed
2025-11-28 00:25:06.734864 | 
2025-11-28 00:25:06.735066 | TASK [Run ensure-virtualenv role]
2025-11-28 00:25:06.764179 | controller | ok
2025-11-28 00:25:06.795197 | 
2025-11-28 00:25:06.795349 | TASK [ensure-virtualenv : Check if virtualenv is installed]
2025-11-28 00:25:07.535806 | controller | /usr/bin/virtualenv
2025-11-28 00:25:07.662735 | controller | ok: Runtime: 0:00:00.005318
2025-11-28 00:25:07.673087 | 
2025-11-28 00:25:07.673239 | LOOP [ensure-virtualenv : Install virtualenv package]
2025-11-28 00:25:07.697478 | controller | skipping: Conditional result was False
2025-11-28 00:25:07.697798 | controller | changed: All items complete
2025-11-28 00:25:07.697828 | 
2025-11-28 00:25:07.713457 | 
2025-11-28 00:25:07.713610 | TASK [Find the full path of the Python interpreter]
2025-11-28 00:25:08.335755 | controller | /usr/bin/python3.8
2025-11-28 00:25:08.575008 | controller | ok
2025-11-28 00:25:08.588415 | 
2025-11-28 00:25:08.588609 | TASK [Create virtualenv for ansible-test with a specific interpreter]
2025-11-28 00:25:11.434192 | controller | created virtual environment CPython3.8.18.final.0-64 in 1389ms
2025-11-28 00:25:11.646969 | controller |   creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False)
2025-11-28 00:25:11.647064 | 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)
2025-11-28 00:25:11.647077 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2025-11-28 00:25:11.647105 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2025-11-28 00:25:11.986342 | controller | changed
2025-11-28 00:25:11.994579 | 
2025-11-28 00:25:11.994675 | TASK [Set selinux package]
2025-11-28 00:25:12.027219 | controller | ok
2025-11-28 00:25:12.034839 | 
2025-11-28 00:25:12.034927 | TASK [Set selinux package (Fedora)]
2025-11-28 00:25:12.088536 | controller | ok
2025-11-28 00:25:12.098638 | 
2025-11-28 00:25:12.098800 | TASK [Install selinux into virtualenv]
2025-11-28 00:25:18.150597 | controller | Collecting selinux-please-lie-to-me
2025-11-28 00:25:18.272579 | controller |   Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB)
2025-11-28 00:25:19.009657 | controller | Collecting setuptools<50.0.0
2025-11-28 00:25:19.016026 | controller |   Downloading setuptools-49.6.0-py3-none-any.whl (803 kB)
2025-11-28 00:25:19.092273 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 11.8 MB/s eta 0:00:00
2025-11-28 00:25:19.205015 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me
2025-11-28 00:25:19.205360 | controller |   Attempting uninstall: setuptools
2025-11-28 00:25:19.206504 | controller |     Found existing installation: setuptools 62.6.0
2025-11-28 00:25:19.316905 | controller |     Uninstalling setuptools-62.6.0:
2025-11-28 00:25:19.330952 | controller |       Successfully uninstalled setuptools-62.6.0
2025-11-28 00:25:19.934261 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0
2025-11-28 00:25:20.109190 | controller |
2025-11-28 00:25:20.357047 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2025-11-28 00:25:20.357126 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2025-11-28 00:25:20.978403 | controller | ok: Runtime: 0:00:07.211010
2025-11-28 00:25:21.005859 | 
2025-11-28 00:25:21.006146 | TASK [Install pytest-forked into virtualenv]
2025-11-28 00:25:22.675527 | controller | Collecting pytest-forked
2025-11-28 00:25:22.730189 | controller |   Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB)
2025-11-28 00:25:22.911382 | controller | Collecting pytest>=3.10
2025-11-28 00:25:22.918267 | controller |   Downloading pytest-8.3.5-py3-none-any.whl (343 kB)
2025-11-28 00:25:22.955631 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 343.6/343.6 kB 10.7 MB/s eta 0:00:00
2025-11-28 00:25:23.008397 | controller | Collecting py
2025-11-28 00:25:23.014593 | controller |   Downloading py-1.11.0-py2.py3-none-any.whl (98 kB)
2025-11-28 00:25:23.024640 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 15.6 MB/s eta 0:00:00
2025-11-28 00:25:23.112150 | controller | Collecting tomli>=1
2025-11-28 00:25:23.118189 | controller |   Downloading tomli-2.3.0-py3-none-any.whl (14 kB)
2025-11-28 00:25:23.151549 | controller | Collecting iniconfig
2025-11-28 00:25:23.156496 | controller |   Downloading iniconfig-2.1.0-py3-none-any.whl (6.0 kB)
2025-11-28 00:25:23.204183 | controller | Collecting pluggy<2,>=1.5
2025-11-28 00:25:23.209358 | controller |   Downloading pluggy-1.5.0-py3-none-any.whl (20 kB)
2025-11-28 00:25:23.273887 | controller | Collecting packaging
2025-11-28 00:25:23.279880 | controller |   Downloading packaging-25.0-py3-none-any.whl (66 kB)
2025-11-28 00:25:23.288996 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 11.4 MB/s eta 0:00:00
2025-11-28 00:25:23.335259 | controller | Collecting exceptiongroup>=1.0.0rc8
2025-11-28 00:25:23.340997 | controller |   Downloading exceptiongroup-1.3.1-py3-none-any.whl (16 kB)
2025-11-28 00:25:23.414445 | controller | Collecting typing-extensions>=4.6.0
2025-11-28 00:25:23.420731 | controller |   Downloading typing_extensions-4.13.2-py3-none-any.whl (45 kB)
2025-11-28 00:25:23.428892 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.8/45.8 kB 8.9 MB/s eta 0:00:00
2025-11-28 00:25:23.519536 | controller | Installing collected packages: typing-extensions, tomli, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked
2025-11-28 00:25:24.297828 | controller | Successfully installed exceptiongroup-1.3.1 iniconfig-2.1.0 packaging-25.0 pluggy-1.5.0 py-1.11.0 pytest-8.3.5 pytest-forked-1.6.0 tomli-2.3.0 typing-extensions-4.13.2
2025-11-28 00:25:24.303668 | controller |
2025-11-28 00:25:24.618541 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2025-11-28 00:25:24.618594 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2025-11-28 00:25:24.874400 | controller | ok: Runtime: 0:00:02.701687
2025-11-28 00:25:24.893785 | 
2025-11-28 00:25:24.893919 | TASK [Update pip]
2025-11-28 00:25:27.465108 | controller | Requirement already satisfied: pip in ./venv/lib/python3.8/site-packages (22.2.2)
2025-11-28 00:25:27.948774 | controller | Collecting pip
2025-11-28 00:25:28.069765 | controller |   Downloading pip-25.0.1-py3-none-any.whl (1.8 MB)
2025-11-28 00:25:28.192405 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 16.3 MB/s eta 0:00:00
2025-11-28 00:25:28.416035 | controller | Installing collected packages: pip
2025-11-28 00:25:28.416302 | controller |   Attempting uninstall: pip
2025-11-28 00:25:28.418386 | controller |     Found existing installation: pip 22.2.2
2025-11-28 00:25:29.128203 | controller |     Uninstalling pip-22.2.2:
2025-11-28 00:25:29.205064 | controller |       Successfully uninstalled pip-22.2.2
2025-11-28 00:25:31.841057 | controller | Successfully installed pip-25.0.1
2025-11-28 00:25:32.264683 | controller | ok: Runtime: 0:00:06.063581
2025-11-28 00:25:32.275453 | 
2025-11-28 00:25:32.275616 | TASK [Ensure pip temp directory exists in /var/tmp]
2025-11-28 00:25:33.512466 | controller | changed
2025-11-28 00:25:33.520923 | 
2025-11-28 00:25:33.521068 | TASK [Install ansible into virtualenv]
2025-11-28 00:25:35.302238 | controller | Processing ./src/github.com/ansible/ansible
2025-11-28 00:25:35.303631 | controller |   Preparing metadata (setup.py): started
2025-11-28 00:25:36.956876 | controller |   Preparing metadata (setup.py): finished with status 'done'
2025-11-28 00:25:37.016567 | controller | Collecting jinja2 (from ansible==2.9.27.post0)
2025-11-28 00:25:37.031645 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB)
2025-11-28 00:25:37.105533 | controller | Collecting PyYAML (from ansible==2.9.27.post0)
2025-11-28 00:25:37.111699 | 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)
2025-11-28 00:25:37.495108 | controller | Collecting cryptography (from ansible==2.9.27.post0)
2025-11-28 00:25:37.499896 | controller |   Downloading cryptography-46.0.3-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB)
2025-11-28 00:25:37.720497 | controller | Collecting cffi>=1.14 (from cryptography->ansible==2.9.27.post0)
2025-11-28 00:25:37.725081 | controller |   Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB)
2025-11-28 00:25:37.733376 | 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)
2025-11-28 00:25:37.836244 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible==2.9.27.post0)
2025-11-28 00:25:37.840472 | controller |   Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (3.0 kB)
2025-11-28 00:25:37.864656 | controller | Collecting pycparser (from cffi>=1.14->cryptography->ansible==2.9.27.post0)
2025-11-28 00:25:37.869091 | controller |   Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes)
2025-11-28 00:25:37.884315 | controller | Downloading cryptography-46.0.3-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2025-11-28 00:25:37.930552 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 113.4 MB/s eta 0:00:00
2025-11-28 00:25:37.936126 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2025-11-28 00:25:37.948526 | controller | Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB)
2025-11-28 00:25:37.963897 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.0/806.0 kB 56.5 MB/s eta 0:00:00
2025-11-28 00:25:37.970008 | controller | Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB)
2025-11-28 00:25:37.984000 | controller | Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (26 kB)
2025-11-28 00:25:37.993761 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB)
2025-11-28 00:25:38.019718 | controller | Building wheels for collected packages: ansible
2025-11-28 00:25:38.020580 | controller |   Building wheel for ansible (setup.py): started
2025-11-28 00:25:47.575620 | controller |   Building wheel for ansible (setup.py): finished with status 'done'
2025-11-28 00:25:47.596602 | controller |   Created wheel for ansible: filename=ansible-2.9.27.post0-py3-none-any.whl size=16207514 sha256=4a3dc48582174890e10372d203a77c5e8c81b38ded6e37282c1dd118c1b30666
2025-11-28 00:25:47.597017 | controller |   Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-cl_oxrqn/wheels/a5/4b/fa/b6deaae105422b0b3b92831e0369d44bf7fca5bb3413d79be7
2025-11-28 00:25:47.674698 | controller | Successfully built ansible
2025-11-28 00:25:47.856856 | controller | Installing collected packages: PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible
2025-11-28 00:26:01.310612 | controller | Successfully installed MarkupSafe-2.1.5 PyYAML-6.0.3 ansible-2.9.27.post0 cffi-1.17.1 cryptography-46.0.3 jinja2-3.1.6 pycparser-2.23
2025-11-28 00:26:01.902965 | controller | ok: Runtime: 0:00:27.071887
2025-11-28 00:26:01.918164 | 
2025-11-28 00:26:01.918365 | TASK [Setup download-artifact-fork role]
2025-11-28 00:26:01.950618 | controller | ok
2025-11-28 00:26:01.990147 | 
2025-11-28 00:26:01.990505 | TASK [download-artifact-fork : Parse inventory response]
2025-11-28 00:26:02.036237 | controller | ok
2025-11-28 00:26:02.045828 | 
2025-11-28 00:26:02.046040 | TASK [download-artifact-fork : Fetch info from Zuul API]
2025-11-28 00:26:02.081838 | controller | skipping: Conditional result was False
2025-11-28 00:26:02.089546 | 
2025-11-28 00:26:02.089709 | TASK [download-artifact-fork : Parse build response]
2025-11-28 00:26:02.116491 | controller | skipping: Conditional result was False
2025-11-28 00:26:02.125817 | 
2025-11-28 00:26:02.125925 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2025-11-28 00:26:02.915206 | controller | changed
2025-11-28 00:26:02.928585 | 
2025-11-28 00:26:02.928792 | LOOP [download-artifact-fork : Download archive by type]
2025-11-28 00:26:02.968288 | controller | skipping: Conditional result was False
2025-11-28 00:26:02.968933 | 
2025-11-28 00:26:05.630115 | controller | changed: OK (20197 bytes)
2025-11-28 00:26:05.660286 | 
2025-11-28 00:26:05.660498 | TASK [deploy-artifacts : define __collections]
2025-11-28 00:26:05.690927 | controller | ok
2025-11-28 00:26:05.703954 | 
2025-11-28 00:26:05.704188 | LOOP [deploy-artifacts : Create list of collections]
2025-11-28 00:26:05.731917 | controller | skipping: Conditional result was False
2025-11-28 00:26:05.748453 | controller | ok:
2025-11-28 00:26:05.748588 | controller | {
2025-11-28 00:26:05.748636 | controller |   "branch": "main",
2025-11-28 00:26:05.748675 | controller |   "job": "build-ansible-collection",
2025-11-28 00:26:05.748712 | controller |   "metadata": {
2025-11-28 00:26:05.748748 | controller |     "type": "ansible_collection",
2025-11-28 00:26:05.748783 | controller |     "version": "5.0.0"
2025-11-28 00:26:05.748817 | controller |   },
2025-11-28 00:26:05.748851 | controller |   "name": "ansible.network",
2025-11-28 00:26:05.748886 | controller |   "project": "ansible-collections/ansible.network",
2025-11-28 00:26:05.748920 | controller |   "url": "https://fffe8cccde5ccce4b0b1-e741c22f6c3afb4d17467236bf7c8cfd.ssl.cf5.rackcdn.com/ansible/7fba9e5b294640c392afbc3922d334cd/artifacts/ansible-network-5.0.0.tar.gz"
2025-11-28 00:26:05.748965 | controller | }
2025-11-28 00:26:05.802644 | 
2025-11-28 00:26:05.802817 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2025-11-28 00:26:06.882476 | controller | Process install dependency map
2025-11-28 00:26:57.511615 | controller | |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\Starting collection install process
2025-11-28 00:26:57.612773 | controller | |Installing 'ansible.network:5.0.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/network'
2025-11-28 00:26:57.612855 | controller | Installing 'ansible.netcommon:8.2.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2025-11-28 00:26:59.142899 | controller | /-\|/-\|/-\|/-\Installing 'ansible.utils:6.0.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2025-11-28 00:27:00.670990 | controller | |/-\|/-\|/-\|/-Installing 'arista.eos:12.0.0' to '/home/zuul/.ansible/collections/ansible_collections/arista/eos'
2025-11-28 00:27:03.087632 | controller | \|/-\|/-\|/-\|/-\|/-\|/-Installing 'cisco.ios:11.1.1' to '/home/zuul/.ansible/collections/ansible_collections/cisco/ios'
2025-11-28 00:27:05.936153 | controller | \|/-\|/-\|/-\|/-\|/-\|/-\|/-Installing 'cisco.iosxr:12.1.0' to '/home/zuul/.ansible/collections/ansible_collections/cisco/iosxr'
2025-11-28 00:27:08.555476 | controller | \|/-\|/-\|/-\|/-\|/-\|/-\|Installing 'cisco.nxos:11.1.0' to '/home/zuul/.ansible/collections/ansible_collections/cisco/nxos'
2025-11-28 00:27:12.509244 | controller | /-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\Installing 'junipernetworks.junos:11.0.0' to '/home/zuul/.ansible/collections/ansible_collections/junipernetworks/junos'
2025-11-28 00:27:15.700534 | controller | ok: Runtime: 0:01:08.681212
2025-11-28 00:27:15.718722 | 
2025-11-28 00:27:15.718921 | TASK [podman may need iptables kernel modules]
2025-11-28 00:27:17.083481 | controller | ok: Runtime: 0:00:00.006481
2025-11-28 00:27:17.106489 | 
2025-11-28 00:27:17.106584 | PLAY RECAP
2025-11-28 00:27:17.106626 | controller | ok: 46 changed: 26 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0
2025-11-28 00:27:17.106648 | 
2025-11-28 00:27:17.241367 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2025-11-28 00:27:17.242335 | RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2025-11-28 00:27:17.878621 | 
2025-11-28 00:27:17.878745 | PLAY [controller]
2025-11-28 00:27:17.900840 | 
2025-11-28 00:27:17.900963 | TASK [Copy the galaxy.yml on the controller]
2025-11-28 00:27:21.714727 | controller | changed
2025-11-28 00:27:21.722429 | 
2025-11-28 00:27:21.722516 | TASK [Load information from galaxy.yml]
2025-11-28 00:27:21.757531 | controller | ok
2025-11-28 00:27:21.763606 | 
2025-11-28 00:27:21.763668 | LOOP [Enable FIPS mode]
2025-11-28 00:27:21.785009 | 
2025-11-28 00:27:21.785194 | LOOP [ansible-test : Include branch specific variables.]
2025-11-28 00:27:21.812500 | controller | ok: "/var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/untrusted/project_2/github.com/ansible/ansible-zuul-jobs/roles/ansible-test/vars/default.yaml"
2025-11-28 00:27:21.812654 | 
2025-11-28 00:27:21.826497 | 
2025-11-28 00:27:21.826996 | TASK [ansible-test : Setup --skip-tags for test_options]
2025-11-28 00:27:21.870326 | controller | ok
2025-11-28 00:27:21.879439 | 
2025-11-28 00:27:21.879576 | TASK [ansible-test : Enable --inventory for network-integration]
2025-11-28 00:27:21.903709 | controller | skipping: Conditional result was False
2025-11-28 00:27:21.911320 | 
2025-11-28 00:27:21.911419 | TASK [ansible-test : Enable --retry-on-error]
2025-11-28 00:27:21.935460 | controller | skipping: Conditional result was False
2025-11-28 00:27:21.946100 | 
2025-11-28 00:27:21.946251 | TASK [ansible-test : Enable --continue-on-error]
2025-11-28 00:27:21.982437 | controller | ok
2025-11-28 00:27:21.991065 | 
2025-11-28 00:27:21.991191 | TASK [ansible-test : Enable --requirements]
2025-11-28 00:27:22.006249 | controller | skipping: Conditional result was False
2025-11-28 00:27:22.015169 | 
2025-11-28 00:27:22.015283 | TASK [ansible-test : Adjust options for unit tests]
2025-11-28 00:27:22.029631 | controller | skipping: Conditional result was False
2025-11-28 00:27:22.043988 | 
2025-11-28 00:27:22.044139 | TASK [ansible-test : Install requirements with unit tests]
2025-11-28 00:27:22.104451 | controller | ok
2025-11-28 00:27:22.110042 | 
2025-11-28 00:27:22.110115 | TASK [ansible-test : Set --skip-test]
2025-11-28 00:27:22.165359 | controller | skipping: Conditional result was False
2025-11-28 00:27:22.175094 | 
2025-11-28 00:27:22.175234 | TASK [ansible-test : Reduce verbosity]
2025-11-28 00:27:22.212217 | controller | ok
2025-11-28 00:27:22.220784 | 
2025-11-28 00:27:22.220921 | TASK [ansible-test : Setup --python option]
2025-11-28 00:27:22.291918 | controller | skipping: Conditional result was False
2025-11-28 00:27:22.306759 | 
2025-11-28 00:27:22.306909 | TASK [ansible-test : Setup --docker option]
2025-11-28 00:27:22.367445 | controller | ok
2025-11-28 00:27:22.375139 | 
2025-11-28 00:27:22.375242 | TASK [ansible-test : check if MANIFEST.json exists]
2025-11-28 00:27:23.355062 | controller | ok
2025-11-28 00:27:23.364982 | 
2025-11-28 00:27:23.365138 | TASK [ansible-test : Copy the MANIFEST.json on the controller]
2025-11-28 00:27:23.382276 | controller | skipping: Conditional result was False
2025-11-28 00:27:23.390355 | 
2025-11-28 00:27:23.390438 | TASK [ansible-test : Load information from MANIFEST.json]
2025-11-28 00:27:23.425252 | controller | skipping: Conditional result was False
2025-11-28 00:27:23.435245 | 
2025-11-28 00:27:23.435397 | TASK [ansible-test : Setup location of project for integration tests]
2025-11-28 00:27:23.462042 | controller | skipping: Conditional result was False
2025-11-28 00:27:23.468975 | 
2025-11-28 00:27:23.469143 | TASK [ansible-test : Copy the galaxy.yml on the controller]
2025-11-28 00:27:24.775906 | controller | ok
2025-11-28 00:27:24.785426 | 
2025-11-28 00:27:24.785605 | TASK [ansible-test : Load information from galaxy.yml]
2025-11-28 00:27:24.830323 | controller | ok
2025-11-28 00:27:24.839210 | 
2025-11-28 00:27:24.839330 | TASK [ansible-test : Setup location of project for integration tests]
2025-11-28 00:27:24.880195 | controller | ok
2025-11-28 00:27:24.885547 | 
2025-11-28 00:27:24.885616 | TASK [ansible-test : Setup minimum test requirements]
2025-11-28 00:27:24.915408 | controller | ok
2025-11-28 00:27:24.921528 | 
2025-11-28 00:27:24.921609 | TASK [ansible-test : Ensure pip temp directory exists in /var/tmp]
2025-11-28 00:27:25.955169 | controller | ok
2025-11-28 00:27:25.964192 | 
2025-11-28 00:27:25.964298 | TASK [ansible-test : Install python requirements]
2025-11-28 00:27:27.370035 | controller | Collecting yamllint (from -r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2025-11-28 00:27:27.388318 | controller |   Downloading yamllint-1.35.1-py3-none-any.whl.metadata (4.2 kB)
2025-11-28 00:27:27.417065 | controller | Collecting pathspec>=0.5.3 (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2025-11-28 00:27:27.422381 | controller |   Downloading pathspec-0.12.1-py3-none-any.whl.metadata (21 kB)
2025-11-28 00:27:27.431515 | 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)
2025-11-28 00:27:27.439132 | controller | Downloading yamllint-1.35.1-py3-none-any.whl (66 kB)
2025-11-28 00:27:27.451086 | controller | Downloading pathspec-0.12.1-py3-none-any.whl (31 kB)
2025-11-28 00:27:27.508616 | controller | Installing collected packages: pathspec, yamllint
2025-11-28 00:27:27.593578 | controller | Successfully installed pathspec-0.12.1 yamllint-1.35.1
2025-11-28 00:27:28.319550 | controller | ok: Runtime: 0:00:00.921229
2025-11-28 00:27:28.327228 | 
2025-11-28 00:27:28.327380 | TASK [ansible-test : Copy the integration_config.yml file from the controller]
2025-11-28 00:27:29.070966 | controller | cp: cannot stat '/tmp/integration_config.yml': No such file or directory
2025-11-28 00:27:29.689754 | controller | ERROR
2025-11-28 00:27:29.689962 | controller | {
2025-11-28 00:27:29.689991 | controller |   "delta": "0:00:00.009192",
2025-11-28 00:27:29.690010 | controller |   "end": "2025-11-28 00:27:29.071223",
2025-11-28 00:27:29.690064 | controller |   "msg": "non-zero return code",
2025-11-28 00:27:29.690083 | controller |   "rc": 1,
2025-11-28 00:27:29.690099 | controller |   "start": "2025-11-28 00:27:29.062031"
2025-11-28 00:27:29.690115 | controller | }
2025-11-28 00:27:29.690140 | controller | ERROR: Ignoring Errors
2025-11-28 00:27:29.696686 | 
2025-11-28 00:27:29.697285 | TASK [ansible-test : Copy potential cloud provider configuration for ansible-test in the collection]
2025-11-28 00:27:30.058243 | controller | skipping: Conditional result was False
2025-11-28 00:27:30.089601 | 
2025-11-28 00:27:30.089857 | TASK [ansible-test : Enable persistent connection logging]
2025-11-28 00:27:31.417984 | controller | changed: section and option added
2025-11-28 00:27:31.425534 | 
2025-11-28 00:27:31.425624 | TASK [ansible-test : Set persistent ssh_type value]
2025-11-28 00:27:32.536931 | controller | changed: option added
2025-11-28 00:27:32.550740 | 
2025-11-28 00:27:32.550927 | TASK [ansible-test : Set ansible log path]
2025-11-28 00:27:33.689648 | controller | changed: section and option added
2025-11-28 00:27:33.695812 | 
2025-11-28 00:27:33.695904 | TASK [ansible-test : Identify the changed targets]
2025-11-28 00:27:34.057510 | controller | skipping: Conditional result was False
2025-11-28 00:27:34.067631 | 
2025-11-28 00:27:34.067744 | TASK [ansible-test : set_fact]
2025-11-28 00:27:34.133732 | controller | skipping: Conditional result was False
2025-11-28 00:27:34.142827 | 
2025-11-28 00:27:34.142999 | TASK [ansible-test : Set the targets]
2025-11-28 00:27:34.191832 | controller | ok
2025-11-28 00:27:34.208262 | 
2025-11-28 00:27:34.208455 | TASK [ansible-test : set_fact]
2025-11-28 00:27:34.236131 | controller | skipping: Conditional result was False
2025-11-28 00:27:34.292519 | 
2025-11-28 00:27:34.292723 | TASK [ansible-test : List the targets]
2025-11-28 00:27:34.676880 | controller | skipping: Conditional result was False
2025-11-28 00:27:34.683908 | 
2025-11-28 00:27:34.684006 | TASK [ansible-test : set_fact]
2025-11-28 00:27:34.709410 | controller | skipping: Conditional result was False
2025-11-28 00:27:34.716167 | 
2025-11-28 00:27:34.716238 | TASK [ansible-test : set_fact]
2025-11-28 00:27:34.730682 | controller | skipping: Conditional result was False
2025-11-28 00:27:34.739786 | 
2025-11-28 00:27:34.739881 | LOOP [ansible-test : set_fact]
2025-11-28 00:27:34.795253 | 
2025-11-28 00:27:34.795480 | TASK [ansible-test : set_fact]
2025-11-28 00:27:34.812571 | controller | skipping: Conditional result was False
2025-11-28 00:27:34.829450 | 
2025-11-28 00:27:34.829579 | TASK [ansible-test : debug]
2025-11-28 00:27:34.844573 | controller | skipping: Conditional result was False
2025-11-28 00:27:34.851320 | 
2025-11-28 00:27:34.851395 | TASK [ansible-test : debug]
2025-11-28 00:27:34.881076 | About to run: ansible-test sanity --requirements --docker -v
2025-11-28 00:27:34.888785 | 
2025-11-28 00:27:34.888867 | TASK [ansible-test : Run the test suite]
2025-11-28 00:27:36.118282 | controller | Run command: docker images quay.io/ansible/default-test-container:1.10.1 --format '{{json .}}'
2025-11-28 00:27:36.212824 | controller | Run command: docker pull quay.io/ansible/default-test-container:1.10.1
2025-11-28 00:27:38.056943 | controller | 1.10.1: Pulling from ansible/default-test-container
2025-11-28 00:27:38.058727 | 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/
2025-11-28 00:27:38.058765 | controller | 5667fdb72017: Pulling fs layer
2025-11-28 00:27:38.058866 | controller | d83811f270d5: Pulling fs layer
2025-11-28 00:27:38.058879 | controller | ee671aafb583: Pulling fs layer
2025-11-28 00:27:38.058889 | controller | 7fc152dfb3a6: Pulling fs layer
2025-11-28 00:27:38.058897 | controller | 3fb967a6fd03: Pulling fs layer
2025-11-28 00:27:38.058903 | controller | b3e63023ca5f: Pulling fs layer
2025-11-28 00:27:38.058909 | controller | 653cb3e65dbf: Pulling fs layer
2025-11-28 00:27:38.058918 | controller | f4712b586375: Pulling fs layer
2025-11-28 00:27:38.059436 | controller | d696ed7812f8: Pulling fs layer
2025-11-28 00:27:38.059450 | controller | 29bf28764f14: Pulling fs layer
2025-11-28 00:27:38.059457 | controller | 47d7edb3c2b7: Pulling fs layer
2025-11-28 00:27:38.059466 | controller | 07550ad4f6e4: Pulling fs layer
2025-11-28 00:27:38.059538 | controller | 7e79526e64c5: Pulling fs layer
2025-11-28 00:27:38.059604 | controller | 4fffb32882b7: Pulling fs layer
2025-11-28 00:27:38.059711 | controller | fc7a38b06f4e: Pulling fs layer
2025-11-28 00:27:38.059784 | controller | 6d9d912e060e: Pulling fs layer
2025-11-28 00:27:38.059868 | controller | 5dd542dd28d9: Pulling fs layer
2025-11-28 00:27:38.059930 | controller | cef8beb99552: Pulling fs layer
2025-11-28 00:27:38.059985 | controller | bd5557e101ad: Pulling fs layer
2025-11-28 00:27:38.060144 | controller | e057c20fabdd: Pulling fs layer
2025-11-28 00:27:38.060213 | controller | d16059cdae2e: Pulling fs layer
2025-11-28 00:27:38.060291 | controller | 431e42d906a3: Pulling fs layer
2025-11-28 00:27:38.060344 | controller | 7a0fd3b1d7c3: Pulling fs layer
2025-11-28 00:27:38.060422 | controller | aacdb6db0c8c: Pulling fs layer
2025-11-28 00:27:38.060472 | controller | 2e7f04ae8c8b: Pulling fs layer
2025-11-28 00:27:38.060548 | controller | 4cd343027a44: Pulling fs layer
2025-11-28 00:27:38.060601 | controller | 0b4379883f90: Pulling fs layer
2025-11-28 00:27:38.060685 | controller | 3d9d6d9dfc91: Pulling fs layer
2025-11-28 00:27:38.060774 | controller | 57d6314bd293: Pulling fs layer
2025-11-28 00:27:38.060865 | controller | 774036afeb7f: Pulling fs layer
2025-11-28 00:27:38.060919 | controller | 54b10f0e1645: Pulling fs layer
2025-11-28 00:27:38.060995 | controller | 78cf439d9fdb: Pulling fs layer
2025-11-28 00:27:38.061162 | controller | 36e5e20969c7: Pulling fs layer
2025-11-28 00:27:38.061282 | controller | 4b19ac3f17a8: Pulling fs layer
2025-11-28 00:27:38.061294 | controller | 7fc152dfb3a6: Waiting
2025-11-28 00:27:38.061300 | controller | 3fb967a6fd03: Waiting
2025-11-28 00:27:38.061310 | controller | b3e63023ca5f: Waiting
2025-11-28 00:27:38.061316 | controller | 653cb3e65dbf: Waiting
2025-11-28 00:27:38.061322 | controller | f4712b586375: Waiting
2025-11-28 00:27:38.061328 | controller | d696ed7812f8: Waiting
2025-11-28 00:27:38.061336 | controller | 29bf28764f14: Waiting
2025-11-28 00:27:38.061426 | controller | 47d7edb3c2b7: Waiting
2025-11-28 00:27:38.061439 | controller | 07550ad4f6e4: Waiting
2025-11-28 00:27:38.061543 | controller | 7e79526e64c5: Waiting
2025-11-28 00:27:38.061650 | controller | 4fffb32882b7: Waiting
2025-11-28 00:27:38.062390 | controller | fc7a38b06f4e: Waiting
2025-11-28 00:27:38.890241 | controller | 6d9d912e060e: Waiting
2025-11-28 00:27:38.890310 | controller | 5dd542dd28d9: Waiting
2025-11-28 00:27:38.890325 | controller | cef8beb99552: Waiting
2025-11-28 00:27:38.890331 | controller | bd5557e101ad: Waiting
2025-11-28 00:27:38.890336 | controller | e057c20fabdd: Waiting
2025-11-28 00:27:38.890343 | controller | d16059cdae2e: Waiting
2025-11-28 00:27:38.890348 | controller | 431e42d906a3: Waiting
2025-11-28 00:27:38.890379 | controller | 7a0fd3b1d7c3: Waiting
2025-11-28 00:27:38.890388 | controller | aacdb6db0c8c: Waiting
2025-11-28 00:27:38.890394 | controller | 2e7f04ae8c8b: Waiting
2025-11-28 00:27:38.890400 | controller | 4cd343027a44: Waiting
2025-11-28 00:27:38.890407 | controller | 0b4379883f90: Waiting
2025-11-28 00:27:38.890413 | controller | 3d9d6d9dfc91: Waiting
2025-11-28 00:27:38.890418 | controller | 57d6314bd293: Waiting
2025-11-28 00:27:38.890445 | controller | 774036afeb7f: Waiting
2025-11-28 00:27:38.890490 | controller | 54b10f0e1645: Waiting
2025-11-28 00:27:38.890499 | controller | 78cf439d9fdb: Waiting
2025-11-28 00:27:38.890505 | controller | 36e5e20969c7: Waiting
2025-11-28 00:27:38.890512 | controller | 4b19ac3f17a8: Waiting
2025-11-28 00:27:38.890528 | controller | ee671aafb583: Verifying Checksum
2025-11-28 00:27:39.085235 | controller | ee671aafb583: Download complete
2025-11-28 00:27:39.085319 | controller | d83811f270d5: Verifying Checksum
2025-11-28 00:27:39.728297 | controller | d83811f270d5: Download complete
2025-11-28 00:27:39.728538 | controller | 7fc152dfb3a6: Download complete
2025-11-28 00:27:40.427219 | controller | b3e63023ca5f: Verifying Checksum
2025-11-28 00:27:41.133875 | controller | b3e63023ca5f: Download complete
2025-11-28 00:27:41.133959 | controller | 653cb3e65dbf: Verifying Checksum
2025-11-28 00:27:43.328623 | controller | 653cb3e65dbf: Download complete
2025-11-28 00:27:43.328716 | controller | 5667fdb72017: Verifying Checksum
2025-11-28 00:27:43.328769 | controller | 5667fdb72017: Download complete
2025-11-28 00:27:44.201248 | controller | d696ed7812f8: Verifying Checksum
2025-11-28 00:27:44.416784 | controller | d696ed7812f8: Download complete
2025-11-28 00:27:44.416841 | controller | 3fb967a6fd03: Verifying Checksum
2025-11-28 00:27:45.017494 | controller | 3fb967a6fd03: Download complete
2025-11-28 00:27:45.017567 | controller | 29bf28764f14: Verifying Checksum
2025-11-28 00:27:45.017647 | controller | 29bf28764f14: Download complete
2025-11-28 00:27:45.618147 | controller | 47d7edb3c2b7: Verifying Checksum
2025-11-28 00:27:45.618247 | controller | 47d7edb3c2b7: Download complete
2025-11-28 00:27:45.787120 | controller | 07550ad4f6e4: Verifying Checksum
2025-11-28 00:27:45.787270 | controller | 07550ad4f6e4: Download complete
2025-11-28 00:27:45.999840 | controller | 5667fdb72017: Pull complete
2025-11-28 00:27:46.039957 | controller | d83811f270d5: Pull complete
2025-11-28 00:27:46.064929 | controller | ee671aafb583: Pull complete
2025-11-28 00:27:46.097954 | controller | 7fc152dfb3a6: Pull complete
2025-11-28 00:27:46.356326 | controller | 7e79526e64c5: Verifying Checksum
2025-11-28 00:27:46.357135 | controller | 7e79526e64c5: Download complete
2025-11-28 00:27:46.657752 | controller | 4fffb32882b7: Verifying Checksum
2025-11-28 00:27:46.657806 | controller | 4fffb32882b7: Download complete
2025-11-28 00:27:46.908849 | controller | 3fb967a6fd03: Pull complete
2025-11-28 00:27:46.946800 | controller | b3e63023ca5f: Pull complete
2025-11-28 00:27:46.983464 | controller | 653cb3e65dbf: Pull complete
2025-11-28 00:27:47.487810 | controller | 6d9d912e060e: Verifying Checksum
2025-11-28 00:27:48.029903 | controller | 6d9d912e060e: Download complete
2025-11-28 00:27:48.029971 | controller | fc7a38b06f4e: Verifying Checksum
2025-11-28 00:27:48.287636 | controller | fc7a38b06f4e: Download complete
2025-11-28 00:27:48.287727 | controller | 5dd542dd28d9: Verifying Checksum
2025-11-28 00:27:49.026013 | controller | 5dd542dd28d9: Download complete
2025-11-28 00:27:49.026078 | controller | bd5557e101ad: Verifying Checksum
2025-11-28 00:27:49.779049 | controller | bd5557e101ad: Download complete
2025-11-28 00:27:49.779114 | controller | e057c20fabdd: Verifying Checksum
2025-11-28 00:27:50.522801 | controller | e057c20fabdd: Download complete
2025-11-28 00:27:50.522864 | controller | d16059cdae2e: Verifying Checksum
2025-11-28 00:27:52.685726 | controller | d16059cdae2e: Download complete
2025-11-28 00:27:52.685791 | controller | 431e42d906a3: Verifying Checksum
2025-11-28 00:27:53.952345 | controller | 431e42d906a3: Download complete
2025-11-28 00:27:53.952434 | controller | 7a0fd3b1d7c3: Verifying Checksum
2025-11-28 00:27:53.952478 | controller | 7a0fd3b1d7c3: Download complete
2025-11-28 00:27:54.788605 | controller | aacdb6db0c8c: Verifying Checksum
2025-11-28 00:27:54.788790 | controller | aacdb6db0c8c: Download complete
2025-11-28 00:27:55.559244 | controller | 2e7f04ae8c8b: Verifying Checksum
2025-11-28 00:27:55.559339 | controller | 2e7f04ae8c8b: Download complete
2025-11-28 00:27:56.354307 | controller | 4cd343027a44: Verifying Checksum
2025-11-28 00:27:56.354405 | controller | 4cd343027a44: Download complete
2025-11-28 00:27:57.170838 | controller | 0b4379883f90: Verifying Checksum
2025-11-28 00:27:57.171024 | controller | 0b4379883f90: Download complete
2025-11-28 00:27:58.023008 | controller | 3d9d6d9dfc91: Verifying Checksum
2025-11-28 00:27:58.023111 | controller | 3d9d6d9dfc91: Download complete
2025-11-28 00:28:03.668109 | controller | f4712b586375: Verifying Checksum
2025-11-28 00:28:03.668253 | controller | f4712b586375: Download complete
2025-11-28 00:28:10.425478 | controller | 57d6314bd293: Verifying Checksum
2025-11-28 00:28:10.425583 | controller | 57d6314bd293: Download complete
2025-11-28 00:28:16.854281 | controller | 774036afeb7f: Verifying Checksum
2025-11-28 00:28:16.858317 | controller | 774036afeb7f: Download complete
2025-11-28 00:28:20.351660 | controller | 54b10f0e1645: Verifying Checksum
2025-11-28 00:28:22.681389 | controller | 54b10f0e1645: Download complete
2025-11-28 00:28:22.681486 | controller | cef8beb99552: Verifying Checksum
2025-11-28 00:28:25.514984 | controller | cef8beb99552: Download complete
2025-11-28 00:28:25.515065 | controller | f4712b586375: Pull complete
2025-11-28 00:28:25.577155 | controller | d696ed7812f8: Pull complete
2025-11-28 00:28:25.627638 | controller | 29bf28764f14: Pull complete
2025-11-28 00:28:25.679202 | controller | 47d7edb3c2b7: Pull complete
2025-11-28 00:28:25.708953 | controller | 07550ad4f6e4: Pull complete
2025-11-28 00:28:25.735041 | controller | 7e79526e64c5: Pull complete
2025-11-28 00:28:25.766089 | controller | 4fffb32882b7: Pull complete
2025-11-28 00:28:25.877209 | controller | fc7a38b06f4e: Pull complete
2025-11-28 00:28:25.906794 | controller | 6d9d912e060e: Pull complete
2025-11-28 00:28:25.928631 | controller | 5dd542dd28d9: Pull complete
2025-11-28 00:28:29.417382 | controller | 78cf439d9fdb: Verifying Checksum
2025-11-28 00:28:30.718278 | controller | 78cf439d9fdb: Download complete
2025-11-28 00:28:30.718363 | controller | 4b19ac3f17a8: Verifying Checksum
2025-11-28 00:28:38.386327 | controller | 4b19ac3f17a8: Download complete
2025-11-28 00:28:38.386436 | controller | 36e5e20969c7: Verifying Checksum
2025-11-28 00:28:38.386645 | controller | 36e5e20969c7: Download complete
2025-11-28 00:28:50.510699 | controller | cef8beb99552: Pull complete
2025-11-28 00:28:50.577727 | controller | bd5557e101ad: Pull complete
2025-11-28 00:28:50.652478 | controller | e057c20fabdd: Pull complete
2025-11-28 00:28:50.725847 | controller | d16059cdae2e: Pull complete
2025-11-28 00:28:52.858413 | controller | 431e42d906a3: Pull complete
2025-11-28 00:28:52.925346 | controller | 7a0fd3b1d7c3: Pull complete
2025-11-28 00:28:52.982383 | controller | aacdb6db0c8c: Pull complete
2025-11-28 00:28:53.024381 | controller | 2e7f04ae8c8b: Pull complete
2025-11-28 00:28:53.061546 | controller | 4cd343027a44: Pull complete
2025-11-28 00:28:53.106753 | controller | 0b4379883f90: Pull complete
2025-11-28 00:28:53.145344 | controller | 3d9d6d9dfc91: Pull complete
2025-11-28 00:28:58.568346 | controller | 57d6314bd293: Pull complete
2025-11-28 00:29:20.723795 | controller | 774036afeb7f: Pull complete
2025-11-28 00:29:47.716709 | controller | 54b10f0e1645: Pull complete
2025-11-28 00:30:13.735804 | controller | 78cf439d9fdb: Pull complete
2025-11-28 00:30:39.778720 | controller | 36e5e20969c7: Pull complete
2025-11-28 00:31:07.763549 | controller | 4b19ac3f17a8: Pull complete
2025-11-28 00:31:07.789644 | controller | Digest: sha256:954c4edffb0905df64e23c8611b1c4a62db9af13062f51cad5b658e727238d41
2025-11-28 00:31:07.794458 | controller | Status: Downloaded newer image for quay.io/ansible/default-test-container:1.10.1
2025-11-28 00:31:07.802996 | controller | quay.io/ansible/default-test-container:1.10.1
2025-11-28 00:31:07.807691 | controller | Run command: docker images quay.io/ansible/pypi-test-container:1.0.0 --format '{{json .}}'
2025-11-28 00:31:07.833615 | controller | Run command: docker pull quay.io/ansible/pypi-test-container:1.0.0
2025-11-28 00:31:09.200181 | controller | 1.0.0: Pulling from ansible/pypi-test-container
2025-11-28 00:31:09.200358 | controller | 04a5f4cda3ee: Pulling fs layer
2025-11-28 00:31:09.201013 | controller | ff496a88c8ed: Pulling fs layer
2025-11-28 00:31:09.201112 | controller | 0ce83f459fe7: Pulling fs layer
2025-11-28 00:31:09.201276 | controller | 2e5170e1f099: Pulling fs layer
2025-11-28 00:31:09.201354 | controller | 7641eb41b08c: Pulling fs layer
2025-11-28 00:31:09.201445 | controller | ad15fa9da398: Pulling fs layer
2025-11-28 00:31:09.201534 | controller | 087d91352424: Pulling fs layer
2025-11-28 00:31:09.201629 | controller | 8b92efd6a100: Pulling fs layer
2025-11-28 00:31:09.201761 | controller | 2e5170e1f099: Waiting
2025-11-28 00:31:09.201849 | controller | 7641eb41b08c: Waiting
2025-11-28 00:31:09.201927 | controller | ad15fa9da398: Waiting
2025-11-28 00:31:09.202047 | controller | 087d91352424: Waiting
2025-11-28 00:31:09.202154 | controller | 8b92efd6a100: Waiting
2025-11-28 00:31:10.071699 | controller | 0ce83f459fe7: Verifying Checksum
2025-11-28 00:31:10.082326 | controller | 0ce83f459fe7: Download complete
2025-11-28 00:31:10.082408 | controller | ff496a88c8ed: Verifying Checksum
2025-11-28 00:31:10.082490 | controller | ff496a88c8ed: Download complete
2025-11-28 00:31:10.129256 | controller | 04a5f4cda3ee: Verifying Checksum
2025-11-28 00:31:10.918512 | controller | 04a5f4cda3ee: Download complete
2025-11-28 00:31:10.918591 | controller | 7641eb41b08c: Verifying Checksum
2025-11-28 00:31:10.918729 | controller | 7641eb41b08c: Download complete
2025-11-28 00:31:10.944376 | controller | ad15fa9da398: Verifying Checksum
2025-11-28 00:31:10.944474 | controller | ad15fa9da398: Download complete
2025-11-28 00:31:11.038928 | controller | 2e5170e1f099: Verifying Checksum
2025-11-28 00:31:11.039015 | controller | 2e5170e1f099: Download complete
2025-11-28 00:31:11.787920 | controller | 087d91352424: Verifying Checksum
2025-11-28 00:31:11.788006 | controller | 087d91352424: Download complete
2025-11-28 00:31:11.869463 | controller | 8b92efd6a100: Verifying Checksum
2025-11-28 00:31:11.869616 | controller | 8b92efd6a100: Download complete
2025-11-28 00:31:12.028808 | controller | 04a5f4cda3ee: Pull complete
2025-11-28 00:31:12.066574 | controller | ff496a88c8ed: Pull complete
2025-11-28 00:31:12.109349 | controller | 0ce83f459fe7: Pull complete
2025-11-28 00:31:13.510512 | controller | 2e5170e1f099: Pull complete
2025-11-28 00:31:13.555104 | controller | 7641eb41b08c: Pull complete
2025-11-28 00:31:13.593167 | controller | ad15fa9da398: Pull complete
2025-11-28 00:31:14.480249 | controller | 087d91352424: Pull complete
2025-11-28 00:31:14.516010 | controller | 8b92efd6a100: Pull complete
2025-11-28 00:31:14.540780 | controller | Digest: sha256:71042ab0a14971b5608fe75706de54f367fc31db573e3b3955182037f73cadb6
2025-11-28 00:31:14.548309 | controller | Status: Downloaded newer image for quay.io/ansible/pypi-test-container:1.0.0
2025-11-28 00:31:14.560517 | controller | quay.io/ansible/pypi-test-container:1.0.0
2025-11-28 00:31:14.563742 | controller | Run command: docker run --detach quay.io/ansible/pypi-test-container:1.0.0
2025-11-28 00:31:19.256557 | controller | Run command: docker inspect e6ac99440610ae6910f5191f92bff5b436c55d5f1e2101beebe162bac8eb8858
2025-11-28 00:31:19.490118 | controller | Scanning collection root: /home/zuul/.ansible/collections/ansible_collections
2025-11-28 00:31:19.505162 | controller | Including collection: ansible.netcommon (292 files)
2025-11-28 00:31:19.505246 | controller | Including collection: ansible.network (23 files)
2025-11-28 00:31:19.516086 | controller | Including collection: ansible.utils (442 files)
2025-11-28 00:31:19.554600 | controller | Including collection: arista.eos (1022 files)
2025-11-28 00:31:19.599131 | controller | Including collection: cisco.ios (1172 files)
2025-11-28 00:31:19.639470 | controller | Including collection: cisco.iosxr (1043 files)
2025-11-28 00:31:19.711185 | controller | Including collection: cisco.nxos (1684 files)
2025-11-28 00:31:19.752474 | controller | Including collection: junipernetworks.junos (963 files)
2025-11-28 00:31:19.799593 | controller | Creating a payload archive containing 8378 files...
2025-11-28 00:31:22.037055 | controller | Created a 6889698 byte payload archive containing 8378 files in 2 seconds.
2025-11-28 00:31:22.043175 | controller | Assuming Docker is available on localhost.
2025-11-28 00:31:22.043647 | 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
2025-11-28 00:31:22.615782 | controller | Run command: docker exec -i 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e dd of=/root/docker.sh bs=65536
2025-11-28 00:31:22.702954 | controller | Run command: docker exec 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e /bin/bash /root/docker.sh
2025-11-28 00:31:22.796724 | controller | Run command: docker exec -i 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e dd of=/root/ansible.tgz bs=65536
2025-11-28 00:31:22.893902 | controller | Run command: docker exec 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e mkdir /root/ansible
2025-11-28 00:31:22.954061 | controller | Run command: docker exec 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e tar oxzf /root/ansible.tgz -C /root/ansible
2025-11-28 00:31:24.044028 | controller | Run command: docker exec 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e /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-ost2fjia.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/
2025-11-28 00:31:24.518470 | controller | Injecting custom PyPI hosts entries: /etc/hosts
2025-11-28 00:31:24.521205 | controller | Injecting custom PyPI config: /root/.pip/pip.conf
2025-11-28 00:31:24.521254 | controller | Injecting custom PyPI config: /root/.pydistutils.cfg
2025-11-28 00:31:24.521267 | controller | Run command: /usr/bin/python3.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-28 00:31:24.589307 | controller | Running sanity test 'action-plugin-docs' with Python 3.6
2025-11-28 00:31:24.592608 | controller | Read 0 sanity test ignore line(s) for Ansible 2.9 from: tests/sanity/ignore-2.9.txt
2025-11-28 00:31:24.599566 | controller | No tests applicable.
2025-11-28 00:31:24.599836 | controller | Running sanity test 'ansible-doc' with Python 3.6
2025-11-28 00:31:24.599854 | controller | No tests applicable.
2025-11-28 00:31:24.599884 | controller | Run command: /usr/bin/python2.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-28 00:31:24.680054 | controller | Running sanity test 'compile' with Python 2.6
2025-11-28 00:31:24.680260 | controller | No tests applicable.
2025-11-28 00:31:24.680592 | controller | Run command: /usr/bin/python2.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-28 00:31:24.874263 | controller | Running sanity test 'compile' with Python 2.7
2025-11-28 00:31:24.874698 | controller | No tests applicable.
2025-11-28 00:31:24.874736 | controller | Run command: /usr/bin/python3.5 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-28 00:31:24.991016 | controller | Running sanity test 'compile' with Python 3.5
2025-11-28 00:31:24.991256 | controller | No tests applicable.
2025-11-28 00:31:24.991499 | controller | Running sanity test 'compile' with Python 3.6
2025-11-28 00:31:24.991533 | controller | No tests applicable.
2025-11-28 00:31:24.991860 | controller | Run command: /usr/bin/python3.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-28 00:31:25.093425 | controller | Running sanity test 'compile' with Python 3.7
2025-11-28 00:31:25.093592 | controller | No tests applicable.
2025-11-28 00:31:25.093940 | controller | Run command: /usr/bin/python3.8 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-28 00:31:25.195108 | controller | Running sanity test 'compile' with Python 3.8
2025-11-28 00:31:25.195330 | controller | No tests applicable.
2025-11-28 00:31:25.195460 | controller | Running sanity test 'empty-init' with Python 3.6
2025-11-28 00:31:25.195575 | controller | No tests applicable.
2025-11-28 00:31:25.195752 | controller | Running sanity test 'future-import-boilerplate' with Python 3.6
2025-11-28 00:31:25.195767 | controller | No tests applicable.
2025-11-28 00:31:25.195866 | controller | Running sanity test 'ignores'
2025-11-28 00:31:25.196992 | 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
2025-11-28 00:31:25.906019 | controller | Ignoring packaging: markers 'python_version < "3.6"' don't match your environment
2025-11-28 00:31:25.909177 | controller | Ignoring coverage: markers 'python_version > "3.7"' don't match your environment
2025-11-28 00:31:25.910545 | controller | Ignoring cryptography: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.913289 | controller | Ignoring deepdiff: markers 'python_version < "3"' don't match your environment
2025-11-28 00:31:25.914818 | controller | Ignoring jinja2: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.916176 | controller | Ignoring urllib3: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.919201 | controller | Ignoring sphinx: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.923622 | controller | Ignoring wheel: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.925061 | controller | Ignoring yamllint: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.929448 | controller | Ignoring paramiko: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.931931 | controller | Ignoring pytest: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.933489 | controller | Ignoring pytest: markers 'python_version == "2.7"' don't match your environment
2025-11-28 00:31:25.934845 | controller | Ignoring pytest-forked: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.938524 | controller | Ignoring requests: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.945543 | controller | Ignoring virtualenv: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.947096 | controller | Ignoring pathspec: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.948531 | controller | Ignoring pyopenssl: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.951189 | controller | Ignoring pyyaml: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.952446 | controller | Ignoring pycparser: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.955779 | controller | Ignoring xmltodict: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.957104 | controller | Ignoring lxml: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.958630 | controller | Ignoring pyvmomi: markers 'python_version < "2.7"' don't match your environment
2025-11-28 00:31:25.960958 | controller | Ignoring MarkupSafe: markers 'python_version < "3.6"' don't match your environment
2025-11-28 00:31:25.965276 | controller | Ignoring setuptools: markers 'python_version <= "2.7"' don't match your environment
2025-11-28 00:31:25.969033 | controller | Ignoring websocket-client: markers 'python_version < "3"' don't match your environment
2025-11-28 00:31:25.970340 | controller | Ignoring certifi: markers 'python_version < "3"' don't match your environment
2025-11-28 00:31:25.988215 | controller | Looking in indexes: http://172.17.0.2:3141/root/pypi/+simple/
2025-11-28 00:31:25.989317 | 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)
2025-11-28 00:31:26.014931 | 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)
2025-11-28 00:31:26.018382 | 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)
2025-11-28 00:31:26.021613 | 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)
2025-11-28 00:31:26.024172 | 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)
2025-11-28 00:31:26.030191 | 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)
2025-11-28 00:31:26.035016 | 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)
2025-11-28 00:31:26.039051 | 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)
2025-11-28 00:31:26.040988 | 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)
2025-11-28 00:31:26.058098 | 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)
2025-11-28 00:31:26.061769 | 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)
2025-11-28 00:31:26.063835 | 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)
2025-11-28 00:31:26.066153 | 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)
2025-11-28 00:31:26.068290 | 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)
2025-11-28 00:31:26.070865 | controller | Collecting isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55))
2025-11-28 00:31:41.092633 | 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/
2025-11-28 00:31:56.609562 | 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/
2025-11-28 00:32:12.627836 | 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/
2025-11-28 00:32:29.638907 | 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/
2025-11-28 00:32:48.660499 | 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/
2025-11-28 00:33:03.671047 | 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)
2025-11-28 00:33:03.787002 | 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))
2025-11-28 00:33:03.787078 | 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.
2025-11-28 00:33:03.787271 | controller | Removing custom PyPI config: /root/.pydistutils.cfg
2025-11-28 00:33:03.787544 | controller | Removing custom PyPI config: /root/.pip/pip.conf
2025-11-28 00:33:03.787641 | controller | Removing custom PyPI hosts entries: /etc/hosts
2025-11-28 00:33:03.824822 | controller | Run command: docker exec 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e tar czf /root/output.tgz --exclude .tmp -C /root/ansible/ansible_collections/ansible/network/tests output
2025-11-28 00:33:03.901102 | controller | Run command: docker exec -i 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e dd if=/root/output.tgz bs=65536
2025-11-28 00:33:03.972931 | controller | Run command: tar oxzf /tmp/ansible-result-9xh_33j7.tgz -C /home/zuul/.ansible/collections/ansible_collections/ansible/network/tests
2025-11-28 00:33:03.984571 | controller | Run command: docker rm -f e6ac99440610ae6910f5191f92bff5b436c55d5f1e2101beebe162bac8eb8858
2025-11-28 00:33:04.241412 | controller | Run command: docker rm -f 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e
2025-11-28 00:33:04.974572 | controller | ERROR: Command "docker exec 0d6afc56a6a4f227c398060c9930bdca7eaf66920d15406fd68456c2ab91909e /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-ost2fjia.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/" returned exit status 1.
2025-11-28 00:33:05.532669 | controller | ERROR
2025-11-28 00:33:05.532835 | controller | {
2025-11-28 00:33:05.532864 | controller |   "delta": "0:05:29.323410",
2025-11-28 00:33:05.532887 | controller |   "end": "2025-11-28 00:33:05.036369",
2025-11-28 00:33:05.532905 | controller |   "msg": "non-zero return code",
2025-11-28 00:33:05.532923 | controller |   "rc": 1,
2025-11-28 00:33:05.532947 | controller |   "start": "2025-11-28 00:27:35.712959"
2025-11-28 00:33:05.532966 | controller | }
failure
2025-11-28 00:33:05.537274 | 
2025-11-28 00:33:05.537443 | PLAY RECAP
2025-11-28 00:33:05.537549 | controller | ok: 21 changed: 6 unreachable: 0 failed: 1 skipped: 20 rescued: 0 ignored: 1
2025-11-28 00:33:05.537619 | 
2025-11-28 00:33:05.672252 | RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2025-11-28 00:33:05.673869 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-11-28 00:33:06.295704 | 
2025-11-28 00:33:06.295832 | PLAY [all]
2025-11-28 00:33:06.318998 | 
2025-11-28 00:33:06.319157 | TASK [fetch-subunit-output : Find stestr or testr executable]
2025-11-28 00:33:09.282720 | controller | changed: non-zero return code
2025-11-28 00:33:09.295545 | 
2025-11-28 00:33:09.295719 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2025-11-28 00:33:09.321433 | controller | skipping: Conditional result was False
2025-11-28 00:33:09.330252 | 
2025-11-28 00:33:09.330388 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2025-11-28 00:33:09.363267 | 
2025-11-28 00:33:09.363423 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2025-11-28 00:33:09.393486 | 
2025-11-28 00:33:09.393650 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2025-11-28 00:33:09.408073 | controller | skipping: Conditional result was False
2025-11-28 00:33:09.415877 | 
2025-11-28 00:33:09.416061 | LOOP [fetch-subunit-output : Generate subunit file]
2025-11-28 00:33:09.439246 | 
2025-11-28 00:33:09.439491 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2025-11-28 00:33:09.455846 | controller | skipping: Conditional result was False
2025-11-28 00:33:09.464647 | 
2025-11-28 00:33:09.464752 | TASK [fetch-subunit-output : Remove the temporary file]
2025-11-28 00:33:09.480187 | controller | skipping: Conditional result was False
2025-11-28 00:33:09.487313 | 
2025-11-28 00:33:09.487463 | TASK [fetch-subunit-output : Process and fetch subunit results]
2025-11-28 00:33:09.502706 | controller | skipping: Conditional result was False
2025-11-28 00:33:09.538061 | 
2025-11-28 00:33:09.538173 | PLAY RECAP
2025-11-28 00:33:09.538229 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-11-28 00:33:09.538259 | 
2025-11-28 00:33:09.643189 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-11-28 00:33:09.644054 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2025-11-28 00:33:10.222559 | 
2025-11-28 00:33:10.222680 | PLAY [all:!appliance*]
2025-11-28 00:33:10.244816 | 
2025-11-28 00:33:10.244938 | TASK [unregister the node]
2025-11-28 00:33:10.599791 | controller | skipping: Conditional result was False
2025-11-28 00:33:10.612495 | 
2025-11-28 00:33:10.612658 | TASK [include_role : fetch-output]
2025-11-28 00:33:10.658989 | controller | ok
2025-11-28 00:33:10.692391 | 
2025-11-28 00:33:10.692546 | TASK [fetch-output : Set log path for multiple nodes]
2025-11-28 00:33:10.749044 | controller | skipping: Conditional result was False
2025-11-28 00:33:10.773876 | 
2025-11-28 00:33:10.774005 | TASK [fetch-output : Set log path for single node]
2025-11-28 00:33:10.825649 | controller | ok
2025-11-28 00:33:10.837855 | 
2025-11-28 00:33:10.838001 | LOOP [fetch-output : Ensure local output dirs]
2025-11-28 00:33:11.246751 | controller -> localhost | ok: "/var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/logs"
2025-11-28 00:33:11.488008 | controller -> localhost | changed: "/var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/artifacts"
2025-11-28 00:33:11.723300 | controller -> localhost | changed: "/var/lib/zuul/builds/501aeb0b4e1e4d64b56694b19fa1ce52/work/docs"
2025-11-28 00:33:11.744221 | 
2025-11-28 00:33:11.744680 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-11-28 00:33:13.985162 | controller | changed:
2025-11-28 00:33:13.985658 | controller | .d..t...... ./
2025-11-28 00:33:13.985726 | controller | cd+++++++++ controller/
2025-11-28 00:33:13.985800 | controller | changed: All items complete
2025-11-28 00:33:13.985846 | 
2025-11-28 00:33:16.067105 | controller | changed: .d..t...... ./
2025-11-28 00:33:18.150800 | controller | changed: .d..t...... ./
2025-11-28 00:33:18.195893 | 
2025-11-28 00:33:18.200065 | TASK [include_role : fetch-output-openshift]
2025-11-28 00:33:18.217569 | controller | skipping: Conditional result was False
2025-11-28 00:33:18.227566 | 
2025-11-28 00:33:18.227671 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-11-28 00:33:18.263166 | controller | skipping: Conditional result was False
2025-11-28 00:33:18.275922 | controller | skipping: Conditional result was False
2025-11-28 00:33:18.311863 | 
2025-11-28 00:33:18.311958 | PLAY [localhost]
2025-11-28 00:33:18.325103 | 
2025-11-28 00:33:18.325193 | TASK [Run Zuul manifest role]
2025-11-28 00:33:18.344199 | localhost | ok
2025-11-28 00:33:18.358866 | 
2025-11-28 00:33:18.358986 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-11-28 00:33:18.734293 | localhost | changed
2025-11-28 00:33:18.740535 | 
2025-11-28 00:33:18.740666 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-11-28 00:33:18.770481 | localhost | ok
2025-11-28 00:33:18.778699 | 
2025-11-28 00:33:18.778766 | TASK [Set zuul-log-path fact]
2025-11-28 00:33:18.797998 | localhost | ok
2025-11-28 00:33:18.837141 | 
2025-11-28 00:33:18.837257 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-11-28 00:33:18.875858 | localhost | ok
2025-11-28 00:33:18.887602 | 
2025-11-28 00:33:18.887699 | LOOP [Run upload-logs-swift role]
2025-11-28 00:33:18.934263 | localhost | Output suppressed because no_log was given
2025-11-28 00:33:18.973679 | 
2025-11-28 00:33:18.973776 | TASK [Set zuul-log-path fact]
2025-11-28 00:33:18.997917 | localhost | skipping: Conditional result was False
2025-11-28 00:33:19.004766 | 
2025-11-28 00:33:19.004843 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2025-11-28 00:33:19.408506 | localhost -> localhost | ok: Runtime: 0:00:00.006747
2025-11-28 00:33:19.421841 | 
2025-11-28 00:33:19.422007 | TASK [upload-logs-swift : Upload logs to swift]