2026-06-11 10:11:59.235752 | Job console starting 2026-06-11 10:11:59.368634 | Updating git repos 2026-06-11 10:11:59.407174 | Cloning repos into workspace 2026-06-11 10:12:00.074060 | Restoring repo states 2026-06-11 10:12:00.086654 | Merging changes 2026-06-11 10:12:01.468201 | Checking out repos 2026-06-11 10:12:01.611536 | Preparing playbooks 2026-06-11 10:12:05.405554 | Running Ansible setup 2026-06-11 10:12:09.086190 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-06-11 10:12:09.677289 | 2026-06-11 10:12:09.677415 | PLAY [localhost] 2026-06-11 10:12:09.685791 | 2026-06-11 10:12:09.685883 | TASK [Gathering Facts] 2026-06-11 10:12:10.577690 | localhost | ok 2026-06-11 10:12:10.590517 | 2026-06-11 10:12:10.590783 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-11 10:12:11.062912 | localhost -> localhost | changed 2026-06-11 10:12:11.067714 | 2026-06-11 10:12:11.067784 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-11 10:12:12.099724 | localhost -> localhost | changed 2026-06-11 10:12:12.119958 | 2026-06-11 10:12:12.120142 | TASK [Setup log path fact] 2026-06-11 10:12:12.160158 | localhost | ok 2026-06-11 10:12:12.182280 | 2026-06-11 10:12:12.182474 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-11 10:12:12.224350 | localhost | ok 2026-06-11 10:12:12.233457 | 2026-06-11 10:12:12.233569 | TASK [emit-job-header : Print job information] 2026-06-11 10:12:12.284399 | # Job Information 2026-06-11 10:12:12.284598 | Ansible Version: 2.16.18 2026-06-11 10:12:12.284639 | Job: cifmw-molecule-federation 2026-06-11 10:12:12.284666 | Pipeline: github-check 2026-06-11 10:12:12.284691 | Executor: 38.102.83.40 2026-06-11 10:12:12.284714 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3840 2026-06-11 10:12:12.284743 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/840/rdoproject.org/840481fc75d54dcdb668c63ebd788433/ 2026-06-11 10:12:12.284770 | Event ID: b739ec60-657d-11f1-8941-cf475c028f57 2026-06-11 10:12:12.288682 | 2026-06-11 10:12:12.288767 | LOOP [emit-job-header : Print node information] 2026-06-11 10:12:12.403657 | localhost | ok: 2026-06-11 10:12:12.404074 | localhost | # Node Information 2026-06-11 10:12:12.404102 | localhost | Inventory Hostname: controller 2026-06-11 10:12:12.404125 | localhost | Hostname: np0000070584 2026-06-11 10:12:12.404144 | localhost | Username: zuul 2026-06-11 10:12:12.404164 | localhost | Distro: CentOS 9 2026-06-11 10:12:12.404181 | localhost | Provider: vexxhost-nodepool-tripleo 2026-06-11 10:12:12.404197 | localhost | Region: RegionOne 2026-06-11 10:12:12.404213 | localhost | Label: cloud-centos-9-stream-tripleo 2026-06-11 10:12:12.404229 | localhost | Product Name: OpenStack Nova 2026-06-11 10:12:12.404245 | localhost | Interface IP: 38.102.83.68 2026-06-11 10:12:12.413338 | 2026-06-11 10:12:12.413529 | PLAY [all] 2026-06-11 10:12:12.421828 | 2026-06-11 10:12:12.421917 | TASK [Gather network facts] 2026-06-11 10:12:12.814944 | controller | ok 2026-06-11 10:12:12.827498 | 2026-06-11 10:12:12.827671 | TASK [include_role : start-zuul-console] 2026-06-11 10:12:12.857764 | controller | ok 2026-06-11 10:12:12.876993 | 2026-06-11 10:12:12.877120 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-11 10:12:13.272644 | controller | ok 2026-06-11 10:12:13.287759 | 2026-06-11 10:12:13.287972 | TASK [include_role : add-build-sshkey] 2026-06-11 10:12:13.320656 | controller | ok 2026-06-11 10:12:13.342432 | 2026-06-11 10:12:13.342567 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-11 10:12:13.656967 | controller -> localhost | ok 2026-06-11 10:12:13.666436 | 2026-06-11 10:12:13.666612 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-11 10:12:13.700522 | controller | ok 2026-06-11 10:12:13.727989 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-11 10:12:13.736933 | 2026-06-11 10:12:13.737011 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-11 10:12:14.785349 | controller -> localhost | Generating public/private rsa key pair. 2026-06-11 10:12:14.785721 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/work/840481fc75d54dcdb668c63ebd788433_id_rsa 2026-06-11 10:12:14.785789 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/work/840481fc75d54dcdb668c63ebd788433_id_rsa.pub 2026-06-11 10:12:14.785845 | controller -> localhost | The key fingerprint is: 2026-06-11 10:12:14.785906 | controller -> localhost | SHA256:ksMxdKV1HzTn2OkySo9yCnBjp3j081v+UGtc4LFVKhQ zuul-build-sshkey 2026-06-11 10:12:14.785966 | controller -> localhost | The key's randomart image is: 2026-06-11 10:12:14.786049 | controller -> localhost | +---[RSA 3072]----+ 2026-06-11 10:12:14.786095 | controller -> localhost | | . ..o Eo+ o| 2026-06-11 10:12:14.786136 | controller -> localhost | | . . o o . Oo| 2026-06-11 10:12:14.786174 | controller -> localhost | | o . . *.+| 2026-06-11 10:12:14.786213 | controller -> localhost | | . + o.= | 2026-06-11 10:12:14.786252 | controller -> localhost | | .==S. . ooo.| 2026-06-11 10:12:14.786290 | controller -> localhost | | *o= . + = o| 2026-06-11 10:12:14.786329 | controller -> localhost | | . + + + + + | 2026-06-11 10:12:14.786368 | controller -> localhost | | . . * o o | 2026-06-11 10:12:14.786405 | controller -> localhost | | . o.... | 2026-06-11 10:12:14.786442 | controller -> localhost | +----[SHA256]-----+ 2026-06-11 10:12:14.786540 | controller -> localhost | ok: Runtime: 0:00:00.537796 2026-06-11 10:12:14.794934 | 2026-06-11 10:12:14.795080 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-11 10:12:14.828143 | controller | ok 2026-06-11 10:12:14.845022 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-11 10:12:14.859114 | 2026-06-11 10:12:14.859195 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-11 10:12:14.883897 | controller | skipping: Conditional result was False 2026-06-11 10:12:14.889491 | 2026-06-11 10:12:14.889595 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-11 10:12:15.321047 | controller | changed 2026-06-11 10:12:15.328527 | 2026-06-11 10:12:15.328693 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-11 10:12:15.574537 | controller | ok 2026-06-11 10:12:15.582165 | 2026-06-11 10:12:15.582313 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-11 10:12:16.413711 | controller | changed 2026-06-11 10:12:16.421804 | 2026-06-11 10:12:16.421950 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-11 10:12:17.195926 | controller | changed 2026-06-11 10:12:17.203709 | 2026-06-11 10:12:17.203842 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-11 10:12:17.229992 | controller | skipping: Conditional result was False 2026-06-11 10:12:17.240273 | 2026-06-11 10:12:17.240411 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-11 10:12:17.712302 | controller -> localhost | changed 2026-06-11 10:12:17.729766 | 2026-06-11 10:12:17.729975 | TASK [add-build-sshkey : Add back temp key] 2026-06-11 10:12:18.149739 | controller -> localhost | Identity added: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/work/840481fc75d54dcdb668c63ebd788433_id_rsa (zuul-build-sshkey) 2026-06-11 10:12:18.150090 | controller -> localhost | ok: Runtime: 0:00:00.019538 2026-06-11 10:12:18.158437 | 2026-06-11 10:12:18.158570 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-11 10:12:18.547730 | controller | ok 2026-06-11 10:12:18.554780 | 2026-06-11 10:12:18.554915 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-11 10:12:18.590974 | controller | skipping: Conditional result was False 2026-06-11 10:12:18.605450 | 2026-06-11 10:12:18.605634 | TASK [include_role : validate-host] 2026-06-11 10:12:18.641946 | controller | ok 2026-06-11 10:12:18.674189 | 2026-06-11 10:12:18.674336 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-11 10:12:18.713648 | controller | ok 2026-06-11 10:12:18.717909 | 2026-06-11 10:12:18.718011 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-11 10:12:19.017357 | controller -> localhost | ok 2026-06-11 10:12:19.026898 | 2026-06-11 10:12:19.027035 | TASK [validate-host : Collect information about the host] 2026-06-11 10:12:19.738200 | controller | ok 2026-06-11 10:12:19.754799 | 2026-06-11 10:12:19.754937 | TASK [validate-host : Sanitize hostname] 2026-06-11 10:12:19.830179 | controller | ok 2026-06-11 10:12:19.838418 | 2026-06-11 10:12:19.838551 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-11 10:12:20.426008 | controller -> localhost | changed 2026-06-11 10:12:20.433162 | 2026-06-11 10:12:20.433232 | TASK [validate-host : Collect information about zuul worker] 2026-06-11 10:12:20.837973 | controller | ok 2026-06-11 10:12:20.846023 | 2026-06-11 10:12:20.846164 | TASK [validate-host : Write out all zuul information for each host] 2026-06-11 10:12:21.315242 | controller -> localhost | changed 2026-06-11 10:12:21.329787 | 2026-06-11 10:12:21.329914 | TASK [include_role : prepare-workspace-openshift] 2026-06-11 10:12:21.356561 | controller | skipping: Conditional result was False 2026-06-11 10:12:21.364698 | 2026-06-11 10:12:21.364839 | TASK [include_role : remove-zuul-sshkey] 2026-06-11 10:12:21.389981 | controller | skipping: Conditional result was False 2026-06-11 10:12:21.398613 | 2026-06-11 10:12:21.398752 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-11 10:12:21.647806 | controller | ok: "logs" 2026-06-11 10:12:21.648391 | controller | ok: All items complete 2026-06-11 10:12:21.648462 | 2026-06-11 10:12:21.866994 | controller | ok: "artifacts" 2026-06-11 10:12:22.064179 | controller | ok: "docs" 2026-06-11 10:12:22.073158 | 2026-06-11 10:12:22.073346 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-11 10:12:22.339658 | controller | changed: "logs" 2026-06-11 10:12:22.526710 | controller | changed: "artifacts" 2026-06-11 10:12:22.759809 | controller | changed: "docs" 2026-06-11 10:12:22.775827 | 2026-06-11 10:12:22.776024 | PLAY RECAP 2026-06-11 10:12:22.776117 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-06-11 10:12:22.776174 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-11 10:12:22.776213 | 2026-06-11 10:12:22.934511 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-06-11 10:12:22.937012 | PRE-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master] 2026-06-11 10:12:23.547219 | 2026-06-11 10:12:23.547340 | PLAY [localhost] 2026-06-11 10:12:23.556018 | 2026-06-11 10:12:23.556089 | TASK [configure-ssh-config-fips : Ensure ssh config directory] 2026-06-11 10:12:24.007063 | localhost | changed 2026-06-11 10:12:24.015321 | 2026-06-11 10:12:24.015470 | TASK [configure-ssh-config-fips : Setup ssh config] 2026-06-11 10:12:24.829909 | localhost | changed 2026-06-11 10:12:24.849255 | 2026-06-11 10:12:24.849396 | PLAY [all] 2026-06-11 10:12:24.867304 | 2026-06-11 10:12:24.867466 | TASK [include_role : prepare-workspace] 2026-06-11 10:12:24.901529 | controller | ok 2026-06-11 10:12:24.928282 | 2026-06-11 10:12:24.928473 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-11 10:12:25.348205 | controller | ok 2026-06-11 10:12:25.358662 | 2026-06-11 10:12:25.358793 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-11 10:12:26.789396 | controller | Output suppressed because no_log was given 2026-06-11 10:12:26.805197 | 2026-06-11 10:12:26.805338 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-11 10:12:27.069135 | controller | changed: "logs" 2026-06-11 10:12:27.304767 | controller | changed: "artifacts" 2026-06-11 10:12:27.548394 | controller | changed: "docs" 2026-06-11 10:12:27.565801 | 2026-06-11 10:12:27.565950 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-11 10:12:27.808539 | controller | changed: "logs" 2026-06-11 10:12:27.809057 | controller | changed: All items complete 2026-06-11 10:12:27.809117 | 2026-06-11 10:12:28.025931 | controller | changed: "artifacts" 2026-06-11 10:12:28.251446 | controller | changed: "docs" 2026-06-11 10:12:28.278101 | 2026-06-11 10:12:28.278322 | TASK [Check if worker can sudo] 2026-06-11 10:12:28.831266 | controller | ok: Runtime: 0:00:00.036351 2026-06-11 10:12:28.839630 | 2026-06-11 10:12:28.839759 | TASK [configure-mirrors : Gather needed facts] 2026-06-11 10:12:28.907256 | controller | skipping: Conditional result was False 2026-06-11 10:12:28.917115 | 2026-06-11 10:12:28.917256 | TASK [configure-mirrors : Set up infrastructure mirrors] 2026-06-11 10:12:28.982135 | controller | ok 2026-06-11 10:12:28.997637 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror.yaml 2026-06-11 10:12:29.006473 | 2026-06-11 10:12:29.006658 | TASK [configure-mirrors : Remove .pydistutils.cfg configuration in homedir] 2026-06-11 10:12:29.273808 | controller | ok 2026-06-11 10:12:29.282737 | 2026-06-11 10:12:29.282863 | LOOP [configure-mirrors : Include OS-specific variables] 2026-06-11 10:12:29.370959 | controller | ok: "/var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/vars/CentOS-9.yaml" 2026-06-11 10:12:29.382559 | 2026-06-11 10:12:29.382641 | TASK [configure-mirrors : Install /etc/pip.conf configuration] 2026-06-11 10:12:30.248122 | controller | changed 2026-06-11 10:12:30.259059 | 2026-06-11 10:12:30.259216 | LOOP [configure-mirrors : Setup distribution specific packaging mirrors] 2026-06-11 10:12:30.418101 | controller | ok: "/var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml" 2026-06-11 10:12:30.418274 | controller | ok: All items complete 2026-06-11 10:12:30.418307 | 2026-06-11 10:12:30.495193 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml 2026-06-11 10:12:30.502456 | 2026-06-11 10:12:30.502634 | LOOP [configure-mirrors : Install CentOS 9 repository files] 2026-06-11 10:12:31.363464 | controller | changed: "etc/yum.repos.d/centos.repo" 2026-06-11 10:12:32.130357 | controller | changed: "etc/yum.repos.d/centos-addons.repo" 2026-06-11 10:12:32.144300 | 2026-06-11 10:12:32.144505 | TASK [configure-mirrors : Disable deltrarpm] 2026-06-11 10:12:32.624424 | controller | changed: section and option added 2026-06-11 10:12:32.646566 | 2026-06-11 10:12:32.646746 | LOOP [configure-mirrors : Update yum/dnf cache] 2026-06-11 10:12:33.668490 | controller | 29 files removed 2026-06-11 10:12:33.668996 | controller | ok: Item: dnf clean all Runtime: 0:00:00.715942 2026-06-11 10:12:33.669083 | controller | changed: All items complete 2026-06-11 10:12:33.669143 | 2026-06-11 10:12:45.463038 | 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 10:12:45.463212 | controller | DNF version: 4.14.0 2026-06-11 10:12:45.463263 | controller | cachedir: /var/cache/dnf 2026-06-11 10:12:45.463305 | controller | Making cache files for all metadata files. 2026-06-11 10:12:45.463342 | controller | baseos: has expired and will be refreshed. 2026-06-11 10:12:45.463396 | controller | appstream: has expired and will be refreshed. 2026-06-11 10:12:45.463433 | controller | crb: has expired and will be refreshed. 2026-06-11 10:12:45.463468 | controller | extras-common: has expired and will be refreshed. 2026-06-11 10:12:45.463503 | controller | repo: downloading from remote: baseos 2026-06-11 10:12:45.463538 | controller | CentOS Stream 9 - BaseOS 80 MB/s | 8.9 MB 00:00 2026-06-11 10:12:45.463604 | controller | baseos: using metadata from Tue 09 Jun 2026 05:37:52 PM EDT. 2026-06-11 10:12:45.463653 | controller | repo: downloading from remote: appstream 2026-06-11 10:12:45.463689 | controller | CentOS Stream 9 - AppStream 113 MB/s | 28 MB 00:00 2026-06-11 10:12:45.463724 | controller | appstream: using metadata from Tue 09 Jun 2026 05:41:28 PM EDT. 2026-06-11 10:12:45.463758 | controller | repo: downloading from remote: crb 2026-06-11 10:12:45.463792 | controller | CentOS Stream 9 - CRB 85 MB/s | 8.3 MB 00:00 2026-06-11 10:12:45.463827 | controller | crb: using metadata from Tue 09 Jun 2026 05:46:02 PM EDT. 2026-06-11 10:12:45.463860 | controller | repo: downloading from remote: extras-common 2026-06-11 10:12:45.463894 | controller | CentOS Stream 9 - Extras packages 1.9 MB/s | 21 kB 00:00 2026-06-11 10:12:45.463928 | controller | extras-common: using metadata from Wed 10 Jun 2026 10:05:57 AM EDT. 2026-06-11 10:12:45.463961 | controller | User-Agent: constructed: 'libdnf (CentOS Stream 9; generic; Linux.x86_64)' 2026-06-11 10:12:45.463994 | controller | Completion plugin: Generating completion cache... 2026-06-11 10:12:45.464045 | controller | Metadata cache created. 2026-06-11 10:12:45.464099 | controller | ok: Item: dnf makecache -v Runtime: 0:00:11.575938 2026-06-11 10:12:45.474420 | 2026-06-11 10:12:45.474611 | PLAY RECAP 2026-06-11 10:12:45.474701 | controller | ok: 13 changed: 7 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-11 10:12:45.474754 | localhost | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-11 10:12:45.474789 | 2026-06-11 10:12:45.617957 | PRE-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master] 2026-06-11 10:12:45.620154 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-06-11 10:12:46.220071 | 2026-06-11 10:12:46.220173 | PLAY [all] 2026-06-11 10:12:46.230396 | 2026-06-11 10:12:46.230471 | TASK [Install binary dependencies] 2026-06-11 10:12:46.298269 | controller | ok 2026-06-11 10:12:46.314327 | 2026-06-11 10:12:46.314467 | TASK [bindep : Include find tasks] 2026-06-11 10:12:46.352709 | controller | ok 2026-06-11 10:12:46.358945 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-06-11 10:12:46.363337 | 2026-06-11 10:12:46.363396 | TASK [bindep : Look for bindep.txt] 2026-06-11 10:12:46.779613 | controller | ok 2026-06-11 10:12:46.788685 | 2026-06-11 10:12:46.788836 | TASK [bindep : Define bindep_file fact] 2026-06-11 10:12:46.832229 | controller | ok 2026-06-11 10:12:46.840856 | 2026-06-11 10:12:46.840981 | TASK [bindep : Look for other-requirements.txt] 2026-06-11 10:12:46.867541 | controller | skipping: Conditional result was False 2026-06-11 10:12:46.877068 | 2026-06-11 10:12:46.877268 | TASK [bindep : Define bindep_file fact] 2026-06-11 10:12:46.913788 | controller | skipping: Conditional result was False 2026-06-11 10:12:46.922305 | 2026-06-11 10:12:46.922431 | TASK [bindep : Look for bindep fallback file] 2026-06-11 10:12:46.948388 | controller | skipping: Conditional result was False 2026-06-11 10:12:46.957321 | 2026-06-11 10:12:46.957461 | TASK [bindep : Define bindep_file fact] 2026-06-11 10:12:46.993984 | controller | skipping: Conditional result was False 2026-06-11 10:12:47.002645 | 2026-06-11 10:12:47.002776 | TASK [bindep : Include bindep tasks] 2026-06-11 10:12:47.046263 | controller | ok 2026-06-11 10:12:47.057567 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find-bindep.yaml 2026-06-11 10:12:47.074990 | 2026-06-11 10:12:47.075126 | TASK [bindep : Look for bindep command] 2026-06-11 10:12:47.110326 | controller | skipping: Conditional result was False 2026-06-11 10:12:47.115710 | 2026-06-11 10:12:47.115777 | TASK [bindep : Check for system bindep] 2026-06-11 10:12:47.645242 | controller | ok: Runtime: 0:00:00.003430 2026-06-11 10:12:47.653866 | 2026-06-11 10:12:47.653994 | TASK [bindep : Define bindep_command fact] 2026-06-11 10:12:47.680839 | controller | skipping: Conditional result was False 2026-06-11 10:12:47.690082 | 2026-06-11 10:12:47.690205 | TASK [bindep : Include install tasks] 2026-06-11 10:12:47.723786 | controller | ok 2026-06-11 10:12:47.736239 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/install.yaml 2026-06-11 10:12:47.754107 | 2026-06-11 10:12:47.754188 | TASK [bindep : Create temp dir for bindep] 2026-06-11 10:12:48.143879 | controller | changed 2026-06-11 10:12:48.152844 | 2026-06-11 10:12:48.152975 | TASK [Ensure we have pip dependencies] 2026-06-11 10:12:48.177961 | controller | ok 2026-06-11 10:12:48.217470 | 2026-06-11 10:12:48.217596 | TASK [ensure-pip : Check if pip is installed] 2026-06-11 06:12:48.521046 | controller | /usr/bin/pip3 2026-06-11 06:12:48.564228 | controller | /usr/bin/python3: No module named wheel 2026-06-11 10:12:48.752207 | controller | ok: Runtime: 0:00:00.052648 2026-06-11 10:12:48.760363 | 2026-06-11 10:12:48.760489 | LOOP [ensure-pip : Install pip from packages] 2026-06-11 10:12:48.804901 | controller | ok: "/var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-06-11 10:12:48.819664 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-06-11 10:12:48.871831 | 2026-06-11 10:12:48.871966 | TASK [ensure-pip : Install Python 3 pip] 2026-06-11 10:12:50.374237 | controller | ok: Nothing to do 2026-06-11 10:12:50.383378 | 2026-06-11 10:12:50.383558 | TASK [ensure-pip : Install Python3-wheel on older CentOS] 2026-06-11 10:12:51.910609 | controller | changed 2026-06-11 10:12:51.919042 | 2026-06-11 10:12:51.919164 | TASK [ensure-pip : Check for EPEL repository] 2026-06-11 10:12:51.986105 | controller | skipping: Conditional result was False 2026-06-11 10:12:51.995615 | 2026-06-11 10:12:51.995767 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-06-11 10:12:52.042426 | controller | skipping: Conditional result was False 2026-06-11 10:12:52.056154 | 2026-06-11 10:12:52.056299 | TASK [ensure-pip : Install Python 2 pip] 2026-06-11 10:12:52.102667 | controller | skipping: Conditional result was False 2026-06-11 10:12:52.111789 | 2026-06-11 10:12:52.111917 | TASK [ensure-pip : Ensure setuptools] 2026-06-11 10:12:52.137904 | controller | skipping: Conditional result was False 2026-06-11 10:12:52.146701 | 2026-06-11 10:12:52.146833 | TASK [ensure-pip : Check for ensurepip module] 2026-06-11 10:12:52.694597 | controller | skipping: Conditional result was False 2026-06-11 10:12:52.705518 | 2026-06-11 10:12:52.705877 | TASK [ensure-pip : Ensure python3-venv] 2026-06-11 10:12:52.733138 | controller | skipping: Conditional result was False 2026-06-11 10:12:52.744484 | 2026-06-11 10:12:52.744667 | TASK [ensure-pip : Install pip from source] 2026-06-11 10:12:52.784213 | controller | skipping: Conditional result was False 2026-06-11 10:12:52.797208 | 2026-06-11 10:12:52.797356 | TASK [ensure-pip : Probe for venv python full path] 2026-06-11 06:12:53.068764 | controller | /usr/bin/python3 2026-06-11 10:12:53.337366 | controller | ok: Runtime: 0:00:00.005772 2026-06-11 10:12:53.346913 | 2026-06-11 10:12:53.347046 | TASK [ensure-pip : Set host default] 2026-06-11 10:12:53.418700 | controller | ok 2026-06-11 10:12:53.423827 | 2026-06-11 10:12:53.423920 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-06-11 10:12:53.486686 | controller | ok 2026-06-11 10:12:53.497745 | 2026-06-11 10:12:53.497828 | TASK [bindep : Install bindep into temporary venv] 2026-06-11 10:12:57.677832 | controller | changed 2026-06-11 10:12:57.685959 | 2026-06-11 10:12:57.686084 | TASK [bindep : Define bindep_command] 2026-06-11 10:12:57.730298 | controller | ok 2026-06-11 10:12:57.737902 | 2026-06-11 10:12:57.738025 | LOOP [bindep : Include package tasks] 2026-06-11 10:12:57.813381 | controller | ok: "src/github.com/openstack-k8s-operators/ci-framework/bindep.txt" 2026-06-11 10:12:57.813715 | controller | ok: All items complete 2026-06-11 10:12:57.813772 | 2026-06-11 10:12:57.827799 | controller | included: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/packages.yaml 2026-06-11 10:12:57.849483 | 2026-06-11 10:12:57.849659 | TASK [bindep : Define bindep_run fact] 2026-06-11 10:12:57.892566 | controller | ok 2026-06-11 10:12:57.903105 | 2026-06-11 10:12:57.903269 | TASK [bindep : Get list of packages to install from bindep] 2026-06-11 06:12:59.232893 | controller | podman 2026-06-11 06:12:59.232959 | controller | python3-jmespath 2026-06-11 06:12:59.232964 | controller | python3-libvirt 2026-06-11 06:12:59.232970 | controller | python3-lxml 2026-06-11 06:12:59.232974 | controller | python3-netaddr 2026-06-11 10:12:59.443230 | controller | ok: Runtime: 0:00:01.081730 2026-06-11 10:12:59.447174 | 2026-06-11 10:12:59.447235 | TASK [bindep : Install distro packages from bindep] 2026-06-11 10:13:42.045278 | controller | changed 2026-06-11 10:13:42.053884 | 2026-06-11 10:13:42.054010 | TASK [bindep : Check that packages are installed] 2026-06-11 10:13:43.599887 | controller | ok: Runtime: 0:00:01.071137 2026-06-11 10:13:43.607946 | 2026-06-11 10:13:43.608087 | TASK [bindep : Fail if we cannot install all packages] 2026-06-11 10:13:43.643943 | controller | skipping: Conditional result was False 2026-06-11 10:13:43.661489 | 2026-06-11 10:13:43.661655 | TASK [Run test-setup role] 2026-06-11 10:13:43.686235 | controller | ok 2026-06-11 10:13:43.714829 | 2026-06-11 10:13:43.714912 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-06-11 10:13:43.969447 | controller | ok 2026-06-11 10:13:43.976999 | 2026-06-11 10:13:43.977121 | TASK [test-setup : Run tools/test-setup.sh] 2026-06-11 10:13:44.515863 | controller | skipping: Conditional result was False 2026-06-11 10:13:44.537939 | 2026-06-11 10:13:44.538075 | TASK [bindep : Remove bindep temp dir] 2026-06-11 10:13:44.936966 | controller | ok 2026-06-11 10:13:44.939677 | 2026-06-11 10:13:44.939779 | PLAY RECAP 2026-06-11 10:13:44.939863 | controller | ok: 23 changed: 6 unreachable: 0 failed: 0 skipped: 15 rescued: 0 ignored: 0 2026-06-11 10:13:44.939906 | 2026-06-11 10:13:45.107351 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-06-11 10:13:45.111054 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/run-test-command/run.yaml@master] 2026-06-11 10:13:45.713418 | 2026-06-11 10:13:45.713518 | PLAY [all] 2026-06-11 10:13:45.722102 | 2026-06-11 10:13:45.722173 | TASK [Abort when test_command variable is undefined] 2026-06-11 10:13:45.756558 | controller | skipping: Conditional result was False 2026-06-11 10:13:45.761029 | 2026-06-11 10:13:45.761102 | TASK [Convert test_command to list] 2026-06-11 10:13:45.815515 | controller | skipping: Conditional result was False 2026-06-11 10:13:45.823814 | 2026-06-11 10:13:45.823952 | TASK [Use test_command list] 2026-06-11 10:13:45.887223 | controller | ok 2026-06-11 10:13:45.897767 | 2026-06-11 10:13:45.897897 | LOOP [Run test_command] 2026-06-11 10:13:46.355845 | controller | no check to run 2026-06-11 10:13:46.356144 | controller | ok: Item: echo 'no check to run' Runtime: 0:00:00.004981 2026-06-11 10:13:46.366827 | 2026-06-11 10:13:46.367044 | PLAY RECAP 2026-06-11 10:13:46.367156 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-11 10:13:46.367255 | 2026-06-11 10:13:46.499754 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/run-test-command/run.yaml@master] 2026-06-11 10:13:46.502835 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-11 10:13:47.150931 | 2026-06-11 10:13:47.151035 | PLAY [all] 2026-06-11 10:13:47.161119 | 2026-06-11 10:13:47.161189 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-11 10:13:47.516007 | controller | changed: non-zero return code 2026-06-11 10:13:47.524634 | 2026-06-11 10:13:47.524797 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-11 10:13:47.552132 | controller | skipping: Conditional result was False 2026-06-11 10:13:47.564644 | 2026-06-11 10:13:47.564795 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-11 10:13:47.601562 | 2026-06-11 10:13:47.601875 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-11 10:13:47.646380 | 2026-06-11 10:13:47.646688 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-11 10:13:47.673391 | controller | skipping: Conditional result was False 2026-06-11 10:13:47.683384 | 2026-06-11 10:13:47.683525 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-11 10:13:47.720437 | 2026-06-11 10:13:47.720766 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-11 10:13:47.746366 | controller | skipping: Conditional result was False 2026-06-11 10:13:47.755034 | 2026-06-11 10:13:47.755172 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-11 10:13:47.781209 | controller | skipping: Conditional result was False 2026-06-11 10:13:47.789968 | 2026-06-11 10:13:47.790106 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-11 10:13:47.816182 | controller | skipping: Conditional result was False 2026-06-11 10:13:47.829438 | 2026-06-11 10:13:47.829543 | PLAY RECAP 2026-06-11 10:13:47.829667 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-11 10:13:47.829713 | 2026-06-11 10:13:47.965706 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-11 10:13:47.968006 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-06-11 10:13:48.610733 | 2026-06-11 10:13:48.610843 | PLAY [all] 2026-06-11 10:13:48.620371 | 2026-06-11 10:13:48.620443 | TASK [include_role : fetch-output] 2026-06-11 10:13:48.648537 | controller | ok 2026-06-11 10:13:48.663190 | 2026-06-11 10:13:48.663276 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-11 10:13:48.737445 | controller | skipping: Conditional result was False 2026-06-11 10:13:48.747801 | 2026-06-11 10:13:48.747948 | TASK [fetch-output : Set log path for single node] 2026-06-11 10:13:48.811034 | controller | ok 2026-06-11 10:13:48.816312 | 2026-06-11 10:13:48.816403 | LOOP [fetch-output : Ensure local output dirs] 2026-06-11 10:13:49.287535 | controller -> localhost | changed: "/var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/work/logs" 2026-06-11 10:13:49.534479 | controller -> localhost | changed: "/var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/work/artifacts" 2026-06-11 10:13:49.806329 | controller -> localhost | changed: "/var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/work/docs" 2026-06-11 10:13:49.821789 | 2026-06-11 10:13:49.821963 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-11 10:13:50.563880 | controller | changed: .d..t...... ./ 2026-06-11 10:13:50.564235 | controller | changed: All items complete 2026-06-11 10:13:50.564291 | 2026-06-11 10:13:51.123005 | controller | changed: .d..t...... ./ 2026-06-11 10:13:51.708546 | controller | changed: .d..t...... ./ 2026-06-11 10:13:51.726911 | 2026-06-11 10:13:51.727099 | TASK [include_role : fetch-output-openshift] 2026-06-11 10:13:51.755125 | controller | skipping: Conditional result was False 2026-06-11 10:13:51.764532 | 2026-06-11 10:13:51.764698 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-11 10:13:52.271932 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013489 2026-06-11 10:13:52.514679 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012816 2026-06-11 10:13:52.538612 | 2026-06-11 10:13:52.538756 | PLAY [all] 2026-06-11 10:13:52.548192 | 2026-06-11 10:13:52.548316 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-11 10:13:53.029254 | controller | changed 2026-06-11 10:13:53.038064 | 2026-06-11 10:13:53.038182 | PLAY RECAP 2026-06-11 10:13:53.038263 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-11 10:13:53.038305 | 2026-06-11 10:13:53.162836 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-06-11 10:13:53.164014 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-06-11 10:13:53.827528 | 2026-06-11 10:13:53.827727 | PLAY [localhost] 2026-06-11 10:13:53.837887 | 2026-06-11 10:13:53.837967 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-11 10:13:54.292206 | localhost | changed 2026-06-11 10:13:54.304567 | 2026-06-11 10:13:54.304779 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-11 10:13:54.343814 | localhost | ok 2026-06-11 10:13:54.352212 | 2026-06-11 10:13:54.352302 | TASK [add-fileserver : Create SSH private key tempfile] 2026-06-11 10:13:54.749214 | localhost | changed 2026-06-11 10:13:54.759790 | 2026-06-11 10:13:54.759926 | TASK [add-fileserver : Create SSH private key from secret] 2026-06-11 10:13:55.613825 | localhost | changed 2026-06-11 10:13:55.622952 | 2026-06-11 10:13:55.623092 | TASK [add-fileserver : Add fileserver ssh key] 2026-06-11 10:13:56.120804 | localhost | Identity added: /var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/work/tmp/ansible.di8sc2s2 (/var/lib/zuul/builds/840481fc75d54dcdb668c63ebd788433/work/tmp/ansible.di8sc2s2) 2026-06-11 10:13:56.121192 | localhost | ok: Runtime: 0:00:00.012472 2026-06-11 10:13:56.129257 | 2026-06-11 10:13:56.129416 | TASK [add-fileserver : Remove SSH private key from disk] 2026-06-11 10:13:56.453610 | localhost | ok: Runtime: 0:00:00.007130 2026-06-11 10:13:56.461376 | 2026-06-11 10:13:56.461511 | TASK [add-fileserver : Add fileserver to inventory] 2026-06-11 10:13:56.545731 | localhost | changed 2026-06-11 10:13:56.554869 | 2026-06-11 10:13:56.555004 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-06-11 10:13:57.035153 | localhost | changed 2026-06-11 10:13:57.046269 | 2026-06-11 10:13:57.046375 | PLAY [localhost] 2026-06-11 10:13:57.054439 | 2026-06-11 10:13:57.054561 | TASK [Generate bulk log download script] 2026-06-11 10:13:57.078974 | localhost | ok 2026-06-11 10:13:57.099497 | 2026-06-11 10:13:57.099660 | TASK [local-log-download : Check API endpoint is defined] 2026-06-11 10:13:57.139905 | localhost | ok: All assertions passed 2026-06-11 10:13:57.144540 | 2026-06-11 10:13:57.144651 | TASK [local-log-download : Create download script] 2026-06-11 10:13:57.786811 | localhost -> localhost | changed 2026-06-11 10:13:57.823358 | 2026-06-11 10:13:57.823491 | TASK [Register quick-download link] 2026-06-11 10:13:57.851378 | localhost | ok 2026-06-11 10:13:57.853383 | 2026-06-11 10:13:57.853434 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com] 2026-06-11 10:13:57.857901 | 2026-06-11 10:13:57.857956 | TASK [Set zuul-log-path fact] 2026-06-11 10:13:57.874404 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-11 10:13:57.880621 | 2026-06-11 10:13:57.880706 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-11 10:13:57.916440 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-11 10:13:57.918974 | 2026-06-11 10:13:57.919034 | TASK [upload-logs : Create log directories] 2026-06-11 10:13:58.856042 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed 2026-06-11 10:13:58.857699 | 2026-06-11 10:13:58.857761 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-11 10:13:59.156560 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.009675 2026-06-11 10:13:59.159677 | 2026-06-11 10:13:59.159744 | TASK [upload-logs : Upload logs to log server] 2026-06-11 10:14:00.436329 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | Output suppressed because no_log was given 2026-06-11 10:14:00.439432 | 2026-06-11 10:14:00.439565 | LOOP [upload-logs : Compress console log and json output]