2026-03-04 00:06:50.763028 | Job console starting... 2026-03-04 00:06:50.780312 | Updating repositories 2026-03-04 00:06:50.882063 | Preparing job workspace 2026-03-04 00:07:05.135331 | Running Ansible setup... 2026-03-04 00:07:10.795299 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-04 00:07:11.543518 | 2026-03-04 00:07:11.543662 | PLAY [localhost] 2026-03-04 00:07:11.552520 | 2026-03-04 00:07:11.552608 | TASK [Gathering Facts] 2026-03-04 00:07:12.647451 | localhost | ok 2026-03-04 00:07:12.670917 | 2026-03-04 00:07:12.671172 | TASK [Setup log path fact] 2026-03-04 00:07:12.703062 | localhost | ok 2026-03-04 00:07:12.724647 | 2026-03-04 00:07:12.724823 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-04 00:07:12.769560 | localhost | ok 2026-03-04 00:07:12.781930 | 2026-03-04 00:07:12.782048 | TASK [emit-job-header : Print job information] 2026-03-04 00:07:12.825528 | # Job Information 2026-03-04 00:07:12.825840 | Ansible Version: 2.15.12 2026-03-04 00:07:12.825881 | Job: ansible-test-sanity-docker-stable-2.9 2026-03-04 00:07:12.825908 | Pipeline: periodic 2026-03-04 00:07:12.825931 | Executor: ze03.softwarefactory-project.io 2026-03-04 00:07:12.825954 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-03-04 00:07:12.825978 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/3a0/ansible/3a09f67240b142b2b0254329ccc181d3/ 2026-03-04 00:07:12.826001 | Event ID: 8d080478937447648ab6231966323d70 2026-03-04 00:07:12.830904 | 2026-03-04 00:07:12.830999 | LOOP [emit-job-header : Print node information] 2026-03-04 00:07:12.969250 | localhost | ok: 2026-03-04 00:07:12.969586 | localhost | # Node Information 2026-03-04 00:07:12.969634 | localhost | Inventory Hostname: controller 2026-03-04 00:07:12.969668 | localhost | Hostname: np0005636977 2026-03-04 00:07:12.969695 | localhost | Username: zuul 2026-03-04 00:07:12.970119 | localhost | Distro: Fedora 37 2026-03-04 00:07:12.970176 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-04 00:07:12.970205 | localhost | Region: ca-ymq-1 2026-03-04 00:07:12.970225 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-04 00:07:12.970242 | localhost | Product Name: OpenStack Nova 2026-03-04 00:07:12.970259 | localhost | Interface IP: 162.253.55.195 2026-03-04 00:07:12.999789 | 2026-03-04 00:07:13.000028 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-04 00:07:13.445742 | localhost -> localhost | changed 2026-03-04 00:07:13.454164 | 2026-03-04 00:07:13.454290 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-04 00:07:14.476353 | localhost -> localhost | changed 2026-03-04 00:07:14.514904 | 2026-03-04 00:07:14.515005 | PLAY [all:!appliance*] 2026-03-04 00:07:14.540997 | 2026-03-04 00:07:14.541240 | TASK [include_role : start-zuul-console] 2026-03-04 00:07:14.564648 | controller | ok 2026-03-04 00:07:14.579293 | 2026-03-04 00:07:14.579377 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-04 00:07:14.965116 | controller | ok 2026-03-04 00:07:14.976987 | 2026-03-04 00:07:14.977090 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-04 00:07:15.977245 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-04 00:07:15.992246 | 2026-03-04 00:07:15.992410 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-04 00:07:16.543080 | controller | skipping: Conditional result was False 2026-03-04 00:07:16.563585 | 2026-03-04 00:07:16.563861 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-04 00:07:16.602388 | controller | skipping: Conditional result was False 2026-03-04 00:07:16.612514 | 2026-03-04 00:07:16.612620 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-04 00:07:16.649025 | controller | skipping: Conditional result was False 2026-03-04 00:07:16.663957 | 2026-03-04 00:07:16.664283 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-04 00:07:16.701961 | controller | skipping: Conditional result was False 2026-03-04 00:07:16.716876 | 2026-03-04 00:07:16.717054 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-04 00:07:16.745003 | controller | skipping: Conditional result was False 2026-03-04 00:07:16.762288 | 2026-03-04 00:07:16.762495 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-04 00:07:16.799343 | controller | skipping: Conditional result was False 2026-03-04 00:07:16.815677 | 2026-03-04 00:07:16.815805 | TASK [Disable Fedora Modular] 2026-03-04 00:07:17.075274 | controller | changed 2026-03-04 00:07:17.088265 | 2026-03-04 00:07:17.088400 | TASK [Enable EPEL] 2026-03-04 00:07:17.115543 | controller | skipping: Conditional result was False 2026-03-04 00:07:17.130154 | 2026-03-04 00:07:17.130360 | TASK [Register the RHEL node] 2026-03-04 00:07:17.701051 | 2026-03-04 00:07:17.701334 | TASK [Show the subscription-manager status] 2026-03-04 00:07:18.317368 | controller | skipping: Conditional result was False 2026-03-04 00:07:18.329803 | 2026-03-04 00:07:18.329965 | TASK [Enable EPEL on RHEL] 2026-03-04 00:07:18.875926 | controller | skipping: Conditional result was False 2026-03-04 00:07:18.885558 | 2026-03-04 00:07:18.885697 | TASK [Install git and tox] 2026-03-04 00:08:42.384824 | controller | changed 2026-03-04 00:08:42.401585 | 2026-03-04 00:08:42.401713 | TASK [include_role : prepare-workspace] 2026-03-04 00:08:42.437188 | controller | ok 2026-03-04 00:08:42.472064 | 2026-03-04 00:08:42.472242 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-04 00:08:42.750532 | controller | ok 2026-03-04 00:08:42.760598 | 2026-03-04 00:08:42.760702 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-04 00:15:12.581591 | controller | Output suppressed because no_log was given 2026-03-04 00:15:12.593323 | 2026-03-04 00:15:12.593458 | TASK [include_role : prepare-workspace-openshift] 2026-03-04 00:15:12.625433 | controller | skipping: Conditional result was False 2026-03-04 00:15:12.656041 | 2026-03-04 00:15:12.656186 | PLAY [all:!appliance] 2026-03-04 00:15:12.672781 | 2026-03-04 00:15:12.672917 | TASK [Run add-build-sshkey role (RSA)] 2026-03-04 00:15:12.696464 | controller | ok 2026-03-04 00:15:12.718684 | 2026-03-04 00:15:12.718858 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-04 00:15:12.947719 | controller -> localhost | ok 2026-03-04 00:15:12.955267 | 2026-03-04 00:15:12.955371 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-04 00:15:12.998970 | controller | ok 2026-03-04 00:15:13.023021 | controller | included: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-04 00:15:13.030069 | 2026-03-04 00:15:13.030157 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-04 00:15:13.778332 | controller -> localhost | Generating public/private rsa key pair. 2026-03-04 00:15:13.778579 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/3a09f67240b142b2b0254329ccc181d3_id_rsa. 2026-03-04 00:15:13.778634 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/3a09f67240b142b2b0254329ccc181d3_id_rsa.pub. 2026-03-04 00:15:13.778658 | controller -> localhost | The key fingerprint is: 2026-03-04 00:15:13.778677 | controller -> localhost | SHA256:moCwnxB4CD7ds6FD6fiY9rMpulKevKPD1BVUUbmrThc zuul-build-sshkey 2026-03-04 00:15:13.778720 | controller -> localhost | The key's randomart image is: 2026-03-04 00:15:13.778780 | controller -> localhost | +---[RSA 2048]----+ 2026-03-04 00:15:13.778800 | controller -> localhost | |. ...oo.. | 2026-03-04 00:15:13.778842 | controller -> localhost | |+.. o. . | 2026-03-04 00:15:13.778920 | controller -> localhost | |=o.+ +. . | 2026-03-04 00:15:13.778944 | controller -> localhost | | ==...+ . | 2026-03-04 00:15:13.778962 | controller -> localhost | |o.o+o. SE. | 2026-03-04 00:15:13.778990 | controller -> localhost | | +=o.. o .. | 2026-03-04 00:15:13.779015 | controller -> localhost | |oBoo o... | 2026-03-04 00:15:13.779036 | controller -> localhost | |+o*.. ... | 2026-03-04 00:15:13.779055 | controller -> localhost | |*+o*o .. | 2026-03-04 00:15:13.779075 | controller -> localhost | +----[SHA256]-----+ 2026-03-04 00:15:13.779120 | controller -> localhost | ok: Runtime: 0:00:00.222807 2026-03-04 00:15:13.786310 | 2026-03-04 00:15:13.786404 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-04 00:15:13.823461 | controller | ok 2026-03-04 00:15:13.834825 | controller | included: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-04 00:15:13.847006 | 2026-03-04 00:15:13.847156 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-04 00:15:13.871941 | controller | skipping: Conditional result was False 2026-03-04 00:15:13.878596 | 2026-03-04 00:15:13.878692 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-04 00:15:14.557230 | controller | changed 2026-03-04 00:15:14.565785 | 2026-03-04 00:15:14.565987 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-04 00:15:14.791556 | controller | ok 2026-03-04 00:15:14.810390 | 2026-03-04 00:15:14.810632 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-04 00:15:15.480136 | controller | changed 2026-03-04 00:15:15.488210 | 2026-03-04 00:15:15.488321 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-04 00:15:16.081748 | controller | changed 2026-03-04 00:15:16.088247 | 2026-03-04 00:15:16.088326 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-04 00:15:16.113165 | controller | skipping: Conditional result was False 2026-03-04 00:15:16.121417 | 2026-03-04 00:15:16.121539 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-04 00:15:16.568240 | controller -> localhost | changed 2026-03-04 00:15:16.596931 | 2026-03-04 00:15:16.597075 | TASK [add-build-sshkey : Add back temp key] 2026-03-04 00:15:16.981878 | controller -> localhost | Identity added: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/3a09f67240b142b2b0254329ccc181d3_id_rsa (zuul-build-sshkey) 2026-03-04 00:15:16.982182 | controller -> localhost | ok: Runtime: 0:00:00.007965 2026-03-04 00:15:16.992620 | 2026-03-04 00:15:16.992752 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-04 00:15:17.416470 | controller | ok 2026-03-04 00:15:17.479566 | 2026-03-04 00:15:17.479688 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-04 00:15:17.524684 | controller | skipping: Conditional result was False 2026-03-04 00:15:17.537704 | 2026-03-04 00:15:17.537844 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-04 00:15:17.568345 | controller | ok 2026-03-04 00:15:17.587507 | 2026-03-04 00:15:17.587623 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-04 00:15:17.853477 | controller -> localhost | ok 2026-03-04 00:15:17.860417 | 2026-03-04 00:15:17.860498 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-04 00:15:17.890370 | controller | ok 2026-03-04 00:15:17.911584 | controller | included: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-04 00:15:17.917981 | 2026-03-04 00:15:17.918056 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-04 00:15:18.268247 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-04 00:15:18.268423 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/3a09f67240b142b2b0254329ccc181d3_id_ecdsa. 2026-03-04 00:15:18.268453 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/3a09f67240b142b2b0254329ccc181d3_id_ecdsa.pub. 2026-03-04 00:15:18.268486 | controller -> localhost | The key fingerprint is: 2026-03-04 00:15:18.268508 | controller -> localhost | SHA256:yG+EF/BA73Idi5mithPjZHYHZqQk3xI38lDHJQuD1vQ zuul-build-sshkey 2026-03-04 00:15:18.268529 | controller -> localhost | The key's randomart image is: 2026-03-04 00:15:18.268550 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-04 00:15:18.268570 | controller -> localhost | | *O.o.. | 2026-03-04 00:15:18.268590 | controller -> localhost | | . B =X.o | 2026-03-04 00:15:18.268609 | controller -> localhost | | = X .E . | 2026-03-04 00:15:18.268629 | controller -> localhost | | +.*+ * o | 2026-03-04 00:15:18.268648 | controller -> localhost | | +*.S o | 2026-03-04 00:15:18.268667 | controller -> localhost | | *..B. | 2026-03-04 00:15:18.268686 | controller -> localhost | | =o+ .o | 2026-03-04 00:15:18.268705 | controller -> localhost | | .o. . | 2026-03-04 00:15:18.268746 | controller -> localhost | | .. | 2026-03-04 00:15:18.268771 | controller -> localhost | +----[SHA256]-----+ 2026-03-04 00:15:18.268819 | controller -> localhost | ok: Runtime: 0:00:00.014004 2026-03-04 00:15:18.276757 | 2026-03-04 00:15:18.276828 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-04 00:15:18.307125 | controller | ok 2026-03-04 00:15:18.315596 | controller | included: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-04 00:15:18.325492 | 2026-03-04 00:15:18.325594 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-04 00:15:18.349326 | controller | skipping: Conditional result was False 2026-03-04 00:15:18.355667 | 2026-03-04 00:15:18.355788 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-04 00:15:18.627770 | controller | changed 2026-03-04 00:15:18.641340 | 2026-03-04 00:15:18.641460 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-04 00:15:18.856822 | controller | ok 2026-03-04 00:15:18.865209 | 2026-03-04 00:15:18.865347 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-04 00:15:19.470275 | controller | changed 2026-03-04 00:15:19.478655 | 2026-03-04 00:15:19.478824 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-04 00:15:20.096640 | controller | changed 2026-03-04 00:15:20.105330 | 2026-03-04 00:15:20.105460 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-04 00:15:20.130377 | controller | skipping: Conditional result was False 2026-03-04 00:15:20.137603 | 2026-03-04 00:15:20.137741 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-04 00:15:20.396504 | controller -> localhost | changed 2026-03-04 00:15:20.409081 | 2026-03-04 00:15:20.409170 | TASK [add-build-sshkey : Add back temp key] 2026-03-04 00:15:20.711066 | controller -> localhost | Identity added: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/3a09f67240b142b2b0254329ccc181d3_id_ecdsa (zuul-build-sshkey) 2026-03-04 00:15:20.711282 | controller -> localhost | ok: Runtime: 0:00:00.016582 2026-03-04 00:15:20.720165 | 2026-03-04 00:15:20.720260 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-04 00:15:20.927168 | controller | ok 2026-03-04 00:15:20.934092 | 2026-03-04 00:15:20.934178 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-04 00:15:20.989019 | controller | skipping: Conditional result was False 2026-03-04 00:15:21.001747 | 2026-03-04 00:15:21.001850 | TASK [include_role : remove-zuul-sshkey] 2026-03-04 00:15:21.026407 | controller | skipping: Conditional result was False 2026-03-04 00:15:21.036125 | 2026-03-04 00:15:21.036259 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-04 00:15:21.255211 | controller | ok: "logs" 2026-03-04 00:15:21.260722 | controller | ok: All items complete 2026-03-04 00:15:21.260817 | 2026-03-04 00:15:21.451758 | controller | ok: "artifacts" 2026-03-04 00:15:21.639975 | controller | ok: "docs" 2026-03-04 00:15:21.661412 | 2026-03-04 00:15:21.661604 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-04 00:15:21.877591 | controller | changed: "logs" 2026-03-04 00:15:22.082639 | controller | changed: "artifacts" 2026-03-04 00:15:22.262312 | controller | changed: "docs" 2026-03-04 00:15:22.310752 | 2026-03-04 00:15:22.310871 | PLAY RECAP 2026-03-04 00:15:22.310926 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-04 00:15:22.310960 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-04 00:15:22.311084 | 2026-03-04 00:15:22.455586 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-04 00:15:22.456672 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-04 00:15:23.044178 | 2026-03-04 00:15:23.044311 | PLAY [all] 2026-03-04 00:15:23.067299 | 2026-03-04 00:15:23.067437 | TASK [Install binary dependencies] 2026-03-04 00:15:23.118210 | controller | ok 2026-03-04 00:15:23.141972 | 2026-03-04 00:15:23.142122 | TASK [bindep : Include find tasks] 2026-03-04 00:15:23.172908 | controller | ok 2026-03-04 00:15:23.182037 | controller | included: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-04 00:15:23.188768 | 2026-03-04 00:15:23.188852 | TASK [bindep : Look for bindep.txt] 2026-03-04 00:15:23.755833 | controller | ok 2026-03-04 00:15:23.766010 | 2026-03-04 00:15:23.766160 | TASK [bindep : Define bindep_file fact] 2026-03-04 00:15:23.781952 | controller | skipping: Conditional result was False 2026-03-04 00:15:23.792596 | 2026-03-04 00:15:23.792766 | TASK [bindep : Look for other-requirements.txt] 2026-03-04 00:15:24.004258 | controller | ok 2026-03-04 00:15:24.019786 | 2026-03-04 00:15:24.019987 | TASK [bindep : Define bindep_file fact] 2026-03-04 00:15:24.059296 | controller | skipping: Conditional result was False 2026-03-04 00:15:24.075876 | 2026-03-04 00:15:24.076107 | TASK [bindep : Look for bindep fallback file] 2026-03-04 00:15:24.126893 | controller | skipping: Conditional result was False 2026-03-04 00:15:24.144552 | 2026-03-04 00:15:24.144783 | TASK [bindep : Define bindep_file fact] 2026-03-04 00:15:24.174320 | controller | skipping: Conditional result was False 2026-03-04 00:15:24.190323 | 2026-03-04 00:15:24.190543 | TASK [bindep : Include bindep tasks] 2026-03-04 00:15:24.228374 | controller | skipping: Conditional result was False 2026-03-04 00:15:24.243670 | 2026-03-04 00:15:24.244119 | TASK [bindep : Include install tasks] 2026-03-04 00:15:24.272263 | controller | skipping: Conditional result was False 2026-03-04 00:15:24.283019 | 2026-03-04 00:15:24.283159 | LOOP [bindep : Include package tasks] 2026-03-04 00:15:24.341832 | 2026-03-04 00:15:24.342034 | TASK [Run test-setup role] 2026-03-04 00:15:24.362976 | controller | ok 2026-03-04 00:15:24.381979 | 2026-03-04 00:15:24.382103 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-04 00:15:24.586769 | controller | ok 2026-03-04 00:15:24.593562 | 2026-03-04 00:15:24.593667 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-04 00:15:25.142805 | controller | skipping: Conditional result was False 2026-03-04 00:15:25.200163 | 2026-03-04 00:15:25.200312 | PLAY RECAP 2026-03-04 00:15:25.200378 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-04 00:15:25.200406 | 2026-03-04 00:15:25.333012 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-04 00:15:25.333970 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-04 00:15:26.037085 | 2026-03-04 00:15:26.037295 | PLAY [controller] 2026-03-04 00:15:26.062011 | 2026-03-04 00:15:26.062157 | TASK [Create the /root directory] 2026-03-04 00:15:26.646034 | controller | ok 2026-03-04 00:15:26.654679 | 2026-03-04 00:15:26.654856 | TASK [Install glibc-langpack-en] 2026-03-04 00:15:30.632488 | controller | ok: Nothing to do 2026-03-04 00:15:30.640032 | 2026-03-04 00:15:30.640149 | TASK [Ensure controller directory exists] 2026-03-04 00:15:30.856481 | controller | changed 2026-03-04 00:15:30.863901 | 2026-03-04 00:15:30.864016 | TASK [Install container runtime] 2026-03-04 00:15:30.925303 | controller | ok 2026-03-04 00:15:30.967958 | 2026-03-04 00:15:30.968113 | LOOP [ensure-docker : Gather variables for each operating system] 2026-03-04 00:15:31.001264 | controller | ok: "/var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml" 2026-03-04 00:15:31.009767 | 2026-03-04 00:15:31.009853 | TASK [ensure-docker : Sanity check for distro selection] 2026-03-04 00:15:31.023896 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.031121 | 2026-03-04 00:15:31.031217 | TASK [ensure-docker : Sanity check for distro install] 2026-03-04 00:15:31.055166 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.062171 | 2026-03-04 00:15:31.062275 | TASK [ensure-docker : Sanity check for upstream install] 2026-03-04 00:15:31.086616 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.094772 | 2026-03-04 00:15:31.094886 | TASK [ensure-docker : Sanity check for upstream install mirrors] 2026-03-04 00:15:31.119978 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.126131 | 2026-03-04 00:15:31.126203 | TASK [ensure-docker : Include tasks for docker install] 2026-03-04 00:15:31.145218 | controller | ok 2026-03-04 00:15:31.154118 | controller | included: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml 2026-03-04 00:15:31.163157 | 2026-03-04 00:15:31.163260 | TASK [ensure-docker : Not Implemented] 2026-03-04 00:15:31.186929 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.193357 | 2026-03-04 00:15:31.193425 | TASK [Set up docker mirrors] 2026-03-04 00:15:31.213525 | controller | ok 2026-03-04 00:15:31.234487 | 2026-03-04 00:15:31.234655 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info] 2026-03-04 00:15:31.259272 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.272661 | 2026-03-04 00:15:31.272890 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info] 2026-03-04 00:15:31.300098 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.309499 | 2026-03-04 00:15:31.309649 | TASK [use-docker-mirror : Set docker_mirror fact] 2026-03-04 00:15:31.345113 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.355044 | 2026-03-04 00:15:31.355186 | TASK [use-docker-mirror : Set up docker mirrors] 2026-03-04 00:15:31.392362 | controller | skipping: Conditional result was False 2026-03-04 00:15:31.407130 | 2026-03-04 00:15:31.407243 | TASK [Add all repositories] 2026-03-04 00:15:31.429375 | controller | ok 2026-03-04 00:15:31.465169 | 2026-03-04 00:15:31.465344 | LOOP [ensure-package-repositories : Install repositories] 2026-03-04 00:15:31.493571 | controller | ok: "/var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml" 2026-03-04 00:15:31.494410 | controller | ok: All items complete 2026-03-04 00:15:31.494481 | 2026-03-04 00:15:31.568964 | controller | included: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml 2026-03-04 00:15:31.576582 | 2026-03-04 00:15:31.576808 | TASK [ensure-package-repositories : Create GPG key temp directory] 2026-03-04 00:15:31.898376 | controller | changed 2026-03-04 00:15:31.906103 | 2026-03-04 00:15:31.906190 | LOOP [ensure-package-repositories : Upload GPG keys] 2026-03-04 00:15:32.813480 | controller | changed: 2026-03-04 00:15:32.813707 | controller | { 2026-03-04 00:15:32.813757 | 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-03-04 00:15:32.813801 | controller | } 2026-03-04 00:15:32.821406 | 2026-03-04 00:15:32.821496 | LOOP [ensure-package-repositories : Import GPG keys] 2026-03-04 00:15:33.391592 | controller | changed: 2026-03-04 00:15:33.391836 | controller | { 2026-03-04 00:15:33.391880 | 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-03-04 00:15:33.391925 | controller | } 2026-03-04 00:15:33.391973 | controller | changed: All items complete 2026-03-04 00:15:33.392001 | 2026-03-04 00:15:33.403760 | 2026-03-04 00:15:33.403930 | TASK [ensure-package-repositories : Remove GPG temp directory] 2026-03-04 00:15:33.652076 | controller | changed 2026-03-04 00:15:33.663584 | 2026-03-04 00:15:33.663718 | LOOP [ensure-package-repositories : Add repositories] 2026-03-04 00:15:34.030955 | controller | changed: 2026-03-04 00:15:34.031146 | controller | { 2026-03-04 00:15:34.031213 | controller | "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable", 2026-03-04 00:15:34.031243 | controller | "description": "Docker CE Stable - $basearch", 2026-03-04 00:15:34.031267 | controller | "gpgcheck": true, 2026-03-04 00:15:34.031290 | controller | "name": "docker-ce-stable" 2026-03-04 00:15:34.031311 | controller | } 2026-03-04 00:15:34.055412 | 2026-03-04 00:15:34.055943 | TASK [ensure-docker : Install pre-reqs] 2026-03-04 00:15:36.439554 | controller | ok: Nothing to do 2026-03-04 00:15:36.448592 | 2026-03-04 00:15:36.448927 | TASK [ensure-docker : Remove packages] 2026-03-04 00:15:37.777029 | controller | ok: Nothing to do 2026-03-04 00:15:37.787193 | 2026-03-04 00:15:37.787307 | TASK [ensure-docker : Install upstream docker using package] 2026-03-04 00:20:18.235280 | controller | ERROR 2026-03-04 00:20:18.235827 | controller | { 2026-03-04 00:20:18.235882 | controller | "msg": "Data could not be sent to remote host \"162.253.55.195\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.195 port 22: No route to host\r\n", 2026-03-04 00:20:18.235922 | controller | "unreachable": true 2026-03-04 00:20:18.236507 | controller | } unreachable 2026-03-04 00:20:18.240615 | 2026-03-04 00:20:18.240694 | PLAY RECAP 2026-03-04 00:20:18.240789 | controller | ok: 13 changed: 6 unreachable: 1 failed: 0 skipped: 9 rescued: 0 ignored: 0 2026-03-04 00:20:18.240831 | 2026-03-04 00:20:18.435926 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-04 00:20:18.437512 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-04 00:20:19.074909 | 2026-03-04 00:20:19.075169 | PLAY [all] 2026-03-04 00:20:19.104584 | 2026-03-04 00:20:19.104818 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-04 00:20:48.729658 | controller | ERROR 2026-03-04 00:20:48.730012 | controller | { 2026-03-04 00:20:48.730070 | controller | "msg": "Failed to connect to the host via ssh: ssh: connect to host 162.253.55.195 port 22: No route to host", 2026-03-04 00:20:48.730101 | controller | "unreachable": true 2026-03-04 00:20:48.730144 | controller | } unreachable 2026-03-04 00:20:48.735613 | 2026-03-04 00:20:48.735705 | PLAY RECAP 2026-03-04 00:20:48.735768 | controller | ok: 0 changed: 0 unreachable: 1 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-04 00:20:48.735802 | 2026-03-04 00:20:48.897016 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-04 00:20:48.899054 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-04 00:20:49.549055 | 2026-03-04 00:20:49.549222 | PLAY [all:!appliance*] 2026-03-04 00:20:49.589892 | 2026-03-04 00:20:49.590106 | TASK [unregister the node] 2026-03-04 00:20:52.685818 | [controller] Waiting on logger 2026-03-04 00:20:57.792806 | controller | skipping: Conditional result was False 2026-03-04 00:20:57.800026 | 2026-03-04 00:20:57.800196 | TASK [include_role : fetch-output] 2026-03-04 00:20:57.837211 | controller | ok 2026-03-04 00:20:57.862427 | 2026-03-04 00:20:57.862572 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-04 00:20:57.908822 | controller | skipping: Conditional result was False 2026-03-04 00:20:57.925440 | 2026-03-04 00:20:57.925596 | TASK [fetch-output : Set log path for single node] 2026-03-04 00:20:57.967263 | controller | ok 2026-03-04 00:20:57.975498 | 2026-03-04 00:20:57.975677 | LOOP [fetch-output : Ensure local output dirs] 2026-03-04 00:20:58.562417 | controller -> localhost | ok: "/var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/logs" 2026-03-04 00:20:58.796579 | controller -> localhost | changed: "/var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/artifacts" 2026-03-04 00:20:59.106366 | controller -> localhost | changed: "/var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/work/docs" 2026-03-04 00:20:59.143289 | 2026-03-04 00:20:59.143442 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-04 00:21:00.028101 | controller | changed: 2026-03-04 00:21:00.028327 | controller | .d..t...... ./ 2026-03-04 00:21:00.028364 | controller | cd+++++++++ controller/ 2026-03-04 00:21:00.028409 | controller | changed: All items complete 2026-03-04 00:21:00.028439 | 2026-03-04 00:21:00.557134 | controller | changed: .d..t...... ./ 2026-03-04 00:21:01.088154 | controller | changed: .d..t...... ./ 2026-03-04 00:21:01.111391 | 2026-03-04 00:21:01.111527 | TASK [include_role : fetch-output-openshift] 2026-03-04 00:21:01.136402 | controller | skipping: Conditional result was False 2026-03-04 00:21:01.144021 | 2026-03-04 00:21:01.144120 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-04 00:21:01.196386 | controller | skipping: Conditional result was False 2026-03-04 00:21:01.197236 | controller | skipping: Conditional result was False 2026-03-04 00:21:01.239811 | 2026-03-04 00:21:01.239954 | PLAY [localhost] 2026-03-04 00:21:01.266783 | 2026-03-04 00:21:01.266916 | TASK [Run Zuul manifest role] 2026-03-04 00:21:01.291643 | localhost | ok 2026-03-04 00:21:01.314936 | 2026-03-04 00:21:01.315087 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-04 00:21:01.802429 | localhost | changed 2026-03-04 00:21:01.813543 | 2026-03-04 00:21:01.813790 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-04 00:21:01.867207 | localhost | ok 2026-03-04 00:21:01.898645 | 2026-03-04 00:21:01.898819 | TASK [Set zuul-log-path fact] 2026-03-04 00:21:01.918246 | localhost | ok 2026-03-04 00:21:01.933035 | 2026-03-04 00:21:01.933139 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-04 00:21:01.968111 | localhost | ok 2026-03-04 00:21:01.977487 | 2026-03-04 00:21:01.977595 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-04 00:21:02.016611 | localhost | ok: 2026-03-04 00:21:02.016942 | localhost | { 2026-03-04 00:21:02.016987 | localhost | "auth": { 2026-03-04 00:21:02.017011 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-04 00:21:02.017029 | localhost | "username": "9LF91O0RK7JU" 2026-03-04 00:21:02.017046 | localhost | }, 2026-03-04 00:21:02.017063 | localhost | "profile": "rackspace", 2026-03-04 00:21:02.017079 | localhost | "project_name": "1251317", 2026-03-04 00:21:02.017095 | localhost | "region_name": "DFW" 2026-03-04 00:21:02.017111 | localhost | } 2026-03-04 00:21:02.017144 | 2026-03-04 00:21:02.033861 | 2026-03-04 00:21:02.034062 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-04 00:21:02.058065 | localhost | Output suppressed because no_log was given 2026-03-04 00:21:02.078617 | 2026-03-04 00:21:02.078813 | TASK [upload-logs-failover : Initialize control vars] 2026-03-04 00:21:02.116862 | localhost | ok 2026-03-04 00:21:02.190883 | 2026-03-04 00:21:02.191084 | LOOP [upload-logs-failover : Perform log upload] 2026-03-04 00:21:02.227758 | localhost | Output suppressed because no_log was given 2026-03-04 00:21:02.240258 | localhost | included: /var/lib/zuul/builds/3a09f67240b142b2b0254329ccc181d3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-04 00:21:02.252080 | 2026-03-04 00:21:02.252422 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-04 00:21:02.353910 | localhost | Output suppressed because no_log was given 2026-03-04 00:21:02.360947 | 2026-03-04 00:21:02.361079 | TASK [Upload logs to swift] 2026-03-04 00:21:02.387829 | localhost | ok 2026-03-04 00:21:02.429108 | 2026-03-04 00:21:02.429324 | TASK [Set zuul-log-path fact] 2026-03-04 00:21:02.455511 | localhost | skipping: Conditional result was False 2026-03-04 00:21:02.463583 | 2026-03-04 00:21:02.463790 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-04 00:21:02.944167 | localhost -> localhost | ok: Runtime: 0:00:00.006708 2026-03-04 00:21:02.950888 | 2026-03-04 00:21:02.951058 | TASK [upload-logs-swift : Upload logs to swift]