2026-02-15 00:21:53.785527 | Job console starting... 2026-02-15 00:21:53.803404 | Updating repositories 2026-02-15 00:21:53.929920 | Preparing job workspace 2026-02-15 00:21:57.615184 | Running Ansible setup... 2026-02-15 00:22:02.705789 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-15 00:22:03.344854 | 2026-02-15 00:22:03.345016 | PLAY [localhost] 2026-02-15 00:22:03.354259 | 2026-02-15 00:22:03.354360 | TASK [Gathering Facts] 2026-02-15 00:22:04.436990 | localhost | ok 2026-02-15 00:22:04.455063 | 2026-02-15 00:22:04.455215 | TASK [Setup log path fact] 2026-02-15 00:22:04.482035 | localhost | ok 2026-02-15 00:22:04.510588 | 2026-02-15 00:22:04.510801 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-15 00:22:04.553245 | localhost | ok 2026-02-15 00:22:04.564853 | 2026-02-15 00:22:04.564968 | TASK [emit-job-header : Print job information] 2026-02-15 00:22:04.621163 | # Job Information 2026-02-15 00:22:04.621362 | Ansible Version: 2.15.12 2026-02-15 00:22:04.621408 | Job: ansible-test-sanity-docker-stable-2.11 2026-02-15 00:22:04.621441 | Pipeline: periodic 2026-02-15 00:22:04.621470 | Executor: ze03.softwarefactory-project.io 2026-02-15 00:22:04.621496 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-02-15 00:22:04.621528 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/f57/ansible/f578e22c73954ccba303c9a183cfe88a/ 2026-02-15 00:22:04.621557 | Event ID: bfcfc7f67e194cfab2f082a1d8ce3d78 2026-02-15 00:22:04.627316 | 2026-02-15 00:22:04.627408 | LOOP [emit-job-header : Print node information] 2026-02-15 00:22:04.738476 | localhost | ok: 2026-02-15 00:22:04.739300 | localhost | # Node Information 2026-02-15 00:22:04.739376 | localhost | Inventory Hostname: controller 2026-02-15 00:22:04.739423 | localhost | Hostname: np0005620036 2026-02-15 00:22:04.739465 | localhost | Username: zuul 2026-02-15 00:22:04.739517 | localhost | Distro: Fedora 37 2026-02-15 00:22:04.739559 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-15 00:22:04.739598 | localhost | Region: ca-ymq-1 2026-02-15 00:22:04.739636 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-15 00:22:04.739672 | localhost | Product Name: OpenStack Nova 2026-02-15 00:22:04.739732 | localhost | Interface IP: 162.253.55.204 2026-02-15 00:22:04.766461 | 2026-02-15 00:22:04.766649 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-15 00:22:05.164991 | localhost -> localhost | changed 2026-02-15 00:22:05.170859 | 2026-02-15 00:22:05.170937 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-15 00:22:06.013507 | localhost -> localhost | changed 2026-02-15 00:22:06.057349 | 2026-02-15 00:22:06.057463 | PLAY [all:!appliance*] 2026-02-15 00:22:06.083501 | 2026-02-15 00:22:06.083680 | TASK [include_role : start-zuul-console] 2026-02-15 00:22:06.108451 | controller | ok 2026-02-15 00:22:06.129184 | 2026-02-15 00:22:06.129320 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-15 00:22:06.506351 | controller | ok 2026-02-15 00:22:06.534019 | 2026-02-15 00:22:06.534234 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-15 00:22:07.587962 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-15 00:22:07.606203 | 2026-02-15 00:22:07.606393 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-15 00:22:08.159334 | controller | skipping: Conditional result was False 2026-02-15 00:22:08.177925 | 2026-02-15 00:22:08.178098 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-15 00:22:08.206910 | controller | skipping: Conditional result was False 2026-02-15 00:22:08.215493 | 2026-02-15 00:22:08.215630 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-15 00:22:08.241484 | controller | skipping: Conditional result was False 2026-02-15 00:22:08.250409 | 2026-02-15 00:22:08.250526 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-15 00:22:08.276638 | controller | skipping: Conditional result was False 2026-02-15 00:22:08.283949 | 2026-02-15 00:22:08.284027 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-15 00:22:08.308333 | controller | skipping: Conditional result was False 2026-02-15 00:22:08.316489 | 2026-02-15 00:22:08.316589 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-15 00:22:08.350949 | controller | skipping: Conditional result was False 2026-02-15 00:22:08.375821 | 2026-02-15 00:22:08.375967 | TASK [Disable Fedora Modular] 2026-02-15 00:22:08.627406 | controller | changed 2026-02-15 00:22:08.639842 | 2026-02-15 00:22:08.640003 | TASK [Enable EPEL] 2026-02-15 00:22:08.667118 | controller | skipping: Conditional result was False 2026-02-15 00:22:08.679767 | 2026-02-15 00:22:08.679902 | TASK [Register the RHEL node] 2026-02-15 00:22:09.242088 | 2026-02-15 00:22:09.242556 | TASK [Show the subscription-manager status] 2026-02-15 00:22:09.829552 | controller | skipping: Conditional result was False 2026-02-15 00:22:09.836933 | 2026-02-15 00:22:09.837072 | TASK [Enable EPEL on RHEL] 2026-02-15 00:22:10.371877 | controller | skipping: Conditional result was False 2026-02-15 00:22:10.381083 | 2026-02-15 00:22:10.381161 | TASK [Install git and tox] 2026-02-15 00:23:29.547487 | controller | changed 2026-02-15 00:23:29.566308 | 2026-02-15 00:23:29.566568 | TASK [include_role : prepare-workspace] 2026-02-15 00:23:29.605163 | controller | ok 2026-02-15 00:23:29.638110 | 2026-02-15 00:23:29.638317 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-15 00:23:29.879699 | controller | ok 2026-02-15 00:23:29.889668 | 2026-02-15 00:23:29.889851 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-15 00:23:42.747283 | controller | Output suppressed because no_log was given 2026-02-15 00:23:42.793623 | 2026-02-15 00:23:42.793767 | TASK [include_role : prepare-workspace-openshift] 2026-02-15 00:23:42.819317 | controller | skipping: Conditional result was False 2026-02-15 00:23:42.843755 | 2026-02-15 00:23:42.843842 | PLAY [all:!appliance] 2026-02-15 00:23:42.861815 | 2026-02-15 00:23:42.861919 | TASK [Run add-build-sshkey role (RSA)] 2026-02-15 00:23:42.902790 | controller | ok 2026-02-15 00:23:42.918908 | 2026-02-15 00:23:42.919013 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-15 00:23:43.200793 | controller -> localhost | ok 2026-02-15 00:23:43.217351 | 2026-02-15 00:23:43.217529 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-15 00:23:43.253070 | controller | ok 2026-02-15 00:23:43.269833 | controller | included: /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-15 00:23:43.277021 | 2026-02-15 00:23:43.277117 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-15 00:23:43.729948 | controller -> localhost | Generating public/private rsa key pair. 2026-02-15 00:23:43.730350 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/f578e22c73954ccba303c9a183cfe88a_id_rsa. 2026-02-15 00:23:43.730415 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/f578e22c73954ccba303c9a183cfe88a_id_rsa.pub. 2026-02-15 00:23:43.730461 | controller -> localhost | The key fingerprint is: 2026-02-15 00:23:43.730510 | controller -> localhost | SHA256:m7h9SBxepWEwi0x0qoUzar8lPinpwym+3oNxLQdn8Dk zuul-build-sshkey 2026-02-15 00:23:43.730553 | controller -> localhost | The key's randomart image is: 2026-02-15 00:23:43.730594 | controller -> localhost | +---[RSA 2048]----+ 2026-02-15 00:23:43.730634 | controller -> localhost | | .o +. | 2026-02-15 00:23:43.730674 | controller -> localhost | | . + + oo . | 2026-02-15 00:23:43.730713 | controller -> localhost | | * * .. + | 2026-02-15 00:23:43.730951 | controller -> localhost | | o E . o | 2026-02-15 00:23:43.731006 | controller -> localhost | | o * .oSo | 2026-02-15 00:23:43.731066 | controller -> localhost | | o + o .+o | 2026-02-15 00:23:43.731127 | controller -> localhost | | .+o=.o.o. | 2026-02-15 00:23:43.731177 | controller -> localhost | |..Boo+ o. . | 2026-02-15 00:23:43.731224 | controller -> localhost | |o*o++.. .. | 2026-02-15 00:23:43.731272 | controller -> localhost | +----[SHA256]-----+ 2026-02-15 00:23:43.731377 | controller -> localhost | ok: Runtime: 0:00:00.074233 2026-02-15 00:23:43.750284 | 2026-02-15 00:23:43.750442 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-15 00:23:43.783325 | controller | ok 2026-02-15 00:23:43.802700 | controller | included: /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-15 00:23:43.817137 | 2026-02-15 00:23:43.817230 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-15 00:23:43.842915 | controller | skipping: Conditional result was False 2026-02-15 00:23:43.852683 | 2026-02-15 00:23:43.852795 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-15 00:23:44.281344 | controller | changed 2026-02-15 00:23:44.297226 | 2026-02-15 00:23:44.297721 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-15 00:23:44.524176 | controller | ok 2026-02-15 00:23:44.534321 | 2026-02-15 00:23:44.534428 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-15 00:23:45.168346 | controller | changed 2026-02-15 00:23:45.175210 | 2026-02-15 00:23:45.175290 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-15 00:23:45.799685 | controller | changed 2026-02-15 00:23:45.817174 | 2026-02-15 00:23:45.817377 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-15 00:23:45.844574 | controller | skipping: Conditional result was False 2026-02-15 00:23:45.863597 | 2026-02-15 00:23:45.863831 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-15 00:23:46.292111 | controller -> localhost | changed 2026-02-15 00:23:46.323462 | 2026-02-15 00:23:46.323628 | TASK [add-build-sshkey : Add back temp key] 2026-02-15 00:23:46.626181 | controller -> localhost | Identity added: /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/f578e22c73954ccba303c9a183cfe88a_id_rsa (zuul-build-sshkey) 2026-02-15 00:23:46.626405 | controller -> localhost | ok: Runtime: 0:00:00.013535 2026-02-15 00:23:46.633773 | 2026-02-15 00:23:46.633857 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-15 00:23:46.992625 | controller | ok 2026-02-15 00:23:47.008084 | 2026-02-15 00:23:47.008255 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-15 00:23:47.048968 | controller | skipping: Conditional result was False 2026-02-15 00:23:47.069478 | 2026-02-15 00:23:47.069619 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-15 00:23:47.095719 | controller | ok 2026-02-15 00:23:47.121105 | 2026-02-15 00:23:47.121210 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-15 00:23:47.402118 | controller -> localhost | ok 2026-02-15 00:23:47.418464 | 2026-02-15 00:23:47.418632 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-15 00:23:47.460134 | controller | ok 2026-02-15 00:23:47.485118 | controller | included: /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-15 00:23:47.494043 | 2026-02-15 00:23:47.494135 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-15 00:23:47.826005 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-15 00:23:47.826250 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/f578e22c73954ccba303c9a183cfe88a_id_ecdsa. 2026-02-15 00:23:47.826287 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/f578e22c73954ccba303c9a183cfe88a_id_ecdsa.pub. 2026-02-15 00:23:47.826331 | controller -> localhost | The key fingerprint is: 2026-02-15 00:23:47.826355 | controller -> localhost | SHA256:BcKAiceR5k/2neuKi11lB6C+W38Vp8Oc6KY7/JgYdTE zuul-build-sshkey 2026-02-15 00:23:47.826379 | controller -> localhost | The key's randomart image is: 2026-02-15 00:23:47.826409 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-15 00:23:47.826437 | controller -> localhost | | o.=.oo . | 2026-02-15 00:23:47.826459 | controller -> localhost | |. B ..o . | 2026-02-15 00:23:47.826484 | controller -> localhost | | + . . E | 2026-02-15 00:23:47.826511 | controller -> localhost | | ..o o o. . | 2026-02-15 00:23:47.826532 | controller -> localhost | | +.. .S.o+ = | 2026-02-15 00:23:47.826550 | controller -> localhost | | ...+oo. B | 2026-02-15 00:23:47.826573 | controller -> localhost | | . +. o . . | 2026-02-15 00:23:47.826600 | controller -> localhost | | o = ++o+ | 2026-02-15 00:23:47.826623 | controller -> localhost | | . =.ooBB. | 2026-02-15 00:23:47.826643 | controller -> localhost | +----[SHA256]-----+ 2026-02-15 00:23:47.826744 | controller -> localhost | ok: Runtime: 0:00:00.011419 2026-02-15 00:23:47.834762 | 2026-02-15 00:23:47.834847 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-15 00:23:47.874398 | controller | ok 2026-02-15 00:23:47.890685 | controller | included: /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-15 00:23:47.904556 | 2026-02-15 00:23:47.904652 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-15 00:23:47.940869 | controller | skipping: Conditional result was False 2026-02-15 00:23:47.950180 | 2026-02-15 00:23:47.950274 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-15 00:23:48.242315 | controller | changed 2026-02-15 00:23:48.256161 | 2026-02-15 00:23:48.256337 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-15 00:23:48.493048 | controller | ok 2026-02-15 00:23:48.509158 | 2026-02-15 00:23:48.509301 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-15 00:23:49.162136 | controller | changed 2026-02-15 00:23:49.175336 | 2026-02-15 00:23:49.175467 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-15 00:23:49.852338 | controller | changed 2026-02-15 00:23:49.870378 | 2026-02-15 00:23:49.870581 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-15 00:23:49.899680 | controller | skipping: Conditional result was False 2026-02-15 00:23:49.964531 | 2026-02-15 00:23:49.964698 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-15 00:23:50.266026 | controller -> localhost | changed 2026-02-15 00:23:50.282077 | 2026-02-15 00:23:50.282184 | TASK [add-build-sshkey : Add back temp key] 2026-02-15 00:23:50.594795 | controller -> localhost | Identity added: /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/f578e22c73954ccba303c9a183cfe88a_id_ecdsa (zuul-build-sshkey) 2026-02-15 00:23:50.595072 | controller -> localhost | ok: Runtime: 0:00:00.008494 2026-02-15 00:23:50.603227 | 2026-02-15 00:23:50.603344 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-15 00:23:50.810104 | controller | ok 2026-02-15 00:23:50.826210 | 2026-02-15 00:23:50.826382 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-15 00:23:50.863120 | controller | skipping: Conditional result was False 2026-02-15 00:23:50.889471 | 2026-02-15 00:23:50.889685 | TASK [include_role : remove-zuul-sshkey] 2026-02-15 00:23:50.917085 | controller | skipping: Conditional result was False 2026-02-15 00:23:50.925761 | 2026-02-15 00:23:50.925858 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-15 00:23:51.167471 | controller | ok: "logs" 2026-02-15 00:23:51.167969 | controller | ok: All items complete 2026-02-15 00:23:51.168061 | 2026-02-15 00:23:51.381703 | controller | ok: "artifacts" 2026-02-15 00:23:51.577800 | controller | ok: "docs" 2026-02-15 00:23:51.603348 | 2026-02-15 00:23:51.603498 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-15 00:23:51.850910 | controller | changed: "logs" 2026-02-15 00:23:52.045169 | controller | changed: "artifacts" 2026-02-15 00:23:52.239178 | controller | changed: "docs" 2026-02-15 00:23:52.299584 | 2026-02-15 00:23:52.299747 | PLAY RECAP 2026-02-15 00:23:52.299829 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-15 00:23:52.299871 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-15 00:23:52.299899 | 2026-02-15 00:23:52.467463 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-15 00:23:52.468607 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-15 00:23:53.061303 | 2026-02-15 00:23:53.061435 | PLAY [all] 2026-02-15 00:23:53.084718 | 2026-02-15 00:23:53.084867 | TASK [Install binary dependencies] 2026-02-15 00:23:53.135592 | controller | ok 2026-02-15 00:23:53.156852 | 2026-02-15 00:23:53.156985 | TASK [bindep : Include find tasks] 2026-02-15 00:23:53.186908 | controller | ok 2026-02-15 00:23:53.196144 | controller | included: /var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-15 00:23:53.203621 | 2026-02-15 00:23:53.203717 | TASK [bindep : Look for bindep.txt] 2026-02-15 00:23:53.541449 | controller | ok 2026-02-15 00:23:53.553771 | 2026-02-15 00:23:53.553966 | TASK [bindep : Define bindep_file fact] 2026-02-15 00:23:53.581484 | controller | skipping: Conditional result was False 2026-02-15 00:23:53.590631 | 2026-02-15 00:23:53.590771 | TASK [bindep : Look for other-requirements.txt] 2026-02-15 00:23:53.811365 | controller | ok 2026-02-15 00:23:53.827531 | 2026-02-15 00:23:53.827749 | TASK [bindep : Define bindep_file fact] 2026-02-15 00:23:53.864166 | controller | skipping: Conditional result was False 2026-02-15 00:23:53.877382 | 2026-02-15 00:23:53.877609 | TASK [bindep : Look for bindep fallback file] 2026-02-15 00:23:53.910778 | controller | skipping: Conditional result was False 2026-02-15 00:23:53.921834 | 2026-02-15 00:23:53.921976 | TASK [bindep : Define bindep_file fact] 2026-02-15 00:23:53.946975 | controller | skipping: Conditional result was False 2026-02-15 00:23:53.956028 | 2026-02-15 00:23:53.956145 | TASK [bindep : Include bindep tasks] 2026-02-15 00:23:53.981086 | controller | skipping: Conditional result was False 2026-02-15 00:23:53.990113 | 2026-02-15 00:23:53.990231 | TASK [bindep : Include install tasks] 2026-02-15 00:23:54.025094 | controller | skipping: Conditional result was False 2026-02-15 00:23:54.033998 | 2026-02-15 00:23:54.034104 | LOOP [bindep : Include package tasks] 2026-02-15 00:23:54.120160 | 2026-02-15 00:23:54.120348 | TASK [Run test-setup role] 2026-02-15 00:23:54.144912 | controller | ok 2026-02-15 00:23:54.172040 | 2026-02-15 00:23:54.172319 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-15 00:23:54.377914 | controller | ok 2026-02-15 00:23:54.384191 | 2026-02-15 00:23:54.384258 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-15 00:23:54.921593 | controller | skipping: Conditional result was False 2026-02-15 00:23:54.977340 | 2026-02-15 00:23:54.977451 | PLAY RECAP 2026-02-15 00:23:54.977508 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-15 00:23:54.977539 | 2026-02-15 00:23:55.090949 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-15 00:23:55.091840 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-15 00:23:55.725053 | 2026-02-15 00:23:55.725189 | PLAY [controller] 2026-02-15 00:23:55.745515 | 2026-02-15 00:23:55.745640 | TASK [Create the /root directory] 2026-02-15 00:26:08.076614 | controller | ERROR 2026-02-15 00:26:08.077215 | controller | { 2026-02-15 00:26:08.077403 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2026-02-15 00:26:08.077527 | controller | } failure 2026-02-15 00:26:08.080543 | 2026-02-15 00:26:08.080798 | PLAY RECAP 2026-02-15 00:26:08.081037 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-15 00:26:08.081375 | 2026-02-15 00:26:08.212377 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-15 00:26:08.213674 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-15 00:26:08.791308 | 2026-02-15 00:26:08.791440 | PLAY [all] 2026-02-15 00:26:08.814238 | 2026-02-15 00:26:08.814343 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-15 00:29:48.558120 | controller | changed: non-zero return code 2026-02-15 00:29:48.566375 | 2026-02-15 00:29:48.566479 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-15 00:29:48.592474 | controller | skipping: Conditional result was False 2026-02-15 00:29:48.602361 | 2026-02-15 00:29:48.602467 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-15 00:29:48.640321 | 2026-02-15 00:29:48.640523 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-15 00:29:48.694610 | 2026-02-15 00:29:48.694816 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-15 00:29:48.720281 | controller | skipping: Conditional result was False 2026-02-15 00:29:48.730267 | 2026-02-15 00:29:48.730370 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-15 00:29:48.766043 | 2026-02-15 00:29:48.766215 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-15 00:29:48.801634 | controller | skipping: Conditional result was False 2026-02-15 00:29:48.816026 | 2026-02-15 00:29:48.816224 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-15 00:29:48.843188 | controller | skipping: Conditional result was False 2026-02-15 00:29:48.849766 | 2026-02-15 00:29:48.849854 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-15 00:29:48.873982 | controller | skipping: Conditional result was False 2026-02-15 00:29:48.910720 | 2026-02-15 00:29:48.910851 | PLAY RECAP 2026-02-15 00:29:48.910894 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-15 00:29:48.910915 | 2026-02-15 00:29:49.015647 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-15 00:29:49.016971 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-15 00:29:49.642076 | 2026-02-15 00:29:49.642204 | PLAY [all:!appliance*] 2026-02-15 00:29:49.677237 | 2026-02-15 00:29:49.677371 | TASK [unregister the node] 2026-02-15 00:29:50.216986 | controller | skipping: Conditional result was False 2026-02-15 00:29:50.229663 | 2026-02-15 00:29:50.229891 | TASK [include_role : fetch-output] 2026-02-15 00:29:50.290104 | controller | ok 2026-02-15 00:29:50.329526 | 2026-02-15 00:29:50.329676 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-15 00:29:50.386086 | controller | skipping: Conditional result was False 2026-02-15 00:29:50.400462 | 2026-02-15 00:29:50.400628 | TASK [fetch-output : Set log path for single node] 2026-02-15 00:29:50.450012 | controller | ok 2026-02-15 00:29:50.462335 | 2026-02-15 00:29:50.462513 | LOOP [fetch-output : Ensure local output dirs] 2026-02-15 00:29:50.932058 | controller -> localhost | ok: "/var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/logs" 2026-02-15 00:29:51.184143 | controller -> localhost | changed: "/var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/artifacts" 2026-02-15 00:29:51.435336 | controller -> localhost | changed: "/var/lib/zuul/builds/f578e22c73954ccba303c9a183cfe88a/work/docs" 2026-02-15 00:29:51.447918 | 2026-02-15 00:29:51.448058 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-15 00:29:52.182069 | controller | changed: .d..t...... ./ 2026-02-15 00:29:52.182334 | controller | changed: All items complete 2026-02-15 00:29:52.182376 | 2026-02-15 00:29:52.674621 | controller | changed: .d..t...... ./ 2026-02-15 00:29:53.195919 | controller | changed: .d..t...... ./ 2026-02-15 00:29:53.236856 | 2026-02-15 00:29:53.237076 | TASK [include_role : fetch-output-openshift] 2026-02-15 00:29:53.254616 | controller | skipping: Conditional result was False 2026-02-15 00:29:53.265631 | 2026-02-15 00:29:53.265783 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-15 00:29:53.317117 | controller | skipping: Conditional result was False 2026-02-15 00:29:53.331391 | controller | skipping: Conditional result was False 2026-02-15 00:29:53.374623 | 2026-02-15 00:29:53.374831 | PLAY [localhost] 2026-02-15 00:29:53.392961 | 2026-02-15 00:29:53.393205 | TASK [Run Zuul manifest role] 2026-02-15 00:29:53.413691 | localhost | ok 2026-02-15 00:29:53.430040 | 2026-02-15 00:29:53.430145 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-15 00:29:53.808345 | localhost | changed 2026-02-15 00:29:53.814711 | 2026-02-15 00:29:53.814814 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-15 00:29:53.847896 | localhost | ok 2026-02-15 00:29:53.865713 | 2026-02-15 00:29:53.865857 | TASK [Set zuul-log-path fact] 2026-02-15 00:29:53.886866 | localhost | ok 2026-02-15 00:29:53.906647 | 2026-02-15 00:29:53.906799 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-15 00:29:53.937339 | localhost | ok 2026-02-15 00:29:53.948186 | 2026-02-15 00:29:53.948268 | LOOP [Run upload-logs-swift role] 2026-02-15 00:29:53.985712 | localhost | Output suppressed because no_log was given 2026-02-15 00:29:54.030242 | 2026-02-15 00:29:54.030373 | TASK [Set zuul-log-path fact] 2026-02-15 00:29:54.067153 | localhost | skipping: Conditional result was False 2026-02-15 00:29:54.078020 | 2026-02-15 00:29:54.078238 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-15 00:29:54.587920 | localhost -> localhost | ok: Runtime: 0:00:00.009227 2026-02-15 00:29:54.652779 | 2026-02-15 00:29:54.653002 | TASK [upload-logs-swift : Upload logs to swift]