2025-12-06 00:16:51.671434 | Job console starting... 2025-12-06 00:16:51.683210 | Updating repositories 2025-12-06 00:16:51.865244 | Preparing job workspace 2025-12-06 00:16:56.315200 | Running Ansible setup... 2025-12-06 00:17:01.306657 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-12-06 00:17:02.030417 | 2025-12-06 00:17:02.030592 | PLAY [localhost] 2025-12-06 00:17:02.039678 | 2025-12-06 00:17:02.039794 | TASK [Gathering Facts] 2025-12-06 00:17:03.066700 | localhost | ok 2025-12-06 00:17:03.086827 | 2025-12-06 00:17:03.086998 | TASK [Setup log path fact] 2025-12-06 00:17:03.104654 | localhost | ok 2025-12-06 00:17:03.116818 | 2025-12-06 00:17:03.116941 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-06 00:17:03.147034 | localhost | ok 2025-12-06 00:17:03.154893 | 2025-12-06 00:17:03.154968 | TASK [emit-job-header : Print job information] 2025-12-06 00:17:03.192483 | # Job Information 2025-12-06 00:17:03.192649 | Ansible Version: 2.15.12 2025-12-06 00:17:03.192679 | Job: ansible-test-sanity-docker-devel 2025-12-06 00:17:03.192700 | Pipeline: periodic 2025-12-06 00:17:03.192718 | Executor: ze03.softwarefactory-project.io 2025-12-06 00:17:03.192756 | Triggered by: https://github.com/ansible-collections/ansible.network 2025-12-06 00:17:03.192778 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/f7f/ansible/f7faaed68b1f419aa9be3fb5690d9024/ 2025-12-06 00:17:03.192797 | Event ID: a444be38dc2a48ab869f0b68785b4d55 2025-12-06 00:17:03.196414 | 2025-12-06 00:17:03.196474 | LOOP [emit-job-header : Print node information] 2025-12-06 00:17:03.321492 | localhost | ok: 2025-12-06 00:17:03.322015 | localhost | # Node Information 2025-12-06 00:17:03.322081 | localhost | Inventory Hostname: controller 2025-12-06 00:17:03.322128 | localhost | Hostname: np0005548499 2025-12-06 00:17:03.322172 | localhost | Username: zuul 2025-12-06 00:17:03.322229 | localhost | Distro: Fedora 37 2025-12-06 00:17:03.322273 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-12-06 00:17:03.322313 | localhost | Region: ca-ymq-1 2025-12-06 00:17:03.322517 | localhost | Label: ansible-fedora-37-1vcpu 2025-12-06 00:17:03.322574 | localhost | Product Name: OpenStack Nova 2025-12-06 00:17:03.322618 | localhost | Interface IP: 162.253.55.140 2025-12-06 00:17:03.355538 | 2025-12-06 00:17:03.355741 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-06 00:17:03.756018 | localhost -> localhost | changed 2025-12-06 00:17:03.762427 | 2025-12-06 00:17:03.762506 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-06 00:17:04.612500 | localhost -> localhost | changed 2025-12-06 00:17:04.634108 | 2025-12-06 00:17:04.634227 | PLAY [all:!appliance*] 2025-12-06 00:17:04.652858 | 2025-12-06 00:17:04.653005 | TASK [include_role : start-zuul-console] 2025-12-06 00:17:04.675806 | controller | ok 2025-12-06 00:17:04.696132 | 2025-12-06 00:17:04.696287 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-06 00:17:05.117326 | controller | ok 2025-12-06 00:17:05.137973 | 2025-12-06 00:17:05.138116 | TASK [use-our-mirror : Retrieve the IP address] 2025-12-06 00:17:06.182170 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-12-06 00:17:06.199319 | 2025-12-06 00:17:06.199460 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-12-06 00:17:06.746627 | controller | skipping: Conditional result was False 2025-12-06 00:17:06.754460 | 2025-12-06 00:17:06.754566 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-12-06 00:17:06.800023 | controller | skipping: Conditional result was False 2025-12-06 00:17:06.807664 | 2025-12-06 00:17:06.807828 | TASK [use-our-mirror : Create the podman configuration directory] 2025-12-06 00:17:06.863182 | controller | skipping: Conditional result was False 2025-12-06 00:17:06.870540 | 2025-12-06 00:17:06.870622 | TASK [use-our-mirror : Copy the podman configuration] 2025-12-06 00:17:06.896497 | controller | skipping: Conditional result was False 2025-12-06 00:17:06.914001 | 2025-12-06 00:17:06.914149 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-12-06 00:17:06.958342 | controller | skipping: Conditional result was False 2025-12-06 00:17:06.967034 | 2025-12-06 00:17:06.967118 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-12-06 00:17:06.993435 | controller | skipping: Conditional result was False 2025-12-06 00:17:07.009706 | 2025-12-06 00:17:07.009957 | TASK [Disable Fedora Modular] 2025-12-06 00:17:07.266391 | controller | changed 2025-12-06 00:17:07.281010 | 2025-12-06 00:17:07.281289 | TASK [Enable EPEL] 2025-12-06 00:17:07.308200 | controller | skipping: Conditional result was False 2025-12-06 00:17:07.317886 | 2025-12-06 00:17:07.317978 | TASK [Register the RHEL node] 2025-12-06 00:17:07.873319 | 2025-12-06 00:17:07.873633 | TASK [Show the subscription-manager status] 2025-12-06 00:17:08.451980 | controller | skipping: Conditional result was False 2025-12-06 00:17:08.470147 | 2025-12-06 00:17:08.470306 | TASK [Enable EPEL on RHEL] 2025-12-06 00:17:09.022469 | controller | skipping: Conditional result was False 2025-12-06 00:17:09.039706 | 2025-12-06 00:17:09.039929 | TASK [Install git and tox] 2025-12-06 00:18:29.207441 | controller | changed 2025-12-06 00:18:29.222047 | 2025-12-06 00:18:29.222180 | TASK [include_role : prepare-workspace] 2025-12-06 00:18:29.264060 | controller | ok 2025-12-06 00:18:29.297601 | 2025-12-06 00:18:29.297698 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-12-06 00:18:29.550833 | controller | ok 2025-12-06 00:18:29.564972 | 2025-12-06 00:18:29.565109 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-12-06 00:18:42.129484 | controller | Output suppressed because no_log was given 2025-12-06 00:18:42.195791 | 2025-12-06 00:18:42.195934 | TASK [include_role : prepare-workspace-openshift] 2025-12-06 00:18:42.214127 | controller | skipping: Conditional result was False 2025-12-06 00:18:42.244485 | 2025-12-06 00:18:42.244589 | PLAY [all:!appliance] 2025-12-06 00:18:42.262460 | 2025-12-06 00:18:42.262575 | TASK [Run add-build-sshkey role (RSA)] 2025-12-06 00:18:42.284664 | controller | ok 2025-12-06 00:18:42.306402 | 2025-12-06 00:18:42.306535 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-06 00:18:42.556136 | controller -> localhost | ok 2025-12-06 00:18:42.564038 | 2025-12-06 00:18:42.564116 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-06 00:18:42.595587 | controller | ok 2025-12-06 00:18:42.611219 | controller | included: /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-06 00:18:42.617655 | 2025-12-06 00:18:42.617750 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-06 00:18:43.039051 | controller -> localhost | Generating public/private rsa key pair. 2025-12-06 00:18:43.039280 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/f7faaed68b1f419aa9be3fb5690d9024_id_rsa. 2025-12-06 00:18:43.039320 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/f7faaed68b1f419aa9be3fb5690d9024_id_rsa.pub. 2025-12-06 00:18:43.039343 | controller -> localhost | The key fingerprint is: 2025-12-06 00:18:43.039362 | controller -> localhost | SHA256:l0FLqxzmv/4tPtJIUSOMkZPNB6SecQzF32oqvKxiUnk zuul-build-sshkey 2025-12-06 00:18:43.039381 | controller -> localhost | The key's randomart image is: 2025-12-06 00:18:43.039399 | controller -> localhost | +---[RSA 2048]----+ 2025-12-06 00:18:43.039417 | controller -> localhost | | o%*. | 2025-12-06 00:18:43.039435 | controller -> localhost | | =**o+ | 2025-12-06 00:18:43.039452 | controller -> localhost | | =.*= o | 2025-12-06 00:18:43.039469 | controller -> localhost | | = *.o. . | 2025-12-06 00:18:43.039486 | controller -> localhost | | . S o. . | 2025-12-06 00:18:43.039515 | controller -> localhost | | o E o. o | 2025-12-06 00:18:43.039537 | controller -> localhost | | . . . ..= | 2025-12-06 00:18:43.039556 | controller -> localhost | | . o .o +.+. | 2025-12-06 00:18:43.039574 | controller -> localhost | | o ...o+o+oo. | 2025-12-06 00:18:43.039594 | controller -> localhost | +----[SHA256]-----+ 2025-12-06 00:18:43.039643 | controller -> localhost | ok: Runtime: 0:00:00.056464 2025-12-06 00:18:43.047754 | 2025-12-06 00:18:43.047825 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-06 00:18:43.095187 | controller | ok 2025-12-06 00:18:43.108096 | controller | included: /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-06 00:18:43.119819 | 2025-12-06 00:18:43.119901 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-06 00:18:43.146646 | controller | skipping: Conditional result was False 2025-12-06 00:18:43.156348 | 2025-12-06 00:18:43.156433 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-06 00:18:43.632314 | controller | changed 2025-12-06 00:18:43.647131 | 2025-12-06 00:18:43.647382 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-06 00:18:43.881682 | controller | ok 2025-12-06 00:18:43.894011 | 2025-12-06 00:18:43.894512 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-06 00:18:44.573241 | controller | changed 2025-12-06 00:18:44.582865 | 2025-12-06 00:18:44.582960 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-06 00:18:45.193331 | controller | changed 2025-12-06 00:18:45.203712 | 2025-12-06 00:18:45.203856 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-06 00:18:45.243056 | controller | skipping: Conditional result was False 2025-12-06 00:18:45.253296 | 2025-12-06 00:18:45.253399 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-06 00:18:45.720024 | controller -> localhost | changed 2025-12-06 00:18:45.733995 | 2025-12-06 00:18:45.734069 | TASK [add-build-sshkey : Add back temp key] 2025-12-06 00:18:45.984259 | controller -> localhost | Identity added: /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/f7faaed68b1f419aa9be3fb5690d9024_id_rsa (zuul-build-sshkey) 2025-12-06 00:18:45.984604 | controller -> localhost | ok: Runtime: 0:00:00.008594 2025-12-06 00:18:45.992358 | 2025-12-06 00:18:45.992440 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-06 00:18:46.448837 | controller | ok 2025-12-06 00:18:46.461905 | 2025-12-06 00:18:46.462044 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-06 00:18:46.502903 | controller | skipping: Conditional result was False 2025-12-06 00:18:46.521836 | 2025-12-06 00:18:46.521934 | TASK [Run add-build-sshkey role (ECDSA)] 2025-12-06 00:18:46.558084 | controller | ok 2025-12-06 00:18:46.581271 | 2025-12-06 00:18:46.581369 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-06 00:18:46.833176 | controller -> localhost | ok 2025-12-06 00:18:46.841434 | 2025-12-06 00:18:46.841505 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-06 00:18:46.876477 | controller | ok 2025-12-06 00:18:46.894710 | controller | included: /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-06 00:18:46.904225 | 2025-12-06 00:18:46.904400 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-06 00:18:47.235689 | controller -> localhost | Generating public/private ecdsa key pair. 2025-12-06 00:18:47.236120 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/f7faaed68b1f419aa9be3fb5690d9024_id_ecdsa. 2025-12-06 00:18:47.236153 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/f7faaed68b1f419aa9be3fb5690d9024_id_ecdsa.pub. 2025-12-06 00:18:47.236188 | controller -> localhost | The key fingerprint is: 2025-12-06 00:18:47.236208 | controller -> localhost | SHA256:0kfeAaRPFtKzeAOww5crmkaTo+zXDNbccdexOLAxYzU zuul-build-sshkey 2025-12-06 00:18:47.236229 | controller -> localhost | The key's randomart image is: 2025-12-06 00:18:47.236248 | controller -> localhost | +---[ECDSA 521]---+ 2025-12-06 00:18:47.236267 | controller -> localhost | | ...o+.E | 2025-12-06 00:18:47.236286 | controller -> localhost | | . ..+Oo .. | 2025-12-06 00:18:47.236304 | controller -> localhost | | + +++O.o o | 2025-12-06 00:18:47.236321 | controller -> localhost | | . +oB*.+.o | 2025-12-06 00:18:47.236339 | controller -> localhost | | =oo.S++o.. | 2025-12-06 00:18:47.236357 | controller -> localhost | | . oo=oo.. | 2025-12-06 00:18:47.236376 | controller -> localhost | | o.++ | 2025-12-06 00:18:47.236394 | controller -> localhost | | . .. o | 2025-12-06 00:18:47.236413 | controller -> localhost | | .. | 2025-12-06 00:18:47.236431 | controller -> localhost | +----[SHA256]-----+ 2025-12-06 00:18:47.236505 | controller -> localhost | ok: Runtime: 0:00:00.009855 2025-12-06 00:18:47.244284 | 2025-12-06 00:18:47.244368 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-06 00:18:47.276851 | controller | ok 2025-12-06 00:18:47.284636 | controller | included: /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-06 00:18:47.294664 | 2025-12-06 00:18:47.294755 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-06 00:18:47.330064 | controller | skipping: Conditional result was False 2025-12-06 00:18:47.337271 | 2025-12-06 00:18:47.337345 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-06 00:18:47.631100 | controller | changed 2025-12-06 00:18:47.645573 | 2025-12-06 00:18:47.645770 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-06 00:18:47.892436 | controller | ok 2025-12-06 00:18:47.909986 | 2025-12-06 00:18:47.910170 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-06 00:18:48.571925 | controller | changed 2025-12-06 00:18:48.588236 | 2025-12-06 00:18:48.588517 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-06 00:18:49.265416 | controller | changed 2025-12-06 00:18:49.280843 | 2025-12-06 00:18:49.280988 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-06 00:18:49.311781 | controller | skipping: Conditional result was False 2025-12-06 00:18:49.385796 | 2025-12-06 00:18:49.386128 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-06 00:18:49.659265 | controller -> localhost | changed 2025-12-06 00:18:49.671537 | 2025-12-06 00:18:49.671608 | TASK [add-build-sshkey : Add back temp key] 2025-12-06 00:18:49.949697 | controller -> localhost | Identity added: /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/f7faaed68b1f419aa9be3fb5690d9024_id_ecdsa (zuul-build-sshkey) 2025-12-06 00:18:49.949955 | controller -> localhost | ok: Runtime: 0:00:00.008939 2025-12-06 00:18:49.956824 | 2025-12-06 00:18:49.956889 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-06 00:18:50.159953 | controller | ok 2025-12-06 00:18:50.168498 | 2025-12-06 00:18:50.168679 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-06 00:18:50.205004 | controller | skipping: Conditional result was False 2025-12-06 00:18:50.219298 | 2025-12-06 00:18:50.219439 | TASK [include_role : remove-zuul-sshkey] 2025-12-06 00:18:50.235908 | controller | skipping: Conditional result was False 2025-12-06 00:18:50.245529 | 2025-12-06 00:18:50.245669 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-12-06 00:18:50.478534 | controller | ok: "logs" 2025-12-06 00:18:50.478860 | controller | ok: All items complete 2025-12-06 00:18:50.478890 | 2025-12-06 00:18:50.712093 | controller | ok: "artifacts" 2025-12-06 00:18:50.913304 | controller | ok: "docs" 2025-12-06 00:18:50.926598 | 2025-12-06 00:18:50.926770 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-12-06 00:18:51.153080 | controller | changed: "logs" 2025-12-06 00:18:51.356230 | controller | changed: "artifacts" 2025-12-06 00:18:51.558209 | controller | changed: "docs" 2025-12-06 00:18:51.621105 | 2025-12-06 00:18:51.621270 | PLAY RECAP 2025-12-06 00:18:51.621335 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-12-06 00:18:51.621372 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-06 00:18:51.621396 | 2025-12-06 00:18:51.790428 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-12-06 00:18:51.792228 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-12-06 00:18:52.392644 | 2025-12-06 00:18:52.392856 | PLAY [all] 2025-12-06 00:18:52.416064 | 2025-12-06 00:18:52.416190 | TASK [Install binary dependencies] 2025-12-06 00:18:52.467150 | controller | ok 2025-12-06 00:18:52.487918 | 2025-12-06 00:18:52.488057 | TASK [bindep : Include find tasks] 2025-12-06 00:18:52.529456 | controller | ok 2025-12-06 00:18:52.537695 | controller | included: /var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2025-12-06 00:18:52.544136 | 2025-12-06 00:18:52.544201 | TASK [bindep : Look for bindep.txt] 2025-12-06 00:18:52.972272 | controller | ok 2025-12-06 00:18:52.986305 | 2025-12-06 00:18:52.986526 | TASK [bindep : Define bindep_file fact] 2025-12-06 00:18:53.013436 | controller | skipping: Conditional result was False 2025-12-06 00:18:53.031920 | 2025-12-06 00:18:53.032214 | TASK [bindep : Look for other-requirements.txt] 2025-12-06 00:18:53.250462 | controller | ok 2025-12-06 00:18:53.256365 | 2025-12-06 00:18:53.256436 | TASK [bindep : Define bindep_file fact] 2025-12-06 00:18:53.293224 | controller | skipping: Conditional result was False 2025-12-06 00:18:53.300224 | 2025-12-06 00:18:53.300298 | TASK [bindep : Look for bindep fallback file] 2025-12-06 00:18:53.329150 | controller | skipping: Conditional result was False 2025-12-06 00:18:53.338868 | 2025-12-06 00:18:53.338945 | TASK [bindep : Define bindep_file fact] 2025-12-06 00:18:53.364324 | controller | skipping: Conditional result was False 2025-12-06 00:18:53.371078 | 2025-12-06 00:18:53.371145 | TASK [bindep : Include bindep tasks] 2025-12-06 00:18:53.396426 | controller | skipping: Conditional result was False 2025-12-06 00:18:53.406642 | 2025-12-06 00:18:53.407253 | TASK [bindep : Include install tasks] 2025-12-06 00:18:53.435890 | controller | skipping: Conditional result was False 2025-12-06 00:18:53.444202 | 2025-12-06 00:18:53.444289 | LOOP [bindep : Include package tasks] 2025-12-06 00:18:53.538087 | 2025-12-06 00:18:53.538373 | TASK [Run test-setup role] 2025-12-06 00:18:53.565573 | controller | ok 2025-12-06 00:18:53.592835 | 2025-12-06 00:18:53.592968 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2025-12-06 00:18:53.820473 | controller | ok 2025-12-06 00:18:53.836573 | 2025-12-06 00:18:53.836825 | TASK [test-setup : Run tools/test-setup.sh] 2025-12-06 00:19:23.928068 | [Zuul] Log Stream did not terminate 2025-12-06 00:19:23.928377 | controller | skipping: Conditional result was False 2025-12-06 00:19:23.977852 | 2025-12-06 00:19:23.978080 | PLAY RECAP 2025-12-06 00:19:23.978171 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-06 00:19:23.978216 | 2025-12-06 00:19:24.162646 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-12-06 00:19:24.163677 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-12-06 00:19:24.845214 | 2025-12-06 00:19:24.845372 | PLAY [controller] 2025-12-06 00:19:24.868561 | 2025-12-06 00:19:24.868760 | TASK [Create the /root directory] 2025-12-06 00:21:37.236869 | controller | ERROR 2025-12-06 00:21:37.237350 | controller | { 2025-12-06 00:21:37.237437 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2025-12-06 00:21:37.237497 | controller | } failure 2025-12-06 00:21:37.239951 | 2025-12-06 00:21:37.240047 | PLAY RECAP 2025-12-06 00:21:37.240136 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-12-06 00:21:37.240186 | 2025-12-06 00:21:37.398769 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-12-06 00:21:37.402711 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-06 00:21:38.122898 | 2025-12-06 00:21:38.123050 | PLAY [all] 2025-12-06 00:21:38.145382 | 2025-12-06 00:21:38.145513 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-06 00:24:13.743089 | controller | changed: non-zero return code 2025-12-06 00:24:13.761068 | 2025-12-06 00:24:13.761300 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-06 00:24:13.789953 | controller | skipping: Conditional result was False 2025-12-06 00:24:13.801210 | 2025-12-06 00:24:13.801347 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-06 00:24:13.847759 | 2025-12-06 00:24:13.847968 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-06 00:24:13.895187 | 2025-12-06 00:24:13.895442 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-06 00:24:13.922750 | controller | skipping: Conditional result was False 2025-12-06 00:24:13.939708 | 2025-12-06 00:24:13.939921 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-06 00:24:13.977212 | 2025-12-06 00:24:13.977484 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-06 00:24:14.004468 | controller | skipping: Conditional result was False 2025-12-06 00:24:14.018256 | 2025-12-06 00:24:14.018392 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-06 00:24:14.045445 | controller | skipping: Conditional result was False 2025-12-06 00:24:14.054833 | 2025-12-06 00:24:14.054966 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-06 00:24:14.081356 | controller | skipping: Conditional result was False 2025-12-06 00:24:14.121429 | 2025-12-06 00:24:14.121591 | PLAY RECAP 2025-12-06 00:24:14.121653 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-06 00:24:14.121681 | 2025-12-06 00:24:14.338392 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-06 00:24:14.340549 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-12-06 00:24:15.017760 | 2025-12-06 00:24:15.017931 | PLAY [all:!appliance*] 2025-12-06 00:24:15.045637 | 2025-12-06 00:24:15.045833 | TASK [unregister the node] 2025-12-06 00:24:15.578178 | controller | skipping: Conditional result was False 2025-12-06 00:24:15.592343 | 2025-12-06 00:24:15.592521 | TASK [include_role : fetch-output] 2025-12-06 00:24:15.656582 | controller | ok 2025-12-06 00:24:15.702178 | 2025-12-06 00:24:15.702397 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-06 00:24:15.783030 | controller | skipping: Conditional result was False 2025-12-06 00:24:15.793642 | 2025-12-06 00:24:15.793809 | TASK [fetch-output : Set log path for single node] 2025-12-06 00:24:15.859440 | controller | ok 2025-12-06 00:24:15.869324 | 2025-12-06 00:24:15.869489 | LOOP [fetch-output : Ensure local output dirs] 2025-12-06 00:24:16.361390 | controller -> localhost | ok: "/var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/logs" 2025-12-06 00:24:16.661584 | controller -> localhost | changed: "/var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/artifacts" 2025-12-06 00:24:16.883888 | controller -> localhost | changed: "/var/lib/zuul/builds/f7faaed68b1f419aa9be3fb5690d9024/work/docs" 2025-12-06 00:24:16.903684 | 2025-12-06 00:24:16.903946 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-06 00:24:17.700254 | controller | ok 2025-12-06 00:24:17.701401 | controller | changed: All items complete 2025-12-06 00:24:17.701489 | 2025-12-06 00:24:18.218617 | controller | changed: .d..t...... ./ 2025-12-06 00:24:18.755859 | controller | changed: .d..t...... ./ 2025-12-06 00:24:18.786908 | 2025-12-06 00:24:18.787113 | TASK [include_role : fetch-output-openshift] 2025-12-06 00:24:18.803542 | controller | skipping: Conditional result was False 2025-12-06 00:24:18.813644 | 2025-12-06 00:24:18.813782 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-12-06 00:24:18.850520 | controller | skipping: Conditional result was False 2025-12-06 00:24:18.863535 | controller | skipping: Conditional result was False 2025-12-06 00:24:18.915259 | 2025-12-06 00:24:18.915429 | PLAY [localhost] 2025-12-06 00:24:18.934210 | 2025-12-06 00:24:18.934340 | TASK [Run Zuul manifest role] 2025-12-06 00:24:18.959871 | localhost | ok 2025-12-06 00:24:18.979347 | 2025-12-06 00:24:18.979491 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-06 00:24:19.430138 | localhost | changed 2025-12-06 00:24:19.434897 | 2025-12-06 00:24:19.434967 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-06 00:24:19.464707 | localhost | ok 2025-12-06 00:24:19.473928 | 2025-12-06 00:24:19.474045 | TASK [Set zuul-log-path fact] 2025-12-06 00:24:19.493166 | localhost | ok 2025-12-06 00:24:19.507533 | 2025-12-06 00:24:19.507606 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-06 00:24:19.536322 | localhost | ok 2025-12-06 00:24:19.544266 | 2025-12-06 00:24:19.544325 | LOOP [Run upload-logs-swift role] 2025-12-06 00:24:19.569008 | localhost | Output suppressed because no_log was given 2025-12-06 00:24:19.592608 | 2025-12-06 00:24:19.592691 | TASK [Set zuul-log-path fact] 2025-12-06 00:24:19.617589 | localhost | skipping: Conditional result was False 2025-12-06 00:24:19.624480 | 2025-12-06 00:24:19.624575 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-12-06 00:24:20.039856 | localhost -> localhost | ok: Runtime: 0:00:00.005418 2025-12-06 00:24:20.053289 | 2025-12-06 00:24:20.053511 | TASK [upload-logs-swift : Upload logs to swift]