2025-11-30 00:27:21.788010 | Job console starting... 2025-11-30 00:27:21.802464 | Updating repositories 2025-11-30 00:27:21.936825 | Preparing job workspace 2025-11-30 00:27:25.602367 | Running Ansible setup... 2025-11-30 00:27:30.527308 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-30 00:27:31.208926 | 2025-11-30 00:27:31.209085 | PLAY [localhost] 2025-11-30 00:27:31.217933 | 2025-11-30 00:27:31.218046 | TASK [Gathering Facts] 2025-11-30 00:27:32.224667 | localhost | ok 2025-11-30 00:27:32.252082 | 2025-11-30 00:27:32.252256 | TASK [Setup log path fact] 2025-11-30 00:27:32.274345 | localhost | ok 2025-11-30 00:27:32.290394 | 2025-11-30 00:27:32.290484 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-30 00:27:32.331476 | localhost | ok 2025-11-30 00:27:32.343627 | 2025-11-30 00:27:32.343721 | TASK [emit-job-header : Print job information] 2025-11-30 00:27:32.394250 | # Job Information 2025-11-30 00:27:32.394417 | Ansible Version: 2.15.12 2025-11-30 00:27:32.394460 | Job: ansible-test-sanity-docker-milestone 2025-11-30 00:27:32.394491 | Pipeline: periodic 2025-11-30 00:27:32.394518 | Executor: ze01.softwarefactory-project.io 2025-11-30 00:27:32.394543 | Triggered by: https://github.com/ansible-collections/ansible.network 2025-11-30 00:27:32.394572 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/c6f/ansible/c6f72d43163240e1a44c192bea6dabd3/ 2025-11-30 00:27:32.394599 | Event ID: 7a84db3cbb014f2ca6b2aa61dbabec79 2025-11-30 00:27:32.399901 | 2025-11-30 00:27:32.399985 | LOOP [emit-job-header : Print node information] 2025-11-30 00:27:32.516879 | localhost | ok: 2025-11-30 00:27:32.517096 | localhost | # Node Information 2025-11-30 00:27:32.517124 | localhost | Inventory Hostname: controller 2025-11-30 00:27:32.517143 | localhost | Hostname: np0005540052 2025-11-30 00:27:32.517162 | localhost | Username: zuul 2025-11-30 00:27:32.517188 | localhost | Distro: Fedora 37 2025-11-30 00:27:32.517206 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-30 00:27:32.517224 | localhost | Region: ca-ymq-1 2025-11-30 00:27:32.517241 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-30 00:27:32.517257 | localhost | Product Name: OpenStack Nova 2025-11-30 00:27:32.517274 | localhost | Interface IP: 162.253.55.62 2025-11-30 00:27:32.542717 | 2025-11-30 00:27:32.542901 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-30 00:27:32.996358 | localhost -> localhost | changed 2025-11-30 00:27:33.002050 | 2025-11-30 00:27:33.002116 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-30 00:27:33.820533 | localhost -> localhost | changed 2025-11-30 00:27:33.849711 | 2025-11-30 00:27:33.849833 | PLAY [all:!appliance*] 2025-11-30 00:27:33.871904 | 2025-11-30 00:27:33.871982 | TASK [include_role : start-zuul-console] 2025-11-30 00:27:33.891485 | controller | ok 2025-11-30 00:27:33.908164 | 2025-11-30 00:27:33.908261 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-30 00:27:34.302652 | controller | ok 2025-11-30 00:27:34.326882 | 2025-11-30 00:27:34.327170 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-30 00:27:35.334675 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-30 00:27:35.349577 | 2025-11-30 00:27:35.349721 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-30 00:27:35.897005 | controller | skipping: Conditional result was False 2025-11-30 00:27:35.913440 | 2025-11-30 00:27:35.913613 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-30 00:27:35.963678 | controller | skipping: Conditional result was False 2025-11-30 00:27:35.984674 | 2025-11-30 00:27:35.984923 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-30 00:27:36.013986 | controller | skipping: Conditional result was False 2025-11-30 00:27:36.024257 | 2025-11-30 00:27:36.024419 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-30 00:27:36.065220 | controller | skipping: Conditional result was False 2025-11-30 00:27:36.074107 | 2025-11-30 00:27:36.074231 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-30 00:27:36.099283 | controller | skipping: Conditional result was False 2025-11-30 00:27:36.108312 | 2025-11-30 00:27:36.108448 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-30 00:27:36.123597 | controller | skipping: Conditional result was False 2025-11-30 00:27:36.143227 | 2025-11-30 00:27:36.143428 | TASK [Disable Fedora Modular] 2025-11-30 00:27:36.408876 | controller | changed 2025-11-30 00:27:36.416966 | 2025-11-30 00:27:36.417070 | TASK [Enable EPEL] 2025-11-30 00:27:36.431561 | controller | skipping: Conditional result was False 2025-11-30 00:27:36.440536 | 2025-11-30 00:27:36.440674 | TASK [Register the RHEL node] 2025-11-30 00:27:36.996277 | 2025-11-30 00:27:36.996557 | TASK [Show the subscription-manager status] 2025-11-30 00:27:37.577894 | controller | skipping: Conditional result was False 2025-11-30 00:27:37.587069 | 2025-11-30 00:27:37.587166 | TASK [Enable EPEL on RHEL] 2025-11-30 00:27:38.131803 | controller | skipping: Conditional result was False 2025-11-30 00:27:38.145154 | 2025-11-30 00:27:38.145419 | TASK [Install git and tox] 2025-11-30 00:28:59.308933 | controller | changed 2025-11-30 00:28:59.324176 | 2025-11-30 00:28:59.324383 | TASK [include_role : prepare-workspace] 2025-11-30 00:28:59.366884 | controller | ok 2025-11-30 00:28:59.408896 | 2025-11-30 00:28:59.409082 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-30 00:28:59.663977 | controller | ok 2025-11-30 00:28:59.684213 | 2025-11-30 00:28:59.684373 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-30 00:29:11.409115 | controller | Output suppressed because no_log was given 2025-11-30 00:29:11.423605 | 2025-11-30 00:29:11.423693 | TASK [include_role : prepare-workspace-openshift] 2025-11-30 00:29:11.459309 | controller | skipping: Conditional result was False 2025-11-30 00:29:11.490238 | 2025-11-30 00:29:11.490325 | PLAY [all:!appliance] 2025-11-30 00:29:11.535878 | 2025-11-30 00:29:11.535989 | TASK [Run add-build-sshkey role (RSA)] 2025-11-30 00:29:11.565804 | controller | ok 2025-11-30 00:29:11.579922 | 2025-11-30 00:29:11.579990 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-30 00:29:11.830599 | controller -> localhost | ok 2025-11-30 00:29:11.844150 | 2025-11-30 00:29:11.844302 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-30 00:29:11.883544 | controller | ok 2025-11-30 00:29:11.916932 | controller | included: /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-30 00:29:11.925561 | 2025-11-30 00:29:11.925648 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-30 00:29:12.467885 | controller -> localhost | Generating public/private rsa key pair. 2025-11-30 00:29:12.468108 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/c6f72d43163240e1a44c192bea6dabd3_id_rsa. 2025-11-30 00:29:12.468137 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/c6f72d43163240e1a44c192bea6dabd3_id_rsa.pub. 2025-11-30 00:29:12.468158 | controller -> localhost | The key fingerprint is: 2025-11-30 00:29:12.468178 | controller -> localhost | SHA256:DeVbygpFjHD6bxIVKne3NpIoHp7/FLcqE7GSr8mJpPA zuul-build-sshkey 2025-11-30 00:29:12.468197 | controller -> localhost | The key's randomart image is: 2025-11-30 00:29:12.468215 | controller -> localhost | +---[RSA 2048]----+ 2025-11-30 00:29:12.468233 | controller -> localhost | | ...oo . | 2025-11-30 00:29:12.468252 | controller -> localhost | | o.o.+ | 2025-11-30 00:29:12.468270 | controller -> localhost | | o o = o . | 2025-11-30 00:29:12.468288 | controller -> localhost | | +.= * = | 2025-11-30 00:29:12.468305 | controller -> localhost | | o.=oS X | 2025-11-30 00:29:12.468332 | controller -> localhost | | oo+o+ * o | 2025-11-30 00:29:12.468357 | controller -> localhost | |. . +o..= . | 2025-11-30 00:29:12.468377 | controller -> localhost | |.+ o +++ . | 2025-11-30 00:29:12.468396 | controller -> localhost | |. E =..+o | 2025-11-30 00:29:12.468417 | controller -> localhost | +----[SHA256]-----+ 2025-11-30 00:29:12.468463 | controller -> localhost | ok: Runtime: 0:00:00.150520 2025-11-30 00:29:12.475227 | 2025-11-30 00:29:12.475293 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-30 00:29:12.494266 | controller | ok 2025-11-30 00:29:12.504261 | controller | included: /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-30 00:29:12.513072 | 2025-11-30 00:29:12.513144 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-30 00:29:12.537275 | controller | skipping: Conditional result was False 2025-11-30 00:29:12.543418 | 2025-11-30 00:29:12.543482 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-30 00:29:12.962508 | controller | changed 2025-11-30 00:29:12.970174 | 2025-11-30 00:29:12.970254 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-30 00:29:13.195572 | controller | ok 2025-11-30 00:29:13.203060 | 2025-11-30 00:29:13.203192 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-30 00:29:13.831932 | controller | changed 2025-11-30 00:29:13.846155 | 2025-11-30 00:29:13.846295 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-30 00:29:14.477834 | controller | changed 2025-11-30 00:29:14.490266 | 2025-11-30 00:29:14.490415 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-30 00:29:14.517496 | controller | skipping: Conditional result was False 2025-11-30 00:29:14.531442 | 2025-11-30 00:29:14.531586 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-30 00:29:14.997889 | controller -> localhost | changed 2025-11-30 00:29:15.010279 | 2025-11-30 00:29:15.010364 | TASK [add-build-sshkey : Add back temp key] 2025-11-30 00:29:15.281670 | controller -> localhost | Identity added: /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/c6f72d43163240e1a44c192bea6dabd3_id_rsa (zuul-build-sshkey) 2025-11-30 00:29:15.281899 | controller -> localhost | ok: Runtime: 0:00:00.013865 2025-11-30 00:29:15.288904 | 2025-11-30 00:29:15.288973 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-30 00:29:15.653117 | controller | ok 2025-11-30 00:29:15.665234 | 2025-11-30 00:29:15.665373 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-30 00:29:15.703883 | controller | skipping: Conditional result was False 2025-11-30 00:29:15.732474 | 2025-11-30 00:29:15.732635 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-30 00:29:15.767171 | controller | ok 2025-11-30 00:29:15.789807 | 2025-11-30 00:29:15.789911 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-30 00:29:16.089822 | controller -> localhost | ok 2025-11-30 00:29:16.103825 | 2025-11-30 00:29:16.103971 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-30 00:29:16.144826 | controller | ok 2025-11-30 00:29:16.168281 | controller | included: /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-30 00:29:16.176780 | 2025-11-30 00:29:16.176881 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-30 00:29:16.532250 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-30 00:29:16.532559 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/c6f72d43163240e1a44c192bea6dabd3_id_ecdsa. 2025-11-30 00:29:16.532622 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/c6f72d43163240e1a44c192bea6dabd3_id_ecdsa.pub. 2025-11-30 00:29:16.532683 | controller -> localhost | The key fingerprint is: 2025-11-30 00:29:16.532728 | controller -> localhost | SHA256:9MQAla1tKS+aC54JzsV/Ih4cC33ZRZXJrlj33hoszJk zuul-build-sshkey 2025-11-30 00:29:16.532770 | controller -> localhost | The key's randomart image is: 2025-11-30 00:29:16.532812 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-30 00:29:16.532852 | controller -> localhost | | .ooo.o.o | 2025-11-30 00:29:16.532891 | controller -> localhost | | .+. + | 2025-11-30 00:29:16.532929 | controller -> localhost | | .o+o | 2025-11-30 00:29:16.532967 | controller -> localhost | | . +o+= o | 2025-11-30 00:29:16.533005 | controller -> localhost | | . o o S*.o . | 2025-11-30 00:29:16.533117 | controller -> localhost | | + + o oo +. | 2025-11-30 00:29:16.533159 | controller -> localhost | | . B o . E.o. | 2025-11-30 00:29:16.533197 | controller -> localhost | | o +.*+ . ....| 2025-11-30 00:29:16.533235 | controller -> localhost | | o.=.o+ .. | 2025-11-30 00:29:16.533272 | controller -> localhost | +----[SHA256]-----+ 2025-11-30 00:29:16.533363 | controller -> localhost | ok: Runtime: 0:00:00.013958 2025-11-30 00:29:16.549764 | 2025-11-30 00:29:16.549975 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-30 00:29:16.586309 | controller | ok 2025-11-30 00:29:16.597859 | controller | included: /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-30 00:29:16.610215 | 2025-11-30 00:29:16.610319 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-30 00:29:16.645878 | controller | skipping: Conditional result was False 2025-11-30 00:29:16.654462 | 2025-11-30 00:29:16.654559 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-30 00:29:16.927967 | controller | changed 2025-11-30 00:29:16.940540 | 2025-11-30 00:29:16.940685 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-30 00:29:17.172452 | controller | ok 2025-11-30 00:29:17.187302 | 2025-11-30 00:29:17.187449 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-30 00:29:17.797815 | controller | changed 2025-11-30 00:29:17.806908 | 2025-11-30 00:29:17.807042 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-30 00:29:18.390289 | controller | changed 2025-11-30 00:29:18.399045 | 2025-11-30 00:29:18.399140 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-30 00:29:18.415287 | controller | skipping: Conditional result was False 2025-11-30 00:29:18.425104 | 2025-11-30 00:29:18.425200 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-30 00:29:18.674946 | controller -> localhost | changed 2025-11-30 00:29:18.692670 | 2025-11-30 00:29:18.692801 | TASK [add-build-sshkey : Add back temp key] 2025-11-30 00:29:19.004520 | controller -> localhost | Identity added: /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/c6f72d43163240e1a44c192bea6dabd3_id_ecdsa (zuul-build-sshkey) 2025-11-30 00:29:19.004725 | controller -> localhost | ok: Runtime: 0:00:00.012765 2025-11-30 00:29:19.011429 | 2025-11-30 00:29:19.011507 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-30 00:29:19.214277 | controller | ok 2025-11-30 00:29:19.262903 | 2025-11-30 00:29:19.263217 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-30 00:29:19.287917 | controller | skipping: Conditional result was False 2025-11-30 00:29:19.303294 | 2025-11-30 00:29:19.303497 | TASK [include_role : remove-zuul-sshkey] 2025-11-30 00:29:19.319204 | controller | skipping: Conditional result was False 2025-11-30 00:29:19.328927 | 2025-11-30 00:29:19.329063 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-30 00:29:19.554315 | controller | ok: "logs" 2025-11-30 00:29:19.554587 | controller | ok: All items complete 2025-11-30 00:29:19.554627 | 2025-11-30 00:29:19.738901 | controller | ok: "artifacts" 2025-11-30 00:29:19.925769 | controller | ok: "docs" 2025-11-30 00:29:19.950057 | 2025-11-30 00:29:19.950242 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-30 00:29:20.211996 | controller | changed: "logs" 2025-11-30 00:29:20.421353 | controller | changed: "artifacts" 2025-11-30 00:29:20.620555 | controller | changed: "docs" 2025-11-30 00:29:20.685937 | 2025-11-30 00:29:20.686089 | PLAY RECAP 2025-11-30 00:29:20.686153 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-30 00:29:20.686193 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-30 00:29:20.686223 | 2025-11-30 00:29:20.799778 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-30 00:29:20.801577 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-11-30 00:29:21.401688 | 2025-11-30 00:29:21.401838 | PLAY [all] 2025-11-30 00:29:21.423620 | 2025-11-30 00:29:21.423717 | TASK [Install binary dependencies] 2025-11-30 00:29:21.493648 | controller | ok 2025-11-30 00:29:21.513399 | 2025-11-30 00:29:21.513494 | TASK [bindep : Include find tasks] 2025-11-30 00:29:21.558226 | controller | ok 2025-11-30 00:29:21.570225 | controller | included: /var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2025-11-30 00:29:21.579693 | 2025-11-30 00:29:21.579788 | TASK [bindep : Look for bindep.txt] 2025-11-30 00:29:21.944507 | controller | ok 2025-11-30 00:29:21.958006 | 2025-11-30 00:29:21.958195 | TASK [bindep : Define bindep_file fact] 2025-11-30 00:29:21.985010 | controller | skipping: Conditional result was False 2025-11-30 00:29:21.998141 | 2025-11-30 00:29:21.998311 | TASK [bindep : Look for other-requirements.txt] 2025-11-30 00:29:22.222859 | controller | ok 2025-11-30 00:29:22.237504 | 2025-11-30 00:29:22.237660 | TASK [bindep : Define bindep_file fact] 2025-11-30 00:29:22.274689 | controller | skipping: Conditional result was False 2025-11-30 00:29:22.289143 | 2025-11-30 00:29:22.289454 | TASK [bindep : Look for bindep fallback file] 2025-11-30 00:29:22.327642 | controller | skipping: Conditional result was False 2025-11-30 00:29:22.345618 | 2025-11-30 00:29:22.345814 | TASK [bindep : Define bindep_file fact] 2025-11-30 00:29:22.383465 | controller | skipping: Conditional result was False 2025-11-30 00:29:22.401391 | 2025-11-30 00:29:22.401826 | TASK [bindep : Include bindep tasks] 2025-11-30 00:29:22.430378 | controller | skipping: Conditional result was False 2025-11-30 00:29:22.446087 | 2025-11-30 00:29:22.446285 | TASK [bindep : Include install tasks] 2025-11-30 00:29:22.473710 | controller | skipping: Conditional result was False 2025-11-30 00:29:22.487877 | 2025-11-30 00:29:22.488107 | LOOP [bindep : Include package tasks] 2025-11-30 00:29:22.561175 | 2025-11-30 00:29:22.561467 | TASK [Run test-setup role] 2025-11-30 00:29:22.593212 | controller | ok 2025-11-30 00:29:22.622066 | 2025-11-30 00:29:22.622204 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2025-11-30 00:29:22.857880 | controller | ok 2025-11-30 00:29:22.864757 | 2025-11-30 00:29:22.864828 | TASK [test-setup : Run tools/test-setup.sh] 2025-11-30 00:29:52.927790 | [Zuul] Log Stream did not terminate 2025-11-30 00:29:52.928123 | controller | skipping: Conditional result was False 2025-11-30 00:29:52.965900 | 2025-11-30 00:29:52.966105 | PLAY RECAP 2025-11-30 00:29:52.966173 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-30 00:29:52.966204 | 2025-11-30 00:29:53.065867 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-11-30 00:29:53.066737 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-11-30 00:29:53.671755 | 2025-11-30 00:29:53.671876 | PLAY [controller] 2025-11-30 00:29:53.693096 | 2025-11-30 00:29:53.693205 | TASK [Create the /root directory] 2025-11-30 00:32:06.023393 | controller | ERROR 2025-11-30 00:32:06.023665 | controller | { 2025-11-30 00:32:06.023722 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2025-11-30 00:32:06.023763 | controller | } failure 2025-11-30 00:32:06.025604 | 2025-11-30 00:32:06.025684 | PLAY RECAP 2025-11-30 00:32:06.025754 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-11-30 00:32:06.025796 | 2025-11-30 00:32:06.130614 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-11-30 00:32:06.131833 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-30 00:32:06.733562 | 2025-11-30 00:32:06.733693 | PLAY [all] 2025-11-30 00:32:06.757252 | 2025-11-30 00:32:06.757400 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-30 00:34:27.493615 | controller | changed: non-zero return code 2025-11-30 00:34:27.509143 | 2025-11-30 00:34:27.509339 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-30 00:34:27.539639 | controller | skipping: Conditional result was False 2025-11-30 00:34:27.555816 | 2025-11-30 00:34:27.555971 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-30 00:34:27.601814 | 2025-11-30 00:34:27.602238 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-30 00:34:27.648944 | 2025-11-30 00:34:27.649348 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-30 00:34:27.677400 | controller | skipping: Conditional result was False 2025-11-30 00:34:27.688641 | 2025-11-30 00:34:27.688755 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-30 00:34:27.728261 | 2025-11-30 00:34:27.728652 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-30 00:34:27.746267 | controller | skipping: Conditional result was False 2025-11-30 00:34:27.754424 | 2025-11-30 00:34:27.754507 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-30 00:34:27.780503 | controller | skipping: Conditional result was False 2025-11-30 00:34:27.788680 | 2025-11-30 00:34:27.788768 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-30 00:34:27.814529 | controller | skipping: Conditional result was False 2025-11-30 00:34:27.844497 | 2025-11-30 00:34:27.844629 | PLAY RECAP 2025-11-30 00:34:27.844683 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-30 00:34:27.844710 | 2025-11-30 00:34:28.014388 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-30 00:34:28.016194 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-30 00:34:28.651735 | 2025-11-30 00:34:28.651856 | PLAY [all:!appliance*] 2025-11-30 00:34:28.673648 | 2025-11-30 00:34:28.673746 | TASK [unregister the node] 2025-11-30 00:34:29.207582 | controller | skipping: Conditional result was False 2025-11-30 00:34:29.223104 | 2025-11-30 00:34:29.223334 | TASK [include_role : fetch-output] 2025-11-30 00:34:29.267221 | controller | ok 2025-11-30 00:34:29.310270 | 2025-11-30 00:34:29.310502 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-30 00:34:29.388990 | controller | skipping: Conditional result was False 2025-11-30 00:34:29.401667 | 2025-11-30 00:34:29.401788 | TASK [fetch-output : Set log path for single node] 2025-11-30 00:34:29.461163 | controller | ok 2025-11-30 00:34:29.473266 | 2025-11-30 00:34:29.473576 | LOOP [fetch-output : Ensure local output dirs] 2025-11-30 00:34:29.954812 | controller -> localhost | ok: "/var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/logs" 2025-11-30 00:34:30.209178 | controller -> localhost | changed: "/var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/artifacts" 2025-11-30 00:34:30.459932 | controller -> localhost | changed: "/var/lib/zuul/builds/c6f72d43163240e1a44c192bea6dabd3/work/docs" 2025-11-30 00:34:30.488578 | 2025-11-30 00:34:30.488833 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-30 00:34:31.230521 | controller | ok 2025-11-30 00:34:31.230841 | controller | changed: All items complete 2025-11-30 00:34:31.230878 | 2025-11-30 00:34:31.808704 | controller | changed: .d..t...... ./ 2025-11-30 00:34:32.358244 | controller | changed: .d..t...... ./ 2025-11-30 00:34:32.372419 | 2025-11-30 00:34:32.372558 | TASK [include_role : fetch-output-openshift] 2025-11-30 00:34:32.397238 | controller | skipping: Conditional result was False 2025-11-30 00:34:32.410942 | 2025-11-30 00:34:32.411063 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-30 00:34:32.455239 | controller | skipping: Conditional result was False 2025-11-30 00:34:32.467814 | controller | skipping: Conditional result was False 2025-11-30 00:34:32.530429 | 2025-11-30 00:34:32.530566 | PLAY [localhost] 2025-11-30 00:34:32.547823 | 2025-11-30 00:34:32.547913 | TASK [Run Zuul manifest role] 2025-11-30 00:34:32.568733 | localhost | ok 2025-11-30 00:34:32.588076 | 2025-11-30 00:34:32.588202 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-30 00:34:33.009876 | localhost | changed 2025-11-30 00:34:33.019883 | 2025-11-30 00:34:33.020019 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-30 00:34:33.055743 | localhost | ok 2025-11-30 00:34:33.073100 | 2025-11-30 00:34:33.073230 | TASK [Set zuul-log-path fact] 2025-11-30 00:34:33.099171 | localhost | ok 2025-11-30 00:34:33.124614 | 2025-11-30 00:34:33.124704 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-30 00:34:33.168957 | localhost | ok 2025-11-30 00:34:33.186528 | 2025-11-30 00:34:33.186650 | LOOP [Run upload-logs-swift role] 2025-11-30 00:34:33.233531 | localhost | Output suppressed because no_log was given 2025-11-30 00:34:33.277993 | 2025-11-30 00:34:33.278139 | TASK [Set zuul-log-path fact] 2025-11-30 00:34:33.313280 | localhost | skipping: Conditional result was False 2025-11-30 00:34:33.320192 | 2025-11-30 00:34:33.320278 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-30 00:34:33.791631 | localhost -> localhost | ok: Runtime: 0:00:00.006630 2025-11-30 00:34:33.838883 | 2025-11-30 00:34:33.839057 | TASK [upload-logs-swift : Upload logs to swift]