2026-02-24 00:14:30.591070 | Job console starting... 2026-02-24 00:14:30.600687 | Updating repositories 2026-02-24 00:14:30.724312 | Preparing job workspace 2026-02-24 00:14:34.267062 | Running Ansible setup... 2026-02-24 00:14:39.130046 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-24 00:14:39.772222 | 2026-02-24 00:14:39.772341 | PLAY [localhost] 2026-02-24 00:14:39.783091 | 2026-02-24 00:14:39.783185 | TASK [Gathering Facts] 2026-02-24 00:14:40.797772 | localhost | ok 2026-02-24 00:14:40.819438 | 2026-02-24 00:14:40.819593 | TASK [Setup log path fact] 2026-02-24 00:14:40.839733 | localhost | ok 2026-02-24 00:14:40.855240 | 2026-02-24 00:14:40.855381 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-24 00:14:40.884164 | localhost | ok 2026-02-24 00:14:40.893579 | 2026-02-24 00:14:40.893709 | TASK [emit-job-header : Print job information] 2026-02-24 00:14:40.932333 | # Job Information 2026-02-24 00:14:40.932496 | Ansible Version: 2.15.12 2026-02-24 00:14:40.932527 | Job: ansible-test-sanity-docker-stable-2.10 2026-02-24 00:14:40.932549 | Pipeline: periodic 2026-02-24 00:14:40.932567 | Executor: ze01.softwarefactory-project.io 2026-02-24 00:14:40.932586 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-02-24 00:14:40.932643 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/909/ansible/9095a9e8a5e94beea5e3ed96fa156d86/ 2026-02-24 00:14:40.932669 | Event ID: 023de3d20dba42aeae84d5f5ac7fcc8d 2026-02-24 00:14:40.936911 | 2026-02-24 00:14:40.937035 | LOOP [emit-job-header : Print node information] 2026-02-24 00:14:41.048201 | localhost | ok: 2026-02-24 00:14:41.048457 | localhost | # Node Information 2026-02-24 00:14:41.048496 | localhost | Inventory Hostname: controller 2026-02-24 00:14:41.048524 | localhost | Hostname: np0005627469 2026-02-24 00:14:41.048549 | localhost | Username: zuul 2026-02-24 00:14:41.048579 | localhost | Distro: Fedora 37 2026-02-24 00:14:41.048605 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-24 00:14:41.048631 | localhost | Region: ca-ymq-1 2026-02-24 00:14:41.048656 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-24 00:14:41.048679 | localhost | Product Name: OpenStack Nova 2026-02-24 00:14:41.048704 | localhost | Interface IP: 162.253.55.12 2026-02-24 00:14:41.061419 | 2026-02-24 00:14:41.061527 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-24 00:14:41.554795 | localhost -> localhost | changed 2026-02-24 00:14:41.560708 | 2026-02-24 00:14:41.560792 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-24 00:14:42.496111 | localhost -> localhost | changed 2026-02-24 00:14:42.518523 | 2026-02-24 00:14:42.518632 | PLAY [all:!appliance*] 2026-02-24 00:14:42.535826 | 2026-02-24 00:14:42.535907 | TASK [include_role : start-zuul-console] 2026-02-24 00:14:42.555923 | controller | ok 2026-02-24 00:14:42.572744 | 2026-02-24 00:14:42.572864 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-24 00:14:42.951430 | controller | ok 2026-02-24 00:14:42.962629 | 2026-02-24 00:14:42.962737 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-24 00:14:43.990384 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-24 00:14:44.009095 | 2026-02-24 00:14:44.009318 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-24 00:14:44.556464 | controller | skipping: Conditional result was False 2026-02-24 00:14:44.565012 | 2026-02-24 00:14:44.565143 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-24 00:14:44.599591 | controller | skipping: Conditional result was False 2026-02-24 00:14:44.606715 | 2026-02-24 00:14:44.606814 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-24 00:14:44.642051 | controller | skipping: Conditional result was False 2026-02-24 00:14:44.649055 | 2026-02-24 00:14:44.649152 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-24 00:14:44.674195 | controller | skipping: Conditional result was False 2026-02-24 00:14:44.681733 | 2026-02-24 00:14:44.681842 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-24 00:14:44.707846 | controller | skipping: Conditional result was False 2026-02-24 00:14:44.715063 | 2026-02-24 00:14:44.715159 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-24 00:14:44.740695 | controller | skipping: Conditional result was False 2026-02-24 00:14:44.754281 | 2026-02-24 00:14:44.754382 | TASK [Disable Fedora Modular] 2026-02-24 00:14:45.005759 | controller | changed 2026-02-24 00:14:45.014651 | 2026-02-24 00:14:45.014722 | TASK [Enable EPEL] 2026-02-24 00:14:45.040086 | controller | skipping: Conditional result was False 2026-02-24 00:14:45.047802 | 2026-02-24 00:14:45.047886 | TASK [Register the RHEL node] 2026-02-24 00:14:45.599987 | 2026-02-24 00:14:45.600248 | TASK [Show the subscription-manager status] 2026-02-24 00:14:46.175632 | controller | skipping: Conditional result was False 2026-02-24 00:14:46.184032 | 2026-02-24 00:14:46.184131 | TASK [Enable EPEL on RHEL] 2026-02-24 00:14:46.759629 | controller | skipping: Conditional result was False 2026-02-24 00:14:46.787589 | 2026-02-24 00:14:46.787903 | TASK [Install git and tox] 2026-02-24 00:16:15.423378 | controller | changed 2026-02-24 00:16:15.430861 | 2026-02-24 00:16:15.430990 | TASK [include_role : prepare-workspace] 2026-02-24 00:16:15.450963 | controller | ok 2026-02-24 00:16:15.472868 | 2026-02-24 00:16:15.472975 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-24 00:16:15.707382 | controller | ok 2026-02-24 00:16:15.714398 | 2026-02-24 00:16:15.714507 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-24 00:16:28.014946 | controller | Output suppressed because no_log was given 2026-02-24 00:16:28.070196 | 2026-02-24 00:16:28.070367 | TASK [include_role : prepare-workspace-openshift] 2026-02-24 00:16:28.088949 | controller | skipping: Conditional result was False 2026-02-24 00:16:28.120340 | 2026-02-24 00:16:28.120428 | PLAY [all:!appliance] 2026-02-24 00:16:28.143890 | 2026-02-24 00:16:28.144038 | TASK [Run add-build-sshkey role (RSA)] 2026-02-24 00:16:28.166519 | controller | ok 2026-02-24 00:16:28.187493 | 2026-02-24 00:16:28.187594 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-24 00:16:28.496799 | controller -> localhost | ok 2026-02-24 00:16:28.510749 | 2026-02-24 00:16:28.510909 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-24 00:16:28.542857 | controller | ok 2026-02-24 00:16:28.575449 | controller | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-24 00:16:28.590286 | 2026-02-24 00:16:28.590424 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-24 00:16:29.076401 | controller -> localhost | Generating public/private rsa key pair. 2026-02-24 00:16:29.076628 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/9095a9e8a5e94beea5e3ed96fa156d86_id_rsa. 2026-02-24 00:16:29.076658 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/9095a9e8a5e94beea5e3ed96fa156d86_id_rsa.pub. 2026-02-24 00:16:29.076678 | controller -> localhost | The key fingerprint is: 2026-02-24 00:16:29.076697 | controller -> localhost | SHA256:9MV8+l85Xb58+FILw/ctPVC1xpM+49syWiQnd0ygBjE zuul-build-sshkey 2026-02-24 00:16:29.076716 | controller -> localhost | The key's randomart image is: 2026-02-24 00:16:29.076734 | controller -> localhost | +---[RSA 2048]----+ 2026-02-24 00:16:29.076753 | controller -> localhost | | E. . | 2026-02-24 00:16:29.076772 | controller -> localhost | | = . ..| 2026-02-24 00:16:29.076791 | controller -> localhost | | . * o =| 2026-02-24 00:16:29.076809 | controller -> localhost | | . . o o X | 2026-02-24 00:16:29.076826 | controller -> localhost | | S . = B =| 2026-02-24 00:16:29.076857 | controller -> localhost | | % B=| 2026-02-24 00:16:29.076880 | controller -> localhost | | O*X| 2026-02-24 00:16:29.076900 | controller -> localhost | | .B=X| 2026-02-24 00:16:29.076920 | controller -> localhost | | .. XB| 2026-02-24 00:16:29.076941 | controller -> localhost | +----[SHA256]-----+ 2026-02-24 00:16:29.076998 | controller -> localhost | ok: Runtime: 0:00:00.050317 2026-02-24 00:16:29.085722 | 2026-02-24 00:16:29.085847 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-24 00:16:29.124930 | controller | ok 2026-02-24 00:16:29.141356 | controller | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-24 00:16:29.154625 | 2026-02-24 00:16:29.154768 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-24 00:16:29.181059 | controller | skipping: Conditional result was False 2026-02-24 00:16:29.191134 | 2026-02-24 00:16:29.191274 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-24 00:16:29.638937 | controller | changed 2026-02-24 00:16:29.652454 | 2026-02-24 00:16:29.652588 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-24 00:16:29.882626 | controller | ok 2026-02-24 00:16:29.888445 | 2026-02-24 00:16:29.888544 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-24 00:16:30.486707 | controller | changed 2026-02-24 00:16:30.502988 | 2026-02-24 00:16:30.503235 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-24 00:21:34.078587 | controller | changed 2026-02-24 00:21:34.089401 | 2026-02-24 00:21:34.089551 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-24 00:21:34.116651 | controller | skipping: Conditional result was False 2026-02-24 00:21:34.127719 | 2026-02-24 00:21:34.127838 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-24 00:21:34.554519 | controller -> localhost | changed 2026-02-24 00:21:34.569543 | 2026-02-24 00:21:34.569676 | TASK [add-build-sshkey : Add back temp key] 2026-02-24 00:21:34.893449 | controller -> localhost | Identity added: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/9095a9e8a5e94beea5e3ed96fa156d86_id_rsa (zuul-build-sshkey) 2026-02-24 00:21:34.893891 | controller -> localhost | ok: Runtime: 0:00:00.015266 2026-02-24 00:21:34.909472 | 2026-02-24 00:21:34.909660 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-24 00:21:35.266274 | controller | ok 2026-02-24 00:21:35.283419 | 2026-02-24 00:21:35.283558 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-24 00:21:35.308329 | controller | skipping: Conditional result was False 2026-02-24 00:21:35.326546 | 2026-02-24 00:21:35.326692 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-24 00:21:35.346967 | controller | ok 2026-02-24 00:21:35.363369 | 2026-02-24 00:21:35.363459 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-24 00:21:35.623465 | controller -> localhost | ok 2026-02-24 00:21:35.679342 | 2026-02-24 00:21:35.679494 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-24 00:21:35.714552 | controller | ok 2026-02-24 00:21:35.733662 | controller | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-24 00:21:35.743114 | 2026-02-24 00:21:35.743241 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-24 00:21:36.064182 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-24 00:21:36.064460 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/9095a9e8a5e94beea5e3ed96fa156d86_id_ecdsa. 2026-02-24 00:21:36.064518 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/9095a9e8a5e94beea5e3ed96fa156d86_id_ecdsa.pub. 2026-02-24 00:21:36.064578 | controller -> localhost | The key fingerprint is: 2026-02-24 00:21:36.064621 | controller -> localhost | SHA256:4XieqqMpbS8skANO6CcWhOHwKLkdiMqjBCu81jPiu6o zuul-build-sshkey 2026-02-24 00:21:36.064661 | controller -> localhost | The key's randomart image is: 2026-02-24 00:21:36.064703 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-24 00:21:36.064741 | controller -> localhost | |+. | 2026-02-24 00:21:36.064778 | controller -> localhost | |=* | 2026-02-24 00:21:36.064815 | controller -> localhost | |X.o . | 2026-02-24 00:21:36.064851 | controller -> localhost | |O* . o . | 2026-02-24 00:21:36.064888 | controller -> localhost | |X*o . S | 2026-02-24 00:21:36.064925 | controller -> localhost | |B=+. o . | 2026-02-24 00:21:36.064961 | controller -> localhost | |+Bo+ o | 2026-02-24 00:21:36.064998 | controller -> localhost | |= *.+ . | 2026-02-24 00:21:36.065077 | controller -> localhost | |EB=+oo. | 2026-02-24 00:21:36.065118 | controller -> localhost | +----[SHA256]-----+ 2026-02-24 00:21:36.065238 | controller -> localhost | ok: Runtime: 0:00:00.014110 2026-02-24 00:21:36.079110 | 2026-02-24 00:21:36.079251 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-24 00:21:36.112161 | controller | ok 2026-02-24 00:21:36.120042 | controller | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-24 00:21:36.129559 | 2026-02-24 00:21:36.129637 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-24 00:21:36.154169 | controller | skipping: Conditional result was False 2026-02-24 00:21:36.162376 | 2026-02-24 00:21:36.162466 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-24 00:21:36.456277 | controller | changed 2026-02-24 00:21:36.470191 | 2026-02-24 00:21:36.470579 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-24 00:21:36.702660 | controller | ok 2026-02-24 00:21:36.711375 | 2026-02-24 00:21:36.711483 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-24 00:21:37.349917 | controller | changed 2026-02-24 00:21:37.360007 | 2026-02-24 00:21:37.360257 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-24 00:21:38.019635 | controller | changed 2026-02-24 00:21:38.033799 | 2026-02-24 00:21:38.034001 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-24 00:21:38.062228 | controller | skipping: Conditional result was False 2026-02-24 00:21:38.078356 | 2026-02-24 00:21:38.078521 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-24 00:21:38.361114 | controller -> localhost | changed 2026-02-24 00:21:38.389275 | 2026-02-24 00:21:38.389441 | TASK [add-build-sshkey : Add back temp key] 2026-02-24 00:21:38.702323 | controller -> localhost | Identity added: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/9095a9e8a5e94beea5e3ed96fa156d86_id_ecdsa (zuul-build-sshkey) 2026-02-24 00:21:38.702551 | controller -> localhost | ok: Runtime: 0:00:00.008746 2026-02-24 00:21:38.710058 | 2026-02-24 00:21:38.710135 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-24 00:21:38.911955 | controller | ok 2026-02-24 00:21:38.918074 | 2026-02-24 00:21:38.918158 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-24 00:21:38.945376 | controller | skipping: Conditional result was False 2026-02-24 00:21:38.969102 | 2026-02-24 00:21:38.969338 | TASK [include_role : remove-zuul-sshkey] 2026-02-24 00:21:38.998768 | controller | skipping: Conditional result was False 2026-02-24 00:21:39.007595 | 2026-02-24 00:21:39.007784 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-24 00:21:39.224951 | controller | ok: "logs" 2026-02-24 00:21:39.225339 | controller | ok: All items complete 2026-02-24 00:21:39.225369 | 2026-02-24 00:21:39.412688 | controller | ok: "artifacts" 2026-02-24 00:21:39.621085 | controller | ok: "docs" 2026-02-24 00:21:39.639277 | 2026-02-24 00:21:39.639532 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-24 00:21:39.855726 | controller | changed: "logs" 2026-02-24 00:21:40.044383 | controller | changed: "artifacts" 2026-02-24 00:21:40.238463 | controller | changed: "docs" 2026-02-24 00:21:40.280813 | 2026-02-24 00:21:40.280906 | PLAY RECAP 2026-02-24 00:21:40.280950 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-24 00:21:40.280976 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-24 00:21:40.280996 | 2026-02-24 00:21:40.401186 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-24 00:21:40.403913 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-24 00:21:41.049603 | 2026-02-24 00:21:41.049741 | PLAY [all] 2026-02-24 00:21:41.077167 | 2026-02-24 00:21:41.077338 | TASK [Install binary dependencies] 2026-02-24 00:21:41.140327 | controller | ok 2026-02-24 00:21:41.170858 | 2026-02-24 00:21:41.171066 | TASK [bindep : Include find tasks] 2026-02-24 00:21:41.216289 | controller | ok 2026-02-24 00:21:41.225047 | controller | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-24 00:21:41.231331 | 2026-02-24 00:21:41.231398 | TASK [bindep : Look for bindep.txt] 2026-02-24 00:21:41.790278 | controller | ok 2026-02-24 00:21:41.796607 | 2026-02-24 00:21:41.796728 | TASK [bindep : Define bindep_file fact] 2026-02-24 00:21:41.810671 | controller | skipping: Conditional result was False 2026-02-24 00:21:41.817141 | 2026-02-24 00:21:41.817264 | TASK [bindep : Look for other-requirements.txt] 2026-02-24 00:21:42.026891 | controller | ok 2026-02-24 00:21:42.038169 | 2026-02-24 00:21:42.038295 | TASK [bindep : Define bindep_file fact] 2026-02-24 00:21:42.063823 | controller | skipping: Conditional result was False 2026-02-24 00:21:42.077502 | 2026-02-24 00:21:42.077726 | TASK [bindep : Look for bindep fallback file] 2026-02-24 00:21:42.105481 | controller | skipping: Conditional result was False 2026-02-24 00:21:42.117254 | 2026-02-24 00:21:42.117397 | TASK [bindep : Define bindep_file fact] 2026-02-24 00:21:42.143469 | controller | skipping: Conditional result was False 2026-02-24 00:21:42.149766 | 2026-02-24 00:21:42.149844 | TASK [bindep : Include bindep tasks] 2026-02-24 00:21:42.173569 | controller | skipping: Conditional result was False 2026-02-24 00:21:42.180254 | 2026-02-24 00:21:42.180318 | TASK [bindep : Include install tasks] 2026-02-24 00:21:42.214055 | controller | skipping: Conditional result was False 2026-02-24 00:21:42.220345 | 2026-02-24 00:21:42.220413 | LOOP [bindep : Include package tasks] 2026-02-24 00:21:42.302159 | 2026-02-24 00:21:42.302367 | TASK [Run test-setup role] 2026-02-24 00:21:42.325865 | controller | ok 2026-02-24 00:21:42.350504 | 2026-02-24 00:21:42.350657 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-24 00:21:42.563338 | controller | ok 2026-02-24 00:21:42.579442 | 2026-02-24 00:21:42.579595 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-24 00:21:43.133427 | controller | skipping: Conditional result was False 2026-02-24 00:21:43.176862 | 2026-02-24 00:21:43.176968 | PLAY RECAP 2026-02-24 00:21:43.177011 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-24 00:21:43.177073 | 2026-02-24 00:21:43.283912 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-24 00:21:43.285001 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-24 00:21:43.920593 | 2026-02-24 00:21:43.920727 | PLAY [controller] 2026-02-24 00:21:43.941391 | 2026-02-24 00:21:43.941553 | TASK [Create the /root directory] 2026-02-24 00:21:44.491496 | controller | ok 2026-02-24 00:21:44.501859 | 2026-02-24 00:21:44.502000 | TASK [Install glibc-langpack-en] 2026-02-24 00:21:48.447091 | controller | ok: Nothing to do 2026-02-24 00:21:48.457994 | 2026-02-24 00:21:48.458168 | TASK [Ensure controller directory exists] 2026-02-24 00:21:48.679879 | controller | changed 2026-02-24 00:21:48.692839 | 2026-02-24 00:21:48.693004 | TASK [Install container runtime] 2026-02-24 00:21:48.770989 | controller | ok 2026-02-24 00:21:48.823290 | 2026-02-24 00:21:48.824024 | LOOP [ensure-docker : Gather variables for each operating system] 2026-02-24 00:21:48.876079 | controller | ok: "/var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml" 2026-02-24 00:21:48.890050 | 2026-02-24 00:21:48.890199 | TASK [ensure-docker : Sanity check for distro selection] 2026-02-24 00:21:48.915658 | controller | skipping: Conditional result was False 2026-02-24 00:21:48.922524 | 2026-02-24 00:21:48.922601 | TASK [ensure-docker : Sanity check for distro install] 2026-02-24 00:21:48.948164 | controller | skipping: Conditional result was False 2026-02-24 00:21:48.954504 | 2026-02-24 00:21:48.954582 | TASK [ensure-docker : Sanity check for upstream install] 2026-02-24 00:21:48.979155 | controller | skipping: Conditional result was False 2026-02-24 00:21:48.985609 | 2026-02-24 00:21:48.985700 | TASK [ensure-docker : Sanity check for upstream install mirrors] 2026-02-24 00:21:49.010445 | controller | skipping: Conditional result was False 2026-02-24 00:21:49.018906 | 2026-02-24 00:21:49.019088 | TASK [ensure-docker : Include tasks for docker install] 2026-02-24 00:21:49.039623 | controller | ok 2026-02-24 00:21:49.048771 | controller | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml 2026-02-24 00:21:49.056925 | 2026-02-24 00:21:49.057056 | TASK [ensure-docker : Not Implemented] 2026-02-24 00:21:49.072331 | controller | skipping: Conditional result was False 2026-02-24 00:21:49.079596 | 2026-02-24 00:21:49.079706 | TASK [Set up docker mirrors] 2026-02-24 00:21:49.102613 | controller | ok 2026-02-24 00:21:49.139395 | 2026-02-24 00:21:49.139537 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info] 2026-02-24 00:21:49.173867 | controller | skipping: Conditional result was False 2026-02-24 00:21:49.180152 | 2026-02-24 00:21:49.180224 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info] 2026-02-24 00:21:49.204103 | controller | skipping: Conditional result was False 2026-02-24 00:21:49.210356 | 2026-02-24 00:21:49.210423 | TASK [use-docker-mirror : Set docker_mirror fact] 2026-02-24 00:21:49.234273 | controller | skipping: Conditional result was False 2026-02-24 00:21:49.240831 | 2026-02-24 00:21:49.240897 | TASK [use-docker-mirror : Set up docker mirrors] 2026-02-24 00:21:49.265122 | controller | skipping: Conditional result was False 2026-02-24 00:21:49.277066 | 2026-02-24 00:21:49.277132 | TASK [Add all repositories] 2026-02-24 00:21:49.297270 | controller | ok 2026-02-24 00:21:49.322207 | 2026-02-24 00:21:49.322322 | LOOP [ensure-package-repositories : Install repositories] 2026-02-24 00:21:49.345173 | controller | ok: "/var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml" 2026-02-24 00:21:49.345406 | controller | ok: All items complete 2026-02-24 00:21:49.345434 | 2026-02-24 00:21:49.395894 | controller | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml 2026-02-24 00:21:49.404090 | 2026-02-24 00:21:49.404210 | TASK [ensure-package-repositories : Create GPG key temp directory] 2026-02-24 00:21:49.710459 | controller | changed 2026-02-24 00:21:49.717234 | 2026-02-24 00:21:49.717323 | LOOP [ensure-package-repositories : Upload GPG keys] 2026-02-24 00:21:50.585112 | controller | changed: 2026-02-24 00:21:50.585292 | controller | { 2026-02-24 00:21:50.585318 | controller | "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n" 2026-02-24 00:21:50.585340 | controller | } 2026-02-24 00:21:50.600631 | 2026-02-24 00:21:50.600783 | LOOP [ensure-package-repositories : Import GPG keys] 2026-02-24 00:21:51.259653 | controller | changed: 2026-02-24 00:21:51.260325 | controller | { 2026-02-24 00:21:51.260385 | controller | "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n" 2026-02-24 00:21:51.260427 | controller | } 2026-02-24 00:21:51.260474 | controller | changed: All items complete 2026-02-24 00:21:51.260501 | 2026-02-24 00:21:51.300206 | 2026-02-24 00:21:51.302221 | TASK [ensure-package-repositories : Remove GPG temp directory] 2026-02-24 00:21:51.529585 | controller | changed 2026-02-24 00:21:51.537437 | 2026-02-24 00:21:51.537536 | LOOP [ensure-package-repositories : Add repositories] 2026-02-24 00:21:51.892791 | controller | changed: 2026-02-24 00:21:51.893073 | controller | { 2026-02-24 00:21:51.893113 | controller | "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable", 2026-02-24 00:21:51.893182 | controller | "description": "Docker CE Stable - $basearch", 2026-02-24 00:21:51.893236 | controller | "gpgcheck": true, 2026-02-24 00:21:51.893278 | controller | "name": "docker-ce-stable" 2026-02-24 00:21:51.893309 | controller | } 2026-02-24 00:21:51.930506 | 2026-02-24 00:21:51.930722 | TASK [ensure-docker : Install pre-reqs] 2026-02-24 00:21:54.544239 | controller | ok: Nothing to do 2026-02-24 00:21:54.550992 | 2026-02-24 00:21:54.551121 | TASK [ensure-docker : Remove packages] 2026-02-24 00:21:55.875964 | controller | ok: Nothing to do 2026-02-24 00:21:55.894032 | 2026-02-24 00:21:55.894226 | TASK [ensure-docker : Install upstream docker using package] 2026-02-24 00:22:42.051923 | controller | changed 2026-02-24 00:22:42.065528 | 2026-02-24 00:22:42.065699 | TASK [ensure-docker : Setup docker] 2026-02-24 00:22:42.105160 | controller | ok 2026-02-24 00:22:42.128944 | controller | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml 2026-02-24 00:22:42.146766 | 2026-02-24 00:22:42.146889 | TASK [ensure-docker : Ensure "docker" group exists] 2026-02-24 00:22:42.517164 | controller | ok 2026-02-24 00:22:42.531629 | 2026-02-24 00:22:42.531807 | TASK [ensure-docker : Add user to docker group] 2026-02-24 00:22:43.027912 | controller | changed 2026-02-24 00:22:43.035938 | 2026-02-24 00:22:43.036080 | TASK [Update docker daemon proxy configuration] 2026-02-24 00:22:43.081517 | controller | skipping: Conditional result was False 2026-02-24 00:22:43.088685 | 2026-02-24 00:22:43.088775 | TASK [Lower default MTU] 2026-02-24 00:22:43.113779 | controller | skipping: Conditional result was False 2026-02-24 00:22:43.124470 | 2026-02-24 00:22:43.124575 | TASK [ensure-docker : Get the status of the docket.socket unit] 2026-02-24 00:22:43.519585 | controller | inactive 2026-02-24 00:22:43.708318 | controller | ok: Runtime: 0:00:00.011630 2026-02-24 00:22:43.725935 | 2026-02-24 00:22:43.726157 | TASK [ensure-docker : Get the status of the docket unit] 2026-02-24 00:22:43.981667 | controller | inactive 2026-02-24 00:22:44.294464 | controller | ok: Runtime: 0:00:00.008348 2026-02-24 00:22:44.320005 | 2026-02-24 00:22:44.320327 | TASK [ensure-docker : Restart docker] 2026-02-24 00:22:44.391589 | Trigger a Docker restart 2026-02-24 00:22:44.410003 | 2026-02-24 00:22:44.410188 | TASK [ensure-docker : Reset ssh connection to pick up docker group] 2026-02-24 00:22:44.457090 | 2026-02-24 00:22:44.457279 | TASK [ensure-docker : Install docker-compose] 2026-02-24 00:22:44.483052 | controller | skipping: Conditional result was False 2026-02-24 00:22:44.493519 | 2026-02-24 00:22:44.493666 | TASK [ensure-docker : Flush handlers before role exit] 2026-02-24 00:22:44.510000 | 2026-02-24 00:22:44.510124 | TASK [ensure-docker : Stop docker.socket to avoid any conflict] 2026-02-24 00:22:45.818910 | controller | changed 2026-02-24 00:22:45.838428 | 2026-02-24 00:22:45.838636 | TASK [ensure-docker : Assure docker service is running] 2026-02-24 00:22:47.848159 | controller | changed 2026-02-24 00:22:47.865300 | 2026-02-24 00:22:47.865563 | TASK [ensure-docker : Assure docker.socket service is running] 2026-02-24 00:22:48.790641 | controller | ok 2026-02-24 00:22:48.803192 | 2026-02-24 00:22:48.803325 | TASK [ensure-docker : Correct group ownership on docker sock] 2026-02-24 00:22:49.392678 | controller | ok 2026-02-24 00:22:49.399328 | 2026-02-24 00:22:49.399601 | TASK [ensure-docker : Validate ability to talk with docker] 2026-02-24 00:22:49.960288 | controller | CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES 2026-02-24 00:22:50.437687 | controller | ok: Runtime: 0:00:00.053309 2026-02-24 00:22:50.444133 | 2026-02-24 00:22:50.444243 | TASK [ensure-docker : Get version details] 2026-02-24 00:22:50.661994 | controller | Client: Docker Engine - Community 2026-02-24 00:22:50.662117 | controller | Version: 24.0.7 2026-02-24 00:22:50.662158 | controller | API version: 1.43 2026-02-24 00:22:50.662189 | controller | Go version: go1.20.10 2026-02-24 00:22:50.662239 | controller | Git commit: afdd53b 2026-02-24 00:22:50.662283 | controller | Built: Thu Oct 26 09:09:39 2023 2026-02-24 00:22:50.662325 | controller | OS/Arch: linux/amd64 2026-02-24 00:22:50.662369 | controller | Context: default 2026-02-24 00:22:50.662389 | controller | 2026-02-24 00:22:50.662422 | controller | Server: Docker Engine - Community 2026-02-24 00:22:50.662464 | controller | Engine: 2026-02-24 00:22:50.662565 | controller | Version: 24.0.7 2026-02-24 00:22:50.662597 | controller | API version: 1.43 (minimum version 1.12) 2026-02-24 00:22:50.662638 | controller | Go version: go1.20.10 2026-02-24 00:22:50.662668 | controller | Git commit: 311b9ff 2026-02-24 00:22:50.662715 | controller | Built: Thu Oct 26 09:08:11 2023 2026-02-24 00:22:50.662750 | controller | OS/Arch: linux/amd64 2026-02-24 00:22:50.662810 | controller | Experimental: false 2026-02-24 00:22:50.662830 | controller | containerd: 2026-02-24 00:22:50.662910 | controller | Version: 1.6.25 2026-02-24 00:22:50.662953 | controller | GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f 2026-02-24 00:22:50.662972 | controller | runc: 2026-02-24 00:22:50.663040 | controller | Version: 1.1.10 2026-02-24 00:22:50.663089 | controller | GitCommit: v1.1.10-0-g18a0cb0 2026-02-24 00:22:50.663110 | controller | docker-init: 2026-02-24 00:22:50.663170 | controller | Version: 0.19.0 2026-02-24 00:22:50.663201 | controller | GitCommit: de40ad0 2026-02-24 00:22:50.984386 | controller | ok: Runtime: 0:00:00.025681 2026-02-24 00:22:50.993885 | 2026-02-24 00:22:50.994079 | TASK [ensure-docker : Dump installed docker details] 2026-02-24 00:22:51.040208 | {'changed': True, 'stdout': 'Client: Docker Engine - Community\n Version: 24.0.7\n API version: 1.43\n Go version: go1.20.10\n Git commit: afdd53b\n Built: Thu Oct 26 09:09:39 2023\n OS/Arch: linux/amd64\n Context: default\n\nServer: Docker Engine - Community\n Engine:\n Version: 24.0.7\n API version: 1.43 (minimum version 1.12)\n Go version: go1.20.10\n Git commit: 311b9ff\n Built: Thu Oct 26 09:08:11 2023\n OS/Arch: linux/amd64\n Experimental: false\n containerd:\n Version: 1.6.25\n GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f\n runc:\n Version: 1.1.10\n GitCommit: v1.1.10-0-g18a0cb0\n docker-init:\n Version: 0.19.0\n GitCommit: de40ad0', 'stderr': '', 'rc': 0, 'cmd': ['docker', 'version'], 'start': '2026-02-24 00:22:50.638853', 'end': '2026-02-24 00:22:50.664534', 'delta': '0:00:00.025681', 'msg': '', 'zuul_log_id': 'fa163ec2-ffbe-1180-c0e2-000000000061-1-controller', 'stdout_lines': ['Client: Docker Engine - Community', ' Version: 24.0.7', ' API version: 1.43', ' Go version: go1.20.10', ' Git commit: afdd53b', ' Built: Thu Oct 26 09:09:39 2023', ' OS/Arch: linux/amd64', ' Context: default', '', 'Server: Docker Engine - Community', ' Engine:', ' Version: 24.0.7', ' API version: 1.43 (minimum version 1.12)', ' Go version: go1.20.10', ' Git commit: 311b9ff', ' Built: Thu Oct 26 09:08:11 2023', ' OS/Arch: linux/amd64', ' Experimental: false', ' containerd:', ' Version: 1.6.25', ' GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f', ' runc:', ' Version: 1.1.10', ' GitCommit: v1.1.10-0-g18a0cb0', ' docker-init:', ' Version: 0.19.0', ' GitCommit: de40ad0'], 'stderr_lines': [], 'failed': False} 2026-02-24 00:22:51.050271 | 2026-02-24 00:22:51.050413 | TASK [Use buildset registry] 2026-02-24 00:22:51.077705 | controller | skipping: Conditional result was False 2026-02-24 00:22:51.095234 | 2026-02-24 00:22:51.095389 | TASK [Ensure python3.8 is present] 2026-02-24 00:22:51.122319 | controller | skipping: Conditional result was False 2026-02-24 00:22:51.132517 | 2026-02-24 00:22:51.132668 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-24 00:22:51.157502 | controller | ok 2026-02-24 00:22:51.191473 | 2026-02-24 00:22:51.191636 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-24 00:22:53.363825 | controller | ok: Nothing to do 2026-02-24 00:22:53.373150 | 2026-02-24 00:22:53.373319 | TASK [our-ensure-python : Also install python3-devel] 2026-02-24 00:23:04.850654 | controller | changed 2026-02-24 00:23:04.876869 | 2026-02-24 00:23:04.877125 | TASK [Run ensure-virtualenv role] 2026-02-24 00:23:04.903470 | controller | ok 2026-02-24 00:23:04.940144 | 2026-02-24 00:23:04.940526 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-02-24 00:23:05.149996 | controller | /usr/bin/virtualenv 2026-02-24 00:23:05.473849 | controller | ok: Runtime: 0:00:00.004536 2026-02-24 00:23:05.482291 | 2026-02-24 00:23:05.482394 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-02-24 00:23:05.505470 | controller | skipping: Conditional result was False 2026-02-24 00:23:05.505935 | controller | changed: All items complete 2026-02-24 00:23:05.505996 | 2026-02-24 00:23:05.531206 | 2026-02-24 00:23:05.531384 | TASK [Find the full path of the Python interpreter] 2026-02-24 00:23:05.762617 | controller | /usr/bin/python3.8 2026-02-24 00:23:06.074713 | controller | ok 2026-02-24 00:23:06.082700 | 2026-02-24 00:23:06.082851 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-02-24 00:23:07.732483 | controller | created virtual environment CPython3.8.18.final.0-64 in 840ms 2026-02-24 00:23:07.775408 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-02-24 00:23:07.775443 | controller | seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) 2026-02-24 00:23:07.775453 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-02-24 00:23:07.775467 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-02-24 00:23:08.126996 | controller | changed 2026-02-24 00:23:08.134373 | 2026-02-24 00:23:08.134466 | TASK [Set selinux package] 2026-02-24 00:23:08.171246 | controller | ok 2026-02-24 00:23:08.180733 | 2026-02-24 00:23:08.180828 | TASK [Set selinux package (Fedora)] 2026-02-24 00:23:08.224395 | controller | ok 2026-02-24 00:23:08.231510 | 2026-02-24 00:23:08.231625 | TASK [Install selinux into virtualenv] 2026-02-24 00:23:11.413573 | controller | Collecting selinux-please-lie-to-me 2026-02-24 00:23:11.502175 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-02-24 00:23:12.550050 | controller | Collecting setuptools<50.0.0 2026-02-24 00:23:12.554822 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-02-24 00:23:12.637949 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 11.4 MB/s eta 0:00:00 2026-02-24 00:23:12.840172 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-02-24 00:23:12.843764 | controller | Attempting uninstall: setuptools 2026-02-24 00:23:12.849349 | controller | Found existing installation: setuptools 62.6.0 2026-02-24 00:23:13.066393 | controller | Uninstalling setuptools-62.6.0: 2026-02-24 00:23:13.099274 | controller | Successfully uninstalled setuptools-62.6.0 2026-02-24 00:23:13.801248 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-02-24 00:23:14.141225 | controller | 2026-02-24 00:23:14.370458 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1 2026-02-24 00:23:14.370478 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip 2026-02-24 00:23:14.781008 | controller | ok: Runtime: 0:00:05.597914 2026-02-24 00:23:14.787063 | 2026-02-24 00:23:14.787151 | TASK [Install pytest-forked into virtualenv] 2026-02-24 00:23:16.021547 | controller | Collecting pytest-forked 2026-02-24 00:23:16.104635 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-02-24 00:23:16.194720 | controller | Collecting py 2026-02-24 00:23:16.200150 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-02-24 00:23:16.235458 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 3.0 MB/s eta 0:00:00 2026-02-24 00:23:16.838846 | controller | Collecting pytest>=3.10 2026-02-24 00:23:16.844858 | controller | Downloading pytest-8.3.5-py3-none-any.whl (343 kB) 2026-02-24 00:23:16.864394 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 343.6/343.6 kB 20.5 MB/s eta 0:00:00 2026-02-24 00:23:17.032601 | controller | Collecting packaging 2026-02-24 00:23:17.036163 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-24 00:23:17.044293 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 10.6 MB/s eta 0:00:00 2026-02-24 00:23:17.071905 | controller | Collecting pluggy<2,>=1.5 2026-02-24 00:23:17.076348 | controller | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2026-02-24 00:23:17.101773 | controller | Collecting iniconfig 2026-02-24 00:23:17.105242 | controller | Downloading iniconfig-2.1.0-py3-none-any.whl (6.0 kB) 2026-02-24 00:23:17.161793 | controller | Collecting tomli>=1 2026-02-24 00:23:17.165304 | controller | Downloading tomli-2.4.0-py3-none-any.whl (14 kB) 2026-02-24 00:23:17.201714 | controller | Collecting exceptiongroup>=1.0.0rc8 2026-02-24 00:23:17.205227 | controller | Downloading exceptiongroup-1.3.1-py3-none-any.whl (16 kB) 2026-02-24 00:23:17.392754 | controller | Collecting typing-extensions>=4.6.0 2026-02-24 00:23:17.403711 | controller | Downloading typing_extensions-4.13.2-py3-none-any.whl (45 kB) 2026-02-24 00:23:17.415063 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.8/45.8 kB 4.5 MB/s eta 0:00:00 2026-02-24 00:23:17.613561 | controller | Installing collected packages: typing-extensions, tomli, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked 2026-02-24 00:23:18.324435 | controller | Successfully installed exceptiongroup-1.3.1 iniconfig-2.1.0 packaging-26.0 pluggy-1.5.0 py-1.11.0 pytest-8.3.5 pytest-forked-1.6.0 tomli-2.4.0 typing-extensions-4.13.2 2026-02-24 00:23:18.328930 | controller | 2026-02-24 00:23:18.397457 | controller | [notice] A new release of pip available: 22.2.2 -> 25.0.1 2026-02-24 00:23:18.397484 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip 2026-02-24 00:23:18.842191 | controller | ok: Runtime: 0:00:03.126867 2026-02-24 00:23:18.876297 | 2026-02-24 00:23:18.876517 | TASK [Update pip] 2026-02-24 00:23:20.598402 | controller | Requirement already satisfied: pip in ./venv/lib/python3.8/site-packages (22.2.2) 2026-02-24 00:23:20.957934 | controller | Collecting pip 2026-02-24 00:23:21.051579 | controller | Downloading pip-25.0.1-py3-none-any.whl (1.8 MB) 2026-02-24 00:23:21.144042 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 20.8 MB/s eta 0:00:00 2026-02-24 00:23:21.196975 | controller | Installing collected packages: pip 2026-02-24 00:23:21.197144 | controller | Attempting uninstall: pip 2026-02-24 00:23:21.197816 | controller | Found existing installation: pip 22.2.2 2026-02-24 00:23:21.728424 | controller | Uninstalling pip-22.2.2: 2026-02-24 00:23:21.787018 | controller | Successfully uninstalled pip-22.2.2 2026-02-24 00:23:24.133369 | controller | Successfully installed pip-25.0.1 2026-02-24 00:23:24.459382 | controller | ok: Runtime: 0:00:04.723956 2026-02-24 00:23:24.467268 | 2026-02-24 00:23:24.467365 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-02-24 00:23:24.826973 | controller | changed 2026-02-24 00:23:24.836453 | 2026-02-24 00:23:24.836581 | TASK [Install ansible into virtualenv] 2026-02-24 00:23:26.263627 | controller | Processing ./src/github.com/ansible/ansible 2026-02-24 00:23:26.264425 | controller | Preparing metadata (setup.py): started 2026-02-24 00:23:27.607002 | controller | Preparing metadata (setup.py): finished with status 'done' 2026-02-24 00:23:27.666798 | controller | Collecting jinja2 (from ansible-base==2.10.17.post0) 2026-02-24 00:23:27.684809 | controller | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-02-24 00:23:27.809241 | controller | Collecting PyYAML (from ansible-base==2.10.17.post0) 2026-02-24 00:23:27.814150 | controller | Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.1 kB) 2026-02-24 00:23:28.757708 | controller | Collecting cryptography (from ansible-base==2.10.17.post0) 2026-02-24 00:23:28.770118 | controller | Downloading cryptography-46.0.5-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2026-02-24 00:23:28.802207 | controller | Requirement already satisfied: packaging in ./venv/lib/python3.8/site-packages (from ansible-base==2.10.17.post0) (26.0) 2026-02-24 00:23:28.948604 | controller | Collecting cffi>=1.14 (from cryptography->ansible-base==2.10.17.post0) 2026-02-24 00:23:28.953583 | controller | Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB) 2026-02-24 00:23:28.961035 | controller | Requirement already satisfied: typing-extensions>=4.13.2 in ./venv/lib/python3.8/site-packages (from cryptography->ansible-base==2.10.17.post0) (4.13.2) 2026-02-24 00:23:29.032776 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible-base==2.10.17.post0) 2026-02-24 00:23:29.684239 | controller | Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (3.0 kB) 2026-02-24 00:23:29.709499 | controller | Collecting pycparser (from cffi>=1.14->cryptography->ansible-base==2.10.17.post0) 2026-02-24 00:23:29.715271 | controller | Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes) 2026-02-24 00:23:29.725735 | controller | Downloading cryptography-46.0.5-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2026-02-24 00:23:29.851912 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 41.1 MB/s eta 0:00:00 2026-02-24 00:23:29.856473 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-02-24 00:23:29.871263 | controller | Downloading PyYAML-6.0.3-cp38-cp38-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB) 2026-02-24 00:23:29.908304 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.0/806.0 kB 18.1 MB/s eta 0:00:00 2026-02-24 00:23:29.914305 | controller | Downloading cffi-1.17.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB) 2026-02-24 00:23:29.930606 | controller | Downloading MarkupSafe-2.1.5-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (26 kB) 2026-02-24 00:23:29.939699 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB) 2026-02-24 00:23:29.959605 | controller | Building wheels for collected packages: ansible-base 2026-02-24 00:23:29.960130 | controller | Building wheel for ansible-base (setup.py): started 2026-02-24 00:23:31.239839 | controller | Building wheel for ansible-base (setup.py): finished with status 'done' 2026-02-24 00:23:31.240469 | controller | Created wheel for ansible-base: filename=ansible_base-2.10.17.post0-py3-none-any.whl size=1881569 sha256=c7120095d868a2fbff64c169001d05270aeb976cb104ed68e3ffa206ae29475e 2026-02-24 00:23:31.240696 | controller | Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-lhjo5znj/wheels/a5/4b/fa/b6deaae105422b0b3b92831e0369d44bf7fca5bb3413d79be7 2026-02-24 00:23:31.249399 | controller | Successfully built ansible-base 2026-02-24 00:23:31.282094 | controller | Installing collected packages: PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible-base 2026-02-24 00:23:32.743436 | controller | Successfully installed MarkupSafe-2.1.5 PyYAML-6.0.3 ansible-base-2.10.17.post0 cffi-1.17.1 cryptography-46.0.5 jinja2-3.1.6 pycparser-2.23 2026-02-24 00:23:32.932595 | controller | ok: Runtime: 0:00:07.507411 2026-02-24 00:23:32.941774 | 2026-02-24 00:23:32.942435 | TASK [Setup download-artifact-fork role] 2026-02-24 00:23:32.969398 | controller | ok 2026-02-24 00:23:32.999367 | 2026-02-24 00:23:32.999497 | TASK [download-artifact-fork : Parse inventory response] 2026-02-24 00:23:33.057760 | controller | ok 2026-02-24 00:23:33.071199 | 2026-02-24 00:23:33.071346 | TASK [download-artifact-fork : Fetch info from Zuul API] 2026-02-24 00:23:33.100958 | controller | skipping: Conditional result was False 2026-02-24 00:23:33.118344 | 2026-02-24 00:23:33.118549 | TASK [download-artifact-fork : Parse build response] 2026-02-24 00:23:33.159133 | controller | skipping: Conditional result was False 2026-02-24 00:23:33.179773 | 2026-02-24 00:23:33.180069 | TASK [download-artifact-fork : Ensure artifacts directory exists] 2026-02-24 00:23:33.511541 | controller | changed 2026-02-24 00:23:33.518713 | 2026-02-24 00:23:33.518808 | LOOP [download-artifact-fork : Download archive by type] 2026-02-24 00:23:33.557348 | controller | skipping: Conditional result was False 2026-02-24 00:23:33.557662 | 2026-02-24 00:23:34.805633 | controller | changed: OK (20200 bytes) 2026-02-24 00:23:34.826273 | 2026-02-24 00:23:34.826414 | TASK [deploy-artifacts : define __collections] 2026-02-24 00:23:34.867636 | controller | ok 2026-02-24 00:23:34.873633 | 2026-02-24 00:23:34.873703 | LOOP [deploy-artifacts : Create list of collections] 2026-02-24 00:23:34.907273 | controller | skipping: Conditional result was False 2026-02-24 00:23:34.920859 | controller | ok: 2026-02-24 00:23:34.921110 | controller | { 2026-02-24 00:23:34.921142 | controller | "branch": "main", 2026-02-24 00:23:34.921161 | controller | "job": "build-ansible-collection", 2026-02-24 00:23:34.921178 | controller | "metadata": { 2026-02-24 00:23:34.921194 | controller | "type": "ansible_collection", 2026-02-24 00:23:34.921210 | controller | "version": "5.0.0" 2026-02-24 00:23:34.921224 | controller | }, 2026-02-24 00:23:34.921240 | controller | "name": "ansible.network", 2026-02-24 00:23:34.921255 | controller | "project": "ansible-collections/ansible.network", 2026-02-24 00:23:34.921271 | controller | "url": "https://f30bcf576ae4b165da2a-1880631fa2540a8d60b3b9ea139018c7.ssl.cf2.rackcdn.com/ansible/88f0594a032e442cb572fdcc5e8066b4/artifacts/ansible-network-5.0.0.tar.gz" 2026-02-24 00:23:34.921291 | controller | } 2026-02-24 00:23:34.940432 | 2026-02-24 00:23:34.940535 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy] 2026-02-24 00:23:35.522709 | controller | Starting galaxy collection install process 2026-02-24 00:23:35.522960 | controller | Process install dependency map 2026-02-24 00:28:35.122244 | [Zuul] Log Stream did not terminate 2026-02-24 00:28:35.122572 | controller | ERROR 2026-02-24 00:28:35.122796 | controller | { 2026-02-24 00:28:35.122872 | controller | "msg": "Data could not be sent to remote host \"162.253.55.12\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.12 port 22: No route to host\r\n", 2026-02-24 00:28:35.122925 | controller | "unreachable": true 2026-02-24 00:28:35.122962 | controller | } unreachable 2026-02-24 00:28:35.125444 | 2026-02-24 00:28:35.125551 | PLAY RECAP 2026-02-24 00:28:35.125649 | controller | ok: 44 changed: 24 unreachable: 1 failed: 0 skipped: 17 rescued: 0 ignored: 0 2026-02-24 00:28:35.125697 | 2026-02-24 00:28:35.272190 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-24 00:28:35.273194 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-24 00:28:35.904603 | 2026-02-24 00:28:35.904735 | PLAY [all] 2026-02-24 00:28:35.926896 | 2026-02-24 00:28:35.927080 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-24 00:28:38.244385 | controller | changed: non-zero return code 2026-02-24 00:28:38.258204 | 2026-02-24 00:28:38.258370 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-24 00:28:38.286381 | controller | skipping: Conditional result was False 2026-02-24 00:28:38.294137 | 2026-02-24 00:28:38.294269 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-24 00:28:38.328064 | 2026-02-24 00:28:38.328263 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-24 00:28:38.359175 | 2026-02-24 00:28:38.359383 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-24 00:28:38.383698 | controller | skipping: Conditional result was False 2026-02-24 00:28:38.391711 | 2026-02-24 00:28:38.391847 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-24 00:28:38.425992 | 2026-02-24 00:28:38.426374 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-24 00:28:38.441372 | controller | skipping: Conditional result was False 2026-02-24 00:28:38.448567 | 2026-02-24 00:28:38.448662 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-24 00:28:38.462650 | controller | skipping: Conditional result was False 2026-02-24 00:28:38.474435 | 2026-02-24 00:28:38.474571 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-24 00:28:38.489959 | controller | skipping: Conditional result was False 2026-02-24 00:28:38.524049 | 2026-02-24 00:28:38.524158 | PLAY RECAP 2026-02-24 00:28:38.524201 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-24 00:28:38.524222 | 2026-02-24 00:28:38.638539 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-24 00:28:38.641445 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-24 00:28:39.246507 | 2026-02-24 00:28:39.246623 | PLAY [all:!appliance*] 2026-02-24 00:28:39.269056 | 2026-02-24 00:28:39.269180 | TASK [unregister the node] 2026-02-24 00:28:39.339632 | controller | skipping: Conditional result was False 2026-02-24 00:28:39.345312 | 2026-02-24 00:28:39.345393 | TASK [include_role : fetch-output] 2026-02-24 00:28:39.395402 | controller | ok 2026-02-24 00:28:39.414556 | 2026-02-24 00:28:39.414642 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-24 00:28:39.489401 | controller | skipping: Conditional result was False 2026-02-24 00:28:39.495534 | 2026-02-24 00:28:39.495611 | TASK [fetch-output : Set log path for single node] 2026-02-24 00:28:39.538815 | controller | ok 2026-02-24 00:28:39.555491 | 2026-02-24 00:28:39.555642 | LOOP [fetch-output : Ensure local output dirs] 2026-02-24 00:28:39.947879 | controller -> localhost | ok: "/var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/logs" 2026-02-24 00:28:40.194817 | controller -> localhost | changed: "/var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/artifacts" 2026-02-24 00:28:40.409676 | controller -> localhost | changed: "/var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/work/docs" 2026-02-24 00:28:40.423284 | 2026-02-24 00:28:40.423407 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-24 00:28:41.124576 | controller | changed: 2026-02-24 00:28:41.124758 | controller | .d..t...... ./ 2026-02-24 00:28:41.124786 | controller | cd+++++++++ controller/ 2026-02-24 00:28:41.124821 | controller | changed: All items complete 2026-02-24 00:28:41.124850 | 2026-02-24 00:28:41.604813 | controller | changed: .d..t...... ./ 2026-02-24 00:28:42.045821 | controller | changed: .d..t...... ./ 2026-02-24 00:28:42.065641 | 2026-02-24 00:28:42.065750 | TASK [include_role : fetch-output-openshift] 2026-02-24 00:28:42.079495 | controller | skipping: Conditional result was False 2026-02-24 00:28:42.086978 | 2026-02-24 00:28:42.087090 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-24 00:28:42.123466 | controller | skipping: Conditional result was False 2026-02-24 00:28:42.124634 | controller | skipping: Conditional result was False 2026-02-24 00:28:42.162570 | 2026-02-24 00:28:42.162668 | PLAY [localhost] 2026-02-24 00:28:42.174954 | 2026-02-24 00:28:42.175065 | TASK [Run Zuul manifest role] 2026-02-24 00:28:42.192878 | localhost | ok 2026-02-24 00:28:42.207475 | 2026-02-24 00:28:42.207552 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-24 00:28:42.540813 | localhost | changed 2026-02-24 00:28:42.545529 | 2026-02-24 00:28:42.545590 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-24 00:28:42.573886 | localhost | ok 2026-02-24 00:28:42.582945 | 2026-02-24 00:28:42.583084 | TASK [Set zuul-log-path fact] 2026-02-24 00:28:42.601782 | localhost | ok 2026-02-24 00:28:42.615699 | 2026-02-24 00:28:42.615804 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-24 00:28:42.645328 | localhost | ok 2026-02-24 00:28:42.653675 | 2026-02-24 00:28:42.653756 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-24 00:28:42.677060 | localhost | ok: 2026-02-24 00:28:42.677274 | localhost | { 2026-02-24 00:28:42.677301 | localhost | "auth": { 2026-02-24 00:28:42.677676 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-24 00:28:42.677802 | localhost | "username": "9LF91O0RK7JU" 2026-02-24 00:28:42.677828 | localhost | }, 2026-02-24 00:28:42.677846 | localhost | "profile": "rackspace", 2026-02-24 00:28:42.677864 | localhost | "region_name": "IAD" 2026-02-24 00:28:42.677881 | localhost | } 2026-02-24 00:28:42.678120 | 2026-02-24 00:28:42.693307 | 2026-02-24 00:28:42.693390 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-24 00:28:42.711402 | localhost | Output suppressed because no_log was given 2026-02-24 00:28:42.729038 | 2026-02-24 00:28:42.729185 | TASK [upload-logs-failover : Initialize control vars] 2026-02-24 00:28:42.750579 | localhost | ok 2026-02-24 00:28:42.757181 | 2026-02-24 00:28:42.757270 | LOOP [upload-logs-failover : Perform log upload] 2026-02-24 00:28:42.783813 | localhost | Output suppressed because no_log was given 2026-02-24 00:28:42.795186 | localhost | included: /var/lib/zuul/builds/9095a9e8a5e94beea5e3ed96fa156d86/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-24 00:28:42.829888 | 2026-02-24 00:28:42.830003 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-24 00:28:42.904698 | localhost | Output suppressed because no_log was given 2026-02-24 00:28:42.912628 | 2026-02-24 00:28:42.912762 | TASK [Upload logs to swift] 2026-02-24 00:28:42.934008 | localhost | ok 2026-02-24 00:28:42.973165 | 2026-02-24 00:28:42.973276 | TASK [Set zuul-log-path fact] 2026-02-24 00:28:42.997200 | localhost | skipping: Conditional result was False 2026-02-24 00:28:43.002733 | 2026-02-24 00:28:43.002809 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-24 00:28:43.351652 | localhost -> localhost | ok: Runtime: 0:00:00.005888 2026-02-24 00:28:43.359627 | 2026-02-24 00:28:43.359741 | TASK [upload-logs-swift : Upload logs to swift]