2026-02-05 00:06:57.592525 | Job console starting...
2026-02-05 00:06:57.601557 | Updating repositories
2026-02-05 00:06:57.710977 | Preparing job workspace
2026-02-05 00:07:03.209600 | Running Ansible setup...
2026-02-05 00:07:11.628853 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-05 00:07:12.256526 | 
2026-02-05 00:07:12.256658 | PLAY [localhost]
2026-02-05 00:07:12.265555 | 
2026-02-05 00:07:12.265649 | TASK [Gathering Facts]
2026-02-05 00:07:13.288807 | localhost | ok
2026-02-05 00:07:13.320956 | 
2026-02-05 00:07:13.321219 | TASK [Setup log path fact]
2026-02-05 00:07:13.344754 | localhost | ok
2026-02-05 00:07:13.364370 | 
2026-02-05 00:07:13.364517 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-05 00:07:13.405616 | localhost | ok
2026-02-05 00:07:13.417936 | 
2026-02-05 00:07:13.418146 | TASK [emit-job-header : Print job information]
2026-02-05 00:07:13.450002 | # Job Information
2026-02-05 00:07:13.450233 | Ansible Version: 2.15.12
2026-02-05 00:07:13.450282 | Job: ansible-test-sanity-docker-stable-2.9
2026-02-05 00:07:13.450314 | Pipeline: periodic
2026-02-05 00:07:13.450345 | Executor: ze01.softwarefactory-project.io
2026-02-05 00:07:13.450373 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-02-05 00:07:13.450406 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/5d2/ansible/5d20dd1e88ed41b7bff6e9ac9e098b62/
2026-02-05 00:07:13.450435 | Event ID: 9feee7bbbe884a658b69c76d84949d2e
2026-02-05 00:07:13.457711 | 
2026-02-05 00:07:13.457817 | LOOP [emit-job-header : Print node information]
2026-02-05 00:07:13.560800 | localhost | ok:
2026-02-05 00:07:13.561214 | localhost | # Node Information
2026-02-05 00:07:13.561285 | localhost | Inventory Hostname: controller
2026-02-05 00:07:13.561331 | localhost | Hostname: np0005609076
2026-02-05 00:07:13.561374 | localhost | Username: zuul
2026-02-05 00:07:13.561428 | localhost | Distro: Fedora 37
2026-02-05 00:07:13.561471 | localhost | Provider: ansible-vexxhost-ams1
2026-02-05 00:07:13.561511 | localhost | Region: ams1
2026-02-05 00:07:13.561549 | localhost | Label: ansible-fedora-37-1vcpu
2026-02-05 00:07:13.561585 | localhost | Product Name: OpenStack Nova
2026-02-05 00:07:13.561623 | localhost | Interface IP: 38.129.16.108
2026-02-05 00:07:13.573431 | 
2026-02-05 00:07:13.573538 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-05 00:07:14.048554 | localhost -> localhost | changed
2026-02-05 00:07:14.054415 | 
2026-02-05 00:07:14.054489 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-05 00:07:15.450160 | localhost -> localhost | changed
2026-02-05 00:07:15.489166 | 
2026-02-05 00:07:15.489319 | PLAY [all:!appliance*]
2026-02-05 00:07:15.549930 | 
2026-02-05 00:07:15.550106 | TASK [include_role : start-zuul-console]
2026-02-05 00:07:15.604062 | controller | ok
2026-02-05 00:07:15.636440 | 
2026-02-05 00:07:15.636558 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-02-05 00:07:16.816673 | controller | ok
2026-02-05 00:07:16.836859 | 
2026-02-05 00:07:16.836981 | TASK [use-our-mirror : Retrieve the IP address]
2026-02-05 00:07:18.869675 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-02-05 00:07:18.877169 | 
2026-02-05 00:07:18.877247 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-02-05 00:07:19.234480 | controller | skipping: Conditional result was False
2026-02-05 00:07:19.255275 | 
2026-02-05 00:07:19.255489 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-02-05 00:07:19.283327 | controller | skipping: Conditional result was False
2026-02-05 00:07:19.293338 | 
2026-02-05 00:07:19.293477 | TASK [use-our-mirror : Create the podman configuration directory]
2026-02-05 00:07:19.318924 | controller | skipping: Conditional result was False
2026-02-05 00:07:19.337599 | 
2026-02-05 00:07:19.338099 | TASK [use-our-mirror : Copy the podman configuration]
2026-02-05 00:07:19.366278 | controller | skipping: Conditional result was False
2026-02-05 00:07:19.378052 | 
2026-02-05 00:07:19.378225 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-02-05 00:07:19.405257 | controller | skipping: Conditional result was False
2026-02-05 00:07:19.415878 | 
2026-02-05 00:07:19.416216 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-02-05 00:07:19.442432 | controller | skipping: Conditional result was False
2026-02-05 00:07:19.460303 | 
2026-02-05 00:07:19.460473 | TASK [Disable Fedora Modular]
2026-02-05 00:07:20.562213 | controller | changed
2026-02-05 00:07:20.569258 | 
2026-02-05 00:07:20.569339 | TASK [Enable EPEL]
2026-02-05 00:07:20.603935 | controller | skipping: Conditional result was False
2026-02-05 00:07:20.610845 | 
2026-02-05 00:07:20.610956 | TASK [Register the RHEL node]
2026-02-05 00:07:21.012175 | 
2026-02-05 00:07:21.012364 | TASK [Show the subscription-manager status]
2026-02-05 00:07:21.379605 | controller | skipping: Conditional result was False
2026-02-05 00:07:21.396244 | 
2026-02-05 00:07:21.396422 | TASK [Enable EPEL on RHEL]
2026-02-05 00:07:21.784444 | controller | skipping: Conditional result was False
2026-02-05 00:07:21.800570 | 
2026-02-05 00:07:21.800787 | TASK [Install git and tox]
2026-02-05 00:09:37.404538 | controller | changed
2026-02-05 00:09:37.421658 | 
2026-02-05 00:09:37.421814 | TASK [include_role : prepare-workspace]
2026-02-05 00:09:37.456674 | controller | ok
2026-02-05 00:09:37.489593 | 
2026-02-05 00:09:37.489718 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-05 00:09:38.336597 | controller | ok
2026-02-05 00:09:38.345002 | 
2026-02-05 00:09:38.345150 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-05 00:09:59.503806 | controller | Output suppressed because no_log was given
2026-02-05 00:09:59.521811 | 
2026-02-05 00:09:59.522033 | TASK [include_role : prepare-workspace-openshift]
2026-02-05 00:09:59.542921 | controller | skipping: Conditional result was False
2026-02-05 00:09:59.584591 | 
2026-02-05 00:09:59.584673 | PLAY [all:!appliance]
2026-02-05 00:09:59.607674 | 
2026-02-05 00:09:59.607795 | TASK [Run add-build-sshkey role (RSA)]
2026-02-05 00:09:59.639814 | controller | ok
2026-02-05 00:09:59.663825 | 
2026-02-05 00:09:59.663950 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-05 00:09:59.933386 | controller -> localhost | ok
2026-02-05 00:09:59.942724 | 
2026-02-05 00:09:59.942824 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-05 00:09:59.975624 | controller | ok
2026-02-05 00:09:59.997650 | controller | included: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-05 00:10:00.007965 | 
2026-02-05 00:10:00.008075 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-05 00:10:00.588080 | controller -> localhost | Generating public/private rsa key pair.
2026-02-05 00:10:00.588270 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/5d20dd1e88ed41b7bff6e9ac9e098b62_id_rsa.
2026-02-05 00:10:00.588300 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/5d20dd1e88ed41b7bff6e9ac9e098b62_id_rsa.pub.
2026-02-05 00:10:00.588322 | controller -> localhost | The key fingerprint is:
2026-02-05 00:10:00.588343 | controller -> localhost | SHA256:56zATOCc8tDrWD5/Bmtw2B5pdqP63iNUmnOcAXiwZpg zuul-build-sshkey
2026-02-05 00:10:00.588363 | controller -> localhost | The key's randomart image is:
2026-02-05 00:10:00.588383 | controller -> localhost | +---[RSA 2048]----+
2026-02-05 00:10:00.588402 | controller -> localhost | |    .o           |
2026-02-05 00:10:00.588421 | controller -> localhost | |   o..o          |
2026-02-05 00:10:00.588440 | controller -> localhost | |  E =. .         |
2026-02-05 00:10:00.588458 | controller -> localhost | |   * o  o        |
2026-02-05 00:10:00.588477 | controller -> localhost | |  o =o.*So.      |
2026-02-05 00:10:00.588505 | controller -> localhost | |   +o=& *+       |
2026-02-05 00:10:00.588528 | controller -> localhost | |    +B+O .o      |
2026-02-05 00:10:00.588549 | controller -> localhost | |   =. *o+.       |
2026-02-05 00:10:00.588569 | controller -> localhost | |  . +B++o.       |
2026-02-05 00:10:00.588591 | controller -> localhost | +----[SHA256]-----+
2026-02-05 00:10:00.588653 | controller -> localhost | ok: Runtime: 0:00:00.114550
2026-02-05 00:10:00.604648 | 
2026-02-05 00:10:00.604771 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-05 00:10:00.646009 | controller | ok
2026-02-05 00:10:00.656274 | controller | included: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-05 00:10:00.665801 | 
2026-02-05 00:10:00.665892 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-05 00:10:00.689925 | controller | skipping: Conditional result was False
2026-02-05 00:10:00.701671 | 
2026-02-05 00:10:00.701807 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-05 00:10:01.798509 | controller | changed
2026-02-05 00:10:01.806612 | 
2026-02-05 00:10:01.806733 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-05 00:10:02.465514 | controller | ok
2026-02-05 00:10:02.475513 | 
2026-02-05 00:10:02.475630 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-05 00:10:05.472850 | controller | changed
2026-02-05 00:10:05.480894 | 
2026-02-05 00:10:05.481084 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-05 00:10:08.538369 | controller | changed
2026-02-05 00:10:08.588448 | 
2026-02-05 00:10:08.588582 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-05 00:10:08.603060 | controller | skipping: Conditional result was False
2026-02-05 00:10:08.612086 | 
2026-02-05 00:10:08.612213 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-05 00:10:08.957233 | controller -> localhost | changed
2026-02-05 00:10:08.978309 | 
2026-02-05 00:10:08.978724 | TASK [add-build-sshkey : Add back temp key]
2026-02-05 00:10:09.291899 | controller -> localhost | Identity added: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/5d20dd1e88ed41b7bff6e9ac9e098b62_id_rsa (zuul-build-sshkey)
2026-02-05 00:10:09.292173 | controller -> localhost | ok: Runtime: 0:00:00.018567
2026-02-05 00:10:09.300862 | 
2026-02-05 00:10:09.300981 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-05 00:10:10.192325 | controller | ok
2026-02-05 00:10:10.203344 | 
2026-02-05 00:10:10.203485 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-05 00:10:10.239886 | controller | skipping: Conditional result was False
2026-02-05 00:10:10.253083 | 
2026-02-05 00:10:10.253194 | TASK [Run add-build-sshkey role (ECDSA)]
2026-02-05 00:10:10.287454 | controller | ok
2026-02-05 00:10:10.319506 | 
2026-02-05 00:10:10.319720 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-05 00:10:10.603119 | controller -> localhost | ok
2026-02-05 00:10:10.610087 | 
2026-02-05 00:10:10.610200 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-05 00:10:10.641841 | controller | ok
2026-02-05 00:10:10.653916 | controller | included: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-05 00:10:10.661197 | 
2026-02-05 00:10:10.661492 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-05 00:10:10.965375 | controller -> localhost | Generating public/private ecdsa key pair.
2026-02-05 00:10:10.965568 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/5d20dd1e88ed41b7bff6e9ac9e098b62_id_ecdsa.
2026-02-05 00:10:10.965596 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/5d20dd1e88ed41b7bff6e9ac9e098b62_id_ecdsa.pub.
2026-02-05 00:10:10.965625 | controller -> localhost | The key fingerprint is:
2026-02-05 00:10:10.965645 | controller -> localhost | SHA256:LzUA754M1htwPBPm/ikon3I1w4Eqptd3yMoxUawxTAg zuul-build-sshkey
2026-02-05 00:10:10.965664 | controller -> localhost | The key's randomart image is:
2026-02-05 00:10:10.965682 | controller -> localhost | +---[ECDSA 521]---+
2026-02-05 00:10:10.965699 | controller -> localhost | |E. .. . o        |
2026-02-05 00:10:10.965716 | controller -> localhost | |  .o . * .       |
2026-02-05 00:10:10.965733 | controller -> localhost | |    + +.O        |
2026-02-05 00:10:10.965749 | controller -> localhost | |     =.*.+       |
2026-02-05 00:10:10.965766 | controller -> localhost | |    o.o.S.o      |
2026-02-05 00:10:10.965782 | controller -> localhost | |  o .o ==B o     |
2026-02-05 00:10:10.965798 | controller -> localhost | | o o+..oBo+      |
2026-02-05 00:10:10.965815 | controller -> localhost | |. ..o==..o       |
2026-02-05 00:10:10.965831 | controller -> localhost | | .  o=o.         |
2026-02-05 00:10:10.965848 | controller -> localhost | +----[SHA256]-----+
2026-02-05 00:10:10.965895 | controller -> localhost | ok: Runtime: 0:00:00.008687
2026-02-05 00:10:10.972929 | 
2026-02-05 00:10:10.973031 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-05 00:10:11.004187 | controller | ok
2026-02-05 00:10:11.014493 | controller | included: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-05 00:10:11.036600 | 
2026-02-05 00:10:11.036727 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-05 00:10:11.060947 | controller | skipping: Conditional result was False
2026-02-05 00:10:11.074051 | 
2026-02-05 00:10:11.074185 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-05 00:10:11.991139 | controller | changed
2026-02-05 00:10:12.002619 | 
2026-02-05 00:10:12.002770 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-05 00:10:12.650750 | controller | ok
2026-02-05 00:10:12.659940 | 
2026-02-05 00:10:12.660102 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-05 00:10:15.642935 | controller | changed
2026-02-05 00:10:15.655047 | 
2026-02-05 00:10:15.655204 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-05 00:10:18.675481 | controller | changed
2026-02-05 00:10:18.691501 | 
2026-02-05 00:10:18.691610 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-05 00:10:18.717293 | controller | skipping: Conditional result was False
2026-02-05 00:10:18.727622 | 
2026-02-05 00:10:18.727723 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-05 00:10:18.998952 | controller -> localhost | changed
2026-02-05 00:10:19.017879 | 
2026-02-05 00:10:19.018055 | TASK [add-build-sshkey : Add back temp key]
2026-02-05 00:10:19.318971 | controller -> localhost | Identity added: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/5d20dd1e88ed41b7bff6e9ac9e098b62_id_ecdsa (zuul-build-sshkey)
2026-02-05 00:10:19.319207 | controller -> localhost | ok: Runtime: 0:00:00.017171
2026-02-05 00:10:19.325923 | 
2026-02-05 00:10:19.325997 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-05 00:10:20.027651 | controller | ok
2026-02-05 00:10:20.040718 | 
2026-02-05 00:10:20.040897 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-05 00:10:20.078786 | controller | skipping: Conditional result was False
2026-02-05 00:10:20.094812 | 
2026-02-05 00:10:20.094949 | TASK [include_role : remove-zuul-sshkey]
2026-02-05 00:10:20.121205 | controller | skipping: Conditional result was False
2026-02-05 00:10:20.132193 | 
2026-02-05 00:10:20.132345 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-05 00:10:20.794148 | controller | ok: "logs"
2026-02-05 00:10:20.794392 | controller | ok: All items complete
2026-02-05 00:10:20.794423 | 
2026-02-05 00:10:21.397486 | controller | ok: "artifacts"
2026-02-05 00:10:21.990961 | controller | ok: "docs"
2026-02-05 00:10:22.013348 | 
2026-02-05 00:10:22.013505 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-05 00:10:22.672876 | controller | changed: "logs"
2026-02-05 00:10:23.273171 | controller | changed: "artifacts"
2026-02-05 00:10:23.871301 | controller | changed: "docs"
2026-02-05 00:10:23.954688 | 
2026-02-05 00:10:23.954791 | PLAY RECAP
2026-02-05 00:10:23.954832 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-02-05 00:10:23.954859 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-05 00:10:23.954877 | 
2026-02-05 00:10:24.070426 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-05 00:10:24.072197 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-05 00:10:24.693828 | 
2026-02-05 00:10:24.693971 | PLAY [all]
2026-02-05 00:10:24.719938 | 
2026-02-05 00:10:24.720094 | TASK [Install binary dependencies]
2026-02-05 00:10:24.773638 | controller | ok
2026-02-05 00:10:24.797698 | 
2026-02-05 00:10:24.797846 | TASK [bindep : Include find tasks]
2026-02-05 00:10:24.830117 | controller | ok
2026-02-05 00:10:24.841762 | controller | included: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-05 00:10:24.851819 | 
2026-02-05 00:10:24.851974 | TASK [bindep : Look for bindep.txt]
2026-02-05 00:10:25.782904 | controller | ok
2026-02-05 00:10:25.792307 | 
2026-02-05 00:10:25.792456 | TASK [bindep : Define bindep_file fact]
2026-02-05 00:10:25.818408 | controller | skipping: Conditional result was False
2026-02-05 00:10:25.828257 | 
2026-02-05 00:10:25.828417 | TASK [bindep : Look for other-requirements.txt]
2026-02-05 00:10:26.459819 | controller | ok
2026-02-05 00:10:26.466467 | 
2026-02-05 00:10:26.466559 | TASK [bindep : Define bindep_file fact]
2026-02-05 00:10:26.490956 | controller | skipping: Conditional result was False
2026-02-05 00:10:26.498023 | 
2026-02-05 00:10:26.498174 | TASK [bindep : Look for bindep fallback file]
2026-02-05 00:10:26.522866 | controller | skipping: Conditional result was False
2026-02-05 00:10:26.529361 | 
2026-02-05 00:10:26.529450 | TASK [bindep : Define bindep_file fact]
2026-02-05 00:10:26.553591 | controller | skipping: Conditional result was False
2026-02-05 00:10:26.561006 | 
2026-02-05 00:10:26.561113 | TASK [bindep : Include bindep tasks]
2026-02-05 00:10:26.585132 | controller | skipping: Conditional result was False
2026-02-05 00:10:26.591387 | 
2026-02-05 00:10:26.591475 | TASK [bindep : Include install tasks]
2026-02-05 00:10:26.615768 | controller | skipping: Conditional result was False
2026-02-05 00:10:26.622030 | 
2026-02-05 00:10:26.622122 | LOOP [bindep : Include package tasks]
2026-02-05 00:10:26.681135 | 
2026-02-05 00:10:26.681321 | TASK [Run test-setup role]
2026-02-05 00:10:26.702206 | controller | ok
2026-02-05 00:10:26.723817 | 
2026-02-05 00:10:26.723942 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-05 00:10:27.446431 | controller | ok
2026-02-05 00:10:27.452912 | 
2026-02-05 00:10:27.452992 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-05 00:10:27.805357 | controller | skipping: Conditional result was False
2026-02-05 00:10:27.859255 | 
2026-02-05 00:10:27.859404 | PLAY RECAP
2026-02-05 00:10:27.859464 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-05 00:10:27.859494 | 
2026-02-05 00:10:27.965475 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-05 00:10:27.966412 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-05 00:10:28.720754 | 
2026-02-05 00:10:28.720929 | PLAY [controller]
2026-02-05 00:10:28.748334 | 
2026-02-05 00:10:28.748477 | TASK [Create the /root directory]
2026-02-05 00:10:29.794438 | controller | ok
2026-02-05 00:10:29.800930 | 
2026-02-05 00:10:29.801091 | TASK [Install glibc-langpack-en]
2026-02-05 00:10:38.222783 | controller | ok: Nothing to do
2026-02-05 00:10:38.232584 | 
2026-02-05 00:10:38.232720 | TASK [Ensure controller directory exists]
2026-02-05 00:10:39.054539 | controller | changed
2026-02-05 00:10:39.063548 | 
2026-02-05 00:10:39.063664 | TASK [Install container runtime]
2026-02-05 00:10:39.134362 | controller | ok
2026-02-05 00:10:39.204412 | 
2026-02-05 00:10:39.204556 | LOOP [ensure-docker : Gather variables for each operating system]
2026-02-05 00:10:39.247878 | controller | ok: "/var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml"
2026-02-05 00:10:39.258159 | 
2026-02-05 00:10:39.258303 | TASK [ensure-docker : Sanity check for distro selection]
2026-02-05 00:10:39.284136 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.293786 | 
2026-02-05 00:10:39.293956 | TASK [ensure-docker : Sanity check for distro install]
2026-02-05 00:10:39.318950 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.327523 | 
2026-02-05 00:10:39.327666 | TASK [ensure-docker : Sanity check for upstream install]
2026-02-05 00:10:39.353665 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.360753 | 
2026-02-05 00:10:39.361058 | TASK [ensure-docker : Sanity check for upstream install mirrors]
2026-02-05 00:10:39.387242 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.397011 | 
2026-02-05 00:10:39.397162 | TASK [ensure-docker : Include tasks for docker install]
2026-02-05 00:10:39.418988 | controller | ok
2026-02-05 00:10:39.429042 | controller | included: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml
2026-02-05 00:10:39.438624 | 
2026-02-05 00:10:39.438700 | TASK [ensure-docker : Not Implemented]
2026-02-05 00:10:39.452279 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.460397 | 
2026-02-05 00:10:39.460492 | TASK [Set up docker mirrors]
2026-02-05 00:10:39.482277 | controller | ok
2026-02-05 00:10:39.508502 | 
2026-02-05 00:10:39.508627 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info]
2026-02-05 00:10:39.543885 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.551702 | 
2026-02-05 00:10:39.551824 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info]
2026-02-05 00:10:39.576533 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.614796 | 
2026-02-05 00:10:39.614929 | TASK [use-docker-mirror : Set docker_mirror fact]
2026-02-05 00:10:39.639672 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.645780 | 
2026-02-05 00:10:39.645991 | TASK [use-docker-mirror : Set up docker mirrors]
2026-02-05 00:10:39.670118 | controller | skipping: Conditional result was False
2026-02-05 00:10:39.682048 | 
2026-02-05 00:10:39.682145 | TASK [Add all repositories]
2026-02-05 00:10:39.702398 | controller | ok
2026-02-05 00:10:39.730798 | 
2026-02-05 00:10:39.730942 | LOOP [ensure-package-repositories : Install repositories]
2026-02-05 00:10:39.756646 | controller | ok: "/var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml"
2026-02-05 00:10:39.757003 | controller | ok: All items complete
2026-02-05 00:10:39.757422 | 
2026-02-05 00:10:39.779314 | controller | included: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml
2026-02-05 00:10:39.786150 | 
2026-02-05 00:10:39.786230 | TASK [ensure-package-repositories : Create GPG key temp directory]
2026-02-05 00:10:40.633217 | controller | changed
2026-02-05 00:10:40.645622 | 
2026-02-05 00:10:40.645732 | LOOP [ensure-package-repositories : Upload GPG keys]
2026-02-05 00:10:43.789752 | controller | changed:
2026-02-05 00:10:43.789958 | controller | {
2026-02-05 00:10:43.789986 | controller |   "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n"
2026-02-05 00:10:43.790008 | controller | }
2026-02-05 00:10:43.799036 | 
2026-02-05 00:10:43.799159 | LOOP [ensure-package-repositories : Import GPG keys]
2026-02-05 00:10:45.075044 | controller | changed:
2026-02-05 00:10:45.075223 | controller | {
2026-02-05 00:10:45.075251 | controller |   "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n"
2026-02-05 00:10:45.075273 | controller | }
2026-02-05 00:10:45.075303 | controller | changed: All items complete
2026-02-05 00:10:45.075322 | 
2026-02-05 00:10:45.086127 | 
2026-02-05 00:10:45.086293 | TASK [ensure-package-repositories : Remove GPG temp directory]
2026-02-05 00:10:45.747718 | controller | changed
2026-02-05 00:10:45.753759 | 
2026-02-05 00:10:45.753864 | LOOP [ensure-package-repositories : Add repositories]
2026-02-05 00:10:46.625112 | controller | changed:
2026-02-05 00:10:46.625461 | controller | {
2026-02-05 00:10:46.625538 | controller |   "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable",
2026-02-05 00:10:46.625593 | controller |   "description": "Docker CE Stable - $basearch",
2026-02-05 00:10:46.625658 | controller |   "gpgcheck": true,
2026-02-05 00:10:46.625721 | controller |   "name": "docker-ce-stable"
2026-02-05 00:10:46.625785 | controller | }
2026-02-05 00:10:46.656808 | 
2026-02-05 00:10:46.656954 | TASK [ensure-docker : Install pre-reqs]
2026-02-05 00:10:51.461861 | controller | ok: Nothing to do
2026-02-05 00:10:51.468279 | 
2026-02-05 00:10:51.468365 | TASK [ensure-docker : Remove packages]
2026-02-05 00:10:54.472988 | controller | ok: Nothing to do
2026-02-05 00:10:54.479632 | 
2026-02-05 00:10:54.479717 | TASK [ensure-docker : Install upstream docker using package]
2026-02-05 00:12:16.909974 | controller | changed
2026-02-05 00:12:16.918999 | 
2026-02-05 00:12:16.919251 | TASK [ensure-docker : Setup docker]
2026-02-05 00:12:16.954594 | controller | ok
2026-02-05 00:12:17.005562 | controller | included: /var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml
2026-02-05 00:12:17.028116 | 
2026-02-05 00:12:17.028317 | TASK [ensure-docker : Ensure "docker" group exists]
2026-02-05 00:12:18.016074 | controller | ok
2026-02-05 00:12:18.024992 | 
2026-02-05 00:12:18.025139 | TASK [ensure-docker : Add user to docker group]
2026-02-05 00:12:19.000168 | controller | changed
2026-02-05 00:12:19.008607 | 
2026-02-05 00:12:19.008705 | TASK [Update docker daemon proxy configuration]
2026-02-05 00:12:19.035101 | controller | skipping: Conditional result was False
2026-02-05 00:12:19.046634 | 
2026-02-05 00:12:19.046781 | TASK [Lower default MTU]
2026-02-05 00:12:19.061445 | controller | skipping: Conditional result was False
2026-02-05 00:12:19.069008 | 
2026-02-05 00:12:19.069132 | TASK [ensure-docker : Get the status of the docket.socket unit]
2026-02-05 00:12:19.831100 | controller | inactive
2026-02-05 00:12:20.428054 | controller | ok: Runtime: 0:00:00.018049
2026-02-05 00:12:20.444191 | 
2026-02-05 00:12:20.444385 | TASK [ensure-docker : Get the status of the docket unit]
2026-02-05 00:12:21.216681 | controller | inactive
2026-02-05 00:12:21.834985 | controller | ok: Runtime: 0:00:00.019957
2026-02-05 00:12:21.846404 | 
2026-02-05 00:12:21.846574 | TASK [ensure-docker : Restart docker]
2026-02-05 00:12:21.894485 | Trigger a Docker restart
2026-02-05 00:12:21.903764 | 
2026-02-05 00:12:21.903875 | TASK [ensure-docker : Reset ssh connection to pick up docker group]
2026-02-05 00:12:21.947204 | 
2026-02-05 00:12:21.947337 | TASK [ensure-docker : Install docker-compose]
2026-02-05 00:12:21.963365 | controller | skipping: Conditional result was False
2026-02-05 00:12:21.973132 | 
2026-02-05 00:12:21.973247 | TASK [ensure-docker : Flush handlers before role exit]
2026-02-05 00:12:21.983448 | 
2026-02-05 00:12:21.983516 | TASK [ensure-docker : Stop docker.socket to avoid any conflict]
2026-02-05 00:12:25.404155 | controller | changed
2026-02-05 00:12:25.417217 | 
2026-02-05 00:12:25.417371 | TASK [ensure-docker : Assure docker service is running]
2026-02-05 00:12:29.222692 | controller | changed
2026-02-05 00:12:29.235724 | 
2026-02-05 00:12:29.235882 | TASK [ensure-docker : Assure docker.socket service is running]
2026-02-05 00:12:30.875679 | controller | ok
2026-02-05 00:12:30.886395 | 
2026-02-05 00:12:30.886553 | TASK [ensure-docker : Correct group ownership on docker sock]
2026-02-05 00:12:31.862157 | controller | ok
2026-02-05 00:12:31.868885 | 
2026-02-05 00:12:31.868993 | TASK [ensure-docker : Validate ability to talk with docker]
2026-02-05 00:12:32.686481 | controller | CONTAINER ID   IMAGE     COMMAND   CREATED   STATUS    PORTS     NAMES
2026-02-05 00:12:33.232261 | controller | ok: Runtime: 0:00:00.039276
2026-02-05 00:12:33.241644 | 
2026-02-05 00:12:33.241925 | TASK [ensure-docker : Get version details]
2026-02-05 00:12:34.080798 | controller | Client: Docker Engine - Community
2026-02-05 00:12:34.082428 | controller |  Version:           24.0.7
2026-02-05 00:12:34.082470 | controller |  API version:       1.43
2026-02-05 00:12:34.082480 | controller |  Go version:        go1.20.10
2026-02-05 00:12:34.082499 | controller |  Git commit:        afdd53b
2026-02-05 00:12:34.082507 | controller |  Built:             Thu Oct 26 09:09:39 2023
2026-02-05 00:12:34.082514 | controller |  OS/Arch:           linux/amd64
2026-02-05 00:12:34.082523 | controller |  Context:           default
2026-02-05 00:12:34.082533 | controller |
2026-02-05 00:12:34.082539 | controller | Server: Docker Engine - Community
2026-02-05 00:12:34.082545 | controller |  Engine:
2026-02-05 00:12:34.082552 | controller |   Version:          24.0.7
2026-02-05 00:12:34.082557 | controller |   API version:      1.43 (minimum version 1.12)
2026-02-05 00:12:34.082563 | controller |   Go version:       go1.20.10
2026-02-05 00:12:34.082569 | controller |   Git commit:       311b9ff
2026-02-05 00:12:34.082576 | controller |   Built:            Thu Oct 26 09:08:11 2023
2026-02-05 00:12:34.082582 | controller |   OS/Arch:          linux/amd64
2026-02-05 00:12:34.082588 | controller |   Experimental:     false
2026-02-05 00:12:34.082594 | controller |  containerd:
2026-02-05 00:12:34.082601 | controller |   Version:          1.6.25
2026-02-05 00:12:34.082606 | controller |   GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f
2026-02-05 00:12:34.082613 | controller |  runc:
2026-02-05 00:12:34.082618 | controller |   Version:          1.1.10
2026-02-05 00:12:34.082625 | controller |   GitCommit:        v1.1.10-0-g18a0cb0
2026-02-05 00:12:34.082662 | controller |  docker-init:
2026-02-05 00:12:34.082670 | controller |   Version:          0.19.0
2026-02-05 00:12:34.082676 | controller |   GitCommit:        de40ad0
2026-02-05 00:12:34.642076 | controller | ok: Runtime: 0:00:00.042939
2026-02-05 00:12:34.649173 | 
2026-02-05 00:12:34.649268 | TASK [ensure-docker : Dump installed docker details]
2026-02-05 00:12:34.713874 | {'changed': True, 'stdout': 'Client: Docker Engine - Community\n Version:           24.0.7\n API version:       1.43\n Go version:        go1.20.10\n Git commit:        afdd53b\n Built:             Thu Oct 26 09:09:39 2023\n OS/Arch:           linux/amd64\n Context:           default\n\nServer: Docker Engine - Community\n Engine:\n  Version:          24.0.7\n  API version:      1.43 (minimum version 1.12)\n  Go version:       go1.20.10\n  Git commit:       311b9ff\n  Built:            Thu Oct 26 09:08:11 2023\n  OS/Arch:          linux/amd64\n  Experimental:     false\n containerd:\n  Version:          1.6.25\n  GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f\n runc:\n  Version:          1.1.10\n  GitCommit:        v1.1.10-0-g18a0cb0\n docker-init:\n  Version:          0.19.0\n  GitCommit:        de40ad0', 'stderr': '', 'rc': 0, 'cmd': ['docker', 'version'], 'start': '2026-02-05 00:12:34.040097', 'end': '2026-02-05 00:12:34.083036', 'delta': '0:00:00.042939', 'msg': '', 'zuul_log_id': 'fa163ec2-ffbe-1bb9-a795-000000000061-1-controller', 'stdout_lines': ['Client: Docker Engine - Community', ' Version:           24.0.7', ' API version:       1.43', ' Go version:        go1.20.10', ' Git commit:        afdd53b', ' Built:             Thu Oct 26 09:09:39 2023', ' OS/Arch:           linux/amd64', ' Context:           default', '', 'Server: Docker Engine - Community', ' Engine:', '  Version:          24.0.7', '  API version:      1.43 (minimum version 1.12)', '  Go version:       go1.20.10', '  Git commit:       311b9ff', '  Built:            Thu Oct 26 09:08:11 2023', '  OS/Arch:          linux/amd64', '  Experimental:     false', ' containerd:', '  Version:          1.6.25', '  GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f', ' runc:', '  Version:          1.1.10', '  GitCommit:        v1.1.10-0-g18a0cb0', ' docker-init:', '  Version:          0.19.0', '  GitCommit:        de40ad0'], 'stderr_lines': [], 'failed': False}
2026-02-05 00:12:34.730148 | 
2026-02-05 00:12:34.730291 | TASK [Use buildset registry]
2026-02-05 00:12:34.746066 | controller | skipping: Conditional result was False
2026-02-05 00:12:34.764996 | 
2026-02-05 00:12:34.765351 | TASK [Ensure python3.8 is present]
2026-02-05 00:12:34.780777 | controller | skipping: Conditional result was False
2026-02-05 00:12:34.791915 | 
2026-02-05 00:12:34.792077 | TASK [Run our-ensure-python role (Fedora only for now)]
2026-02-05 00:12:34.838178 | controller | ok
2026-02-05 00:12:34.866388 | 
2026-02-05 00:12:34.866726 | TASK [our-ensure-python : Install the right Python version (rpm)]
2026-02-05 00:12:40.988745 | controller | ok: Nothing to do
2026-02-05 00:12:40.994518 | 
2026-02-05 00:12:40.994585 | TASK [our-ensure-python : Also install python3-devel]
2026-02-05 00:12:58.499617 | controller | changed
2026-02-05 00:12:58.526189 | 
2026-02-05 00:12:58.526293 | TASK [Run ensure-virtualenv role]
2026-02-05 00:12:58.549008 | controller | ok
2026-02-05 00:12:58.581076 | 
2026-02-05 00:12:58.581200 | TASK [ensure-virtualenv : Check if virtualenv is installed]
2026-02-05 00:12:59.328198 | controller | /usr/bin/virtualenv
2026-02-05 00:12:59.944323 | controller | ok: Runtime: 0:00:00.004599
2026-02-05 00:12:59.960260 | 
2026-02-05 00:12:59.960450 | LOOP [ensure-virtualenv : Install virtualenv package]
2026-02-05 00:12:59.982699 | controller | skipping: Conditional result was False
2026-02-05 00:12:59.983163 | controller | changed: All items complete
2026-02-05 00:12:59.983201 | 
2026-02-05 00:13:00.004594 | 
2026-02-05 00:13:00.004748 | TASK [Find the full path of the Python interpreter]
2026-02-05 00:13:00.776055 | controller | /usr/bin/python3.8
2026-02-05 00:13:01.367761 | controller | ok
2026-02-05 00:13:01.382109 | 
2026-02-05 00:13:01.382289 | TASK [Create virtualenv for ansible-test with a specific interpreter]
2026-02-05 00:13:03.796259 | controller | created virtual environment CPython3.8.18.final.0-64 in 1139ms
2026-02-05 00:13:03.915699 | controller |   creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False)
2026-02-05 00:13:03.915754 | controller |   seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv)
2026-02-05 00:13:03.915771 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2026-02-05 00:13:03.915791 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2026-02-05 00:13:04.296759 | controller | changed
2026-02-05 00:13:04.304806 | 
2026-02-05 00:13:04.304912 | TASK [Set selinux package]
2026-02-05 00:13:04.328121 | controller | ok
2026-02-05 00:13:04.335617 | 
2026-02-05 00:13:04.335709 | TASK [Set selinux package (Fedora)]
2026-02-05 00:13:04.371487 | controller | ok
2026-02-05 00:13:04.380441 | 
2026-02-05 00:13:04.380553 | TASK [Install selinux into virtualenv]
2026-02-05 00:13:10.114789 | controller | Collecting selinux-please-lie-to-me
2026-02-05 00:13:10.246534 | controller |   Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB)
2026-02-05 00:13:11.473470 | controller | Collecting setuptools<50.0.0
2026-02-05 00:13:11.482242 | controller |   Downloading setuptools-49.6.0-py3-none-any.whl (803 kB)
2026-02-05 00:13:11.570750 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 9.5 MB/s eta 0:00:00
2026-02-05 00:13:11.698174 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me
2026-02-05 00:13:11.698391 | controller |   Attempting uninstall: setuptools
2026-02-05 00:13:11.699534 | controller |     Found existing installation: setuptools 62.6.0
2026-02-05 00:13:11.823083 | controller |     Uninstalling setuptools-62.6.0:
2026-02-05 00:13:11.837660 | controller |       Successfully uninstalled setuptools-62.6.0
2026-02-05 00:13:12.570229 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0
2026-02-05 00:13:12.785618 | controller |
2026-02-05 00:13:13.021865 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2026-02-05 00:13:13.021912 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2026-02-05 00:13:13.266790 | controller | ok: Runtime: 0:00:07.493144
2026-02-05 00:13:13.276812 | 
2026-02-05 00:13:13.276927 | TASK [Install pytest-forked into virtualenv]
2026-02-05 00:13:15.027935 | controller | Collecting pytest-forked
2026-02-05 00:13:15.086624 | controller |   Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB)
2026-02-05 00:13:15.300259 | controller | Collecting pytest>=3.10
2026-02-05 00:13:15.306052 | controller |   Downloading pytest-8.3.5-py3-none-any.whl (343 kB)
2026-02-05 00:13:15.353954 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 343.6/343.6 kB 8.4 MB/s eta 0:00:00
2026-02-05 00:13:15.419785 | controller | Collecting py
2026-02-05 00:13:15.426538 | controller |   Downloading py-1.11.0-py2.py3-none-any.whl (98 kB)
2026-02-05 00:13:15.441498 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 11.3 MB/s eta 0:00:00
2026-02-05 00:13:15.564946 | controller | Collecting tomli>=1
2026-02-05 00:13:15.573998 | controller |   Downloading tomli-2.4.0-py3-none-any.whl (14 kB)
2026-02-05 00:13:15.659712 | controller | Collecting packaging
2026-02-05 00:13:15.667036 | controller |   Downloading packaging-26.0-py3-none-any.whl (74 kB)
2026-02-05 00:13:15.680064 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 8.7 MB/s eta 0:00:00
2026-02-05 00:13:15.708619 | controller | Collecting iniconfig
2026-02-05 00:13:15.714952 | controller |   Downloading iniconfig-2.1.0-py3-none-any.whl (6.0 kB)
2026-02-05 00:13:15.790562 | controller | Collecting exceptiongroup>=1.0.0rc8
2026-02-05 00:13:15.797191 | controller |   Downloading exceptiongroup-1.3.1-py3-none-any.whl (16 kB)
2026-02-05 00:13:15.867510 | controller | Collecting pluggy<2,>=1.5
2026-02-05 00:13:15.874592 | controller |   Downloading pluggy-1.5.0-py3-none-any.whl (20 kB)
2026-02-05 00:13:15.975986 | controller | Collecting typing-extensions>=4.6.0
2026-02-05 00:13:15.982592 | controller |   Downloading typing_extensions-4.13.2-py3-none-any.whl (45 kB)
2026-02-05 00:13:15.995764 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.8/45.8 kB 5.0 MB/s eta 0:00:00
2026-02-05 00:13:16.121089 | controller | Installing collected packages: typing-extensions, tomli, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked
2026-02-05 00:13:17.272659 | controller | Successfully installed exceptiongroup-1.3.1 iniconfig-2.1.0 packaging-26.0 pluggy-1.5.0 py-1.11.0 pytest-8.3.5 pytest-forked-1.6.0 tomli-2.4.0 typing-extensions-4.13.2
2026-02-05 00:13:17.281744 | controller |
2026-02-05 00:13:17.587286 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2026-02-05 00:13:17.587341 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2026-02-05 00:13:18.160872 | controller | ok: Runtime: 0:00:03.388964
2026-02-05 00:13:18.176400 | 
2026-02-05 00:13:18.176557 | TASK [Update pip]
2026-02-05 00:13:20.448604 | controller | Requirement already satisfied: pip in ./venv/lib/python3.8/site-packages (22.2.2)
2026-02-05 00:13:20.890807 | controller | Collecting pip
2026-02-05 00:13:20.965502 | controller |   Downloading pip-25.0.1-py3-none-any.whl (1.8 MB)
2026-02-05 00:13:21.070447 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 19.7 MB/s eta 0:00:00
2026-02-05 00:13:21.217475 | controller | Installing collected packages: pip
2026-02-05 00:13:21.219321 | controller |   Attempting uninstall: pip
2026-02-05 00:13:21.223078 | controller |     Found existing installation: pip 22.2.2
2026-02-05 00:13:21.831733 | controller |     Uninstalling pip-22.2.2:
2026-02-05 00:13:21.901442 | controller |       Successfully uninstalled pip-22.2.2
2026-02-05 00:13:24.155384 | controller | Successfully installed pip-25.0.1
2026-02-05 00:13:24.580904 | controller | ok: Runtime: 0:00:05.143832
2026-02-05 00:13:24.599798 | 
2026-02-05 00:13:24.599980 | TASK [Ensure pip temp directory exists in /var/tmp]
2026-02-05 00:13:25.743612 | controller | changed
2026-02-05 00:13:25.752918 | 
2026-02-05 00:13:25.753065 | TASK [Install ansible into virtualenv]
2026-02-05 00:13:27.839326 | controller | Processing ./src/github.com/ansible/ansible
2026-02-05 00:13:27.840931 | controller |   Preparing metadata (setup.py): started
2026-02-05 00:13:30.027004 | controller |   Preparing metadata (setup.py): finished with status 'done'
2026-02-05 00:13:30.097867 | controller | Collecting jinja2 (from ansible==2.9.27.post0)
2026-02-05 00:13:30.114705 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB)
2026-02-05 00:13:30.209995 | controller | Collecting PyYAML (from ansible==2.9.27.post0)
2026-02-05 00:13:30.215575 | controller |   Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.1 kB)
2026-02-05 00:13:30.720233 | controller | Collecting cryptography (from ansible==2.9.27.post0)
2026-02-05 00:13:30.727712 | controller |   Downloading cryptography-46.0.4-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB)
2026-02-05 00:13:31.022024 | controller | Collecting cffi>=1.14 (from cryptography->ansible==2.9.27.post0)
2026-02-05 00:13:31.028624 | controller |   Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB)
2026-02-05 00:13:31.039605 | controller | Requirement already satisfied: typing-extensions>=4.13.2 in ./venv/lib/python3.8/site-packages (from cryptography->ansible==2.9.27.post0) (4.13.2)
2026-02-05 00:13:31.177063 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible==2.9.27.post0)
2026-02-05 00:13:31.184328 | controller |   Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (3.0 kB)
2026-02-05 00:13:31.222062 | controller | Collecting pycparser (from cffi>=1.14->cryptography->ansible==2.9.27.post0)
2026-02-05 00:13:31.228431 | controller |   Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes)
2026-02-05 00:13:31.247125 | controller | Downloading cryptography-46.0.4-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2026-02-05 00:13:31.334364 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 58.5 MB/s eta 0:00:00
2026-02-05 00:13:31.344268 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2026-02-05 00:13:31.374892 | controller | Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB)
2026-02-05 00:13:31.401800 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.0/806.0 kB 26.7 MB/s eta 0:00:00
2026-02-05 00:13:31.410873 | controller | Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB)
2026-02-05 00:13:31.433056 | controller | Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (26 kB)
2026-02-05 00:13:31.451569 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB)
2026-02-05 00:13:31.486152 | controller | Building wheels for collected packages: ansible
2026-02-05 00:13:31.487152 | controller |   Building wheel for ansible (setup.py): started
2026-02-05 00:13:42.128665 | controller |   Building wheel for ansible (setup.py): finished with status 'done'
2026-02-05 00:13:42.147137 | controller |   Created wheel for ansible: filename=ansible-2.9.27.post0-py3-none-any.whl size=16207514 sha256=6e93d9d0ee482aec90735677bcb9dd3c186299f499c4601724273bdb13571bbb
2026-02-05 00:13:42.147440 | controller |   Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-9nvdf9ie/wheels/a5/4b/fa/b6deaae105422b0b3b92831e0369d44bf7fca5bb3413d79be7
2026-02-05 00:13:42.228183 | controller | Successfully built ansible
2026-02-05 00:13:42.407065 | controller | Installing collected packages: PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible
2026-02-05 00:13:56.377922 | controller | Successfully installed MarkupSafe-2.1.5 PyYAML-6.0.3 ansible-2.9.27.post0 cffi-1.17.1 cryptography-46.0.4 jinja2-3.1.6 pycparser-2.23
2026-02-05 00:13:57.145620 | controller | ok: Runtime: 0:00:29.779094
2026-02-05 00:13:57.154834 | 
2026-02-05 00:13:57.154923 | TASK [Setup download-artifact-fork role]
2026-02-05 00:13:57.178471 | controller | ok
2026-02-05 00:13:57.209047 | 
2026-02-05 00:13:57.209166 | TASK [download-artifact-fork : Parse inventory response]
2026-02-05 00:13:57.241535 | controller | ok
2026-02-05 00:13:57.249376 | 
2026-02-05 00:13:57.249455 | TASK [download-artifact-fork : Fetch info from Zuul API]
2026-02-05 00:13:57.275091 | controller | skipping: Conditional result was False
2026-02-05 00:13:57.282753 | 
2026-02-05 00:13:57.282841 | TASK [download-artifact-fork : Parse build response]
2026-02-05 00:13:57.307293 | controller | skipping: Conditional result was False
2026-02-05 00:13:57.317433 | 
2026-02-05 00:13:57.317567 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2026-02-05 00:13:58.158477 | controller | changed
2026-02-05 00:13:58.171787 | 
2026-02-05 00:13:58.171911 | LOOP [download-artifact-fork : Download archive by type]
2026-02-05 00:13:58.213284 | controller | skipping: Conditional result was False
2026-02-05 00:13:58.213600 | 
2026-02-05 00:14:00.378681 | controller | changed: OK (20193 bytes)
2026-02-05 00:14:00.402218 | 
2026-02-05 00:14:00.402333 | TASK [deploy-artifacts : define __collections]
2026-02-05 00:14:00.434938 | controller | ok
2026-02-05 00:14:00.445247 | 
2026-02-05 00:14:00.445390 | LOOP [deploy-artifacts : Create list of collections]
2026-02-05 00:14:00.482958 | controller | skipping: Conditional result was False
2026-02-05 00:14:00.495699 | controller | ok:
2026-02-05 00:14:00.495881 | controller | {
2026-02-05 00:14:00.495910 | controller |   "branch": "main",
2026-02-05 00:14:00.495929 | controller |   "job": "build-ansible-collection",
2026-02-05 00:14:00.495946 | controller |   "metadata": {
2026-02-05 00:14:00.495963 | controller |     "type": "ansible_collection",
2026-02-05 00:14:00.495979 | controller |     "version": "5.0.0"
2026-02-05 00:14:00.495995 | controller |   },
2026-02-05 00:14:00.496010 | controller |   "name": "ansible.network",
2026-02-05 00:14:00.496067 | controller |   "project": "ansible-collections/ansible.network",
2026-02-05 00:14:00.496085 | controller |   "url": "https://58392405ffaf4d36757d-d385a5eb6a9c8a0109e28831e3925824.ssl.cf5.rackcdn.com/ansible/669fcd407ac442ed9308993aa06c3840/artifacts/ansible-network-5.0.0.tar.gz"
2026-02-05 00:14:00.496107 | controller | }
2026-02-05 00:14:00.565191 | 
2026-02-05 00:14:00.565320 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2026-02-05 00:14:01.716567 | controller | Process install dependency map
2026-02-05 00:14:56.164829 | controller | |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/Starting collection install process
2026-02-05 00:14:56.265808 | controller | |Installing 'ansible.network:5.0.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/network'
2026-02-05 00:14:56.265874 | controller | Installing 'ansible.netcommon:8.4.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-02-05 00:14:57.974927 | controller | /-\|/-\|/-\|/-\|/Installing 'ansible.utils:6.0.1' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-02-05 00:14:59.722061 | controller | -\|/-\|/-\|/-\|/-Installing 'arista.eos:12.0.0' to '/home/zuul/.ansible/collections/ansible_collections/arista/eos'
2026-02-05 00:15:02.231408 | controller | \|/-\|/-\|/-\|/-\|/-\|/-\Installing 'cisco.ios:11.2.0' to '/home/zuul/.ansible/collections/ansible_collections/cisco/ios'
2026-02-05 00:15:05.254039 | controller | |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/Installing 'cisco.iosxr:12.1.1' to '/home/zuul/.ansible/collections/ansible_collections/cisco/iosxr'
2026-02-05 00:15:07.970814 | controller | -\|/-\|/-\|/-\|/-\|/-\|/-\|Installing 'cisco.nxos:11.1.3' to '/home/zuul/.ansible/collections/ansible_collections/cisco/nxos'
2026-02-05 00:15:12.514458 | controller | /-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/Installing 'junipernetworks.junos:11.0.0' to '/home/zuul/.ansible/collections/ansible_collections/junipernetworks/junos'
2026-02-05 00:15:15.461086 | controller | ok: Runtime: 0:01:13.802221
2026-02-05 00:15:15.477210 | 
2026-02-05 00:15:15.477706 | TASK [podman may need iptables kernel modules]
2026-02-05 00:15:16.864685 | controller | ok: Runtime: 0:00:00.008082
2026-02-05 00:15:16.925349 | 
2026-02-05 00:15:16.925555 | PLAY RECAP
2026-02-05 00:15:16.925648 | controller | ok: 46 changed: 26 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0
2026-02-05 00:15:16.925698 | 
2026-02-05 00:15:17.092724 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-05 00:15:17.094881 | RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2026-02-05 00:15:17.797703 | 
2026-02-05 00:15:17.797842 | PLAY [controller]
2026-02-05 00:15:17.823568 | 
2026-02-05 00:15:17.823703 | TASK [Copy the galaxy.yml on the controller]
2026-02-05 00:15:21.436184 | controller | changed
2026-02-05 00:15:21.442749 | 
2026-02-05 00:15:21.442869 | TASK [Load information from galaxy.yml]
2026-02-05 00:15:21.473551 | controller | ok
2026-02-05 00:15:21.480903 | 
2026-02-05 00:15:21.481010 | LOOP [Enable FIPS mode]
2026-02-05 00:15:21.511155 | 
2026-02-05 00:15:21.511305 | LOOP [ansible-test : Include branch specific variables.]
2026-02-05 00:15:21.549284 | controller | ok: "/var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/untrusted/project_2/github.com/ansible/ansible-zuul-jobs/roles/ansible-test/vars/default.yaml"
2026-02-05 00:15:21.549425 | 
2026-02-05 00:15:21.563219 | 
2026-02-05 00:15:21.563350 | TASK [ansible-test : Setup --skip-tags for test_options]
2026-02-05 00:15:21.621962 | controller | ok
2026-02-05 00:15:21.635999 | 
2026-02-05 00:15:21.636141 | TASK [ansible-test : Enable --inventory for network-integration]
2026-02-05 00:15:21.660284 | controller | skipping: Conditional result was False
2026-02-05 00:15:21.668517 | 
2026-02-05 00:15:21.668611 | TASK [ansible-test : Enable --retry-on-error]
2026-02-05 00:15:21.692626 | controller | skipping: Conditional result was False
2026-02-05 00:15:21.699437 | 
2026-02-05 00:15:21.699544 | TASK [ansible-test : Enable --continue-on-error]
2026-02-05 00:15:21.732793 | controller | ok
2026-02-05 00:15:21.743731 | 
2026-02-05 00:15:21.743857 | TASK [ansible-test : Enable --requirements]
2026-02-05 00:15:21.760008 | controller | skipping: Conditional result was False
2026-02-05 00:15:21.770589 | 
2026-02-05 00:15:21.770726 | TASK [ansible-test : Adjust options for unit tests]
2026-02-05 00:15:21.785928 | controller | skipping: Conditional result was False
2026-02-05 00:15:21.796817 | 
2026-02-05 00:15:21.796966 | TASK [ansible-test : Install requirements with unit tests]
2026-02-05 00:15:21.832654 | controller | ok
2026-02-05 00:15:21.867658 | 
2026-02-05 00:15:21.867786 | TASK [ansible-test : Set --skip-test]
2026-02-05 00:15:21.915605 | controller | skipping: Conditional result was False
2026-02-05 00:15:21.923256 | 
2026-02-05 00:15:21.923343 | TASK [ansible-test : Reduce verbosity]
2026-02-05 00:15:21.958244 | controller | ok
2026-02-05 00:15:21.965194 | 
2026-02-05 00:15:21.965281 | TASK [ansible-test : Setup --python option]
2026-02-05 00:15:21.989970 | controller | skipping: Conditional result was False
2026-02-05 00:15:22.003948 | 
2026-02-05 00:15:22.004095 | TASK [ansible-test : Setup --docker option]
2026-02-05 00:15:22.034813 | controller | ok
2026-02-05 00:15:22.049189 | 
2026-02-05 00:15:22.049323 | TASK [ansible-test : check if MANIFEST.json exists]
2026-02-05 00:15:23.386549 | controller | ok
2026-02-05 00:15:23.400625 | 
2026-02-05 00:15:23.400792 | TASK [ansible-test : Copy the MANIFEST.json on the controller]
2026-02-05 00:15:23.428312 | controller | skipping: Conditional result was False
2026-02-05 00:15:23.445242 | 
2026-02-05 00:15:23.445436 | TASK [ansible-test : Load information from MANIFEST.json]
2026-02-05 00:15:23.475099 | controller | skipping: Conditional result was False
2026-02-05 00:15:23.494227 | 
2026-02-05 00:15:23.494406 | TASK [ansible-test : Setup location of project for integration tests]
2026-02-05 00:15:23.562425 | controller | skipping: Conditional result was False
2026-02-05 00:15:23.572463 | 
2026-02-05 00:15:23.572574 | TASK [ansible-test : Copy the galaxy.yml on the controller]
2026-02-05 00:15:24.819671 | controller | ok
2026-02-05 00:15:24.836459 | 
2026-02-05 00:15:24.836641 | TASK [ansible-test : Load information from galaxy.yml]
2026-02-05 00:15:24.892420 | controller | ok
2026-02-05 00:15:24.903218 | 
2026-02-05 00:15:24.903313 | TASK [ansible-test : Setup location of project for integration tests]
2026-02-05 00:15:24.961923 | controller | ok
2026-02-05 00:15:24.971970 | 
2026-02-05 00:15:24.972143 | TASK [ansible-test : Setup minimum test requirements]
2026-02-05 00:15:25.005313 | controller | ok
2026-02-05 00:15:25.013043 | 
2026-02-05 00:15:25.013151 | TASK [ansible-test : Ensure pip temp directory exists in /var/tmp]
2026-02-05 00:15:25.926948 | controller | ok
2026-02-05 00:15:25.938944 | 
2026-02-05 00:15:25.939153 | TASK [ansible-test : Install python requirements]
2026-02-05 00:15:27.513366 | controller | Collecting yamllint (from -r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2026-02-05 00:15:27.531287 | controller |   Downloading yamllint-1.35.1-py3-none-any.whl.metadata (4.2 kB)
2026-02-05 00:15:27.574302 | controller | Collecting pathspec>=0.5.3 (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2026-02-05 00:15:27.582877 | controller |   Downloading pathspec-0.12.1-py3-none-any.whl.metadata (21 kB)
2026-02-05 00:15:27.592977 | controller | Requirement already satisfied: pyyaml in ./venv/lib64/python3.8/site-packages (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1)) (6.0.3)
2026-02-05 00:15:27.602015 | controller | Downloading yamllint-1.35.1-py3-none-any.whl (66 kB)
2026-02-05 00:15:27.619113 | controller | Downloading pathspec-0.12.1-py3-none-any.whl (31 kB)
2026-02-05 00:15:27.695681 | controller | Installing collected packages: pathspec, yamllint
2026-02-05 00:15:27.802492 | controller | Successfully installed pathspec-0.12.1 yamllint-1.35.1
2026-02-05 00:15:28.311981 | controller | ok: Runtime: 0:00:01.131414
2026-02-05 00:15:28.322496 | 
2026-02-05 00:15:28.322645 | TASK [ansible-test : Copy the integration_config.yml file from the controller]
2026-02-05 00:15:29.150368 | controller | cp: cannot stat '/tmp/integration_config.yml': No such file or directory
2026-02-05 00:15:29.688051 | controller | ERROR
2026-02-05 00:15:29.688321 | controller | {
2026-02-05 00:15:29.688360 | controller |   "delta": "0:00:00.008532",
2026-02-05 00:15:29.688386 | controller |   "end": "2026-02-05 00:15:29.150664",
2026-02-05 00:15:29.688409 | controller |   "msg": "non-zero return code",
2026-02-05 00:15:29.688457 | controller |   "rc": 1,
2026-02-05 00:15:29.688483 | controller |   "start": "2026-02-05 00:15:29.142132"
2026-02-05 00:15:29.688507 | controller | }
2026-02-05 00:15:29.688537 | controller | ERROR: Ignoring Errors
2026-02-05 00:15:29.698477 | 
2026-02-05 00:15:29.698627 | TASK [ansible-test : Copy potential cloud provider configuration for ansible-test in the collection]
2026-02-05 00:15:30.071647 | controller | skipping: Conditional result was False
2026-02-05 00:15:30.080131 | 
2026-02-05 00:15:30.080282 | TASK [ansible-test : Enable persistent connection logging]
2026-02-05 00:15:31.368519 | controller | changed: section and option added
2026-02-05 00:15:31.377764 | 
2026-02-05 00:15:31.377863 | TASK [ansible-test : Set persistent ssh_type value]
2026-02-05 00:15:32.398661 | controller | changed: option added
2026-02-05 00:15:32.405273 | 
2026-02-05 00:15:32.405371 | TASK [ansible-test : Set ansible log path]
2026-02-05 00:15:33.610011 | controller | changed: section and option added
2026-02-05 00:15:33.625464 | 
2026-02-05 00:15:33.625639 | TASK [ansible-test : Identify the changed targets]
2026-02-05 00:15:33.999891 | controller | skipping: Conditional result was False
2026-02-05 00:15:34.009335 | 
2026-02-05 00:15:34.009434 | TASK [ansible-test : set_fact]
2026-02-05 00:15:34.076112 | controller | skipping: Conditional result was False
2026-02-05 00:15:34.094831 | 
2026-02-05 00:15:34.095061 | TASK [ansible-test : Set the targets]
2026-02-05 00:15:34.130322 | controller | ok
2026-02-05 00:15:34.168809 | 
2026-02-05 00:15:34.168931 | TASK [ansible-test : set_fact]
2026-02-05 00:15:34.192993 | controller | skipping: Conditional result was False
2026-02-05 00:15:34.200750 | 
2026-02-05 00:15:34.200862 | TASK [ansible-test : List the targets]
2026-02-05 00:15:34.558575 | controller | skipping: Conditional result was False
2026-02-05 00:15:34.575525 | 
2026-02-05 00:15:34.575723 | TASK [ansible-test : set_fact]
2026-02-05 00:15:34.603565 | controller | skipping: Conditional result was False
2026-02-05 00:15:34.620453 | 
2026-02-05 00:15:34.620645 | TASK [ansible-test : set_fact]
2026-02-05 00:15:34.639003 | controller | skipping: Conditional result was False
2026-02-05 00:15:34.656380 | 
2026-02-05 00:15:34.656798 | LOOP [ansible-test : set_fact]
2026-02-05 00:15:34.723975 | 
2026-02-05 00:15:34.724199 | TASK [ansible-test : set_fact]
2026-02-05 00:15:34.750081 | controller | skipping: Conditional result was False
2026-02-05 00:15:34.760184 | 
2026-02-05 00:15:34.760314 | TASK [ansible-test : debug]
2026-02-05 00:15:34.786659 | controller | skipping: Conditional result was False
2026-02-05 00:15:34.795701 | 
2026-02-05 00:15:34.795968 | TASK [ansible-test : debug]
2026-02-05 00:15:34.831329 | About to run: ansible-test sanity --requirements --docker -v
2026-02-05 00:15:34.839401 | 
2026-02-05 00:15:34.839869 | TASK [ansible-test : Run the test suite]
2026-02-05 00:15:36.916526 | controller | Run command: docker images quay.io/ansible/default-test-container:1.10.1 --format '{{json .}}'
2026-02-05 00:15:37.010842 | controller | Run command: docker pull quay.io/ansible/default-test-container:1.10.1
2026-02-05 00:15:38.711753 | controller | 1.10.1: Pulling from ansible/default-test-container
2026-02-05 00:15:38.718728 | controller | [DEPRECATION NOTICE] Docker Image Format v1, and Docker Image manifest version 2, schema 1 support will be removed in an upcoming release. Suggest the author of quay.io/ansible/default-test-container:1.10.1 to upgrade the image to the OCI Format, or Docker Image manifest v2, schema 2. More information at https://docs.docker.com/go/deprecated-image-specs/
2026-02-05 00:15:38.718773 | controller | 5667fdb72017: Pulling fs layer
2026-02-05 00:15:38.718782 | controller | d83811f270d5: Pulling fs layer
2026-02-05 00:15:38.718789 | controller | ee671aafb583: Pulling fs layer
2026-02-05 00:15:38.718799 | controller | 7fc152dfb3a6: Pulling fs layer
2026-02-05 00:15:38.718808 | controller | 3fb967a6fd03: Pulling fs layer
2026-02-05 00:15:38.718814 | controller | b3e63023ca5f: Pulling fs layer
2026-02-05 00:15:38.718820 | controller | 653cb3e65dbf: Pulling fs layer
2026-02-05 00:15:38.718827 | controller | f4712b586375: Pulling fs layer
2026-02-05 00:15:38.718833 | controller | d696ed7812f8: Pulling fs layer
2026-02-05 00:15:38.718841 | controller | 29bf28764f14: Pulling fs layer
2026-02-05 00:15:38.718848 | controller | 47d7edb3c2b7: Pulling fs layer
2026-02-05 00:15:38.718854 | controller | 07550ad4f6e4: Pulling fs layer
2026-02-05 00:15:38.718860 | controller | 7e79526e64c5: Pulling fs layer
2026-02-05 00:15:38.718877 | controller | 4fffb32882b7: Pulling fs layer
2026-02-05 00:15:39.797772 | controller | fc7a38b06f4e: Pulling fs layer
2026-02-05 00:15:39.797850 | controller | 6d9d912e060e: Pulling fs layer
2026-02-05 00:15:39.797860 | controller | 5dd542dd28d9: Pulling fs layer
2026-02-05 00:15:39.797867 | controller | cef8beb99552: Pulling fs layer
2026-02-05 00:15:39.797880 | controller | bd5557e101ad: Pulling fs layer
2026-02-05 00:15:39.797886 | controller | e057c20fabdd: Pulling fs layer
2026-02-05 00:15:39.797895 | controller | d16059cdae2e: Pulling fs layer
2026-02-05 00:15:39.797901 | controller | 431e42d906a3: Pulling fs layer
2026-02-05 00:15:39.797907 | controller | 7a0fd3b1d7c3: Pulling fs layer
2026-02-05 00:15:39.797913 | controller | aacdb6db0c8c: Pulling fs layer
2026-02-05 00:15:39.797919 | controller | 2e7f04ae8c8b: Pulling fs layer
2026-02-05 00:15:39.797924 | controller | 4cd343027a44: Pulling fs layer
2026-02-05 00:15:39.797931 | controller | 0b4379883f90: Pulling fs layer
2026-02-05 00:15:39.797937 | controller | 3d9d6d9dfc91: Pulling fs layer
2026-02-05 00:15:39.797946 | controller | 57d6314bd293: Pulling fs layer
2026-02-05 00:15:39.797952 | controller | 774036afeb7f: Pulling fs layer
2026-02-05 00:15:39.797958 | controller | 54b10f0e1645: Pulling fs layer
2026-02-05 00:15:39.797964 | controller | 78cf439d9fdb: Pulling fs layer
2026-02-05 00:15:39.797970 | controller | 36e5e20969c7: Pulling fs layer
2026-02-05 00:15:39.797976 | controller | 4b19ac3f17a8: Pulling fs layer
2026-02-05 00:15:39.797982 | controller | bd5557e101ad: Waiting
2026-02-05 00:15:39.797988 | controller | e057c20fabdd: Waiting
2026-02-05 00:15:39.797997 | controller | d16059cdae2e: Waiting
2026-02-05 00:15:39.798003 | controller | 431e42d906a3: Waiting
2026-02-05 00:15:39.798009 | controller | 7a0fd3b1d7c3: Waiting
2026-02-05 00:15:39.798014 | controller | aacdb6db0c8c: Waiting
2026-02-05 00:15:39.798020 | controller | 2e7f04ae8c8b: Waiting
2026-02-05 00:15:39.798026 | controller | 4cd343027a44: Waiting
2026-02-05 00:15:39.798032 | controller | 0b4379883f90: Waiting
2026-02-05 00:15:39.798038 | controller | 3d9d6d9dfc91: Waiting
2026-02-05 00:15:39.798044 | controller | 57d6314bd293: Waiting
2026-02-05 00:15:39.798050 | controller | 774036afeb7f: Waiting
2026-02-05 00:15:39.798056 | controller | 54b10f0e1645: Waiting
2026-02-05 00:15:39.798062 | controller | 78cf439d9fdb: Waiting
2026-02-05 00:15:39.798070 | controller | 36e5e20969c7: Waiting
2026-02-05 00:15:39.798076 | controller | 4b19ac3f17a8: Waiting
2026-02-05 00:15:39.798082 | controller | 7fc152dfb3a6: Waiting
2026-02-05 00:15:39.798088 | controller | 3fb967a6fd03: Waiting
2026-02-05 00:15:39.798093 | controller | b3e63023ca5f: Waiting
2026-02-05 00:15:39.798099 | controller | 653cb3e65dbf: Waiting
2026-02-05 00:15:39.798105 | controller | f4712b586375: Waiting
2026-02-05 00:15:39.798111 | controller | d696ed7812f8: Waiting
2026-02-05 00:15:39.798117 | controller | 29bf28764f14: Waiting
2026-02-05 00:15:39.798123 | controller | 47d7edb3c2b7: Waiting
2026-02-05 00:15:39.798129 | controller | 07550ad4f6e4: Waiting
2026-02-05 00:15:39.798135 | controller | 7e79526e64c5: Waiting
2026-02-05 00:15:39.798143 | controller | 4fffb32882b7: Waiting
2026-02-05 00:15:39.798159 | controller | fc7a38b06f4e: Waiting
2026-02-05 00:15:39.798167 | controller | 6d9d912e060e: Waiting
2026-02-05 00:15:39.798173 | controller | 5dd542dd28d9: Waiting
2026-02-05 00:15:39.798178 | controller | cef8beb99552: Waiting
2026-02-05 00:15:39.798192 | controller | ee671aafb583: Verifying Checksum
2026-02-05 00:15:40.086941 | controller | ee671aafb583: Download complete
2026-02-05 00:15:40.087019 | controller | d83811f270d5: Verifying Checksum
2026-02-05 00:15:40.924987 | controller | d83811f270d5: Download complete
2026-02-05 00:15:40.925062 | controller | 7fc152dfb3a6: Verifying Checksum
2026-02-05 00:15:41.838387 | controller | 7fc152dfb3a6: Download complete
2026-02-05 00:15:41.838540 | controller | b3e63023ca5f: Verifying Checksum
2026-02-05 00:15:42.756522 | controller | b3e63023ca5f: Download complete
2026-02-05 00:15:42.756579 | controller | 653cb3e65dbf: Verifying Checksum
2026-02-05 00:15:45.376770 | controller | 653cb3e65dbf: Download complete
2026-02-05 00:15:45.376832 | controller | 5667fdb72017: Verifying Checksum
2026-02-05 00:15:45.377445 | controller | 5667fdb72017: Download complete
2026-02-05 00:15:46.205374 | controller | d696ed7812f8: Verifying Checksum
2026-02-05 00:15:46.205503 | controller | d696ed7812f8: Download complete
2026-02-05 00:15:46.559924 | controller | 3fb967a6fd03: Verifying Checksum
2026-02-05 00:15:47.001459 | controller | 3fb967a6fd03: Download complete
2026-02-05 00:15:47.001569 | controller | 29bf28764f14: Verifying Checksum
2026-02-05 00:15:47.848219 | controller | 29bf28764f14: Download complete
2026-02-05 00:15:47.848312 | controller | 07550ad4f6e4: Verifying Checksum
2026-02-05 00:15:47.848349 | controller | 07550ad4f6e4: Download complete
2026-02-05 00:15:47.878014 | controller | 47d7edb3c2b7: Verifying Checksum
2026-02-05 00:15:47.878065 | controller | 47d7edb3c2b7: Download complete
2026-02-05 00:15:48.162565 | controller | 5667fdb72017: Pull complete
2026-02-05 00:15:48.212254 | controller | d83811f270d5: Pull complete
2026-02-05 00:15:48.252952 | controller | ee671aafb583: Pull complete
2026-02-05 00:15:48.297255 | controller | 7fc152dfb3a6: Pull complete
2026-02-05 00:15:48.613724 | controller | 7e79526e64c5: Verifying Checksum
2026-02-05 00:15:48.613778 | controller | 7e79526e64c5: Download complete
2026-02-05 00:15:48.711301 | controller | 4fffb32882b7: Verifying Checksum
2026-02-05 00:15:48.711587 | controller | 4fffb32882b7: Download complete
2026-02-05 00:15:49.364019 | controller | 3fb967a6fd03: Pull complete
2026-02-05 00:15:49.404169 | controller | b3e63023ca5f: Pull complete
2026-02-05 00:15:49.440527 | controller | 653cb3e65dbf: Pull complete
2026-02-05 00:15:49.497177 | controller | 6d9d912e060e: Verifying Checksum
2026-02-05 00:15:50.098211 | controller | 6d9d912e060e: Download complete
2026-02-05 00:15:50.098275 | controller | fc7a38b06f4e: Download complete
2026-02-05 00:15:50.304849 | controller | 5dd542dd28d9: Verifying Checksum
2026-02-05 00:15:50.304903 | controller | 5dd542dd28d9: Download complete
2026-02-05 00:15:51.018759 | controller | bd5557e101ad: Verifying Checksum
2026-02-05 00:15:51.840381 | controller | bd5557e101ad: Download complete
2026-02-05 00:15:51.840444 | controller | e057c20fabdd: Verifying Checksum
2026-02-05 00:15:51.842964 | controller | e057c20fabdd: Download complete
2026-02-05 00:15:52.690467 | controller | d16059cdae2e: Verifying Checksum
2026-02-05 00:15:54.395325 | controller | d16059cdae2e: Download complete
2026-02-05 00:15:54.395393 | controller | 431e42d906a3: Verifying Checksum
2026-02-05 00:15:55.695327 | controller | 431e42d906a3: Download complete
2026-02-05 00:15:55.695388 | controller | 7a0fd3b1d7c3: Verifying Checksum
2026-02-05 00:15:56.999298 | controller | 7a0fd3b1d7c3: Download complete
2026-02-05 00:15:56.999357 | controller | aacdb6db0c8c: Verifying Checksum
2026-02-05 00:15:57.765182 | controller | aacdb6db0c8c: Download complete
2026-02-05 00:15:57.765259 | controller | 2e7f04ae8c8b: Verifying Checksum
2026-02-05 00:15:58.526883 | controller | 2e7f04ae8c8b: Download complete
2026-02-05 00:15:58.526965 | controller | 4cd343027a44: Verifying Checksum
2026-02-05 00:15:59.266391 | controller | 4cd343027a44: Download complete
2026-02-05 00:15:59.266468 | controller | 0b4379883f90: Verifying Checksum
2026-02-05 00:15:59.977030 | controller | 0b4379883f90: Download complete
2026-02-05 00:15:59.977107 | controller | 3d9d6d9dfc91: Verifying Checksum
2026-02-05 00:16:09.942793 | controller | 3d9d6d9dfc91: Download complete
2026-02-05 00:16:09.942922 | controller | f4712b586375: Verifying Checksum
2026-02-05 00:16:13.763005 | controller | f4712b586375: Download complete
2026-02-05 00:16:13.763095 | controller | 57d6314bd293: Verifying Checksum
2026-02-05 00:16:23.795277 | controller | 57d6314bd293: Download complete
2026-02-05 00:16:23.795376 | controller | 54b10f0e1645: Verifying Checksum
2026-02-05 00:16:23.795553 | controller | 54b10f0e1645: Download complete
2026-02-05 00:16:24.762245 | controller | cef8beb99552: Verifying Checksum
2026-02-05 00:16:24.762386 | controller | cef8beb99552: Download complete
2026-02-05 00:16:25.973693 | controller | 774036afeb7f: Verifying Checksum
2026-02-05 00:16:25.973777 | controller | 774036afeb7f: Download complete
2026-02-05 00:16:35.656563 | controller | f4712b586375: Pull complete
2026-02-05 00:16:35.788482 | controller | d696ed7812f8: Pull complete
2026-02-05 00:16:35.867015 | controller | 29bf28764f14: Pull complete
2026-02-05 00:16:36.150389 | controller | 47d7edb3c2b7: Pull complete
2026-02-05 00:16:36.250955 | controller | 4b19ac3f17a8: Verifying Checksum
2026-02-05 00:16:36.251231 | controller | 4b19ac3f17a8: Download complete
2026-02-05 00:16:36.254117 | controller | 07550ad4f6e4: Pull complete
2026-02-05 00:16:36.399517 | controller | 7e79526e64c5: Pull complete
2026-02-05 00:16:36.481137 | controller | 4fffb32882b7: Pull complete
2026-02-05 00:16:36.516131 | controller | 78cf439d9fdb: Verifying Checksum
2026-02-05 00:16:36.516359 | controller | 78cf439d9fdb: Download complete
2026-02-05 00:16:36.604154 | controller | fc7a38b06f4e: Pull complete
2026-02-05 00:16:36.625648 | controller | 6d9d912e060e: Pull complete
2026-02-05 00:16:36.649435 | controller | 5dd542dd28d9: Pull complete
2026-02-05 00:16:39.224931 | controller | 36e5e20969c7: Verifying Checksum
2026-02-05 00:16:39.225015 | controller | 36e5e20969c7: Download complete
2026-02-05 00:16:56.703704 | controller | cef8beb99552: Pull complete
2026-02-05 00:16:56.755281 | controller | bd5557e101ad: Pull complete
2026-02-05 00:16:56.799360 | controller | e057c20fabdd: Pull complete
2026-02-05 00:16:56.838549 | controller | d16059cdae2e: Pull complete
2026-02-05 00:16:59.198545 | controller | 431e42d906a3: Pull complete
2026-02-05 00:16:59.268501 | controller | 7a0fd3b1d7c3: Pull complete
2026-02-05 00:16:59.328201 | controller | aacdb6db0c8c: Pull complete
2026-02-05 00:16:59.368166 | controller | 2e7f04ae8c8b: Pull complete
2026-02-05 00:16:59.410932 | controller | 4cd343027a44: Pull complete
2026-02-05 00:16:59.454088 | controller | 0b4379883f90: Pull complete
2026-02-05 00:16:59.499584 | controller | 3d9d6d9dfc91: Pull complete
2026-02-05 00:17:04.848719 | controller | 57d6314bd293: Pull complete
2026-02-05 00:17:26.400762 | controller | 774036afeb7f: Pull complete
2026-02-05 00:17:55.304668 | controller | 54b10f0e1645: Pull complete
2026-02-05 00:18:21.969644 | controller | 78cf439d9fdb: Pull complete
2026-02-05 00:18:51.181981 | controller | 36e5e20969c7: Pull complete
2026-02-05 00:19:15.567251 | controller | 4b19ac3f17a8: Pull complete
2026-02-05 00:19:15.583545 | controller | Digest: sha256:954c4edffb0905df64e23c8611b1c4a62db9af13062f51cad5b658e727238d41
2026-02-05 00:19:15.589302 | controller | Status: Downloaded newer image for quay.io/ansible/default-test-container:1.10.1
2026-02-05 00:19:15.602750 | controller | quay.io/ansible/default-test-container:1.10.1
2026-02-05 00:19:15.603732 | controller | Run command: docker images quay.io/ansible/pypi-test-container:1.0.0 --format '{{json .}}'
2026-02-05 00:19:15.634075 | controller | Run command: docker pull quay.io/ansible/pypi-test-container:1.0.0
2026-02-05 00:19:17.137892 | controller | 1.0.0: Pulling from ansible/pypi-test-container
2026-02-05 00:19:17.138117 | controller | 04a5f4cda3ee: Pulling fs layer
2026-02-05 00:19:17.138674 | controller | ff496a88c8ed: Pulling fs layer
2026-02-05 00:19:17.138691 | controller | 0ce83f459fe7: Pulling fs layer
2026-02-05 00:19:17.138698 | controller | 2e5170e1f099: Pulling fs layer
2026-02-05 00:19:17.138704 | controller | 7641eb41b08c: Pulling fs layer
2026-02-05 00:19:17.138710 | controller | ad15fa9da398: Pulling fs layer
2026-02-05 00:19:17.138735 | controller | 087d91352424: Pulling fs layer
2026-02-05 00:19:17.138742 | controller | 8b92efd6a100: Pulling fs layer
2026-02-05 00:19:17.138752 | controller | 7641eb41b08c: Waiting
2026-02-05 00:19:17.138805 | controller | ad15fa9da398: Waiting
2026-02-05 00:19:17.138818 | controller | 087d91352424: Waiting
2026-02-05 00:19:17.139144 | controller | 8b92efd6a100: Waiting
2026-02-05 00:19:17.139173 | controller | 2e5170e1f099: Waiting
2026-02-05 00:19:17.886185 | controller | 0ce83f459fe7: Verifying Checksum
2026-02-05 00:19:17.886397 | controller | 0ce83f459fe7: Download complete
2026-02-05 00:19:17.959821 | controller | ff496a88c8ed: Verifying Checksum
2026-02-05 00:19:18.779261 | controller | ff496a88c8ed: Download complete
2026-02-05 00:19:18.779322 | controller | 7641eb41b08c: Verifying Checksum
2026-02-05 00:19:19.631790 | controller | 7641eb41b08c: Download complete
2026-02-05 00:19:19.631859 | controller | ad15fa9da398: Download complete
2026-02-05 00:19:20.779164 | controller | 04a5f4cda3ee: Verifying Checksum
2026-02-05 00:19:21.169292 | controller | 04a5f4cda3ee: Download complete
2026-02-05 00:19:21.169362 | controller | 087d91352424: Verifying Checksum
2026-02-05 00:19:21.596433 | controller | 087d91352424: Download complete
2026-02-05 00:19:21.596493 | controller | 8b92efd6a100: Verifying Checksum
2026-02-05 00:19:22.264760 | controller | 8b92efd6a100: Download complete
2026-02-05 00:19:22.264819 | controller | 2e5170e1f099: Verifying Checksum
2026-02-05 00:19:22.961212 | controller | 2e5170e1f099: Download complete
2026-02-05 00:19:22.961275 | controller | 04a5f4cda3ee: Pull complete
2026-02-05 00:19:23.010318 | controller | ff496a88c8ed: Pull complete
2026-02-05 00:19:23.041537 | controller | 0ce83f459fe7: Pull complete
2026-02-05 00:19:24.503178 | controller | 2e5170e1f099: Pull complete
2026-02-05 00:19:24.532451 | controller | 7641eb41b08c: Pull complete
2026-02-05 00:19:24.582233 | controller | ad15fa9da398: Pull complete
2026-02-05 00:19:25.554601 | controller | 087d91352424: Pull complete
2026-02-05 00:19:25.585807 | controller | 8b92efd6a100: Pull complete
2026-02-05 00:19:25.612160 | controller | Digest: sha256:71042ab0a14971b5608fe75706de54f367fc31db573e3b3955182037f73cadb6
2026-02-05 00:19:25.616322 | controller | Status: Downloaded newer image for quay.io/ansible/pypi-test-container:1.0.0
2026-02-05 00:19:25.626929 | controller | quay.io/ansible/pypi-test-container:1.0.0
2026-02-05 00:19:25.631962 | controller | Run command: docker run --detach quay.io/ansible/pypi-test-container:1.0.0
2026-02-05 00:19:36.152934 | controller | Run command: docker inspect e755498a625bb85f3ce19868cf88c240e01cecfd993de77a29f3dad94c7d6b6a
2026-02-05 00:19:36.413275 | controller | Scanning collection root: /home/zuul/.ansible/collections/ansible_collections
2026-02-05 00:19:36.431454 | controller | Including collection: ansible.netcommon (278 files)
2026-02-05 00:19:36.431541 | controller | Including collection: ansible.network (23 files)
2026-02-05 00:19:36.447278 | controller | Including collection: ansible.utils (441 files)
2026-02-05 00:19:36.492854 | controller | Including collection: arista.eos (1022 files)
2026-02-05 00:19:36.551563 | controller | Including collection: cisco.ios (1174 files)
2026-02-05 00:19:36.598095 | controller | Including collection: cisco.iosxr (1044 files)
2026-02-05 00:19:36.684565 | controller | Including collection: cisco.nxos (1687 files)
2026-02-05 00:19:36.730976 | controller | Including collection: junipernetworks.junos (963 files)
2026-02-05 00:19:36.777301 | controller | Creating a payload archive containing 8369 files...
2026-02-05 00:19:39.117249 | controller | Created a 6913069 byte payload archive containing 8369 files in 2 seconds.
2026-02-05 00:19:39.121664 | controller | Assuming Docker is available on localhost.
2026-02-05 00:19:39.122154 | controller | Run command: docker run --detach --volume /sys/fs/cgroup:/sys/fs/cgroup:ro --privileged=false --security-opt seccomp=unconfined --volume /var/run/docker.sock:/var/run/docker.sock quay.io/ansible/default-test-container:1.10.1
2026-02-05 00:19:39.748043 | controller | Run command: docker exec -i 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 dd of=/root/docker.sh bs=65536
2026-02-05 00:19:39.861998 | controller | Run command: docker exec 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 /bin/bash /root/docker.sh
2026-02-05 00:19:39.962716 | controller | Run command: docker exec -i 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 dd of=/root/ansible.tgz bs=65536
2026-02-05 00:19:40.072276 | controller | Run command: docker exec 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 mkdir /root/ansible
2026-02-05 00:19:40.155428 | controller | Run command: docker exec 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 tar oxzf /root/ansible.tgz -C /root/ansible
2026-02-05 00:19:41.370382 | controller | Run command: docker exec 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 /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-0gxl_3th.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/
2026-02-05 00:19:41.875008 | controller | Injecting custom PyPI hosts entries: /etc/hosts
2026-02-05 00:19:41.875119 | controller | Injecting custom PyPI config: /root/.pip/pip.conf
2026-02-05 00:19:41.875515 | controller | Injecting custom PyPI config: /root/.pydistutils.cfg
2026-02-05 00:19:41.877555 | controller | Run command: /usr/bin/python3.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-05 00:19:41.961176 | controller | Running sanity test 'action-plugin-docs' with Python 3.6
2026-02-05 00:19:41.964450 | controller | Read 0 sanity test ignore line(s) for Ansible 2.9 from: tests/sanity/ignore-2.9.txt
2026-02-05 00:19:41.974035 | controller | No tests applicable.
2026-02-05 00:19:41.974245 | controller | Running sanity test 'ansible-doc' with Python 3.6
2026-02-05 00:19:41.974262 | controller | No tests applicable.
2026-02-05 00:19:41.974522 | controller | Run command: /usr/bin/python2.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-05 00:19:42.049975 | controller | Running sanity test 'compile' with Python 2.6
2026-02-05 00:19:42.050383 | controller | No tests applicable.
2026-02-05 00:19:42.050736 | controller | Run command: /usr/bin/python2.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-05 00:19:42.243366 | controller | Running sanity test 'compile' with Python 2.7
2026-02-05 00:19:42.243426 | controller | No tests applicable.
2026-02-05 00:19:42.243440 | controller | Run command: /usr/bin/python3.5 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-05 00:19:42.364747 | controller | Running sanity test 'compile' with Python 3.5
2026-02-05 00:19:42.364956 | controller | No tests applicable.
2026-02-05 00:19:42.365137 | controller | Running sanity test 'compile' with Python 3.6
2026-02-05 00:19:42.365152 | controller | No tests applicable.
2026-02-05 00:19:42.365484 | controller | Run command: /usr/bin/python3.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-05 00:19:42.474538 | controller | Running sanity test 'compile' with Python 3.7
2026-02-05 00:19:42.474736 | controller | No tests applicable.
2026-02-05 00:19:42.475082 | controller | Run command: /usr/bin/python3.8 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2026-02-05 00:19:42.583906 | controller | Running sanity test 'compile' with Python 3.8
2026-02-05 00:19:42.584393 | controller | No tests applicable.
2026-02-05 00:19:42.584530 | controller | Running sanity test 'empty-init' with Python 3.6
2026-02-05 00:19:42.584820 | controller | No tests applicable.
2026-02-05 00:19:42.585002 | controller | Running sanity test 'future-import-boilerplate' with Python 3.6
2026-02-05 00:19:42.585288 | controller | No tests applicable.
2026-02-05 00:19:42.586564 | controller | Running sanity test 'ignores'
2026-02-05 00:19:42.586587 | controller | Run command: /usr/bin/python3.6 -m pip.__main__ install --disable-pip-version-check -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt
2026-02-05 00:19:43.336430 | controller | Ignoring packaging: markers 'python_version < "3.6"' don't match your environment
2026-02-05 00:19:43.341259 | controller | Ignoring coverage: markers 'python_version > "3.7"' don't match your environment
2026-02-05 00:19:43.342951 | controller | Ignoring cryptography: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.346012 | controller | Ignoring deepdiff: markers 'python_version < "3"' don't match your environment
2026-02-05 00:19:43.351242 | controller | Ignoring jinja2: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.353107 | controller | Ignoring urllib3: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.356817 | controller | Ignoring sphinx: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.361702 | controller | Ignoring wheel: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.363324 | controller | Ignoring yamllint: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.368387 | controller | Ignoring paramiko: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.371036 | controller | Ignoring pytest: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.372855 | controller | Ignoring pytest: markers 'python_version == "2.7"' don't match your environment
2026-02-05 00:19:43.374465 | controller | Ignoring pytest-forked: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.378692 | controller | Ignoring requests: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.386610 | controller | Ignoring virtualenv: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.388379 | controller | Ignoring pathspec: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.389806 | controller | Ignoring pyopenssl: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.392533 | controller | Ignoring pyyaml: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.394034 | controller | Ignoring pycparser: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.399194 | controller | Ignoring xmltodict: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.400817 | controller | Ignoring lxml: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.402590 | controller | Ignoring pyvmomi: markers 'python_version < "2.7"' don't match your environment
2026-02-05 00:19:43.405050 | controller | Ignoring MarkupSafe: markers 'python_version < "3.6"' don't match your environment
2026-02-05 00:19:43.410862 | controller | Ignoring setuptools: markers 'python_version <= "2.7"' don't match your environment
2026-02-05 00:19:43.415218 | controller | Ignoring websocket-client: markers 'python_version < "3"' don't match your environment
2026-02-05 00:19:43.416733 | controller | Ignoring certifi: markers 'python_version < "3"' don't match your environment
2026-02-05 00:19:43.432887 | controller | Looking in indexes: http://172.17.0.2:3141/root/pypi/+simple/
2026-02-05 00:19:43.434125 | controller | Requirement already satisfied: cryptography<3.4 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (2.7)
2026-02-05 00:19:43.464779 | controller | Requirement already satisfied: rstcheck==3.3.1 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 12)) (3.3.1)
2026-02-05 00:19:43.468747 | controller | Requirement already satisfied: voluptuous>=0.11.0 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 30)) (0.11.7)
2026-02-05 00:19:43.472149 | controller | Requirement already satisfied: cffi!=1.14.4 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 49)) (1.13.0)
2026-02-05 00:19:43.474509 | controller | Requirement already satisfied: pylint==2.3.1 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 58)) (2.3.1)
2026-02-05 00:19:43.480805 | controller | Requirement already satisfied: jinja2 in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 2)) (2.10.3)
2026-02-05 00:19:43.484466 | controller | Requirement already satisfied: pycodestyle in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 3)) (2.5.0)
2026-02-05 00:19:43.488215 | controller | Requirement already satisfied: pyyaml in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 5)) (5.1.2)
2026-02-05 00:19:43.490104 | controller | Requirement already satisfied: virtualenv in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 7)) (16.7.5)
2026-02-05 00:19:43.507702 | controller | Requirement already satisfied: yamllint in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 9)) (1.18.0)
2026-02-05 00:19:43.511284 | controller | Requirement already satisfied: six>=1.4.1 in /usr/local/lib/python3.6/dist-packages (from cryptography<3.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (1.12.0)
2026-02-05 00:19:43.513256 | controller | Requirement already satisfied: asn1crypto>=0.21.0 in /usr/local/lib/python3.6/dist-packages (from cryptography<3.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (1.1.0)
2026-02-05 00:19:43.515666 | controller | Requirement already satisfied: docutils>=0.7 in /usr/local/lib/python3.6/dist-packages (from rstcheck==3.3.1->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 12)) (0.15.2)
2026-02-05 00:19:43.517849 | controller | Requirement already satisfied: pycparser in /usr/local/lib/python3.6/dist-packages (from cffi!=1.14.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 49)) (2.19)
2026-02-05 00:19:43.519652 | controller | Requirement already satisfied: mccabe==0.6.1 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 57)) (0.6.1)
2026-02-05 00:19:43.522322 | controller | Collecting isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55))
2026-02-05 00:19:58.530253 | controller |   WARNING: Retrying (Retry(total=4, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-05 00:20:14.040630 | controller |   WARNING: Retrying (Retry(total=3, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-05 00:20:30.058422 | controller |   WARNING: Retrying (Retry(total=2, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-05 00:20:47.077139 | controller |   WARNING: Retrying (Retry(total=1, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-05 00:21:06.097648 | controller |   WARNING: Retrying (Retry(total=0, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2026-02-05 00:21:21.115243 | controller |   ERROR: Could not find a version that satisfies the requirement isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55)) (from versions: none)
2026-02-05 00:21:21.116246 | controller | ERROR: No matching distribution found for isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55))
2026-02-05 00:21:21.243323 | controller | ERROR: Command "/usr/bin/python3.6 -m pip.__main__ install --disable-pip-version-check -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt" returned exit status 1.
2026-02-05 00:21:21.243602 | controller | Removing custom PyPI config: /root/.pydistutils.cfg
2026-02-05 00:21:21.286983 | controller | Removing custom PyPI config: /root/.pip/pip.conf
2026-02-05 00:21:21.287035 | controller | Removing custom PyPI hosts entries: /etc/hosts
2026-02-05 00:21:21.287059 | controller | Run command: docker exec 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 tar czf /root/output.tgz --exclude .tmp -C /root/ansible/ansible_collections/ansible/network/tests output
2026-02-05 00:21:21.374651 | controller | Run command: docker exec -i 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 dd if=/root/output.tgz bs=65536
2026-02-05 00:21:21.464276 | controller | Run command: tar oxzf /tmp/ansible-result-0ysxp255.tgz -C /home/zuul/.ansible/collections/ansible_collections/ansible/network/tests
2026-02-05 00:21:21.480937 | controller | Run command: docker rm -f e755498a625bb85f3ce19868cf88c240e01cecfd993de77a29f3dad94c7d6b6a
2026-02-05 00:21:21.830498 | controller | Run command: docker rm -f 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0
2026-02-05 00:21:22.641678 | controller | ERROR: Command "docker exec 9e6afa036fae31601cb3daf3ce1b08d14d489db1caf3dc57c7f3b4aa8157f9e0 /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-0gxl_3th.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/" returned exit status 1.
2026-02-05 00:21:22.950244 | controller | ERROR
2026-02-05 00:21:22.950552 | controller | {
2026-02-05 00:21:22.950636 | controller |   "delta": "0:05:46.455273",
2026-02-05 00:21:22.950682 | controller |   "end": "2026-02-05 00:21:22.706447",
2026-02-05 00:21:22.950884 | controller |   "msg": "non-zero return code",
2026-02-05 00:21:22.950931 | controller |   "rc": 1,
2026-02-05 00:21:22.950973 | controller |   "start": "2026-02-05 00:15:36.251174"
2026-02-05 00:21:22.951011 | controller | }
failure
2026-02-05 00:21:22.960363 | 
2026-02-05 00:21:22.960474 | PLAY RECAP
2026-02-05 00:21:22.960563 | controller | ok: 21 changed: 6 unreachable: 0 failed: 1 skipped: 20 rescued: 0 ignored: 1
2026-02-05 00:21:22.960611 | 
2026-02-05 00:21:23.087315 | RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2026-02-05 00:21:23.088301 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-05 00:21:23.701619 | 
2026-02-05 00:21:23.701766 | PLAY [all]
2026-02-05 00:21:23.728067 | 
2026-02-05 00:21:23.728237 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-05 00:21:26.756086 | controller | changed: non-zero return code
2026-02-05 00:21:26.762309 | 
2026-02-05 00:21:26.762408 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-02-05 00:21:26.786995 | controller | skipping: Conditional result was False
2026-02-05 00:21:26.794521 | 
2026-02-05 00:21:26.794637 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-02-05 00:21:26.818337 | 
2026-02-05 00:21:26.818510 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-02-05 00:21:26.839288 | 
2026-02-05 00:21:26.839453 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-02-05 00:21:26.853368 | controller | skipping: Conditional result was False
2026-02-05 00:21:26.861796 | 
2026-02-05 00:21:26.861915 | LOOP [fetch-subunit-output : Generate subunit file]
2026-02-05 00:21:26.883951 | 
2026-02-05 00:21:26.884141 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-02-05 00:21:26.898397 | controller | skipping: Conditional result was False
2026-02-05 00:21:26.906812 | 
2026-02-05 00:21:26.906927 | TASK [fetch-subunit-output : Remove the temporary file]
2026-02-05 00:21:26.921144 | controller | skipping: Conditional result was False
2026-02-05 00:21:26.928866 | 
2026-02-05 00:21:26.928988 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-02-05 00:21:26.943324 | controller | skipping: Conditional result was False
2026-02-05 00:21:26.973311 | 
2026-02-05 00:21:26.973435 | PLAY RECAP
2026-02-05 00:21:26.973478 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-05 00:21:26.973500 | 
2026-02-05 00:21:27.098618 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-05 00:21:27.099678 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-02-05 00:21:27.731174 | 
2026-02-05 00:21:27.731309 | PLAY [all:!appliance*]
2026-02-05 00:21:27.754971 | 
2026-02-05 00:21:27.755156 | TASK [unregister the node]
2026-02-05 00:21:28.111866 | controller | skipping: Conditional result was False
2026-02-05 00:21:28.118576 | 
2026-02-05 00:21:28.118694 | TASK [include_role : fetch-output]
2026-02-05 00:21:28.159315 | controller | ok
2026-02-05 00:21:28.181131 | 
2026-02-05 00:21:28.181264 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-05 00:21:28.227543 | controller | skipping: Conditional result was False
2026-02-05 00:21:28.235722 | 
2026-02-05 00:21:28.235859 | TASK [fetch-output : Set log path for single node]
2026-02-05 00:21:28.279797 | controller | ok
2026-02-05 00:21:28.287730 | 
2026-02-05 00:21:28.287857 | LOOP [fetch-output : Ensure local output dirs]
2026-02-05 00:21:28.730524 | controller -> localhost | ok: "/var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/logs"
2026-02-05 00:21:28.959291 | controller -> localhost | changed: "/var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/artifacts"
2026-02-05 00:21:29.222369 | controller -> localhost | changed: "/var/lib/zuul/builds/5d20dd1e88ed41b7bff6e9ac9e098b62/work/docs"
2026-02-05 00:21:29.233151 | 
2026-02-05 00:21:29.233273 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-05 00:21:31.464726 | controller | changed:
2026-02-05 00:21:31.464960 | controller | .d..t...... ./
2026-02-05 00:21:31.465001 | controller | cd+++++++++ controller/
2026-02-05 00:21:31.465096 | controller | changed: All items complete
2026-02-05 00:21:31.465127 | 
2026-02-05 00:21:33.554720 | controller | changed: .d..t...... ./
2026-02-05 00:21:35.596159 | controller | changed: .d..t...... ./
2026-02-05 00:21:35.615938 | 
2026-02-05 00:21:35.616129 | TASK [include_role : fetch-output-openshift]
2026-02-05 00:21:35.631185 | controller | skipping: Conditional result was False
2026-02-05 00:21:35.638449 | 
2026-02-05 00:21:35.638560 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-05 00:21:35.667134 | controller | skipping: Conditional result was False
2026-02-05 00:21:35.681658 | controller | skipping: Conditional result was False
2026-02-05 00:21:35.711266 | 
2026-02-05 00:21:35.711378 | PLAY [localhost]
2026-02-05 00:21:35.724749 | 
2026-02-05 00:21:35.724882 | TASK [Run Zuul manifest role]
2026-02-05 00:21:35.753677 | localhost | ok
2026-02-05 00:21:35.769310 | 
2026-02-05 00:21:35.769433 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-05 00:21:36.168354 | localhost | changed
2026-02-05 00:21:36.173386 | 
2026-02-05 00:21:36.173470 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-05 00:21:36.202485 | localhost | ok
2026-02-05 00:21:36.211198 | 
2026-02-05 00:21:36.211292 | TASK [Set zuul-log-path fact]
2026-02-05 00:21:36.230813 | localhost | ok
2026-02-05 00:21:36.271269 | 
2026-02-05 00:21:36.271385 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-05 00:21:36.301473 | localhost | ok
2026-02-05 00:21:36.312786 | 
2026-02-05 00:21:36.312900 | LOOP [Run upload-logs-swift role]
2026-02-05 00:21:36.337352 | localhost | Output suppressed because no_log was given
2026-02-05 00:21:36.364470 | 
2026-02-05 00:21:36.364595 | TASK [Set zuul-log-path fact]
2026-02-05 00:21:36.389228 | localhost | skipping: Conditional result was False
2026-02-05 00:21:36.396110 | 
2026-02-05 00:21:36.396311 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-02-05 00:21:36.767260 | localhost -> localhost | ok: Runtime: 0:00:00.007927
2026-02-05 00:21:36.772745 | 
2026-02-05 00:21:36.772848 | TASK [upload-logs-swift : Upload logs to swift]