2026-02-20 00:27:47.231576 | Job console starting... 2026-02-20 00:27:47.243199 | Updating repositories 2026-02-20 00:27:47.376888 | Preparing job workspace 2026-02-20 00:27:51.181392 | Running Ansible setup... 2026-02-20 00:27:55.785252 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-20 00:27:56.459681 | 2026-02-20 00:27:56.459863 | PLAY [localhost] 2026-02-20 00:27:56.470188 | 2026-02-20 00:27:56.470558 | TASK [Gathering Facts] 2026-02-20 00:27:57.461732 | localhost | ok 2026-02-20 00:27:57.507996 | 2026-02-20 00:27:57.508333 | TASK [Setup log path fact] 2026-02-20 00:27:57.537163 | localhost | ok 2026-02-20 00:27:57.567470 | 2026-02-20 00:27:57.567617 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-20 00:27:57.598276 | localhost | ok 2026-02-20 00:27:57.620823 | 2026-02-20 00:27:57.620969 | TASK [emit-job-header : Print job information] 2026-02-20 00:27:57.661763 | # Job Information 2026-02-20 00:27:57.661950 | Ansible Version: 2.15.12 2026-02-20 00:27:57.661993 | Job: ansible-test-sanity-docker-stable-2.11 2026-02-20 00:27:57.662044 | Pipeline: periodic 2026-02-20 00:27:57.662099 | Executor: ze01.softwarefactory-project.io 2026-02-20 00:27:57.662129 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-02-20 00:27:57.662160 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/3b5/ansible/3b5576ded7904938a24cfe5111038151/ 2026-02-20 00:27:57.662189 | Event ID: 6d539d67fcee4d5b96e508018f097453 2026-02-20 00:27:57.667209 | 2026-02-20 00:27:57.667287 | LOOP [emit-job-header : Print node information] 2026-02-20 00:27:57.787005 | localhost | ok: 2026-02-20 00:27:57.787225 | localhost | # Node Information 2026-02-20 00:27:57.787278 | localhost | Inventory Hostname: controller 2026-02-20 00:27:57.787320 | localhost | Hostname: np0005625048 2026-02-20 00:27:57.787360 | localhost | Username: zuul 2026-02-20 00:27:57.787409 | localhost | Distro: Fedora 37 2026-02-20 00:27:57.787450 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-20 00:27:57.787491 | localhost | Region: ca-ymq-1 2026-02-20 00:27:57.787523 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-20 00:27:57.787549 | localhost | Product Name: OpenStack Nova 2026-02-20 00:27:57.787575 | localhost | Interface IP: 162.253.55.70 2026-02-20 00:27:57.802299 | 2026-02-20 00:27:57.802454 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-20 00:27:58.238657 | localhost -> localhost | changed 2026-02-20 00:27:58.256014 | 2026-02-20 00:27:58.256201 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-20 00:27:59.149452 | localhost -> localhost | changed 2026-02-20 00:27:59.198237 | 2026-02-20 00:27:59.198385 | PLAY [all:!appliance*] 2026-02-20 00:27:59.235088 | 2026-02-20 00:27:59.235231 | TASK [include_role : start-zuul-console] 2026-02-20 00:27:59.254542 | controller | ok 2026-02-20 00:27:59.268733 | 2026-02-20 00:27:59.268827 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-20 00:27:59.653019 | controller | ok 2026-02-20 00:27:59.693391 | 2026-02-20 00:27:59.693575 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-20 00:28:00.721888 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-20 00:28:00.730252 | 2026-02-20 00:28:00.730358 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-20 00:28:01.270477 | controller | skipping: Conditional result was False 2026-02-20 00:28:01.277292 | 2026-02-20 00:28:01.277379 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-20 00:28:01.301333 | controller | skipping: Conditional result was False 2026-02-20 00:28:01.308446 | 2026-02-20 00:28:01.308556 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-20 00:28:01.332857 | controller | skipping: Conditional result was False 2026-02-20 00:28:01.340166 | 2026-02-20 00:28:01.340259 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-20 00:28:01.364848 | controller | skipping: Conditional result was False 2026-02-20 00:28:01.372953 | 2026-02-20 00:28:01.373086 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-20 00:28:01.403285 | controller | skipping: Conditional result was False 2026-02-20 00:28:01.413264 | 2026-02-20 00:28:01.413403 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-20 00:28:01.438483 | controller | skipping: Conditional result was False 2026-02-20 00:28:01.456350 | 2026-02-20 00:28:01.456487 | TASK [Disable Fedora Modular] 2026-02-20 00:28:01.691805 | controller | changed 2026-02-20 00:28:01.698721 | 2026-02-20 00:28:01.698818 | TASK [Enable EPEL] 2026-02-20 00:28:01.723553 | controller | skipping: Conditional result was False 2026-02-20 00:28:01.730692 | 2026-02-20 00:28:01.730811 | TASK [Register the RHEL node] 2026-02-20 00:28:02.281003 | 2026-02-20 00:28:02.281228 | TASK [Show the subscription-manager status] 2026-02-20 00:28:02.900134 | controller | skipping: Conditional result was False 2026-02-20 00:28:02.919642 | 2026-02-20 00:28:02.919824 | TASK [Enable EPEL on RHEL] 2026-02-20 00:28:03.485726 | controller | skipping: Conditional result was False 2026-02-20 00:28:03.500730 | 2026-02-20 00:28:03.500914 | TASK [Install git and tox] 2026-02-20 00:29:20.882837 | controller | changed 2026-02-20 00:29:20.889303 | 2026-02-20 00:29:20.889381 | TASK [include_role : prepare-workspace] 2026-02-20 00:29:20.915888 | controller | ok 2026-02-20 00:29:20.944626 | 2026-02-20 00:29:20.944740 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-20 00:29:21.211007 | controller | ok 2026-02-20 00:29:21.220295 | 2026-02-20 00:29:21.220388 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-20 00:29:34.254809 | controller | Output suppressed because no_log was given 2026-02-20 00:29:34.266175 | 2026-02-20 00:29:34.266334 | TASK [include_role : prepare-workspace-openshift] 2026-02-20 00:29:34.282437 | controller | skipping: Conditional result was False 2026-02-20 00:29:34.305548 | 2026-02-20 00:29:34.305635 | PLAY [all:!appliance] 2026-02-20 00:29:34.322765 | 2026-02-20 00:29:34.322858 | TASK [Run add-build-sshkey role (RSA)] 2026-02-20 00:29:34.342315 | controller | ok 2026-02-20 00:29:34.357385 | 2026-02-20 00:29:34.357507 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-20 00:29:34.602439 | controller -> localhost | ok 2026-02-20 00:29:34.617381 | 2026-02-20 00:29:34.617590 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-20 00:29:34.659238 | controller | ok 2026-02-20 00:29:34.685511 | controller | included: /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-20 00:29:34.694572 | 2026-02-20 00:29:34.694683 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-20 00:29:35.159656 | controller -> localhost | Generating public/private rsa key pair. 2026-02-20 00:29:35.159950 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/3b5576ded7904938a24cfe5111038151_id_rsa. 2026-02-20 00:29:35.159992 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/3b5576ded7904938a24cfe5111038151_id_rsa.pub. 2026-02-20 00:29:35.160050 | controller -> localhost | The key fingerprint is: 2026-02-20 00:29:35.160082 | controller -> localhost | SHA256:+T8hbUdSle2WPupW84IlqYLpWj147a1062lT9AsCX/Y zuul-build-sshkey 2026-02-20 00:29:35.160109 | controller -> localhost | The key's randomart image is: 2026-02-20 00:29:35.160136 | controller -> localhost | +---[RSA 2048]----+ 2026-02-20 00:29:35.160162 | controller -> localhost | | .+| 2026-02-20 00:29:35.160188 | controller -> localhost | | ...| 2026-02-20 00:29:35.160213 | controller -> localhost | | . ..| 2026-02-20 00:29:35.160239 | controller -> localhost | | o .oo.o| 2026-02-20 00:29:35.160264 | controller -> localhost | | S o.o=oo | 2026-02-20 00:29:35.160303 | controller -> localhost | | o o.o*.+E.| 2026-02-20 00:29:35.160338 | controller -> localhost | | oo+ ++oB+ =| 2026-02-20 00:29:35.160366 | controller -> localhost | | .o..+.+==...| 2026-02-20 00:29:35.160393 | controller -> localhost | | .o. .o+O+ . | 2026-02-20 00:29:35.160423 | controller -> localhost | +----[SHA256]-----+ 2026-02-20 00:29:35.160499 | controller -> localhost | ok: Runtime: 0:00:00.050925 2026-02-20 00:29:35.173234 | 2026-02-20 00:29:35.173385 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-20 00:29:35.204975 | controller | ok 2026-02-20 00:29:35.215132 | controller | included: /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-20 00:29:35.224404 | 2026-02-20 00:29:35.224487 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-20 00:29:35.248762 | controller | skipping: Conditional result was False 2026-02-20 00:29:35.256202 | 2026-02-20 00:29:35.256279 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-20 00:29:35.724940 | controller | changed 2026-02-20 00:29:35.735847 | 2026-02-20 00:29:35.735939 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-20 00:29:35.981469 | controller | ok 2026-02-20 00:29:35.996941 | 2026-02-20 00:29:35.997210 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-20 00:29:36.639421 | controller | changed 2026-02-20 00:29:36.646850 | 2026-02-20 00:29:36.647124 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-20 00:29:37.286811 | controller | changed 2026-02-20 00:29:37.296894 | 2026-02-20 00:29:37.297081 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-20 00:29:37.313407 | controller | skipping: Conditional result was False 2026-02-20 00:29:37.325213 | 2026-02-20 00:29:37.325369 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-20 00:29:37.720880 | controller -> localhost | changed 2026-02-20 00:29:37.733655 | 2026-02-20 00:29:37.733737 | TASK [add-build-sshkey : Add back temp key] 2026-02-20 00:29:38.056369 | controller -> localhost | Identity added: /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/3b5576ded7904938a24cfe5111038151_id_rsa (zuul-build-sshkey) 2026-02-20 00:29:38.056734 | controller -> localhost | ok: Runtime: 0:00:00.015745 2026-02-20 00:29:38.071700 | 2026-02-20 00:29:38.071996 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-20 00:29:38.443136 | controller | ok 2026-02-20 00:29:38.449008 | 2026-02-20 00:29:38.449177 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-20 00:29:38.486305 | controller | skipping: Conditional result was False 2026-02-20 00:29:38.501649 | 2026-02-20 00:29:38.501859 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-20 00:29:38.536010 | controller | ok 2026-02-20 00:29:38.559706 | 2026-02-20 00:29:38.559846 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-20 00:29:38.860643 | controller -> localhost | ok 2026-02-20 00:29:38.867833 | 2026-02-20 00:29:38.867970 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-20 00:29:38.892003 | controller | ok 2026-02-20 00:29:38.910759 | controller | included: /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-20 00:29:38.917976 | 2026-02-20 00:29:38.918145 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-20 00:29:39.211229 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-20 00:29:39.211690 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/3b5576ded7904938a24cfe5111038151_id_ecdsa. 2026-02-20 00:29:39.211755 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/3b5576ded7904938a24cfe5111038151_id_ecdsa.pub. 2026-02-20 00:29:39.211820 | controller -> localhost | The key fingerprint is: 2026-02-20 00:29:39.211866 | controller -> localhost | SHA256:boJeRCgvzbtCIh6jMn4cHEIdDfh8tae7tT2IwPaZGaU zuul-build-sshkey 2026-02-20 00:29:39.211910 | controller -> localhost | The key's randomart image is: 2026-02-20 00:29:39.211953 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-20 00:29:39.211993 | controller -> localhost | | oo+ | 2026-02-20 00:29:39.212093 | controller -> localhost | | o . o . | 2026-02-20 00:29:39.212226 | controller -> localhost | |. + . o . | 2026-02-20 00:29:39.212281 | controller -> localhost | | . O o . o | 2026-02-20 00:29:39.212323 | controller -> localhost | | + B . S | 2026-02-20 00:29:39.212363 | controller -> localhost | |oo.+ B E | 2026-02-20 00:29:39.212403 | controller -> localhost | |+o+ = = X.. | 2026-02-20 00:29:39.212441 | controller -> localhost | |+..+ o X..o. | 2026-02-20 00:29:39.212481 | controller -> localhost | |oo..o ... .. | 2026-02-20 00:29:39.212520 | controller -> localhost | +----[SHA256]-----+ 2026-02-20 00:29:39.212638 | controller -> localhost | ok: Runtime: 0:00:00.015603 2026-02-20 00:29:39.231381 | 2026-02-20 00:29:39.231582 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-20 00:29:39.269121 | controller | ok 2026-02-20 00:29:39.281107 | controller | included: /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-20 00:29:39.298596 | 2026-02-20 00:29:39.298756 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-20 00:29:39.323918 | controller | skipping: Conditional result was False 2026-02-20 00:29:39.333818 | 2026-02-20 00:29:39.333949 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-20 00:29:39.627835 | controller | changed 2026-02-20 00:29:39.642534 | 2026-02-20 00:29:39.642734 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-20 00:29:39.896905 | controller | ok 2026-02-20 00:29:39.912511 | 2026-02-20 00:29:39.912721 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-20 00:29:40.582380 | controller | changed 2026-02-20 00:29:40.597400 | 2026-02-20 00:29:40.597640 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-20 00:29:41.264520 | controller | changed 2026-02-20 00:29:41.273860 | 2026-02-20 00:29:41.274007 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-20 00:29:41.301130 | controller | skipping: Conditional result was False 2026-02-20 00:29:41.359368 | 2026-02-20 00:29:41.359519 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-20 00:29:41.610775 | controller -> localhost | changed 2026-02-20 00:29:41.624762 | 2026-02-20 00:29:41.624897 | TASK [add-build-sshkey : Add back temp key] 2026-02-20 00:29:41.936741 | controller -> localhost | Identity added: /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/3b5576ded7904938a24cfe5111038151_id_ecdsa (zuul-build-sshkey) 2026-02-20 00:29:41.936994 | controller -> localhost | ok: Runtime: 0:00:00.011941 2026-02-20 00:29:41.947619 | 2026-02-20 00:29:41.947758 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-20 00:29:42.147752 | controller | ok 2026-02-20 00:29:42.159330 | 2026-02-20 00:29:42.159502 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-20 00:29:42.206141 | controller | skipping: Conditional result was False 2026-02-20 00:29:42.237123 | 2026-02-20 00:29:42.237285 | TASK [include_role : remove-zuul-sshkey] 2026-02-20 00:29:42.263822 | controller | skipping: Conditional result was False 2026-02-20 00:29:42.274737 | 2026-02-20 00:29:42.274893 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-20 00:29:42.506247 | controller | ok: "logs" 2026-02-20 00:29:42.506539 | controller | ok: All items complete 2026-02-20 00:29:42.506583 | 2026-02-20 00:29:42.705678 | controller | ok: "artifacts" 2026-02-20 00:29:42.895909 | controller | ok: "docs" 2026-02-20 00:29:42.905249 | 2026-02-20 00:29:42.905366 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-20 00:29:43.161782 | controller | changed: "logs" 2026-02-20 00:29:43.354257 | controller | changed: "artifacts" 2026-02-20 00:29:43.566386 | controller | changed: "docs" 2026-02-20 00:29:43.628563 | 2026-02-20 00:29:43.628917 | PLAY RECAP 2026-02-20 00:29:43.629194 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-20 00:29:43.629238 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-20 00:29:43.629270 | 2026-02-20 00:29:43.824763 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-20 00:29:43.826638 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-20 00:29:44.580238 | 2026-02-20 00:29:44.580387 | PLAY [all] 2026-02-20 00:29:44.606555 | 2026-02-20 00:29:44.606706 | TASK [Install binary dependencies] 2026-02-20 00:29:44.680389 | controller | ok 2026-02-20 00:29:44.708787 | 2026-02-20 00:29:44.708960 | TASK [bindep : Include find tasks] 2026-02-20 00:29:44.753661 | controller | ok 2026-02-20 00:29:44.764590 | controller | included: /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-20 00:29:44.773131 | 2026-02-20 00:29:44.773193 | TASK [bindep : Look for bindep.txt] 2026-02-20 00:29:45.133816 | controller | ok 2026-02-20 00:29:45.143132 | 2026-02-20 00:29:45.143275 | TASK [bindep : Define bindep_file fact] 2026-02-20 00:29:45.160570 | controller | skipping: Conditional result was False 2026-02-20 00:29:45.171220 | 2026-02-20 00:29:45.171384 | TASK [bindep : Look for other-requirements.txt] 2026-02-20 00:29:45.413306 | controller | ok 2026-02-20 00:29:45.422634 | 2026-02-20 00:29:45.422784 | TASK [bindep : Define bindep_file fact] 2026-02-20 00:29:45.461660 | controller | skipping: Conditional result was False 2026-02-20 00:29:45.486915 | 2026-02-20 00:29:45.487128 | TASK [bindep : Look for bindep fallback file] 2026-02-20 00:29:45.512530 | controller | skipping: Conditional result was False 2026-02-20 00:29:45.523080 | 2026-02-20 00:29:45.523199 | TASK [bindep : Define bindep_file fact] 2026-02-20 00:29:45.548114 | controller | skipping: Conditional result was False 2026-02-20 00:29:45.556625 | 2026-02-20 00:29:45.556717 | TASK [bindep : Include bindep tasks] 2026-02-20 00:29:45.582141 | controller | skipping: Conditional result was False 2026-02-20 00:29:45.591589 | 2026-02-20 00:29:45.591709 | TASK [bindep : Include install tasks] 2026-02-20 00:29:45.617334 | controller | skipping: Conditional result was False 2026-02-20 00:29:45.627880 | 2026-02-20 00:29:45.628046 | LOOP [bindep : Include package tasks] 2026-02-20 00:29:45.691241 | 2026-02-20 00:29:45.691562 | TASK [Run test-setup role] 2026-02-20 00:29:45.714761 | controller | ok 2026-02-20 00:29:45.733585 | 2026-02-20 00:29:45.733673 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-20 00:29:45.939965 | controller | ok 2026-02-20 00:29:45.948109 | 2026-02-20 00:29:45.948215 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-20 00:29:46.495947 | controller | skipping: Conditional result was False 2026-02-20 00:29:46.543593 | 2026-02-20 00:29:46.543935 | PLAY RECAP 2026-02-20 00:29:46.544007 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-20 00:29:46.544066 | 2026-02-20 00:29:46.690477 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-20 00:29:46.691482 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-20 00:29:47.349283 | 2026-02-20 00:29:47.349452 | PLAY [controller] 2026-02-20 00:29:47.371406 | 2026-02-20 00:29:47.371557 | TASK [Create the /root directory] 2026-02-20 00:29:47.757683 | controller | ok 2026-02-20 00:29:47.767782 | 2026-02-20 00:29:47.767956 | TASK [Install glibc-langpack-en] 2026-02-20 00:32:00.109204 | controller | ERROR 2026-02-20 00:32:00.109587 | controller | { 2026-02-20 00:32:00.109657 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2026-02-20 00:32:00.109707 | controller | } failure 2026-02-20 00:32:00.112402 | 2026-02-20 00:32:00.112507 | PLAY RECAP 2026-02-20 00:32:00.112629 | controller | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-20 00:32:00.112687 | 2026-02-20 00:32:00.246343 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-20 00:32:00.247385 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-20 00:32:00.868030 | 2026-02-20 00:32:00.868200 | PLAY [all] 2026-02-20 00:32:00.894205 | 2026-02-20 00:32:00.894347 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-20 00:35:09.462482 | controller | changed: non-zero return code 2026-02-20 00:35:09.468987 | 2026-02-20 00:35:09.469120 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-20 00:35:09.494605 | controller | skipping: Conditional result was False 2026-02-20 00:35:09.500792 | 2026-02-20 00:35:09.500874 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-20 00:35:09.527609 | 2026-02-20 00:35:09.527851 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-20 00:35:09.560737 | 2026-02-20 00:35:09.561095 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-20 00:35:09.575765 | controller | skipping: Conditional result was False 2026-02-20 00:35:09.584150 | 2026-02-20 00:35:09.584293 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-20 00:35:09.618250 | 2026-02-20 00:35:09.618449 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-20 00:35:09.632851 | controller | skipping: Conditional result was False 2026-02-20 00:35:09.641842 | 2026-02-20 00:35:09.641989 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-20 00:35:09.679289 | controller | skipping: Conditional result was False 2026-02-20 00:35:09.686004 | 2026-02-20 00:35:09.686166 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-20 00:35:09.710879 | controller | skipping: Conditional result was False 2026-02-20 00:35:09.739780 | 2026-02-20 00:35:09.739887 | PLAY RECAP 2026-02-20 00:35:09.739931 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-20 00:35:09.739951 | 2026-02-20 00:35:09.862576 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-20 00:35:09.863481 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-20 00:35:10.559761 | 2026-02-20 00:35:10.559902 | PLAY [all:!appliance*] 2026-02-20 00:35:10.584897 | 2026-02-20 00:35:10.585059 | TASK [unregister the node] 2026-02-20 00:35:11.126434 | controller | skipping: Conditional result was False 2026-02-20 00:35:11.132921 | 2026-02-20 00:35:11.133009 | TASK [include_role : fetch-output] 2026-02-20 00:35:11.193575 | controller | ok 2026-02-20 00:35:11.221887 | 2026-02-20 00:35:11.222004 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-20 00:35:11.270853 | controller | skipping: Conditional result was False 2026-02-20 00:35:11.277054 | 2026-02-20 00:35:11.277130 | TASK [fetch-output : Set log path for single node] 2026-02-20 00:35:11.326146 | controller | ok 2026-02-20 00:35:11.333001 | 2026-02-20 00:35:11.333082 | LOOP [fetch-output : Ensure local output dirs] 2026-02-20 00:35:12.024646 | controller -> localhost | ok: "/var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/logs" 2026-02-20 00:35:12.315648 | controller -> localhost | changed: "/var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/artifacts" 2026-02-20 00:35:12.631277 | controller -> localhost | changed: "/var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/work/docs" 2026-02-20 00:35:12.648496 | 2026-02-20 00:35:12.648684 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-20 00:35:13.370544 | controller | ok 2026-02-20 00:35:13.370747 | controller | changed: All items complete 2026-02-20 00:35:13.370778 | 2026-02-20 00:35:13.817773 | controller | changed: .d..t...... ./ 2026-02-20 00:35:14.327238 | controller | changed: .d..t...... ./ 2026-02-20 00:35:14.347001 | 2026-02-20 00:35:14.347853 | TASK [include_role : fetch-output-openshift] 2026-02-20 00:35:14.361587 | controller | skipping: Conditional result was False 2026-02-20 00:35:14.370117 | 2026-02-20 00:35:14.370280 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-20 00:35:14.401043 | controller | skipping: Conditional result was False 2026-02-20 00:35:14.410142 | controller | skipping: Conditional result was False 2026-02-20 00:35:14.450878 | 2026-02-20 00:35:14.450982 | PLAY [localhost] 2026-02-20 00:35:14.465009 | 2026-02-20 00:35:14.465112 | TASK [Run Zuul manifest role] 2026-02-20 00:35:14.483991 | localhost | ok 2026-02-20 00:35:14.497923 | 2026-02-20 00:35:14.498002 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-20 00:35:14.946946 | localhost | changed 2026-02-20 00:35:14.952194 | 2026-02-20 00:35:14.952282 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-20 00:35:14.983749 | localhost | ok 2026-02-20 00:35:14.992287 | 2026-02-20 00:35:14.992382 | TASK [Set zuul-log-path fact] 2026-02-20 00:35:15.010301 | localhost | ok 2026-02-20 00:35:15.026133 | 2026-02-20 00:35:15.026249 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-20 00:35:15.055307 | localhost | ok 2026-02-20 00:35:15.063862 | 2026-02-20 00:35:15.063955 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-20 00:35:15.087117 | localhost | ok: 2026-02-20 00:35:15.087302 | localhost | { 2026-02-20 00:35:15.087328 | localhost | "auth": { 2026-02-20 00:35:15.087346 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-20 00:35:15.087362 | localhost | "username": "9LF91O0RK7JU" 2026-02-20 00:35:15.087381 | localhost | }, 2026-02-20 00:35:15.087396 | localhost | "profile": "rackspace", 2026-02-20 00:35:15.087413 | localhost | "region_name": "IAD" 2026-02-20 00:35:15.087428 | localhost | } 2026-02-20 00:35:15.087450 | 2026-02-20 00:35:15.095231 | 2026-02-20 00:35:15.095403 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-20 00:35:15.114319 | localhost | Output suppressed because no_log was given 2026-02-20 00:35:15.128702 | 2026-02-20 00:35:15.128824 | TASK [upload-logs-failover : Initialize control vars] 2026-02-20 00:35:15.159413 | localhost | ok 2026-02-20 00:35:15.196525 | 2026-02-20 00:35:15.196649 | LOOP [upload-logs-failover : Perform log upload] 2026-02-20 00:35:15.230838 | localhost | Output suppressed because no_log was given 2026-02-20 00:35:15.245406 | localhost | included: /var/lib/zuul/builds/3b5576ded7904938a24cfe5111038151/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-20 00:35:15.253651 | 2026-02-20 00:35:15.253787 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-20 00:35:15.361601 | localhost | Output suppressed because no_log was given 2026-02-20 00:35:15.367760 | 2026-02-20 00:35:15.367830 | TASK [Upload logs to swift] 2026-02-20 00:35:15.388607 | localhost | ok 2026-02-20 00:35:15.419678 | 2026-02-20 00:35:15.419837 | TASK [Set zuul-log-path fact] 2026-02-20 00:35:15.444438 | localhost | skipping: Conditional result was False 2026-02-20 00:35:15.451588 | 2026-02-20 00:35:15.451738 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-20 00:35:15.855585 | localhost -> localhost | ok: Runtime: 0:00:00.005637 2026-02-20 00:35:15.861463 | 2026-02-20 00:35:15.861538 | TASK [upload-logs-swift : Upload logs to swift]