2025-11-14 00:15:04.624329 | Job console starting... 2025-11-14 00:15:04.636116 | Updating repositories 2025-11-14 00:15:05.577473 | Preparing job workspace 2025-11-14 00:15:09.370257 | Running Ansible setup... 2025-11-14 00:15:14.328255 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-14 00:15:15.067928 | 2025-11-14 00:15:15.068110 | PLAY [localhost] 2025-11-14 00:15:15.080231 | 2025-11-14 00:15:15.080393 | TASK [Gathering Facts] 2025-11-14 00:15:16.109131 | localhost | ok 2025-11-14 00:15:16.130219 | 2025-11-14 00:15:16.130436 | TASK [Setup log path fact] 2025-11-14 00:15:16.154292 | localhost | ok 2025-11-14 00:15:16.173921 | 2025-11-14 00:15:16.174077 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-14 00:15:16.206252 | localhost | ok 2025-11-14 00:15:16.219463 | 2025-11-14 00:15:16.219625 | TASK [emit-job-header : Print job information] 2025-11-14 00:15:16.260397 | # Job Information 2025-11-14 00:15:16.260591 | Ansible Version: 2.15.12 2025-11-14 00:15:16.260634 | Job: ansible-test-sanity-docker-stable-2.11 2025-11-14 00:15:16.260663 | Pipeline: periodic 2025-11-14 00:15:16.260689 | Executor: ze03.softwarefactory-project.io 2025-11-14 00:15:16.260714 | Triggered by: https://github.com/ansible-collections/ansible.network 2025-11-14 00:15:16.260771 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/86b/ansible/86ba9c973e9c4959932dc4ab88d6cafc/ 2025-11-14 00:15:16.260800 | Event ID: cd9e3d3ce9024090aa7497036110b86b 2025-11-14 00:15:16.266351 | 2025-11-14 00:15:16.266467 | LOOP [emit-job-header : Print node information] 2025-11-14 00:15:16.375172 | localhost | ok: 2025-11-14 00:15:16.375439 | localhost | # Node Information 2025-11-14 00:15:16.375497 | localhost | Inventory Hostname: controller 2025-11-14 00:15:16.375541 | localhost | Hostname: np0005522218 2025-11-14 00:15:16.375584 | localhost | Username: zuul 2025-11-14 00:15:16.375632 | localhost | Distro: Fedora 37 2025-11-14 00:15:16.375673 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-14 00:15:16.375712 | localhost | Region: ca-ymq-1 2025-11-14 00:15:16.375790 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-14 00:15:16.375830 | localhost | Product Name: OpenStack Nova 2025-11-14 00:15:16.375868 | localhost | Interface IP: 162.253.55.62 2025-11-14 00:15:16.388925 | 2025-11-14 00:15:16.389086 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-14 00:15:16.801388 | localhost -> localhost | changed 2025-11-14 00:15:16.809373 | 2025-11-14 00:15:16.809466 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-14 00:15:17.636811 | localhost -> localhost | changed 2025-11-14 00:15:17.659166 | 2025-11-14 00:15:17.659251 | PLAY [all:!appliance*] 2025-11-14 00:15:17.678779 | 2025-11-14 00:15:17.678902 | TASK [include_role : start-zuul-console] 2025-11-14 00:15:17.699055 | controller | ok 2025-11-14 00:15:17.715657 | 2025-11-14 00:15:17.716048 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-14 00:15:18.132518 | controller | ok 2025-11-14 00:15:18.170139 | 2025-11-14 00:15:18.170814 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-14 00:15:18.958921 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-14 00:15:18.965831 | 2025-11-14 00:15:18.965934 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-14 00:15:19.513001 | controller | skipping: Conditional result was False 2025-11-14 00:15:19.519432 | 2025-11-14 00:15:19.519674 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-14 00:15:19.548200 | controller | skipping: Conditional result was False 2025-11-14 00:15:19.564810 | 2025-11-14 00:15:19.565028 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-14 00:15:19.592243 | controller | skipping: Conditional result was False 2025-11-14 00:15:19.607575 | 2025-11-14 00:15:19.607853 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-14 00:15:19.635265 | controller | skipping: Conditional result was False 2025-11-14 00:15:19.645599 | 2025-11-14 00:15:19.645772 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-14 00:15:19.670420 | controller | skipping: Conditional result was False 2025-11-14 00:15:19.681213 | 2025-11-14 00:15:19.681374 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-14 00:15:19.717476 | controller | skipping: Conditional result was False 2025-11-14 00:15:19.736580 | 2025-11-14 00:15:19.736759 | TASK [Disable Fedora Modular] 2025-11-14 00:15:19.995562 | controller | changed 2025-11-14 00:15:20.003875 | 2025-11-14 00:15:20.004003 | TASK [Enable EPEL] 2025-11-14 00:15:20.039467 | controller | skipping: Conditional result was False 2025-11-14 00:15:20.047213 | 2025-11-14 00:15:20.047353 | TASK [Register the RHEL node] 2025-11-14 00:15:20.599642 | 2025-11-14 00:15:20.599928 | TASK [Show the subscription-manager status] 2025-11-14 00:15:21.203473 | controller | skipping: Conditional result was False 2025-11-14 00:15:21.219783 | 2025-11-14 00:15:21.220083 | TASK [Enable EPEL on RHEL] 2025-11-14 00:15:21.787578 | controller | skipping: Conditional result was False 2025-11-14 00:15:21.801237 | 2025-11-14 00:15:21.801415 | TASK [Install git and tox] 2025-11-14 00:16:41.658821 | controller | changed 2025-11-14 00:16:41.669298 | 2025-11-14 00:16:41.669467 | TASK [include_role : prepare-workspace] 2025-11-14 00:16:41.710080 | controller | ok 2025-11-14 00:16:41.747712 | 2025-11-14 00:16:41.747878 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-14 00:16:41.986600 | controller | ok 2025-11-14 00:16:41.998536 | 2025-11-14 00:16:41.998663 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-14 00:16:54.677189 | controller | Output suppressed because no_log was given 2025-11-14 00:16:54.691240 | 2025-11-14 00:16:54.691344 | TASK [include_role : prepare-workspace-openshift] 2025-11-14 00:16:54.706152 | controller | skipping: Conditional result was False 2025-11-14 00:16:54.729228 | 2025-11-14 00:16:54.729327 | PLAY [all:!appliance] 2025-11-14 00:16:54.777988 | 2025-11-14 00:16:54.778102 | TASK [Run add-build-sshkey role (RSA)] 2025-11-14 00:16:54.798692 | controller | ok 2025-11-14 00:16:54.814898 | 2025-11-14 00:16:54.815015 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-14 00:16:55.063440 | controller -> localhost | ok 2025-11-14 00:16:55.069601 | 2025-11-14 00:16:55.070465 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-14 00:16:55.089847 | controller | ok 2025-11-14 00:16:55.105091 | controller | included: /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-14 00:16:55.111002 | 2025-11-14 00:16:55.111068 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-14 00:16:55.634940 | controller -> localhost | Generating public/private rsa key pair. 2025-11-14 00:16:55.635212 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/86ba9c973e9c4959932dc4ab88d6cafc_id_rsa. 2025-11-14 00:16:55.635249 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/86ba9c973e9c4959932dc4ab88d6cafc_id_rsa.pub. 2025-11-14 00:16:55.635275 | controller -> localhost | The key fingerprint is: 2025-11-14 00:16:55.635299 | controller -> localhost | SHA256:8pwud+S9KricWvp6M1Jss9gRA85xYQ0AzfvaJGXAPOk zuul-build-sshkey 2025-11-14 00:16:55.635321 | controller -> localhost | The key's randomart image is: 2025-11-14 00:16:55.635344 | controller -> localhost | +---[RSA 2048]----+ 2025-11-14 00:16:55.635367 | controller -> localhost | | .*.o++ | 2025-11-14 00:16:55.635392 | controller -> localhost | | @.. . | 2025-11-14 00:16:55.635416 | controller -> localhost | | + B | 2025-11-14 00:16:55.635438 | controller -> localhost | | E = | 2025-11-14 00:16:55.635459 | controller -> localhost | | =.oS | 2025-11-14 00:16:55.635492 | controller -> localhost | | . O+ .. | 2025-11-14 00:16:55.635519 | controller -> localhost | | X.=+o . | 2025-11-14 00:16:55.635542 | controller -> localhost | | ++Xoo o . | 2025-11-14 00:16:55.635565 | controller -> localhost | | +*=*.o.... | 2025-11-14 00:16:55.635590 | controller -> localhost | +----[SHA256]-----+ 2025-11-14 00:16:55.635663 | controller -> localhost | ok: Runtime: 0:00:00.144436 2025-11-14 00:16:55.643464 | 2025-11-14 00:16:55.643578 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-14 00:16:55.673087 | controller | ok 2025-11-14 00:16:55.684036 | controller | included: /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-14 00:16:55.693159 | 2025-11-14 00:16:55.693258 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-14 00:16:55.717242 | controller | skipping: Conditional result was False 2025-11-14 00:16:55.725757 | 2025-11-14 00:16:55.725864 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-14 00:16:56.207327 | controller | changed 2025-11-14 00:16:56.215076 | 2025-11-14 00:16:56.215188 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-14 00:16:56.448106 | controller | ok 2025-11-14 00:16:56.461291 | 2025-11-14 00:16:56.461442 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-14 00:16:57.137968 | controller | changed 2025-11-14 00:16:57.150234 | 2025-11-14 00:16:57.150420 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-14 00:16:57.780867 | controller | changed 2025-11-14 00:16:57.788094 | 2025-11-14 00:16:57.788282 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-14 00:16:57.814973 | controller | skipping: Conditional result was False 2025-11-14 00:16:57.823481 | 2025-11-14 00:16:57.823571 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-14 00:16:58.272612 | controller -> localhost | changed 2025-11-14 00:16:58.288785 | 2025-11-14 00:16:58.289004 | TASK [add-build-sshkey : Add back temp key] 2025-11-14 00:16:58.593055 | controller -> localhost | Identity added: /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/86ba9c973e9c4959932dc4ab88d6cafc_id_rsa (zuul-build-sshkey) 2025-11-14 00:16:58.593386 | controller -> localhost | ok: Runtime: 0:00:00.009808 2025-11-14 00:16:58.604796 | 2025-11-14 00:16:58.605018 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-14 00:16:58.960864 | controller | ok 2025-11-14 00:16:58.974011 | 2025-11-14 00:16:58.974231 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-14 00:16:59.023069 | controller | skipping: Conditional result was False 2025-11-14 00:16:59.049775 | 2025-11-14 00:16:59.049971 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-14 00:16:59.092522 | controller | ok 2025-11-14 00:16:59.122242 | 2025-11-14 00:16:59.122403 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-14 00:16:59.418440 | controller -> localhost | ok 2025-11-14 00:16:59.439956 | 2025-11-14 00:16:59.440193 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-14 00:16:59.500070 | controller | ok 2025-11-14 00:16:59.517824 | controller | included: /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-14 00:16:59.528653 | 2025-11-14 00:16:59.528869 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-14 00:16:59.901396 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-14 00:16:59.901681 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/86ba9c973e9c4959932dc4ab88d6cafc_id_ecdsa. 2025-11-14 00:16:59.901713 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/86ba9c973e9c4959932dc4ab88d6cafc_id_ecdsa.pub. 2025-11-14 00:16:59.901803 | controller -> localhost | The key fingerprint is: 2025-11-14 00:16:59.901830 | controller -> localhost | SHA256:aR2bZdAnATGV7a5/2nFCV1EiqbOBE8PKb+hubWa4Bm4 zuul-build-sshkey 2025-11-14 00:16:59.901850 | controller -> localhost | The key's randomart image is: 2025-11-14 00:16:59.901870 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-14 00:16:59.901889 | controller -> localhost | | . ==+=..o| 2025-11-14 00:16:59.901908 | controller -> localhost | | + o=.o..| 2025-11-14 00:16:59.901941 | controller -> localhost | | . . +..o+ .| 2025-11-14 00:16:59.901962 | controller -> localhost | | o oo+* . .| 2025-11-14 00:16:59.901981 | controller -> localhost | | oS.++ .. .| 2025-11-14 00:16:59.901999 | controller -> localhost | | . ..o . ... | 2025-11-14 00:16:59.902018 | controller -> localhost | | . o + ....| 2025-11-14 00:16:59.902036 | controller -> localhost | | E = = . o+| 2025-11-14 00:16:59.902054 | controller -> localhost | | . +o= .oo.| 2025-11-14 00:16:59.902073 | controller -> localhost | +----[SHA256]-----+ 2025-11-14 00:16:59.902140 | controller -> localhost | ok: Runtime: 0:00:00.014897 2025-11-14 00:16:59.913439 | 2025-11-14 00:16:59.913623 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-14 00:16:59.949075 | controller | ok 2025-11-14 00:16:59.960427 | controller | included: /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-14 00:16:59.973858 | 2025-11-14 00:16:59.973948 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-14 00:17:00.000601 | controller | skipping: Conditional result was False 2025-11-14 00:17:00.008102 | 2025-11-14 00:17:00.008199 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-14 00:17:00.278203 | controller | changed 2025-11-14 00:17:00.287451 | 2025-11-14 00:17:00.287608 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-14 00:17:00.528237 | controller | ok 2025-11-14 00:17:00.538812 | 2025-11-14 00:17:00.539028 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-14 00:17:01.234280 | controller | changed 2025-11-14 00:17:01.249883 | 2025-11-14 00:17:01.250115 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-14 00:17:01.876542 | controller | changed 2025-11-14 00:17:01.884775 | 2025-11-14 00:17:01.884974 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-14 00:17:01.911256 | controller | skipping: Conditional result was False 2025-11-14 00:17:01.924091 | 2025-11-14 00:17:01.924249 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-14 00:17:02.271477 | controller -> localhost | changed 2025-11-14 00:17:02.287749 | 2025-11-14 00:17:02.287916 | TASK [add-build-sshkey : Add back temp key] 2025-11-14 00:17:02.579468 | controller -> localhost | Identity added: /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/86ba9c973e9c4959932dc4ab88d6cafc_id_ecdsa (zuul-build-sshkey) 2025-11-14 00:17:02.579990 | controller -> localhost | ok: Runtime: 0:00:00.021132 2025-11-14 00:17:02.592447 | 2025-11-14 00:17:02.593158 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-14 00:17:02.802452 | controller | ok 2025-11-14 00:17:02.809413 | 2025-11-14 00:17:02.809506 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-14 00:17:02.835637 | controller | skipping: Conditional result was False 2025-11-14 00:17:02.919945 | 2025-11-14 00:17:02.920676 | TASK [include_role : remove-zuul-sshkey] 2025-11-14 00:17:02.939129 | controller | skipping: Conditional result was False 2025-11-14 00:17:02.948412 | 2025-11-14 00:17:02.948576 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-14 00:17:03.187860 | controller | ok: "logs" 2025-11-14 00:17:03.188367 | controller | ok: All items complete 2025-11-14 00:17:03.188431 | 2025-11-14 00:17:03.362537 | controller | ok: "artifacts" 2025-11-14 00:17:03.549836 | controller | ok: "docs" 2025-11-14 00:17:03.569793 | 2025-11-14 00:17:03.569926 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-14 00:17:03.791357 | controller | changed: "logs" 2025-11-14 00:17:03.995587 | controller | changed: "artifacts" 2025-11-14 00:17:04.175310 | controller | changed: "docs" 2025-11-14 00:17:04.211597 | 2025-11-14 00:17:04.211768 | PLAY RECAP 2025-11-14 00:17:04.211832 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-14 00:17:04.211861 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-14 00:17:04.211879 | 2025-11-14 00:17:04.400780 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-14 00:17:04.401998 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-11-14 00:17:05.087811 | 2025-11-14 00:17:05.087947 | PLAY [all] 2025-11-14 00:17:05.110913 | 2025-11-14 00:17:05.111052 | TASK [Install binary dependencies] 2025-11-14 00:17:05.173544 | controller | ok 2025-11-14 00:17:05.221189 | 2025-11-14 00:17:05.221407 | TASK [bindep : Include find tasks] 2025-11-14 00:17:05.254515 | controller | ok 2025-11-14 00:17:05.266096 | controller | included: /var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2025-11-14 00:17:05.276233 | 2025-11-14 00:17:05.276351 | TASK [bindep : Look for bindep.txt] 2025-11-14 00:17:05.675296 | controller | ok 2025-11-14 00:17:05.686076 | 2025-11-14 00:17:05.686196 | TASK [bindep : Define bindep_file fact] 2025-11-14 00:17:05.702511 | controller | skipping: Conditional result was False 2025-11-14 00:17:05.714167 | 2025-11-14 00:17:05.714318 | TASK [bindep : Look for other-requirements.txt] 2025-11-14 00:17:05.924671 | controller | ok 2025-11-14 00:17:05.936334 | 2025-11-14 00:17:05.936466 | TASK [bindep : Define bindep_file fact] 2025-11-14 00:17:05.962320 | controller | skipping: Conditional result was False 2025-11-14 00:17:05.968651 | 2025-11-14 00:17:05.968720 | TASK [bindep : Look for bindep fallback file] 2025-11-14 00:17:05.992487 | controller | skipping: Conditional result was False 2025-11-14 00:17:06.000272 | 2025-11-14 00:17:06.000405 | TASK [bindep : Define bindep_file fact] 2025-11-14 00:17:06.025053 | controller | skipping: Conditional result was False 2025-11-14 00:17:06.031550 | 2025-11-14 00:17:06.031635 | TASK [bindep : Include bindep tasks] 2025-11-14 00:17:06.055777 | controller | skipping: Conditional result was False 2025-11-14 00:17:06.061922 | 2025-11-14 00:17:06.061989 | TASK [bindep : Include install tasks] 2025-11-14 00:17:06.085707 | controller | skipping: Conditional result was False 2025-11-14 00:17:06.092175 | 2025-11-14 00:17:06.092271 | LOOP [bindep : Include package tasks] 2025-11-14 00:17:06.158212 | 2025-11-14 00:17:06.158374 | TASK [Run test-setup role] 2025-11-14 00:17:06.178943 | controller | ok 2025-11-14 00:17:06.201586 | 2025-11-14 00:17:06.201759 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2025-11-14 00:17:06.416435 | controller | ok 2025-11-14 00:17:06.432921 | 2025-11-14 00:17:06.433073 | TASK [test-setup : Run tools/test-setup.sh] 2025-11-14 00:17:36.487287 | [Zuul] Log Stream did not terminate 2025-11-14 00:17:36.487580 | controller | skipping: Conditional result was False 2025-11-14 00:17:36.529214 | 2025-11-14 00:17:36.529333 | PLAY RECAP 2025-11-14 00:17:36.529402 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-14 00:17:36.529441 | 2025-11-14 00:17:36.635774 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-11-14 00:17:36.637028 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-11-14 00:17:37.269385 | 2025-11-14 00:17:37.269522 | PLAY [controller] 2025-11-14 00:17:37.290695 | 2025-11-14 00:17:37.290848 | TASK [Create the /root directory] 2025-11-14 00:19:49.638376 | controller | ERROR 2025-11-14 00:19:49.643981 | controller | { 2025-11-14 00:19:49.644129 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2025-11-14 00:19:49.644199 | controller | } failure 2025-11-14 00:19:49.646325 | 2025-11-14 00:19:49.646406 | PLAY RECAP 2025-11-14 00:19:49.646463 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-11-14 00:19:49.646495 | 2025-11-14 00:19:49.768017 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-11-14 00:19:49.769913 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-14 00:19:50.419326 | 2025-11-14 00:19:50.419449 | PLAY [all] 2025-11-14 00:19:50.440464 | 2025-11-14 00:19:50.440570 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-14 00:23:14.361357 | controller | changed: non-zero return code 2025-11-14 00:23:14.369911 | 2025-11-14 00:23:14.370058 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-14 00:23:14.395532 | controller | skipping: Conditional result was False 2025-11-14 00:23:14.407641 | 2025-11-14 00:23:14.407900 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-14 00:23:14.444257 | 2025-11-14 00:23:14.444463 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-14 00:23:14.481311 | 2025-11-14 00:23:14.481543 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-14 00:23:14.508881 | controller | skipping: Conditional result was False 2025-11-14 00:23:14.529676 | 2025-11-14 00:23:14.529984 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-14 00:23:14.570898 | 2025-11-14 00:23:14.571178 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-14 00:23:14.597146 | controller | skipping: Conditional result was False 2025-11-14 00:23:14.605318 | 2025-11-14 00:23:14.605457 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-14 00:23:14.630023 | controller | skipping: Conditional result was False 2025-11-14 00:23:14.638161 | 2025-11-14 00:23:14.638277 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-14 00:23:14.662928 | controller | skipping: Conditional result was False 2025-11-14 00:23:14.703335 | 2025-11-14 00:23:14.703514 | PLAY RECAP 2025-11-14 00:23:14.703578 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-14 00:23:14.703608 | 2025-11-14 00:23:14.852876 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-14 00:23:14.854362 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-14 00:23:15.469033 | 2025-11-14 00:23:15.469196 | PLAY [all:!appliance*] 2025-11-14 00:23:15.492911 | 2025-11-14 00:23:15.493042 | TASK [unregister the node] 2025-11-14 00:23:16.026644 | controller | skipping: Conditional result was False 2025-11-14 00:23:16.041164 | 2025-11-14 00:23:16.041400 | TASK [include_role : fetch-output] 2025-11-14 00:23:16.078090 | controller | ok 2025-11-14 00:23:16.105989 | 2025-11-14 00:23:16.106140 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-14 00:23:16.161823 | controller | skipping: Conditional result was False 2025-11-14 00:23:16.169196 | 2025-11-14 00:23:16.169323 | TASK [fetch-output : Set log path for single node] 2025-11-14 00:23:16.211465 | controller | ok 2025-11-14 00:23:16.217314 | 2025-11-14 00:23:16.217383 | LOOP [fetch-output : Ensure local output dirs] 2025-11-14 00:23:16.669955 | controller -> localhost | ok: "/var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/logs" 2025-11-14 00:23:16.924385 | controller -> localhost | changed: "/var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/artifacts" 2025-11-14 00:23:17.153407 | controller -> localhost | changed: "/var/lib/zuul/builds/86ba9c973e9c4959932dc4ab88d6cafc/work/docs" 2025-11-14 00:23:17.166479 | 2025-11-14 00:23:17.166589 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-14 00:23:17.887964 | controller | changed: .d..t...... ./ 2025-11-14 00:23:17.890802 | controller | changed: All items complete 2025-11-14 00:23:17.890866 | 2025-11-14 00:23:18.397711 | controller | changed: .d..t...... ./ 2025-11-14 00:23:18.916095 | controller | changed: .d..t...... ./ 2025-11-14 00:23:18.950404 | 2025-11-14 00:23:18.951265 | TASK [include_role : fetch-output-openshift] 2025-11-14 00:23:18.986776 | controller | skipping: Conditional result was False 2025-11-14 00:23:18.997259 | 2025-11-14 00:23:18.997359 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-14 00:23:19.043145 | controller | skipping: Conditional result was False 2025-11-14 00:23:19.056884 | controller | skipping: Conditional result was False 2025-11-14 00:23:19.101433 | 2025-11-14 00:23:19.101598 | PLAY [localhost] 2025-11-14 00:23:19.114007 | 2025-11-14 00:23:19.114088 | TASK [Run Zuul manifest role] 2025-11-14 00:23:19.142564 | localhost | ok 2025-11-14 00:23:19.159048 | 2025-11-14 00:23:19.159206 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-14 00:23:19.517455 | localhost | changed 2025-11-14 00:23:19.523794 | 2025-11-14 00:23:19.523893 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-14 00:23:19.557111 | localhost | ok 2025-11-14 00:23:19.571210 | 2025-11-14 00:23:19.571445 | TASK [Set zuul-log-path fact] 2025-11-14 00:23:19.594209 | localhost | ok 2025-11-14 00:23:19.622392 | 2025-11-14 00:23:19.622563 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-14 00:23:19.653568 | localhost | ok 2025-11-14 00:23:19.665474 | 2025-11-14 00:23:19.665622 | LOOP [Run upload-logs-swift role] 2025-11-14 00:23:19.702713 | localhost | Output suppressed because no_log was given 2025-11-14 00:23:19.732274 | 2025-11-14 00:23:19.732436 | TASK [Set zuul-log-path fact] 2025-11-14 00:23:19.768487 | localhost | skipping: Conditional result was False 2025-11-14 00:23:19.776578 | 2025-11-14 00:23:19.776777 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-14 00:23:20.250981 | localhost -> localhost | ok: Runtime: 0:00:00.006484 2025-11-14 00:23:20.313378 | 2025-11-14 00:23:20.313556 | TASK [upload-logs-swift : Upload logs to swift]