2025-12-04 00:06:51.620025 | Job console starting... 2025-12-04 00:06:51.631831 | Updating repositories 2025-12-04 00:06:51.811371 | Preparing job workspace 2025-12-04 00:06:58.683438 | Running Ansible setup... 2025-12-04 00:07:04.284017 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-12-04 00:07:04.889171 | 2025-12-04 00:07:04.889292 | PLAY [localhost] 2025-12-04 00:07:04.897743 | 2025-12-04 00:07:04.897815 | TASK [Gathering Facts] 2025-12-04 00:07:05.933571 | localhost | ok 2025-12-04 00:07:05.952125 | 2025-12-04 00:07:05.952200 | TASK [Setup log path fact] 2025-12-04 00:07:05.969821 | localhost | ok 2025-12-04 00:07:05.981936 | 2025-12-04 00:07:05.982001 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-04 00:07:06.009088 | localhost | ok 2025-12-04 00:07:06.017356 | 2025-12-04 00:07:06.017432 | TASK [emit-job-header : Print job information] 2025-12-04 00:07:06.056022 | # Job Information 2025-12-04 00:07:06.056170 | Ansible Version: 2.15.12 2025-12-04 00:07:06.056204 | Job: ansible-test-sanity-docker-stable-2.12 2025-12-04 00:07:06.056226 | Pipeline: periodic 2025-12-04 00:07:06.056262 | Executor: ze02.softwarefactory-project.io 2025-12-04 00:07:06.056288 | Triggered by: https://github.com/ansible-collections/ansible.network 2025-12-04 00:07:06.056310 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/9dd/ansible/9dddcab18a4c47898237afb1a9877071/ 2025-12-04 00:07:06.056329 | Event ID: 21f6f916db01404d9ca1e0a410197a8e 2025-12-04 00:07:06.060310 | 2025-12-04 00:07:06.060401 | LOOP [emit-job-header : Print node information] 2025-12-04 00:07:06.166979 | localhost | ok: 2025-12-04 00:07:06.167158 | localhost | # Node Information 2025-12-04 00:07:06.167196 | localhost | Inventory Hostname: controller 2025-12-04 00:07:06.167223 | localhost | Hostname: np0005544899 2025-12-04 00:07:06.167249 | localhost | Username: zuul 2025-12-04 00:07:06.167278 | localhost | Distro: Fedora 37 2025-12-04 00:07:06.167304 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-12-04 00:07:06.167330 | localhost | Region: ca-ymq-1 2025-12-04 00:07:06.167353 | localhost | Label: ansible-fedora-37-1vcpu 2025-12-04 00:07:06.167376 | localhost | Product Name: OpenStack Nova 2025-12-04 00:07:06.167398 | localhost | Interface IP: 162.253.55.206 2025-12-04 00:07:06.184244 | 2025-12-04 00:07:06.184352 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-04 00:07:06.606982 | localhost -> localhost | changed 2025-12-04 00:07:06.619507 | 2025-12-04 00:07:06.619691 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-04 00:07:07.785441 | localhost -> localhost | changed 2025-12-04 00:07:07.806521 | 2025-12-04 00:07:07.806633 | PLAY [all:!appliance*] 2025-12-04 00:07:07.827406 | 2025-12-04 00:07:07.827543 | TASK [include_role : start-zuul-console] 2025-12-04 00:07:07.847577 | controller | ok 2025-12-04 00:07:07.860348 | 2025-12-04 00:07:07.860423 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-04 00:07:08.258486 | controller | ok 2025-12-04 00:07:08.268974 | 2025-12-04 00:07:08.269041 | TASK [use-our-mirror : Retrieve the IP address] 2025-12-04 00:07:09.637829 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-12-04 00:07:09.645046 | 2025-12-04 00:07:09.645109 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-12-04 00:07:10.184891 | controller | skipping: Conditional result was False 2025-12-04 00:07:10.197381 | 2025-12-04 00:07:10.197501 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-12-04 00:07:10.235925 | controller | skipping: Conditional result was False 2025-12-04 00:07:10.244832 | 2025-12-04 00:07:10.244956 | TASK [use-our-mirror : Create the podman configuration directory] 2025-12-04 00:07:10.270080 | controller | skipping: Conditional result was False 2025-12-04 00:07:10.279195 | 2025-12-04 00:07:10.279309 | TASK [use-our-mirror : Copy the podman configuration] 2025-12-04 00:07:10.304421 | controller | skipping: Conditional result was False 2025-12-04 00:07:10.313165 | 2025-12-04 00:07:10.313256 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-12-04 00:07:10.338713 | controller | skipping: Conditional result was False 2025-12-04 00:07:10.348686 | 2025-12-04 00:07:10.348782 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-12-04 00:07:10.374380 | controller | skipping: Conditional result was False 2025-12-04 00:07:10.397008 | 2025-12-04 00:07:10.397094 | TASK [Disable Fedora Modular] 2025-12-04 00:07:10.646015 | controller | changed 2025-12-04 00:07:10.653307 | 2025-12-04 00:07:10.653431 | TASK [Enable EPEL] 2025-12-04 00:07:10.719348 | controller | skipping: Conditional result was False 2025-12-04 00:07:10.727809 | 2025-12-04 00:07:10.727875 | TASK [Register the RHEL node] 2025-12-04 00:07:11.263829 | 2025-12-04 00:07:11.263969 | TASK [Show the subscription-manager status] 2025-12-04 00:07:11.822488 | controller | skipping: Conditional result was False 2025-12-04 00:07:11.836799 | 2025-12-04 00:07:11.836937 | TASK [Enable EPEL on RHEL] 2025-12-04 00:07:12.393530 | controller | skipping: Conditional result was False 2025-12-04 00:07:12.402216 | 2025-12-04 00:07:12.402308 | TASK [Install git and tox] 2025-12-04 00:08:36.733828 | controller | changed 2025-12-04 00:08:36.747646 | 2025-12-04 00:08:36.747765 | TASK [include_role : prepare-workspace] 2025-12-04 00:08:36.781570 | controller | ok 2025-12-04 00:08:36.816636 | 2025-12-04 00:08:36.816779 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-12-04 00:08:37.071850 | controller | ok 2025-12-04 00:08:37.081959 | 2025-12-04 00:08:37.082093 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-12-04 00:08:53.492530 | controller | Output suppressed because no_log was given 2025-12-04 00:08:53.547634 | 2025-12-04 00:08:53.547778 | TASK [include_role : prepare-workspace-openshift] 2025-12-04 00:08:53.564501 | controller | skipping: Conditional result was False 2025-12-04 00:08:53.587700 | 2025-12-04 00:08:53.587802 | PLAY [all:!appliance] 2025-12-04 00:08:53.606450 | 2025-12-04 00:08:53.606577 | TASK [Run add-build-sshkey role (RSA)] 2025-12-04 00:08:53.627510 | controller | ok 2025-12-04 00:08:53.649536 | 2025-12-04 00:08:53.649752 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-04 00:08:53.902236 | controller -> localhost | ok 2025-12-04 00:08:53.918245 | 2025-12-04 00:08:53.918384 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-04 00:08:53.953789 | controller | ok 2025-12-04 00:08:53.980868 | controller | included: /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-04 00:08:53.990012 | 2025-12-04 00:08:53.990102 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-04 00:08:54.494842 | controller -> localhost | Generating public/private rsa key pair. 2025-12-04 00:08:54.495072 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/9dddcab18a4c47898237afb1a9877071_id_rsa. 2025-12-04 00:08:54.495102 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/9dddcab18a4c47898237afb1a9877071_id_rsa.pub. 2025-12-04 00:08:54.495123 | controller -> localhost | The key fingerprint is: 2025-12-04 00:08:54.495143 | controller -> localhost | SHA256:1SGpWPIxVC769+xRF+Oitp10J81DB39k14emsRiY4aU zuul-build-sshkey 2025-12-04 00:08:54.495162 | controller -> localhost | The key's randomart image is: 2025-12-04 00:08:54.495181 | controller -> localhost | +---[RSA 2048]----+ 2025-12-04 00:08:54.495198 | controller -> localhost | | .o.+.. | 2025-12-04 00:08:54.495217 | controller -> localhost | | ..+B.o . ..| 2025-12-04 00:08:54.495235 | controller -> localhost | | =E++ o +o*| 2025-12-04 00:08:54.495252 | controller -> localhost | | ..oo o =.==| 2025-12-04 00:08:54.495270 | controller -> localhost | | . S . o..o=| 2025-12-04 00:08:54.495297 | controller -> localhost | | . ..o+o| 2025-12-04 00:08:54.495319 | controller -> localhost | | . .o...o+| 2025-12-04 00:08:54.495339 | controller -> localhost | | ..o+.o.o| 2025-12-04 00:08:54.495357 | controller -> localhost | | o+o | 2025-12-04 00:08:54.495377 | controller -> localhost | +----[SHA256]-----+ 2025-12-04 00:08:54.495425 | controller -> localhost | ok: Runtime: 0:00:00.065853 2025-12-04 00:08:54.503627 | 2025-12-04 00:08:54.503715 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-04 00:08:54.524359 | controller | ok 2025-12-04 00:08:54.535778 | controller | included: /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-04 00:08:54.545197 | 2025-12-04 00:08:54.545298 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-04 00:08:54.570647 | controller | skipping: Conditional result was False 2025-12-04 00:08:54.580758 | 2025-12-04 00:08:54.580871 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-04 00:13:56.539175 | controller | changed 2025-12-04 00:13:56.553819 | 2025-12-04 00:13:56.554029 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-04 00:13:56.763290 | controller | ok 2025-12-04 00:13:56.772276 | 2025-12-04 00:13:56.772418 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-04 00:13:57.389186 | controller | changed 2025-12-04 00:13:57.395756 | 2025-12-04 00:13:57.395828 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-04 00:13:58.067333 | controller | changed 2025-12-04 00:13:58.082447 | 2025-12-04 00:13:58.082629 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-04 00:13:58.123485 | controller | skipping: Conditional result was False 2025-12-04 00:13:58.140564 | 2025-12-04 00:13:58.140756 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-04 00:13:58.600688 | controller -> localhost | changed 2025-12-04 00:13:58.613359 | 2025-12-04 00:13:58.613435 | TASK [add-build-sshkey : Add back temp key] 2025-12-04 00:13:58.959602 | controller -> localhost | Identity added: /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/9dddcab18a4c47898237afb1a9877071_id_rsa (zuul-build-sshkey) 2025-12-04 00:13:58.959934 | controller -> localhost | ok: Runtime: 0:00:00.020959 2025-12-04 00:13:58.969178 | 2025-12-04 00:13:58.969568 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-04 00:13:59.352725 | controller | ok 2025-12-04 00:13:59.358604 | 2025-12-04 00:13:59.358692 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-04 00:13:59.394217 | controller | skipping: Conditional result was False 2025-12-04 00:13:59.407431 | 2025-12-04 00:13:59.407553 | TASK [Run add-build-sshkey role (ECDSA)] 2025-12-04 00:13:59.438839 | controller | ok 2025-12-04 00:13:59.455579 | 2025-12-04 00:13:59.455687 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-04 00:13:59.750598 | controller -> localhost | ok 2025-12-04 00:13:59.757695 | 2025-12-04 00:13:59.757766 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-04 00:13:59.789512 | controller | ok 2025-12-04 00:13:59.801103 | controller | included: /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-04 00:13:59.807364 | 2025-12-04 00:13:59.807432 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-04 00:14:00.142931 | controller -> localhost | Generating public/private ecdsa key pair. 2025-12-04 00:14:00.143184 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/9dddcab18a4c47898237afb1a9877071_id_ecdsa. 2025-12-04 00:14:00.143214 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/9dddcab18a4c47898237afb1a9877071_id_ecdsa.pub. 2025-12-04 00:14:00.143244 | controller -> localhost | The key fingerprint is: 2025-12-04 00:14:00.143265 | controller -> localhost | SHA256:4DZ+JIm5JxvDlsaKf3QzOPMOrVJUVo/VpLSm715ij74 zuul-build-sshkey 2025-12-04 00:14:00.143284 | controller -> localhost | The key's randomart image is: 2025-12-04 00:14:00.143303 | controller -> localhost | +---[ECDSA 521]---+ 2025-12-04 00:14:00.143321 | controller -> localhost | | .. oo. | 2025-12-04 00:14:00.143338 | controller -> localhost | | o = o. | 2025-12-04 00:14:00.143355 | controller -> localhost | | o. . = | 2025-12-04 00:14:00.143372 | controller -> localhost | | .+ o o | 2025-12-04 00:14:00.143388 | controller -> localhost | | .o.* S | 2025-12-04 00:14:00.143405 | controller -> localhost | | o**++ . | 2025-12-04 00:14:00.143422 | controller -> localhost | | o%=+o. + . | 2025-12-04 00:14:00.143438 | controller -> localhost | | ..+.O.. o = | 2025-12-04 00:14:00.143456 | controller -> localhost | |..ooo.. oE.. | 2025-12-04 00:14:00.143473 | controller -> localhost | +----[SHA256]-----+ 2025-12-04 00:14:00.143529 | controller -> localhost | ok: Runtime: 0:00:00.021197 2025-12-04 00:14:00.151495 | 2025-12-04 00:14:00.151570 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-04 00:14:00.227234 | controller | ok 2025-12-04 00:14:00.235165 | controller | included: /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-04 00:14:00.244421 | 2025-12-04 00:14:00.244489 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-04 00:14:00.269631 | controller | skipping: Conditional result was False 2025-12-04 00:14:00.276809 | 2025-12-04 00:14:00.276883 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-04 00:14:00.546188 | controller | changed 2025-12-04 00:14:00.555735 | 2025-12-04 00:14:00.555833 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-04 00:14:00.787433 | controller | ok 2025-12-04 00:14:00.796323 | 2025-12-04 00:14:00.796406 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-04 00:14:01.443292 | controller | changed 2025-12-04 00:14:01.454757 | 2025-12-04 00:14:01.454880 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-04 00:14:02.094642 | controller | changed 2025-12-04 00:14:02.111163 | 2025-12-04 00:14:02.111404 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-04 00:14:02.156003 | controller | skipping: Conditional result was False 2025-12-04 00:14:02.166811 | 2025-12-04 00:14:02.166922 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-04 00:14:02.458771 | controller -> localhost | changed 2025-12-04 00:14:02.471407 | 2025-12-04 00:14:02.471543 | TASK [add-build-sshkey : Add back temp key] 2025-12-04 00:14:02.775186 | controller -> localhost | Identity added: /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/9dddcab18a4c47898237afb1a9877071_id_ecdsa (zuul-build-sshkey) 2025-12-04 00:14:02.775486 | controller -> localhost | ok: Runtime: 0:00:00.016787 2025-12-04 00:14:02.782560 | 2025-12-04 00:14:02.782644 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-04 00:14:02.989059 | controller | ok 2025-12-04 00:14:02.994999 | 2025-12-04 00:14:02.995064 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-04 00:14:03.052743 | controller | skipping: Conditional result was False 2025-12-04 00:14:03.070191 | 2025-12-04 00:14:03.070302 | TASK [include_role : remove-zuul-sshkey] 2025-12-04 00:14:03.096957 | controller | skipping: Conditional result was False 2025-12-04 00:14:03.105871 | 2025-12-04 00:14:03.105948 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-12-04 00:14:03.325775 | controller | ok: "logs" 2025-12-04 00:14:03.326234 | controller | ok: All items complete 2025-12-04 00:14:03.326267 | 2025-12-04 00:14:03.526462 | controller | ok: "artifacts" 2025-12-04 00:14:03.737742 | controller | ok: "docs" 2025-12-04 00:14:03.759106 | 2025-12-04 00:14:03.759300 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-12-04 00:14:04.007003 | controller | changed: "logs" 2025-12-04 00:14:04.227042 | controller | changed: "artifacts" 2025-12-04 00:14:04.442514 | controller | changed: "docs" 2025-12-04 00:14:04.514639 | 2025-12-04 00:14:04.514932 | PLAY RECAP 2025-12-04 00:14:04.515045 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-12-04 00:14:04.515088 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-04 00:14:04.515117 | 2025-12-04 00:14:04.671845 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-12-04 00:14:04.673549 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-12-04 00:14:05.365759 | 2025-12-04 00:14:05.366117 | PLAY [all] 2025-12-04 00:14:05.421743 | 2025-12-04 00:14:05.421906 | TASK [Install binary dependencies] 2025-12-04 00:14:05.495893 | controller | ok 2025-12-04 00:14:05.522716 | 2025-12-04 00:14:05.522801 | TASK [bindep : Include find tasks] 2025-12-04 00:14:05.566767 | controller | ok 2025-12-04 00:14:05.582070 | controller | included: /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2025-12-04 00:14:05.592197 | 2025-12-04 00:14:05.592294 | TASK [bindep : Look for bindep.txt] 2025-12-04 00:14:06.184852 | controller | ok 2025-12-04 00:14:06.198413 | 2025-12-04 00:14:06.198742 | TASK [bindep : Define bindep_file fact] 2025-12-04 00:14:06.226859 | controller | skipping: Conditional result was False 2025-12-04 00:14:06.236486 | 2025-12-04 00:14:06.236698 | TASK [bindep : Look for other-requirements.txt] 2025-12-04 00:14:06.479967 | controller | ok 2025-12-04 00:14:06.492365 | 2025-12-04 00:14:06.492514 | TASK [bindep : Define bindep_file fact] 2025-12-04 00:14:06.533548 | controller | skipping: Conditional result was False 2025-12-04 00:14:06.545573 | 2025-12-04 00:14:06.545831 | TASK [bindep : Look for bindep fallback file] 2025-12-04 00:14:06.594971 | controller | skipping: Conditional result was False 2025-12-04 00:14:06.606225 | 2025-12-04 00:14:06.606348 | TASK [bindep : Define bindep_file fact] 2025-12-04 00:14:06.643258 | controller | skipping: Conditional result was False 2025-12-04 00:14:06.659148 | 2025-12-04 00:14:06.659301 | TASK [bindep : Include bindep tasks] 2025-12-04 00:14:06.700414 | controller | skipping: Conditional result was False 2025-12-04 00:14:06.709084 | 2025-12-04 00:14:06.709160 | TASK [bindep : Include install tasks] 2025-12-04 00:14:06.734972 | controller | skipping: Conditional result was False 2025-12-04 00:14:06.752807 | 2025-12-04 00:14:06.752990 | LOOP [bindep : Include package tasks] 2025-12-04 00:14:06.812862 | 2025-12-04 00:14:06.813045 | TASK [Run test-setup role] 2025-12-04 00:14:06.837025 | controller | ok 2025-12-04 00:14:06.864411 | 2025-12-04 00:14:06.864520 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2025-12-04 00:14:07.108249 | controller | ok 2025-12-04 00:14:07.123408 | 2025-12-04 00:14:07.123645 | TASK [test-setup : Run tools/test-setup.sh] 2025-12-04 00:14:07.679791 | controller | skipping: Conditional result was False 2025-12-04 00:14:07.728289 | 2025-12-04 00:14:07.728406 | PLAY RECAP 2025-12-04 00:14:07.728458 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-04 00:14:07.728485 | 2025-12-04 00:14:07.834138 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-12-04 00:14:07.835815 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-12-04 00:14:08.471887 | 2025-12-04 00:14:08.472018 | PLAY [controller] 2025-12-04 00:14:08.492715 | 2025-12-04 00:14:08.492847 | TASK [Create the /root directory] 2025-12-04 00:14:09.054626 | controller | ok 2025-12-04 00:14:09.061602 | 2025-12-04 00:14:09.061713 | TASK [Install glibc-langpack-en] 2025-12-04 00:14:12.922338 | controller | ok: Nothing to do 2025-12-04 00:14:12.935353 | 2025-12-04 00:14:12.935492 | TASK [Ensure controller directory exists] 2025-12-04 00:14:13.162285 | controller | changed 2025-12-04 00:14:13.176732 | 2025-12-04 00:14:13.176873 | TASK [Install container runtime] 2025-12-04 00:14:13.229162 | controller | ok 2025-12-04 00:14:13.335960 | 2025-12-04 00:14:13.336170 | LOOP [ensure-podman : Find distribution installation] 2025-12-04 00:14:13.367123 | controller | ok: "/var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2025-12-04 00:14:13.381768 | controller | included: /var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2025-12-04 00:14:13.388208 | 2025-12-04 00:14:13.388279 | TASK [ensure-podman : Install podman (RedHat)] 2025-12-04 00:15:17.939585 | controller | changed 2025-12-04 00:15:17.954417 | 2025-12-04 00:15:17.954606 | TASK [ensure-podman : Fetch podman version] 2025-12-04 00:15:18.546931 | controller | Client: Podman Engine 2025-12-04 00:15:18.566928 | controller | Version: 4.6.2 2025-12-04 00:15:18.566970 | controller | API Version: 4.6.2 2025-12-04 00:15:18.566983 | controller | Go Version: go1.19.12 2025-12-04 00:15:18.567008 | controller | Built: Mon Aug 28 19:38:31 2023 2025-12-04 00:15:18.567020 | controller | OS/Arch: linux/amd64 2025-12-04 00:15:19.006829 | controller | ok: Runtime: 0:00:00.184950 2025-12-04 00:15:19.021176 | 2025-12-04 00:15:19.021361 | TASK [ensure-podman : Print podman version installed] 2025-12-04 00:15:19.064196 | Podman version: Client: Podman Engine 2025-12-04 00:15:19.064375 | Version: 4.6.2 2025-12-04 00:15:19.064406 | API Version: 4.6.2 2025-12-04 00:15:19.064426 | Go Version: go1.19.12 2025-12-04 00:15:19.064444 | Built: Mon Aug 28 19:38:31 2023 2025-12-04 00:15:19.064461 | OS/Arch: linux/amd64 2025-12-04 00:15:19.070173 | 2025-12-04 00:15:19.070270 | TASK [ensure-podman : Validate podman engine] 2025-12-04 00:15:19.601500 | controller | skipping: Conditional result was False 2025-12-04 00:15:19.617454 | 2025-12-04 00:15:19.617635 | TASK [ensure-podman : Set up docker compatability socket] 2025-12-04 00:15:19.644746 | controller | skipping: Conditional result was False 2025-12-04 00:15:19.668449 | 2025-12-04 00:15:19.668602 | TASK [Ensure python3.8 is present] 2025-12-04 00:15:19.695403 | controller | skipping: Conditional result was False 2025-12-04 00:15:19.701638 | 2025-12-04 00:15:19.701728 | TASK [Run our-ensure-python role (Fedora only for now)] 2025-12-04 00:15:19.727131 | controller | ok 2025-12-04 00:15:19.758879 | 2025-12-04 00:15:19.759004 | TASK [our-ensure-python : Install the right Python version (rpm)] 2025-12-04 00:15:21.344912 | controller | ok: Nothing to do 2025-12-04 00:15:21.358475 | 2025-12-04 00:15:21.358616 | TASK [our-ensure-python : Also install python3-devel] 2025-12-04 00:15:31.036416 | controller | changed 2025-12-04 00:15:31.059540 | 2025-12-04 00:15:31.059693 | TASK [Run ensure-virtualenv role] 2025-12-04 00:15:31.093208 | controller | ok 2025-12-04 00:15:31.122027 | 2025-12-04 00:15:31.122154 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2025-12-04 00:15:31.359749 | controller | /usr/bin/virtualenv 2025-12-04 00:15:31.660650 | controller | ok: Runtime: 0:00:00.005490 2025-12-04 00:15:31.669699 | 2025-12-04 00:15:31.669792 | LOOP [ensure-virtualenv : Install virtualenv package] 2025-12-04 00:15:31.704411 | controller | skipping: Conditional result was False 2025-12-04 00:15:31.704888 | controller | ok: All items complete 2025-12-04 00:15:31.704928 | 2025-12-04 00:15:31.723277 | 2025-12-04 00:15:31.723490 | TASK [Find the full path of the Python interpreter] 2025-12-04 00:15:31.993957 | controller | /usr/bin/python3.10 2025-12-04 00:15:32.301935 | controller | ok 2025-12-04 00:15:32.314992 | 2025-12-04 00:15:32.315237 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2025-12-04 00:15:33.315068 | controller | created virtual environment CPython3.10.13.final.0-64 in 554ms 2025-12-04 00:15:33.331716 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2025-12-04 00:15:33.331759 | 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) 2025-12-04 00:15:33.331770 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-12-04 00:15:33.331785 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-12-04 00:15:33.368486 | controller | changed 2025-12-04 00:15:33.381816 | 2025-12-04 00:15:33.381949 | TASK [Set selinux package] 2025-12-04 00:15:33.420794 | controller | ok 2025-12-04 00:15:33.435133 | 2025-12-04 00:15:33.435272 | TASK [Set selinux package (Fedora)] 2025-12-04 00:15:33.495367 | controller | ok 2025-12-04 00:15:33.507231 | 2025-12-04 00:15:33.507368 | TASK [Install selinux into virtualenv] 2025-12-04 00:15:34.745060 | controller | Collecting selinux-please-lie-to-me 2025-12-04 00:15:34.784118 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2025-12-04 00:15:35.119556 | controller | Collecting setuptools<50.0.0 2025-12-04 00:15:35.124851 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2025-12-04 00:15:35.162482 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 24.9 MB/s eta 0:00:00 2025-12-04 00:15:35.238906 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2025-12-04 00:15:35.239081 | controller | Attempting uninstall: setuptools 2025-12-04 00:15:35.239755 | controller | Found existing installation: setuptools 62.6.0 2025-12-04 00:15:35.309000 | controller | Uninstalling setuptools-62.6.0: 2025-12-04 00:15:35.317471 | controller | Successfully uninstalled setuptools-62.6.0 2025-12-04 00:15:35.640043 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2025-12-04 00:15:35.762873 | controller | 2025-12-04 00:15:35.838517 | controller | [notice] A new release of pip available: 22.2.2 -> 25.3 2025-12-04 00:15:35.838533 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip 2025-12-04 00:15:36.058002 | controller | ok: Runtime: 0:00:02.114720 2025-12-04 00:15:36.071366 | 2025-12-04 00:15:36.071533 | TASK [Install pytest-forked into virtualenv] 2025-12-04 00:15:36.644455 | controller | Collecting pytest-forked 2025-12-04 00:15:36.677882 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2025-12-04 00:15:36.806424 | controller | Collecting pytest>=3.10 2025-12-04 00:15:36.812766 | controller | Downloading pytest-9.0.1-py3-none-any.whl (373 kB) 2025-12-04 00:15:36.834791 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 373.7/373.7 kB 18.9 MB/s eta 0:00:00 2025-12-04 00:15:36.865434 | controller | Collecting py 2025-12-04 00:15:36.870757 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2025-12-04 00:15:36.877542 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 18.4 MB/s eta 0:00:00 2025-12-04 00:15:36.933700 | controller | Collecting tomli>=1 2025-12-04 00:15:36.939514 | controller | Downloading tomli-2.3.0-py3-none-any.whl (14 kB) 2025-12-04 00:15:36.990022 | controller | Collecting pygments>=2.7.2 2025-12-04 00:15:36.995238 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2025-12-04 00:15:37.028507 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 40.7 MB/s eta 0:00:00 2025-12-04 00:15:37.064285 | controller | Collecting exceptiongroup>=1 2025-12-04 00:15:37.068053 | controller | Downloading exceptiongroup-1.3.1-py3-none-any.whl (16 kB) 2025-12-04 00:15:37.095465 | controller | Collecting iniconfig>=1.0.1 2025-12-04 00:15:37.098891 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2025-12-04 00:15:37.142860 | controller | Collecting pluggy<2,>=1.5 2025-12-04 00:15:37.147689 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-04 00:15:37.189470 | controller | Collecting packaging>=22 2025-12-04 00:15:37.193127 | controller | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-04 00:15:37.201946 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.3 MB/s eta 0:00:00 2025-12-04 00:15:37.253911 | controller | Collecting typing-extensions>=4.6.0 2025-12-04 00:15:37.257705 | controller | Downloading typing_extensions-4.15.0-py3-none-any.whl (44 kB) 2025-12-04 00:15:37.263600 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 44.6/44.6 kB 10.7 MB/s eta 0:00:00 2025-12-04 00:15:37.332809 | controller | Installing collected packages: typing-extensions, tomli, pygments, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked 2025-12-04 00:15:38.444629 | controller | Successfully installed exceptiongroup-1.3.1 iniconfig-2.3.0 packaging-25.0 pluggy-1.6.0 py-1.11.0 pygments-2.19.2 pytest-9.0.1 pytest-forked-1.6.0 tomli-2.3.0 typing-extensions-4.15.0 2025-12-04 00:15:38.448938 | controller | 2025-12-04 00:15:38.522296 | controller | [notice] A new release of pip available: 22.2.2 -> 25.3 2025-12-04 00:15:38.522343 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip 2025-12-04 00:15:38.630463 | controller | ok: Runtime: 0:00:02.238270 2025-12-04 00:15:38.640190 | 2025-12-04 00:15:38.640327 | TASK [Update pip] 2025-12-04 00:15:39.169062 | controller | Requirement already satisfied: pip in ./venv/lib/python3.10/site-packages (22.2.2) 2025-12-04 00:15:39.300842 | controller | Collecting pip 2025-12-04 00:15:39.334384 | controller | Downloading pip-25.3-py3-none-any.whl (1.8 MB) 2025-12-04 00:15:39.392003 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 32.9 MB/s eta 0:00:00 2025-12-04 00:15:39.452488 | controller | Installing collected packages: pip 2025-12-04 00:15:39.452687 | controller | Attempting uninstall: pip 2025-12-04 00:15:39.453287 | controller | Found existing installation: pip 22.2.2 2025-12-04 00:15:39.618999 | controller | Uninstalling pip-22.2.2: 2025-12-04 00:15:39.636202 | controller | Successfully uninstalled pip-22.2.2 2025-12-04 00:15:40.461291 | controller | Successfully installed pip-25.3 2025-12-04 00:15:40.685277 | controller | ok: Runtime: 0:00:01.655832 2025-12-04 00:15:40.699016 | 2025-12-04 00:15:40.699156 | TASK [Ensure pip temp directory exists in /var/tmp] 2025-12-04 00:15:40.912647 | controller | changed 2025-12-04 00:15:40.926065 | 2025-12-04 00:15:40.926218 | TASK [Install ansible into virtualenv] 2025-12-04 00:15:41.481180 | controller | Processing ./src/github.com/ansible/ansible 2025-12-04 00:15:41.484018 | controller | Installing build dependencies: started 2025-12-04 00:15:42.441580 | controller | Installing build dependencies: finished with status 'done' 2025-12-04 00:15:42.442750 | controller | Getting requirements to build wheel: started 2025-12-04 00:15:43.063264 | controller | Getting requirements to build wheel: finished with status 'done' 2025-12-04 00:15:43.532207 | controller | Preparing metadata (pyproject.toml): started 2025-12-04 00:15:43.532253 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2025-12-04 00:15:43.665850 | controller | Collecting jinja2 (from ansible-core==2.12.10.post0) 2025-12-04 00:15:43.727114 | controller | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-12-04 00:15:43.803611 | controller | Collecting PyYAML (from ansible-core==2.12.10.post0) 2025-12-04 00:15:43.811706 | controller | Downloading pyyaml-6.0.3-cp310-cp310-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.4 kB) 2025-12-04 00:15:44.109117 | controller | Collecting cryptography (from ansible-core==2.12.10.post0) 2025-12-04 00:15:44.114285 | controller | Downloading cryptography-46.0.3-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-12-04 00:15:44.132852 | controller | Requirement already satisfied: packaging in ./venv/lib/python3.10/site-packages (from ansible-core==2.12.10.post0) (25.0) 2025-12-04 00:15:44.151259 | controller | Collecting resolvelib<0.6.0,>=0.5.3 (from ansible-core==2.12.10.post0) 2025-12-04 00:15:44.169138 | controller | Downloading resolvelib-0.5.4-py2.py3-none-any.whl.metadata (3.7 kB) 2025-12-04 00:15:44.327378 | controller | Collecting cffi>=2.0.0 (from cryptography->ansible-core==2.12.10.post0) 2025-12-04 00:15:44.338358 | controller | Downloading cffi-2.0.0-cp310-cp310-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2025-12-04 00:15:44.357173 | controller | Requirement already satisfied: typing-extensions>=4.13.2 in ./venv/lib/python3.10/site-packages (from cryptography->ansible-core==2.12.10.post0) (4.15.0) 2025-12-04 00:15:44.399787 | controller | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core==2.12.10.post0) 2025-12-04 00:15:44.403677 | controller | Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes) 2025-12-04 00:15:44.488499 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible-core==2.12.10.post0) 2025-12-04 00:15:44.504285 | controller | Downloading markupsafe-3.0.3-cp310-cp310-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.7 kB) 2025-12-04 00:15:44.524317 | controller | Downloading resolvelib-0.5.4-py2.py3-none-any.whl (12 kB) 2025-12-04 00:15:44.568124 | controller | Downloading cryptography-46.0.3-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-12-04 00:15:44.769214 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 22.6 MB/s 0:00:00 2025-12-04 00:15:44.773025 | controller | Downloading cffi-2.0.0-cp310-cp310-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (216 kB) 2025-12-04 00:15:44.785496 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-12-04 00:15:44.796774 | controller | Downloading markupsafe-3.0.3-cp310-cp310-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (20 kB) 2025-12-04 00:15:44.805612 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB) 2025-12-04 00:15:44.819343 | controller | Downloading pyyaml-6.0.3-cp310-cp310-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (770 kB) 2025-12-04 00:15:44.843737 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 770.3/770.3 kB 26.5 MB/s 0:00:00 2025-12-04 00:15:44.854585 | controller | Building wheels for collected packages: ansible-core 2025-12-04 00:15:44.856114 | controller | Building wheel for ansible-core (pyproject.toml): started 2025-12-04 00:15:46.479686 | controller | Building wheel for ansible-core (pyproject.toml): finished with status 'done' 2025-12-04 00:15:46.487895 | controller | Created wheel for ansible-core: filename=ansible_core-2.12.10.post0-py3-none-any.whl size=2117519 sha256=6e04498b34e532ecb892a292272dce424aa36baaba7c8797b846a358d6e1e0ad 2025-12-04 00:15:46.487908 | controller | Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-uigk0j7s/wheels/68/27/b0/9b068d12b42b734c64dc438319298ad4c1c5027b13ccb3a660 2025-12-04 00:15:46.487926 | controller | Successfully built ansible-core 2025-12-04 00:15:46.544362 | controller | Installing collected packages: resolvelib, PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible-core 2025-12-04 00:15:48.468372 | controller | 2025-12-04 00:15:48.470866 | controller | Successfully installed MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-core-2.12.10.post0 cffi-2.0.0 cryptography-46.0.3 jinja2-3.1.6 pycparser-2.23 resolvelib-0.5.4 2025-12-04 00:15:49.031445 | controller | ok: Runtime: 0:00:07.440720 2025-12-04 00:15:49.046347 | 2025-12-04 00:15:49.046602 | TASK [Setup download-artifact-fork role] 2025-12-04 00:15:49.077775 | controller | ok 2025-12-04 00:15:49.148900 | 2025-12-04 00:15:49.149036 | TASK [download-artifact-fork : Parse inventory response] 2025-12-04 00:15:49.182605 | controller | ok 2025-12-04 00:15:49.191208 | 2025-12-04 00:15:49.191300 | TASK [download-artifact-fork : Fetch info from Zuul API] 2025-12-04 00:15:49.216522 | controller | skipping: Conditional result was False 2025-12-04 00:15:49.227424 | 2025-12-04 00:15:49.227523 | TASK [download-artifact-fork : Parse build response] 2025-12-04 00:15:49.255212 | controller | skipping: Conditional result was False 2025-12-04 00:15:49.268224 | 2025-12-04 00:15:49.268331 | TASK [download-artifact-fork : Ensure artifacts directory exists] 2025-12-04 00:15:49.555045 | controller | changed 2025-12-04 00:15:49.563862 | 2025-12-04 00:15:49.563985 | LOOP [download-artifact-fork : Download archive by type] 2025-12-04 00:15:49.605429 | controller | skipping: Conditional result was False 2025-12-04 00:15:49.605962 | 2025-12-04 00:15:50.796692 | controller | changed: OK (20206 bytes) 2025-12-04 00:15:50.817091 | 2025-12-04 00:15:50.817170 | TASK [deploy-artifacts : define __collections] 2025-12-04 00:15:50.856841 | controller | ok 2025-12-04 00:15:50.862013 | 2025-12-04 00:15:50.862076 | LOOP [deploy-artifacts : Create list of collections] 2025-12-04 00:15:50.887578 | controller | skipping: Conditional result was False 2025-12-04 00:15:50.902826 | controller | ok: 2025-12-04 00:15:50.902929 | controller | { 2025-12-04 00:15:50.902976 | controller | "branch": "main", 2025-12-04 00:15:50.903016 | controller | "job": "build-ansible-collection", 2025-12-04 00:15:50.903052 | controller | "metadata": { 2025-12-04 00:15:50.903087 | controller | "type": "ansible_collection", 2025-12-04 00:15:50.903122 | controller | "version": "5.0.0" 2025-12-04 00:15:50.903186 | controller | }, 2025-12-04 00:15:50.903221 | controller | "name": "ansible.network", 2025-12-04 00:15:50.903255 | controller | "project": "ansible-collections/ansible.network", 2025-12-04 00:15:50.903289 | controller | "url": "https://fbecb4dc559a52b4ca2d-60669662a12ad9533aef0b938ec3720d.ssl.cf2.rackcdn.com/ansible/6a43c116b98840d7aad5e3e8e31ead01/artifacts/ansible-network-5.0.0.tar.gz" 2025-12-04 00:15:50.903335 | controller | } 2025-12-04 00:15:50.924865 | 2025-12-04 00:15:50.925086 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy] 2025-12-04 00:15:51.554086 | controller | Starting galaxy collection install process 2025-12-04 00:15:51.554284 | controller | Process install dependency map 2025-12-04 00:20:42.294416 | [Zuul] Log Stream did not terminate 2025-12-04 00:20:42.295446 | controller | ERROR 2025-12-04 00:20:42.295633 | controller | { 2025-12-04 00:20:42.295722 | controller | "msg": "Data could not be sent to remote host \"162.253.55.206\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.206 port 22: No route to host\r\n", 2025-12-04 00:20:42.295779 | controller | "unreachable": true 2025-12-04 00:20:42.295817 | controller | } unreachable 2025-12-04 00:20:42.300405 | 2025-12-04 00:20:42.300504 | PLAY RECAP 2025-12-04 00:20:42.300586 | controller | ok: 24 changed: 13 unreachable: 1 failed: 0 skipped: 6 rescued: 0 ignored: 0 2025-12-04 00:20:42.300643 | 2025-12-04 00:20:42.489377 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-12-04 00:20:42.490832 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-04 00:20:43.166456 | 2025-12-04 00:20:43.166627 | PLAY [all] 2025-12-04 00:20:43.193109 | 2025-12-04 00:20:43.193294 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-04 00:21:13.739599 | controller | changed: non-zero return code 2025-12-04 00:21:13.754013 | 2025-12-04 00:21:13.754191 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-04 00:21:13.772503 | controller | skipping: Conditional result was False 2025-12-04 00:21:13.789348 | 2025-12-04 00:21:13.789574 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-04 00:21:13.833540 | 2025-12-04 00:21:13.833899 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-04 00:21:13.878491 | 2025-12-04 00:21:13.878991 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-04 00:21:13.898407 | controller | skipping: Conditional result was False 2025-12-04 00:21:13.916888 | 2025-12-04 00:21:13.917164 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-04 00:21:13.955770 | 2025-12-04 00:21:13.956013 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-04 00:21:13.992201 | controller | skipping: Conditional result was False 2025-12-04 00:21:14.001747 | 2025-12-04 00:21:14.001883 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-04 00:21:14.018644 | controller | skipping: Conditional result was False 2025-12-04 00:21:14.029122 | 2025-12-04 00:21:14.029302 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-04 00:21:14.055503 | controller | skipping: Conditional result was False 2025-12-04 00:21:14.090490 | 2025-12-04 00:21:14.090704 | PLAY RECAP 2025-12-04 00:21:14.090777 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-04 00:21:14.090806 | 2025-12-04 00:21:14.239004 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-04 00:21:14.239949 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-12-04 00:21:14.887053 | 2025-12-04 00:21:14.887284 | PLAY [all:!appliance*] 2025-12-04 00:21:14.917764 | 2025-12-04 00:21:14.917869 | TASK [unregister the node] 2025-12-04 00:21:15.455098 | controller | skipping: Conditional result was False 2025-12-04 00:21:15.469386 | 2025-12-04 00:21:15.469570 | TASK [include_role : fetch-output] 2025-12-04 00:21:15.511330 | controller | ok 2025-12-04 00:21:15.559016 | 2025-12-04 00:21:15.559190 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-04 00:21:15.646183 | controller | skipping: Conditional result was False 2025-12-04 00:21:15.655542 | 2025-12-04 00:21:15.655805 | TASK [fetch-output : Set log path for single node] 2025-12-04 00:21:15.708839 | controller | ok 2025-12-04 00:21:15.716775 | 2025-12-04 00:21:15.716895 | LOOP [fetch-output : Ensure local output dirs] 2025-12-04 00:21:16.233949 | controller -> localhost | ok: "/var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/logs" 2025-12-04 00:21:16.535531 | controller -> localhost | changed: "/var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/artifacts" 2025-12-04 00:21:16.775928 | controller -> localhost | changed: "/var/lib/zuul/builds/9dddcab18a4c47898237afb1a9877071/work/docs" 2025-12-04 00:21:16.798691 | 2025-12-04 00:21:16.798870 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-04 00:21:17.473868 | controller | changed: 2025-12-04 00:21:17.474310 | controller | .d..t...... ./ 2025-12-04 00:21:17.474366 | controller | cd+++++++++ controller/ 2025-12-04 00:21:17.474422 | controller | changed: All items complete 2025-12-04 00:21:17.474471 | 2025-12-04 00:21:18.025766 | controller | changed: .d..t...... ./ 2025-12-04 00:21:18.553411 | controller | changed: .d..t...... ./ 2025-12-04 00:21:18.588986 | 2025-12-04 00:21:18.589333 | TASK [include_role : fetch-output-openshift] 2025-12-04 00:21:18.616135 | controller | skipping: Conditional result was False 2025-12-04 00:21:18.634990 | 2025-12-04 00:21:18.635259 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-12-04 00:21:18.670170 | controller | skipping: Conditional result was False 2025-12-04 00:21:18.684932 | controller | skipping: Conditional result was False 2025-12-04 00:21:18.729962 | 2025-12-04 00:21:18.730175 | PLAY [localhost] 2025-12-04 00:21:18.746973 | 2025-12-04 00:21:18.747162 | TASK [Run Zuul manifest role] 2025-12-04 00:21:18.778448 | localhost | ok 2025-12-04 00:21:18.799117 | 2025-12-04 00:21:18.799237 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-04 00:21:19.235117 | localhost | changed 2025-12-04 00:21:19.246315 | 2025-12-04 00:21:19.246481 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-04 00:21:19.284635 | localhost | ok 2025-12-04 00:21:19.303167 | 2025-12-04 00:21:19.303352 | TASK [Set zuul-log-path fact] 2025-12-04 00:21:19.326945 | localhost | ok 2025-12-04 00:21:19.349955 | 2025-12-04 00:21:19.350140 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-04 00:21:19.383337 | localhost | ok 2025-12-04 00:21:19.395935 | 2025-12-04 00:21:19.396074 | LOOP [Run upload-logs-swift role] 2025-12-04 00:21:19.423062 | localhost | Output suppressed because no_log was given 2025-12-04 00:21:19.463783 | 2025-12-04 00:21:19.464005 | TASK [Set zuul-log-path fact] 2025-12-04 00:21:19.490828 | localhost | skipping: Conditional result was False 2025-12-04 00:21:19.496000 | 2025-12-04 00:21:19.496079 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-12-04 00:21:19.993748 | localhost -> localhost | ok: Runtime: 0:00:00.013206 2025-12-04 00:21:20.051074 | 2025-12-04 00:21:20.051265 | TASK [upload-logs-swift : Upload logs to swift]