2026-02-23 00:29:04.218254 | Job console starting... 2026-02-23 00:29:04.230285 | Updating repositories 2026-02-23 00:29:04.395750 | Preparing job workspace 2026-02-23 00:29:09.885918 | Running Ansible setup... 2026-02-23 00:29:15.009260 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-23 00:29:15.646253 | 2026-02-23 00:29:15.646450 | PLAY [localhost] 2026-02-23 00:29:15.669641 | 2026-02-23 00:29:15.669883 | TASK [Gathering Facts] 2026-02-23 00:29:16.699363 | localhost | ok 2026-02-23 00:29:16.718439 | 2026-02-23 00:29:16.718696 | TASK [Setup log path fact] 2026-02-23 00:29:16.754823 | localhost | ok 2026-02-23 00:29:16.772563 | 2026-02-23 00:29:16.772682 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 00:29:16.802533 | localhost | ok 2026-02-23 00:29:16.811092 | 2026-02-23 00:29:16.811167 | TASK [emit-job-header : Print job information] 2026-02-23 00:29:16.850868 | # Job Information 2026-02-23 00:29:16.851037 | Ansible Version: 2.15.12 2026-02-23 00:29:16.851080 | Job: ansible-test-sanity-docker-stable-2.9 2026-02-23 00:29:16.851108 | Pipeline: periodic 2026-02-23 00:29:16.851133 | Executor: ze02.softwarefactory-project.io 2026-02-23 00:29:16.851158 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-02-23 00:29:16.851187 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/1c5/ansible/1c55fe78834947ba83c8e7b35ecfdee6/ 2026-02-23 00:29:16.851213 | Event ID: 6a8a9386ce23468fa82fb2babfc7fd44 2026-02-23 00:29:16.856607 | 2026-02-23 00:29:16.856719 | LOOP [emit-job-header : Print node information] 2026-02-23 00:29:16.982150 | localhost | ok: 2026-02-23 00:29:16.982481 | localhost | # Node Information 2026-02-23 00:29:16.982512 | localhost | Inventory Hostname: controller 2026-02-23 00:29:16.982533 | localhost | Hostname: np0005626346 2026-02-23 00:29:16.982551 | localhost | Username: zuul 2026-02-23 00:29:16.982579 | localhost | Distro: Fedora 37 2026-02-23 00:29:16.982598 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-23 00:29:16.982615 | localhost | Region: ca-ymq-1 2026-02-23 00:29:16.982632 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-23 00:29:16.982648 | localhost | Product Name: OpenStack Nova 2026-02-23 00:29:16.982693 | localhost | Interface IP: 162.253.55.70 2026-02-23 00:29:17.008178 | 2026-02-23 00:29:17.008358 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-23 00:29:17.465697 | localhost -> localhost | changed 2026-02-23 00:29:17.478529 | 2026-02-23 00:29:17.478614 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-23 00:29:18.419829 | localhost -> localhost | changed 2026-02-23 00:29:18.467324 | 2026-02-23 00:29:18.467440 | PLAY [all:!appliance*] 2026-02-23 00:29:18.491782 | 2026-02-23 00:29:18.491926 | TASK [include_role : start-zuul-console] 2026-02-23 00:29:18.517581 | controller | ok 2026-02-23 00:29:18.536827 | 2026-02-23 00:29:18.536947 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-23 00:29:18.967624 | controller | ok 2026-02-23 00:29:18.994003 | 2026-02-23 00:29:18.994165 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-23 00:29:20.191240 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-23 00:29:20.206284 | 2026-02-23 00:29:20.206426 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-23 00:29:20.756754 | controller | skipping: Conditional result was False 2026-02-23 00:29:20.772909 | 2026-02-23 00:29:20.773069 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-23 00:29:20.803343 | controller | skipping: Conditional result was False 2026-02-23 00:29:20.818560 | 2026-02-23 00:29:20.818743 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-23 00:29:20.846443 | controller | skipping: Conditional result was False 2026-02-23 00:29:20.860855 | 2026-02-23 00:29:20.861002 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-23 00:29:20.899041 | controller | skipping: Conditional result was False 2026-02-23 00:29:20.913350 | 2026-02-23 00:29:20.913549 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-23 00:29:20.953070 | controller | skipping: Conditional result was False 2026-02-23 00:29:20.960900 | 2026-02-23 00:29:20.960990 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-23 00:29:20.987549 | controller | skipping: Conditional result was False 2026-02-23 00:29:21.002237 | 2026-02-23 00:29:21.002367 | TASK [Disable Fedora Modular] 2026-02-23 00:29:21.234284 | controller | changed 2026-02-23 00:29:21.248169 | 2026-02-23 00:29:21.248301 | TASK [Enable EPEL] 2026-02-23 00:29:21.266882 | controller | skipping: Conditional result was False 2026-02-23 00:29:21.282937 | 2026-02-23 00:29:21.283305 | TASK [Register the RHEL node] 2026-02-23 00:29:21.848455 | 2026-02-23 00:29:21.848749 | TASK [Show the subscription-manager status] 2026-02-23 00:29:22.426652 | controller | skipping: Conditional result was False 2026-02-23 00:29:22.442926 | 2026-02-23 00:29:22.443063 | TASK [Enable EPEL on RHEL] 2026-02-23 00:29:22.999711 | controller | skipping: Conditional result was False 2026-02-23 00:29:23.012820 | 2026-02-23 00:29:23.012971 | TASK [Install git and tox] 2026-02-23 00:30:57.247339 | controller | changed 2026-02-23 00:30:57.254398 | 2026-02-23 00:30:57.254515 | TASK [include_role : prepare-workspace] 2026-02-23 00:30:57.279407 | controller | ok 2026-02-23 00:30:57.303921 | 2026-02-23 00:30:57.304083 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-23 00:30:57.568149 | controller | ok 2026-02-23 00:30:57.579666 | 2026-02-23 00:30:57.579883 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-23 00:36:30.884824 | controller | Output suppressed because no_log was given 2026-02-23 00:36:30.895145 | 2026-02-23 00:36:30.895209 | TASK [include_role : prepare-workspace-openshift] 2026-02-23 00:36:30.926008 | controller | skipping: Conditional result was False 2026-02-23 00:36:30.975199 | 2026-02-23 00:36:30.975385 | PLAY [all:!appliance] 2026-02-23 00:36:31.007595 | 2026-02-23 00:36:31.007742 | TASK [Run add-build-sshkey role (RSA)] 2026-02-23 00:36:31.041912 | controller | ok 2026-02-23 00:36:31.061947 | 2026-02-23 00:36:31.062042 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-23 00:36:31.373785 | controller -> localhost | ok 2026-02-23 00:36:31.388195 | 2026-02-23 00:36:31.388359 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-23 00:36:31.435931 | controller | ok 2026-02-23 00:36:31.456161 | controller | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-23 00:36:31.465430 | 2026-02-23 00:36:31.465530 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-23 00:36:32.081878 | controller -> localhost | Generating public/private rsa key pair. 2026-02-23 00:36:32.082155 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/1c55fe78834947ba83c8e7b35ecfdee6_id_rsa. 2026-02-23 00:36:32.082185 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/1c55fe78834947ba83c8e7b35ecfdee6_id_rsa.pub. 2026-02-23 00:36:32.082206 | controller -> localhost | The key fingerprint is: 2026-02-23 00:36:32.082225 | controller -> localhost | SHA256:vsiioVi3LfcnxRYt/ZqeZ/xXzhzcj577ClIW3rzZXBQ zuul-build-sshkey 2026-02-23 00:36:32.082243 | controller -> localhost | The key's randomart image is: 2026-02-23 00:36:32.082262 | controller -> localhost | +---[RSA 2048]----+ 2026-02-23 00:36:32.082279 | controller -> localhost | | E | 2026-02-23 00:36:32.082297 | controller -> localhost | | .| 2026-02-23 00:36:32.082315 | controller -> localhost | | o. .| 2026-02-23 00:36:32.082333 | controller -> localhost | | o.o+ . | 2026-02-23 00:36:32.082350 | controller -> localhost | | S. o+.+ o| 2026-02-23 00:36:32.082376 | controller -> localhost | | . +o .B+| 2026-02-23 00:36:32.082461 | controller -> localhost | | o . .o. .+o=*| 2026-02-23 00:36:32.082486 | controller -> localhost | |.o oo+......oo=.*| 2026-02-23 00:36:32.082505 | controller -> localhost | |o ...++.oo .o+==+| 2026-02-23 00:36:32.082526 | controller -> localhost | +----[SHA256]-----+ 2026-02-23 00:36:32.082579 | controller -> localhost | ok: Runtime: 0:00:00.107284 2026-02-23 00:36:32.089755 | 2026-02-23 00:36:32.089823 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-23 00:36:32.131290 | controller | ok 2026-02-23 00:36:32.146639 | controller | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-23 00:36:32.160885 | 2026-02-23 00:36:32.161124 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-23 00:36:32.188407 | controller | skipping: Conditional result was False 2026-02-23 00:36:32.199274 | 2026-02-23 00:36:32.199442 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-23 00:36:32.893876 | controller | changed 2026-02-23 00:36:32.908142 | 2026-02-23 00:36:32.908329 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-23 00:36:33.162909 | controller | ok 2026-02-23 00:36:33.177241 | 2026-02-23 00:36:33.177377 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-23 00:36:33.894482 | controller | changed 2026-02-23 00:36:33.907498 | 2026-02-23 00:36:33.907720 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-23 00:36:34.609777 | controller | changed 2026-02-23 00:36:34.615506 | 2026-02-23 00:36:34.615571 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-23 00:36:34.641261 | controller | skipping: Conditional result was False 2026-02-23 00:36:34.648630 | 2026-02-23 00:36:34.648726 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-23 00:36:35.083309 | controller -> localhost | changed 2026-02-23 00:36:35.096379 | 2026-02-23 00:36:35.096526 | TASK [add-build-sshkey : Add back temp key] 2026-02-23 00:36:35.461452 | controller -> localhost | Identity added: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/1c55fe78834947ba83c8e7b35ecfdee6_id_rsa (zuul-build-sshkey) 2026-02-23 00:36:35.461814 | controller -> localhost | ok: Runtime: 0:00:00.010002 2026-02-23 00:36:35.471195 | 2026-02-23 00:36:35.471286 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-23 00:36:37.164706 | controller | ok 2026-02-23 00:36:37.177368 | 2026-02-23 00:36:37.177532 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-23 00:36:37.216450 | controller | skipping: Conditional result was False 2026-02-23 00:36:37.283107 | 2026-02-23 00:36:37.283241 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-23 00:36:37.305407 | controller | ok 2026-02-23 00:36:37.322112 | 2026-02-23 00:36:37.322243 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-23 00:36:37.583995 | controller -> localhost | ok 2026-02-23 00:36:37.600191 | 2026-02-23 00:36:37.600381 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-23 00:36:37.653778 | controller | ok 2026-02-23 00:36:37.674817 | controller | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-23 00:36:37.683655 | 2026-02-23 00:36:37.683765 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-23 00:36:38.025967 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-23 00:36:38.026195 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/1c55fe78834947ba83c8e7b35ecfdee6_id_ecdsa. 2026-02-23 00:36:38.026229 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/1c55fe78834947ba83c8e7b35ecfdee6_id_ecdsa.pub. 2026-02-23 00:36:38.026269 | controller -> localhost | The key fingerprint is: 2026-02-23 00:36:38.026299 | controller -> localhost | SHA256:dZxl1Xu8KfPDVzjunwjLuvSxvcQ4Fu8u53JXfawx4/g zuul-build-sshkey 2026-02-23 00:36:38.026326 | controller -> localhost | The key's randomart image is: 2026-02-23 00:36:38.026345 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-23 00:36:38.026363 | controller -> localhost | | o.o| 2026-02-23 00:36:38.026386 | controller -> localhost | | . + .| 2026-02-23 00:36:38.026411 | controller -> localhost | | . + ..| 2026-02-23 00:36:38.026434 | controller -> localhost | | . . .o| 2026-02-23 00:36:38.026455 | controller -> localhost | | S . o=| 2026-02-23 00:36:38.026475 | controller -> localhost | | =o*o*| 2026-02-23 00:36:38.026492 | controller -> localhost | | . * B=*+| 2026-02-23 00:36:38.026508 | controller -> localhost | | . +o@o==o| 2026-02-23 00:36:38.026524 | controller -> localhost | | oo=BXEo+| 2026-02-23 00:36:38.026541 | controller -> localhost | +----[SHA256]-----+ 2026-02-23 00:36:38.026589 | controller -> localhost | ok: Runtime: 0:00:00.010985 2026-02-23 00:36:38.033611 | 2026-02-23 00:36:38.033696 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-23 00:36:38.063708 | controller | ok 2026-02-23 00:36:38.072374 | controller | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-23 00:36:38.080948 | 2026-02-23 00:36:38.081010 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-23 00:36:38.105410 | controller | skipping: Conditional result was False 2026-02-23 00:36:38.114432 | 2026-02-23 00:36:38.114528 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-23 00:36:38.448757 | controller | changed 2026-02-23 00:36:38.462838 | 2026-02-23 00:36:38.463000 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-23 00:36:38.722017 | controller | ok 2026-02-23 00:36:38.739031 | 2026-02-23 00:36:38.739218 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-23 00:36:39.454917 | controller | changed 2026-02-23 00:36:39.468558 | 2026-02-23 00:36:39.468734 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-23 00:36:40.198148 | controller | changed 2026-02-23 00:36:40.213463 | 2026-02-23 00:36:40.213646 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-23 00:36:40.241407 | controller | skipping: Conditional result was False 2026-02-23 00:36:40.256748 | 2026-02-23 00:36:40.256958 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-23 00:36:40.520826 | controller -> localhost | changed 2026-02-23 00:36:40.545154 | 2026-02-23 00:36:40.545338 | TASK [add-build-sshkey : Add back temp key] 2026-02-23 00:36:40.818414 | controller -> localhost | Identity added: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/1c55fe78834947ba83c8e7b35ecfdee6_id_ecdsa (zuul-build-sshkey) 2026-02-23 00:36:40.818862 | controller -> localhost | ok: Runtime: 0:00:00.012561 2026-02-23 00:36:40.831925 | 2026-02-23 00:36:40.832063 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-23 00:36:41.159007 | controller | ok 2026-02-23 00:36:41.170590 | 2026-02-23 00:36:41.170782 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-23 00:36:41.197965 | controller | skipping: Conditional result was False 2026-02-23 00:36:41.214384 | 2026-02-23 00:36:41.214487 | TASK [include_role : remove-zuul-sshkey] 2026-02-23 00:36:41.229448 | controller | skipping: Conditional result was False 2026-02-23 00:36:41.242185 | 2026-02-23 00:36:41.242307 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-23 00:36:41.487039 | controller | ok: "logs" 2026-02-23 00:36:41.487474 | controller | ok: All items complete 2026-02-23 00:36:41.487533 | 2026-02-23 00:36:41.696103 | controller | ok: "artifacts" 2026-02-23 00:36:41.896729 | controller | ok: "docs" 2026-02-23 00:36:41.924247 | 2026-02-23 00:36:41.924462 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-23 00:36:42.187917 | controller | changed: "logs" 2026-02-23 00:36:42.404613 | controller | changed: "artifacts" 2026-02-23 00:36:42.605121 | controller | changed: "docs" 2026-02-23 00:36:42.668501 | 2026-02-23 00:36:42.668656 | PLAY RECAP 2026-02-23 00:36:42.668747 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-23 00:36:42.668785 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-23 00:36:42.668810 | 2026-02-23 00:36:42.820898 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-23 00:36:42.821899 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-23 00:36:43.398208 | 2026-02-23 00:36:43.398535 | PLAY [all] 2026-02-23 00:36:43.420713 | 2026-02-23 00:36:43.420826 | TASK [Install binary dependencies] 2026-02-23 00:36:43.482885 | controller | ok 2026-02-23 00:36:43.503038 | 2026-02-23 00:36:43.503127 | TASK [bindep : Include find tasks] 2026-02-23 00:36:43.544252 | controller | ok 2026-02-23 00:36:43.551813 | controller | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-23 00:36:43.562215 | 2026-02-23 00:36:43.562443 | TASK [bindep : Look for bindep.txt] 2026-02-23 00:36:44.139349 | controller | ok 2026-02-23 00:36:44.149053 | 2026-02-23 00:36:44.149209 | TASK [bindep : Define bindep_file fact] 2026-02-23 00:36:44.175923 | controller | skipping: Conditional result was False 2026-02-23 00:36:44.186646 | 2026-02-23 00:36:44.186809 | TASK [bindep : Look for other-requirements.txt] 2026-02-23 00:36:44.447837 | controller | ok 2026-02-23 00:36:44.456103 | 2026-02-23 00:36:44.456200 | TASK [bindep : Define bindep_file fact] 2026-02-23 00:36:44.491772 | controller | skipping: Conditional result was False 2026-02-23 00:36:44.501285 | 2026-02-23 00:36:44.501404 | TASK [bindep : Look for bindep fallback file] 2026-02-23 00:36:44.547919 | controller | skipping: Conditional result was False 2026-02-23 00:36:44.563367 | 2026-02-23 00:36:44.563561 | TASK [bindep : Define bindep_file fact] 2026-02-23 00:36:44.601379 | controller | skipping: Conditional result was False 2026-02-23 00:36:44.616014 | 2026-02-23 00:36:44.616196 | TASK [bindep : Include bindep tasks] 2026-02-23 00:36:44.653858 | controller | skipping: Conditional result was False 2026-02-23 00:36:44.667448 | 2026-02-23 00:36:44.667594 | TASK [bindep : Include install tasks] 2026-02-23 00:36:44.695323 | controller | skipping: Conditional result was False 2026-02-23 00:36:44.709507 | 2026-02-23 00:36:44.709725 | LOOP [bindep : Include package tasks] 2026-02-23 00:36:44.804981 | 2026-02-23 00:36:44.805280 | TASK [Run test-setup role] 2026-02-23 00:36:44.836976 | controller | ok 2026-02-23 00:36:44.864578 | 2026-02-23 00:36:44.864709 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-23 00:36:45.090216 | controller | ok 2026-02-23 00:36:45.098827 | 2026-02-23 00:36:45.098921 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-23 00:36:45.641344 | controller | skipping: Conditional result was False 2026-02-23 00:36:45.667711 | 2026-02-23 00:36:45.667816 | PLAY RECAP 2026-02-23 00:36:45.667859 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-23 00:36:45.667879 | 2026-02-23 00:36:45.786937 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-23 00:36:45.787873 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-23 00:36:46.462431 | 2026-02-23 00:36:46.462587 | PLAY [controller] 2026-02-23 00:36:46.483672 | 2026-02-23 00:36:46.483789 | TASK [Create the /root directory] 2026-02-23 00:36:47.121111 | controller | ok 2026-02-23 00:36:47.142329 | 2026-02-23 00:36:47.142602 | TASK [Install glibc-langpack-en] 2026-02-23 00:36:51.600275 | controller | ok: Nothing to do 2026-02-23 00:36:51.612731 | 2026-02-23 00:36:51.612869 | TASK [Ensure controller directory exists] 2026-02-23 00:36:51.855289 | controller | changed 2026-02-23 00:36:51.866788 | 2026-02-23 00:36:51.866876 | TASK [Install container runtime] 2026-02-23 00:36:51.954655 | controller | ok 2026-02-23 00:36:52.017249 | 2026-02-23 00:36:52.017344 | LOOP [ensure-docker : Gather variables for each operating system] 2026-02-23 00:36:52.076586 | controller | ok: "/var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml" 2026-02-23 00:36:52.097117 | 2026-02-23 00:36:52.097288 | TASK [ensure-docker : Sanity check for distro selection] 2026-02-23 00:36:52.115091 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.128349 | 2026-02-23 00:36:52.128494 | TASK [ensure-docker : Sanity check for distro install] 2026-02-23 00:36:52.155947 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.169486 | 2026-02-23 00:36:52.169629 | TASK [ensure-docker : Sanity check for upstream install] 2026-02-23 00:36:52.196898 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.211589 | 2026-02-23 00:36:52.211845 | TASK [ensure-docker : Sanity check for upstream install mirrors] 2026-02-23 00:36:52.240550 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.260556 | 2026-02-23 00:36:52.260782 | TASK [ensure-docker : Include tasks for docker install] 2026-02-23 00:36:52.303461 | controller | ok 2026-02-23 00:36:52.319244 | controller | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml 2026-02-23 00:36:52.327124 | 2026-02-23 00:36:52.327192 | TASK [ensure-docker : Not Implemented] 2026-02-23 00:36:52.352182 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.359369 | 2026-02-23 00:36:52.359443 | TASK [Set up docker mirrors] 2026-02-23 00:36:52.391038 | controller | ok 2026-02-23 00:36:52.409902 | 2026-02-23 00:36:52.410029 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info] 2026-02-23 00:36:52.445402 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.452522 | 2026-02-23 00:36:52.452607 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info] 2026-02-23 00:36:52.500250 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.509390 | 2026-02-23 00:36:52.509504 | TASK [use-docker-mirror : Set docker_mirror fact] 2026-02-23 00:36:52.555870 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.571417 | 2026-02-23 00:36:52.571594 | TASK [use-docker-mirror : Set up docker mirrors] 2026-02-23 00:36:52.599524 | controller | skipping: Conditional result was False 2026-02-23 00:36:52.624470 | 2026-02-23 00:36:52.624608 | TASK [Add all repositories] 2026-02-23 00:36:52.655654 | controller | ok 2026-02-23 00:36:52.704535 | 2026-02-23 00:36:52.704653 | LOOP [ensure-package-repositories : Install repositories] 2026-02-23 00:36:52.802271 | controller | ok: "/var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml" 2026-02-23 00:36:52.802512 | controller | ok: All items complete 2026-02-23 00:36:52.802564 | 2026-02-23 00:36:52.823513 | controller | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml 2026-02-23 00:36:52.832223 | 2026-02-23 00:36:52.832304 | TASK [ensure-package-repositories : Create GPG key temp directory] 2026-02-23 00:36:53.197906 | controller | changed 2026-02-23 00:36:53.213528 | 2026-02-23 00:36:53.213766 | LOOP [ensure-package-repositories : Upload GPG keys] 2026-02-23 00:36:55.899454 | controller | changed: 2026-02-23 00:36:55.899676 | controller | { 2026-02-23 00:36:55.899708 | 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-23 00:36:55.899729 | controller | } 2026-02-23 00:36:55.914957 | 2026-02-23 00:36:55.915098 | LOOP [ensure-package-repositories : Import GPG keys] 2026-02-23 00:36:56.621080 | controller | changed: 2026-02-23 00:36:56.621296 | controller | { 2026-02-23 00:36:56.621324 | 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-23 00:36:56.621347 | controller | } 2026-02-23 00:36:56.621376 | controller | changed: All items complete 2026-02-23 00:36:56.621413 | 2026-02-23 00:36:56.631359 | 2026-02-23 00:36:56.631525 | TASK [ensure-package-repositories : Remove GPG temp directory] 2026-02-23 00:36:56.892038 | controller | changed 2026-02-23 00:36:56.900954 | 2026-02-23 00:36:56.901070 | LOOP [ensure-package-repositories : Add repositories] 2026-02-23 00:36:57.303996 | controller | changed: 2026-02-23 00:36:57.304279 | controller | { 2026-02-23 00:36:57.304332 | controller | "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable", 2026-02-23 00:36:57.304372 | controller | "description": "Docker CE Stable - $basearch", 2026-02-23 00:36:57.304408 | controller | "gpgcheck": true, 2026-02-23 00:36:57.304443 | controller | "name": "docker-ce-stable" 2026-02-23 00:36:57.304478 | controller | } 2026-02-23 00:36:57.349321 | 2026-02-23 00:36:57.349599 | TASK [ensure-docker : Install pre-reqs] 2026-02-23 00:36:59.998201 | controller | ok: Nothing to do 2026-02-23 00:37:00.013054 | 2026-02-23 00:37:00.013203 | TASK [ensure-docker : Remove packages] 2026-02-23 00:37:01.757616 | controller | ok: Nothing to do 2026-02-23 00:37:01.771056 | 2026-02-23 00:37:01.771223 | TASK [ensure-docker : Install upstream docker using package] 2026-02-23 00:37:53.985053 | controller | changed 2026-02-23 00:37:53.998628 | 2026-02-23 00:37:53.998797 | TASK [ensure-docker : Setup docker] 2026-02-23 00:37:54.043580 | controller | ok 2026-02-23 00:37:54.065226 | controller | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml 2026-02-23 00:37:54.082527 | 2026-02-23 00:37:54.082621 | TASK [ensure-docker : Ensure "docker" group exists] 2026-02-23 00:37:54.496540 | controller | ok 2026-02-23 00:37:54.510716 | 2026-02-23 00:37:54.510853 | TASK [ensure-docker : Add user to docker group] 2026-02-23 00:37:55.012222 | controller | changed 2026-02-23 00:37:55.026358 | 2026-02-23 00:37:55.026511 | TASK [Update docker daemon proxy configuration] 2026-02-23 00:37:55.066454 | controller | skipping: Conditional result was False 2026-02-23 00:37:55.075659 | 2026-02-23 00:37:55.075860 | TASK [Lower default MTU] 2026-02-23 00:37:55.102461 | controller | skipping: Conditional result was False 2026-02-23 00:37:55.118079 | 2026-02-23 00:37:55.118245 | TASK [ensure-docker : Get the status of the docket.socket unit] 2026-02-23 00:37:55.539368 | controller | inactive 2026-02-23 00:37:55.717262 | controller | ok: Runtime: 0:00:00.015753 2026-02-23 00:37:55.723631 | 2026-02-23 00:37:55.723716 | TASK [ensure-docker : Get the status of the docket unit] 2026-02-23 00:37:55.972557 | controller | inactive 2026-02-23 00:37:56.255006 | controller | ok: Runtime: 0:00:00.007914 2026-02-23 00:37:56.271989 | 2026-02-23 00:37:56.272148 | TASK [ensure-docker : Restart docker] 2026-02-23 00:37:56.326088 | Trigger a Docker restart 2026-02-23 00:37:56.338930 | 2026-02-23 00:37:56.339024 | TASK [ensure-docker : Reset ssh connection to pick up docker group] 2026-02-23 00:37:56.385529 | 2026-02-23 00:37:56.385651 | TASK [ensure-docker : Install docker-compose] 2026-02-23 00:37:56.411612 | controller | skipping: Conditional result was False 2026-02-23 00:37:56.421644 | 2026-02-23 00:37:56.421762 | TASK [ensure-docker : Flush handlers before role exit] 2026-02-23 00:37:56.437859 | 2026-02-23 00:37:56.437958 | TASK [ensure-docker : Stop docker.socket to avoid any conflict] 2026-02-23 00:37:57.760147 | controller | changed 2026-02-23 00:37:57.772499 | 2026-02-23 00:37:57.772647 | TASK [ensure-docker : Assure docker service is running] 2026-02-23 00:37:59.617248 | controller | changed 2026-02-23 00:37:59.633966 | 2026-02-23 00:37:59.634244 | TASK [ensure-docker : Assure docker.socket service is running] 2026-02-23 00:38:01.620597 | controller | ok 2026-02-23 00:38:01.628342 | 2026-02-23 00:38:01.628404 | TASK [ensure-docker : Correct group ownership on docker sock] 2026-02-23 00:38:02.202943 | controller | ok 2026-02-23 00:38:02.214838 | 2026-02-23 00:38:02.214980 | TASK [ensure-docker : Validate ability to talk with docker] 2026-02-23 00:38:02.655715 | controller | CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES 2026-02-23 00:38:02.762492 | controller | ok: Runtime: 0:00:00.047998 2026-02-23 00:38:02.790703 | 2026-02-23 00:38:02.790909 | TASK [ensure-docker : Get version details] 2026-02-23 00:38:03.254042 | controller | Client: Docker Engine - Community 2026-02-23 00:38:03.254189 | controller | Version: 24.0.7 2026-02-23 00:38:03.254226 | controller | API version: 1.43 2026-02-23 00:38:03.254270 | controller | Go version: go1.20.10 2026-02-23 00:38:03.254309 | controller | Git commit: afdd53b 2026-02-23 00:38:03.254358 | controller | Built: Thu Oct 26 09:09:39 2023 2026-02-23 00:38:03.254396 | controller | OS/Arch: linux/amd64 2026-02-23 00:38:03.254455 | controller | Context: default 2026-02-23 00:38:03.254472 | controller | 2026-02-23 00:38:03.254539 | controller | Server: Docker Engine - Community 2026-02-23 00:38:03.254614 | controller | Engine: 2026-02-23 00:38:03.254738 | controller | Version: 24.0.7 2026-02-23 00:38:03.254773 | controller | API version: 1.43 (minimum version 1.12) 2026-02-23 00:38:03.254815 | controller | Go version: go1.20.10 2026-02-23 00:38:03.254846 | controller | Git commit: 311b9ff 2026-02-23 00:38:03.254892 | controller | Built: Thu Oct 26 09:08:11 2023 2026-02-23 00:38:03.254945 | controller | OS/Arch: linux/amd64 2026-02-23 00:38:03.254987 | controller | Experimental: false 2026-02-23 00:38:03.255006 | controller | containerd: 2026-02-23 00:38:03.255090 | controller | Version: 1.6.25 2026-02-23 00:38:03.255134 | controller | GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f 2026-02-23 00:38:03.255154 | controller | runc: 2026-02-23 00:38:03.255222 | controller | Version: 1.1.10 2026-02-23 00:38:03.255254 | controller | GitCommit: v1.1.10-0-g18a0cb0 2026-02-23 00:38:03.255287 | controller | docker-init: 2026-02-23 00:38:03.255339 | controller | Version: 0.19.0 2026-02-23 00:38:03.255382 | controller | GitCommit: de40ad0 2026-02-23 00:38:03.344278 | controller | ok: Runtime: 0:00:00.056922 2026-02-23 00:38:03.360243 | 2026-02-23 00:38:03.360398 | TASK [ensure-docker : Dump installed docker details] 2026-02-23 00:38:03.406892 | {'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-23 00:38:03.200098', 'end': '2026-02-23 00:38:03.257020', 'delta': '0:00:00.056922', 'msg': '', 'zuul_log_id': 'fa163efc-24cc-1856-948e-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-23 00:38:03.415337 | 2026-02-23 00:38:03.415424 | TASK [Use buildset registry] 2026-02-23 00:38:03.441878 | controller | skipping: Conditional result was False 2026-02-23 00:38:03.469532 | 2026-02-23 00:38:03.469714 | TASK [Ensure python3.8 is present] 2026-02-23 00:38:03.495115 | controller | skipping: Conditional result was False 2026-02-23 00:38:03.501323 | 2026-02-23 00:38:03.501406 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-23 00:38:03.522538 | controller | ok 2026-02-23 00:38:03.544848 | 2026-02-23 00:38:03.545004 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-23 00:38:05.817794 | controller | ok: Nothing to do 2026-02-23 00:38:05.837475 | 2026-02-23 00:38:05.837649 | TASK [our-ensure-python : Also install python3-devel] 2026-02-23 00:42:26.685980 | controller | ERROR 2026-02-23 00:42:26.686315 | controller | { 2026-02-23 00:42:26.686377 | controller | "msg": "Data could not be sent to remote host \"162.253.55.70\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.70 port 22: No route to host\r\n", 2026-02-23 00:42:26.686433 | controller | "unreachable": true 2026-02-23 00:42:26.686472 | controller | } unreachable 2026-02-23 00:42:26.688305 | 2026-02-23 00:42:26.688432 | PLAY RECAP 2026-02-23 00:42:26.688514 | controller | ok: 28 changed: 14 unreachable: 1 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-23 00:42:26.688557 | 2026-02-23 00:42:26.817230 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-23 00:42:26.818183 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-23 00:42:27.374441 | 2026-02-23 00:42:27.374558 | PLAY [all] 2026-02-23 00:42:27.396432 | 2026-02-23 00:42:27.396541 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-23 00:43:12.083472 | controller | changed: non-zero return code 2026-02-23 00:43:12.103823 | 2026-02-23 00:43:12.103953 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-23 00:43:12.129695 | controller | skipping: Conditional result was False 2026-02-23 00:43:12.138497 | 2026-02-23 00:43:12.138612 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-23 00:43:12.173623 | 2026-02-23 00:43:12.173831 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-23 00:43:12.230028 | 2026-02-23 00:43:12.230241 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-23 00:43:12.245303 | controller | skipping: Conditional result was False 2026-02-23 00:43:12.254370 | 2026-02-23 00:43:12.254460 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-23 00:43:12.277097 | 2026-02-23 00:43:12.277252 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-23 00:43:12.302198 | controller | skipping: Conditional result was False 2026-02-23 00:43:12.310000 | 2026-02-23 00:43:12.310087 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-23 00:43:12.325339 | controller | skipping: Conditional result was False 2026-02-23 00:43:12.335926 | 2026-02-23 00:43:12.336012 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-23 00:43:12.360880 | controller | skipping: Conditional result was False 2026-02-23 00:43:12.396740 | 2026-02-23 00:43:12.396836 | PLAY RECAP 2026-02-23 00:43:12.396895 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-23 00:43:12.396923 | 2026-02-23 00:43:12.516784 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-23 00:43:12.517643 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-23 00:43:13.093798 | 2026-02-23 00:43:13.093921 | PLAY [all:!appliance*] 2026-02-23 00:43:13.116336 | 2026-02-23 00:43:13.116435 | TASK [unregister the node] 2026-02-23 00:43:13.646954 | controller | skipping: Conditional result was False 2026-02-23 00:43:13.659092 | 2026-02-23 00:43:13.659249 | TASK [include_role : fetch-output] 2026-02-23 00:43:13.708289 | controller | ok 2026-02-23 00:43:13.747228 | 2026-02-23 00:43:13.747491 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-23 00:43:13.823513 | controller | skipping: Conditional result was False 2026-02-23 00:43:13.832324 | 2026-02-23 00:43:13.832429 | TASK [fetch-output : Set log path for single node] 2026-02-23 00:43:13.880396 | controller | ok 2026-02-23 00:43:13.893514 | 2026-02-23 00:43:13.893716 | LOOP [fetch-output : Ensure local output dirs] 2026-02-23 00:43:14.365056 | controller -> localhost | ok: "/var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/logs" 2026-02-23 00:43:14.642279 | controller -> localhost | changed: "/var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/artifacts" 2026-02-23 00:43:14.906397 | controller -> localhost | changed: "/var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/work/docs" 2026-02-23 00:43:14.934180 | 2026-02-23 00:43:14.934341 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-23 00:43:15.680270 | controller | changed: 2026-02-23 00:43:15.680645 | controller | .d..t...... ./ 2026-02-23 00:43:15.680755 | controller | cd+++++++++ controller/ 2026-02-23 00:43:15.680826 | controller | changed: All items complete 2026-02-23 00:43:15.680871 | 2026-02-23 00:43:16.235432 | controller | changed: .d..t...... ./ 2026-02-23 00:43:16.734591 | controller | changed: .d..t...... ./ 2026-02-23 00:43:16.764628 | 2026-02-23 00:43:16.764861 | TASK [include_role : fetch-output-openshift] 2026-02-23 00:43:16.792252 | controller | skipping: Conditional result was False 2026-02-23 00:43:16.807141 | 2026-02-23 00:43:16.807329 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-23 00:43:16.844152 | controller | skipping: Conditional result was False 2026-02-23 00:43:16.852105 | controller | skipping: Conditional result was False 2026-02-23 00:43:16.907810 | 2026-02-23 00:43:16.907948 | PLAY [localhost] 2026-02-23 00:43:16.924176 | 2026-02-23 00:43:16.924255 | TASK [Run Zuul manifest role] 2026-02-23 00:43:16.944362 | localhost | ok 2026-02-23 00:43:16.962532 | 2026-02-23 00:43:16.962621 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-23 00:43:17.408305 | localhost | changed 2026-02-23 00:43:17.413170 | 2026-02-23 00:43:17.413233 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-23 00:43:17.456951 | localhost | ok 2026-02-23 00:43:17.464691 | 2026-02-23 00:43:17.464749 | TASK [Set zuul-log-path fact] 2026-02-23 00:43:17.481931 | localhost | ok 2026-02-23 00:43:17.495702 | 2026-02-23 00:43:17.495805 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 00:43:17.534014 | localhost | ok 2026-02-23 00:43:17.541993 | 2026-02-23 00:43:17.542054 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-23 00:43:17.585642 | localhost | ok: 2026-02-23 00:43:17.586077 | localhost | { 2026-02-23 00:43:17.586147 | localhost | "auth": { 2026-02-23 00:43:17.586215 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-23 00:43:17.586285 | localhost | "username": "9LF91O0RK7JU" 2026-02-23 00:43:17.586364 | localhost | }, 2026-02-23 00:43:17.586431 | localhost | "profile": "rackspace", 2026-02-23 00:43:17.586501 | localhost | "project_name": "1251317", 2026-02-23 00:43:17.586570 | localhost | "region_name": "DFW" 2026-02-23 00:43:17.586640 | localhost | } 2026-02-23 00:43:17.586781 | 2026-02-23 00:43:17.599492 | 2026-02-23 00:43:17.599626 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-23 00:43:17.625602 | localhost | Output suppressed because no_log was given 2026-02-23 00:43:17.649745 | 2026-02-23 00:43:17.649883 | TASK [upload-logs-failover : Initialize control vars] 2026-02-23 00:43:17.680819 | localhost | ok 2026-02-23 00:43:17.686609 | 2026-02-23 00:43:17.686729 | LOOP [upload-logs-failover : Perform log upload] 2026-02-23 00:43:17.758235 | localhost | Output suppressed because no_log was given 2026-02-23 00:43:17.771836 | localhost | included: /var/lib/zuul/builds/1c55fe78834947ba83c8e7b35ecfdee6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-23 00:43:17.786402 | 2026-02-23 00:43:17.786547 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-23 00:43:17.885052 | localhost | Output suppressed because no_log was given 2026-02-23 00:43:17.891968 | 2026-02-23 00:43:17.892057 | TASK [Upload logs to swift] 2026-02-23 00:43:17.914893 | localhost | ok 2026-02-23 00:43:17.950531 | 2026-02-23 00:43:17.950640 | TASK [Set zuul-log-path fact] 2026-02-23 00:43:17.975925 | localhost | skipping: Conditional result was False 2026-02-23 00:43:17.983796 | 2026-02-23 00:43:17.983894 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-23 00:43:18.437702 | localhost -> localhost | ok: Runtime: 0:00:00.009664 2026-02-23 00:43:18.444149 | 2026-02-23 00:43:18.444230 | TASK [upload-logs-swift : Upload logs to swift]