2025-12-09 00:06:42.169063 | Job console starting...
2025-12-09 00:06:42.180208 | Updating repositories
2025-12-09 00:06:42.381901 | Preparing job workspace
2025-12-09 00:06:47.527880 | Running Ansible setup...
2025-12-09 00:06:52.569486 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-12-09 00:06:53.214184 | 
2025-12-09 00:06:53.214351 | PLAY [localhost]
2025-12-09 00:06:53.223405 | 
2025-12-09 00:06:53.223479 | TASK [Gathering Facts]
2025-12-09 00:06:54.220597 | localhost | ok
2025-12-09 00:06:54.246551 | 
2025-12-09 00:06:54.246695 | TASK [Setup log path fact]
2025-12-09 00:06:54.265289 | localhost | ok
2025-12-09 00:06:54.278917 | 
2025-12-09 00:06:54.279012 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-09 00:06:54.307131 | localhost | ok
2025-12-09 00:06:54.316261 | 
2025-12-09 00:06:54.316333 | TASK [emit-job-header : Print job information]
2025-12-09 00:06:54.344919 | # Job Information
2025-12-09 00:06:54.345124 | Ansible Version: 2.15.12
2025-12-09 00:06:54.345157 | Job: ansible-test-sanity-docker-stable-2.9
2025-12-09 00:06:54.345179 | Pipeline: periodic
2025-12-09 00:06:54.345197 | Executor: ze03.softwarefactory-project.io
2025-12-09 00:06:54.345215 | Triggered by: https://github.com/ansible-collections/ansible.network
2025-12-09 00:06:54.345235 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/231/ansible/231367469fd94ddc817e92f58526baf0/
2025-12-09 00:06:54.345254 | Event ID: af90092fb8e9455a9ddccb9605b9ecd4
2025-12-09 00:06:54.349482 | 
2025-12-09 00:06:54.349552 | LOOP [emit-job-header : Print node information]
2025-12-09 00:06:54.477112 | localhost | ok:
2025-12-09 00:06:54.477310 | localhost | # Node Information
2025-12-09 00:06:54.477338 | localhost | Inventory Hostname: controller
2025-12-09 00:06:54.477358 | localhost | Hostname: np0005551155
2025-12-09 00:06:54.477377 | localhost | Username: zuul
2025-12-09 00:06:54.477402 | localhost | Distro: Fedora 37
2025-12-09 00:06:54.477421 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2025-12-09 00:06:54.477440 | localhost | Region: ca-ymq-1
2025-12-09 00:06:54.477459 | localhost | Label: ansible-fedora-37-1vcpu
2025-12-09 00:06:54.477478 | localhost | Product Name: OpenStack Nova
2025-12-09 00:06:54.477495 | localhost | Interface IP: 162.253.55.187
2025-12-09 00:06:54.498579 | 
2025-12-09 00:06:54.498716 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-12-09 00:06:54.895237 | localhost -> localhost | changed
2025-12-09 00:06:54.903016 | 
2025-12-09 00:06:54.903142 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-12-09 00:06:55.841745 | localhost -> localhost | changed
2025-12-09 00:06:55.862569 | 
2025-12-09 00:06:55.862633 | PLAY [all:!appliance*]
2025-12-09 00:06:55.879657 | 
2025-12-09 00:06:55.879721 | TASK [include_role : start-zuul-console]
2025-12-09 00:06:55.909628 | controller | ok
2025-12-09 00:06:55.924223 | 
2025-12-09 00:06:55.924286 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-12-09 00:06:56.298864 | controller | ok
2025-12-09 00:06:56.321292 | 
2025-12-09 00:06:56.321388 | TASK [use-our-mirror : Retrieve the IP address]
2025-12-09 00:06:57.114164 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2025-12-09 00:06:57.129557 | 
2025-12-09 00:06:57.129716 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2025-12-09 00:06:57.673303 | controller | skipping: Conditional result was False
2025-12-09 00:06:57.682526 | 
2025-12-09 00:06:57.682609 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2025-12-09 00:06:57.697241 | controller | skipping: Conditional result was False
2025-12-09 00:06:57.704058 | 
2025-12-09 00:06:57.704121 | TASK [use-our-mirror : Create the podman configuration directory]
2025-12-09 00:06:57.718003 | controller | skipping: Conditional result was False
2025-12-09 00:06:57.724598 | 
2025-12-09 00:06:57.724684 | TASK [use-our-mirror : Copy the podman configuration]
2025-12-09 00:06:57.739041 | controller | skipping: Conditional result was False
2025-12-09 00:06:57.746369 | 
2025-12-09 00:06:57.746442 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2025-12-09 00:06:57.760562 | controller | skipping: Conditional result was False
2025-12-09 00:06:57.767828 | 
2025-12-09 00:06:57.767900 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2025-12-09 00:06:57.792018 | controller | skipping: Conditional result was False
2025-12-09 00:06:57.805211 | 
2025-12-09 00:06:57.805303 | TASK [Disable Fedora Modular]
2025-12-09 00:06:58.030470 | controller | changed
2025-12-09 00:06:58.038571 | 
2025-12-09 00:06:58.038675 | TASK [Enable EPEL]
2025-12-09 00:06:58.062496 | controller | skipping: Conditional result was False
2025-12-09 00:06:58.069086 | 
2025-12-09 00:06:58.069164 | TASK [Register the RHEL node]
2025-12-09 00:06:58.630657 | 
2025-12-09 00:06:58.631810 | TASK [Show the subscription-manager status]
2025-12-09 00:06:59.219447 | controller | skipping: Conditional result was False
2025-12-09 00:06:59.236555 | 
2025-12-09 00:06:59.236762 | TASK [Enable EPEL on RHEL]
2025-12-09 00:06:59.797164 | controller | skipping: Conditional result was False
2025-12-09 00:06:59.811030 | 
2025-12-09 00:06:59.811182 | TASK [Install git and tox]
2025-12-09 00:08:17.829208 | controller | changed
2025-12-09 00:08:17.839524 | 
2025-12-09 00:08:17.839660 | TASK [include_role : prepare-workspace]
2025-12-09 00:08:17.874364 | controller | ok
2025-12-09 00:08:17.908260 | 
2025-12-09 00:08:17.908458 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-12-09 00:08:18.147229 | controller | ok
2025-12-09 00:08:18.157150 | 
2025-12-09 00:08:18.157265 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-12-09 00:08:35.289442 | controller | Output suppressed because no_log was given
2025-12-09 00:08:35.300883 | 
2025-12-09 00:08:35.300952 | TASK [include_role : prepare-workspace-openshift]
2025-12-09 00:08:35.330482 | controller | skipping: Conditional result was False
2025-12-09 00:08:35.355460 | 
2025-12-09 00:08:35.355549 | PLAY [all:!appliance]
2025-12-09 00:08:35.374026 | 
2025-12-09 00:08:35.374121 | TASK [Run add-build-sshkey role (RSA)]
2025-12-09 00:08:35.397915 | controller | ok
2025-12-09 00:08:35.415029 | 
2025-12-09 00:08:35.415105 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-12-09 00:08:35.693949 | controller -> localhost | ok
2025-12-09 00:08:35.700876 | 
2025-12-09 00:08:35.700946 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-12-09 00:08:35.732871 | controller | ok
2025-12-09 00:08:35.771402 | controller | included: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-12-09 00:08:35.782406 | 
2025-12-09 00:08:35.782535 | TASK [add-build-sshkey : Create Temp SSH key]
2025-12-09 00:08:36.327683 | controller -> localhost | Generating public/private rsa key pair.
2025-12-09 00:08:36.327880 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/231367469fd94ddc817e92f58526baf0_id_rsa.
2025-12-09 00:08:36.327911 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/231367469fd94ddc817e92f58526baf0_id_rsa.pub.
2025-12-09 00:08:36.327932 | controller -> localhost | The key fingerprint is:
2025-12-09 00:08:36.327951 | controller -> localhost | SHA256:2jv2TsWPPVusAZbg5T3oLGJ4dz66XOY5X4DLIjIyk7I zuul-build-sshkey
2025-12-09 00:08:36.327969 | controller -> localhost | The key's randomart image is:
2025-12-09 00:08:36.327987 | controller -> localhost | +---[RSA 2048]----+
2025-12-09 00:08:36.328006 | controller -> localhost | |                 |
2025-12-09 00:08:36.328024 | controller -> localhost | |                 |
2025-12-09 00:08:36.328042 | controller -> localhost | |          . .    |
2025-12-09 00:08:36.328059 | controller -> localhost | |         . = =   |
2025-12-09 00:08:36.328076 | controller -> localhost | |        S . X +  |
2025-12-09 00:08:36.328102 | controller -> localhost | |     . +   * * + |
2025-12-09 00:08:36.328125 | controller -> localhost | |  . = = * = X = +|
2025-12-09 00:08:36.328143 | controller -> localhost | |   o + =oB Oo. B |
2025-12-09 00:08:36.328161 | controller -> localhost | |  E    ..+*o+++  |
2025-12-09 00:08:36.328181 | controller -> localhost | +----[SHA256]-----+
2025-12-09 00:08:36.328221 | controller -> localhost | ok: Runtime: 0:00:00.088955
2025-12-09 00:08:36.335895 | 
2025-12-09 00:08:36.335968 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-12-09 00:08:36.371399 | controller | ok
2025-12-09 00:08:36.385974 | controller | included: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-12-09 00:08:36.397232 | 
2025-12-09 00:08:36.397331 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-12-09 00:08:36.422358 | controller | skipping: Conditional result was False
2025-12-09 00:08:36.429354 | 
2025-12-09 00:08:36.429424 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-12-09 00:08:36.905233 | controller | changed
2025-12-09 00:08:36.917297 | 
2025-12-09 00:08:36.917436 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-12-09 00:08:37.156540 | controller | ok
2025-12-09 00:08:37.172054 | 
2025-12-09 00:08:37.172171 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-12-09 00:08:37.791205 | controller | changed
2025-12-09 00:08:37.797196 | 
2025-12-09 00:08:37.797260 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-12-09 00:08:38.511938 | controller | changed
2025-12-09 00:08:38.530171 | 
2025-12-09 00:08:38.530328 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-12-09 00:08:38.557067 | controller | skipping: Conditional result was False
2025-12-09 00:08:38.568619 | 
2025-12-09 00:08:38.568788 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-12-09 00:08:39.056338 | controller -> localhost | changed
2025-12-09 00:08:39.074446 | 
2025-12-09 00:08:39.074591 | TASK [add-build-sshkey : Add back temp key]
2025-12-09 00:08:39.389191 | controller -> localhost | Identity added: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/231367469fd94ddc817e92f58526baf0_id_rsa (zuul-build-sshkey)
2025-12-09 00:08:39.389404 | controller -> localhost | ok: Runtime: 0:00:00.008827
2025-12-09 00:08:39.396877 | 
2025-12-09 00:08:39.397008 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-12-09 00:08:39.768709 | controller | ok
2025-12-09 00:08:39.778468 | 
2025-12-09 00:08:39.778564 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-12-09 00:08:39.804179 | controller | skipping: Conditional result was False
2025-12-09 00:08:39.819496 | 
2025-12-09 00:08:39.819636 | TASK [Run add-build-sshkey role (ECDSA)]
2025-12-09 00:08:39.850662 | controller | ok
2025-12-09 00:08:39.933074 | 
2025-12-09 00:08:39.933273 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-12-09 00:08:40.215011 | controller -> localhost | ok
2025-12-09 00:08:40.224413 | 
2025-12-09 00:08:40.224573 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-12-09 00:08:40.258258 | controller | ok
2025-12-09 00:08:40.272352 | controller | included: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-12-09 00:08:40.280219 | 
2025-12-09 00:08:40.280312 | TASK [add-build-sshkey : Create Temp SSH key]
2025-12-09 00:08:40.584618 | controller -> localhost | Generating public/private ecdsa key pair.
2025-12-09 00:08:40.584828 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/231367469fd94ddc817e92f58526baf0_id_ecdsa.
2025-12-09 00:08:40.584858 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/231367469fd94ddc817e92f58526baf0_id_ecdsa.pub.
2025-12-09 00:08:40.584891 | controller -> localhost | The key fingerprint is:
2025-12-09 00:08:40.584911 | controller -> localhost | SHA256:TBB7royn1G6yns/wdb2OgnhLRaCraZw/NwVrgDGAnhY zuul-build-sshkey
2025-12-09 00:08:40.584930 | controller -> localhost | The key's randomart image is:
2025-12-09 00:08:40.584948 | controller -> localhost | +---[ECDSA 521]---+
2025-12-09 00:08:40.584966 | controller -> localhost | |o.    +.         |
2025-12-09 00:08:40.584982 | controller -> localhost | |.Eo  . +         |
2025-12-09 00:08:40.584999 | controller -> localhost | |. o+. . +        |
2025-12-09 00:08:40.585015 | controller -> localhost | | +. ...*         |
2025-12-09 00:08:40.585032 | controller -> localhost | |.   .. oS        |
2025-12-09 00:08:40.585049 | controller -> localhost | | . + +oo.  .     |
2025-12-09 00:08:40.585065 | controller -> localhost | |  * +o*o. . .    |
2025-12-09 00:08:40.585081 | controller -> localhost | | . o+X*... . .   |
2025-12-09 00:08:40.585097 | controller -> localhost | |   .*O*o ...o    |
2025-12-09 00:08:40.585113 | controller -> localhost | +----[SHA256]-----+
2025-12-09 00:08:40.585166 | controller -> localhost | ok: Runtime: 0:00:00.017619
2025-12-09 00:08:40.594583 | 
2025-12-09 00:08:40.594706 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-12-09 00:08:40.629614 | controller | ok
2025-12-09 00:08:40.639234 | controller | included: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-12-09 00:08:40.649871 | 
2025-12-09 00:08:40.649935 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-12-09 00:08:40.664365 | controller | skipping: Conditional result was False
2025-12-09 00:08:40.671375 | 
2025-12-09 00:08:40.671441 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-12-09 00:08:40.925936 | controller | changed
2025-12-09 00:08:40.932584 | 
2025-12-09 00:08:40.932665 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-12-09 00:08:41.154520 | controller | ok
2025-12-09 00:08:41.168388 | 
2025-12-09 00:08:41.168859 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-12-09 00:08:41.839052 | controller | changed
2025-12-09 00:08:41.852160 | 
2025-12-09 00:08:41.852285 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-12-09 00:08:42.479158 | controller | changed
2025-12-09 00:08:42.489490 | 
2025-12-09 00:08:42.489589 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-12-09 00:08:42.506317 | controller | skipping: Conditional result was False
2025-12-09 00:08:42.518668 | 
2025-12-09 00:08:42.518825 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-12-09 00:08:42.799486 | controller -> localhost | changed
2025-12-09 00:08:42.814397 | 
2025-12-09 00:08:42.814513 | TASK [add-build-sshkey : Add back temp key]
2025-12-09 00:08:43.082510 | controller -> localhost | Identity added: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/231367469fd94ddc817e92f58526baf0_id_ecdsa (zuul-build-sshkey)
2025-12-09 00:08:43.082707 | controller -> localhost | ok: Runtime: 0:00:00.007835
2025-12-09 00:08:43.090020 | 
2025-12-09 00:08:43.090081 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-12-09 00:08:43.285431 | controller | ok
2025-12-09 00:08:43.296387 | 
2025-12-09 00:08:43.296559 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-12-09 00:08:43.324010 | controller | skipping: Conditional result was False
2025-12-09 00:08:43.340700 | 
2025-12-09 00:08:43.340841 | TASK [include_role : remove-zuul-sshkey]
2025-12-09 00:08:43.355828 | controller | skipping: Conditional result was False
2025-12-09 00:08:43.365679 | 
2025-12-09 00:08:43.365828 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-12-09 00:08:43.589292 | controller | ok: "logs"
2025-12-09 00:08:43.589549 | controller | ok: All items complete
2025-12-09 00:08:43.589576 | 
2025-12-09 00:08:43.774084 | controller | ok: "artifacts"
2025-12-09 00:08:43.961279 | controller | ok: "docs"
2025-12-09 00:08:43.981532 | 
2025-12-09 00:08:43.981714 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-12-09 00:08:44.232907 | controller | changed: "logs"
2025-12-09 00:08:44.441934 | controller | changed: "artifacts"
2025-12-09 00:08:44.640486 | controller | changed: "docs"
2025-12-09 00:08:44.697442 | 
2025-12-09 00:08:44.697551 | PLAY RECAP
2025-12-09 00:08:44.697610 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2025-12-09 00:08:44.697648 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-09 00:08:44.697675 | 
2025-12-09 00:08:44.808628 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-12-09 00:08:44.810396 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-12-09 00:08:45.426355 | 
2025-12-09 00:08:45.426466 | PLAY [all]
2025-12-09 00:08:45.465350 | 
2025-12-09 00:08:45.465465 | TASK [Install binary dependencies]
2025-12-09 00:08:45.535123 | controller | ok
2025-12-09 00:08:45.570115 | 
2025-12-09 00:08:45.570229 | TASK [bindep : Include find tasks]
2025-12-09 00:08:45.604086 | controller | ok
2025-12-09 00:08:45.616582 | controller | included: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2025-12-09 00:08:45.625930 | 
2025-12-09 00:08:45.626025 | TASK [bindep : Look for bindep.txt]
2025-12-09 00:13:47.500086 | controller | ok
2025-12-09 00:13:47.514328 | 
2025-12-09 00:13:47.514479 | TASK [bindep : Define bindep_file fact]
2025-12-09 00:13:47.544951 | controller | skipping: Conditional result was False
2025-12-09 00:13:47.562003 | 
2025-12-09 00:13:47.562394 | TASK [bindep : Look for other-requirements.txt]
2025-12-09 00:13:47.802373 | controller | ok
2025-12-09 00:13:47.816426 | 
2025-12-09 00:13:47.816579 | TASK [bindep : Define bindep_file fact]
2025-12-09 00:13:47.844669 | controller | skipping: Conditional result was False
2025-12-09 00:13:47.856241 | 
2025-12-09 00:13:47.856392 | TASK [bindep : Look for bindep fallback file]
2025-12-09 00:13:47.883164 | controller | skipping: Conditional result was False
2025-12-09 00:13:47.898654 | 
2025-12-09 00:13:47.898883 | TASK [bindep : Define bindep_file fact]
2025-12-09 00:13:47.926991 | controller | skipping: Conditional result was False
2025-12-09 00:13:47.937848 | 
2025-12-09 00:13:47.937959 | TASK [bindep : Include bindep tasks]
2025-12-09 00:13:47.964209 | controller | skipping: Conditional result was False
2025-12-09 00:13:47.981122 | 
2025-12-09 00:13:47.981310 | TASK [bindep : Include install tasks]
2025-12-09 00:13:48.007841 | controller | skipping: Conditional result was False
2025-12-09 00:13:48.016147 | 
2025-12-09 00:13:48.016236 | LOOP [bindep : Include package tasks]
2025-12-09 00:13:48.097290 | 
2025-12-09 00:13:48.097637 | TASK [Run test-setup role]
2025-12-09 00:13:48.124416 | controller | ok
2025-12-09 00:13:48.150432 | 
2025-12-09 00:13:48.150565 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2025-12-09 00:13:48.386928 | controller | ok
2025-12-09 00:13:48.402673 | 
2025-12-09 00:13:48.402928 | TASK [test-setup : Run tools/test-setup.sh]
2025-12-09 00:13:48.957395 | controller | skipping: Conditional result was False
2025-12-09 00:13:49.020004 | 
2025-12-09 00:13:49.020203 | PLAY RECAP
2025-12-09 00:13:49.020299 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-12-09 00:13:49.020345 | 
2025-12-09 00:13:49.202886 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-12-09 00:13:49.203897 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2025-12-09 00:13:49.847958 | 
2025-12-09 00:13:49.848117 | PLAY [controller]
2025-12-09 00:13:49.874040 | 
2025-12-09 00:13:49.874176 | TASK [Create the /root directory]
2025-12-09 00:13:50.453250 | controller | ok
2025-12-09 00:13:50.468002 | 
2025-12-09 00:13:50.468167 | TASK [Install glibc-langpack-en]
2025-12-09 00:13:54.447610 | controller | ok: Nothing to do
2025-12-09 00:13:54.461383 | 
2025-12-09 00:13:54.461518 | TASK [Ensure controller directory exists]
2025-12-09 00:13:54.687237 | controller | changed
2025-12-09 00:13:54.693351 | 
2025-12-09 00:13:54.693441 | TASK [Install container runtime]
2025-12-09 00:13:54.763977 | controller | ok
2025-12-09 00:13:54.817267 | 
2025-12-09 00:13:54.817407 | LOOP [ensure-docker : Gather variables for each operating system]
2025-12-09 00:13:54.869830 | controller | ok: "/var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml"
2025-12-09 00:13:54.882645 | 
2025-12-09 00:13:54.882818 | TASK [ensure-docker : Sanity check for distro selection]
2025-12-09 00:13:54.899911 | controller | skipping: Conditional result was False
2025-12-09 00:13:54.910637 | 
2025-12-09 00:13:54.910762 | TASK [ensure-docker : Sanity check for distro install]
2025-12-09 00:13:54.939027 | controller | skipping: Conditional result was False
2025-12-09 00:13:54.947579 | 
2025-12-09 00:13:54.947674 | TASK [ensure-docker : Sanity check for upstream install]
2025-12-09 00:13:54.971839 | controller | skipping: Conditional result was False
2025-12-09 00:13:54.981990 | 
2025-12-09 00:13:54.982078 | TASK [ensure-docker : Sanity check for upstream install mirrors]
2025-12-09 00:13:55.005922 | controller | skipping: Conditional result was False
2025-12-09 00:13:55.014937 | 
2025-12-09 00:13:55.015064 | TASK [ensure-docker : Include tasks for docker install]
2025-12-09 00:13:55.038245 | controller | ok
2025-12-09 00:13:55.053319 | controller | included: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml
2025-12-09 00:13:55.061351 | 
2025-12-09 00:13:55.061414 | TASK [ensure-docker : Not Implemented]
2025-12-09 00:13:55.074678 | controller | skipping: Conditional result was False
2025-12-09 00:13:55.080891 | 
2025-12-09 00:13:55.080952 | TASK [Set up docker mirrors]
2025-12-09 00:13:55.119881 | controller | ok
2025-12-09 00:13:55.139836 | 
2025-12-09 00:13:55.139922 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info]
2025-12-09 00:13:55.163254 | controller | skipping: Conditional result was False
2025-12-09 00:13:55.169689 | 
2025-12-09 00:13:55.169780 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info]
2025-12-09 00:13:55.192789 | controller | skipping: Conditional result was False
2025-12-09 00:13:55.199391 | 
2025-12-09 00:13:55.199494 | TASK [use-docker-mirror : Set docker_mirror fact]
2025-12-09 00:13:55.223542 | controller | skipping: Conditional result was False
2025-12-09 00:13:55.230697 | 
2025-12-09 00:13:55.230797 | TASK [use-docker-mirror : Set up docker mirrors]
2025-12-09 00:13:55.253957 | controller | skipping: Conditional result was False
2025-12-09 00:13:55.266777 | 
2025-12-09 00:13:55.266924 | TASK [Add all repositories]
2025-12-09 00:13:55.285452 | controller | ok
2025-12-09 00:13:55.311203 | 
2025-12-09 00:13:55.311287 | LOOP [ensure-package-repositories : Install repositories]
2025-12-09 00:13:55.333263 | controller | ok: "/var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml"
2025-12-09 00:13:55.333482 | controller | ok: All items complete
2025-12-09 00:13:55.333509 | 
2025-12-09 00:13:55.369540 | controller | included: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml
2025-12-09 00:13:55.376491 | 
2025-12-09 00:13:55.376554 | TASK [ensure-package-repositories : Create GPG key temp directory]
2025-12-09 00:13:55.704681 | controller | changed
2025-12-09 00:13:55.711928 | 
2025-12-09 00:13:55.712000 | LOOP [ensure-package-repositories : Upload GPG keys]
2025-12-09 00:13:56.587161 | controller | changed:
2025-12-09 00:13:56.587452 | controller | {
2025-12-09 00:13:56.587508 | 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-12-09 00:13:56.587556 | controller | }
2025-12-09 00:13:56.595937 | 
2025-12-09 00:13:56.596018 | LOOP [ensure-package-repositories : Import GPG keys]
2025-12-09 00:13:57.163842 | controller | changed:
2025-12-09 00:13:57.164034 | controller | {
2025-12-09 00:13:57.164081 | 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-12-09 00:13:57.164116 | controller | }
2025-12-09 00:13:57.164159 | controller | changed: All items complete
2025-12-09 00:13:57.164193 | 
2025-12-09 00:13:57.187050 | 
2025-12-09 00:13:57.187303 | TASK [ensure-package-repositories : Remove GPG temp directory]
2025-12-09 00:13:57.406476 | controller | changed
2025-12-09 00:13:57.413926 | 
2025-12-09 00:13:57.413990 | LOOP [ensure-package-repositories : Add repositories]
2025-12-09 00:13:57.738773 | controller | changed:
2025-12-09 00:13:57.738957 | controller | {
2025-12-09 00:13:57.738992 | controller |   "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable",
2025-12-09 00:13:57.739020 | controller |   "description": "Docker CE Stable - $basearch",
2025-12-09 00:13:57.739043 | controller |   "gpgcheck": true,
2025-12-09 00:13:57.739066 | controller |   "name": "docker-ce-stable"
2025-12-09 00:13:57.739088 | controller | }
2025-12-09 00:13:57.757993 | 
2025-12-09 00:13:57.758100 | TASK [ensure-docker : Install pre-reqs]
2025-12-09 00:14:00.195070 | controller | ok: Nothing to do
2025-12-09 00:14:00.205764 | 
2025-12-09 00:14:00.205899 | TASK [ensure-docker : Remove packages]
2025-12-09 00:14:01.540404 | controller | ok: Nothing to do
2025-12-09 00:14:01.549315 | 
2025-12-09 00:14:01.549414 | TASK [ensure-docker : Install upstream docker using package]
2025-12-09 00:14:46.043092 | controller | changed
2025-12-09 00:14:46.060114 | 
2025-12-09 00:14:46.060312 | TASK [ensure-docker : Setup docker]
2025-12-09 00:14:46.108126 | controller | ok
2025-12-09 00:14:46.133663 | controller | included: /var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml
2025-12-09 00:14:46.153071 | 
2025-12-09 00:14:46.153217 | TASK [ensure-docker : Ensure "docker" group exists]
2025-12-09 00:14:46.548812 | controller | ok
2025-12-09 00:14:46.561703 | 
2025-12-09 00:14:46.561928 | TASK [ensure-docker : Add user to docker group]
2025-12-09 00:14:47.079411 | controller | changed
2025-12-09 00:14:47.094105 | 
2025-12-09 00:14:47.094292 | TASK [Update docker daemon proxy configuration]
2025-12-09 00:14:47.132469 | controller | skipping: Conditional result was False
2025-12-09 00:14:47.149280 | 
2025-12-09 00:14:47.149420 | TASK [Lower default MTU]
2025-12-09 00:14:47.176529 | controller | skipping: Conditional result was False
2025-12-09 00:14:47.194516 | 
2025-12-09 00:14:47.194684 | TASK [ensure-docker : Get the status of the docket.socket unit]
2025-12-09 00:14:47.611940 | controller | inactive
2025-12-09 00:14:47.756093 | controller | ok: Runtime: 0:00:00.012809
2025-12-09 00:14:47.809453 | 
2025-12-09 00:14:47.809598 | TASK [ensure-docker : Get the status of the docket unit]
2025-12-09 00:14:48.044198 | controller | inactive
2025-12-09 00:14:48.350001 | controller | ok: Runtime: 0:00:00.008712
2025-12-09 00:14:48.366113 | 
2025-12-09 00:14:48.366246 | TASK [ensure-docker : Restart docker]
2025-12-09 00:14:48.428092 | Trigger a Docker restart
2025-12-09 00:14:48.441062 | 
2025-12-09 00:14:48.441204 | TASK [ensure-docker : Reset ssh connection to pick up docker group]
2025-12-09 00:14:48.484409 | 
2025-12-09 00:14:48.484555 | TASK [ensure-docker : Install docker-compose]
2025-12-09 00:14:48.509758 | controller | skipping: Conditional result was False
2025-12-09 00:14:48.519790 | 
2025-12-09 00:14:48.519895 | TASK [ensure-docker : Flush handlers before role exit]
2025-12-09 00:14:48.534071 | 
2025-12-09 00:14:48.534156 | TASK [ensure-docker : Stop docker.socket to avoid any conflict]
2025-12-09 00:14:49.676857 | controller | changed
2025-12-09 00:14:49.687284 | 
2025-12-09 00:14:49.687376 | TASK [ensure-docker : Assure docker service is running]
2025-12-09 00:14:51.792144 | controller | changed
2025-12-09 00:14:51.806329 | 
2025-12-09 00:14:51.806429 | TASK [ensure-docker : Assure docker.socket service is running]
2025-12-09 00:14:52.537837 | controller | ok
2025-12-09 00:14:52.566965 | 
2025-12-09 00:14:52.567760 | TASK [ensure-docker : Correct group ownership on docker sock]
2025-12-09 00:14:53.199417 | controller | ok
2025-12-09 00:14:53.218150 | 
2025-12-09 00:14:53.218260 | TASK [ensure-docker : Validate ability to talk with docker]
2025-12-09 00:14:53.649388 | controller | CONTAINER ID   IMAGE     COMMAND   CREATED   STATUS    PORTS     NAMES
2025-12-09 00:14:53.772894 | controller | ok: Runtime: 0:00:00.043544
2025-12-09 00:14:53.780864 | 
2025-12-09 00:14:53.780949 | TASK [ensure-docker : Get version details]
2025-12-09 00:14:54.455082 | controller | Client: Docker Engine - Community
2025-12-09 00:14:54.455131 | controller |  Version:           24.0.7
2025-12-09 00:14:54.455138 | controller |  API version:       1.43
2025-12-09 00:14:54.455143 | controller |  Go version:        go1.20.10
2025-12-09 00:14:54.455155 | controller |  Git commit:        afdd53b
2025-12-09 00:14:54.455162 | controller |  Built:             Thu Oct 26 09:09:39 2023
2025-12-09 00:14:54.455167 | controller |  OS/Arch:           linux/amd64
2025-12-09 00:14:54.455173 | controller |  Context:           default
2025-12-09 00:14:54.455179 | controller |
2025-12-09 00:14:54.455184 | controller | Server: Docker Engine - Community
2025-12-09 00:14:54.455189 | controller |  Engine:
2025-12-09 00:14:54.455193 | controller |   Version:          24.0.7
2025-12-09 00:14:54.455197 | controller |   API version:      1.43 (minimum version 1.12)
2025-12-09 00:14:54.455202 | controller |   Go version:       go1.20.10
2025-12-09 00:14:54.455206 | controller |   Git commit:       311b9ff
2025-12-09 00:14:54.455219 | controller |   Built:            Thu Oct 26 09:08:11 2023
2025-12-09 00:14:54.455223 | controller |   OS/Arch:          linux/amd64
2025-12-09 00:14:54.455233 | controller |   Experimental:     false
2025-12-09 00:14:54.455237 | controller |  containerd:
2025-12-09 00:14:54.455243 | controller |   Version:          1.6.25
2025-12-09 00:14:54.456475 | controller |   GitCommit:        d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f
2025-12-09 00:14:54.456486 | controller |  runc:
2025-12-09 00:14:54.456490 | controller |   Version:          1.1.10
2025-12-09 00:14:54.456494 | controller |   GitCommit:        v1.1.10-0-g18a0cb0
2025-12-09 00:14:54.456501 | controller |  docker-init:
2025-12-09 00:14:54.456506 | controller |   Version:          0.19.0
2025-12-09 00:14:54.456510 | controller |   GitCommit:        de40ad0
2025-12-09 00:14:54.826059 | controller | ok: Runtime: 0:00:00.079262
2025-12-09 00:14:54.845430 | 
2025-12-09 00:14:54.845696 | TASK [ensure-docker : Dump installed docker details]
2025-12-09 00:14:54.917359 | {'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-12-09 00:14:54.377525', 'end': '2025-12-09 00:14:54.456787', 'delta': '0:00:00.079262', 'msg': '', 'zuul_log_id': 'fa163ef9-e89a-ccdd-2b80-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-12-09 00:14:54.929930 | 
2025-12-09 00:14:54.930131 | TASK [Use buildset registry]
2025-12-09 00:14:54.960699 | controller | skipping: Conditional result was False
2025-12-09 00:14:54.977428 | 
2025-12-09 00:14:54.977532 | TASK [Ensure python3.8 is present]
2025-12-09 00:14:55.005264 | controller | skipping: Conditional result was False
2025-12-09 00:14:55.013619 | 
2025-12-09 00:14:55.013710 | TASK [Run our-ensure-python role (Fedora only for now)]
2025-12-09 00:14:55.039006 | controller | ok
2025-12-09 00:14:55.063876 | 
2025-12-09 00:14:55.064036 | TASK [our-ensure-python : Install the right Python version (rpm)]
2025-12-09 00:14:57.488422 | controller | ok: Nothing to do
2025-12-09 00:14:57.504886 | 
2025-12-09 00:14:57.505091 | TASK [our-ensure-python : Also install python3-devel]
2025-12-09 00:15:08.302863 | controller | changed
2025-12-09 00:15:08.324701 | 
2025-12-09 00:15:08.324935 | TASK [Run ensure-virtualenv role]
2025-12-09 00:15:08.354110 | controller | ok
2025-12-09 00:15:08.393910 | 
2025-12-09 00:15:08.394245 | TASK [ensure-virtualenv : Check if virtualenv is installed]
2025-12-09 00:15:08.617462 | controller | /usr/bin/virtualenv
2025-12-09 00:15:08.935573 | controller | ok: Runtime: 0:00:00.003128
2025-12-09 00:15:08.942538 | 
2025-12-09 00:15:08.942606 | LOOP [ensure-virtualenv : Install virtualenv package]
2025-12-09 00:15:08.997521 | controller | skipping: Conditional result was False
2025-12-09 00:15:08.998207 | controller | changed: All items complete
2025-12-09 00:15:08.998281 | 
2025-12-09 00:15:09.026830 | 
2025-12-09 00:15:09.026952 | TASK [Find the full path of the Python interpreter]
2025-12-09 00:15:09.264874 | controller | /usr/bin/python3.8
2025-12-09 00:15:09.568253 | controller | ok
2025-12-09 00:15:09.586573 | 
2025-12-09 00:15:09.586770 | TASK [Create virtualenv for ansible-test with a specific interpreter]
2025-12-09 00:15:11.319103 | controller | created virtual environment CPython3.8.18.final.0-64 in 850ms
2025-12-09 00:15:11.364040 | controller |   creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False)
2025-12-09 00:15:11.364057 | 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-12-09 00:15:11.364066 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2025-12-09 00:15:11.364085 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2025-12-09 00:15:11.648094 | controller | changed
2025-12-09 00:15:11.656863 | 
2025-12-09 00:15:11.656970 | TASK [Set selinux package]
2025-12-09 00:15:11.681637 | controller | ok
2025-12-09 00:15:11.695246 | 
2025-12-09 00:15:11.695385 | TASK [Set selinux package (Fedora)]
2025-12-09 00:15:11.749164 | controller | ok
2025-12-09 00:15:11.759025 | 
2025-12-09 00:15:11.759164 | TASK [Install selinux into virtualenv]
2025-12-09 00:15:14.142890 | controller | Collecting selinux-please-lie-to-me
2025-12-09 00:15:14.233104 | controller |   Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB)
2025-12-09 00:15:15.263780 | controller | Collecting setuptools<50.0.0
2025-12-09 00:15:15.269091 | controller |   Downloading setuptools-49.6.0-py3-none-any.whl (803 kB)
2025-12-09 00:15:15.320941 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 19.6 MB/s eta 0:00:00
2025-12-09 00:15:15.531532 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me
2025-12-09 00:15:15.532571 | controller |   Attempting uninstall: setuptools
2025-12-09 00:15:15.538745 | controller |     Found existing installation: setuptools 62.6.0
2025-12-09 00:15:15.769188 | controller |     Uninstalling setuptools-62.6.0:
2025-12-09 00:15:15.791049 | controller |       Successfully uninstalled setuptools-62.6.0
2025-12-09 00:15:16.567328 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0
2025-12-09 00:15:16.891788 | controller |
2025-12-09 00:15:17.103149 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2025-12-09 00:15:17.103186 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2025-12-09 00:15:17.322675 | controller | ok: Runtime: 0:00:05.091652
2025-12-09 00:15:17.339369 | 
2025-12-09 00:15:17.339557 | TASK [Install pytest-forked into virtualenv]
2025-12-09 00:15:18.299803 | controller | Collecting pytest-forked
2025-12-09 00:15:18.352126 | controller |   Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB)
2025-12-09 00:15:18.412356 | controller | Collecting py
2025-12-09 00:15:18.418164 | controller |   Downloading py-1.11.0-py2.py3-none-any.whl (98 kB)
2025-12-09 00:15:18.439212 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 5.0 MB/s eta 0:00:00
2025-12-09 00:15:18.716051 | controller | Collecting pytest>=3.10
2025-12-09 00:15:18.723309 | controller |   Downloading pytest-8.3.5-py3-none-any.whl (343 kB)
2025-12-09 00:15:18.739400 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 343.6/343.6 kB 26.7 MB/s eta 0:00:00
2025-12-09 00:15:18.777486 | controller | Collecting iniconfig
2025-12-09 00:15:18.780945 | controller |   Downloading iniconfig-2.1.0-py3-none-any.whl (6.0 kB)
2025-12-09 00:15:18.826848 | controller | Collecting pluggy<2,>=1.5
2025-12-09 00:15:18.833418 | controller |   Downloading pluggy-1.5.0-py3-none-any.whl (20 kB)
2025-12-09 00:15:18.882686 | controller | Collecting exceptiongroup>=1.0.0rc8
2025-12-09 00:15:18.887810 | controller |   Downloading exceptiongroup-1.3.1-py3-none-any.whl (16 kB)
2025-12-09 00:15:18.957594 | controller | Collecting packaging
2025-12-09 00:15:18.972765 | controller |   Downloading packaging-25.0-py3-none-any.whl (66 kB)
2025-12-09 00:15:18.982033 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 11.7 MB/s eta 0:00:00
2025-12-09 00:15:19.084096 | controller | Collecting tomli>=1
2025-12-09 00:15:19.098361 | controller |   Downloading tomli-2.3.0-py3-none-any.whl (14 kB)
2025-12-09 00:15:19.221523 | controller | Collecting typing-extensions>=4.6.0
2025-12-09 00:15:19.234100 | controller |   Downloading typing_extensions-4.13.2-py3-none-any.whl (45 kB)
2025-12-09 00:15:19.244427 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.8/45.8 kB 12.0 MB/s eta 0:00:00
2025-12-09 00:15:19.419439 | controller | Installing collected packages: typing-extensions, tomli, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked
2025-12-09 00:15:19.987535 | controller | Successfully installed exceptiongroup-1.3.1 iniconfig-2.1.0 packaging-25.0 pluggy-1.5.0 py-1.11.0 pytest-8.3.5 pytest-forked-1.6.0 tomli-2.3.0 typing-extensions-4.13.2
2025-12-09 00:15:19.990798 | controller |
2025-12-09 00:15:20.178801 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1
2025-12-09 00:15:20.178840 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip
2025-12-09 00:15:20.403592 | controller | ok: Runtime: 0:00:02.440718
2025-12-09 00:15:20.410223 | 
2025-12-09 00:15:20.410311 | TASK [Update pip]
2025-12-09 00:15:21.969502 | controller | Requirement already satisfied: pip in ./venv/lib/python3.8/site-packages (22.2.2)
2025-12-09 00:15:22.336369 | controller | Collecting pip
2025-12-09 00:15:22.415706 | controller |   Downloading pip-25.0.1-py3-none-any.whl (1.8 MB)
2025-12-09 00:15:22.481348 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 30.0 MB/s eta 0:00:00
2025-12-09 00:15:22.643048 | controller | Installing collected packages: pip
2025-12-09 00:15:22.643900 | controller |   Attempting uninstall: pip
2025-12-09 00:15:22.645054 | controller |     Found existing installation: pip 22.2.2
2025-12-09 00:15:23.195141 | controller |     Uninstalling pip-22.2.2:
2025-12-09 00:15:23.242816 | controller |       Successfully uninstalled pip-22.2.2
2025-12-09 00:15:25.327364 | controller | Successfully installed pip-25.0.1
2025-12-09 00:15:25.956338 | controller | ok: Runtime: 0:00:04.512550
2025-12-09 00:15:25.970583 | 
2025-12-09 00:15:25.970785 | TASK [Ensure pip temp directory exists in /var/tmp]
2025-12-09 00:15:26.330995 | controller | changed
2025-12-09 00:15:26.341700 | 
2025-12-09 00:15:26.341807 | TASK [Install ansible into virtualenv]
2025-12-09 00:15:27.605635 | controller | Processing ./src/github.com/ansible/ansible
2025-12-09 00:15:27.606415 | controller |   Preparing metadata (setup.py): started
2025-12-09 00:15:30.491289 | controller |   Preparing metadata (setup.py): finished with status 'done'
2025-12-09 00:15:30.543969 | controller | Collecting jinja2 (from ansible==2.9.27.post0)
2025-12-09 00:15:30.553757 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB)
2025-12-09 00:15:30.618266 | controller | Collecting PyYAML (from ansible==2.9.27.post0)
2025-12-09 00:15:30.623421 | 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-12-09 00:15:30.870346 | controller | Collecting cryptography (from ansible==2.9.27.post0)
2025-12-09 00:15:30.876075 | controller |   Downloading cryptography-46.0.3-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB)
2025-12-09 00:15:31.028248 | controller | Collecting cffi>=1.14 (from cryptography->ansible==2.9.27.post0)
2025-12-09 00:15:31.054773 | controller |   Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB)
2025-12-09 00:15:31.062216 | 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-12-09 00:15:31.187883 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible==2.9.27.post0)
2025-12-09 00:15:31.200387 | controller |   Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (3.0 kB)
2025-12-09 00:15:31.261780 | controller | Collecting pycparser (from cffi>=1.14->cryptography->ansible==2.9.27.post0)
2025-12-09 00:15:31.265799 | controller |   Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes)
2025-12-09 00:15:31.286670 | controller | Downloading cryptography-46.0.3-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2025-12-09 00:15:31.364704 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 60.8 MB/s eta 0:00:00
2025-12-09 00:15:31.380129 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2025-12-09 00:15:31.397587 | 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-12-09 00:15:31.412487 | controller |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.0/806.0 kB 53.7 MB/s eta 0:00:00
2025-12-09 00:15:31.431298 | controller | Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB)
2025-12-09 00:15:31.586568 | controller | Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (26 kB)
2025-12-09 00:15:31.602899 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB)
2025-12-09 00:15:31.627576 | controller | Building wheels for collected packages: ansible
2025-12-09 00:15:31.628169 | controller |   Building wheel for ansible (setup.py): started
2025-12-09 00:15:38.543585 | controller |   Building wheel for ansible (setup.py): finished with status 'done'
2025-12-09 00:15:38.555968 | controller |   Created wheel for ansible: filename=ansible-2.9.27.post0-py3-none-any.whl size=16207514 sha256=c71a5601e530cb3ebf7bacc9884275b6259686b82586db5fd67e963fe8ff9aa5
2025-12-09 00:15:38.556166 | controller |   Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-6clhsr48/wheels/a5/4b/fa/b6deaae105422b0b3b92831e0369d44bf7fca5bb3413d79be7
2025-12-09 00:15:38.603967 | controller | Successfully built ansible
2025-12-09 00:15:38.700281 | controller | Installing collected packages: PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible
2025-12-09 00:15:46.249099 | 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-12-09 00:15:46.434529 | controller | ok: Runtime: 0:00:19.517123
2025-12-09 00:15:46.452521 | 
2025-12-09 00:15:46.452674 | TASK [Setup download-artifact-fork role]
2025-12-09 00:15:46.486998 | controller | ok
2025-12-09 00:15:46.521588 | 
2025-12-09 00:15:46.521750 | TASK [download-artifact-fork : Parse inventory response]
2025-12-09 00:15:46.566797 | controller | ok
2025-12-09 00:15:46.577604 | 
2025-12-09 00:15:46.577703 | TASK [download-artifact-fork : Fetch info from Zuul API]
2025-12-09 00:15:46.604257 | controller | skipping: Conditional result was False
2025-12-09 00:15:46.616103 | 
2025-12-09 00:15:46.616337 | TASK [download-artifact-fork : Parse build response]
2025-12-09 00:15:46.644028 | controller | skipping: Conditional result was False
2025-12-09 00:15:46.657228 | 
2025-12-09 00:15:46.657335 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2025-12-09 00:15:46.876009 | controller | changed
2025-12-09 00:15:46.894180 | 
2025-12-09 00:15:46.894305 | LOOP [download-artifact-fork : Download archive by type]
2025-12-09 00:15:46.921816 | controller | skipping: Conditional result was False
2025-12-09 00:15:46.922146 | 
2025-12-09 00:15:47.661627 | controller | changed: OK (20188 bytes)
2025-12-09 00:15:47.678629 | 
2025-12-09 00:15:47.678784 | TASK [deploy-artifacts : define __collections]
2025-12-09 00:15:47.703519 | controller | ok
2025-12-09 00:15:47.712292 | 
2025-12-09 00:15:47.712403 | LOOP [deploy-artifacts : Create list of collections]
2025-12-09 00:15:47.735690 | controller | skipping: Conditional result was False
2025-12-09 00:15:47.745149 | controller | ok:
2025-12-09 00:15:47.745259 | controller | {
2025-12-09 00:15:47.745288 | controller |   "branch": "main",
2025-12-09 00:15:47.745310 | controller |   "job": "build-ansible-collection",
2025-12-09 00:15:47.745332 | controller |   "metadata": {
2025-12-09 00:15:47.745353 | controller |     "type": "ansible_collection",
2025-12-09 00:15:47.745374 | controller |     "version": "5.0.0"
2025-12-09 00:15:47.745395 | controller |   },
2025-12-09 00:15:47.745416 | controller |   "name": "ansible.network",
2025-12-09 00:15:47.745437 | controller |   "project": "ansible-collections/ansible.network",
2025-12-09 00:15:47.745460 | controller |   "url": "https://edcec2aa4c0fd786eeb6-d34923df66095b7edd2546b60f499928.ssl.cf5.rackcdn.com/ansible/7db3f8b4d52a44e7a3ab4202d1fb7aab/artifacts/ansible-network-5.0.0.tar.gz"
2025-12-09 00:15:47.745490 | controller | }
2025-12-09 00:15:47.755612 | 
2025-12-09 00:15:47.755748 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2025-12-09 00:15:48.197430 | controller | Process install dependency map
2025-12-09 00:21:47.982912 | controller | ok: Runtime: 0:00:55.419236
2025-12-09 00:21:48.009920 | 
2025-12-09 00:21:48.010110 | TASK [podman may need iptables kernel modules]
2025-12-09 00:21:48.562288 | controller | ok: Runtime: 0:00:00.005730
2025-12-09 00:21:48.594914 | 
2025-12-09 00:21:48.595030 | PLAY RECAP
2025-12-09 00:21:48.595083 | controller | ok: 46 changed: 26 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0
2025-12-09 00:21:48.595161 | 
2025-12-09 00:21:48.725947 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2025-12-09 00:21:48.726863 | RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2025-12-09 00:21:49.448908 | 
2025-12-09 00:21:49.449031 | PLAY [controller]
2025-12-09 00:21:49.474583 | 
2025-12-09 00:21:49.474690 | TASK [Copy the galaxy.yml on the controller]
2025-12-09 00:21:50.164964 | controller | changed
2025-12-09 00:21:50.174105 | 
2025-12-09 00:21:50.174200 | TASK [Load information from galaxy.yml]
2025-12-09 00:21:50.222341 | controller | ok
2025-12-09 00:21:50.236503 | 
2025-12-09 00:21:50.236711 | LOOP [Enable FIPS mode]
2025-12-09 00:21:50.267214 | 
2025-12-09 00:21:50.267445 | LOOP [ansible-test : Include branch specific variables.]
2025-12-09 00:21:50.314978 | controller | ok: "/var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/untrusted/project_2/github.com/ansible/ansible-zuul-jobs/roles/ansible-test/vars/default.yaml"
2025-12-09 00:21:50.315243 | 
2025-12-09 00:21:50.326161 | 
2025-12-09 00:21:50.326314 | TASK [ansible-test : Setup --skip-tags for test_options]
2025-12-09 00:21:50.372986 | controller | ok
2025-12-09 00:21:50.385111 | 
2025-12-09 00:21:50.385259 | TASK [ansible-test : Enable --inventory for network-integration]
2025-12-09 00:21:50.409651 | controller | skipping: Conditional result was False
2025-12-09 00:21:50.416278 | 
2025-12-09 00:21:50.416345 | TASK [ansible-test : Enable --retry-on-error]
2025-12-09 00:21:50.440441 | controller | skipping: Conditional result was False
2025-12-09 00:21:50.449300 | 
2025-12-09 00:21:50.449389 | TASK [ansible-test : Enable --continue-on-error]
2025-12-09 00:21:50.495094 | controller | ok
2025-12-09 00:21:50.504202 | 
2025-12-09 00:21:50.504288 | TASK [ansible-test : Enable --requirements]
2025-12-09 00:21:50.530519 | controller | skipping: Conditional result was False
2025-12-09 00:21:50.540111 | 
2025-12-09 00:21:50.540199 | TASK [ansible-test : Adjust options for unit tests]
2025-12-09 00:21:50.565139 | controller | skipping: Conditional result was False
2025-12-09 00:21:50.576333 | 
2025-12-09 00:21:50.576423 | TASK [ansible-test : Install requirements with unit tests]
2025-12-09 00:21:50.620680 | controller | ok
2025-12-09 00:21:50.628645 | 
2025-12-09 00:21:50.628755 | TASK [ansible-test : Set --skip-test]
2025-12-09 00:21:50.685816 | controller | skipping: Conditional result was False
2025-12-09 00:21:50.701491 | 
2025-12-09 00:21:50.701650 | TASK [ansible-test : Reduce verbosity]
2025-12-09 00:21:50.754397 | controller | ok
2025-12-09 00:21:50.767688 | 
2025-12-09 00:21:50.767877 | TASK [ansible-test : Setup --python option]
2025-12-09 00:21:50.795498 | controller | skipping: Conditional result was False
2025-12-09 00:21:50.807850 | 
2025-12-09 00:21:50.807958 | TASK [ansible-test : Setup --docker option]
2025-12-09 00:21:50.883539 | controller | ok
2025-12-09 00:21:50.891882 | 
2025-12-09 00:21:50.892046 | TASK [ansible-test : check if MANIFEST.json exists]
2025-12-09 00:21:51.106884 | controller | ok
2025-12-09 00:21:51.112870 | 
2025-12-09 00:21:51.112935 | TASK [ansible-test : Copy the MANIFEST.json on the controller]
2025-12-09 00:21:51.137125 | controller | skipping: Conditional result was False
2025-12-09 00:21:51.144025 | 
2025-12-09 00:21:51.144103 | TASK [ansible-test : Load information from MANIFEST.json]
2025-12-09 00:21:51.177857 | controller | skipping: Conditional result was False
2025-12-09 00:21:51.185271 | 
2025-12-09 00:21:51.185347 | TASK [ansible-test : Setup location of project for integration tests]
2025-12-09 00:21:51.213806 | controller | skipping: Conditional result was False
2025-12-09 00:21:51.225092 | 
2025-12-09 00:21:51.225175 | TASK [ansible-test : Copy the galaxy.yml on the controller]
2025-12-09 00:21:51.489855 | controller | ok
2025-12-09 00:21:51.510914 | 
2025-12-09 00:21:51.511063 | TASK [ansible-test : Load information from galaxy.yml]
2025-12-09 00:21:51.561808 | controller | ok
2025-12-09 00:21:51.576880 | 
2025-12-09 00:21:51.577236 | TASK [ansible-test : Setup location of project for integration tests]
2025-12-09 00:21:51.618340 | controller | ok
2025-12-09 00:21:51.627619 | 
2025-12-09 00:21:51.627707 | TASK [ansible-test : Setup minimum test requirements]
2025-12-09 00:21:51.660916 | controller | ok
2025-12-09 00:21:51.668960 | 
2025-12-09 00:21:51.669043 | TASK [ansible-test : Ensure pip temp directory exists in /var/tmp]
2025-12-09 00:21:51.989737 | controller | ok
2025-12-09 00:21:51.998629 | 
2025-12-09 00:21:51.998715 | TASK [ansible-test : Install python requirements]
2025-12-09 00:21:52.744632 | controller | Collecting yamllint (from -r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2025-12-09 00:21:52.760549 | controller |   Downloading yamllint-1.35.1-py3-none-any.whl.metadata (4.2 kB)
2025-12-09 00:21:52.793399 | controller | Collecting pathspec>=0.5.3 (from yamllint->-r /home/zuul/.ansible/collections/ansible_collections/ansible/network/test-requirements.txt (line 1))
2025-12-09 00:21:52.798367 | controller |   Downloading pathspec-0.12.1-py3-none-any.whl.metadata (21 kB)
2025-12-09 00:21:52.809940 | 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-12-09 00:21:52.819304 | controller | Downloading yamllint-1.35.1-py3-none-any.whl (66 kB)
2025-12-09 00:21:52.835800 | controller | Downloading pathspec-0.12.1-py3-none-any.whl (31 kB)
2025-12-09 00:21:52.883752 | controller | Installing collected packages: pathspec, yamllint
2025-12-09 00:21:52.937258 | controller | Successfully installed pathspec-0.12.1 yamllint-1.35.1
2025-12-09 00:21:53.044036 | controller | ok: Runtime: 0:00:00.599499
2025-12-09 00:21:53.060917 | 
2025-12-09 00:21:53.061064 | TASK [ansible-test : Copy the integration_config.yml file from the controller]
2025-12-09 00:21:53.659405 | controller | cp: cannot stat '/tmp/integration_config.yml': No such file or directory
2025-12-09 00:21:54.121423 | controller | ERROR
2025-12-09 00:21:54.121685 | controller | {
2025-12-09 00:21:54.121800 | controller |   "delta": "0:00:00.019163",
2025-12-09 00:21:54.121849 | controller |   "end": "2025-12-09 00:21:53.659646",
2025-12-09 00:21:54.121889 | controller |   "msg": "non-zero return code",
2025-12-09 00:21:54.121927 | controller |   "rc": 1,
2025-12-09 00:21:54.121965 | controller |   "start": "2025-12-09 00:21:53.640483"
2025-12-09 00:21:54.122002 | controller | }
2025-12-09 00:21:54.122052 | controller | ERROR: Ignoring Errors
2025-12-09 00:21:54.137651 | 
2025-12-09 00:21:54.137848 | TASK [ansible-test : Copy potential cloud provider configuration for ansible-test in the collection]
2025-12-09 00:21:54.691242 | controller | skipping: Conditional result was False
2025-12-09 00:21:54.698580 | 
2025-12-09 00:21:54.698646 | TASK [ansible-test : Enable persistent connection logging]
2025-12-09 00:21:55.187037 | controller | changed: section and option added
2025-12-09 00:21:55.201514 | 
2025-12-09 00:21:55.201653 | TASK [ansible-test : Set persistent ssh_type value]
2025-12-09 00:21:55.660500 | controller | changed: option added
2025-12-09 00:21:55.669600 | 
2025-12-09 00:21:55.669756 | TASK [ansible-test : Set ansible log path]
2025-12-09 00:21:56.068177 | controller | changed: section and option added
2025-12-09 00:21:56.084042 | 
2025-12-09 00:21:56.084194 | TASK [ansible-test : Identify the changed targets]
2025-12-09 00:21:56.637419 | controller | skipping: Conditional result was False
2025-12-09 00:21:56.654697 | 
2025-12-09 00:21:56.654963 | TASK [ansible-test : set_fact]
2025-12-09 00:21:56.749992 | controller | skipping: Conditional result was False
2025-12-09 00:21:56.760480 | 
2025-12-09 00:21:56.760587 | TASK [ansible-test : Set the targets]
2025-12-09 00:21:56.804161 | controller | ok
2025-12-09 00:21:56.812962 | 
2025-12-09 00:21:56.813075 | TASK [ansible-test : set_fact]
2025-12-09 00:21:56.838759 | controller | skipping: Conditional result was False
2025-12-09 00:21:56.848832 | 
2025-12-09 00:21:56.848965 | TASK [ansible-test : List the targets]
2025-12-09 00:21:57.400534 | controller | skipping: Conditional result was False
2025-12-09 00:21:57.416705 | 
2025-12-09 00:21:57.417117 | TASK [ansible-test : set_fact]
2025-12-09 00:21:57.444227 | controller | skipping: Conditional result was False
2025-12-09 00:21:57.461133 | 
2025-12-09 00:21:57.461330 | TASK [ansible-test : set_fact]
2025-12-09 00:21:57.490174 | controller | skipping: Conditional result was False
2025-12-09 00:21:57.505895 | 
2025-12-09 00:21:57.506047 | LOOP [ansible-test : set_fact]
2025-12-09 00:21:57.589134 | 
2025-12-09 00:21:57.589410 | TASK [ansible-test : set_fact]
2025-12-09 00:21:57.617047 | controller | skipping: Conditional result was False
2025-12-09 00:21:57.638873 | 
2025-12-09 00:21:57.638984 | TASK [ansible-test : debug]
2025-12-09 00:21:57.667285 | controller | skipping: Conditional result was False
2025-12-09 00:21:57.681811 | 
2025-12-09 00:21:57.681951 | TASK [ansible-test : debug]
2025-12-09 00:21:57.711665 | About to run: ansible-test sanity --requirements --docker -v
2025-12-09 00:21:57.718043 | 
2025-12-09 00:21:57.718110 | TASK [ansible-test : Run the test suite]
2025-12-09 00:21:58.320329 | controller | Run command: docker images quay.io/ansible/default-test-container:1.10.1 --format '{{json .}}'
2025-12-09 00:21:58.352283 | controller | Run command: docker pull quay.io/ansible/default-test-container:1.10.1
2025-12-09 00:21:58.918232 | controller | 1.10.1: Pulling from ansible/default-test-container
2025-12-09 00:21:58.918264 | 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-12-09 00:21:58.918279 | controller | 5667fdb72017: Pulling fs layer
2025-12-09 00:21:58.918287 | controller | d83811f270d5: Pulling fs layer
2025-12-09 00:21:58.918292 | controller | ee671aafb583: Pulling fs layer
2025-12-09 00:21:58.918300 | controller | 7fc152dfb3a6: Pulling fs layer
2025-12-09 00:21:58.918306 | controller | 3fb967a6fd03: Pulling fs layer
2025-12-09 00:21:58.918374 | controller | b3e63023ca5f: Pulling fs layer
2025-12-09 00:21:58.918379 | controller | 653cb3e65dbf: Pulling fs layer
2025-12-09 00:21:58.918383 | controller | f4712b586375: Pulling fs layer
2025-12-09 00:21:58.918388 | controller | d696ed7812f8: Pulling fs layer
2025-12-09 00:21:58.918392 | controller | 29bf28764f14: Pulling fs layer
2025-12-09 00:21:58.918396 | controller | 47d7edb3c2b7: Pulling fs layer
2025-12-09 00:21:58.918401 | controller | 07550ad4f6e4: Pulling fs layer
2025-12-09 00:21:58.918405 | controller | 7e79526e64c5: Pulling fs layer
2025-12-09 00:21:58.918409 | controller | 4fffb32882b7: Pulling fs layer
2025-12-09 00:21:58.918414 | controller | fc7a38b06f4e: Pulling fs layer
2025-12-09 00:21:58.918418 | controller | 6d9d912e060e: Pulling fs layer
2025-12-09 00:21:58.918422 | controller | 5dd542dd28d9: Pulling fs layer
2025-12-09 00:21:58.918426 | controller | cef8beb99552: Pulling fs layer
2025-12-09 00:21:58.918441 | controller | bd5557e101ad: Pulling fs layer
2025-12-09 00:21:58.918446 | controller | e057c20fabdd: Pulling fs layer
2025-12-09 00:21:58.918452 | controller | d16059cdae2e: Pulling fs layer
2025-12-09 00:21:58.918456 | controller | 431e42d906a3: Pulling fs layer
2025-12-09 00:21:58.918460 | controller | 7a0fd3b1d7c3: Pulling fs layer
2025-12-09 00:21:58.918465 | controller | aacdb6db0c8c: Pulling fs layer
2025-12-09 00:21:58.918469 | controller | 2e7f04ae8c8b: Pulling fs layer
2025-12-09 00:21:58.918473 | controller | 4cd343027a44: Pulling fs layer
2025-12-09 00:21:58.918477 | controller | 0b4379883f90: Pulling fs layer
2025-12-09 00:21:58.918481 | controller | 3d9d6d9dfc91: Pulling fs layer
2025-12-09 00:21:58.918488 | controller | 57d6314bd293: Pulling fs layer
2025-12-09 00:21:58.918492 | controller | 774036afeb7f: Pulling fs layer
2025-12-09 00:21:58.918496 | controller | 54b10f0e1645: Pulling fs layer
2025-12-09 00:21:58.918500 | controller | 78cf439d9fdb: Pulling fs layer
2025-12-09 00:21:58.918504 | controller | 36e5e20969c7: Pulling fs layer
2025-12-09 00:21:58.918508 | controller | 4b19ac3f17a8: Pulling fs layer
2025-12-09 00:21:58.918512 | controller | 5dd542dd28d9: Waiting
2025-12-09 00:21:58.918517 | controller | cef8beb99552: Waiting
2025-12-09 00:21:58.918523 | controller | bd5557e101ad: Waiting
2025-12-09 00:21:58.918527 | controller | e057c20fabdd: Waiting
2025-12-09 00:21:58.918531 | controller | d16059cdae2e: Waiting
2025-12-09 00:21:58.918535 | controller | 431e42d906a3: Waiting
2025-12-09 00:21:58.918539 | controller | 7a0fd3b1d7c3: Waiting
2025-12-09 00:21:58.918543 | controller | aacdb6db0c8c: Waiting
2025-12-09 00:21:58.918547 | controller | 2e7f04ae8c8b: Waiting
2025-12-09 00:21:58.918551 | controller | 4cd343027a44: Waiting
2025-12-09 00:21:58.918555 | controller | 0b4379883f90: Waiting
2025-12-09 00:21:58.918559 | controller | 3d9d6d9dfc91: Waiting
2025-12-09 00:21:58.918564 | controller | 57d6314bd293: Waiting
2025-12-09 00:21:58.918568 | controller | 774036afeb7f: Waiting
2025-12-09 00:21:58.918574 | controller | 54b10f0e1645: Waiting
2025-12-09 00:21:58.918578 | controller | 78cf439d9fdb: Waiting
2025-12-09 00:21:58.918582 | controller | 36e5e20969c7: Waiting
2025-12-09 00:21:58.918586 | controller | 4b19ac3f17a8: Waiting
2025-12-09 00:21:58.918592 | controller | d696ed7812f8: Waiting
2025-12-09 00:21:59.119286 | controller | 29bf28764f14: Waiting
2025-12-09 00:21:59.119305 | controller | 47d7edb3c2b7: Waiting
2025-12-09 00:21:59.119312 | controller | 07550ad4f6e4: Waiting
2025-12-09 00:21:59.119318 | controller | 7e79526e64c5: Waiting
2025-12-09 00:21:59.119325 | controller | 4fffb32882b7: Waiting
2025-12-09 00:21:59.119330 | controller | fc7a38b06f4e: Waiting
2025-12-09 00:21:59.119336 | controller | 6d9d912e060e: Waiting
2025-12-09 00:21:59.119344 | controller | 3fb967a6fd03: Waiting
2025-12-09 00:21:59.119359 | controller | b3e63023ca5f: Waiting
2025-12-09 00:21:59.119366 | controller | 653cb3e65dbf: Waiting
2025-12-09 00:21:59.119374 | controller | f4712b586375: Waiting
2025-12-09 00:21:59.119380 | controller | 7fc152dfb3a6: Waiting
2025-12-09 00:21:59.119390 | controller | ee671aafb583: Verifying Checksum
2025-12-09 00:21:59.291773 | controller | ee671aafb583: Download complete
2025-12-09 00:21:59.291793 | controller | d83811f270d5: Verifying Checksum
2025-12-09 00:21:59.334894 | controller | d83811f270d5: Download complete
2025-12-09 00:21:59.334912 | controller | 7fc152dfb3a6: Verifying Checksum
2025-12-09 00:21:59.334963 | controller | 7fc152dfb3a6: Download complete
2025-12-09 00:21:59.402024 | controller | 5667fdb72017: Verifying Checksum
2025-12-09 00:21:59.491095 | controller | 5667fdb72017: Download complete
2025-12-09 00:21:59.491126 | controller | b3e63023ca5f: Verifying Checksum
2025-12-09 00:21:59.607413 | controller | b3e63023ca5f: Download complete
2025-12-09 00:21:59.607462 | controller | 653cb3e65dbf: Verifying Checksum
2025-12-09 00:21:59.876870 | controller | 653cb3e65dbf: Download complete
2025-12-09 00:21:59.876904 | controller | 3fb967a6fd03: Verifying Checksum
2025-12-09 00:21:59.967801 | controller | 3fb967a6fd03: Download complete
2025-12-09 00:21:59.967846 | controller | d696ed7812f8: Verifying Checksum
2025-12-09 00:22:00.199065 | controller | d696ed7812f8: Download complete
2025-12-09 00:22:00.199119 | controller | 29bf28764f14: Verifying Checksum
2025-12-09 00:22:00.301797 | controller | 29bf28764f14: Download complete
2025-12-09 00:22:00.301831 | controller | 47d7edb3c2b7: Verifying Checksum
2025-12-09 00:22:00.468596 | controller | 47d7edb3c2b7: Download complete
2025-12-09 00:22:00.468648 | controller | 07550ad4f6e4: Verifying Checksum
2025-12-09 00:22:00.535783 | controller | 07550ad4f6e4: Download complete
2025-12-09 00:22:00.535817 | controller | 7e79526e64c5: Verifying Checksum
2025-12-09 00:22:00.798123 | controller | 7e79526e64c5: Download complete
2025-12-09 00:22:00.798164 | controller | fc7a38b06f4e: Download complete
2025-12-09 00:22:00.959799 | controller | 6d9d912e060e: Verifying Checksum
2025-12-09 00:22:01.108636 | controller | 6d9d912e060e: Download complete
2025-12-09 00:22:01.108673 | controller | 4fffb32882b7: Verifying Checksum
2025-12-09 00:22:01.152310 | controller | 4fffb32882b7: Download complete
2025-12-09 00:22:01.152348 | controller | 5dd542dd28d9: Verifying Checksum
2025-12-09 00:22:01.377206 | controller | 5dd542dd28d9: Download complete
2025-12-09 00:22:01.377246 | controller | bd5557e101ad: Verifying Checksum
2025-12-09 00:22:01.566531 | controller | bd5557e101ad: Download complete
2025-12-09 00:22:01.566583 | controller | e057c20fabdd: Verifying Checksum
2025-12-09 00:22:01.575609 | controller | e057c20fabdd: Download complete
2025-12-09 00:22:01.824748 | controller | d16059cdae2e: Verifying Checksum
2025-12-09 00:22:01.967097 | controller | d16059cdae2e: Download complete
2025-12-09 00:22:01.967153 | controller | 5667fdb72017: Pull complete
2025-12-09 00:22:02.053199 | controller | d83811f270d5: Pull complete
2025-12-09 00:22:02.096891 | controller | ee671aafb583: Pull complete
2025-12-09 00:22:02.135850 | controller | 7fc152dfb3a6: Pull complete
2025-12-09 00:22:02.352232 | controller | 431e42d906a3: Verifying Checksum
2025-12-09 00:22:02.864914 | controller | 431e42d906a3: Download complete
2025-12-09 00:22:02.864953 | controller | 7a0fd3b1d7c3: Verifying Checksum
2025-12-09 00:22:03.333000 | controller | 7a0fd3b1d7c3: Download complete
2025-12-09 00:22:03.333048 | controller | aacdb6db0c8c: Verifying Checksum
2025-12-09 00:22:03.742731 | controller | aacdb6db0c8c: Download complete
2025-12-09 00:22:03.742766 | controller | 2e7f04ae8c8b: Verifying Checksum
2025-12-09 00:22:04.116106 | controller | 2e7f04ae8c8b: Download complete
2025-12-09 00:22:04.116147 | controller | 4cd343027a44: Download complete
2025-12-09 00:22:04.297852 | controller | 3fb967a6fd03: Pull complete
2025-12-09 00:22:04.340814 | controller | b3e63023ca5f: Pull complete
2025-12-09 00:22:04.383807 | controller | 653cb3e65dbf: Pull complete
2025-12-09 00:22:04.767498 | controller | 0b4379883f90: Verifying Checksum
2025-12-09 00:22:05.066973 | controller | 0b4379883f90: Download complete
2025-12-09 00:22:05.067124 | controller | 3d9d6d9dfc91: Verifying Checksum
2025-12-09 00:22:06.308378 | controller | 3d9d6d9dfc91: Download complete
2025-12-09 00:22:06.308446 | controller | 57d6314bd293: Verifying Checksum
2025-12-09 00:22:06.828267 | controller | 57d6314bd293: Download complete
2025-12-09 00:22:06.828350 | controller | cef8beb99552: Verifying Checksum
2025-12-09 00:22:07.749348 | controller | cef8beb99552: Download complete
2025-12-09 00:22:07.749397 | controller | 774036afeb7f: Verifying Checksum
2025-12-09 00:22:10.239505 | controller | 774036afeb7f: Download complete
2025-12-09 00:22:10.239557 | controller | f4712b586375: Verifying Checksum
2025-12-09 00:22:10.401322 | controller | f4712b586375: Download complete
2025-12-09 00:22:10.401362 | controller | 54b10f0e1645: Verifying Checksum
2025-12-09 00:22:11.184939 | controller | 54b10f0e1645: Download complete
2025-12-09 00:22:11.185025 | controller | 36e5e20969c7: Verifying Checksum
2025-12-09 00:22:11.185144 | controller | 36e5e20969c7: Download complete
2025-12-09 00:22:12.244166 | controller | 78cf439d9fdb: Verifying Checksum
2025-12-09 00:22:12.244259 | controller | 78cf439d9fdb: Download complete
2025-12-09 00:22:13.601473 | controller | 4b19ac3f17a8: Verifying Checksum
2025-12-09 00:22:13.601626 | controller | 4b19ac3f17a8: Download complete
2025-12-09 00:22:20.848119 | controller | f4712b586375: Pull complete
2025-12-09 00:22:20.876891 | controller | d696ed7812f8: Pull complete
2025-12-09 00:22:20.893457 | controller | 29bf28764f14: Pull complete
2025-12-09 00:22:20.927140 | controller | 47d7edb3c2b7: Pull complete
2025-12-09 00:22:20.947684 | controller | 07550ad4f6e4: Pull complete
2025-12-09 00:22:20.967825 | controller | 7e79526e64c5: Pull complete
2025-12-09 00:22:20.987573 | controller | 4fffb32882b7: Pull complete
2025-12-09 00:22:21.032778 | controller | fc7a38b06f4e: Pull complete
2025-12-09 00:22:21.050203 | controller | 6d9d912e060e: Pull complete
2025-12-09 00:22:21.070178 | controller | 5dd542dd28d9: Pull complete
2025-12-09 00:22:32.566501 | controller | cef8beb99552: Pull complete
2025-12-09 00:22:32.598301 | controller | bd5557e101ad: Pull complete
2025-12-09 00:22:32.620873 | controller | e057c20fabdd: Pull complete
2025-12-09 00:22:32.645086 | controller | d16059cdae2e: Pull complete
2025-12-09 00:22:33.937818 | controller | 431e42d906a3: Pull complete
2025-12-09 00:22:34.003198 | controller | 7a0fd3b1d7c3: Pull complete
2025-12-09 00:22:34.052836 | controller | aacdb6db0c8c: Pull complete
2025-12-09 00:22:34.081626 | controller | 2e7f04ae8c8b: Pull complete
2025-12-09 00:22:34.104598 | controller | 4cd343027a44: Pull complete
2025-12-09 00:22:34.126753 | controller | 0b4379883f90: Pull complete
2025-12-09 00:22:34.155868 | controller | 3d9d6d9dfc91: Pull complete
2025-12-09 00:22:38.296468 | controller | 57d6314bd293: Pull complete
2025-12-09 00:22:50.086996 | controller | 774036afeb7f: Pull complete
2025-12-09 00:27:38.281431 | [Zuul] Log Stream did not terminate
2025-12-09 00:27:38.281803 | controller | ERROR
2025-12-09 00:27:38.281976 | controller | {
2025-12-09 00:27:38.282033 | controller |   "msg": "Data could not be sent to remote host \"162.253.55.187\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.187 port 22: Connection timed out\r\n",
2025-12-09 00:27:38.282077 | controller |   "unreachable": true
2025-12-09 00:27:38.282116 | controller | }
unreachable
2025-12-09 00:27:38.284540 | 
2025-12-09 00:27:38.284657 | PLAY RECAP
2025-12-09 00:27:38.284782 | controller | ok: 21 changed: 6 unreachable: 1 failed: 0 skipped: 20 rescued: 0 ignored: 1
2025-12-09 00:27:38.284846 | 
2025-12-09 00:27:38.419989 | RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/run.yaml@master]
2025-12-09 00:27:38.421195 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-12-09 00:27:39.036326 | 
2025-12-09 00:27:39.036444 | PLAY [all]
2025-12-09 00:27:39.060563 | 
2025-12-09 00:27:39.060657 | TASK [fetch-subunit-output : Find stestr or testr executable]
2025-12-09 00:27:57.192394 | controller | changed: non-zero return code
2025-12-09 00:27:57.205663 | 
2025-12-09 00:27:57.205863 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2025-12-09 00:27:57.233863 | controller | skipping: Conditional result was False
2025-12-09 00:27:57.248258 | 
2025-12-09 00:27:57.248429 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2025-12-09 00:27:57.292062 | 
2025-12-09 00:27:57.292351 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2025-12-09 00:27:57.332990 | 
2025-12-09 00:27:57.333256 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2025-12-09 00:27:57.360989 | controller | skipping: Conditional result was False
2025-12-09 00:27:57.374864 | 
2025-12-09 00:27:57.375034 | LOOP [fetch-subunit-output : Generate subunit file]
2025-12-09 00:27:57.415345 | 
2025-12-09 00:27:57.415660 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2025-12-09 00:27:57.432565 | controller | skipping: Conditional result was False
2025-12-09 00:27:57.448613 | 
2025-12-09 00:27:57.448836 | TASK [fetch-subunit-output : Remove the temporary file]
2025-12-09 00:27:57.475032 | controller | skipping: Conditional result was False
2025-12-09 00:27:57.483818 | 
2025-12-09 00:27:57.483913 | TASK [fetch-subunit-output : Process and fetch subunit results]
2025-12-09 00:27:57.508579 | controller | skipping: Conditional result was False
2025-12-09 00:27:57.547952 | 
2025-12-09 00:27:57.548039 | PLAY RECAP
2025-12-09 00:27:57.548094 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-12-09 00:27:57.548139 | 
2025-12-09 00:27:57.637030 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-12-09 00:27:57.637898 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2025-12-09 00:27:58.205207 | 
2025-12-09 00:27:58.205314 | PLAY [all:!appliance*]
2025-12-09 00:27:58.227147 | 
2025-12-09 00:27:58.227255 | TASK [unregister the node]
2025-12-09 00:27:58.759486 | controller | skipping: Conditional result was False
2025-12-09 00:27:58.772518 | 
2025-12-09 00:27:58.772684 | TASK [include_role : fetch-output]
2025-12-09 00:27:58.825894 | controller | ok
2025-12-09 00:27:58.868260 | 
2025-12-09 00:27:58.868410 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-09 00:27:58.924440 | controller | skipping: Conditional result was False
2025-12-09 00:27:58.938436 | 
2025-12-09 00:27:58.938636 | TASK [fetch-output : Set log path for single node]
2025-12-09 00:27:58.979375 | controller | ok
2025-12-09 00:27:58.992575 | 
2025-12-09 00:27:58.992718 | LOOP [fetch-output : Ensure local output dirs]
2025-12-09 00:27:59.458117 | controller -> localhost | ok: "/var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/logs"
2025-12-09 00:27:59.700095 | controller -> localhost | changed: "/var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/artifacts"
2025-12-09 00:27:59.929786 | controller -> localhost | changed: "/var/lib/zuul/builds/231367469fd94ddc817e92f58526baf0/work/docs"
2025-12-09 00:27:59.949519 | 
2025-12-09 00:27:59.949699 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-09 00:28:00.671059 | controller | changed:
2025-12-09 00:28:00.671632 | controller | .d..t...... ./
2025-12-09 00:28:00.671778 | controller | cd+++++++++ controller/
2025-12-09 00:28:00.671913 | controller | changed: All items complete
2025-12-09 00:28:00.671999 | 
2025-12-09 00:28:01.259228 | controller | changed: .d..t...... ./
2025-12-09 00:28:01.785205 | controller | changed: .d..t...... ./
2025-12-09 00:28:01.822318 | 
2025-12-09 00:28:01.822506 | TASK [include_role : fetch-output-openshift]
2025-12-09 00:28:01.850146 | controller | skipping: Conditional result was False
2025-12-09 00:28:01.864312 | 
2025-12-09 00:28:01.864461 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-12-09 00:28:01.912972 | controller | skipping: Conditional result was False
2025-12-09 00:28:01.925950 | controller | skipping: Conditional result was False
2025-12-09 00:28:01.988388 | 
2025-12-09 00:28:01.988507 | PLAY [localhost]
2025-12-09 00:28:02.006060 | 
2025-12-09 00:28:02.006150 | TASK [Run Zuul manifest role]
2025-12-09 00:28:02.028183 | localhost | ok
2025-12-09 00:28:02.048686 | 
2025-12-09 00:28:02.048813 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-12-09 00:28:02.578017 | localhost | changed
2025-12-09 00:28:02.582930 | 
2025-12-09 00:28:02.582994 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-12-09 00:28:02.624219 | localhost | ok
2025-12-09 00:28:02.636080 | 
2025-12-09 00:28:02.636173 | TASK [Set zuul-log-path fact]
2025-12-09 00:28:02.658564 | localhost | ok
2025-12-09 00:28:02.678968 | 
2025-12-09 00:28:02.679071 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-09 00:28:02.719153 | localhost | ok
2025-12-09 00:28:02.727447 | 
2025-12-09 00:28:02.727509 | LOOP [Run upload-logs-swift role]
2025-12-09 00:28:02.775389 | localhost | Output suppressed because no_log was given
2025-12-09 00:28:02.827628 | 
2025-12-09 00:28:02.827787 | TASK [Set zuul-log-path fact]
2025-12-09 00:28:02.864246 | localhost | skipping: Conditional result was False
2025-12-09 00:28:02.872009 | 
2025-12-09 00:28:02.872102 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2025-12-09 00:28:03.288542 | localhost -> localhost | ok: Runtime: 0:00:00.009154
2025-12-09 00:28:03.317053 | 
2025-12-09 00:28:03.317175 | TASK [upload-logs-swift : Upload logs to swift]