2025-11-08 00:07:08.357551 | Job console starting...
2025-11-08 00:07:08.371407 | Updating repositories
2025-11-08 00:07:08.564015 | Preparing job workspace
2025-11-08 00:07:14.519709 | Running Ansible setup...
2025-11-08 00:07:22.429707 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-11-08 00:07:23.133051 | 
2025-11-08 00:07:23.133200 | PLAY [localhost]
2025-11-08 00:07:23.142444 | 
2025-11-08 00:07:23.142531 | TASK [Gathering Facts]
2025-11-08 00:07:24.264281 | localhost | ok
2025-11-08 00:07:24.295592 | 
2025-11-08 00:07:24.295856 | TASK [Setup log path fact]
2025-11-08 00:07:24.320969 | localhost | ok
2025-11-08 00:07:24.340060 | 
2025-11-08 00:07:24.340209 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-11-08 00:07:24.372650 | localhost | ok
2025-11-08 00:07:24.384921 | 
2025-11-08 00:07:24.385073 | TASK [emit-job-header : Print job information]
2025-11-08 00:07:24.416281 | # Job Information
2025-11-08 00:07:24.416483 | Ansible Version: 2.15.12
2025-11-08 00:07:24.416518 | Job: ansible-test-sanity-docker-stable-2.9
2025-11-08 00:07:24.416547 | Pipeline: periodic
2025-11-08 00:07:24.416566 | Executor: ze02.softwarefactory-project.io
2025-11-08 00:07:24.416584 | Triggered by: https://github.com/ansible-collections/ansible.network
2025-11-08 00:07:24.416605 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/141/ansible/1415399ae4844da5a5f8d285c3f3ebdb/
2025-11-08 00:07:24.416624 | Event ID: 9db656c0baa84bdc9b327314cc4269ab
2025-11-08 00:07:24.421009 | 
2025-11-08 00:07:24.421087 | LOOP [emit-job-header : Print node information]
2025-11-08 00:07:24.525023 | localhost | ok:
2025-11-08 00:07:24.525242 | localhost | # Node Information
2025-11-08 00:07:24.525270 | localhost | Inventory Hostname: controller
2025-11-08 00:07:24.525290 | localhost | Hostname: np0005515346
2025-11-08 00:07:24.525309 | localhost | Username: zuul
2025-11-08 00:07:24.525336 | localhost | Distro: Fedora 37
2025-11-08 00:07:24.525355 | localhost | Provider: ansible-vexxhost-ams1
2025-11-08 00:07:24.525372 | localhost | Region: ams1
2025-11-08 00:07:24.525389 | localhost | Label: ansible-fedora-37-1vcpu
2025-11-08 00:07:24.525405 | localhost | Product Name: OpenStack Nova
2025-11-08 00:07:24.525422 | localhost | Interface IP: 38.129.16.205
2025-11-08 00:07:24.535643 | 
2025-11-08 00:07:24.535829 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-11-08 00:07:24.980065 | localhost -> localhost | changed
2025-11-08 00:07:24.986152 | 
2025-11-08 00:07:24.986229 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-11-08 00:07:26.078030 | localhost -> localhost | changed
2025-11-08 00:07:26.102511 | 
2025-11-08 00:07:26.102658 | PLAY [all:!appliance*]
2025-11-08 00:07:26.118297 | 
2025-11-08 00:07:26.118363 | TASK [include_role : start-zuul-console]
2025-11-08 00:07:26.138173 | controller | ok
2025-11-08 00:07:26.151327 | 
2025-11-08 00:07:26.151397 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-11-08 00:07:27.222796 | controller | ok
2025-11-08 00:07:27.238206 | 
2025-11-08 00:07:27.238345 | TASK [use-our-mirror : Retrieve the IP address]
2025-11-08 00:07:29.565934 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2025-11-08 00:07:29.580517 | 
2025-11-08 00:07:29.580845 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2025-11-08 00:07:29.951840 | controller | skipping: Conditional result was False
2025-11-08 00:07:29.959458 | 
2025-11-08 00:07:29.959585 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2025-11-08 00:07:29.995044 | controller | skipping: Conditional result was False
2025-11-08 00:07:30.002281 | 
2025-11-08 00:07:30.002401 | TASK [use-our-mirror : Create the podman configuration directory]
2025-11-08 00:07:30.017650 | controller | skipping: Conditional result was False
2025-11-08 00:07:30.025804 | 
2025-11-08 00:07:30.025975 | TASK [use-our-mirror : Copy the podman configuration]
2025-11-08 00:07:30.051896 | controller | skipping: Conditional result was False
2025-11-08 00:07:30.058622 | 
2025-11-08 00:07:30.058736 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2025-11-08 00:07:30.083352 | controller | skipping: Conditional result was False
2025-11-08 00:07:30.090117 | 
2025-11-08 00:07:30.090209 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2025-11-08 00:07:30.122218 | controller | skipping: Conditional result was False
2025-11-08 00:07:30.140327 | 
2025-11-08 00:07:30.140477 | TASK [Disable Fedora Modular]
2025-11-08 00:07:31.280234 | controller | changed
2025-11-08 00:07:31.295546 | 
2025-11-08 00:07:31.295814 | TASK [Enable EPEL]
2025-11-08 00:07:31.324084 | controller | skipping: Conditional result was False
2025-11-08 00:07:31.339422 | 
2025-11-08 00:07:31.340035 | TASK [Register the RHEL node]
2025-11-08 00:07:31.779209 | 
2025-11-08 00:07:31.779372 | TASK [Show the subscription-manager status]
2025-11-08 00:07:32.174288 | controller | skipping: Conditional result was False
2025-11-08 00:07:32.190593 | 
2025-11-08 00:07:32.190803 | TASK [Enable EPEL on RHEL]
2025-11-08 00:07:32.591688 | controller | skipping: Conditional result was False
2025-11-08 00:07:32.601503 | 
2025-11-08 00:07:32.601637 | TASK [Install git and tox]
2025-11-08 00:09:37.732564 | controller | changed
2025-11-08 00:09:37.746243 | 
2025-11-08 00:09:37.746364 | TASK [include_role : prepare-workspace]
2025-11-08 00:09:37.771809 | controller | ok
2025-11-08 00:09:37.799448 | 
2025-11-08 00:09:37.799571 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-11-08 00:09:38.632422 | controller | ok
2025-11-08 00:09:38.641995 | 
2025-11-08 00:09:38.642124 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-11-08 00:09:58.981886 | controller | Output suppressed because no_log was given
2025-11-08 00:09:58.993014 | 
2025-11-08 00:09:58.993088 | TASK [include_role : prepare-workspace-openshift]
2025-11-08 00:09:59.024780 | controller | skipping: Conditional result was False
2025-11-08 00:09:59.051792 | 
2025-11-08 00:09:59.051905 | PLAY [all:!appliance]
2025-11-08 00:09:59.070784 | 
2025-11-08 00:09:59.070867 | TASK [Run add-build-sshkey role (RSA)]
2025-11-08 00:09:59.104892 | controller | ok
2025-11-08 00:09:59.125581 | 
2025-11-08 00:09:59.125764 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-11-08 00:09:59.396335 | controller -> localhost | ok
2025-11-08 00:09:59.406116 | 
2025-11-08 00:09:59.406207 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-11-08 00:09:59.456683 | controller | ok
2025-11-08 00:09:59.478652 | controller | included: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-11-08 00:09:59.488108 | 
2025-11-08 00:09:59.488189 | TASK [add-build-sshkey : Create Temp SSH key]
2025-11-08 00:10:00.142751 | controller -> localhost | Generating public/private rsa key pair.
2025-11-08 00:10:00.143910 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/1415399ae4844da5a5f8d285c3f3ebdb_id_rsa.
2025-11-08 00:10:00.144036 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/1415399ae4844da5a5f8d285c3f3ebdb_id_rsa.pub.
2025-11-08 00:10:00.144141 | controller -> localhost | The key fingerprint is:
2025-11-08 00:10:00.144277 | controller -> localhost | SHA256:YFLahfWqoyMbwsZEYBT6W1XB8Nf/b/fWg/C4jUAlSfc zuul-build-sshkey
2025-11-08 00:10:00.144369 | controller -> localhost | The key's randomart image is:
2025-11-08 00:10:00.144424 | controller -> localhost | +---[RSA 2048]----+
2025-11-08 00:10:00.144599 | controller -> localhost | |o+.   o==o .     |
2025-11-08 00:10:00.144700 | controller -> localhost | |+    +.+o.o..    |
2025-11-08 00:10:00.144836 | controller -> localhost | |..  o = .oo..E   |
2025-11-08 00:10:00.144932 | controller -> localhost | |..   + . oo  .   |
2025-11-08 00:10:00.145022 | controller -> localhost | | .. .   S.    .  |
2025-11-08 00:10:00.145127 | controller -> localhost | |+  o   ..  .   . |
2025-11-08 00:10:00.145272 | controller -> localhost | |.+o   o  .  + . o|
2025-11-08 00:10:00.145394 | controller -> localhost | |...... .  ..oo .*|
2025-11-08 00:10:00.145497 | controller -> localhost | |  .o..     o.. o*|
2025-11-08 00:10:00.145597 | controller -> localhost | +----[SHA256]-----+
2025-11-08 00:10:00.145824 | controller -> localhost | ok: Runtime: 0:00:00.127721
2025-11-08 00:10:00.161392 | 
2025-11-08 00:10:00.161519 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-11-08 00:10:00.203345 | controller | ok
2025-11-08 00:10:00.220406 | controller | included: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-11-08 00:10:00.230578 | 
2025-11-08 00:10:00.230646 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-11-08 00:10:00.257454 | controller | skipping: Conditional result was False
2025-11-08 00:10:00.268642 | 
2025-11-08 00:10:00.268868 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-11-08 00:10:01.379735 | controller | changed
2025-11-08 00:10:01.397433 | 
2025-11-08 00:10:01.397621 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-11-08 00:10:02.075496 | controller | ok
2025-11-08 00:10:02.089817 | 
2025-11-08 00:10:02.090023 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-11-08 00:10:05.150822 | controller | changed
2025-11-08 00:10:05.171401 | 
2025-11-08 00:10:05.171645 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-11-08 00:10:08.222425 | controller | changed
2025-11-08 00:10:08.230945 | 
2025-11-08 00:10:08.231032 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-11-08 00:10:08.256543 | controller | skipping: Conditional result was False
2025-11-08 00:10:08.265907 | 
2025-11-08 00:10:08.266018 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-11-08 00:10:08.699710 | controller -> localhost | changed
2025-11-08 00:10:08.769736 | 
2025-11-08 00:10:08.769908 | TASK [add-build-sshkey : Add back temp key]
2025-11-08 00:10:09.101224 | controller -> localhost | Identity added: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/1415399ae4844da5a5f8d285c3f3ebdb_id_rsa (zuul-build-sshkey)
2025-11-08 00:10:09.101526 | controller -> localhost | ok: Runtime: 0:00:00.021903
2025-11-08 00:10:09.108764 | 
2025-11-08 00:10:09.108831 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-11-08 00:10:10.022420 | controller | ok
2025-11-08 00:10:10.030233 | 
2025-11-08 00:10:10.030319 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-11-08 00:10:10.068342 | controller | skipping: Conditional result was False
2025-11-08 00:10:10.089923 | 
2025-11-08 00:10:10.090066 | TASK [Run add-build-sshkey role (ECDSA)]
2025-11-08 00:10:10.126429 | controller | ok
2025-11-08 00:10:10.146122 | 
2025-11-08 00:10:10.146254 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-11-08 00:10:10.484656 | controller -> localhost | ok
2025-11-08 00:10:10.494471 | 
2025-11-08 00:10:10.494585 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-11-08 00:10:10.533328 | controller | ok
2025-11-08 00:10:10.546281 | controller | included: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-11-08 00:10:10.554026 | 
2025-11-08 00:10:10.554140 | TASK [add-build-sshkey : Create Temp SSH key]
2025-11-08 00:10:10.916477 | controller -> localhost | Generating public/private ecdsa key pair.
2025-11-08 00:10:10.916715 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/1415399ae4844da5a5f8d285c3f3ebdb_id_ecdsa.
2025-11-08 00:10:10.916746 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/1415399ae4844da5a5f8d285c3f3ebdb_id_ecdsa.pub.
2025-11-08 00:10:10.916776 | controller -> localhost | The key fingerprint is:
2025-11-08 00:10:10.916796 | controller -> localhost | SHA256:FpZJYjKmQDrMzHPFGatlNRVs96V/Y1Ny/N5p95vP0Zw zuul-build-sshkey
2025-11-08 00:10:10.916815 | controller -> localhost | The key's randomart image is:
2025-11-08 00:10:10.916832 | controller -> localhost | +---[ECDSA 521]---+
2025-11-08 00:10:10.916850 | controller -> localhost | |o.  =o=o+o.      |
2025-11-08 00:10:10.916866 | controller -> localhost | |*. o.*oo.= .   . |
2025-11-08 00:10:10.916883 | controller -> localhost | |o*.. +  * . . o. |
2025-11-08 00:10:10.916899 | controller -> localhost | | .o +  . .   o. +|
2025-11-08 00:10:10.916915 | controller -> localhost | |   .    S     .oo|
2025-11-08 00:10:10.916932 | controller -> localhost | |       .       *=|
2025-11-08 00:10:10.916948 | controller -> localhost | |              .EO|
2025-11-08 00:10:10.916964 | controller -> localhost | |               +*|
2025-11-08 00:10:10.916981 | controller -> localhost | |              .oO|
2025-11-08 00:10:10.916997 | controller -> localhost | +----[SHA256]-----+
2025-11-08 00:10:10.917058 | controller -> localhost | ok: Runtime: 0:00:00.024565
2025-11-08 00:10:10.925090 | 
2025-11-08 00:10:10.925154 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-11-08 00:10:10.962911 | controller | ok
2025-11-08 00:10:10.974494 | controller | included: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-11-08 00:10:10.985122 | 
2025-11-08 00:10:10.985201 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-11-08 00:10:11.011251 | controller | skipping: Conditional result was False
2025-11-08 00:10:11.022378 | 
2025-11-08 00:10:11.022472 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-11-08 00:10:11.926311 | controller | changed
2025-11-08 00:10:11.934140 | 
2025-11-08 00:10:11.934205 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-11-08 00:10:12.600873 | controller | ok
2025-11-08 00:10:12.607294 | 
2025-11-08 00:10:12.607455 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-11-08 00:10:15.622564 | controller | changed
2025-11-08 00:10:15.629076 | 
2025-11-08 00:10:15.629167 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-11-08 00:10:18.678860 | controller | changed
2025-11-08 00:10:18.685052 | 
2025-11-08 00:10:18.685120 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-11-08 00:10:18.714426 | controller | skipping: Conditional result was False
2025-11-08 00:10:18.733163 | 
2025-11-08 00:10:18.733558 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-11-08 00:10:19.059193 | controller -> localhost | changed
2025-11-08 00:10:19.077575 | 
2025-11-08 00:10:19.077779 | TASK [add-build-sshkey : Add back temp key]
2025-11-08 00:10:19.483574 | controller -> localhost | Identity added: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/1415399ae4844da5a5f8d285c3f3ebdb_id_ecdsa (zuul-build-sshkey)
2025-11-08 00:10:19.483901 | controller -> localhost | ok: Runtime: 0:00:00.011374
2025-11-08 00:10:19.491344 | 
2025-11-08 00:10:19.491447 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-11-08 00:10:20.185429 | controller | ok
2025-11-08 00:10:20.193527 | 
2025-11-08 00:10:20.193633 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-11-08 00:10:20.219565 | controller | skipping: Conditional result was False
2025-11-08 00:10:20.238838 | 
2025-11-08 00:10:20.238989 | TASK [include_role : remove-zuul-sshkey]
2025-11-08 00:10:20.263716 | controller | skipping: Conditional result was False
2025-11-08 00:10:20.272103 | 
2025-11-08 00:10:20.272196 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-11-08 00:10:20.928179 | controller | ok: "logs"
2025-11-08 00:10:20.928819 | controller | ok: All items complete
2025-11-08 00:10:20.928911 | 
2025-11-08 00:10:21.549535 | controller | ok: "artifacts"
2025-11-08 00:10:22.158418 | controller | ok: "docs"
2025-11-08 00:10:22.171544 | 
2025-11-08 00:10:22.171643 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-11-08 00:10:22.848251 | controller | changed: "logs"
2025-11-08 00:10:23.485026 | controller | changed: "artifacts"
2025-11-08 00:10:24.070877 | controller | changed: "docs"
2025-11-08 00:10:24.160863 | 
2025-11-08 00:10:24.161000 | PLAY RECAP
2025-11-08 00:10:24.161044 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2025-11-08 00:10:24.161069 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-11-08 00:10:24.161086 | 
2025-11-08 00:10:24.302469 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-11-08 00:10:24.305274 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-11-08 00:10:24.971730 | 
2025-11-08 00:10:24.971857 | PLAY [all]
2025-11-08 00:10:24.995026 | 
2025-11-08 00:10:24.995156 | TASK [Install binary dependencies]
2025-11-08 00:10:25.082342 | controller | ok
2025-11-08 00:10:25.117981 | 
2025-11-08 00:10:25.118182 | TASK [bindep : Include find tasks]
2025-11-08 00:10:25.162893 | controller | ok
2025-11-08 00:10:25.174621 | controller | included: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2025-11-08 00:10:25.183984 | 
2025-11-08 00:10:25.184084 | TASK [bindep : Look for bindep.txt]
2025-11-08 00:10:26.107700 | controller | ok
2025-11-08 00:10:26.113999 | 
2025-11-08 00:10:26.114073 | TASK [bindep : Define bindep_file fact]
2025-11-08 00:10:26.139958 | controller | skipping: Conditional result was False
2025-11-08 00:10:26.147345 | 
2025-11-08 00:10:26.147421 | TASK [bindep : Look for other-requirements.txt]
2025-11-08 00:10:26.768092 | controller | ok
2025-11-08 00:10:26.780096 | 
2025-11-08 00:10:26.780292 | TASK [bindep : Define bindep_file fact]
2025-11-08 00:10:26.808694 | controller | skipping: Conditional result was False
2025-11-08 00:10:26.818639 | 
2025-11-08 00:10:26.818795 | TASK [bindep : Look for bindep fallback file]
2025-11-08 00:10:26.855554 | controller | skipping: Conditional result was False
2025-11-08 00:10:26.863270 | 
2025-11-08 00:10:26.863446 | TASK [bindep : Define bindep_file fact]
2025-11-08 00:10:26.890557 | controller | skipping: Conditional result was False
2025-11-08 00:10:26.898969 | 
2025-11-08 00:10:26.899112 | TASK [bindep : Include bindep tasks]
2025-11-08 00:10:26.934968 | controller | skipping: Conditional result was False
2025-11-08 00:10:26.944132 | 
2025-11-08 00:10:26.944338 | TASK [bindep : Include install tasks]
2025-11-08 00:10:26.970482 | controller | skipping: Conditional result was False
2025-11-08 00:10:26.978388 | 
2025-11-08 00:10:26.978511 | LOOP [bindep : Include package tasks]
2025-11-08 00:10:27.041608 | 
2025-11-08 00:10:27.041871 | TASK [Run test-setup role]
2025-11-08 00:10:27.075967 | controller | ok
2025-11-08 00:10:27.097467 | 
2025-11-08 00:10:27.097628 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2025-11-08 00:10:27.742960 | controller | ok
2025-11-08 00:10:27.758189 | 
2025-11-08 00:10:27.758406 | TASK [test-setup : Run tools/test-setup.sh]
2025-11-08 00:10:28.133489 | controller | skipping: Conditional result was False
2025-11-08 00:10:28.202389 | 
2025-11-08 00:10:28.202549 | PLAY RECAP
2025-11-08 00:10:28.202614 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-11-08 00:10:28.202642 | 
2025-11-08 00:10:28.365501 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-11-08 00:10:28.366542 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2025-11-08 00:10:29.092128 | 
2025-11-08 00:10:29.092273 | PLAY [controller]
2025-11-08 00:10:29.120628 | 
2025-11-08 00:10:29.120746 | TASK [Create the /root directory]
2025-11-08 00:10:30.233072 | controller | ok
2025-11-08 00:10:30.258443 | 
2025-11-08 00:10:30.258618 | TASK [Install glibc-langpack-en]
2025-11-08 00:10:38.879595 | controller | ok: Nothing to do
2025-11-08 00:10:38.890746 | 
2025-11-08 00:10:38.890868 | TASK [Ensure controller directory exists]
2025-11-08 00:10:39.690343 | controller | changed
2025-11-08 00:10:39.697681 | 
2025-11-08 00:10:39.697763 | TASK [Install container runtime]
2025-11-08 00:10:39.752842 | controller | ok
2025-11-08 00:10:39.818834 | 
2025-11-08 00:10:39.818964 | LOOP [ensure-docker : Gather variables for each operating system]
2025-11-08 00:10:39.889972 | controller | ok: "/var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml"
2025-11-08 00:10:39.905107 | 
2025-11-08 00:10:39.905216 | TASK [ensure-docker : Sanity check for distro selection]
2025-11-08 00:10:39.929985 | controller | skipping: Conditional result was False
2025-11-08 00:10:39.937522 | 
2025-11-08 00:10:39.937603 | TASK [ensure-docker : Sanity check for distro install]
2025-11-08 00:10:39.962256 | controller | skipping: Conditional result was False
2025-11-08 00:10:39.969818 | 
2025-11-08 00:10:39.969916 | TASK [ensure-docker : Sanity check for upstream install]
2025-11-08 00:10:40.009050 | controller | skipping: Conditional result was False
2025-11-08 00:10:40.017865 | 
2025-11-08 00:10:40.018003 | TASK [ensure-docker : Sanity check for upstream install mirrors]
2025-11-08 00:10:40.054247 | controller | skipping: Conditional result was False
2025-11-08 00:10:40.064205 | 
2025-11-08 00:10:40.064375 | TASK [ensure-docker : Include tasks for docker install]
2025-11-08 00:10:40.088141 | controller | ok
2025-11-08 00:10:40.099183 | controller | included: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml
2025-11-08 00:10:40.111782 | 
2025-11-08 00:10:40.111956 | TASK [ensure-docker : Not Implemented]
2025-11-08 00:10:40.138277 | controller | skipping: Conditional result was False
2025-11-08 00:10:40.146439 | 
2025-11-08 00:10:40.146553 | TASK [Set up docker mirrors]
2025-11-08 00:10:40.170980 | controller | ok
2025-11-08 00:10:40.196619 | 
2025-11-08 00:10:40.196770 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info]
2025-11-08 00:10:40.232200 | controller | skipping: Conditional result was False
2025-11-08 00:10:40.243022 | 
2025-11-08 00:10:40.243160 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info]
2025-11-08 00:10:40.340558 | controller | skipping: Conditional result was False
2025-11-08 00:10:40.400177 | 
2025-11-08 00:10:40.400384 | TASK [use-docker-mirror : Set docker_mirror fact]
2025-11-08 00:10:40.436869 | controller | skipping: Conditional result was False
2025-11-08 00:10:40.444381 | 
2025-11-08 00:10:40.444457 | TASK [use-docker-mirror : Set up docker mirrors]
2025-11-08 00:10:40.469567 | controller | skipping: Conditional result was False
2025-11-08 00:10:40.486046 | 
2025-11-08 00:10:40.486153 | TASK [Add all repositories]
2025-11-08 00:10:40.506606 | controller | ok
2025-11-08 00:10:40.538229 | 
2025-11-08 00:10:40.538492 | LOOP [ensure-package-repositories : Install repositories]
2025-11-08 00:10:40.565534 | controller | ok: "/var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml"
2025-11-08 00:10:40.565747 | controller | ok: All items complete
2025-11-08 00:10:40.565774 | 
2025-11-08 00:10:40.575583 | controller | included: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml
2025-11-08 00:10:40.582425 | 
2025-11-08 00:10:40.582489 | TASK [ensure-package-repositories : Create GPG key temp directory]
2025-11-08 00:10:41.513233 | controller | changed
2025-11-08 00:10:41.530209 | 
2025-11-08 00:10:41.530388 | LOOP [ensure-package-repositories : Upload GPG keys]
2025-11-08 00:10:44.810348 | controller | changed:
2025-11-08 00:10:44.811200 | controller | {
2025-11-08 00:10:44.811315 | controller |   "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n"
2025-11-08 00:10:44.811393 | controller | }
2025-11-08 00:10:44.828512 | 
2025-11-08 00:10:44.828701 | LOOP [ensure-package-repositories : Import GPG keys]
2025-11-08 00:10:46.223937 | controller | changed:
2025-11-08 00:10:46.224215 | controller | {
2025-11-08 00:10:46.224271 | controller |   "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n"
2025-11-08 00:10:46.224318 | controller | }
2025-11-08 00:10:46.224379 | controller | changed: All items complete
2025-11-08 00:10:46.224421 | 
2025-11-08 00:10:46.238464 | 
2025-11-08 00:10:46.238615 | TASK [ensure-package-repositories : Remove GPG temp directory]
2025-11-08 00:10:46.906748 | controller | changed
2025-11-08 00:10:46.916458 | 
2025-11-08 00:10:46.916582 | LOOP [ensure-package-repositories : Add repositories]
2025-11-08 00:10:47.790869 | controller | changed:
2025-11-08 00:10:47.791183 | controller | {
2025-11-08 00:10:47.791286 | controller |   "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable",
2025-11-08 00:10:47.791343 | controller |   "description": "Docker CE Stable - $basearch",
2025-11-08 00:10:47.791393 | controller |   "gpgcheck": true,
2025-11-08 00:10:47.791550 | controller |   "name": "docker-ce-stable"
2025-11-08 00:10:47.791603 | controller | }
2025-11-08 00:10:47.821722 | 
2025-11-08 00:10:47.821892 | TASK [ensure-docker : Install pre-reqs]
2025-11-08 00:10:52.755291 | controller | ok: Nothing to do
2025-11-08 00:10:52.766669 | 
2025-11-08 00:10:52.766777 | TASK [ensure-docker : Remove packages]
2025-11-08 00:10:55.921111 | controller | ok: Nothing to do
2025-11-08 00:10:55.934444 | 
2025-11-08 00:10:55.934604 | TASK [ensure-docker : Install upstream docker using package]
2025-11-08 00:12:19.303338 | controller | changed
2025-11-08 00:12:19.322004 | 
2025-11-08 00:12:19.322158 | TASK [ensure-docker : Setup docker]
2025-11-08 00:12:19.344868 | controller | ok
2025-11-08 00:12:19.359759 | controller | included: /var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml
2025-11-08 00:12:19.397795 | 
2025-11-08 00:12:19.397987 | TASK [ensure-docker : Ensure "docker" group exists]
2025-11-08 00:12:20.503643 | controller | ok
2025-11-08 00:12:20.511396 | 
2025-11-08 00:12:20.511493 | TASK [ensure-docker : Add user to docker group]
2025-11-08 00:12:21.541162 | controller | changed
2025-11-08 00:12:21.559092 | 
2025-11-08 00:12:21.559237 | TASK [Update docker daemon proxy configuration]
2025-11-08 00:12:21.583861 | controller | skipping: Conditional result was False
2025-11-08 00:12:21.591117 | 
2025-11-08 00:12:21.591221 | TASK [Lower default MTU]
2025-11-08 00:12:21.605747 | controller | skipping: Conditional result was False
2025-11-08 00:12:21.614153 | 
2025-11-08 00:12:21.614279 | TASK [ensure-docker : Get the status of the docket.socket unit]
2025-11-08 00:12:22.376497 | controller | inactive
2025-11-08 00:12:22.974551 | controller | ok: Runtime: 0:00:00.018092
2025-11-08 00:12:22.986090 | 
2025-11-08 00:12:22.986244 | TASK [ensure-docker : Get the status of the docket unit]
2025-11-08 00:12:23.792419 | controller | inactive
2025-11-08 00:12:24.346160 | controller | ok: Runtime: 0:00:00.028709
2025-11-08 00:12:24.356727 | 
2025-11-08 00:12:24.356857 | TASK [ensure-docker : Restart docker]
2025-11-08 00:12:24.399440 | Trigger a Docker restart
2025-11-08 00:12:24.406162 | 
2025-11-08 00:12:24.406229 | TASK [ensure-docker : Reset ssh connection to pick up docker group]
2025-11-08 00:12:24.432266 | 
2025-11-08 00:12:24.432383 | TASK [ensure-docker : Install docker-compose]
2025-11-08 00:12:24.456901 | controller | skipping: Conditional result was False
2025-11-08 00:12:24.464388 | 
2025-11-08 00:12:24.464486 | TASK [ensure-docker : Flush handlers before role exit]
2025-11-08 00:12:24.475722 | 
2025-11-08 00:12:24.475795 | TASK [ensure-docker : Stop docker.socket to avoid any conflict]
2025-11-08 00:12:27.839188 | controller | changed
2025-11-08 00:12:27.853703 | 
2025-11-08 00:12:27.854136 | TASK [ensure-docker : Assure docker service is running]
2025-11-08 00:12:31.787608 | controller | changed
2025-11-08 00:12:31.805976 | 
2025-11-08 00:12:31.806151 | TASK [ensure-docker : Assure docker.socket service is running]
2025-11-08 00:12:33.408753 | controller | ok
2025-11-08 00:12:33.420684 | 
2025-11-08 00:12:33.420822 | TASK [ensure-docker : Correct group ownership on docker sock]
2025-11-08 00:12:34.252023 | controller | ok
2025-11-08 00:12:34.261953 | 
2025-11-08 00:12:34.262052 | TASK [ensure-docker : Validate ability to talk with docker]
2025-11-08 00:12:34.883171 | controller | CONTAINER ID   IMAGE     COMMAND   CREATED   STATUS    PORTS     NAMES
2025-11-08 00:12:35.117876 | controller | ok: Runtime: 0:00:00.035604
2025-11-08 00:12:35.125754 | 
2025-11-08 00:12:35.125846 | TASK [ensure-docker : Get version details]
2025-11-08 00:12:35.786094 | controller | Client: Docker Engine - Community
2025-11-08 00:12:35.790714 | controller |  Version:           24.0.7
2025-11-08 00:12:35.790756 | controller |  API version:       1.43
2025-11-08 00:12:35.790766 | controller |  Go version:        go1.20.10
2025-11-08 00:12:35.790784 | controller |  Git commit:        afdd53b
2025-11-08 00:12:35.790792 | controller |  Built:             Thu Oct 26 09:09:39 2023
2025-11-08 00:12:35.790799 | controller |  OS/Arch:           linux/amd64
2025-11-08 00:12:35.790808 | controller |  Context:           default
2025-11-08 00:12:35.790817 | controller |
2025-11-08 00:12:35.790824 | controller | Server: Docker Engine - Community
2025-11-08 00:12:35.790830 | controller |  Engine:
2025-11-08 00:12:35.790836 | controller |   Version:          24.0.7
2025-11-08 00:12:35.790842 | controller |   API version:      1.43 (minimum version 1.12)
2025-11-08 00:12:35.790848 | controller |   Go version:       go1.20.10
2025-11-08 00:12:35.790854 | controller |   Git commit:       311b9ff
2025-11-08 00:12:35.790860 | controller |   Built:            Thu Oct 26 09:08:11 2023
2025-11-08 00:12:35.790866 | controller |   OS/Arch:          linux/amd64
2025-11-08 00:12:35.790872 | controller |   Experimental:     false
2025-11-08 00:12:35.790878 | controller |  containerd:
2025-11-08 00:12:35.790884 | controller |   Version:          1.6.25
2025-11-08 00:12:35.790890 | controller |   GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f
2025-11-08 00:12:35.790896 | controller |  runc:
2025-11-08 00:12:35.790902 | controller |   Version:          1.1.10
2025-11-08 00:12:35.790908 | controller |   GitCommit:        v1.1.10-0-g18a0cb0
2025-11-08 00:12:35.790916 | controller |  docker-init:
2025-11-08 00:12:35.790922 | controller |   Version:          0.19.0
2025-11-08 00:12:35.790928 | controller |   GitCommit:        de40ad0
2025-11-08 00:12:35.983767 | controller | ok: Runtime: 0:00:00.047464
2025-11-08 00:12:35.995545 | 
2025-11-08 00:12:35.995791 | TASK [ensure-docker : Dump installed docker details]
2025-11-08 00:12:36.032453 | {'changed': True, 'stdout': 'Client: Docker Engine - Community\n Version:           24.0.7\n API version:       1.43\n Go version:        go1.20.10\n Git commit:        afdd53b\n Built:             Thu Oct 26 09:09:39 2023\n OS/Arch:           linux/amd64\n Context:           default\n\nServer: Docker Engine - Community\n Engine:\n  Version:          24.0.7\n  API version:      1.43 (minimum version 1.12)\n  Go version:       go1.20.10\n  Git commit:       311b9ff\n  Built:            Thu Oct 26 09:08:11 2023\n  OS/Arch:          linux/amd64\n  Experimental:     false\n containerd:\n  Version:          1.6.25\n  GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f\n runc:\n  Version:          1.1.10\n  GitCommit:        v1.1.10-0-g18a0cb0\n docker-init:\n  Version:          0.19.0\n  GitCommit:        de40ad0', 'stderr': '', 'rc': 0, 'cmd': ['docker', 'version'], 'start': '2025-11-08 00:12:35.743772', 'end': '2025-11-08 00:12:35.791236', 'delta': '0:00:00.047464', 'msg': '', 'zuul_log_id': 'fa163efc-24cc-3f1d-a1f0-000000000061-1-controller', 'stdout_lines': ['Client: Docker Engine - Community', ' Version:           24.0.7', ' API version:       1.43', ' Go version:        go1.20.10', ' Git commit:        afdd53b', ' Built:             Thu Oct 26 09:09:39 2023', ' OS/Arch:           linux/amd64', ' Context:           default', '', 'Server: Docker Engine - Community', ' Engine:', '  Version:          24.0.7', '  API version:      1.43 (minimum version 1.12)', '  Go version:       go1.20.10', '  Git commit:       311b9ff', '  Built:            Thu Oct 26 09:08:11 2023', '  OS/Arch:          linux/amd64', '  Experimental:     false', ' containerd:', '  Version:          1.6.25', '  GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f', ' runc:', '  Version:          1.1.10', '  GitCommit:        v1.1.10-0-g18a0cb0', ' docker-init:', '  Version:          0.19.0', '  GitCommit:        de40ad0'], 'stderr_lines': [], 'failed': False}
2025-11-08 00:12:36.042764 | 
2025-11-08 00:12:36.042956 | TASK [Use buildset registry]
2025-11-08 00:12:36.070146 | controller | skipping: Conditional result was False
2025-11-08 00:12:36.084129 | 
2025-11-08 00:12:36.084228 | TASK [Ensure python3.8 is present]
2025-11-08 00:12:36.110234 | controller | skipping: Conditional result was False
2025-11-08 00:12:36.117315 | 
2025-11-08 00:12:36.117392 | TASK [Run our-ensure-python role (Fedora only for now)]
2025-11-08 00:12:36.138202 | controller | ok
2025-11-08 00:12:36.159474 | 
2025-11-08 00:12:36.159648 | TASK [our-ensure-python : Install the right Python version (rpm)]
2025-11-08 00:12:42.205893 | controller | ok: Nothing to do
2025-11-08 00:12:42.222696 | 
2025-11-08 00:12:42.222920 | TASK [our-ensure-python : Also install python3-devel]
2025-11-08 00:12:58.819264 | controller | changed
2025-11-08 00:12:58.830945 | 
2025-11-08 00:12:58.831034 | TASK [Run ensure-virtualenv role]
2025-11-08 00:12:58.851013 | controller | ok
2025-11-08 00:12:58.875405 | 
2025-11-08 00:12:58.875569 | TASK [ensure-virtualenv : Check if virtualenv is installed]
2025-11-08 00:12:59.660763 | controller | /usr/bin/virtualenv
2025-11-08 00:13:00.239530 | controller | ok: Runtime: 0:00:00.007499
2025-11-08 00:13:00.247123 | 
2025-11-08 00:13:00.247207 | LOOP [ensure-virtualenv : Install virtualenv package]
2025-11-08 00:13:00.268712 | controller | skipping: Conditional result was False
2025-11-08 00:13:00.269015 | controller | changed: All items complete
2025-11-08 00:13:00.269044 | 
2025-11-08 00:13:00.284211 | 
2025-11-08 00:13:00.284354 | TASK [Find the full path of the Python interpreter]
2025-11-08 00:13:01.084915 | controller | /usr/bin/python3.8
2025-11-08 00:13:01.651315 | controller | ok
2025-11-08 00:13:01.657801 | 
2025-11-08 00:13:01.657874 | TASK [Create virtualenv for ansible-test with a specific interpreter]
2025-11-08 00:13:03.995007 | controller | created virtual environment CPython3.8.18.final.0-64 in 1218ms
2025-11-08 00:13:04.095985 | controller |   creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False)
2025-11-08 00:13:04.096039 | controller |   seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv)
2025-11-08 00:13:04.096056 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2025-11-08 00:13:04.096076 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2025-11-08 00:13:04.524119 | controller | changed
2025-11-08 00:13:04.540767 | 
2025-11-08 00:13:04.540981 | TASK [Set selinux package]
2025-11-08 00:13:04.582458 | controller | ok
2025-11-08 00:13:04.599881 | 
2025-11-08 00:13:04.600056 | TASK [Set selinux package (Fedora)]
2025-11-08 00:13:04.657088 | controller | ok
2025-11-08 00:13:04.714474 | 
2025-11-08 00:13:04.714627 | TASK [Install selinux into virtualenv]
2025-11-08 00:13:10.151605 | controller | Collecting selinux-please-lie-to-me
2025-11-08 00:13:10.299255 | controller |   Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB)
2025-11-08 00:13:11.456681 | controller | Collecting setuptools<50.0.0
2025-11-08 00:13:11.468901 | controller |   Downloading setuptools-49.6.0-py3-none-any.whl (803 kB)
2025-11-08 00:13:11.593557 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 7.2 MB/s eta 0:00:00
2025-11-08 00:13:11.775961 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me
2025-11-08 00:13:11.776610 | controller |   Attempting uninstall: setuptools
2025-11-08 00:13:11.776639 | controller |     Found existing installation: setuptools 62.6.0
2025-11-08 00:13:11.903620 | controller |     Uninstalling setuptools-62.6.0:
2025-11-08 00:13:11.918840 | controller |       Successfully uninstalled setuptools-62.6.0
2025-11-08 00:13:12.609201 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0
2025-11-08 00:13:12.820451 | controller |
2025-11-08 00:13:13.099913 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2025-11-08 00:13:13.099974 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2025-11-08 00:13:13.609585 | controller | ok: Runtime: 0:00:07.407742
2025-11-08 00:13:13.618264 | 
2025-11-08 00:13:13.618359 | TASK [Install pytest-forked into virtualenv]
2025-11-08 00:13:15.484466 | controller | Collecting pytest-forked
2025-11-08 00:13:15.549694 | controller |   Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB)
2025-11-08 00:13:15.790090 | controller | Collecting pytest>=3.10
2025-11-08 00:13:15.797321 | controller |   Downloading pytest-8.3.5-py3-none-any.whl (343 kB)
2025-11-08 00:13:15.858274 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 343.6/343.6 kB 7.3 MB/s eta 0:00:00
2025-11-08 00:13:15.918931 | controller | Collecting py
2025-11-08 00:13:15.926333 | controller |   Downloading py-1.11.0-py2.py3-none-any.whl (98 kB)
2025-11-08 00:13:15.935320 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 16.5 MB/s eta 0:00:00
2025-11-08 00:13:16.013927 | controller | Collecting exceptiongroup>=1.0.0rc8
2025-11-08 00:13:16.018893 | controller |   Downloading exceptiongroup-1.3.0-py3-none-any.whl (16 kB)
2025-11-08 00:13:16.103222 | controller | Collecting packaging
2025-11-08 00:13:16.109111 | controller |   Downloading packaging-25.0-py3-none-any.whl (66 kB)
2025-11-08 00:13:16.125411 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 4.4 MB/s eta 0:00:00
2025-11-08 00:13:16.161863 | controller | Collecting iniconfig
2025-11-08 00:13:16.173075 | controller |   Downloading iniconfig-2.1.0-py3-none-any.whl (6.0 kB)
2025-11-08 00:13:16.228648 | controller | Collecting pluggy<2,>=1.5
2025-11-08 00:13:16.234018 | controller |   Downloading pluggy-1.5.0-py3-none-any.whl (20 kB)
2025-11-08 00:13:16.317673 | controller | Collecting tomli>=1
2025-11-08 00:13:16.323630 | controller |   Downloading tomli-2.3.0-py3-none-any.whl (14 kB)
2025-11-08 00:13:16.418093 | controller | Collecting typing-extensions>=4.6.0
2025-11-08 00:13:16.424195 | controller |   Downloading typing_extensions-4.13.2-py3-none-any.whl (45 kB)
2025-11-08 00:13:16.436177 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.8/45.8 kB 4.6 MB/s eta 0:00:00
2025-11-08 00:13:16.551909 | controller | Installing collected packages: typing-extensions, tomli, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked
2025-11-08 00:13:17.546120 | controller | Successfully installed exceptiongroup-1.3.0 iniconfig-2.1.0 packaging-25.0 pluggy-1.5.0 py-1.11.0 pytest-8.3.5 pytest-forked-1.6.0 tomli-2.3.0 typing-extensions-4.13.2
2025-11-08 00:13:17.553207 | controller |
2025-11-08 00:13:17.843285 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2025-11-08 00:13:17.843335 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2025-11-08 00:13:17.985707 | controller | ok: Runtime: 0:00:03.194505
2025-11-08 00:13:17.992379 | 
2025-11-08 00:13:17.992457 | TASK [Update pip]
2025-11-08 00:13:20.436741 | controller | Requirement already satisfied: pip in ./venv/lib/python3.8/site-packages (22.2.2)
2025-11-08 00:13:20.845102 | controller | Collecting pip
2025-11-08 00:13:20.982085 | controller |   Downloading pip-25.0.1-py3-none-any.whl (1.8 MB)
2025-11-08 00:13:21.113531 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 15.5 MB/s eta 0:00:00
2025-11-08 00:13:21.240060 | controller | Installing collected packages: pip
2025-11-08 00:13:21.243570 | controller |   Attempting uninstall: pip
2025-11-08 00:13:21.244983 | controller |     Found existing installation: pip 22.2.2
2025-11-08 00:13:21.871480 | controller |     Uninstalling pip-22.2.2:
2025-11-08 00:13:21.954343 | controller |       Successfully uninstalled pip-22.2.2
2025-11-08 00:13:24.515128 | controller | Successfully installed pip-25.0.1
2025-11-08 00:13:25.361391 | controller | ok: Runtime: 0:00:05.705100
2025-11-08 00:13:25.375385 | 
2025-11-08 00:13:25.375534 | TASK [Ensure pip temp directory exists in /var/tmp]
2025-11-08 00:13:26.564716 | controller | changed
2025-11-08 00:13:26.579294 | 
2025-11-08 00:13:26.579510 | TASK [Install ansible into virtualenv]
2025-11-08 00:13:28.472968 | controller | Processing ./src/github.com/ansible/ansible
2025-11-08 00:13:28.475447 | controller |   Preparing metadata (setup.py): started
2025-11-08 00:13:30.529926 | controller |   Preparing metadata (setup.py): finished with status 'done'
2025-11-08 00:13:30.603604 | controller | Collecting jinja2 (from ansible==2.9.27.post0)
2025-11-08 00:13:30.622200 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB)
2025-11-08 00:13:30.725577 | controller | Collecting PyYAML (from ansible==2.9.27.post0)
2025-11-08 00:13:30.734392 | controller |   Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.1 kB)
2025-11-08 00:13:31.230217 | controller | Collecting cryptography (from ansible==2.9.27.post0)
2025-11-08 00:13:31.235631 | controller |   Downloading cryptography-46.0.3-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB)
2025-11-08 00:13:31.509873 | controller | Collecting cffi>=1.14 (from cryptography->ansible==2.9.27.post0)
2025-11-08 00:13:31.516329 | controller |   Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB)
2025-11-08 00:13:31.531485 | controller | Requirement already satisfied: typing-extensions>=4.13.2 in ./venv/lib/python3.8/site-packages (from cryptography->ansible==2.9.27.post0) (4.13.2)
2025-11-08 00:13:31.652955 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible==2.9.27.post0)
2025-11-08 00:13:31.660964 | controller |   Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (3.0 kB)
2025-11-08 00:13:31.695462 | controller | Collecting pycparser (from cffi>=1.14->cryptography->ansible==2.9.27.post0)
2025-11-08 00:13:31.702553 | controller |   Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes)
2025-11-08 00:13:31.736708 | controller | Downloading cryptography-46.0.3-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2025-11-08 00:13:31.795153 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 87.1 MB/s eta 0:00:00
2025-11-08 00:13:31.803181 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2025-11-08 00:13:31.822312 | controller | Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB)
2025-11-08 00:13:31.850064 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.0/806.0 kB 27.3 MB/s eta 0:00:00
2025-11-08 00:13:31.857026 | controller | Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB)
2025-11-08 00:13:31.878207 | controller | Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (26 kB)
2025-11-08 00:13:31.897660 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB)
2025-11-08 00:13:31.933351 | controller | Building wheels for collected packages: ansible
2025-11-08 00:13:31.937717 | controller |   Building wheel for ansible (setup.py): started
2025-11-08 00:13:42.361900 | controller |   Building wheel for ansible (setup.py): finished with status 'done'
2025-11-08 00:13:42.382016 | controller |   Created wheel for ansible: filename=ansible-2.9.27.post0-py3-none-any.whl size=16207514 sha256=ab277001f4120c711d17b1613670a6147ac1abf2dacb95e81c1c6d3e49512c48
2025-11-08 00:13:42.382587 | controller |   Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-75njb02b/wheels/a5/4b/fa/b6deaae105422b0b3b92831e0369d44bf7fca5bb3413d79be7
2025-11-08 00:13:42.470685 | controller | Successfully built ansible
2025-11-08 00:13:42.652204 | controller | Installing collected packages: PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible
2025-11-08 00:13:56.925619 | controller | Successfully installed MarkupSafe-2.1.5 PyYAML-6.0.3 ansible-2.9.27.post0 cffi-1.17.1 cryptography-46.0.3 jinja2-3.1.6 pycparser-2.23
2025-11-08 00:13:57.503560 | controller | ok: Runtime: 0:00:29.561979
2025-11-08 00:13:57.511624 | 
2025-11-08 00:13:57.511730 | TASK [Setup download-artifact-fork role]
2025-11-08 00:13:57.554440 | controller | ok
2025-11-08 00:13:57.588239 | 
2025-11-08 00:13:57.588429 | TASK [download-artifact-fork : Parse inventory response]
2025-11-08 00:13:57.641958 | controller | ok
2025-11-08 00:13:57.648804 | 
2025-11-08 00:13:57.648928 | TASK [download-artifact-fork : Fetch info from Zuul API]
2025-11-08 00:13:57.695297 | controller | skipping: Conditional result was False
2025-11-08 00:13:57.702423 | 
2025-11-08 00:13:57.702499 | TASK [download-artifact-fork : Parse build response]
2025-11-08 00:13:57.748618 | controller | skipping: Conditional result was False
2025-11-08 00:13:57.758030 | 
2025-11-08 00:13:57.758104 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2025-11-08 00:13:58.640794 | controller | changed
2025-11-08 00:13:58.655115 | 
2025-11-08 00:13:58.655359 | LOOP [download-artifact-fork : Download archive by type]
2025-11-08 00:13:58.702032 | controller | skipping: Conditional result was False
2025-11-08 00:13:58.703391 | 
2025-11-08 00:14:00.661209 | controller | changed: OK (20212 bytes)
2025-11-08 00:14:00.701825 | 
2025-11-08 00:14:00.702127 | TASK [deploy-artifacts : define __collections]
2025-11-08 00:14:00.728425 | controller | ok
2025-11-08 00:14:00.737554 | 
2025-11-08 00:14:00.737650 | LOOP [deploy-artifacts : Create list of collections]
2025-11-08 00:14:00.768130 | controller | skipping: Conditional result was False
2025-11-08 00:14:00.855883 | controller | ok:
2025-11-08 00:14:00.856040 | controller | {
2025-11-08 00:14:00.856065 | controller |   "branch": "main",
2025-11-08 00:14:00.856084 | controller |   "job": "build-ansible-collection",
2025-11-08 00:14:00.856101 | controller |   "metadata": {
2025-11-08 00:14:00.856117 | controller |     "type": "ansible_collection",
2025-11-08 00:14:00.856133 | controller |     "version": "5.0.0"
2025-11-08 00:14:00.856149 | controller |   },
2025-11-08 00:14:00.856164 | controller |   "name": "ansible.network",
2025-11-08 00:14:00.856179 | controller |   "project": "ansible-collections/ansible.network",
2025-11-08 00:14:00.856195 | controller |   "url": "https://9633d17efd53a144cea1-6fa346a2baf72bd4ffcc4b3619ee210f.ssl.cf5.rackcdn.com/ansible/36cf9bf5280443ac938983d1ee9e9148/artifacts/ansible-network-5.0.0.tar.gz"
2025-11-08 00:14:00.856219 | controller | }
2025-11-08 00:14:00.871481 | 
2025-11-08 00:14:00.871678 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2025-11-08 00:14:01.909106 | controller | Process install dependency map
2025-11-08 00:14:47.915037 | controller | |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\Starting collection install process
2025-11-08 00:14:48.016226 | controller | |Installing 'ansible.network:5.0.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/network'
2025-11-08 00:14:48.016370 | controller | Installing 'ansible.netcommon:8.2.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2025-11-08 00:14:49.338977 | controller | /-\|/-\|/-\|/Installing 'ansible.utils:6.0.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2025-11-08 00:14:51.146129 | controller | -\|/-\|/-\|/-\|/-\Installing 'arista.eos:12.0.0' to '/home/zuul/.ansible/collections/ansible_collections/arista/eos'
2025-11-08 00:14:53.566864 | controller | |/-\|/-\|/-\|/-\|/-\|/-\Installing 'cisco.ios:11.1.1' to '/home/zuul/.ansible/collections/ansible_collections/cisco/ios'
2025-11-08 00:14:56.686608 | controller | |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-Installing 'cisco.iosxr:12.1.0' to '/home/zuul/.ansible/collections/ansible_collections/cisco/iosxr'
2025-11-08 00:14:59.309822 | controller | \|/-\|/-\|/-\|/-\|/-\|/-\|Installing 'cisco.nxos:11.1.0' to '/home/zuul/.ansible/collections/ansible_collections/cisco/nxos'
2025-11-08 00:15:03.693047 | controller | /-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\Installing 'junipernetworks.junos:11.0.0' to '/home/zuul/.ansible/collections/ansible_collections/junipernetworks/junos'
2025-11-08 00:15:06.772609 | controller | ok: Runtime: 0:01:04.921749
2025-11-08 00:15:06.790329 | 
2025-11-08 00:15:06.790512 | TASK [podman may need iptables kernel modules]
2025-11-08 00:15:08.153985 | controller | ok: Runtime: 0:00:00.010959
2025-11-08 00:15:08.196477 | 
2025-11-08 00:15:08.196645 | PLAY RECAP
2025-11-08 00:15:08.196758 | controller | ok: 46 changed: 26 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0
2025-11-08 00:15:08.196790 | 
2025-11-08 00:15:08.389597 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2025-11-08 00:15:08.392450 | RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2025-11-08 00:15:09.176705 | 
2025-11-08 00:15:09.176864 | PLAY [controller]
2025-11-08 00:15:09.208270 | 
2025-11-08 00:15:09.208522 | TASK [Copy the galaxy.yml on the controller]
2025-11-08 00:15:12.990529 | controller | changed
2025-11-08 00:15:13.005172 | 
2025-11-08 00:15:13.005342 | TASK [Load information from galaxy.yml]
2025-11-08 00:15:13.047722 | controller | ok
2025-11-08 00:15:13.062065 | 
2025-11-08 00:15:13.062173 | LOOP [Enable FIPS mode]
2025-11-08 00:15:13.104421 | 
2025-11-08 00:15:13.104656 | LOOP [ansible-test : Include branch specific variables.]
2025-11-08 00:15:13.151819 | controller | ok: "/var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/untrusted/project_2/github.com/ansible/ansible-zuul-jobs/roles/ansible-test/vars/default.yaml"
2025-11-08 00:15:13.152177 | 
2025-11-08 00:15:13.162824 | 
2025-11-08 00:15:13.162924 | TASK [ansible-test : Setup --skip-tags for test_options]
2025-11-08 00:15:13.218658 | controller | ok
2025-11-08 00:15:13.226529 | 
2025-11-08 00:15:13.226624 | TASK [ansible-test : Enable --inventory for network-integration]
2025-11-08 00:15:13.272450 | controller | skipping: Conditional result was False
2025-11-08 00:15:13.297911 | 
2025-11-08 00:15:13.298166 | TASK [ansible-test : Enable --retry-on-error]
2025-11-08 00:15:13.336951 | controller | skipping: Conditional result was False
2025-11-08 00:15:13.351298 | 
2025-11-08 00:15:13.351396 | TASK [ansible-test : Enable --continue-on-error]
2025-11-08 00:15:13.394943 | controller | ok
2025-11-08 00:15:13.402952 | 
2025-11-08 00:15:13.403037 | TASK [ansible-test : Enable --requirements]
2025-11-08 00:15:13.429199 | controller | skipping: Conditional result was False
2025-11-08 00:15:13.437755 | 
2025-11-08 00:15:13.438014 | TASK [ansible-test : Adjust options for unit tests]
2025-11-08 00:15:13.463355 | controller | skipping: Conditional result was False
2025-11-08 00:15:13.473179 | 
2025-11-08 00:15:13.473268 | TASK [ansible-test : Install requirements with unit tests]
2025-11-08 00:15:13.550830 | controller | ok
2025-11-08 00:15:13.556800 | 
2025-11-08 00:15:13.556891 | TASK [ansible-test : Set --skip-test]
2025-11-08 00:15:13.613123 | controller | skipping: Conditional result was False
2025-11-08 00:15:13.620528 | 
2025-11-08 00:15:13.620606 | TASK [ansible-test : Reduce verbosity]
2025-11-08 00:15:13.666120 | controller | ok
2025-11-08 00:15:13.675168 | 
2025-11-08 00:15:13.675265 | TASK [ansible-test : Setup --python option]
2025-11-08 00:15:13.702133 | controller | skipping: Conditional result was False
2025-11-08 00:15:13.711985 | 
2025-11-08 00:15:13.712089 | TASK [ansible-test : Setup --docker option]
2025-11-08 00:15:13.750963 | controller | ok
2025-11-08 00:15:13.762021 | 
2025-11-08 00:15:13.762151 | TASK [ansible-test : check if MANIFEST.json exists]
2025-11-08 00:15:14.806545 | controller | ok
2025-11-08 00:15:14.822220 | 
2025-11-08 00:15:14.822404 | TASK [ansible-test : Copy the MANIFEST.json on the controller]
2025-11-08 00:15:14.843723 | controller | skipping: Conditional result was False
2025-11-08 00:15:14.863194 | 
2025-11-08 00:15:14.863412 | TASK [ansible-test : Load information from MANIFEST.json]
2025-11-08 00:15:14.891981 | controller | skipping: Conditional result was False
2025-11-08 00:15:14.902988 | 
2025-11-08 00:15:14.903167 | TASK [ansible-test : Setup location of project for integration tests]
2025-11-08 00:15:14.930350 | controller | skipping: Conditional result was False
2025-11-08 00:15:14.944022 | 
2025-11-08 00:15:14.944158 | TASK [ansible-test : Copy the galaxy.yml on the controller]
2025-11-08 00:15:16.319091 | controller | ok
2025-11-08 00:15:16.336849 | 
2025-11-08 00:15:16.337071 | TASK [ansible-test : Load information from galaxy.yml]
2025-11-08 00:15:16.393013 | controller | ok
2025-11-08 00:15:16.412899 | 
2025-11-08 00:15:16.413068 | TASK [ansible-test : Setup location of project for integration tests]
2025-11-08 00:15:16.469913 | controller | ok
2025-11-08 00:15:16.478276 | 
2025-11-08 00:15:16.478368 | TASK [ansible-test : Setup minimum test requirements]
2025-11-08 00:15:16.536521 | controller | ok
2025-11-08 00:15:16.547013 | 
2025-11-08 00:15:16.547257 | TASK [ansible-test : Ensure pip temp directory exists in /var/tmp]
2025-11-08 00:15:17.504452 | controller | ok
2025-11-08 00:15:17.513802 | 
2025-11-08 00:15:17.513941 | TASK [ansible-test : Install python requirements]
2025-11-08 00:15:19.067392 | controller | Collecting yamllint (from -r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2025-11-08 00:15:19.084794 | controller |   Downloading yamllint-1.35.1-py3-none-any.whl.metadata (4.2 kB)
2025-11-08 00:15:19.134154 | controller | Collecting pathspec>=0.5.3 (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2025-11-08 00:15:19.139536 | controller |   Downloading pathspec-0.12.1-py3-none-any.whl.metadata (21 kB)
2025-11-08 00:15:19.154573 | controller | Requirement already satisfied: pyyaml in ./venv/lib64/python3.8/site-packages (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1)) (6.0.3)
2025-11-08 00:15:19.163064 | controller | Downloading yamllint-1.35.1-py3-none-any.whl (66 kB)
2025-11-08 00:15:19.180050 | controller | Downloading pathspec-0.12.1-py3-none-any.whl (31 kB)
2025-11-08 00:15:19.253689 | controller | Installing collected packages: pathspec, yamllint
2025-11-08 00:15:19.350000 | controller | Successfully installed pathspec-0.12.1 yamllint-1.35.1
2025-11-08 00:15:19.882790 | controller | ok: Runtime: 0:00:01.072334
2025-11-08 00:15:19.894307 | 
2025-11-08 00:15:19.894446 | TASK [ansible-test : Copy the integration_config.yml file from the controller]
2025-11-08 00:15:20.750804 | controller | cp: cannot stat '/tmp/integration_config.yml': No such file or directory
2025-11-08 00:15:21.265635 | controller | ERROR
2025-11-08 00:15:21.266467 | controller | {
2025-11-08 00:15:21.266562 | controller |   "delta": "0:00:00.008224",
2025-11-08 00:15:21.266629 | controller |   "end": "2025-11-08 00:15:20.751097",
2025-11-08 00:15:21.266725 | controller |   "msg": "non-zero return code",
2025-11-08 00:15:21.266769 | controller |   "rc": 1,
2025-11-08 00:15:21.266821 | controller |   "start": "2025-11-08 00:15:20.742873"
2025-11-08 00:15:21.266876 | controller | }
2025-11-08 00:15:21.266946 | controller | ERROR: Ignoring Errors
2025-11-08 00:15:21.289642 | 
2025-11-08 00:15:21.289983 | TASK [ansible-test : Copy potential cloud provider configuration for ansible-test in the collection]
2025-11-08 00:15:21.673930 | controller | skipping: Conditional result was False
2025-11-08 00:15:21.690281 | 
2025-11-08 00:15:21.690520 | TASK [ansible-test : Enable persistent connection logging]
2025-11-08 00:15:23.130643 | controller | changed: section and option added
2025-11-08 00:15:23.147407 | 
2025-11-08 00:15:23.147648 | TASK [ansible-test : Set persistent ssh_type value]
2025-11-08 00:15:24.521200 | controller | changed: option added
2025-11-08 00:15:24.534956 | 
2025-11-08 00:15:24.535105 | TASK [ansible-test : Set ansible log path]
2025-11-08 00:15:25.782267 | controller | changed: section and option added
2025-11-08 00:15:25.798093 | 
2025-11-08 00:15:25.798338 | TASK [ansible-test : Identify the changed targets]
2025-11-08 00:15:26.174074 | controller | skipping: Conditional result was False
2025-11-08 00:15:26.189269 | 
2025-11-08 00:15:26.189510 | TASK [ansible-test : set_fact]
2025-11-08 00:15:26.311253 | controller | skipping: Conditional result was False
2025-11-08 00:15:26.321799 | 
2025-11-08 00:15:26.321990 | TASK [ansible-test : Set the targets]
2025-11-08 00:15:26.403366 | controller | ok
2025-11-08 00:15:26.409327 | 
2025-11-08 00:15:26.409389 | TASK [ansible-test : set_fact]
2025-11-08 00:15:26.434491 | controller | skipping: Conditional result was False
2025-11-08 00:15:26.441716 | 
2025-11-08 00:15:26.441786 | TASK [ansible-test : List the targets]
2025-11-08 00:15:26.812032 | controller | skipping: Conditional result was False
2025-11-08 00:15:26.826427 | 
2025-11-08 00:15:26.826626 | TASK [ansible-test : set_fact]
2025-11-08 00:15:26.864767 | controller | skipping: Conditional result was False
2025-11-08 00:15:26.879435 | 
2025-11-08 00:15:26.879737 | TASK [ansible-test : set_fact]
2025-11-08 00:15:26.909858 | controller | skipping: Conditional result was False
2025-11-08 00:15:26.924932 | 
2025-11-08 00:15:26.925078 | LOOP [ansible-test : set_fact]
2025-11-08 00:15:26.998756 | 
2025-11-08 00:15:26.999100 | TASK [ansible-test : set_fact]
2025-11-08 00:15:27.028320 | controller | skipping: Conditional result was False
2025-11-08 00:15:27.047178 | 
2025-11-08 00:15:27.047429 | TASK [ansible-test : debug]
2025-11-08 00:15:27.075658 | controller | skipping: Conditional result was False
2025-11-08 00:15:27.087900 | 
2025-11-08 00:15:27.088004 | TASK [ansible-test : debug]
2025-11-08 00:15:27.122122 | About to run: ansible-test sanity --requirements --docker -v
2025-11-08 00:15:27.130147 | 
2025-11-08 00:15:27.130279 | TASK [ansible-test : Run the test suite]
2025-11-08 00:15:28.592916 | controller | Run command: docker images quay.io/ansible/default-test-container:1.10.1 --format '{{json .}}'
2025-11-08 00:15:28.669028 | controller | Run command: docker pull quay.io/ansible/default-test-container:1.10.1
2025-11-08 00:15:30.565269 | controller | 1.10.1: Pulling from ansible/default-test-container
2025-11-08 00:15:30.565324 | controller | [DEPRECATION NOTICE] Docker Image Format v1, and Docker Image manifest version 2, schema 1 support will be removed in an upcoming release. Suggest the author of quay.io/ansible/default-test-container:1.10.1 to upgrade the image to the OCI Format, or Docker Image manifest v2, schema 2. More information at https://docs.docker.com/go/deprecated-image-specs/
2025-11-08 00:15:30.565347 | controller | 5667fdb72017: Pulling fs layer
2025-11-08 00:15:30.565355 | controller | d83811f270d5: Pulling fs layer
2025-11-08 00:15:30.565362 | controller | ee671aafb583: Pulling fs layer
2025-11-08 00:15:30.565371 | controller | 7fc152dfb3a6: Pulling fs layer
2025-11-08 00:15:30.565383 | controller | 3fb967a6fd03: Pulling fs layer
2025-11-08 00:15:30.565389 | controller | b3e63023ca5f: Pulling fs layer
2025-11-08 00:15:30.565412 | controller | 653cb3e65dbf: Pulling fs layer
2025-11-08 00:15:30.565419 | controller | f4712b586375: Pulling fs layer
2025-11-08 00:15:30.565425 | controller | d696ed7812f8: Pulling fs layer
2025-11-08 00:15:30.565431 | controller | 29bf28764f14: Pulling fs layer
2025-11-08 00:15:30.565437 | controller | 47d7edb3c2b7: Pulling fs layer
2025-11-08 00:15:30.565444 | controller | 07550ad4f6e4: Pulling fs layer
2025-11-08 00:15:30.565450 | controller | 7e79526e64c5: Pulling fs layer
2025-11-08 00:15:30.565456 | controller | 4fffb32882b7: Pulling fs layer
2025-11-08 00:15:30.565462 | controller | fc7a38b06f4e: Pulling fs layer
2025-11-08 00:15:30.565468 | controller | 6d9d912e060e: Pulling fs layer
2025-11-08 00:15:30.565473 | controller | 5dd542dd28d9: Pulling fs layer
2025-11-08 00:15:30.565479 | controller | cef8beb99552: Pulling fs layer
2025-11-08 00:15:30.565485 | controller | bd5557e101ad: Pulling fs layer
2025-11-08 00:15:30.565491 | controller | e057c20fabdd: Pulling fs layer
2025-11-08 00:15:30.565500 | controller | d16059cdae2e: Pulling fs layer
2025-11-08 00:15:30.565506 | controller | 431e42d906a3: Pulling fs layer
2025-11-08 00:15:30.565514 | controller | 7a0fd3b1d7c3: Pulling fs layer
2025-11-08 00:15:30.565520 | controller | aacdb6db0c8c: Pulling fs layer
2025-11-08 00:15:30.565526 | controller | 2e7f04ae8c8b: Pulling fs layer
2025-11-08 00:15:30.565535 | controller | 4cd343027a44: Pulling fs layer
2025-11-08 00:15:30.565541 | controller | 0b4379883f90: Pulling fs layer
2025-11-08 00:15:30.565548 | controller | 3d9d6d9dfc91: Pulling fs layer
2025-11-08 00:15:30.565557 | controller | 57d6314bd293: Pulling fs layer
2025-11-08 00:15:30.565563 | controller | 774036afeb7f: Pulling fs layer
2025-11-08 00:15:30.565569 | controller | 54b10f0e1645: Pulling fs layer
2025-11-08 00:15:30.565575 | controller | 78cf439d9fdb: Pulling fs layer
2025-11-08 00:15:30.565581 | controller | 36e5e20969c7: Pulling fs layer
2025-11-08 00:15:30.565587 | controller | 4b19ac3f17a8: Pulling fs layer
2025-11-08 00:15:30.565593 | controller | cef8beb99552: Waiting
2025-11-08 00:15:30.565599 | controller | bd5557e101ad: Waiting
2025-11-08 00:15:30.565607 | controller | e057c20fabdd: Waiting
2025-11-08 00:15:30.565612 | controller | d16059cdae2e: Waiting
2025-11-08 00:15:30.565618 | controller | 431e42d906a3: Waiting
2025-11-08 00:15:30.565624 | controller | 7a0fd3b1d7c3: Waiting
2025-11-08 00:15:30.565630 | controller | aacdb6db0c8c: Waiting
2025-11-08 00:15:30.565638 | controller | 2e7f04ae8c8b: Waiting
2025-11-08 00:15:30.565644 | controller | 4cd343027a44: Waiting
2025-11-08 00:15:30.565652 | controller | 0b4379883f90: Waiting
2025-11-08 00:15:30.565657 | controller | 3d9d6d9dfc91: Waiting
2025-11-08 00:15:30.565663 | controller | 57d6314bd293: Waiting
2025-11-08 00:15:30.565669 | controller | 774036afeb7f: Waiting
2025-11-08 00:15:30.565674 | controller | 54b10f0e1645: Waiting
2025-11-08 00:15:30.565683 | controller | 78cf439d9fdb: Waiting
2025-11-08 00:15:30.565689 | controller | 36e5e20969c7: Waiting
2025-11-08 00:15:30.565695 | controller | 4b19ac3f17a8: Waiting
2025-11-08 00:15:30.565709 | controller | 7fc152dfb3a6: Waiting
2025-11-08 00:15:30.565715 | controller | 3fb967a6fd03: Waiting
2025-11-08 00:15:30.565727 | controller | b3e63023ca5f: Waiting
2025-11-08 00:15:30.565733 | controller | 47d7edb3c2b7: Waiting
2025-11-08 00:15:30.565739 | controller | 653cb3e65dbf: Waiting
2025-11-08 00:15:30.565745 | controller | f4712b586375: Waiting
2025-11-08 00:15:30.565751 | controller | d696ed7812f8: Waiting
2025-11-08 00:15:30.565757 | controller | 29bf28764f14: Waiting
2025-11-08 00:15:30.565763 | controller | 07550ad4f6e4: Waiting
2025-11-08 00:15:30.565771 | controller | fc7a38b06f4e: Waiting
2025-11-08 00:15:30.565788 | controller | 6d9d912e060e: Waiting
2025-11-08 00:15:30.565796 | controller | 7e79526e64c5: Waiting
2025-11-08 00:15:30.565805 | controller | 4fffb32882b7: Waiting
2025-11-08 00:15:31.381119 | controller | ee671aafb583: Verifying Checksum
2025-11-08 00:15:31.618591 | controller | ee671aafb583: Download complete
2025-11-08 00:15:31.618653 | controller | d83811f270d5: Verifying Checksum
2025-11-08 00:15:32.112673 | controller | d83811f270d5: Download complete
2025-11-08 00:15:32.112731 | controller | 7fc152dfb3a6: Verifying Checksum
2025-11-08 00:15:32.936446 | controller | 7fc152dfb3a6: Download complete
2025-11-08 00:15:32.936518 | controller | b3e63023ca5f: Verifying Checksum
2025-11-08 00:15:33.684541 | controller | b3e63023ca5f: Download complete
2025-11-08 00:15:33.684616 | controller | 653cb3e65dbf: Verifying Checksum
2025-11-08 00:15:36.873869 | controller | 653cb3e65dbf: Download complete
2025-11-08 00:15:36.873929 | controller | 3fb967a6fd03: Verifying Checksum
2025-11-08 00:15:38.072116 | controller | 3fb967a6fd03: Download complete
2025-11-08 00:15:38.072190 | controller | d696ed7812f8: Download complete
2025-11-08 00:15:38.631736 | controller | 5667fdb72017: Verifying Checksum
2025-11-08 00:15:38.631864 | controller | 5667fdb72017: Download complete
2025-11-08 00:15:39.124123 | controller | 29bf28764f14: Verifying Checksum
2025-11-08 00:15:39.124227 | controller | 29bf28764f14: Download complete
2025-11-08 00:15:39.913295 | controller | 07550ad4f6e4: Verifying Checksum
2025-11-08 00:15:39.913650 | controller | 07550ad4f6e4: Download complete
2025-11-08 00:15:40.018723 | controller | 47d7edb3c2b7: Verifying Checksum
2025-11-08 00:15:40.019087 | controller | 47d7edb3c2b7: Download complete
2025-11-08 00:15:40.665604 | controller | 7e79526e64c5: Verifying Checksum
2025-11-08 00:15:40.665973 | controller | 7e79526e64c5: Download complete
2025-11-08 00:15:40.829033 | controller | 4fffb32882b7: Verifying Checksum
2025-11-08 00:15:40.829127 | controller | 4fffb32882b7: Download complete
2025-11-08 00:15:41.239423 | controller | 5667fdb72017: Pull complete
2025-11-08 00:15:41.314739 | controller | d83811f270d5: Pull complete
2025-11-08 00:15:41.349077 | controller | ee671aafb583: Pull complete
2025-11-08 00:15:41.377379 | controller | 7fc152dfb3a6: Pull complete
2025-11-08 00:15:41.703363 | controller | 6d9d912e060e: Verifying Checksum
2025-11-08 00:15:41.703460 | controller | 6d9d912e060e: Download complete
2025-11-08 00:15:42.122715 | controller | fc7a38b06f4e: Verifying Checksum
2025-11-08 00:15:42.122797 | controller | fc7a38b06f4e: Download complete
2025-11-08 00:15:42.460297 | controller | 3fb967a6fd03: Pull complete
2025-11-08 00:15:42.505684 | controller | 5dd542dd28d9: Verifying Checksum
2025-11-08 00:15:42.506247 | controller | b3e63023ca5f: Pull complete
2025-11-08 00:15:42.506698 | controller | 5dd542dd28d9: Download complete
2025-11-08 00:15:42.543749 | controller | 653cb3e65dbf: Pull complete
2025-11-08 00:15:43.319670 | controller | bd5557e101ad: Verifying Checksum
2025-11-08 00:15:43.319761 | controller | bd5557e101ad: Download complete
2025-11-08 00:15:44.007151 | controller | e057c20fabdd: Verifying Checksum
2025-11-08 00:15:44.007239 | controller | e057c20fabdd: Download complete
2025-11-08 00:15:44.718611 | controller | d16059cdae2e: Download complete
2025-11-08 00:15:47.080459 | controller | 431e42d906a3: Verifying Checksum
2025-11-08 00:15:47.080556 | controller | 431e42d906a3: Download complete
2025-11-08 00:15:48.643245 | controller | 7a0fd3b1d7c3: Verifying Checksum
2025-11-08 00:15:48.643370 | controller | 7a0fd3b1d7c3: Download complete
2025-11-08 00:15:50.126047 | controller | aacdb6db0c8c: Verifying Checksum
2025-11-08 00:15:50.126135 | controller | aacdb6db0c8c: Download complete
2025-11-08 00:15:50.919804 | controller | 2e7f04ae8c8b: Verifying Checksum
2025-11-08 00:15:50.919915 | controller | 2e7f04ae8c8b: Download complete
2025-11-08 00:15:51.613797 | controller | 4cd343027a44: Verifying Checksum
2025-11-08 00:15:51.613894 | controller | 4cd343027a44: Download complete
2025-11-08 00:15:52.429645 | controller | 0b4379883f90: Verifying Checksum
2025-11-08 00:15:52.429756 | controller | 0b4379883f90: Download complete
2025-11-08 00:15:53.787912 | controller | 3d9d6d9dfc91: Download complete
2025-11-08 00:15:58.282077 | controller | f4712b586375: Verifying Checksum
2025-11-08 00:15:58.282172 | controller | f4712b586375: Download complete
2025-11-08 00:16:06.485382 | controller | 57d6314bd293: Verifying Checksum
2025-11-08 00:16:06.485487 | controller | 57d6314bd293: Download complete
2025-11-08 00:16:14.893623 | controller | 774036afeb7f: Verifying Checksum
2025-11-08 00:16:14.893794 | controller | 774036afeb7f: Download complete
2025-11-08 00:16:16.222815 | controller | 54b10f0e1645: Verifying Checksum
2025-11-08 00:16:16.226031 | controller | 54b10f0e1645: Download complete
2025-11-08 00:16:17.968506 | controller | cef8beb99552: Verifying Checksum
2025-11-08 00:16:17.968596 | controller | cef8beb99552: Download complete
2025-11-08 00:16:22.953111 | controller | f4712b586375: Pull complete
2025-11-08 00:16:23.007599 | controller | d696ed7812f8: Pull complete
2025-11-08 00:16:23.049373 | controller | 29bf28764f14: Pull complete
2025-11-08 00:16:23.105684 | controller | 47d7edb3c2b7: Pull complete
2025-11-08 00:16:23.142579 | controller | 07550ad4f6e4: Pull complete
2025-11-08 00:16:23.175506 | controller | 7e79526e64c5: Pull complete
2025-11-08 00:16:23.234844 | controller | 4fffb32882b7: Pull complete
2025-11-08 00:16:23.337276 | controller | fc7a38b06f4e: Pull complete
2025-11-08 00:16:23.394825 | controller | 6d9d912e060e: Pull complete
2025-11-08 00:16:23.471912 | controller | 5dd542dd28d9: Pull complete
2025-11-08 00:16:25.298905 | controller | 4b19ac3f17a8: Verifying Checksum
2025-11-08 00:16:25.298999 | controller | 4b19ac3f17a8: Download complete
2025-11-08 00:16:25.501488 | controller | 78cf439d9fdb: Verifying Checksum
2025-11-08 00:16:25.505835 | controller | 78cf439d9fdb: Download complete
2025-11-08 00:16:31.385848 | controller | 36e5e20969c7: Verifying Checksum
2025-11-08 00:16:31.386002 | controller | 36e5e20969c7: Download complete
2025-11-08 00:16:47.685193 | controller | cef8beb99552: Pull complete
2025-11-08 00:16:47.706466 | controller | bd5557e101ad: Pull complete
2025-11-08 00:16:47.728997 | controller | e057c20fabdd: Pull complete
2025-11-08 00:16:47.760457 | controller | d16059cdae2e: Pull complete
2025-11-08 00:16:49.931196 | controller | 431e42d906a3: Pull complete
2025-11-08 00:16:50.004086 | controller | 7a0fd3b1d7c3: Pull complete
2025-11-08 00:16:50.076599 | controller | aacdb6db0c8c: Pull complete
2025-11-08 00:16:50.117016 | controller | 2e7f04ae8c8b: Pull complete
2025-11-08 00:16:50.171655 | controller | 4cd343027a44: Pull complete
2025-11-08 00:16:50.241114 | controller | 0b4379883f90: Pull complete
2025-11-08 00:16:50.288455 | controller | 3d9d6d9dfc91: Pull complete
2025-11-08 00:16:55.779966 | controller | 57d6314bd293: Pull complete
2025-11-08 00:17:17.901063 | controller | 774036afeb7f: Pull complete
2025-11-08 00:17:48.328822 | controller | 54b10f0e1645: Pull complete
2025-11-08 00:18:13.749790 | controller | 78cf439d9fdb: Pull complete
2025-11-08 00:18:44.462578 | controller | 36e5e20969c7: Pull complete
2025-11-08 00:19:12.074348 | controller | 4b19ac3f17a8: Pull complete
2025-11-08 00:19:12.108013 | controller | Digest: sha256:954c4edffb0905df64e23c8611b1c4a62db9af13062f51cad5b658e727238d41
2025-11-08 00:19:12.112872 | controller | Status: Downloaded newer image for quay.io/ansible/default-test-container:1.10.1
2025-11-08 00:19:12.126477 | controller | quay.io/ansible/default-test-container:1.10.1
2025-11-08 00:19:12.156143 | controller | Run command: docker images quay.io/ansible/pypi-test-container:1.0.0 --format '{{json .}}'
2025-11-08 00:19:12.156202 | controller | Run command: docker pull quay.io/ansible/pypi-test-container:1.0.0
2025-11-08 00:19:13.549997 | controller | 1.0.0: Pulling from ansible/pypi-test-container
2025-11-08 00:19:13.550051 | controller | 04a5f4cda3ee: Pulling fs layer
2025-11-08 00:19:13.550110 | controller | ff496a88c8ed: Pulling fs layer
2025-11-08 00:19:13.550210 | controller | 0ce83f459fe7: Pulling fs layer
2025-11-08 00:19:13.550255 | controller | 2e5170e1f099: Pulling fs layer
2025-11-08 00:19:13.550331 | controller | 7641eb41b08c: Pulling fs layer
2025-11-08 00:19:13.550367 | controller | ad15fa9da398: Pulling fs layer
2025-11-08 00:19:13.550537 | controller | 087d91352424: Pulling fs layer
2025-11-08 00:19:13.550640 | controller | 8b92efd6a100: Pulling fs layer
2025-11-08 00:19:13.551265 | controller | 7641eb41b08c: Waiting
2025-11-08 00:19:13.551321 | controller | ad15fa9da398: Waiting
2025-11-08 00:19:13.551446 | controller | 087d91352424: Waiting
2025-11-08 00:19:13.551494 | controller | 8b92efd6a100: Waiting
2025-11-08 00:19:13.551620 | controller | 2e5170e1f099: Waiting
2025-11-08 00:19:14.158043 | controller | ff496a88c8ed: Verifying Checksum
2025-11-08 00:19:14.158091 | controller | ff496a88c8ed: Download complete
2025-11-08 00:19:14.167817 | controller | 0ce83f459fe7: Verifying Checksum
2025-11-08 00:19:14.168511 | controller | 0ce83f459fe7: Download complete
2025-11-08 00:19:14.413195 | controller | 04a5f4cda3ee: Verifying Checksum
2025-11-08 00:19:14.413246 | controller | 04a5f4cda3ee: Download complete
2025-11-08 00:19:14.698387 | controller | 7641eb41b08c: Verifying Checksum
2025-11-08 00:19:14.722576 | controller | 7641eb41b08c: Download complete
2025-11-08 00:19:14.722633 | controller | 2e5170e1f099: Verifying Checksum
2025-11-08 00:19:14.810557 | controller | 2e5170e1f099: Download complete
2025-11-08 00:19:14.810863 | controller | ad15fa9da398: Verifying Checksum
2025-11-08 00:19:15.116555 | controller | ad15fa9da398: Download complete
2025-11-08 00:19:15.116618 | controller | 8b92efd6a100: Verifying Checksum
2025-11-08 00:19:15.121687 | controller | 8b92efd6a100: Download complete
2025-11-08 00:19:15.121747 | controller | 087d91352424: Verifying Checksum
2025-11-08 00:19:16.648967 | controller | 087d91352424: Download complete
2025-11-08 00:19:16.649062 | controller | 04a5f4cda3ee: Pull complete
2025-11-08 00:19:16.719502 | controller | ff496a88c8ed: Pull complete
2025-11-08 00:19:16.801688 | controller | 0ce83f459fe7: Pull complete
2025-11-08 00:19:19.472119 | controller | 2e5170e1f099: Pull complete
2025-11-08 00:19:19.506633 | controller | 7641eb41b08c: Pull complete
2025-11-08 00:19:19.553443 | controller | ad15fa9da398: Pull complete
2025-11-08 00:19:20.592964 | controller | 087d91352424: Pull complete
2025-11-08 00:19:20.649083 | controller | 8b92efd6a100: Pull complete
2025-11-08 00:19:20.680277 | controller | Digest: sha256:71042ab0a14971b5608fe75706de54f367fc31db573e3b3955182037f73cadb6
2025-11-08 00:19:20.691101 | controller | Status: Downloaded newer image for quay.io/ansible/pypi-test-container:1.0.0
2025-11-08 00:19:20.702357 | controller | quay.io/ansible/pypi-test-container:1.0.0
2025-11-08 00:19:20.706250 | controller | Run command: docker run --detach quay.io/ansible/pypi-test-container:1.0.0
2025-11-08 00:19:23.365370 | controller | Run command: docker inspect a09e9562a24cd947291a5e82260475c55cb12b446c953262781737bb5b2f063e
2025-11-08 00:19:23.620786 | controller | Scanning collection root: /home/zuul/.ansible/collections/ansible_collections
2025-11-08 00:19:23.657015 | controller | Including collection: ansible.netcommon (292 files)
2025-11-08 00:19:23.657102 | controller | Including collection: ansible.network (23 files)
2025-11-08 00:19:23.677872 | controller | Including collection: ansible.utils (442 files)
2025-11-08 00:19:23.722217 | controller | Including collection: arista.eos (1022 files)
2025-11-08 00:19:23.769210 | controller | Including collection: cisco.ios (1172 files)
2025-11-08 00:19:23.813071 | controller | Including collection: cisco.iosxr (1043 files)
2025-11-08 00:19:23.892780 | controller | Including collection: cisco.nxos (1684 files)
2025-11-08 00:19:23.935091 | controller | Including collection: junipernetworks.junos (963 files)
2025-11-08 00:19:23.978695 | controller | Creating a payload archive containing 8378 files...
2025-11-08 00:19:26.456566 | controller | Created a 6890340 byte payload archive containing 8378 files in 2 seconds.
2025-11-08 00:19:26.461156 | controller | Assuming Docker is available on localhost.
2025-11-08 00:19:26.462444 | controller | Run command: docker run --detach --volume /sys/fs/cgroup:/sys/fs/cgroup:ro --privileged=false --security-opt seccomp=unconfined --volume /var/run/docker.sock:/var/run/docker.sock quay.io/ansible/default-test-container:1.10.1
2025-11-08 00:19:27.089481 | controller | Run command: docker exec -i 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b dd of=/root/docker.sh bs=65536
2025-11-08 00:19:27.218634 | controller | Run command: docker exec 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b /bin/bash /root/docker.sh
2025-11-08 00:19:27.319487 | controller | Run command: docker exec -i 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b dd of=/root/ansible.tgz bs=65536
2025-11-08 00:19:27.438493 | controller | Run command: docker exec 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b mkdir /root/ansible
2025-11-08 00:19:27.519848 | controller | Run command: docker exec 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b tar oxzf /root/ansible.tgz -C /root/ansible
2025-11-08 00:19:28.848095 | controller | Run command: docker exec 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b /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-8fnxn8yi.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/
2025-11-08 00:19:29.445471 | controller | Injecting custom PyPI hosts entries: /etc/hosts
2025-11-08 00:19:29.445931 | controller | Injecting custom PyPI config: /root/.pip/pip.conf
2025-11-08 00:19:29.446362 | controller | Injecting custom PyPI config: /root/.pydistutils.cfg
2025-11-08 00:19:29.448326 | controller | Run command: /usr/bin/python3.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-08 00:19:29.555015 | controller | Running sanity test 'action-plugin-docs' with Python 3.6
2025-11-08 00:19:29.558597 | controller | Read 0 sanity test ignore line(s) for Ansible 2.9 from: tests/sanity/ignore-2.9.txt
2025-11-08 00:19:29.569211 | controller | No tests applicable.
2025-11-08 00:19:29.569431 | controller | Running sanity test 'ansible-doc' with Python 3.6
2025-11-08 00:19:29.569743 | controller | No tests applicable.
2025-11-08 00:19:29.570154 | controller | Run command: /usr/bin/python2.6 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-08 00:19:29.659415 | controller | Running sanity test 'compile' with Python 2.6
2025-11-08 00:19:29.862487 | controller | No tests applicable.
2025-11-08 00:19:29.862551 | controller | Run command: /usr/bin/python2.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-08 00:19:29.862573 | controller | Running sanity test 'compile' with Python 2.7
2025-11-08 00:19:29.863040 | controller | No tests applicable.
2025-11-08 00:19:29.863509 | controller | Run command: /usr/bin/python3.5 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-08 00:19:30.010798 | controller | Running sanity test 'compile' with Python 3.5
2025-11-08 00:19:30.011269 | controller | No tests applicable.
2025-11-08 00:19:30.011381 | controller | Running sanity test 'compile' with Python 3.6
2025-11-08 00:19:30.011662 | controller | No tests applicable.
2025-11-08 00:19:30.012075 | controller | Run command: /usr/bin/python3.7 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-08 00:19:30.131604 | controller | Running sanity test 'compile' with Python 3.7
2025-11-08 00:19:30.131901 | controller | No tests applicable.
2025-11-08 00:19:30.132305 | controller | Run command: /usr/bin/python3.8 /root/ansible/test/lib/ansible_test/_data/yamlcheck.py
2025-11-08 00:19:30.256112 | controller | Running sanity test 'compile' with Python 3.8
2025-11-08 00:19:30.256603 | controller | No tests applicable.
2025-11-08 00:19:30.256826 | controller | Running sanity test 'empty-init' with Python 3.6
2025-11-08 00:19:30.257135 | controller | No tests applicable.
2025-11-08 00:19:30.257365 | controller | Running sanity test 'future-import-boilerplate' with Python 3.6
2025-11-08 00:19:30.257666 | controller | No tests applicable.
2025-11-08 00:19:30.257837 | controller | Running sanity test 'ignores'
2025-11-08 00:19:30.259127 | controller | Run command: /usr/bin/python3.6 -m pip.__main__ install --disable-pip-version-check -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt
2025-11-08 00:19:31.078802 | controller | Ignoring packaging: markers 'python_version < "3.6"' don't match your environment
2025-11-08 00:19:31.084315 | controller | Ignoring coverage: markers 'python_version > "3.7"' don't match your environment
2025-11-08 00:19:31.086025 | controller | Ignoring cryptography: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.089012 | controller | Ignoring deepdiff: markers 'python_version < "3"' don't match your environment
2025-11-08 00:19:31.090950 | controller | Ignoring jinja2: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.092321 | controller | Ignoring urllib3: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.095511 | controller | Ignoring sphinx: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.101254 | controller | Ignoring wheel: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.102825 | controller | Ignoring yamllint: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.107635 | controller | Ignoring paramiko: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.110473 | controller | Ignoring pytest: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.112097 | controller | Ignoring pytest: markers 'python_version == "2.7"' don't match your environment
2025-11-08 00:19:31.113564 | controller | Ignoring pytest-forked: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.117289 | controller | Ignoring requests: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.125317 | controller | Ignoring virtualenv: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.126873 | controller | Ignoring pathspec: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.128237 | controller | Ignoring pyopenssl: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.130677 | controller | Ignoring pyyaml: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.131965 | controller | Ignoring pycparser: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.136313 | controller | Ignoring xmltodict: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.137711 | controller | Ignoring lxml: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.139208 | controller | Ignoring pyvmomi: markers 'python_version < "2.7"' don't match your environment
2025-11-08 00:19:31.141458 | controller | Ignoring MarkupSafe: markers 'python_version < "3.6"' don't match your environment
2025-11-08 00:19:31.147800 | controller | Ignoring setuptools: markers 'python_version <= "2.7"' don't match your environment
2025-11-08 00:19:31.151600 | controller | Ignoring websocket-client: markers 'python_version < "3"' don't match your environment
2025-11-08 00:19:31.152921 | controller | Ignoring certifi: markers 'python_version < "3"' don't match your environment
2025-11-08 00:19:31.169313 | controller | Looking in indexes: http://172.17.0.2:3141/root/pypi/+simple/
2025-11-08 00:19:31.170266 | controller | Requirement already satisfied: cryptography<3.4 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (2.7)
2025-11-08 00:19:31.199050 | controller | Requirement already satisfied: rstcheck==3.3.1 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 12)) (3.3.1)
2025-11-08 00:19:31.204747 | controller | Requirement already satisfied: voluptuous>=0.11.0 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 30)) (0.11.7)
2025-11-08 00:19:31.209946 | controller | Requirement already satisfied: cffi!=1.14.4 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 49)) (1.13.0)
2025-11-08 00:19:31.211279 | controller | Requirement already satisfied: pylint==2.3.1 in /usr/local/lib/python3.6/dist-packages (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 58)) (2.3.1)
2025-11-08 00:19:31.220195 | controller | Requirement already satisfied: jinja2 in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 2)) (2.10.3)
2025-11-08 00:19:31.224365 | controller | Requirement already satisfied: pycodestyle in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 3)) (2.5.0)
2025-11-08 00:19:31.233374 | controller | Requirement already satisfied: pyyaml in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 5)) (5.1.2)
2025-11-08 00:19:31.235749 | controller | Requirement already satisfied: virtualenv in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 7)) (16.7.5)
2025-11-08 00:19:31.254081 | controller | Requirement already satisfied: yamllint in /usr/local/lib/python3.6/dist-packages (from -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt (line 9)) (1.18.0)
2025-11-08 00:19:31.261159 | controller | Requirement already satisfied: asn1crypto>=0.21.0 in /usr/local/lib/python3.6/dist-packages (from cryptography<3.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (1.1.0)
2025-11-08 00:19:31.264169 | controller | Requirement already satisfied: six>=1.4.1 in /usr/local/lib/python3.6/dist-packages (from cryptography<3.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 5)) (1.12.0)
2025-11-08 00:19:31.266199 | controller | Requirement already satisfied: docutils>=0.7 in /usr/local/lib/python3.6/dist-packages (from rstcheck==3.3.1->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 12)) (0.15.2)
2025-11-08 00:19:31.268417 | controller | Requirement already satisfied: pycparser in /usr/local/lib/python3.6/dist-packages (from cffi!=1.14.4->-c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 49)) (2.19)
2025-11-08 00:19:31.270378 | 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)
2025-11-08 00:19:31.273161 | controller | Collecting isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55))
2025-11-08 00:19:46.302207 | controller |   WARNING: Retrying (Retry(total=4, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2025-11-08 00:20:01.822418 | controller |   WARNING: Retrying (Retry(total=3, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2025-11-08 00:20:17.841737 | controller |   WARNING: Retrying (Retry(total=2, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2025-11-08 00:20:34.866550 | controller |   WARNING: Retrying (Retry(total=1, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2025-11-08 00:20:53.879715 | controller |   WARNING: Retrying (Retry(total=0, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ReadTimeoutError("HTTPConnectionPool(host='172.17.0.2', port=3141): Read timed out. (read timeout=15)",)': /root/pypi/+simple/isort/
2025-11-08 00:21:08.897781 | controller |   ERROR: Could not find a version that satisfies the requirement isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55)) (from versions: none)
2025-11-08 00:21:08.898029 | controller | ERROR: No matching distribution found for isort==4.3.16 (from -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt (line 55))
2025-11-08 00:21:09.020761 | controller | ERROR: Command "/usr/bin/python3.6 -m pip.__main__ install --disable-pip-version-check -r /root/ansible/test/lib/ansible_test/_data/requirements/sanity.txt -c /root/ansible/test/lib/ansible_test/_data/requirements/constraints.txt" returned exit status 1.
2025-11-08 00:21:09.021538 | controller | Removing custom PyPI config: /root/.pydistutils.cfg
2025-11-08 00:21:09.021604 | controller | Removing custom PyPI config: /root/.pip/pip.conf
2025-11-08 00:21:09.021620 | controller | Removing custom PyPI hosts entries: /etc/hosts
2025-11-08 00:21:09.080592 | controller | Run command: docker exec 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b tar czf /root/output.tgz --exclude .tmp -C /root/ansible/ansible_collections/ansible/network/tests output
2025-11-08 00:21:09.157027 | controller | Run command: docker exec -i 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b dd if=/root/output.tgz bs=65536
2025-11-08 00:21:09.228371 | controller | Run command: tar oxzf /tmp/ansible-result-hf0zj443.tgz -C /home/zuul/.ansible/collections/ansible_collections/ansible/network/tests
2025-11-08 00:21:09.242275 | controller | Run command: docker rm -f a09e9562a24cd947291a5e82260475c55cb12b446c953262781737bb5b2f063e
2025-11-08 00:21:09.507020 | controller | Run command: docker rm -f 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b
2025-11-08 00:21:10.294786 | controller | ERROR: Command "docker exec 256303c2ec5d05986fefdd5de491744a5d79aad658630fdfe5c1fab909c6788b /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-8fnxn8yi.json --truncate 0 --redact --color no --requirements --pypi-endpoint http://172.17.0.2:3141/root/pypi/+simple/" returned exit status 1.
2025-11-08 00:21:10.735957 | controller | ERROR
2025-11-08 00:21:10.736241 | controller | {
2025-11-08 00:21:10.736301 | controller |   "delta": "0:05:42.058633",
2025-11-08 00:21:10.736343 | controller |   "end": "2025-11-08 00:21:10.352848",
2025-11-08 00:21:10.736382 | controller |   "msg": "non-zero return code",
2025-11-08 00:21:10.736418 | controller |   "rc": 1,
2025-11-08 00:21:10.736455 | controller |   "start": "2025-11-08 00:15:28.294215"
2025-11-08 00:21:10.736511 | controller | }
failure
2025-11-08 00:21:10.745562 | 
2025-11-08 00:21:10.745708 | PLAY RECAP
2025-11-08 00:21:10.745796 | controller | ok: 21 changed: 6 unreachable: 0 failed: 1 skipped: 20 rescued: 0 ignored: 1
2025-11-08 00:21:10.745840 | 
2025-11-08 00:21:10.897307 | RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2025-11-08 00:21:10.898995 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-11-08 00:21:11.548553 | 
2025-11-08 00:21:11.548762 | PLAY [all]
2025-11-08 00:21:11.570916 | 
2025-11-08 00:21:11.571019 | TASK [fetch-subunit-output : Find stestr or testr executable]
2025-11-08 00:21:14.568025 | controller | changed: non-zero return code
2025-11-08 00:21:14.581094 | 
2025-11-08 00:21:14.581251 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2025-11-08 00:21:14.608417 | controller | skipping: Conditional result was False
2025-11-08 00:21:14.621628 | 
2025-11-08 00:21:14.621818 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2025-11-08 00:21:14.662735 | 
2025-11-08 00:21:14.662986 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2025-11-08 00:21:14.703874 | 
2025-11-08 00:21:14.704162 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2025-11-08 00:21:14.731218 | controller | skipping: Conditional result was False
2025-11-08 00:21:14.746543 | 
2025-11-08 00:21:14.746738 | LOOP [fetch-subunit-output : Generate subunit file]
2025-11-08 00:21:14.787868 | 
2025-11-08 00:21:14.788149 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2025-11-08 00:21:14.815794 | controller | skipping: Conditional result was False
2025-11-08 00:21:14.832344 | 
2025-11-08 00:21:14.832489 | TASK [fetch-subunit-output : Remove the temporary file]
2025-11-08 00:21:14.859726 | controller | skipping: Conditional result was False
2025-11-08 00:21:14.872525 | 
2025-11-08 00:21:14.872710 | TASK [fetch-subunit-output : Process and fetch subunit results]
2025-11-08 00:21:14.899438 | controller | skipping: Conditional result was False
2025-11-08 00:21:14.947804 | 
2025-11-08 00:21:14.947889 | PLAY RECAP
2025-11-08 00:21:14.947945 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-11-08 00:21:14.947976 | 
2025-11-08 00:21:15.081693 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-11-08 00:21:15.082607 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2025-11-08 00:21:15.766497 | 
2025-11-08 00:21:15.766625 | PLAY [all:!appliance*]
2025-11-08 00:21:15.788894 | 
2025-11-08 00:21:15.789022 | TASK [unregister the node]
2025-11-08 00:21:16.148773 | controller | skipping: Conditional result was False
2025-11-08 00:21:16.158657 | 
2025-11-08 00:21:16.158886 | TASK [include_role : fetch-output]
2025-11-08 00:21:16.206192 | controller | ok
2025-11-08 00:21:16.243386 | 
2025-11-08 00:21:16.243556 | TASK [fetch-output : Set log path for multiple nodes]
2025-11-08 00:21:16.300455 | controller | skipping: Conditional result was False
2025-11-08 00:21:16.308536 | 
2025-11-08 00:21:16.308659 | TASK [fetch-output : Set log path for single node]
2025-11-08 00:21:16.353778 | controller | ok
2025-11-08 00:21:16.361794 | 
2025-11-08 00:21:16.361901 | LOOP [fetch-output : Ensure local output dirs]
2025-11-08 00:21:16.881629 | controller -> localhost | ok: "/var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/logs"
2025-11-08 00:21:17.206307 | controller -> localhost | changed: "/var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/artifacts"
2025-11-08 00:21:17.555526 | controller -> localhost | changed: "/var/lib/zuul/builds/1415399ae4844da5a5f8d285c3f3ebdb/work/docs"
2025-11-08 00:21:17.577202 | 
2025-11-08 00:21:17.577717 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-11-08 00:21:19.934249 | controller | changed:
2025-11-08 00:21:19.934624 | controller | .d..t...... ./
2025-11-08 00:21:19.934756 | controller | cd+++++++++ controller/
2025-11-08 00:21:19.934933 | controller | changed: All items complete
2025-11-08 00:21:19.934984 | 
2025-11-08 00:21:22.046486 | controller | changed: .d..t...... ./
2025-11-08 00:21:24.159614 | controller | changed: .d..t...... ./
2025-11-08 00:21:24.196861 | 
2025-11-08 00:21:24.197012 | TASK [include_role : fetch-output-openshift]
2025-11-08 00:21:24.227038 | controller | skipping: Conditional result was False
2025-11-08 00:21:24.244719 | 
2025-11-08 00:21:24.244869 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-11-08 00:21:24.298993 | controller | skipping: Conditional result was False
2025-11-08 00:21:24.309555 | controller | skipping: Conditional result was False
2025-11-08 00:21:24.358873 | 
2025-11-08 00:21:24.358986 | PLAY [localhost]
2025-11-08 00:21:24.378796 | 
2025-11-08 00:21:24.378888 | TASK [Run Zuul manifest role]
2025-11-08 00:21:24.409971 | localhost | ok
2025-11-08 00:21:24.426584 | 
2025-11-08 00:21:24.426687 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-11-08 00:21:24.861782 | localhost | changed
2025-11-08 00:21:24.872256 | 
2025-11-08 00:21:24.872364 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-11-08 00:21:24.922928 | localhost | ok
2025-11-08 00:21:24.984565 | 
2025-11-08 00:21:24.984737 | TASK [Set zuul-log-path fact]
2025-11-08 00:21:25.003796 | localhost | ok
2025-11-08 00:21:25.020151 | 
2025-11-08 00:21:25.020327 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-11-08 00:21:25.072932 | localhost | ok
2025-11-08 00:21:25.085193 | 
2025-11-08 00:21:25.085286 | LOOP [Run upload-logs-swift role]
2025-11-08 00:21:25.133974 | localhost | Output suppressed because no_log was given
2025-11-08 00:21:25.202204 | 
2025-11-08 00:21:25.202431 | TASK [Set zuul-log-path fact]
2025-11-08 00:21:25.248827 | localhost | skipping: Conditional result was False
2025-11-08 00:21:25.256287 | 
2025-11-08 00:21:25.256390 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2025-11-08 00:21:25.767654 | localhost -> localhost | ok: Runtime: 0:00:00.006562
2025-11-08 00:21:25.777113 | 
2025-11-08 00:21:25.777211 | TASK [upload-logs-swift : Upload logs to swift]