2026-06-11 12:00:17.185243 | Job console starting 2026-06-11 12:00:17.312606 | Updating git repos 2026-06-11 12:00:17.349695 | Cloning repos into workspace 2026-06-11 12:00:17.956377 | Restoring repo states 2026-06-11 12:00:17.968471 | Merging changes 2026-06-11 12:00:19.037617 | Checking out repos 2026-06-11 12:00:19.208896 | Preparing playbooks 2026-06-11 12:00:23.076947 | Running Ansible setup 2026-06-11 12:00:26.791129 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-06-11 12:00:27.385073 | 2026-06-11 12:00:27.385181 | PLAY [localhost] 2026-06-11 12:00:27.392485 | 2026-06-11 12:00:27.392592 | TASK [Gathering Facts] 2026-06-11 12:00:28.329929 | localhost | ok 2026-06-11 12:00:28.342699 | 2026-06-11 12:00:28.342916 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-11 12:00:28.794918 | localhost -> localhost | changed 2026-06-11 12:00:28.799504 | 2026-06-11 12:00:28.799588 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-11 12:00:29.769748 | localhost -> localhost | changed 2026-06-11 12:00:29.782592 | 2026-06-11 12:00:29.782723 | TASK [Setup log path fact] 2026-06-11 12:00:29.805359 | localhost | ok 2026-06-11 12:00:29.825785 | 2026-06-11 12:00:29.825931 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-11 12:00:29.865412 | localhost | ok 2026-06-11 12:00:29.873232 | 2026-06-11 12:00:29.873335 | TASK [emit-job-header : Print job information] 2026-06-11 12:00:29.915948 | # Job Information 2026-06-11 12:00:29.916145 | Ansible Version: 2.16.18 2026-06-11 12:00:29.916181 | Job: cifmw-molecule-ci_dcn_site 2026-06-11 12:00:29.916207 | Pipeline: github-check 2026-06-11 12:00:29.916231 | Executor: 38.102.83.32 2026-06-11 12:00:29.916254 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3963 2026-06-11 12:00:29.916279 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/ec0/rdoproject.org/ec0efbc54db14253bf91b64c23a04f66/ 2026-06-11 12:00:29.916306 | Event ID: db7598e0-658c-11f1-8616-016a757526ed 2026-06-11 12:00:29.919961 | 2026-06-11 12:00:29.920064 | LOOP [emit-job-header : Print node information] 2026-06-11 12:00:30.011671 | localhost | ok: 2026-06-11 12:00:30.011953 | localhost | # Node Information 2026-06-11 12:00:30.012011 | localhost | Inventory Hostname: controller 2026-06-11 12:00:30.012059 | localhost | Hostname: np0000070710 2026-06-11 12:00:30.012101 | localhost | Username: zuul 2026-06-11 12:00:30.012145 | localhost | Distro: CentOS 9 2026-06-11 12:00:30.012184 | localhost | Provider: vexxhost-nodepool-tripleo 2026-06-11 12:00:30.012221 | localhost | Region: RegionOne 2026-06-11 12:00:30.012256 | localhost | Label: cloud-centos-9-stream-tripleo 2026-06-11 12:00:30.012291 | localhost | Product Name: OpenStack Nova 2026-06-11 12:00:30.012327 | localhost | Interface IP: 38.102.83.64 2026-06-11 12:00:30.024240 | 2026-06-11 12:00:30.024382 | PLAY [all] 2026-06-11 12:00:30.034036 | 2026-06-11 12:00:30.034135 | TASK [Gather network facts] 2026-06-11 12:00:30.548581 | controller | ok 2026-06-11 12:00:30.564939 | 2026-06-11 12:00:30.565152 | TASK [include_role : start-zuul-console] 2026-06-11 12:00:30.591422 | controller | ok 2026-06-11 12:00:30.616245 | 2026-06-11 12:00:30.616398 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-11 12:00:31.045361 | controller | ok 2026-06-11 12:00:31.060332 | 2026-06-11 12:00:31.060485 | TASK [include_role : add-build-sshkey] 2026-06-11 12:00:31.098290 | controller | ok 2026-06-11 12:00:31.127797 | 2026-06-11 12:00:31.127960 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-11 12:00:31.427231 | controller -> localhost | ok 2026-06-11 12:00:31.433300 | 2026-06-11 12:00:31.433385 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-11 12:00:31.462282 | controller | ok 2026-06-11 12:00:31.480082 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-11 12:00:31.486151 | 2026-06-11 12:00:31.486229 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-11 12:00:32.096704 | controller -> localhost | Generating public/private rsa key pair. 2026-06-11 12:00:32.096982 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/work/ec0efbc54db14253bf91b64c23a04f66_id_rsa 2026-06-11 12:00:32.097047 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/work/ec0efbc54db14253bf91b64c23a04f66_id_rsa.pub 2026-06-11 12:00:32.097095 | controller -> localhost | The key fingerprint is: 2026-06-11 12:00:32.097139 | controller -> localhost | SHA256:gj3ZmNyEdp7/6E4SW0z7hn/DVoenbukcpCc6A6veyXE zuul-build-sshkey 2026-06-11 12:00:32.097253 | controller -> localhost | The key's randomart image is: 2026-06-11 12:00:32.097302 | controller -> localhost | +---[RSA 3072]----+ 2026-06-11 12:00:32.097343 | controller -> localhost | | | 2026-06-11 12:00:32.097385 | controller -> localhost | | . | 2026-06-11 12:00:32.097426 | controller -> localhost | | o o . | 2026-06-11 12:00:32.097467 | controller -> localhost | | = X + . | 2026-06-11 12:00:32.097506 | controller -> localhost | | . O S + .. | 2026-06-11 12:00:32.097586 | controller -> localhost | | o.= o o. +| 2026-06-11 12:00:32.097628 | controller -> localhost | | +oE =.o=.| 2026-06-11 12:00:32.097668 | controller -> localhost | | o.*o* +O. | 2026-06-11 12:00:32.097730 | controller -> localhost | | .o.+o=oo*+. | 2026-06-11 12:00:32.097771 | controller -> localhost | +----[SHA256]-----+ 2026-06-11 12:00:32.097855 | controller -> localhost | ok: Runtime: 0:00:00.104653 2026-06-11 12:00:32.106362 | 2026-06-11 12:00:32.106484 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-11 12:00:32.159884 | controller | ok 2026-06-11 12:00:32.177603 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-11 12:00:32.192644 | 2026-06-11 12:00:32.192771 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-11 12:00:32.218229 | controller | skipping: Conditional result was False 2026-06-11 12:00:32.223199 | 2026-06-11 12:00:32.223281 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-11 12:00:32.732007 | controller | changed 2026-06-11 12:00:32.741001 | 2026-06-11 12:00:32.741160 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-11 12:00:33.007842 | controller | ok 2026-06-11 12:00:33.014228 | 2026-06-11 12:00:33.014338 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-11 12:00:33.775014 | controller | changed 2026-06-11 12:00:33.784473 | 2026-06-11 12:00:33.784627 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-11 12:00:34.564392 | controller | changed 2026-06-11 12:00:34.572231 | 2026-06-11 12:00:34.572421 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-11 12:00:34.598667 | controller | skipping: Conditional result was False 2026-06-11 12:00:34.607702 | 2026-06-11 12:00:34.607839 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-11 12:00:35.079443 | controller -> localhost | changed 2026-06-11 12:00:35.093348 | 2026-06-11 12:00:35.093474 | TASK [add-build-sshkey : Add back temp key] 2026-06-11 12:00:35.462801 | controller -> localhost | Identity added: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/work/ec0efbc54db14253bf91b64c23a04f66_id_rsa (zuul-build-sshkey) 2026-06-11 12:00:35.463211 | controller -> localhost | ok: Runtime: 0:00:00.012542 2026-06-11 12:00:35.473469 | 2026-06-11 12:00:35.473646 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-11 12:00:35.903858 | controller | ok 2026-06-11 12:00:35.916734 | 2026-06-11 12:00:35.916881 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-11 12:00:35.954340 | controller | skipping: Conditional result was False 2026-06-11 12:00:35.969048 | 2026-06-11 12:00:35.969184 | TASK [include_role : validate-host] 2026-06-11 12:00:36.005907 | controller | ok 2026-06-11 12:00:36.036331 | 2026-06-11 12:00:36.036429 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-11 12:00:36.076602 | controller | ok 2026-06-11 12:00:36.080877 | 2026-06-11 12:00:36.080958 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-11 12:00:36.391014 | controller -> localhost | ok 2026-06-11 12:00:36.399926 | 2026-06-11 12:00:36.400083 | TASK [validate-host : Collect information about the host] 2026-06-11 12:00:37.120892 | controller | ok 2026-06-11 12:00:37.137575 | 2026-06-11 12:00:37.137710 | TASK [validate-host : Sanitize hostname] 2026-06-11 12:00:37.219464 | controller | ok 2026-06-11 12:00:37.226589 | 2026-06-11 12:00:37.226719 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-11 12:00:37.717417 | controller -> localhost | changed 2026-06-11 12:00:37.727637 | 2026-06-11 12:00:37.727784 | TASK [validate-host : Collect information about zuul worker] 2026-06-11 12:00:38.205029 | controller | ok 2026-06-11 12:00:38.213396 | 2026-06-11 12:00:38.213573 | TASK [validate-host : Write out all zuul information for each host] 2026-06-11 12:00:38.777134 | controller -> localhost | changed 2026-06-11 12:00:38.783966 | 2026-06-11 12:00:38.784031 | TASK [include_role : prepare-workspace-openshift] 2026-06-11 12:00:38.807637 | controller | skipping: Conditional result was False 2026-06-11 12:00:38.811783 | 2026-06-11 12:00:38.811847 | TASK [include_role : remove-zuul-sshkey] 2026-06-11 12:00:38.836029 | controller | skipping: Conditional result was False 2026-06-11 12:00:38.840377 | 2026-06-11 12:00:38.840439 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-11 12:00:39.113677 | controller | ok: "logs" 2026-06-11 12:00:39.114106 | controller | ok: All items complete 2026-06-11 12:00:39.114163 | 2026-06-11 12:00:39.301607 | controller | ok: "artifacts" 2026-06-11 12:00:39.512935 | controller | ok: "docs" 2026-06-11 12:00:39.522342 | 2026-06-11 12:00:39.525830 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-11 12:00:39.825945 | controller | changed: "logs" 2026-06-11 12:00:40.031702 | controller | changed: "artifacts" 2026-06-11 12:00:40.282850 | controller | changed: "docs" 2026-06-11 12:00:40.307920 | 2026-06-11 12:00:40.308056 | PLAY RECAP 2026-06-11 12:00:40.308112 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-06-11 12:00:40.308146 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-11 12:00:40.308168 | 2026-06-11 12:00:40.434189 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-06-11 12:00:40.435400 | PRE-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master] 2026-06-11 12:00:41.048845 | 2026-06-11 12:00:41.049018 | PLAY [localhost] 2026-06-11 12:00:41.056908 | 2026-06-11 12:00:41.056978 | TASK [configure-ssh-config-fips : Ensure ssh config directory] 2026-06-11 12:00:41.512388 | localhost | changed 2026-06-11 12:00:41.522119 | 2026-06-11 12:00:41.522273 | TASK [configure-ssh-config-fips : Setup ssh config] 2026-06-11 12:00:42.329632 | localhost | changed 2026-06-11 12:00:42.343161 | 2026-06-11 12:00:42.343289 | PLAY [all] 2026-06-11 12:00:42.355445 | 2026-06-11 12:00:42.355624 | TASK [include_role : prepare-workspace] 2026-06-11 12:00:42.389834 | controller | ok 2026-06-11 12:00:42.421097 | 2026-06-11 12:00:42.421194 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-11 12:00:42.913928 | controller | ok 2026-06-11 12:00:42.926798 | 2026-06-11 12:00:42.926952 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-11 12:00:44.374957 | controller | Output suppressed because no_log was given 2026-06-11 12:00:44.389973 | 2026-06-11 12:00:44.390125 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-11 12:00:44.665474 | controller | changed: "logs" 2026-06-11 12:00:44.906888 | controller | changed: "artifacts" 2026-06-11 12:00:45.142094 | controller | changed: "docs" 2026-06-11 12:00:45.155581 | 2026-06-11 12:00:45.155666 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-11 12:00:45.441307 | controller | changed: "logs" 2026-06-11 12:00:45.441733 | controller | changed: All items complete 2026-06-11 12:00:45.441797 | 2026-06-11 12:00:45.681168 | controller | changed: "artifacts" 2026-06-11 12:00:45.933774 | controller | changed: "docs" 2026-06-11 12:00:45.952211 | 2026-06-11 12:00:45.952342 | TASK [Check if worker can sudo] 2026-06-11 12:00:46.497896 | controller | ok: Runtime: 0:00:00.047080 2026-06-11 12:00:46.501934 | 2026-06-11 12:00:46.502000 | TASK [configure-mirrors : Gather needed facts] 2026-06-11 12:00:46.579054 | controller | skipping: Conditional result was False 2026-06-11 12:00:46.585103 | 2026-06-11 12:00:46.585190 | TASK [configure-mirrors : Set up infrastructure mirrors] 2026-06-11 12:00:46.640973 | controller | ok 2026-06-11 12:00:46.650395 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror.yaml 2026-06-11 12:00:46.655844 | 2026-06-11 12:00:46.655925 | TASK [configure-mirrors : Remove .pydistutils.cfg configuration in homedir] 2026-06-11 12:00:46.972773 | controller | ok 2026-06-11 12:00:46.981787 | 2026-06-11 12:00:46.981921 | LOOP [configure-mirrors : Include OS-specific variables] 2026-06-11 12:00:47.073836 | controller | ok: "/var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/vars/CentOS-9.yaml" 2026-06-11 12:00:47.086098 | 2026-06-11 12:00:47.086277 | TASK [configure-mirrors : Install /etc/pip.conf configuration] 2026-06-11 12:00:47.997106 | controller | changed 2026-06-11 12:00:48.009244 | 2026-06-11 12:00:48.009452 | LOOP [configure-mirrors : Setup distribution specific packaging mirrors] 2026-06-11 12:00:48.175735 | controller | ok: "/var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml" 2026-06-11 12:00:48.175927 | controller | ok: All items complete 2026-06-11 12:00:48.175963 | 2026-06-11 12:00:48.253212 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml 2026-06-11 12:00:48.260487 | 2026-06-11 12:00:48.260595 | LOOP [configure-mirrors : Install CentOS 9 repository files] 2026-06-11 12:00:49.247968 | controller | changed: "etc/yum.repos.d/centos.repo" 2026-06-11 12:00:50.041967 | controller | changed: "etc/yum.repos.d/centos-addons.repo" 2026-06-11 12:00:50.056117 | 2026-06-11 12:00:50.056327 | TASK [configure-mirrors : Disable deltrarpm] 2026-06-11 12:00:50.569315 | controller | changed: section and option added 2026-06-11 12:00:50.591662 | 2026-06-11 12:00:50.591814 | LOOP [configure-mirrors : Update yum/dnf cache] 2026-06-11 12:00:51.407395 | controller | 29 files removed 2026-06-11 12:00:51.407863 | controller | ok: Item: dnf clean all Runtime: 0:00:00.477814 2026-06-11 12:00:51.407970 | controller | changed: All items complete 2026-06-11 12:00:51.408029 | 2026-06-11 12:01:03.533462 | 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-11 12:01:03.533672 | controller | DNF version: 4.14.0 2026-06-11 12:01:03.533731 | controller | cachedir: /var/cache/dnf 2026-06-11 12:01:03.533777 | controller | Making cache files for all metadata files. 2026-06-11 12:01:03.533819 | controller | baseos: has expired and will be refreshed. 2026-06-11 12:01:03.533875 | controller | appstream: has expired and will be refreshed. 2026-06-11 12:01:03.533913 | controller | crb: has expired and will be refreshed. 2026-06-11 12:01:03.533948 | controller | extras-common: has expired and will be refreshed. 2026-06-11 12:01:03.533985 | controller | repo: downloading from remote: baseos 2026-06-11 12:01:03.534023 | controller | CentOS Stream 9 - BaseOS 37 MB/s | 8.9 MB 00:00 2026-06-11 12:01:03.534061 | controller | baseos: using metadata from Tue 09 Jun 2026 05:37:52 PM EDT. 2026-06-11 12:01:03.534096 | controller | repo: downloading from remote: appstream 2026-06-11 12:01:03.534133 | controller | CentOS Stream 9 - AppStream 57 MB/s | 28 MB 00:00 2026-06-11 12:01:03.534170 | controller | appstream: using metadata from Tue 09 Jun 2026 05:41:28 PM EDT. 2026-06-11 12:01:03.534206 | controller | repo: downloading from remote: crb 2026-06-11 12:01:03.534243 | controller | CentOS Stream 9 - CRB 55 MB/s | 8.3 MB 00:00 2026-06-11 12:01:03.534279 | controller | crb: using metadata from Tue 09 Jun 2026 05:46:02 PM EDT. 2026-06-11 12:01:03.534316 | controller | repo: downloading from remote: extras-common 2026-06-11 12:01:03.534353 | controller | CentOS Stream 9 - Extras packages 1.4 MB/s | 21 kB 00:00 2026-06-11 12:01:03.534389 | controller | extras-common: using metadata from Wed 10 Jun 2026 10:05:57 AM EDT. 2026-06-11 12:01:03.534423 | controller | Last metadata expiration check: 0:00:01 ago on Thu 11 Jun 2026 08:01:01 AM EDT. 2026-06-11 12:01:03.534461 | controller | User-Agent: constructed: 'libdnf (CentOS Stream 9; generic; Linux.x86_64)' 2026-06-11 12:01:03.534496 | controller | Completion plugin: Generating completion cache... 2026-06-11 12:01:03.534592 | controller | Metadata cache created. 2026-06-11 12:01:03.534655 | controller | ok: Item: dnf makecache -v Runtime: 0:00:11.833956 2026-06-11 12:01:03.540315 | 2026-06-11 12:01:03.540601 | PLAY RECAP 2026-06-11 12:01:03.540797 | controller | ok: 13 changed: 7 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-11 12:01:03.540884 | localhost | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-11 12:01:03.540940 | 2026-06-11 12:01:03.714872 | PRE-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master] 2026-06-11 12:01:03.717821 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-06-11 12:01:04.372866 | 2026-06-11 12:01:04.372973 | PLAY [all] 2026-06-11 12:01:04.383199 | 2026-06-11 12:01:04.383271 | TASK [Install binary dependencies] 2026-06-11 12:01:04.455396 | controller | ok 2026-06-11 12:01:04.481603 | 2026-06-11 12:01:04.481721 | TASK [bindep : Include find tasks] 2026-06-11 12:01:04.521632 | controller | ok 2026-06-11 12:01:04.530054 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-06-11 12:01:04.536261 | 2026-06-11 12:01:04.536348 | TASK [bindep : Look for bindep.txt] 2026-06-11 12:01:04.987317 | controller | ok 2026-06-11 12:01:04.997306 | 2026-06-11 12:01:04.997466 | TASK [bindep : Define bindep_file fact] 2026-06-11 12:01:05.042124 | controller | ok 2026-06-11 12:01:05.051900 | 2026-06-11 12:01:05.052050 | TASK [bindep : Look for other-requirements.txt] 2026-06-11 12:01:05.079007 | controller | skipping: Conditional result was False 2026-06-11 12:01:05.088338 | 2026-06-11 12:01:05.088489 | TASK [bindep : Define bindep_file fact] 2026-06-11 12:01:05.124466 | controller | skipping: Conditional result was False 2026-06-11 12:01:05.133465 | 2026-06-11 12:01:05.133652 | TASK [bindep : Look for bindep fallback file] 2026-06-11 12:01:05.170017 | controller | skipping: Conditional result was False 2026-06-11 12:01:05.179407 | 2026-06-11 12:01:05.179583 | TASK [bindep : Define bindep_file fact] 2026-06-11 12:01:05.215462 | controller | skipping: Conditional result was False 2026-06-11 12:01:05.224946 | 2026-06-11 12:01:05.225087 | TASK [bindep : Include bindep tasks] 2026-06-11 12:01:05.260801 | controller | ok 2026-06-11 12:01:05.272184 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find-bindep.yaml 2026-06-11 12:01:05.289403 | 2026-06-11 12:01:05.289692 | TASK [bindep : Look for bindep command] 2026-06-11 12:01:05.324369 | controller | skipping: Conditional result was False 2026-06-11 12:01:05.332074 | 2026-06-11 12:01:05.332163 | TASK [bindep : Check for system bindep] 2026-06-11 12:01:05.870603 | controller | ok: Runtime: 0:00:00.004362 2026-06-11 12:01:05.879343 | 2026-06-11 12:01:05.879645 | TASK [bindep : Define bindep_command fact] 2026-06-11 12:01:05.915931 | controller | skipping: Conditional result was False 2026-06-11 12:01:05.925018 | 2026-06-11 12:01:05.925159 | TASK [bindep : Include install tasks] 2026-06-11 12:01:05.969947 | controller | ok 2026-06-11 12:01:05.982972 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/install.yaml 2026-06-11 12:01:05.999288 | 2026-06-11 12:01:05.999417 | TASK [bindep : Create temp dir for bindep] 2026-06-11 12:01:06.379604 | controller | changed 2026-06-11 12:01:06.387831 | 2026-06-11 12:01:06.387963 | TASK [Ensure we have pip dependencies] 2026-06-11 12:01:06.413168 | controller | ok 2026-06-11 12:01:06.450085 | 2026-06-11 12:01:06.450187 | TASK [ensure-pip : Check if pip is installed] 2026-06-11 08:01:06.762848 | controller | /usr/bin/pip3 2026-06-11 08:01:06.802815 | controller | /usr/bin/python3: No module named wheel 2026-06-11 12:01:06.978495 | controller | ok: Runtime: 0:00:00.052605 2026-06-11 12:01:06.983879 | 2026-06-11 12:01:06.983951 | LOOP [ensure-pip : Install pip from packages] 2026-06-11 12:01:07.012536 | controller | ok: "/var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-06-11 12:01:07.036824 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-06-11 12:01:07.090503 | 2026-06-11 12:01:07.090668 | TASK [ensure-pip : Install Python 3 pip] 2026-06-11 12:01:08.643711 | controller | ok: Nothing to do 2026-06-11 12:01:08.652312 | 2026-06-11 12:01:08.652442 | TASK [ensure-pip : Install Python3-wheel on older CentOS] 2026-06-11 12:01:10.507662 | controller | changed 2026-06-11 12:01:10.516654 | 2026-06-11 12:01:10.516790 | TASK [ensure-pip : Check for EPEL repository] 2026-06-11 12:01:10.574635 | controller | skipping: Conditional result was False 2026-06-11 12:01:10.586127 | 2026-06-11 12:01:10.586304 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-06-11 12:01:10.655619 | controller | skipping: Conditional result was False 2026-06-11 12:01:10.668576 | 2026-06-11 12:01:10.668746 | TASK [ensure-pip : Install Python 2 pip] 2026-06-11 12:01:10.725741 | controller | skipping: Conditional result was False 2026-06-11 12:01:10.736597 | 2026-06-11 12:01:10.736751 | TASK [ensure-pip : Ensure setuptools] 2026-06-11 12:01:10.753569 | controller | skipping: Conditional result was False 2026-06-11 12:01:10.763794 | 2026-06-11 12:01:10.763943 | TASK [ensure-pip : Check for ensurepip module] 2026-06-11 12:01:11.303263 | controller | skipping: Conditional result was False 2026-06-11 12:01:11.314255 | 2026-06-11 12:01:11.314399 | TASK [ensure-pip : Ensure python3-venv] 2026-06-11 12:01:11.339059 | controller | skipping: Conditional result was False 2026-06-11 12:01:11.346036 | 2026-06-11 12:01:11.346133 | TASK [ensure-pip : Install pip from source] 2026-06-11 12:01:11.369862 | controller | skipping: Conditional result was False 2026-06-11 12:01:11.376750 | 2026-06-11 12:01:11.376856 | TASK [ensure-pip : Probe for venv python full path] 2026-06-11 08:01:11.697061 | controller | /usr/bin/python3 2026-06-11 12:01:11.920856 | controller | ok: Runtime: 0:00:00.005307 2026-06-11 12:01:11.929289 | 2026-06-11 12:01:11.929417 | TASK [ensure-pip : Set host default] 2026-06-11 12:01:12.005186 | controller | ok 2026-06-11 12:01:12.013245 | 2026-06-11 12:01:12.013390 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-06-11 12:01:12.082857 | controller | ok 2026-06-11 12:01:12.100332 | 2026-06-11 12:01:12.100489 | TASK [bindep : Install bindep into temporary venv] 2026-06-11 12:01:16.223140 | controller | changed 2026-06-11 12:01:16.237793 | 2026-06-11 12:01:16.237959 | TASK [bindep : Define bindep_command] 2026-06-11 12:01:16.270777 | controller | ok 2026-06-11 12:01:16.278763 | 2026-06-11 12:01:16.278890 | LOOP [bindep : Include package tasks] 2026-06-11 12:01:16.325974 | controller | ok: "src/github.com/openstack-k8s-operators/ci-framework/bindep.txt" 2026-06-11 12:01:16.326270 | controller | ok: All items complete 2026-06-11 12:01:16.326313 | 2026-06-11 12:01:16.347712 | controller | included: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/packages.yaml 2026-06-11 12:01:16.370117 | 2026-06-11 12:01:16.370270 | TASK [bindep : Define bindep_run fact] 2026-06-11 12:01:16.403441 | controller | ok 2026-06-11 12:01:16.411916 | 2026-06-11 12:01:16.412087 | TASK [bindep : Get list of packages to install from bindep] 2026-06-11 08:01:17.847717 | controller | podman 2026-06-11 08:01:17.847825 | controller | python3-jmespath 2026-06-11 08:01:17.847843 | controller | python3-libvirt 2026-06-11 08:01:17.847856 | controller | python3-lxml 2026-06-11 08:01:17.847869 | controller | python3-netaddr 2026-06-11 12:01:17.954731 | controller | ok: Runtime: 0:00:01.169008 2026-06-11 12:01:17.963887 | 2026-06-11 12:01:17.964021 | TASK [bindep : Install distro packages from bindep] 2026-06-11 12:02:02.082772 | controller | changed 2026-06-11 12:02:02.089236 | 2026-06-11 12:02:02.089407 | TASK [bindep : Check that packages are installed] 2026-06-11 12:02:03.627926 | controller | ok: Runtime: 0:00:01.019355 2026-06-11 12:02:03.636991 | 2026-06-11 12:02:03.637125 | TASK [bindep : Fail if we cannot install all packages] 2026-06-11 12:02:03.673945 | controller | skipping: Conditional result was False 2026-06-11 12:02:03.692454 | 2026-06-11 12:02:03.692626 | TASK [Run test-setup role] 2026-06-11 12:02:03.727826 | controller | ok 2026-06-11 12:02:03.766574 | 2026-06-11 12:02:03.766883 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-06-11 12:02:03.987922 | controller | ok 2026-06-11 12:02:03.996789 | 2026-06-11 12:02:03.996928 | TASK [test-setup : Run tools/test-setup.sh] 2026-06-11 12:02:04.532900 | controller | skipping: Conditional result was False 2026-06-11 12:02:04.555960 | 2026-06-11 12:02:04.556150 | TASK [bindep : Remove bindep temp dir] 2026-06-11 12:02:05.025722 | controller | ok 2026-06-11 12:02:05.028637 | 2026-06-11 12:02:05.028744 | PLAY RECAP 2026-06-11 12:02:05.028832 | controller | ok: 23 changed: 6 unreachable: 0 failed: 0 skipped: 15 rescued: 0 ignored: 0 2026-06-11 12:02:05.028879 | 2026-06-11 12:02:05.195909 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-06-11 12:02:05.199017 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/run-test-command/run.yaml@master] 2026-06-11 12:02:05.823718 | 2026-06-11 12:02:05.823877 | PLAY [all] 2026-06-11 12:02:05.833904 | 2026-06-11 12:02:05.834008 | TASK [Abort when test_command variable is undefined] 2026-06-11 12:02:05.869676 | controller | skipping: Conditional result was False 2026-06-11 12:02:05.875316 | 2026-06-11 12:02:05.875401 | TASK [Convert test_command to list] 2026-06-11 12:02:05.940936 | controller | skipping: Conditional result was False 2026-06-11 12:02:05.946586 | 2026-06-11 12:02:05.946678 | TASK [Use test_command list] 2026-06-11 12:02:06.009489 | controller | ok 2026-06-11 12:02:06.021805 | 2026-06-11 12:02:06.021964 | LOOP [Run test_command] 2026-06-11 12:02:06.430984 | controller | no check to run 2026-06-11 12:02:06.431401 | controller | ok: Item: echo 'no check to run' Runtime: 0:00:00.003760 2026-06-11 12:02:06.440258 | 2026-06-11 12:02:06.440443 | PLAY RECAP 2026-06-11 12:02:06.440504 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-11 12:02:06.440558 | 2026-06-11 12:02:06.585683 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/run-test-command/run.yaml@master] 2026-06-11 12:02:06.588452 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-11 12:02:07.179193 | 2026-06-11 12:02:07.179304 | PLAY [all] 2026-06-11 12:02:07.189493 | 2026-06-11 12:02:07.189581 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-11 12:02:07.524207 | controller | changed: non-zero return code 2026-06-11 12:02:07.532770 | 2026-06-11 12:02:07.532924 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-11 12:02:07.559739 | controller | skipping: Conditional result was False 2026-06-11 12:02:07.570495 | 2026-06-11 12:02:07.570688 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-11 12:02:07.615464 | 2026-06-11 12:02:07.615825 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-11 12:02:07.651698 | 2026-06-11 12:02:07.651999 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-11 12:02:07.678582 | controller | skipping: Conditional result was False 2026-06-11 12:02:07.687911 | 2026-06-11 12:02:07.688103 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-11 12:02:07.723448 | 2026-06-11 12:02:07.723800 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-11 12:02:07.749414 | controller | skipping: Conditional result was False 2026-06-11 12:02:07.758900 | 2026-06-11 12:02:07.759052 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-11 12:02:07.784860 | controller | skipping: Conditional result was False 2026-06-11 12:02:07.794733 | 2026-06-11 12:02:07.794880 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-11 12:02:07.821941 | controller | skipping: Conditional result was False 2026-06-11 12:02:07.837425 | 2026-06-11 12:02:07.837619 | PLAY RECAP 2026-06-11 12:02:07.837713 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-11 12:02:07.837758 | 2026-06-11 12:02:07.982644 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-11 12:02:07.985827 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-06-11 12:02:08.669550 | 2026-06-11 12:02:08.669668 | PLAY [all] 2026-06-11 12:02:08.678939 | 2026-06-11 12:02:08.679008 | TASK [include_role : fetch-output] 2026-06-11 12:02:08.727666 | controller | ok 2026-06-11 12:02:08.743437 | 2026-06-11 12:02:08.743562 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-11 12:02:08.809561 | controller | skipping: Conditional result was False 2026-06-11 12:02:08.818752 | 2026-06-11 12:02:08.818903 | TASK [fetch-output : Set log path for single node] 2026-06-11 12:02:08.887750 | controller | ok 2026-06-11 12:02:08.896390 | 2026-06-11 12:02:08.896580 | LOOP [fetch-output : Ensure local output dirs] 2026-06-11 12:02:09.453552 | controller -> localhost | changed: "/var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/work/logs" 2026-06-11 12:02:09.717095 | controller -> localhost | changed: "/var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/work/artifacts" 2026-06-11 12:02:10.034032 | controller -> localhost | changed: "/var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/work/docs" 2026-06-11 12:02:10.042682 | 2026-06-11 12:02:10.042757 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-11 12:02:10.800283 | controller | changed: .d..t...... ./ 2026-06-11 12:02:10.800619 | controller | changed: All items complete 2026-06-11 12:02:10.800688 | 2026-06-11 12:02:11.412496 | controller | changed: .d..t...... ./ 2026-06-11 12:02:11.958552 | controller | changed: .d..t...... ./ 2026-06-11 12:02:11.979069 | 2026-06-11 12:02:11.979318 | TASK [include_role : fetch-output-openshift] 2026-06-11 12:02:12.009735 | controller | skipping: Conditional result was False 2026-06-11 12:02:12.022108 | 2026-06-11 12:02:12.022258 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-11 12:02:12.587266 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.019216 2026-06-11 12:02:12.902009 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.015836 2026-06-11 12:02:12.913454 | 2026-06-11 12:02:12.913644 | PLAY [all] 2026-06-11 12:02:12.919104 | 2026-06-11 12:02:12.919174 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-11 12:02:13.341433 | controller | changed 2026-06-11 12:02:13.350468 | 2026-06-11 12:02:13.350592 | PLAY RECAP 2026-06-11 12:02:13.350673 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-11 12:02:13.350714 | 2026-06-11 12:02:13.488121 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-06-11 12:02:13.489327 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-06-11 12:02:14.165776 | 2026-06-11 12:02:14.165886 | PLAY [localhost] 2026-06-11 12:02:14.175665 | 2026-06-11 12:02:14.175739 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-11 12:02:14.621578 | localhost | changed 2026-06-11 12:02:14.641279 | 2026-06-11 12:02:14.641649 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-11 12:02:14.685408 | localhost | ok 2026-06-11 12:02:14.700310 | 2026-06-11 12:02:14.700561 | TASK [add-fileserver : Create SSH private key tempfile] 2026-06-11 12:02:15.201985 | localhost | changed 2026-06-11 12:02:15.213049 | 2026-06-11 12:02:15.213203 | TASK [add-fileserver : Create SSH private key from secret] 2026-06-11 12:02:16.049216 | localhost | changed 2026-06-11 12:02:16.060645 | 2026-06-11 12:02:16.060789 | TASK [add-fileserver : Add fileserver ssh key] 2026-06-11 12:02:16.565793 | localhost | Identity added: /var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/work/tmp/ansible.g32cr_4u (/var/lib/zuul/builds/ec0efbc54db14253bf91b64c23a04f66/work/tmp/ansible.g32cr_4u) 2026-06-11 12:02:16.566169 | localhost | ok: Runtime: 0:00:00.020131 2026-06-11 12:02:16.574580 | 2026-06-11 12:02:16.574731 | TASK [add-fileserver : Remove SSH private key from disk] 2026-06-11 12:02:16.886162 | localhost | ok: Runtime: 0:00:00.009597 2026-06-11 12:02:16.895312 | 2026-06-11 12:02:16.895452 | TASK [add-fileserver : Add fileserver to inventory] 2026-06-11 12:02:16.950388 | localhost | changed 2026-06-11 12:02:16.957206 | 2026-06-11 12:02:16.957293 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-06-11 12:02:17.366095 | localhost | changed 2026-06-11 12:02:17.377219 | 2026-06-11 12:02:17.377325 | PLAY [localhost] 2026-06-11 12:02:17.385970 | 2026-06-11 12:02:17.386085 | TASK [Generate bulk log download script] 2026-06-11 12:02:17.410002 | localhost | ok 2026-06-11 12:02:17.430401 | 2026-06-11 12:02:17.430486 | TASK [local-log-download : Check API endpoint is defined] 2026-06-11 12:02:17.472670 | localhost | ok: All assertions passed 2026-06-11 12:02:17.477985 | 2026-06-11 12:02:17.478065 | TASK [local-log-download : Create download script] 2026-06-11 12:02:18.020036 | localhost -> localhost | changed 2026-06-11 12:02:18.074842 | 2026-06-11 12:02:18.075015 | TASK [Register quick-download link] 2026-06-11 12:02:18.104740 | localhost | ok 2026-06-11 12:02:18.107455 | 2026-06-11 12:02:18.107551 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com] 2026-06-11 12:02:18.113816 | 2026-06-11 12:02:18.113891 | TASK [Set zuul-log-path fact] 2026-06-11 12:02:18.131320 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-11 12:02:18.139609 | 2026-06-11 12:02:18.139689 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-11 12:02:18.176323 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-11 12:02:18.179376 | 2026-06-11 12:02:18.179456 | TASK [upload-logs : Create log directories] 2026-06-11 12:02:19.077813 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed 2026-06-11 12:02:19.088724 | 2026-06-11 12:02:19.088875 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-11 12:02:19.437835 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.010337 2026-06-11 12:02:19.447443 | 2026-06-11 12:02:19.447621 | TASK [upload-logs : Upload logs to log server] 2026-06-11 12:02:20.716128 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | Output suppressed because no_log was given 2026-06-11 12:02:20.719500 | 2026-06-11 12:02:20.719678 | LOOP [upload-logs : Compress console log and json output]