2026-03-16 16:32:44.988701 | Job console starting... 2026-03-16 16:32:45.267039 | Updating repositories 2026-03-16 16:32:46.134462 | Preparing job workspace 2026-03-16 16:32:57.398840 | Running Ansible setup... 2026-03-16 16:33:02.849118 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-03-16 16:33:04.301804 | 2026-03-16 16:33:04.301906 | PLAY [localhost] 2026-03-16 16:33:04.325042 | 2026-03-16 16:33:04.325131 | TASK [Gathering Facts] 2026-03-16 16:33:06.892958 | localhost | ok 2026-03-16 16:33:06.930112 | 2026-03-16 16:33:06.930240 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 16:33:08.225182 | localhost -> localhost | changed 2026-03-16 16:33:08.238673 | 2026-03-16 16:33:08.238760 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 16:33:11.617015 | localhost -> localhost | changed 2026-03-16 16:33:11.626562 | 2026-03-16 16:33:11.626647 | TASK [Setup log path fact] 2026-03-16 16:33:11.674700 | localhost | ok 2026-03-16 16:33:11.737602 | 2026-03-16 16:33:11.737704 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:33:11.847738 | localhost | ok 2026-03-16 16:33:11.866975 | 2026-03-16 16:33:11.867053 | TASK [emit-job-header : Print job information] 2026-03-16 16:33:11.966603 | # Job Information 2026-03-16 16:33:11.966735 | Ansible Version: 2.15.12 2026-03-16 16:33:11.966766 | Job: cifmw-molecule-edpm_kustomize 2026-03-16 16:33:11.966789 | Pipeline: github-check 2026-03-16 16:33:11.966820 | Executor: ibm-bm4-ze.softwarefactory-project.io 2026-03-16 16:33:11.966839 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3770 2026-03-16 16:33:11.966860 | Log URL (when completed): https://logserver.rdoproject.org/cf6/rdoproject.org/cf677e770f674bd8a6a135d7bd48da34/ 2026-03-16 16:33:11.966881 | Event ID: 072a8580-2155-11f1-9026-7307b7bf6b98 2026-03-16 16:33:11.971232 | 2026-03-16 16:33:11.971329 | LOOP [emit-job-header : Print node information] 2026-03-16 16:33:12.309001 | localhost | ok: 2026-03-16 16:33:12.309214 | localhost | # Node Information 2026-03-16 16:33:12.309247 | localhost | Inventory Hostname: controller 2026-03-16 16:33:12.309272 | localhost | Hostname: np0005648776 2026-03-16 16:33:12.309311 | localhost | Username: zuul 2026-03-16 16:33:12.309341 | localhost | Distro: CentOS 9 2026-03-16 16:33:12.309363 | localhost | Provider: ibm-bm4-nodepool 2026-03-16 16:33:12.309382 | localhost | Region: regionOne 2026-03-16 16:33:12.309400 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2026-03-16 16:33:12.309418 | localhost | Product Name: OpenStack Compute 2026-03-16 16:33:12.309436 | localhost | Interface IP: 192.168.26.42 2026-03-16 16:33:12.355553 | 2026-03-16 16:33:12.355664 | PLAY [all] 2026-03-16 16:33:12.372948 | 2026-03-16 16:33:12.373020 | TASK [Gather network facts] 2026-03-16 16:33:12.801890 | controller | ok 2026-03-16 16:33:12.867008 | 2026-03-16 16:33:12.867117 | TASK [include_role : start-zuul-console] 2026-03-16 16:33:12.923256 | controller | ok 2026-03-16 16:33:12.958511 | 2026-03-16 16:33:12.958615 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 16:33:13.694695 | controller | ok 2026-03-16 16:33:13.717330 | 2026-03-16 16:33:13.717414 | TASK [include_role : add-build-sshkey] 2026-03-16 16:33:13.792173 | controller | ok 2026-03-16 16:33:13.824918 | 2026-03-16 16:33:13.824997 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:33:14.507931 | controller -> localhost | ok 2026-03-16 16:33:14.513449 | 2026-03-16 16:33:14.513525 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:33:14.565797 | controller | ok 2026-03-16 16:33:14.597436 | controller | included: /var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:33:14.611581 | 2026-03-16 16:33:14.611656 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:33:15.622411 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 16:33:15.622596 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/cf677e770f674bd8a6a135d7bd48da34_id_rsa. 2026-03-16 16:33:15.622631 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/cf677e770f674bd8a6a135d7bd48da34_id_rsa.pub. 2026-03-16 16:33:15.622656 | controller -> localhost | The key fingerprint is: 2026-03-16 16:33:15.622680 | controller -> localhost | SHA256:40p/D5p5Bmst9gmkS9NH1U5xukYv46Lr1tYAZp1URJU zuul-build-sshkey 2026-03-16 16:33:15.622702 | controller -> localhost | The key's randomart image is: 2026-03-16 16:33:15.622723 | controller -> localhost | +---[RSA 3072]----+ 2026-03-16 16:33:15.622743 | controller -> localhost | | +=.+| 2026-03-16 16:33:15.622762 | controller -> localhost | | .. E | 2026-03-16 16:33:15.622782 | controller -> localhost | | o..= | 2026-03-16 16:33:15.622802 | controller -> localhost | | +.o+ o | 2026-03-16 16:33:15.622825 | controller -> localhost | | So.. * .| 2026-03-16 16:33:15.622849 | controller -> localhost | | =.o .o o | 2026-03-16 16:33:15.622868 | controller -> localhost | | = ++o..o. | 2026-03-16 16:33:15.622888 | controller -> localhost | | o ==**+o.. | 2026-03-16 16:33:15.622907 | controller -> localhost | | oo=O*+. | 2026-03-16 16:33:15.622926 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:33:15.622969 | controller -> localhost | ok: Runtime: 0:00:00.232774 2026-03-16 16:33:15.632787 | 2026-03-16 16:33:15.632855 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:33:15.684402 | controller | ok 2026-03-16 16:33:15.708567 | controller | included: /var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:33:15.745713 | 2026-03-16 16:33:15.745822 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:33:15.769376 | controller | skipping: Conditional result was False 2026-03-16 16:33:15.776425 | 2026-03-16 16:33:15.776499 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:33:16.288523 | controller | changed 2026-03-16 16:33:16.298545 | 2026-03-16 16:33:16.298630 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:33:16.522507 | controller | ok 2026-03-16 16:33:16.527571 | 2026-03-16 16:33:16.527648 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:33:17.267922 | controller | changed 2026-03-16 16:33:17.274408 | 2026-03-16 16:33:17.274488 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:33:18.086644 | controller | changed 2026-03-16 16:33:18.095378 | 2026-03-16 16:33:18.101685 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:33:18.207140 | controller | skipping: Conditional result was False 2026-03-16 16:33:18.265640 | 2026-03-16 16:33:18.265738 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:33:18.913024 | controller -> localhost | changed 2026-03-16 16:33:18.927731 | 2026-03-16 16:33:18.927810 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:33:19.797827 | controller -> localhost | Identity added: /var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/cf677e770f674bd8a6a135d7bd48da34_id_rsa (zuul-build-sshkey) 2026-03-16 16:33:19.798026 | controller -> localhost | ok: Runtime: 0:00:00.023116 2026-03-16 16:33:19.803846 | 2026-03-16 16:33:19.803916 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:33:20.242164 | controller | ok 2026-03-16 16:33:20.250114 | 2026-03-16 16:33:20.250193 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:33:20.336857 | controller | skipping: Conditional result was False 2026-03-16 16:33:20.346992 | 2026-03-16 16:33:20.347091 | TASK [include_role : validate-host] 2026-03-16 16:33:20.408987 | controller | ok 2026-03-16 16:33:20.455409 | 2026-03-16 16:33:20.455503 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-16 16:33:20.537044 | controller | ok 2026-03-16 16:33:20.542038 | 2026-03-16 16:33:20.542121 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-16 16:33:21.316046 | controller -> localhost | ok 2026-03-16 16:33:21.323084 | 2026-03-16 16:33:21.323171 | TASK [validate-host : Collect information about the host] 2026-03-16 16:33:22.014265 | controller | ok 2026-03-16 16:33:22.034812 | 2026-03-16 16:33:22.034881 | TASK [validate-host : Sanitize hostname] 2026-03-16 16:33:22.201723 | controller | ok 2026-03-16 16:33:22.212379 | 2026-03-16 16:33:22.212455 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-16 16:33:23.189138 | controller -> localhost | changed 2026-03-16 16:33:23.194681 | 2026-03-16 16:33:23.194766 | TASK [validate-host : Collect information about zuul worker] 2026-03-16 16:33:23.766620 | controller | ok 2026-03-16 16:33:23.777685 | 2026-03-16 16:33:23.777801 | TASK [validate-host : Write out all zuul information for each host] 2026-03-16 16:33:24.791396 | controller -> localhost | changed 2026-03-16 16:33:24.808104 | 2026-03-16 16:33:24.808232 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 16:33:24.865766 | controller | skipping: Conditional result was False 2026-03-16 16:33:24.871433 | 2026-03-16 16:33:24.871507 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 16:33:24.895368 | controller | skipping: Conditional result was False 2026-03-16 16:33:24.901080 | 2026-03-16 16:33:24.901152 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 16:33:25.176492 | controller | ok: "logs" 2026-03-16 16:33:25.176700 | controller | ok: All items complete 2026-03-16 16:33:25.176733 | 2026-03-16 16:33:25.358990 | controller | ok: "artifacts" 2026-03-16 16:33:25.533101 | controller | ok: "docs" 2026-03-16 16:33:25.540423 | 2026-03-16 16:33:25.540524 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 16:33:25.739871 | controller | changed: "logs" 2026-03-16 16:33:25.926936 | controller | changed: "artifacts" 2026-03-16 16:33:26.107038 | controller | changed: "docs" 2026-03-16 16:33:26.176515 | 2026-03-16 16:33:26.176607 | PLAY RECAP 2026-03-16 16:33:26.176660 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-16 16:33:26.176701 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:33:26.176724 | 2026-03-16 16:33:26.314851 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-03-16 16:33:26.315634 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-03-16 16:33:27.170460 | 2026-03-16 16:33:27.170584 | PLAY [all] 2026-03-16 16:33:27.210844 | 2026-03-16 16:33:27.210930 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-03-16 16:33:27.262517 | controller | ok 2026-03-16 16:33:27.269801 | 2026-03-16 16:33:27.269908 | TASK [mirror-info-fork : Create /etc/ci] 2026-03-16 16:33:27.803616 | controller | changed 2026-03-16 16:33:27.820657 | 2026-03-16 16:33:27.820751 | TASK [mirror-info-fork : Install ci_mirror script] 2026-03-16 16:33:28.986190 | controller | changed 2026-03-16 16:33:29.016856 | 2026-03-16 16:33:29.016951 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2026-03-16 16:33:29.549908 | controller | changed: 2026-03-16 16:33:29.550097 | controller | { 2026-03-16 16:33:29.550142 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2026-03-16 16:33:29.550176 | controller | } 2026-03-16 16:33:29.764475 | controller | changed: 2026-03-16 16:33:29.764579 | controller | { 2026-03-16 16:33:29.764613 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2026-03-16 16:33:29.764638 | controller | } 2026-03-16 16:33:29.969757 | controller | changed: 2026-03-16 16:33:29.969838 | controller | { 2026-03-16 16:33:29.969869 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2026-03-16 16:33:29.969893 | controller | } 2026-03-16 16:33:30.186830 | controller | changed: 2026-03-16 16:33:30.186928 | controller | { 2026-03-16 16:33:30.186959 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2026-03-16 16:33:30.186983 | controller | } 2026-03-16 16:33:30.394838 | controller | changed: 2026-03-16 16:33:30.394931 | controller | { 2026-03-16 16:33:30.394961 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2026-03-16 16:33:30.394983 | controller | } 2026-03-16 16:33:30.605345 | controller | changed: 2026-03-16 16:33:30.605442 | controller | { 2026-03-16 16:33:30.605473 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2026-03-16 16:33:30.605497 | controller | } 2026-03-16 16:33:30.824743 | controller | changed: 2026-03-16 16:33:30.824836 | controller | { 2026-03-16 16:33:30.824867 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen" 2026-03-16 16:33:30.824891 | controller | } 2026-03-16 16:33:31.060738 | controller | changed: 2026-03-16 16:33:31.060832 | controller | { 2026-03-16 16:33:31.060939 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora" 2026-03-16 16:33:31.060968 | controller | } 2026-03-16 16:33:31.287542 | controller | changed: 2026-03-16 16:33:31.287643 | controller | { 2026-03-16 16:33:31.287674 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2026-03-16 16:33:31.287698 | controller | } 2026-03-16 16:33:31.524881 | controller | changed: 2026-03-16 16:33:31.524964 | controller | { 2026-03-16 16:33:31.524993 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2026-03-16 16:33:31.525015 | controller | } 2026-03-16 16:33:31.761435 | controller | changed: 2026-03-16 16:33:31.761510 | controller | { 2026-03-16 16:33:31.761538 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2026-03-16 16:33:31.761559 | controller | } 2026-03-16 16:33:31.926183 | controller | changed: 2026-03-16 16:33:31.926276 | controller | { 2026-03-16 16:33:31.926343 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2026-03-16 16:33:31.926371 | controller | } 2026-03-16 16:33:32.154439 | controller | changed: 2026-03-16 16:33:32.154531 | controller | { 2026-03-16 16:33:32.154561 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com" 2026-03-16 16:33:32.154584 | controller | } 2026-03-16 16:33:32.369154 | controller | changed: 2026-03-16 16:33:32.369233 | controller | { 2026-03-16 16:33:32.369262 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2026-03-16 16:33:32.369287 | controller | } 2026-03-16 16:33:32.588026 | controller | changed: 2026-03-16 16:33:32.588125 | controller | { 2026-03-16 16:33:32.588154 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2026-03-16 16:33:32.588176 | controller | } 2026-03-16 16:33:32.796616 | controller | changed: 2026-03-16 16:33:32.796699 | controller | { 2026-03-16 16:33:32.796728 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2026-03-16 16:33:32.796751 | controller | } 2026-03-16 16:33:33.006625 | controller | changed: 2026-03-16 16:33:33.006712 | controller | { 2026-03-16 16:33:33.006741 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com" 2026-03-16 16:33:33.006764 | controller | } 2026-03-16 16:33:33.233251 | controller | changed: 2026-03-16 16:33:33.233344 | controller | { 2026-03-16 16:33:33.233374 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb" 2026-03-16 16:33:33.233404 | controller | } 2026-03-16 16:33:33.439149 | controller | changed: 2026-03-16 16:33:33.439236 | controller | { 2026-03-16 16:33:33.439267 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2026-03-16 16:33:33.439290 | controller | } 2026-03-16 16:33:33.645919 | controller | changed: 2026-03-16 16:33:33.646001 | controller | { 2026-03-16 16:33:33.646031 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2026-03-16 16:33:33.646054 | controller | } 2026-03-16 16:33:33.847703 | controller | changed: 2026-03-16 16:33:33.847813 | controller | { 2026-03-16 16:33:33.847850 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2026-03-16 16:33:33.847879 | controller | } 2026-03-16 16:33:34.051804 | controller | changed: 2026-03-16 16:33:34.051886 | controller | { 2026-03-16 16:33:34.051916 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2026-03-16 16:33:34.051939 | controller | } 2026-03-16 16:33:34.249331 | controller | changed: 2026-03-16 16:33:34.249425 | controller | { 2026-03-16 16:33:34.249457 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com" 2026-03-16 16:33:34.249482 | controller | } 2026-03-16 16:33:34.463934 | controller | changed: 2026-03-16 16:33:34.464010 | controller | { 2026-03-16 16:33:34.464039 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2026-03-16 16:33:34.464072 | controller | } 2026-03-16 16:33:34.664992 | controller | changed: 2026-03-16 16:33:34.665080 | controller | { 2026-03-16 16:33:34.665111 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2026-03-16 16:33:34.665135 | controller | } 2026-03-16 16:33:34.885209 | controller | changed: 2026-03-16 16:33:34.885312 | controller | { 2026-03-16 16:33:34.885350 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2026-03-16 16:33:34.885375 | controller | } 2026-03-16 16:33:34.925185 | 2026-03-16 16:33:34.925391 | TASK [Set timezone to UTC] 2026-03-16 16:33:35.565516 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2026-03-16 16:33:35.570634 | 2026-03-16 16:33:35.570709 | TASK [Create nodepool directory] 2026-03-16 16:33:35.790230 | controller | changed 2026-03-16 16:33:35.797591 | 2026-03-16 16:33:35.797675 | TASK [Create nodepool sub_nodes file] 2026-03-16 16:33:36.452026 | controller | changed 2026-03-16 16:33:36.466126 | 2026-03-16 16:33:36.466213 | TASK [Create nodepool sub_nodes_private file] 2026-03-16 16:33:37.201394 | controller | changed 2026-03-16 16:33:37.211994 | 2026-03-16 16:33:37.212095 | LOOP [Populate nodepool sub_nodes file] 2026-03-16 16:33:37.295765 | 2026-03-16 16:33:37.295908 | LOOP [Populate nodepool sub_nodes_private file] 2026-03-16 16:33:37.359480 | 2026-03-16 16:33:37.359627 | TASK [Create nodepool primary file] 2026-03-16 16:33:37.413824 | controller | skipping: Conditional result was False 2026-03-16 16:33:37.421924 | 2026-03-16 16:33:37.422008 | TASK [Create nodepool node_private for this node] 2026-03-16 16:33:38.094364 | controller | changed 2026-03-16 16:33:38.100932 | 2026-03-16 16:33:38.101008 | LOOP [Copy ssh keys to nodepool directory] 2026-03-16 16:33:38.583761 | controller | ok: Item: id_rsa Runtime: 0:00:00.004513 2026-03-16 16:33:38.583942 | 2026-03-16 16:33:38.762485 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004791 2026-03-16 16:33:38.772153 | 2026-03-16 16:33:38.772283 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2026-03-16 16:33:39.451549 | controller | changed 2026-03-16 16:33:39.460491 | 2026-03-16 16:33:39.460564 | TASK [Validate sudoers config after edits] 2026-03-16 16:33:39.762117 | controller | /etc/sudoers: parsed OK 2026-03-16 16:33:39.762173 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2026-03-16 16:33:39.762182 | controller | /etc/sudoers.d/zuul: parsed OK 2026-03-16 16:33:39.762188 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2026-03-16 16:33:40.048694 | controller | ok: Runtime: 0:00:00.005776 2026-03-16 16:33:40.054190 | 2026-03-16 16:33:40.054255 | TASK [Show the environment passed in to job shell scripts] 2026-03-16 16:33:40.372832 | controller | SHELL=/bin/bash 2026-03-16 16:33:40.372884 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2026-03-16 16:33:40.372895 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2026-03-16 16:33:40.372902 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/70/3770/235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:33:40.372907 | controller | PWD=/home/zuul 2026-03-16 16:33:40.372954 | controller | ZUUL_PIPELINE=github-check 2026-03-16 16:33:40.372963 | controller | LOGNAME=zuul 2026-03-16 16:33:40.372968 | controller | XDG_SESSION_TYPE=tty 2026-03-16 16:33:40.372974 | controller | _=/usr/bin/env 2026-03-16 16:33:40.372980 | controller | MOTD_SHOWN=pam 2026-03-16 16:33:40.372985 | controller | HOME=/home/zuul 2026-03-16 16:33:40.372990 | controller | LANG=en_US.UTF-8 2026-03-16 16:33:40.372995 | controller | SSH_CONNECTION=192.168.26.12 39832 192.168.26.42 22 2026-03-16 16:33:40.373001 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET 2026-03-16 16:33:40.373010 | controller | ZUUL_CHANGE_IDS=3770,235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:33:40.373015 | controller | WORKSPACE=/home/zuul/workspace 2026-03-16 16:33:40.373021 | controller | XDG_SESSION_CLASS=user 2026-03-16 16:33:40.373026 | controller | SELINUX_ROLE_REQUESTED= 2026-03-16 16:33:40.373032 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2026-03-16 16:33:40.373037 | controller | USER=zuul 2026-03-16 16:33:40.373042 | controller | ZUUL_VOTING=True 2026-03-16 16:33:40.373048 | controller | BUILD_TIMEOUT=1800000 2026-03-16 16:33:40.373053 | controller | SELINUX_USE_CURRENT_RANGE= 2026-03-16 16:33:40.373058 | controller | SHLVL=1 2026-03-16 16:33:40.373064 | controller | ZUUL_PATCHSET=235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:33:40.373069 | controller | XDG_SESSION_ID=1 2026-03-16 16:33:40.373074 | controller | ZUUL_BRANCH=main 2026-03-16 16:33:40.373080 | controller | XDG_RUNTIME_DIR=/run/user/1000 2026-03-16 16:33:40.373085 | controller | SSH_CLIENT=192.168.26.12 39832 22 2026-03-16 16:33:40.373090 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2026-03-16 16:33:40.373109 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2026-03-16 16:33:40.373119 | controller | which_declare=declare -f 2026-03-16 16:33:40.373125 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-16 16:33:40.373130 | controller | SELINUX_LEVEL_REQUESTED= 2026-03-16 16:33:40.373136 | controller | ZUUL_CHANGE=3770 2026-03-16 16:33:40.373143 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2026-03-16 16:33:40.373148 | controller | ZUUL_UUID=cf677e770f674bd8a6a135d7bd48da34 2026-03-16 16:33:40.373153 | controller | BASH_FUNC_which%%=() { ( alias; 2026-03-16 16:33:40.373160 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2026-03-16 16:33:40.373166 | controller | } 2026-03-16 16:33:40.623006 | controller | ok: Runtime: 0:00:00.006672 2026-03-16 16:33:40.629054 | 2026-03-16 16:33:40.629138 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2026-03-16 16:33:40.673530 | controller | skipping: Conditional result was False 2026-03-16 16:33:40.679840 | 2026-03-16 16:33:40.679932 | TASK [Symlink /home/zuul-worker/workspace] 2026-03-16 16:33:41.276213 | controller | skipping: Conditional result was False 2026-03-16 16:33:41.282732 | 2026-03-16 16:33:41.282828 | TASK [Ensure legacy workspace directory] 2026-03-16 16:33:41.560119 | controller | changed 2026-03-16 16:33:41.696874 | 2026-03-16 16:33:41.696953 | PLAY RECAP 2026-03-16 16:33:41.697003 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-16 16:33:41.697028 | 2026-03-16 16:33:41.785079 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-03-16 16:33:41.785872 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-03-16 16:33:43.325667 | 2026-03-16 16:33:43.325781 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2026-03-16 16:33:43.391680 | 2026-03-16 16:33:43.401405 | TASK [Create zuul-output directory] 2026-03-16 16:33:43.853765 | controller | changed 2026-03-16 16:33:43.873220 | 2026-03-16 16:33:43.876391 | TASK [Slurp Zuul inventory test] 2026-03-16 16:33:44.916939 | controller -> localhost | ok 2026-03-16 16:33:44.926633 | 2026-03-16 16:33:44.926753 | TASK [Save zuul inventory] 2026-03-16 16:33:45.938427 | controller | changed 2026-03-16 16:33:45.944353 | 2026-03-16 16:33:45.944431 | TASK [Save zuul vars without the change_message] 2026-03-16 16:33:46.793595 | controller | changed 2026-03-16 16:33:46.856000 | 2026-03-16 16:33:46.856085 | PLAY RECAP 2026-03-16 16:33:46.856137 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:33:46.856162 | 2026-03-16 16:33:46.989054 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-03-16 16:33:46.989847 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-03-16 16:33:48.222794 | 2026-03-16 16:33:48.222912 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2026-03-16 16:33:48.283467 | 2026-03-16 16:33:48.283579 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2026-03-16 16:33:48.337195 | controller | ok 2026-03-16 16:33:48.380944 | 2026-03-16 16:33:48.381081 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-03-16 16:33:48.420183 | controller | skipping: Conditional result was False 2026-03-16 16:33:48.426118 | 2026-03-16 16:33:48.426211 | TASK [mirror-info-fork : Create /etc/ci] 2026-03-16 16:33:48.928051 | controller | ok 2026-03-16 16:33:48.943286 | 2026-03-16 16:33:48.943626 | TASK [mirror-info-fork : Install ci_mirror script] 2026-03-16 16:33:49.655881 | controller | ok 2026-03-16 16:33:49.666744 | 2026-03-16 16:33:49.666828 | TASK [Prepare workspace] 2026-03-16 16:33:49.684765 | controller | ok 2026-03-16 16:33:49.701774 | 2026-03-16 16:33:49.701851 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 16:33:50.055362 | controller | ok 2026-03-16 16:33:50.062312 | 2026-03-16 16:33:50.062403 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 16:33:54.565582 | controller | Output suppressed because no_log was given 2026-03-16 16:33:54.578848 | 2026-03-16 16:33:54.578945 | LOOP [Create zuul-output directory] 2026-03-16 16:33:54.799559 | controller | changed: "/home/zuul/ci-framework-data/logs" 2026-03-16 16:33:54.974026 | controller | ok: "/home/zuul/zuul-output/logs" 2026-03-16 16:33:54.984796 | 2026-03-16 16:33:54.984897 | TASK [Install required packages] 2026-03-16 16:34:32.070945 | controller | changed 2026-03-16 16:34:32.076356 | 2026-03-16 16:34:32.076433 | TASK [Install venv] 2026-03-16 16:34:46.302543 | controller | ERROR 2026-03-16 16:34:46.302750 | controller | { 2026-03-16 16:34:46.302790 | controller | "msg": "gmake: *** [Makefile:56: setup_tests] Error 1", 2026-03-16 16:34:46.302815 | controller | "rc": 2 2026-03-16 16:34:46.302835 | controller | } failure 2026-03-16 16:34:46.309420 | 2026-03-16 16:34:46.309489 | PLAY RECAP 2026-03-16 16:34:46.309541 | controller | ok: 6 changed: 3 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0 2026-03-16 16:34:46.309569 | 2026-03-16 16:34:46.595393 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-03-16 16:34:46.596278 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-03-16 16:34:47.820010 | 2026-03-16 16:34:47.820139 | PLAY [Run ci/playbooks/collect-logs.yml] 2026-03-16 16:34:47.866803 | 2026-03-16 16:34:47.866930 | TASK [Filter out host if needed] 2026-03-16 16:34:47.885531 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2026-03-16 16:34:47.890191 | 2026-03-16 16:34:47.890265 | TASK [Ensure file is present] 2026-03-16 16:34:48.269153 | controller | ok 2026-03-16 16:34:48.278339 | 2026-03-16 16:34:48.278437 | TASK [Manage molecule report file] 2026-03-16 16:34:48.813623 | controller | skipping: Conditional result was False 2026-03-16 16:34:48.819269 | 2026-03-16 16:34:48.819366 | TASK [Check if we get ci-framework-data basedir] 2026-03-16 16:34:49.005755 | controller | ok 2026-03-16 16:34:49.010868 | 2026-03-16 16:34:49.010943 | TASK [Create ci-framework-data log directory for zuul] 2026-03-16 16:34:49.371815 | controller | changed 2026-03-16 16:34:49.380853 | 2026-03-16 16:34:49.380978 | TASK [Copy ci-framework interesting files] 2026-03-16 16:34:49.778577 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2026-03-16 16:34:49.908412 | controller | changed 2026-03-16 16:34:49.913714 | 2026-03-16 16:34:49.913793 | TASK [Get SELinux listing] 2026-03-16 16:34:50.436398 | controller | changed 2026-03-16 16:34:50.442359 | 2026-03-16 16:34:50.442443 | TASK [Generate log index] 2026-03-16 16:34:51.297512 | controller | changed 2026-03-16 16:34:51.303001 | 2026-03-16 16:34:51.303095 | TASK [Get some env related data] 2026-03-16 16:34:52.349992 | controller | changed 2026-03-16 16:34:52.355783 | 2026-03-16 16:34:52.355866 | TASK [Generate list of logs to collect in home directory] 2026-03-16 16:34:52.809663 | controller | ok: All paths examined 2026-03-16 16:34:52.818779 | 2026-03-16 16:34:52.818857 | LOOP [Copy logs from home directory] 2026-03-16 16:34:52.870745 | 2026-03-16 16:34:52.870876 | TASK [Copy crio stats log file] 2026-03-16 16:34:52.914563 | controller | skipping: Conditional result was False 2026-03-16 16:34:52.922048 | 2026-03-16 16:34:52.922130 | TASK [Get SELinux related data] 2026-03-16 16:34:53.325829 | controller | 2026-03-16 16:34:53.581020 | controller | ERROR 2026-03-16 16:34:53.581202 | controller | { 2026-03-16 16:34:53.581237 | controller | "delta": "0:00:00.009753", 2026-03-16 16:34:53.581261 | controller | "end": "2026-03-16 16:34:53.326400", 2026-03-16 16:34:53.581281 | controller | "msg": "non-zero return code", 2026-03-16 16:34:53.581322 | controller | "rc": 1, 2026-03-16 16:34:53.581346 | controller | "start": "2026-03-16 16:34:53.316647" 2026-03-16 16:34:53.581365 | controller | } 2026-03-16 16:34:53.581391 | controller | ERROR: Ignoring Errors 2026-03-16 16:34:53.586531 | 2026-03-16 16:34:53.586595 | TASK [Create system configuration directory] 2026-03-16 16:34:53.820463 | controller | changed 2026-03-16 16:34:53.827722 | 2026-03-16 16:34:53.827788 | TASK [Get some of the system configurations] 2026-03-16 16:34:54.380073 | controller | changed 2026-03-16 16:34:54.385407 | 2026-03-16 16:34:54.385472 | TASK [Copy generated documentation if available] 2026-03-16 16:34:54.419001 | controller | skipping: Conditional result was False 2026-03-16 16:34:54.425543 | 2026-03-16 16:34:54.425607 | TASK [Copy generated AsciiDoc documentation if available] 2026-03-16 16:34:54.462599 | controller | skipping: Conditional result was False 2026-03-16 16:34:54.467987 | 2026-03-16 16:34:54.468049 | TASK [Compress logs bigger than 2MB] 2026-03-16 16:34:55.065427 | controller | changed 2026-03-16 16:34:55.072260 | 2026-03-16 16:34:55.072365 | TASK [Copy files from workspace on node] 2026-03-16 16:34:55.121253 | controller | ok 2026-03-16 16:34:55.179561 | 2026-03-16 16:34:55.179663 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:34:55.220452 | controller | skipping: Conditional result was False 2026-03-16 16:34:55.227022 | 2026-03-16 16:34:55.227121 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:34:55.289420 | controller | ok 2026-03-16 16:34:55.295858 | 2026-03-16 16:34:55.296001 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:34:55.851641 | controller -> localhost | ok: "/var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/logs" 2026-03-16 16:34:55.851867 | 2026-03-16 16:34:56.338114 | controller -> localhost | changed: "/var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/artifacts" 2026-03-16 16:34:56.773634 | controller -> localhost | changed: "/var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/docs" 2026-03-16 16:34:56.786484 | 2026-03-16 16:34:56.786589 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:34:58.096468 | controller | changed: 2026-03-16 16:34:58.096642 | controller | .d..t...... ./ 2026-03-16 16:34:58.096674 | controller | >f+++++++++ README.html 2026-03-16 16:34:58.096697 | controller | >f+++++++++ dmesg.log 2026-03-16 16:34:58.096720 | controller | >f+++++++++ installed-pkgs.log 2026-03-16 16:34:58.096743 | controller | >f+++++++++ python.log 2026-03-16 16:34:58.096762 | controller | >f+++++++++ registries.conf 2026-03-16 16:34:58.096781 | controller | >f+++++++++ selinux-denials.log 2026-03-16 16:34:58.096799 | controller | >f+++++++++ selinux-listing.log 2026-03-16 16:34:58.096817 | controller | cd+++++++++ ci-framework-data/ 2026-03-16 16:34:58.096835 | controller | cd+++++++++ ci-framework-data/artifacts/ 2026-03-16 16:34:58.096853 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2026-03-16 16:34:58.096871 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2026-03-16 16:34:58.096960 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2026-03-16 16:34:58.096995 | controller | cd+++++++++ ci-framework-data/logs/ 2026-03-16 16:34:58.097018 | controller | cd+++++++++ registries.conf.d/ 2026-03-16 16:34:58.097038 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2026-03-16 16:34:58.097076 | controller | cd+++++++++ system-config/ 2026-03-16 16:34:58.097097 | controller | cd+++++++++ system-config/libvirt/ 2026-03-16 16:34:58.097116 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2026-03-16 16:34:58.097133 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2026-03-16 16:34:59.160742 | controller | changed: .d..t...... ./ 2026-03-16 16:34:59.963279 | controller | changed: .d..t...... ./ 2026-03-16 16:34:59.991187 | 2026-03-16 16:34:59.991313 | TASK [Return artifact to Zuul] 2026-03-16 16:35:00.045175 | controller | skipping: Conditional result was False 2026-03-16 16:35:00.076582 | 2026-03-16 16:35:00.076677 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2026-03-16 16:35:00.076879 | 2026-03-16 16:35:00.078349 | PLAY RECAP 2026-03-16 16:35:00.078410 | controller | ok: 15 changed: 11 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 1 2026-03-16 16:35:00.078437 | 2026-03-16 16:35:00.311559 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-03-16 16:35:00.312365 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-03-16 16:35:01.224339 | 2026-03-16 16:35:01.224443 | PLAY [all] 2026-03-16 16:35:01.264496 | 2026-03-16 16:35:01.264586 | TASK [include_role : fetch-output] 2026-03-16 16:35:01.337107 | controller | ok 2026-03-16 16:35:01.355470 | 2026-03-16 16:35:01.355571 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:35:01.419698 | controller | skipping: Conditional result was False 2026-03-16 16:35:01.439871 | 2026-03-16 16:35:01.439958 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:35:01.518142 | controller | ok 2026-03-16 16:35:01.523981 | 2026-03-16 16:35:01.524084 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:35:02.333209 | controller -> localhost | ok: "/var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/logs" 2026-03-16 16:35:02.883142 | controller -> localhost | ok: "/var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/artifacts" 2026-03-16 16:35:03.490338 | controller -> localhost | ok: "/var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/docs" 2026-03-16 16:35:03.504640 | 2026-03-16 16:35:03.504743 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:35:04.899079 | controller | ok 2026-03-16 16:35:04.899410 | controller | ok: All items complete 2026-03-16 16:35:04.899459 | 2026-03-16 16:35:05.957092 | controller | ok 2026-03-16 16:35:07.045893 | controller | ok 2026-03-16 16:35:07.068633 | 2026-03-16 16:35:07.068724 | TASK [include_role : fetch-output-openshift] 2026-03-16 16:35:07.129740 | controller | skipping: Conditional result was False 2026-03-16 16:35:07.135767 | 2026-03-16 16:35:07.135849 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 16:35:08.649320 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.074159 2026-03-16 16:35:09.490808 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.073366 2026-03-16 16:35:09.558660 | 2026-03-16 16:35:09.558762 | PLAY [all] 2026-03-16 16:35:09.587518 | 2026-03-16 16:35:09.587589 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-16 16:35:10.298440 | controller | changed 2026-03-16 16:35:10.336904 | 2026-03-16 16:35:10.336978 | PLAY RECAP 2026-03-16 16:35:10.337025 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-03-16 16:35:10.337050 | 2026-03-16 16:35:10.503433 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-03-16 16:35:10.504176 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-03-16 16:35:12.227227 | 2026-03-16 16:35:12.238244 | PLAY [localhost] 2026-03-16 16:35:12.288174 | 2026-03-16 16:35:12.288282 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 16:35:13.392543 | localhost | changed 2026-03-16 16:35:13.397240 | 2026-03-16 16:35:13.397358 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 16:35:13.481341 | localhost | ok 2026-03-16 16:35:13.495495 | 2026-03-16 16:35:13.495579 | TASK [add-fileserver : Create SSH private key tempfile] 2026-03-16 16:35:14.630913 | localhost | changed 2026-03-16 16:35:14.635657 | 2026-03-16 16:35:14.635735 | TASK [add-fileserver : Create SSH private key from secret] 2026-03-16 16:35:17.003803 | localhost | changed 2026-03-16 16:35:17.008937 | 2026-03-16 16:35:17.009007 | TASK [add-fileserver : Add fileserver ssh key] 2026-03-16 16:35:18.098157 | localhost | Identity added: /var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/tmp/ansible.u94g42tr (/var/lib/zuul/builds/cf677e770f674bd8a6a135d7bd48da34/work/tmp/ansible.u94g42tr) 2026-03-16 16:35:18.098366 | localhost | ok: Runtime: 0:00:00.033884 2026-03-16 16:35:18.104365 | 2026-03-16 16:35:18.104443 | TASK [add-fileserver : Remove SSH private key from disk] 2026-03-16 16:35:18.891889 | localhost | ok: Runtime: 0:00:00.032470 2026-03-16 16:35:18.905111 | 2026-03-16 16:35:18.905203 | TASK [add-fileserver : Add fileserver to inventory] 2026-03-16 16:35:19.080031 | localhost | changed 2026-03-16 16:35:19.084399 | 2026-03-16 16:35:19.084473 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-03-16 16:35:20.134701 | localhost | changed 2026-03-16 16:35:20.278796 | 2026-03-16 16:35:20.278918 | PLAY [localhost] 2026-03-16 16:35:20.297910 | 2026-03-16 16:35:20.297975 | TASK [Generate bulk log download script] 2026-03-16 16:35:20.348244 | localhost | ok 2026-03-16 16:35:20.365436 | 2026-03-16 16:35:20.365515 | TASK [local-log-download : Check API endpoint is defined] 2026-03-16 16:35:20.407619 | localhost | ok: All assertions passed 2026-03-16 16:35:20.416737 | 2026-03-16 16:35:20.416817 | TASK [local-log-download : Create download script] 2026-03-16 16:35:21.461691 | localhost -> localhost | changed 2026-03-16 16:35:21.471456 | 2026-03-16 16:35:21.471540 | TASK [Register quick-download link] 2026-03-16 16:35:21.543515 | localhost | ok 2026-03-16 16:35:21.583237 | 2026-03-16 16:35:21.583329 | PLAY [logserver.rdoproject.org] 2026-03-16 16:35:21.616956 | 2026-03-16 16:35:21.617027 | TASK [Set zuul-log-path fact] 2026-03-16 16:35:21.658645 | logserver.rdoproject.org | ok 2026-03-16 16:35:21.670358 | 2026-03-16 16:35:21.670435 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:35:21.810289 | logserver.rdoproject.org | ok 2026-03-16 16:35:21.816957 | 2026-03-16 16:35:21.817047 | TASK [upload-logs : Create log directories] 2026-03-16 16:35:23.701448 | logserver.rdoproject.org | changed 2026-03-16 16:35:23.705037 | 2026-03-16 16:35:23.705122 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-16 16:35:24.655623 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.026554 2026-03-16 16:35:24.661770 | 2026-03-16 16:35:24.661859 | TASK [upload-logs : Upload logs to log server] 2026-03-16 16:35:27.174443 | logserver.rdoproject.org | Output suppressed because no_log was given 2026-03-16 16:35:27.177591 | 2026-03-16 16:35:27.177664 | LOOP [upload-logs : Compress console log and json output] 2026-03-16 16:35:27.250949 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:35:27.257953 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:35:27.268467 | 2026-03-16 16:35:27.268558 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-16 16:35:27.382268 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:35:27.382501 | 2026-03-16 16:35:27.384514 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:35:27.399515 | 2026-03-16 16:35:27.399621 | LOOP [upload-logs : Upload console log and json output]