2026-06-13 08:40:41.796169 | Job console starting 2026-06-13 08:40:41.941195 | Updating git repos 2026-06-13 08:40:41.977385 | Cloning repos into workspace 2026-06-13 08:40:42.570814 | Restoring repo states 2026-06-13 08:40:42.584614 | Merging changes 2026-06-13 08:40:43.635450 | Checking out repos 2026-06-13 08:40:43.727792 | Preparing playbooks 2026-06-13 08:40:47.647083 | Running Ansible setup 2026-06-13 08:40:51.341336 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-06-13 08:40:51.978944 | 2026-06-13 08:40:51.979105 | PLAY [localhost] 2026-06-13 08:40:51.987318 | 2026-06-13 08:40:51.987386 | TASK [Gathering Facts] 2026-06-13 08:40:52.944164 | localhost | ok 2026-06-13 08:40:52.959263 | 2026-06-13 08:40:52.959474 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-13 08:40:53.464908 | localhost -> localhost | changed 2026-06-13 08:40:53.474648 | 2026-06-13 08:40:53.474845 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-13 08:40:54.462980 | localhost -> localhost | changed 2026-06-13 08:40:54.475916 | 2026-06-13 08:40:54.476082 | TASK [Setup log path fact] 2026-06-13 08:40:54.499180 | localhost | ok 2026-06-13 08:40:54.519562 | 2026-06-13 08:40:54.519706 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-13 08:40:54.551687 | localhost | ok 2026-06-13 08:40:54.565146 | 2026-06-13 08:40:54.565298 | TASK [emit-job-header : Print job information] 2026-06-13 08:40:54.618071 | # Job Information 2026-06-13 08:40:54.618391 | Ansible Version: 2.16.18 2026-06-13 08:40:54.618461 | Job: cifmw-molecule-ci_dcn_site 2026-06-13 08:40:54.618507 | Pipeline: github-check 2026-06-13 08:40:54.618593 | Executor: 38.102.83.32 2026-06-13 08:40:54.618633 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3963 2026-06-13 08:40:54.618769 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/039/rdoproject.org/0396dd20b19d4e93b4cfbb58ddc9fe79/ 2026-06-13 08:40:54.618830 | Event ID: 54bea8a0-6703-11f1-9994-e777863a64de 2026-06-13 08:40:54.624614 | 2026-06-13 08:40:54.624758 | LOOP [emit-job-header : Print node information] 2026-06-13 08:40:54.728937 | localhost | ok: 2026-06-13 08:40:54.729207 | localhost | # Node Information 2026-06-13 08:40:54.729381 | localhost | Inventory Hostname: controller 2026-06-13 08:40:54.729442 | localhost | Hostname: np0000072739 2026-06-13 08:40:54.729486 | localhost | Username: zuul 2026-06-13 08:40:54.729583 | localhost | Distro: CentOS 9 2026-06-13 08:40:54.729634 | localhost | Provider: vexxhost-nodepool-tripleo 2026-06-13 08:40:54.729676 | localhost | Region: RegionOne 2026-06-13 08:40:54.729713 | localhost | Label: cloud-centos-9-stream-tripleo 2026-06-13 08:40:54.729749 | localhost | Product Name: OpenStack Nova 2026-06-13 08:40:54.729786 | localhost | Interface IP: 38.102.83.146 2026-06-13 08:40:54.745948 | 2026-06-13 08:40:54.746098 | PLAY [all] 2026-06-13 08:40:54.757368 | 2026-06-13 08:40:54.757501 | TASK [Gather network facts] 2026-06-13 08:40:55.202106 | controller | ok 2026-06-13 08:40:55.214829 | 2026-06-13 08:40:55.214961 | TASK [include_role : start-zuul-console] 2026-06-13 08:40:55.239929 | controller | ok 2026-06-13 08:40:55.259563 | 2026-06-13 08:40:55.259699 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-13 08:40:55.677375 | controller | ok 2026-06-13 08:40:55.692398 | 2026-06-13 08:40:55.692572 | TASK [include_role : add-build-sshkey] 2026-06-13 08:40:55.727867 | controller | ok 2026-06-13 08:40:55.751051 | 2026-06-13 08:40:55.751376 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-13 08:40:56.070868 | controller -> localhost | ok 2026-06-13 08:40:56.082361 | 2026-06-13 08:40:56.082607 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-13 08:40:56.108500 | controller | ok 2026-06-13 08:40:56.138473 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-13 08:40:56.144947 | 2026-06-13 08:40:56.145033 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-13 08:40:56.773986 | controller -> localhost | Generating public/private rsa key pair. 2026-06-13 08:40:56.774288 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/work/0396dd20b19d4e93b4cfbb58ddc9fe79_id_rsa 2026-06-13 08:40:56.774353 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/work/0396dd20b19d4e93b4cfbb58ddc9fe79_id_rsa.pub 2026-06-13 08:40:56.774441 | controller -> localhost | The key fingerprint is: 2026-06-13 08:40:56.774490 | controller -> localhost | SHA256:QhU/uWfnJzvANuQVoEYOYIKsRHjHZNpPPMA7jWTcKmw zuul-build-sshkey 2026-06-13 08:40:56.774565 | controller -> localhost | The key's randomart image is: 2026-06-13 08:40:56.774609 | controller -> localhost | +---[RSA 3072]----+ 2026-06-13 08:40:56.774650 | controller -> localhost | |oo *=.o.+.. .. | 2026-06-13 08:40:56.774713 | controller -> localhost | |..++B=.. = o . | 2026-06-13 08:40:56.774755 | controller -> localhost | |.+.+.== B . | 2026-06-13 08:40:56.774795 | controller -> localhost | |. E =+.. . o. . | 2026-06-13 08:40:56.774834 | controller -> localhost | | . . .o S .+o.. | 2026-06-13 08:40:56.774873 | controller -> localhost | | . o*o | 2026-06-13 08:40:56.774910 | controller -> localhost | | . oo .| 2026-06-13 08:40:56.774953 | controller -> localhost | | .+ | 2026-06-13 08:40:56.774991 | controller -> localhost | | .. | 2026-06-13 08:40:56.775028 | controller -> localhost | +----[SHA256]-----+ 2026-06-13 08:40:56.775111 | controller -> localhost | ok: Runtime: 0:00:00.157549 2026-06-13 08:40:56.783186 | 2026-06-13 08:40:56.783323 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-13 08:40:56.819074 | controller | ok 2026-06-13 08:40:56.838128 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-13 08:40:56.850355 | 2026-06-13 08:40:56.850441 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-13 08:40:56.874959 | controller | skipping: Conditional result was False 2026-06-13 08:40:56.880873 | 2026-06-13 08:40:56.880983 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-13 08:40:57.357421 | controller | changed 2026-06-13 08:40:57.365693 | 2026-06-13 08:40:57.365842 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-13 08:40:57.637279 | controller | ok 2026-06-13 08:40:57.645105 | 2026-06-13 08:40:57.645242 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-13 08:40:58.525782 | controller | changed 2026-06-13 08:40:58.529254 | 2026-06-13 08:40:58.529318 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-13 08:40:59.318833 | controller | changed 2026-06-13 08:40:59.326311 | 2026-06-13 08:40:59.326443 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-13 08:40:59.353303 | controller | skipping: Conditional result was False 2026-06-13 08:40:59.362870 | 2026-06-13 08:40:59.363024 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-13 08:40:59.826561 | controller -> localhost | changed 2026-06-13 08:40:59.833446 | 2026-06-13 08:40:59.833530 | TASK [add-build-sshkey : Add back temp key] 2026-06-13 08:41:00.156173 | controller -> localhost | Identity added: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/work/0396dd20b19d4e93b4cfbb58ddc9fe79_id_rsa (zuul-build-sshkey) 2026-06-13 08:41:00.156472 | controller -> localhost | ok: Runtime: 0:00:00.011350 2026-06-13 08:41:00.163748 | 2026-06-13 08:41:00.163902 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-13 08:41:00.541128 | controller | ok 2026-06-13 08:41:00.547881 | 2026-06-13 08:41:00.548015 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-13 08:41:00.573815 | controller | skipping: Conditional result was False 2026-06-13 08:41:00.587834 | 2026-06-13 08:41:00.587968 | TASK [include_role : validate-host] 2026-06-13 08:41:00.622301 | controller | ok 2026-06-13 08:41:00.654762 | 2026-06-13 08:41:00.654852 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-13 08:41:00.695701 | controller | ok 2026-06-13 08:41:00.702567 | 2026-06-13 08:41:00.702757 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-13 08:41:00.993159 | controller -> localhost | ok 2026-06-13 08:41:01.002156 | 2026-06-13 08:41:01.002286 | TASK [validate-host : Collect information about the host] 2026-06-13 08:41:01.711891 | controller | ok 2026-06-13 08:41:01.720093 | 2026-06-13 08:41:01.720171 | TASK [validate-host : Sanitize hostname] 2026-06-13 08:41:01.799276 | controller | ok 2026-06-13 08:41:01.804385 | 2026-06-13 08:41:01.804466 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-13 08:41:02.346660 | controller -> localhost | changed 2026-06-13 08:41:02.358454 | 2026-06-13 08:41:02.358662 | TASK [validate-host : Collect information about zuul worker] 2026-06-13 08:41:02.827981 | controller | ok 2026-06-13 08:41:02.835869 | 2026-06-13 08:41:02.836014 | TASK [validate-host : Write out all zuul information for each host] 2026-06-13 08:41:03.339109 | controller -> localhost | changed 2026-06-13 08:41:03.355565 | 2026-06-13 08:41:03.355813 | TASK [include_role : prepare-workspace-openshift] 2026-06-13 08:41:03.395220 | controller | skipping: Conditional result was False 2026-06-13 08:41:03.404130 | 2026-06-13 08:41:03.404263 | TASK [include_role : remove-zuul-sshkey] 2026-06-13 08:41:03.432536 | controller | skipping: Conditional result was False 2026-06-13 08:41:03.442145 | 2026-06-13 08:41:03.442359 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-13 08:41:03.724736 | controller | ok: "logs" 2026-06-13 08:41:03.725412 | controller | ok: All items complete 2026-06-13 08:41:03.725483 | 2026-06-13 08:41:03.935984 | controller | ok: "artifacts" 2026-06-13 08:41:04.149694 | controller | ok: "docs" 2026-06-13 08:41:04.165864 | 2026-06-13 08:41:04.166167 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-13 08:41:04.449727 | controller | changed: "logs" 2026-06-13 08:41:04.660075 | controller | changed: "artifacts" 2026-06-13 08:41:04.901061 | controller | changed: "docs" 2026-06-13 08:41:04.913454 | 2026-06-13 08:41:04.913650 | PLAY RECAP 2026-06-13 08:41:04.913741 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-06-13 08:41:04.913798 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-13 08:41:04.913836 | 2026-06-13 08:41:05.042474 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-06-13 08:41:05.045358 | PRE-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master] 2026-06-13 08:41:05.652225 | 2026-06-13 08:41:05.652335 | PLAY [localhost] 2026-06-13 08:41:05.660300 | 2026-06-13 08:41:05.660369 | TASK [configure-ssh-config-fips : Ensure ssh config directory] 2026-06-13 08:41:06.104799 | localhost | changed 2026-06-13 08:41:06.112843 | 2026-06-13 08:41:06.112992 | TASK [configure-ssh-config-fips : Setup ssh config] 2026-06-13 08:41:06.899322 | localhost | changed 2026-06-13 08:41:06.905547 | 2026-06-13 08:41:06.905612 | PLAY [all] 2026-06-13 08:41:06.910489 | 2026-06-13 08:41:06.910565 | TASK [include_role : prepare-workspace] 2026-06-13 08:41:06.937568 | controller | ok 2026-06-13 08:41:06.950139 | 2026-06-13 08:41:06.950222 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-13 08:41:07.325796 | controller | ok 2026-06-13 08:41:07.336271 | 2026-06-13 08:41:07.336399 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-13 08:41:08.545747 | controller | Output suppressed because no_log was given 2026-06-13 08:41:08.553285 | 2026-06-13 08:41:08.553377 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-13 08:41:08.802729 | controller | changed: "logs" 2026-06-13 08:41:09.002571 | controller | changed: "artifacts" 2026-06-13 08:41:09.219433 | controller | changed: "docs" 2026-06-13 08:41:09.232674 | 2026-06-13 08:41:09.232878 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-13 08:41:09.519270 | controller | changed: "logs" 2026-06-13 08:41:09.519635 | controller | changed: All items complete 2026-06-13 08:41:09.519684 | 2026-06-13 08:41:09.743212 | controller | changed: "artifacts" 2026-06-13 08:41:09.984677 | controller | changed: "docs" 2026-06-13 08:41:09.998637 | 2026-06-13 08:41:09.998783 | TASK [Check if worker can sudo] 2026-06-13 08:41:10.530809 | controller | ok: Runtime: 0:00:00.053989 2026-06-13 08:41:10.539052 | 2026-06-13 08:41:10.539214 | TASK [configure-mirrors : Gather needed facts] 2026-06-13 08:41:10.615735 | controller | skipping: Conditional result was False 2026-06-13 08:41:10.627055 | 2026-06-13 08:41:10.627190 | TASK [configure-mirrors : Set up infrastructure mirrors] 2026-06-13 08:41:10.715060 | controller | ok 2026-06-13 08:41:10.730623 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror.yaml 2026-06-13 08:41:10.742855 | 2026-06-13 08:41:10.742985 | TASK [configure-mirrors : Remove .pydistutils.cfg configuration in homedir] 2026-06-13 08:41:11.050356 | controller | ok 2026-06-13 08:41:11.059703 | 2026-06-13 08:41:11.059858 | LOOP [configure-mirrors : Include OS-specific variables] 2026-06-13 08:41:11.141921 | controller | ok: "/var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/vars/CentOS-9.yaml" 2026-06-13 08:41:11.154559 | 2026-06-13 08:41:11.154703 | TASK [configure-mirrors : Install /etc/pip.conf configuration] 2026-06-13 08:41:12.077429 | controller | changed 2026-06-13 08:41:12.081873 | 2026-06-13 08:41:12.081939 | LOOP [configure-mirrors : Setup distribution specific packaging mirrors] 2026-06-13 08:41:12.198942 | controller | ok: "/var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml" 2026-06-13 08:41:12.199126 | controller | ok: All items complete 2026-06-13 08:41:12.199150 | 2026-06-13 08:41:12.347589 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml 2026-06-13 08:41:12.356777 | 2026-06-13 08:41:12.356863 | LOOP [configure-mirrors : Install CentOS 9 repository files] 2026-06-13 08:41:13.284758 | controller | changed: "etc/yum.repos.d/centos.repo" 2026-06-13 08:41:14.126449 | controller | changed: "etc/yum.repos.d/centos-addons.repo" 2026-06-13 08:41:14.137808 | 2026-06-13 08:41:14.137949 | TASK [configure-mirrors : Disable deltrarpm] 2026-06-13 08:41:14.604806 | controller | changed: section and option added 2026-06-13 08:41:14.617693 | 2026-06-13 08:41:14.617771 | LOOP [configure-mirrors : Update yum/dnf cache] 2026-06-13 08:41:15.338933 | controller | 29 files removed 2026-06-13 08:41:15.339461 | controller | ok: Item: dnf clean all Runtime: 0:00:00.407018 2026-06-13 08:41:15.339631 | controller | changed: All items complete 2026-06-13 08:41:15.339686 | 2026-06-13 08:41:27.378769 | controller | Loaded plugins: builddep, changelog, config-manager, copr, debug, debuginfo-install, download, generate_completion_cache, groups-manager, needs-restarting, playground, repoclosure, repodiff, repograph, repomanage, reposync, system-upgrade 2026-06-13 08:41:27.378890 | controller | DNF version: 4.14.0 2026-06-13 08:41:27.378916 | controller | cachedir: /var/cache/dnf 2026-06-13 08:41:27.378935 | controller | Making cache files for all metadata files. 2026-06-13 08:41:27.378954 | controller | baseos: has expired and will be refreshed. 2026-06-13 08:41:27.378980 | controller | appstream: has expired and will be refreshed. 2026-06-13 08:41:27.378997 | controller | crb: has expired and will be refreshed. 2026-06-13 08:41:27.379014 | controller | extras-common: has expired and will be refreshed. 2026-06-13 08:41:27.379030 | controller | repo: downloading from remote: baseos 2026-06-13 08:41:27.379047 | controller | CentOS Stream 9 - BaseOS 78 MB/s | 8.9 MB 00:00 2026-06-13 08:41:27.379063 | controller | baseos: using metadata from Thu 11 Jun 2026 01:27:06 PM EDT. 2026-06-13 08:41:27.379080 | controller | repo: downloading from remote: appstream 2026-06-13 08:41:27.379096 | controller | CentOS Stream 9 - AppStream 92 MB/s | 28 MB 00:00 2026-06-13 08:41:27.379112 | controller | appstream: using metadata from Thu 11 Jun 2026 01:30:52 PM EDT. 2026-06-13 08:41:27.379128 | controller | repo: downloading from remote: crb 2026-06-13 08:41:27.379143 | controller | CentOS Stream 9 - CRB 61 MB/s | 8.3 MB 00:00 2026-06-13 08:41:27.379160 | controller | crb: using metadata from Thu 11 Jun 2026 01:35:27 PM EDT. 2026-06-13 08:41:27.379176 | controller | repo: downloading from remote: extras-common 2026-06-13 08:41:27.379193 | controller | CentOS Stream 9 - Extras packages 77 kB/s | 21 kB 00:00 2026-06-13 08:41:27.379209 | controller | extras-common: using metadata from Wed 10 Jun 2026 10:05:57 AM EDT. 2026-06-13 08:41:27.379225 | controller | User-Agent: constructed: 'libdnf (CentOS Stream 9; generic; Linux.x86_64)' 2026-06-13 08:41:27.379242 | controller | Completion plugin: Generating completion cache... 2026-06-13 08:41:27.379258 | controller | Metadata cache created. 2026-06-13 08:41:27.379282 | controller | ok: Item: dnf makecache -v Runtime: 0:00:11.799534 2026-06-13 08:41:27.382861 | 2026-06-13 08:41:27.382903 | PLAY RECAP 2026-06-13 08:41:27.382942 | controller | ok: 13 changed: 7 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-13 08:41:27.382966 | localhost | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-13 08:41:27.382983 | 2026-06-13 08:41:27.503317 | PRE-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master] 2026-06-13 08:41:27.504460 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-06-13 08:41:28.134246 | 2026-06-13 08:41:28.134344 | PLAY [all] 2026-06-13 08:41:28.144379 | 2026-06-13 08:41:28.144446 | TASK [Install binary dependencies] 2026-06-13 08:41:28.216076 | controller | ok 2026-06-13 08:41:28.248679 | 2026-06-13 08:41:28.248794 | TASK [bindep : Include find tasks] 2026-06-13 08:41:28.287608 | controller | ok 2026-06-13 08:41:28.296467 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-06-13 08:41:28.304865 | 2026-06-13 08:41:28.305062 | TASK [bindep : Look for bindep.txt] 2026-06-13 08:41:28.712695 | controller | ok 2026-06-13 08:41:28.718565 | 2026-06-13 08:41:28.718652 | TASK [bindep : Define bindep_file fact] 2026-06-13 08:41:28.758271 | controller | ok 2026-06-13 08:41:28.763745 | 2026-06-13 08:41:28.763826 | TASK [bindep : Look for other-requirements.txt] 2026-06-13 08:41:28.788128 | controller | skipping: Conditional result was False 2026-06-13 08:41:28.793715 | 2026-06-13 08:41:28.793822 | TASK [bindep : Define bindep_file fact] 2026-06-13 08:41:28.820296 | controller | skipping: Conditional result was False 2026-06-13 08:41:28.826775 | 2026-06-13 08:41:28.826902 | TASK [bindep : Look for bindep fallback file] 2026-06-13 08:41:28.852157 | controller | skipping: Conditional result was False 2026-06-13 08:41:28.858009 | 2026-06-13 08:41:28.858122 | TASK [bindep : Define bindep_file fact] 2026-06-13 08:41:28.892356 | controller | skipping: Conditional result was False 2026-06-13 08:41:28.897500 | 2026-06-13 08:41:28.897592 | TASK [bindep : Include bindep tasks] 2026-06-13 08:41:28.938423 | controller | ok 2026-06-13 08:41:28.949719 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find-bindep.yaml 2026-06-13 08:41:28.965959 | 2026-06-13 08:41:28.966085 | TASK [bindep : Look for bindep command] 2026-06-13 08:41:29.001909 | controller | skipping: Conditional result was False 2026-06-13 08:41:29.008621 | 2026-06-13 08:41:29.008704 | TASK [bindep : Check for system bindep] 2026-06-13 08:41:29.544493 | controller | ok: Runtime: 0:00:00.005031 2026-06-13 08:41:29.548558 | 2026-06-13 08:41:29.548636 | TASK [bindep : Define bindep_command fact] 2026-06-13 08:41:29.582832 | controller | skipping: Conditional result was False 2026-06-13 08:41:29.587604 | 2026-06-13 08:41:29.587677 | TASK [bindep : Include install tasks] 2026-06-13 08:41:29.626206 | controller | ok 2026-06-13 08:41:29.631713 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/install.yaml 2026-06-13 08:41:29.645587 | 2026-06-13 08:41:29.645735 | TASK [bindep : Create temp dir for bindep] 2026-06-13 08:41:30.002895 | controller | changed 2026-06-13 08:41:30.010556 | 2026-06-13 08:41:30.010706 | TASK [Ensure we have pip dependencies] 2026-06-13 08:41:30.034351 | controller | ok 2026-06-13 08:41:30.073188 | 2026-06-13 08:41:30.073316 | TASK [ensure-pip : Check if pip is installed] 2026-06-13 04:41:30.390354 | controller | /usr/bin/pip3 2026-06-13 04:41:30.431542 | controller | /usr/bin/python3: No module named wheel 2026-06-13 08:41:30.607033 | controller | ok: Runtime: 0:00:00.054967 2026-06-13 08:41:30.616302 | 2026-06-13 08:41:30.616443 | LOOP [ensure-pip : Install pip from packages] 2026-06-13 08:41:30.658998 | controller | ok: "/var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-06-13 08:41:30.680849 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-06-13 08:41:30.730808 | 2026-06-13 08:41:30.730936 | TASK [ensure-pip : Install Python 3 pip] 2026-06-13 08:41:32.005559 | controller | ok: Nothing to do 2026-06-13 08:41:32.014303 | 2026-06-13 08:41:32.014480 | TASK [ensure-pip : Install Python3-wheel on older CentOS] 2026-06-13 08:41:33.674266 | controller | changed 2026-06-13 08:41:33.679710 | 2026-06-13 08:41:33.679794 | TASK [ensure-pip : Check for EPEL repository] 2026-06-13 08:41:33.714076 | controller | skipping: Conditional result was False 2026-06-13 08:41:33.721565 | 2026-06-13 08:41:33.721662 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-06-13 08:41:33.786853 | controller | skipping: Conditional result was False 2026-06-13 08:41:33.803161 | 2026-06-13 08:41:33.803331 | TASK [ensure-pip : Install Python 2 pip] 2026-06-13 08:41:33.860915 | controller | skipping: Conditional result was False 2026-06-13 08:41:33.870404 | 2026-06-13 08:41:33.870570 | TASK [ensure-pip : Ensure setuptools] 2026-06-13 08:41:33.896489 | controller | skipping: Conditional result was False 2026-06-13 08:41:33.905929 | 2026-06-13 08:41:33.906133 | TASK [ensure-pip : Check for ensurepip module] 2026-06-13 08:41:34.445450 | controller | skipping: Conditional result was False 2026-06-13 08:41:34.458170 | 2026-06-13 08:41:34.458347 | TASK [ensure-pip : Ensure python3-venv] 2026-06-13 08:41:34.486031 | controller | skipping: Conditional result was False 2026-06-13 08:41:34.497655 | 2026-06-13 08:41:34.497802 | TASK [ensure-pip : Install pip from source] 2026-06-13 08:41:34.524332 | controller | skipping: Conditional result was False 2026-06-13 08:41:34.534234 | 2026-06-13 08:41:34.534369 | TASK [ensure-pip : Probe for venv python full path] 2026-06-13 04:41:34.792622 | controller | /usr/bin/python3 2026-06-13 08:41:35.078378 | controller | ok: Runtime: 0:00:00.005925 2026-06-13 08:41:35.086611 | 2026-06-13 08:41:35.086742 | TASK [ensure-pip : Set host default] 2026-06-13 08:41:35.160934 | controller | ok 2026-06-13 08:41:35.169167 | 2026-06-13 08:41:35.169296 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-06-13 08:41:35.239615 | controller | ok 2026-06-13 08:41:35.263148 | 2026-06-13 08:41:35.263389 | TASK [bindep : Install bindep into temporary venv] 2026-06-13 08:41:39.588089 | controller | changed 2026-06-13 08:41:39.596673 | 2026-06-13 08:41:39.596802 | TASK [bindep : Define bindep_command] 2026-06-13 08:41:39.632029 | controller | ok 2026-06-13 08:41:39.639809 | 2026-06-13 08:41:39.639930 | LOOP [bindep : Include package tasks] 2026-06-13 08:41:39.692869 | controller | ok: "src/github.com/openstack-k8s-operators/ci-framework/bindep.txt" 2026-06-13 08:41:39.693076 | controller | ok: All items complete 2026-06-13 08:41:39.693108 | 2026-06-13 08:41:39.708346 | controller | included: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/packages.yaml 2026-06-13 08:41:39.729242 | 2026-06-13 08:41:39.729386 | TASK [bindep : Define bindep_run fact] 2026-06-13 08:41:39.773158 | controller | ok 2026-06-13 08:41:39.780490 | 2026-06-13 08:41:39.780645 | TASK [bindep : Get list of packages to install from bindep] 2026-06-13 04:41:40.973518 | controller | podman 2026-06-13 04:41:40.973600 | controller | python3-jmespath 2026-06-13 04:41:40.973608 | controller | python3-libvirt 2026-06-13 04:41:40.973614 | controller | python3-lxml 2026-06-13 04:41:40.973620 | controller | python3-netaddr 2026-06-13 08:41:41.323479 | controller | ok: Runtime: 0:00:00.932940 2026-06-13 08:41:41.331857 | 2026-06-13 08:41:41.331987 | TASK [bindep : Install distro packages from bindep] 2026-06-13 08:42:23.127114 | controller | changed 2026-06-13 08:42:23.136444 | 2026-06-13 08:42:23.136615 | TASK [bindep : Check that packages are installed] 2026-06-13 08:42:24.681273 | controller | ok: Runtime: 0:00:01.078074 2026-06-13 08:42:24.689406 | 2026-06-13 08:42:24.689592 | TASK [bindep : Fail if we cannot install all packages] 2026-06-13 08:42:24.725105 | controller | skipping: Conditional result was False 2026-06-13 08:42:24.741842 | 2026-06-13 08:42:24.742009 | TASK [Run test-setup role] 2026-06-13 08:42:24.767682 | controller | ok 2026-06-13 08:42:24.794234 | 2026-06-13 08:42:24.794360 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-06-13 08:42:25.009423 | controller | ok 2026-06-13 08:42:25.017917 | 2026-06-13 08:42:25.018049 | TASK [test-setup : Run tools/test-setup.sh] 2026-06-13 08:42:25.559030 | controller | skipping: Conditional result was False 2026-06-13 08:42:25.580451 | 2026-06-13 08:42:25.580627 | TASK [bindep : Remove bindep temp dir] 2026-06-13 08:42:25.968417 | controller | ok 2026-06-13 08:42:25.970950 | 2026-06-13 08:42:25.971042 | PLAY RECAP 2026-06-13 08:42:25.971122 | controller | ok: 23 changed: 6 unreachable: 0 failed: 0 skipped: 15 rescued: 0 ignored: 0 2026-06-13 08:42:25.971164 | 2026-06-13 08:42:26.102895 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-06-13 08:42:26.106616 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/run-test-command/run.yaml@master] 2026-06-13 08:42:26.772158 | 2026-06-13 08:42:26.772320 | PLAY [all] 2026-06-13 08:42:26.782333 | 2026-06-13 08:42:26.782416 | TASK [Abort when test_command variable is undefined] 2026-06-13 08:42:26.818455 | controller | skipping: Conditional result was False 2026-06-13 08:42:26.823420 | 2026-06-13 08:42:26.823528 | TASK [Convert test_command to list] 2026-06-13 08:42:26.888610 | controller | skipping: Conditional result was False 2026-06-13 08:42:26.893554 | 2026-06-13 08:42:26.893623 | TASK [Use test_command list] 2026-06-13 08:42:26.966798 | controller | ok 2026-06-13 08:42:26.979000 | 2026-06-13 08:42:26.979150 | LOOP [Run test_command] 2026-06-13 08:42:27.414479 | controller | no check to run 2026-06-13 08:42:27.414884 | controller | ok: Item: echo 'no check to run' Runtime: 0:00:00.005614 2026-06-13 08:42:27.418811 | 2026-06-13 08:42:27.418981 | PLAY RECAP 2026-06-13 08:42:27.419067 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-13 08:42:27.419110 | 2026-06-13 08:42:27.541344 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/run-test-command/run.yaml@master] 2026-06-13 08:42:27.544229 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-13 08:42:28.167132 | 2026-06-13 08:42:28.167235 | PLAY [all] 2026-06-13 08:42:28.177247 | 2026-06-13 08:42:28.177316 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-13 08:42:28.623639 | controller | changed: non-zero return code 2026-06-13 08:42:28.631945 | 2026-06-13 08:42:28.632093 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-13 08:42:28.658499 | controller | skipping: Conditional result was False 2026-06-13 08:42:28.669599 | 2026-06-13 08:42:28.669754 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-13 08:42:28.705673 | 2026-06-13 08:42:28.706038 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-13 08:42:28.740696 | 2026-06-13 08:42:28.740925 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-13 08:42:28.767089 | controller | skipping: Conditional result was False 2026-06-13 08:42:28.776079 | 2026-06-13 08:42:28.776213 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-13 08:42:28.811052 | 2026-06-13 08:42:28.811325 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-13 08:42:28.836938 | controller | skipping: Conditional result was False 2026-06-13 08:42:28.845706 | 2026-06-13 08:42:28.845845 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-13 08:42:28.871731 | controller | skipping: Conditional result was False 2026-06-13 08:42:28.883062 | 2026-06-13 08:42:28.883249 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-13 08:42:28.908868 | controller | skipping: Conditional result was False 2026-06-13 08:42:28.922350 | 2026-06-13 08:42:28.922451 | PLAY RECAP 2026-06-13 08:42:28.922575 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-13 08:42:28.922631 | 2026-06-13 08:42:29.036603 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-13 08:42:29.039214 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-06-13 08:42:29.664814 | 2026-06-13 08:42:29.664944 | PLAY [all] 2026-06-13 08:42:29.674740 | 2026-06-13 08:42:29.674838 | TASK [include_role : fetch-output] 2026-06-13 08:42:29.716979 | controller | ok 2026-06-13 08:42:29.739086 | 2026-06-13 08:42:29.739259 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-13 08:42:29.807354 | controller | skipping: Conditional result was False 2026-06-13 08:42:29.816646 | 2026-06-13 08:42:29.816865 | TASK [fetch-output : Set log path for single node] 2026-06-13 08:42:29.871250 | controller | ok 2026-06-13 08:42:29.879369 | 2026-06-13 08:42:29.879619 | LOOP [fetch-output : Ensure local output dirs] 2026-06-13 08:42:30.367096 | controller -> localhost | changed: "/var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/work/logs" 2026-06-13 08:42:30.623292 | controller -> localhost | changed: "/var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/work/artifacts" 2026-06-13 08:42:30.884344 | controller -> localhost | changed: "/var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/work/docs" 2026-06-13 08:42:30.903427 | 2026-06-13 08:42:30.903609 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-13 08:42:31.638576 | controller | changed: .d..t...... ./ 2026-06-13 08:42:31.638955 | controller | changed: All items complete 2026-06-13 08:42:31.639001 | 2026-06-13 08:42:32.196582 | controller | changed: .d..t...... ./ 2026-06-13 08:42:32.727909 | controller | changed: .d..t...... ./ 2026-06-13 08:42:32.753510 | 2026-06-13 08:42:32.753687 | TASK [include_role : fetch-output-openshift] 2026-06-13 08:42:32.780221 | controller | skipping: Conditional result was False 2026-06-13 08:42:32.790692 | 2026-06-13 08:42:32.790837 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-13 08:42:33.303054 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.015069 2026-06-13 08:42:33.619483 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.014335 2026-06-13 08:42:33.638683 | 2026-06-13 08:42:33.638858 | PLAY [all] 2026-06-13 08:42:33.651646 | 2026-06-13 08:42:33.651910 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-13 08:42:34.125271 | controller | changed 2026-06-13 08:42:34.132992 | 2026-06-13 08:42:34.133089 | PLAY RECAP 2026-06-13 08:42:34.133158 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-13 08:42:34.133194 | 2026-06-13 08:42:34.251399 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-06-13 08:42:34.252664 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-06-13 08:42:34.969111 | 2026-06-13 08:42:34.969228 | PLAY [localhost] 2026-06-13 08:42:34.979244 | 2026-06-13 08:42:34.979320 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-13 08:42:35.461183 | localhost | changed 2026-06-13 08:42:35.470413 | 2026-06-13 08:42:35.470580 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-13 08:42:35.510752 | localhost | ok 2026-06-13 08:42:35.523486 | 2026-06-13 08:42:35.523672 | TASK [add-fileserver : Create SSH private key tempfile] 2026-06-13 08:42:35.989533 | localhost | changed 2026-06-13 08:42:35.994538 | 2026-06-13 08:42:35.994629 | TASK [add-fileserver : Create SSH private key from secret] 2026-06-13 08:42:36.894066 | localhost | changed 2026-06-13 08:42:36.899843 | 2026-06-13 08:42:36.899924 | TASK [add-fileserver : Add fileserver ssh key] 2026-06-13 08:42:37.395483 | localhost | Identity added: /var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/work/tmp/ansible.hltiug7c (/var/lib/zuul/builds/0396dd20b19d4e93b4cfbb58ddc9fe79/work/tmp/ansible.hltiug7c) 2026-06-13 08:42:37.395736 | localhost | ok: Runtime: 0:00:00.020417 2026-06-13 08:42:37.400507 | 2026-06-13 08:42:37.400618 | TASK [add-fileserver : Remove SSH private key from disk] 2026-06-13 08:42:37.783842 | localhost | ok: Runtime: 0:00:00.009695 2026-06-13 08:42:37.788205 | 2026-06-13 08:42:37.788290 | TASK [add-fileserver : Add fileserver to inventory] 2026-06-13 08:42:37.878208 | localhost | changed 2026-06-13 08:42:37.887537 | 2026-06-13 08:42:37.887637 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-06-13 08:42:38.381121 | localhost | changed 2026-06-13 08:42:38.393922 | 2026-06-13 08:42:38.394040 | PLAY [localhost] 2026-06-13 08:42:38.400544 | 2026-06-13 08:42:38.400633 | TASK [Generate bulk log download script] 2026-06-13 08:42:38.426887 | localhost | ok 2026-06-13 08:42:38.449973 | 2026-06-13 08:42:38.450204 | TASK [local-log-download : Check API endpoint is defined] 2026-06-13 08:42:38.504562 | localhost | ok: All assertions passed 2026-06-13 08:42:38.512364 | 2026-06-13 08:42:38.512506 | TASK [local-log-download : Create download script] 2026-06-13 08:42:39.130258 | localhost -> localhost | changed 2026-06-13 08:42:39.186025 | 2026-06-13 08:42:39.186188 | TASK [Register quick-download link] 2026-06-13 08:42:39.216705 | localhost | ok 2026-06-13 08:42:39.219677 | 2026-06-13 08:42:39.219752 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com] 2026-06-13 08:42:39.226366 | 2026-06-13 08:42:39.226448 | TASK [Set zuul-log-path fact] 2026-06-13 08:42:39.253558 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-13 08:42:39.268153 | 2026-06-13 08:42:39.268328 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-13 08:42:39.307340 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-13 08:42:39.311373 | 2026-06-13 08:42:39.311482 | TASK [upload-logs : Create log directories] 2026-06-13 08:42:40.221621 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed 2026-06-13 08:42:40.224990 | 2026-06-13 08:42:40.225116 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-13 08:42:40.548344 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.009252 2026-06-13 08:42:40.554071 | 2026-06-13 08:42:40.554196 | TASK [upload-logs : Upload logs to log server] 2026-06-13 08:42:41.805282 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | Output suppressed because no_log was given 2026-06-13 08:42:41.808241 | 2026-06-13 08:42:41.808378 | LOOP [upload-logs : Compress console log and json output]