2025-12-05 12:59:39.857666 | Job console starting... 2025-12-05 12:59:39.868184 | Updating repositories 2025-12-05 12:59:39.966596 | Preparing job workspace 2025-12-05 12:59:50.144221 | Running Ansible setup... 2025-12-05 12:59:55.462708 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-12-05 12:59:56.075162 | 2025-12-05 12:59:56.075333 | PLAY [localhost] 2025-12-05 12:59:56.084526 | 2025-12-05 12:59:56.084596 | TASK [Gathering Facts] 2025-12-05 12:59:57.193276 | localhost | ok 2025-12-05 12:59:57.211137 | 2025-12-05 12:59:57.211243 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-05 12:59:57.631240 | localhost -> localhost | changed 2025-12-05 12:59:57.636864 | 2025-12-05 12:59:57.636935 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-05 12:59:58.486895 | localhost -> localhost | changed 2025-12-05 12:59:58.495556 | 2025-12-05 12:59:58.495629 | TASK [Setup log path fact] 2025-12-05 12:59:58.520027 | localhost | ok 2025-12-05 12:59:58.532029 | 2025-12-05 12:59:58.532096 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 12:59:58.559320 | localhost | ok 2025-12-05 12:59:58.567921 | 2025-12-05 12:59:58.568015 | TASK [emit-job-header : Print job information] 2025-12-05 12:59:58.606063 | # Job Information 2025-12-05 12:59:58.606186 | Ansible Version: 2.15.12 2025-12-05 12:59:58.606211 | Job: cifmw-crc-podified-edpm-baremetal-minor-update 2025-12-05 12:59:58.606231 | Pipeline: github-check 2025-12-05 12:59:58.606249 | Executor: ze04.softwarefactory-project.io 2025-12-05 12:59:58.606267 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3537 2025-12-05 12:59:58.606286 | Log URL (when completed): https://logserver.rdoproject.org/d74/rdoproject.org/d74a4c9aa6fe4096aae18ec3883082ca/ 2025-12-05 12:59:58.606304 | Event ID: 34e04720-d1d8-11f0-9d3d-e934a308552e 2025-12-05 12:59:58.609993 | 2025-12-05 12:59:58.610058 | LOOP [emit-job-header : Print node information] 2025-12-05 12:59:58.708972 | localhost | ok: 2025-12-05 12:59:58.709131 | localhost | # Node Information 2025-12-05 12:59:58.709157 | localhost | Inventory Hostname: controller 2025-12-05 12:59:58.709182 | localhost | Hostname: np0005547059 2025-12-05 12:59:58.709201 | localhost | Username: zuul 2025-12-05 12:59:58.709222 | localhost | Distro: CentOS 9 2025-12-05 12:59:58.709239 | localhost | Provider: vexxhost-nodepool-tripleo 2025-12-05 12:59:58.709257 | localhost | Region: RegionOne 2025-12-05 12:59:58.709274 | localhost | Label: centos-9-stream-crc-2-48-0-6xlarge 2025-12-05 12:59:58.709291 | localhost | Product Name: OpenStack Nova 2025-12-05 12:59:58.709308 | localhost | Interface IP: 38.102.83.23 2025-12-05 12:59:58.727714 | 2025-12-05 12:59:58.727768 | PLAY [all] 2025-12-05 12:59:58.734396 | 2025-12-05 12:59:58.734460 | TASK [Gather network facts] 2025-12-05 12:59:59.321146 | controller | ok 2025-12-05 12:59:59.344227 | 2025-12-05 12:59:59.344302 | TASK [include_role : start-zuul-console] 2025-12-05 12:59:59.367169 | controller | ok 2025-12-05 12:59:59.379078 | 2025-12-05 12:59:59.379142 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-05 12:59:59.905078 | controller | ok 2025-12-05 12:59:59.915331 | 2025-12-05 12:59:59.915397 | TASK [include_role : add-build-sshkey] 2025-12-05 12:59:59.944832 | controller | ok 2025-12-05 12:59:59.957861 | 2025-12-05 12:59:59.957924 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-05 13:00:00.224914 | controller -> localhost | ok 2025-12-05 13:00:00.230947 | 2025-12-05 13:00:00.231016 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-05 13:00:00.250226 | controller | ok 2025-12-05 13:00:00.263416 | controller | included: /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-05 13:00:00.269219 | 2025-12-05 13:00:00.269280 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-05 13:00:01.121993 | controller -> localhost | Generating public/private rsa key pair. 2025-12-05 13:00:01.122334 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/work/d74a4c9aa6fe4096aae18ec3883082ca_id_rsa. 2025-12-05 13:00:01.122371 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/work/d74a4c9aa6fe4096aae18ec3883082ca_id_rsa.pub. 2025-12-05 13:00:01.122395 | controller -> localhost | The key fingerprint is: 2025-12-05 13:00:01.122415 | controller -> localhost | SHA256:0e0jBxRFXMIMjoXuTVVYht9UerQXp4LEj+Y5CdtJ41g zuul-build-sshkey 2025-12-05 13:00:01.122434 | controller -> localhost | The key's randomart image is: 2025-12-05 13:00:01.122453 | controller -> localhost | +---[RSA 3072]----+ 2025-12-05 13:00:01.122472 | controller -> localhost | | o*O+*=.=| 2025-12-05 13:00:01.122491 | controller -> localhost | | .B.oBo +=| 2025-12-05 13:00:01.122509 | controller -> localhost | | .o =+o.o+o| 2025-12-05 13:00:01.122527 | controller -> localhost | | o.Eo....o| 2025-12-05 13:00:01.122545 | controller -> localhost | | .S&.=+ | 2025-12-05 13:00:01.122563 | controller -> localhost | | + Xo . | 2025-12-05 13:00:01.122580 | controller -> localhost | | . | 2025-12-05 13:00:01.122597 | controller -> localhost | | | 2025-12-05 13:00:01.122614 | controller -> localhost | | | 2025-12-05 13:00:01.122632 | controller -> localhost | +----[SHA256]-----+ 2025-12-05 13:00:01.122697 | controller -> localhost | ok: Runtime: 0:00:00.442595 2025-12-05 13:00:01.128643 | 2025-12-05 13:00:01.128725 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-05 13:00:01.161320 | controller | ok 2025-12-05 13:00:01.174742 | controller | included: /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-05 13:00:01.186117 | 2025-12-05 13:00:01.186200 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-05 13:00:01.211564 | controller | skipping: Conditional result was False 2025-12-05 13:00:01.220305 | 2025-12-05 13:00:01.220392 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-05 13:00:01.910147 | controller | changed 2025-12-05 13:00:01.921805 | 2025-12-05 13:00:01.921939 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-05 13:00:02.325605 | controller | ok 2025-12-05 13:00:02.339282 | 2025-12-05 13:00:02.339428 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-05 13:00:04.538153 | controller | changed 2025-12-05 13:00:04.550237 | 2025-12-05 13:00:04.550381 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-05 13:00:06.172397 | controller | changed 2025-12-05 13:00:06.184633 | 2025-12-05 13:00:06.184806 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-05 13:00:06.213815 | controller | skipping: Conditional result was False 2025-12-05 13:00:06.227819 | 2025-12-05 13:00:06.227957 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-05 13:00:06.694922 | controller -> localhost | changed 2025-12-05 13:00:06.707532 | 2025-12-05 13:00:06.707623 | TASK [add-build-sshkey : Add back temp key] 2025-12-05 13:00:07.080639 | controller -> localhost | Identity added: /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/work/d74a4c9aa6fe4096aae18ec3883082ca_id_rsa (zuul-build-sshkey) 2025-12-05 13:00:07.080947 | controller -> localhost | ok: Runtime: 0:00:00.016426 2025-12-05 13:00:07.135834 | 2025-12-05 13:00:07.136079 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-05 13:00:07.591744 | controller | ok 2025-12-05 13:00:07.603900 | 2025-12-05 13:00:07.604048 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-05 13:00:07.644736 | controller | skipping: Conditional result was False 2025-12-05 13:00:07.668942 | 2025-12-05 13:00:07.669131 | TASK [include_role : validate-host] 2025-12-05 13:00:07.710597 | controller | ok 2025-12-05 13:00:07.746885 | 2025-12-05 13:00:07.747023 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-05 13:00:07.790883 | controller | ok 2025-12-05 13:00:07.799912 | 2025-12-05 13:00:07.799999 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-05 13:00:08.090965 | controller -> localhost | ok 2025-12-05 13:00:08.100670 | 2025-12-05 13:00:08.100818 | TASK [validate-host : Collect information about the host] 2025-12-05 13:00:09.043403 | controller | ok 2025-12-05 13:00:09.065129 | 2025-12-05 13:00:09.065276 | TASK [validate-host : Sanitize hostname] 2025-12-05 13:00:09.145642 | controller | ok 2025-12-05 13:00:09.157451 | 2025-12-05 13:00:09.157593 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-05 13:00:09.677635 | controller -> localhost | changed 2025-12-05 13:00:09.690594 | 2025-12-05 13:00:09.690803 | TASK [validate-host : Collect information about zuul worker] 2025-12-05 13:00:10.282324 | controller | ok 2025-12-05 13:00:10.294090 | 2025-12-05 13:00:10.294259 | TASK [validate-host : Write out all zuul information for each host] 2025-12-05 13:00:10.845376 | controller -> localhost | changed 2025-12-05 13:00:10.856955 | 2025-12-05 13:00:10.857027 | TASK [include_role : prepare-workspace-openshift] 2025-12-05 13:00:10.883121 | controller | skipping: Conditional result was False 2025-12-05 13:00:10.890058 | 2025-12-05 13:00:10.890119 | TASK [include_role : remove-zuul-sshkey] 2025-12-05 13:00:10.917618 | controller | skipping: Conditional result was False 2025-12-05 13:00:10.925779 | 2025-12-05 13:00:10.925852 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-12-05 13:00:11.352369 | controller | ok: "logs" 2025-12-05 13:00:11.352871 | controller | ok: All items complete 2025-12-05 13:00:11.352946 | 2025-12-05 13:00:11.723193 | controller | ok: "artifacts" 2025-12-05 13:00:12.030382 | controller | ok: "docs" 2025-12-05 13:00:12.045188 | 2025-12-05 13:00:12.045340 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-12-05 13:00:12.481072 | controller | changed: "logs" 2025-12-05 13:00:12.859534 | controller | changed: "artifacts" 2025-12-05 13:00:13.171204 | controller | changed: "docs" 2025-12-05 13:00:13.226224 | 2025-12-05 13:00:13.226369 | PLAY RECAP 2025-12-05 13:00:13.226431 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-12-05 13:00:13.226467 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-05 13:00:13.226493 | 2025-12-05 13:00:13.411366 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-12-05 13:00:13.414448 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-12-05 13:00:14.025413 | 2025-12-05 13:00:14.025581 | PLAY [all] 2025-12-05 13:00:14.046447 | 2025-12-05 13:00:14.046530 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-12-05 13:00:14.143893 | controller | ok 2025-12-05 13:00:14.157231 | 2025-12-05 13:00:14.157395 | TASK [mirror-info-fork : Create /etc/ci] 2025-12-05 13:00:14.779368 | controller | changed 2025-12-05 13:00:14.792851 | 2025-12-05 13:00:14.793000 | TASK [mirror-info-fork : Install ci_mirror script] 2025-12-05 13:00:16.841820 | controller | changed 2025-12-05 13:00:16.864672 | 2025-12-05 13:00:16.864979 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-12-05 13:00:17.514732 | controller | changed: 2025-12-05 13:00:17.515120 | controller | { 2025-12-05 13:00:17.515186 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-12-05 13:00:17.515255 | controller | } 2025-12-05 13:00:17.888733 | controller | changed: 2025-12-05 13:00:17.889004 | controller | { 2025-12-05 13:00:17.889065 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-12-05 13:00:17.889112 | controller | } 2025-12-05 13:00:18.319215 | controller | changed: 2025-12-05 13:00:18.319432 | controller | { 2025-12-05 13:00:18.319485 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-12-05 13:00:18.319528 | controller | } 2025-12-05 13:00:18.746555 | controller | changed: 2025-12-05 13:00:18.747015 | controller | { 2025-12-05 13:00:18.747097 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-12-05 13:00:18.747143 | controller | } 2025-12-05 13:00:19.147423 | controller | changed: 2025-12-05 13:00:19.147623 | controller | { 2025-12-05 13:00:19.147705 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-12-05 13:00:19.147758 | controller | } 2025-12-05 13:00:19.608655 | controller | changed: 2025-12-05 13:00:19.608923 | controller | { 2025-12-05 13:00:19.608979 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-12-05 13:00:19.609021 | controller | } 2025-12-05 13:00:20.024293 | controller | changed: 2025-12-05 13:00:20.024506 | controller | { 2025-12-05 13:00:20.024560 | 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" 2025-12-05 13:00:20.024605 | controller | } 2025-12-05 13:00:20.521532 | controller | changed: 2025-12-05 13:00:20.521801 | controller | { 2025-12-05 13:00:20.521859 | 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" 2025-12-05 13:00:20.521904 | controller | } 2025-12-05 13:00:20.989610 | controller | changed: 2025-12-05 13:00:20.989827 | controller | { 2025-12-05 13:00:20.989881 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-12-05 13:00:20.989921 | controller | } 2025-12-05 13:00:21.444451 | controller | changed: 2025-12-05 13:00:21.444665 | controller | { 2025-12-05 13:00:21.444761 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-12-05 13:00:21.444808 | controller | } 2025-12-05 13:00:21.864244 | controller | changed: 2025-12-05 13:00:21.864615 | controller | { 2025-12-05 13:00:21.864671 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-12-05 13:00:21.864760 | controller | } 2025-12-05 13:00:22.228411 | controller | changed: 2025-12-05 13:00:22.228765 | controller | { 2025-12-05 13:00:22.228842 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-12-05 13:00:22.228890 | controller | } 2025-12-05 13:00:22.643203 | controller | changed: 2025-12-05 13:00:22.643449 | controller | { 2025-12-05 13:00:22.643502 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-12-05 13:00:22.643543 | controller | } 2025-12-05 13:00:23.066029 | controller | changed: 2025-12-05 13:00:23.066347 | controller | { 2025-12-05 13:00:23.066421 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-12-05 13:00:23.066466 | controller | } 2025-12-05 13:00:23.465830 | controller | changed: 2025-12-05 13:00:23.466027 | controller | { 2025-12-05 13:00:23.466078 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-12-05 13:00:23.466119 | controller | } 2025-12-05 13:00:23.954591 | controller | changed: 2025-12-05 13:00:23.955258 | controller | { 2025-12-05 13:00:23.955392 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-12-05 13:00:23.955463 | controller | } 2025-12-05 13:00:24.381362 | controller | changed: 2025-12-05 13:00:24.381607 | controller | { 2025-12-05 13:00:24.381662 | 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" 2025-12-05 13:00:24.381892 | controller | } 2025-12-05 13:00:24.844193 | controller | changed: 2025-12-05 13:00:24.844334 | controller | { 2025-12-05 13:00:24.844386 | 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" 2025-12-05 13:00:24.844481 | controller | } 2025-12-05 13:00:25.251948 | controller | changed: 2025-12-05 13:00:25.252151 | controller | { 2025-12-05 13:00:25.252204 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-12-05 13:00:25.252244 | controller | } 2025-12-05 13:00:25.667352 | controller | changed: 2025-12-05 13:00:25.667527 | controller | { 2025-12-05 13:00:25.667578 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-12-05 13:00:25.667619 | controller | } 2025-12-05 13:00:26.109670 | controller | changed: 2025-12-05 13:00:26.109853 | controller | { 2025-12-05 13:00:26.109904 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-12-05 13:00:26.109945 | controller | } 2025-12-05 13:00:26.515089 | controller | changed: 2025-12-05 13:00:26.515224 | controller | { 2025-12-05 13:00:26.515275 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-12-05 13:00:26.515314 | controller | } 2025-12-05 13:00:27.002096 | controller | changed: 2025-12-05 13:00:27.002257 | controller | { 2025-12-05 13:00:27.002283 | 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" 2025-12-05 13:00:27.002307 | controller | } 2025-12-05 13:00:27.395724 | controller | changed: 2025-12-05 13:00:27.395813 | controller | { 2025-12-05 13:00:27.395836 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-12-05 13:00:27.395855 | controller | } 2025-12-05 13:00:27.816744 | controller | changed: 2025-12-05 13:00:27.816855 | controller | { 2025-12-05 13:00:27.816879 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-12-05 13:00:27.816898 | controller | } 2025-12-05 13:00:28.295327 | controller | changed: 2025-12-05 13:00:28.295497 | controller | { 2025-12-05 13:00:28.295551 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-12-05 13:00:28.295596 | controller | } 2025-12-05 13:00:28.339341 | 2025-12-05 13:00:28.339482 | TASK [Set timezone to UTC] 2025-12-05 13:00:29.040889 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-12-05 13:00:29.053007 | 2025-12-05 13:00:29.053148 | TASK [Create nodepool directory] 2025-12-05 13:00:29.454373 | controller | changed 2025-12-05 13:00:29.461032 | 2025-12-05 13:00:29.461109 | TASK [Create nodepool sub_nodes file] 2025-12-05 13:00:31.164561 | controller | changed 2025-12-05 13:00:31.181532 | 2025-12-05 13:00:31.181716 | TASK [Create nodepool sub_nodes_private file] 2025-12-05 13:00:32.992397 | controller | changed 2025-12-05 13:00:33.004025 | 2025-12-05 13:00:33.004152 | LOOP [Populate nodepool sub_nodes file] 2025-12-05 13:00:33.063236 | 2025-12-05 13:00:33.063468 | LOOP [Populate nodepool sub_nodes_private file] 2025-12-05 13:00:33.112897 | 2025-12-05 13:00:33.113249 | TASK [Create nodepool primary file] 2025-12-05 13:00:33.151578 | controller | skipping: Conditional result was False 2025-12-05 13:00:33.163481 | 2025-12-05 13:00:33.163629 | TASK [Create nodepool node_private for this node] 2025-12-05 13:00:35.021424 | controller | changed 2025-12-05 13:00:35.037030 | 2025-12-05 13:00:35.037250 | LOOP [Copy ssh keys to nodepool directory] 2025-12-05 13:00:35.634072 | controller | ok: Item: id_rsa Runtime: 0:00:00.007488 2025-12-05 13:00:35.634483 | 2025-12-05 13:00:36.006486 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.010589 2025-12-05 13:00:36.028092 | 2025-12-05 13:00:36.028217 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-12-05 13:00:37.874051 | controller | changed 2025-12-05 13:00:37.886447 | 2025-12-05 13:00:37.886597 | TASK [Validate sudoers config after edits] 2025-12-05 13:00:38.386029 | controller | /etc/sudoers: parsed OK 2025-12-05 13:00:38.386190 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-12-05 13:00:38.386208 | controller | /etc/sudoers.d/zuul: parsed OK 2025-12-05 13:00:38.386217 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-12-05 13:00:38.489522 | controller | ok: Runtime: 0:00:00.007440 2025-12-05 13:00:38.501744 | 2025-12-05 13:00:38.501870 | TASK [Show the environment passed in to job shell scripts] 2025-12-05 13:00:38.930881 | controller | SHELL=/bin/bash 2025-12-05 13:00:38.931009 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-12-05 13:00:38.931039 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-12-05 13:00:38.931057 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/37/3537/eb73450086809293a6f3a6959cb5d293c3a8518e 2025-12-05 13:00:38.931072 | controller | PWD=/home/zuul 2025-12-05 13:00:38.931086 | controller | ZUUL_PIPELINE=github-check 2025-12-05 13:00:38.931100 | controller | LOGNAME=zuul 2025-12-05 13:00:38.931113 | controller | XDG_SESSION_TYPE=tty 2025-12-05 13:00:38.931165 | controller | _=/usr/bin/env 2025-12-05 13:00:38.931179 | controller | MOTD_SHOWN=pam 2025-12-05 13:00:38.931192 | controller | HOME=/home/zuul 2025-12-05 13:00:38.931205 | controller | LANG=en_US.UTF-8 2025-12-05 13:00:38.931218 | controller | SSH_CONNECTION=38.102.83.114 44464 38.102.83.23 22 2025-12-05 13:00:38.931231 | 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 2025-12-05 13:00:38.931252 | controller | ZUUL_CHANGE_IDS=3537,eb73450086809293a6f3a6959cb5d293c3a8518e 2025-12-05 13:00:38.931265 | controller | WORKSPACE=/home/zuul/workspace 2025-12-05 13:00:38.931279 | controller | XDG_SESSION_CLASS=user 2025-12-05 13:00:38.931293 | controller | SELINUX_ROLE_REQUESTED= 2025-12-05 13:00:38.931306 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-12-05 13:00:38.931320 | controller | USER=zuul 2025-12-05 13:00:38.931333 | controller | ZUUL_VOTING=True 2025-12-05 13:00:38.931346 | controller | BUILD_TIMEOUT=10800000 2025-12-05 13:00:38.931359 | controller | SELINUX_USE_CURRENT_RANGE= 2025-12-05 13:00:38.931372 | controller | SHLVL=1 2025-12-05 13:00:38.931386 | controller | ZUUL_PATCHSET=eb73450086809293a6f3a6959cb5d293c3a8518e 2025-12-05 13:00:38.931399 | controller | XDG_SESSION_ID=1 2025-12-05 13:00:38.931412 | controller | ZUUL_BRANCH=main 2025-12-05 13:00:38.931425 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-12-05 13:00:38.931439 | controller | SSH_CLIENT=38.102.83.114 44464 22 2025-12-05 13:00:38.931455 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-12-05 13:00:38.931468 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-12-05 13:00:38.931482 | controller | which_declare=declare -f 2025-12-05 13:00:38.931497 | controller | PATH=/home/zuul/.crc/bin/oc:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-12-05 13:00:38.931510 | controller | SELINUX_LEVEL_REQUESTED= 2025-12-05 13:00:38.931523 | controller | ZUUL_CHANGE=3537 2025-12-05 13:00:38.931536 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-12-05 13:00:38.931550 | controller | ZUUL_UUID=d74a4c9aa6fe4096aae18ec3883082ca 2025-12-05 13:00:38.931563 | controller | BASH_FUNC_which%%=() { ( alias; 2025-12-05 13:00:38.931576 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-12-05 13:00:38.931589 | controller | } 2025-12-05 13:00:39.054842 | controller | ok: Runtime: 0:00:00.008046 2025-12-05 13:00:39.068190 | 2025-12-05 13:00:39.068322 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-12-05 13:00:39.096987 | controller | skipping: Conditional result was False 2025-12-05 13:00:39.110187 | 2025-12-05 13:00:39.110330 | TASK [Symlink /home/zuul-worker/workspace] 2025-12-05 13:00:39.667791 | controller | skipping: Conditional result was False 2025-12-05 13:00:39.683098 | 2025-12-05 13:00:39.683234 | TASK [Ensure legacy workspace directory] 2025-12-05 13:00:40.081732 | controller | changed 2025-12-05 13:00:40.121973 | 2025-12-05 13:00:40.122198 | PLAY RECAP 2025-12-05 13:00:40.122270 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-12-05 13:00:40.122299 | 2025-12-05 13:00:40.253726 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-12-05 13:00:40.255213 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-12-05 13:00:40.831572 | 2025-12-05 13:00:40.831711 | PLAY [all,!compute] 2025-12-05 13:00:40.851646 | 2025-12-05 13:00:40.851739 | TASK [Enable container-tools rhel-modules for c8/crc node] 2025-12-05 13:00:41.383171 | controller | skipping: Conditional result was False 2025-12-05 13:00:41.396557 | 2025-12-05 13:00:41.396744 | TASK [Install podman] 2025-12-05 13:01:01.184497 | controller | changed 2025-12-05 13:01:01.196167 | 2025-12-05 13:01:01.196297 | TASK [Set var name for quay login zuul secret] 2025-12-05 13:01:01.274861 | controller | skipping: Conditional result was False 2025-12-05 13:01:01.286405 | 2025-12-05 13:01:01.286538 | TASK [Print the username] 2025-12-05 13:01:01.871539 | controller | openstack-k8s-operators+cirobot 2025-12-05 13:01:02.368568 | controller | ok: Runtime: 0:00:00.005255 2025-12-05 13:01:02.381189 | 2025-12-05 13:01:02.381325 | TASK [Fail when user or password is not set] 2025-12-05 13:01:02.440402 | controller | skipping: Conditional result was False 2025-12-05 13:01:02.454088 | 2025-12-05 13:01:02.454234 | TASK [Set vars for quay login] 2025-12-05 13:01:02.522741 | controller | Output suppressed because no_log was given 2025-12-05 13:01:02.534410 | 2025-12-05 13:01:02.534539 | LOOP [Perform container registry login(s) with podman] 2025-12-05 13:01:03.848404 | controller | Output suppressed because no_log was given 2025-12-05 13:01:03.861157 | 2025-12-05 13:01:03.861300 | LOOP [Perform container registry login(s) with buildah] 2025-12-05 13:01:03.907908 | controller | Output suppressed because no_log was given 2025-12-05 13:01:03.923434 | 2025-12-05 13:01:03.923591 | TASK [Set Insecure registry for content provider] 2025-12-05 13:01:04.484250 | controller | changed: Block inserted 2025-12-05 13:01:04.504201 | 2025-12-05 13:01:04.504287 | PLAY RECAP 2025-12-05 13:01:04.504332 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-05 13:01:04.504352 | 2025-12-05 13:01:04.613580 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-12-05 13:01:04.614972 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/simple-start.yaml@master] 2025-12-05 13:01:05.204557 | 2025-12-05 13:01:05.204719 | PLAY [Prefer ipv4 over ipv6] 2025-12-05 13:01:05.225364 | 2025-12-05 13:01:05.225450 | TASK [Configure /etc/gai.conf to prever ipv4 over ipv6] 2025-12-05 13:01:05.270322 | controller | skipping: Conditional result was False 2025-12-05 13:01:05.290736 | 2025-12-05 13:01:05.290815 | PLAY [controller] 2025-12-05 13:01:05.306188 | 2025-12-05 13:01:05.306284 | TASK [Fail when openshift_pull_sec not provided] 2025-12-05 13:01:05.329843 | controller | skipping: Conditional result was False 2025-12-05 13:01:05.335262 | 2025-12-05 13:01:05.335327 | TASK [Clone repos in the job workspace] 2025-12-05 13:01:05.353858 | controller | ok 2025-12-05 13:01:05.370972 | 2025-12-05 13:01:05.371057 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-12-05 13:01:05.898629 | controller | ok 2025-12-05 13:01:05.904918 | 2025-12-05 13:01:05.904985 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-12-05 13:01:12.139656 | controller | Output suppressed because no_log was given 2025-12-05 13:01:12.160891 | 2025-12-05 13:01:12.161023 | TASK [Create pull-secret.txt file] 2025-12-05 13:01:14.142806 | controller | Output suppressed because no_log was given 2025-12-05 13:01:14.153950 | 2025-12-05 13:01:14.154083 | TASK [Apply CRC features and print image build date] 2025-12-05 13:01:14.185203 | controller | ok 2025-12-05 13:01:14.201467 | controller | included: /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/trusted/project_0/review.rdoproject.org/config/playbooks/crc/features.yaml 2025-12-05 13:01:14.212065 | 2025-12-05 13:01:14.212154 | TASK [Set additional parameters for crc - telemetry] 2025-12-05 13:01:14.751026 | controller | skipping: Conditional result was False 2025-12-05 13:01:14.764666 | 2025-12-05 13:01:14.764843 | TASK [Set additional parameters for crc - monitoring] 2025-12-05 13:01:15.318154 | controller | skipping: Conditional result was False 2025-12-05 13:01:15.331562 | 2025-12-05 13:01:15.331733 | TASK [Set minimum required memory to run the CRC when monitoring enabled] 2025-12-05 13:01:15.884998 | controller | skipping: Conditional result was False 2025-12-05 13:01:15.898350 | 2025-12-05 13:01:15.898486 | TASK [Set additional parameters for crc - enable microshift preset] 2025-12-05 13:01:16.453245 | controller | skipping: Conditional result was False 2025-12-05 13:01:16.466452 | 2025-12-05 13:01:16.466588 | TASK [Set additional parameters for crc - enable okd preset] 2025-12-05 13:01:17.023566 | controller | skipping: Conditional result was False 2025-12-05 13:01:17.036306 | 2025-12-05 13:01:17.036433 | TASK [Delete the cluster if there's a non-default bundle URL] 2025-12-05 13:01:17.596201 | controller | skipping: Conditional result was False 2025-12-05 13:01:17.610602 | 2025-12-05 13:01:17.610776 | TASK [Execute crc start command] 2025-12-05 13:15:40.800944 | controller | ok: Runtime: 0:14:22.574061 2025-12-05 13:15:40.812372 | 2025-12-05 13:15:40.812499 | TASK [Verify that OpenShift is up and running] 2025-12-05 13:15:40.842484 | controller | ok 2025-12-05 13:15:40.861996 | controller | included: /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/trusted/project_0/review.rdoproject.org/config/playbooks/crc/verify_openshift_start.yaml 2025-12-05 13:15:40.872715 | 2025-12-05 13:15:40.872800 | TASK [Create script to login and verify services] 2025-12-05 13:15:42.446915 | controller | changed 2025-12-05 13:15:42.459347 | 2025-12-05 13:15:42.459476 | TASK [Ensure that user is logged] 2025-12-05 13:15:42.825816 | controller | Checking login to the cluster 1... 2025-12-05 13:15:43.929039 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-12-05 13:15:44.870811 | controller | 2025-12-05 13:15:44.870902 | controller | Login successful. 2025-12-05 13:15:44.917175 | controller | 2025-12-05 13:15:44.917286 | controller | You have access to 65 projects, the list has been suppressed. You can list all projects with 'oc projects' 2025-12-05 13:15:44.952104 | controller | 2025-12-05 13:15:44.952329 | controller | Using project "default". 2025-12-05 13:15:45.005421 | controller | changed 2025-12-05 13:15:45.017142 | 2025-12-05 13:15:45.017275 | TASK [Delete all openshift-marketplace pods] 2025-12-05 13:15:45.869332 | controller | pod "certified-operators-mz9qw" deleted 2025-12-05 13:15:45.894338 | controller | pod "community-operators-rl9mj" deleted 2025-12-05 13:15:45.913753 | controller | pod "marketplace-operator-79b997595-bv56r" deleted 2025-12-05 13:15:45.959827 | controller | pod "redhat-marketplace-ww44x" deleted 2025-12-05 13:15:45.976060 | controller | pod "redhat-operators-x9gsj" deleted 2025-12-05 13:15:52.076330 | controller | ok 2025-12-05 13:15:52.082145 | 2025-12-05 13:15:52.082210 | TASK [Copy script ensure_services_up.sh] 2025-12-05 13:15:52.147425 | controller | skipping: Conditional result was False 2025-12-05 13:15:52.153551 | 2025-12-05 13:15:52.153616 | TASK [Ensure all pods are up and running] 2025-12-05 13:15:52.683104 | controller | skipping: Conditional result was False 2025-12-05 13:15:52.745403 | 2025-12-05 13:15:52.745607 | TASK [Check if there is a image build date file] 2025-12-05 13:15:53.103863 | controller | ok 2025-12-05 13:15:53.124635 | 2025-12-05 13:15:53.124802 | TASK [Print image date if available] 2025-12-05 13:15:53.500143 | controller | Mon Nov 24 08:30:59 AM EST 2025 2025-12-05 13:15:53.663317 | controller | changed 2025-12-05 13:15:53.669023 | 2025-12-05 13:15:53.669084 | TASK [Fix machineconfigpool] 2025-12-05 13:15:53.705037 | controller | skipping: Conditional result was False 2025-12-05 13:15:53.712715 | 2025-12-05 13:15:53.712790 | TASK [Show available nodes] 2025-12-05 13:15:54.483633 | controller | NAME STATUS ROLES AGE VERSION 2025-12-05 13:15:54.489566 | controller | crc Ready control-plane,master,worker 285d v1.31.5 2025-12-05 13:15:54.753291 | controller | ok: Runtime: 0:00:00.174565 2025-12-05 13:15:54.770032 | 2025-12-05 13:15:54.770183 | TASK [Configure insecure registry inside crc vm] 2025-12-05 13:15:54.820670 | controller | ok 2025-12-05 13:15:54.837828 | controller | included: /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/trusted/project_0/review.rdoproject.org/config/playbooks/crc/crc_insecure_registry.yaml 2025-12-05 13:15:54.852265 | 2025-12-05 13:15:54.852350 | TASK [Catch CRC IP] 2025-12-05 13:15:55.331671 | controller | 192.168.130.11 2025-12-05 13:15:55.402458 | controller | changed 2025-12-05 13:15:55.414165 | 2025-12-05 13:15:55.414293 | TASK [Patch the image.config.openshift.io resource to include insecure registry] 2025-12-05 13:15:56.218409 | controller | image.config.openshift.io/cluster patched 2025-12-05 13:15:56.480300 | controller | changed 2025-12-05 13:15:56.486277 | 2025-12-05 13:15:56.486344 | TASK [Check if id_ed25519 key exists] 2025-12-05 13:15:56.845610 | controller | ok 2025-12-05 13:15:56.852209 | 2025-12-05 13:15:56.852274 | TASK [Set fact if new keypair exists] 2025-12-05 13:15:56.893983 | controller | ok 2025-12-05 13:15:56.899111 | 2025-12-05 13:15:56.899172 | TASK [update the /etc/containers/registries.conf in crc vm] 2025-12-05 13:15:58.257768 | controller | 2025-12-05 13:16:08.550354 | controller | PLAY [Set insecure registry with in crc vm] ************************************ 2025-12-05 13:16:08.550535 | controller | 2025-12-05 13:16:08.550551 | controller | TASK [Gathering Facts] ********************************************************* 2025-12-05 13:16:08.550568 | controller | [WARNING]: Platform linux on host 192.168.130.11 is using the discovered Python 2025-12-05 13:16:08.604582 | controller | interpreter at /usr/bin/python3.9, but future installation of another Python 2025-12-05 13:16:08.604645 | controller | interpreter could change the meaning of that path. See 2025-12-05 13:16:08.604653 | controller | https://docs.ansible.com/ansible- 2025-12-05 13:16:08.604661 | controller | core/2.14/reference_appendices/interpreter_discovery.html for more information. 2025-12-05 13:16:08.604676 | controller | ok: [192.168.130.11] 2025-12-05 13:16:09.830528 | controller | 2025-12-05 13:16:09.830614 | controller | TASK [Set Insecure registry for content provider] ****************************** 2025-12-05 13:16:09.830638 | controller | changed: [192.168.130.11] 2025-12-05 13:16:17.750484 | controller | 2025-12-05 13:16:17.750565 | controller | TASK [Restart crio] ************************************************************ 2025-12-05 13:16:17.750582 | controller | changed: [192.168.130.11] 2025-12-05 13:16:20.600928 | controller | 2025-12-05 13:16:20.601060 | controller | TASK [Restart kubelet] ********************************************************* 2025-12-05 13:16:20.601108 | controller | changed: [192.168.130.11] 2025-12-05 13:16:20.678788 | controller | 2025-12-05 13:16:20.678998 | controller | PLAY RECAP ********************************************************************* 2025-12-05 13:16:20.679017 | controller | 192.168.130.11 : ok=4 changed=3 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2025-12-05 13:16:20.679026 | controller | 2025-12-05 13:16:20.971170 | controller | changed 2025-12-05 13:16:20.984349 | 2025-12-05 13:16:20.984489 | TASK [Catch CRC IP] 2025-12-05 13:16:21.503849 | controller | 192.168.130.11 2025-12-05 13:16:21.551631 | controller | changed 2025-12-05 13:16:21.568835 | 2025-12-05 13:16:21.569073 | TASK [Check if id_ed25519 key exists] 2025-12-05 13:16:21.943083 | controller | ok 2025-12-05 13:16:21.956879 | 2025-12-05 13:16:21.957032 | TASK [Set fact if new keypair exists] 2025-12-05 13:16:22.008719 | controller | ok 2025-12-05 13:16:22.019717 | 2025-12-05 13:16:22.019859 | TASK [Run crc] 2025-12-05 13:16:22.981264 | controller | 2025-12-05 13:16:27.364823 | controller | PLAY [OpenShift secret copy and CRC securitization] **************************** 2025-12-05 13:16:27.364936 | controller | 2025-12-05 13:16:27.364945 | controller | TASK [Gathering Facts] ********************************************************* 2025-12-05 13:16:27.364966 | controller | [WARNING]: Platform linux on host 192.168.130.11 is using the discovered Python 2025-12-05 13:16:27.428522 | controller | interpreter at /usr/bin/python3.9, but future installation of another Python 2025-12-05 13:16:27.428660 | controller | interpreter could change the meaning of that path. See 2025-12-05 13:16:27.428672 | controller | https://docs.ansible.com/ansible- 2025-12-05 13:16:27.428681 | controller | core/2.14/reference_appendices/interpreter_discovery.html for more information. 2025-12-05 13:16:27.428711 | controller | ok: [192.168.130.11] 2025-12-05 13:16:29.382490 | controller | 2025-12-05 13:16:29.382565 | controller | TASK [Copy pull-secret] ******************************************************** 2025-12-05 13:16:29.382591 | controller | changed: [192.168.130.11] 2025-12-05 13:16:33.074606 | controller | 2025-12-05 13:16:33.074761 | controller | TASK [Add crio config] ********************************************************* 2025-12-05 13:16:33.074778 | controller | changed: [192.168.130.11] 2025-12-05 13:18:11.394464 | controller | 2025-12-05 13:18:11.394554 | controller | TASK [Restart crio to pickup new configuration] ******************************** 2025-12-05 13:18:11.394582 | controller | changed: [192.168.130.11] 2025-12-05 13:18:11.461310 | controller | 2025-12-05 13:18:11.461394 | controller | PLAY RECAP ********************************************************************* 2025-12-05 13:18:11.461403 | controller | 192.168.130.11 : ok=4 changed=3 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2025-12-05 13:18:11.461410 | controller | 2025-12-05 13:18:11.809369 | controller | changed 2025-12-05 13:18:11.823096 | 2025-12-05 13:18:11.823236 | TASK [Set slower etcd profile] 2025-12-05 13:18:11.902831 | controller | ok 2025-12-05 13:18:11.945900 | 2025-12-05 13:18:11.945993 | TASK [prepare-crc-cloud : Set slower profile] 2025-12-05 13:18:42.713354 | controller | error: You must be logged in to the server (Unauthorized) 2025-12-05 13:18:43.046592 | controller | ERROR 2025-12-05 13:18:43.046887 | controller | { 2025-12-05 13:18:43.046951 | controller | "delta": "0:00:30.362451", 2025-12-05 13:18:43.046992 | controller | "end": "2025-12-05 13:18:42.724372", 2025-12-05 13:18:43.047028 | controller | "msg": "non-zero return code", 2025-12-05 13:18:43.047062 | controller | "rc": 1, 2025-12-05 13:18:43.047096 | controller | "start": "2025-12-05 13:18:12.361921" 2025-12-05 13:18:43.047129 | controller | } failure 2025-12-05 13:18:43.049666 | 2025-12-05 13:18:43.049834 | PLAY RECAP 2025-12-05 13:18:43.049920 | controller | ok: 22 changed: 12 unreachable: 0 failed: 1 skipped: 11 rescued: 0 ignored: 0 2025-12-05 13:18:43.049963 | 2025-12-05 13:18:43.175713 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/simple-start.yaml@master] 2025-12-05 13:18:43.177342 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-12-05 13:18:43.747483 | 2025-12-05 13:18:43.747612 | PLAY [Report DLRN results after job run] 2025-12-05 13:18:43.773337 | 2025-12-05 13:18:43.773474 | TASK [Report job status to DLRN] 2025-12-05 13:18:43.794352 | controller | ok 2025-12-05 13:18:43.818416 | 2025-12-05 13:18:43.818518 | TASK [dlrn_report : Warning if DLRN is not running] 2025-12-05 13:18:43.863294 | controller | skipping: Conditional result was False 2025-12-05 13:18:43.870057 | 2025-12-05 13:18:43.870131 | TASK [dlrn_report : Install dlrnapi-client shyaml package] 2025-12-05 13:18:43.914456 | controller | skipping: Conditional result was False 2025-12-05 13:18:43.922068 | 2025-12-05 13:18:43.922149 | TASK [dlrn_report : Install kinit related package] 2025-12-05 13:18:43.966538 | controller | skipping: Conditional result was False 2025-12-05 13:18:43.974184 | 2025-12-05 13:18:43.974256 | TASK [dlrn_report : Install dlrn kerberos related packages] 2025-12-05 13:18:44.018457 | controller | skipping: Conditional result was False 2025-12-05 13:18:44.025618 | 2025-12-05 13:18:44.025709 | TASK [Set zuul-log-path fact] 2025-12-05 13:18:44.070446 | controller | skipping: Conditional result was False 2025-12-05 13:18:44.085374 | 2025-12-05 13:18:44.085584 | TASK [dlrn_report : Set the the value of cifmw_repo_setup_promotion when multiple dlrn tags are used] 2025-12-05 13:18:44.144867 | controller | skipping: Conditional result was False 2025-12-05 13:18:44.157420 | 2025-12-05 13:18:44.157553 | TASK [Get hash related data from repo_setup role] 2025-12-05 13:18:44.204983 | controller | skipping: Conditional result was False 2025-12-05 13:18:44.218532 | 2025-12-05 13:18:44.218663 | TASK [dlrn_report : Perform kinit for DLRN kerberos authentication] 2025-12-05 13:18:44.772188 | controller | skipping: Conditional result was False 2025-12-05 13:18:44.785446 | 2025-12-05 13:18:44.785589 | TASK [dlrn_report : Set empty value for dlrnapi password] 2025-12-05 13:18:44.863889 | controller | skipping: Conditional result was False 2025-12-05 13:18:44.877029 | 2025-12-05 13:18:44.877169 | TASK [dlrn_report : Report results to dlrn for the tested hash] 2025-12-05 13:18:45.434157 | controller | skipping: Conditional result was False 2025-12-05 13:18:45.488510 | 2025-12-05 13:18:45.488598 | PLAY RECAP 2025-12-05 13:18:45.488666 | controller | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 10 rescued: 0 ignored: 0 2025-12-05 13:18:45.488734 | 2025-12-05 13:18:45.599400 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-12-05 13:18:45.602541 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-12-05 13:18:46.213969 | 2025-12-05 13:18:46.214083 | PLAY [all] 2025-12-05 13:18:46.233281 | 2025-12-05 13:18:46.233355 | TASK [include_role : fetch-output] 2025-12-05 13:18:46.275301 | controller | ok 2025-12-05 13:18:46.291642 | 2025-12-05 13:18:46.291745 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-05 13:18:46.367008 | controller | skipping: Conditional result was False 2025-12-05 13:18:46.372650 | 2025-12-05 13:18:46.372745 | TASK [fetch-output : Set log path for single node] 2025-12-05 13:18:46.412097 | controller | ok 2025-12-05 13:18:46.417844 | 2025-12-05 13:18:46.417973 | LOOP [fetch-output : Ensure local output dirs] 2025-12-05 13:18:46.824866 | controller -> localhost | ok: "/var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/work/logs" 2025-12-05 13:18:47.072903 | controller -> localhost | changed: "/var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/work/artifacts" 2025-12-05 13:18:47.289198 | controller -> localhost | changed: "/var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/work/docs" 2025-12-05 13:18:47.310662 | 2025-12-05 13:18:47.310893 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-05 13:18:48.192398 | controller | changed: .d..t...... ./ 2025-12-05 13:18:48.192824 | controller | changed: All items complete 2025-12-05 13:18:48.192889 | 2025-12-05 13:18:48.924202 | controller | changed: .d..t...... ./ 2025-12-05 13:18:49.647823 | controller | changed: .d..t...... ./ 2025-12-05 13:18:49.674743 | 2025-12-05 13:18:49.674896 | TASK [include_role : fetch-output-openshift] 2025-12-05 13:18:49.701070 | controller | skipping: Conditional result was False 2025-12-05 13:18:49.711076 | 2025-12-05 13:18:49.711169 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-12-05 13:18:50.158043 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.014151 2025-12-05 13:18:50.483318 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012854 2025-12-05 13:18:50.517916 | 2025-12-05 13:18:50.518037 | PLAY [all] 2025-12-05 13:18:50.533140 | 2025-12-05 13:18:50.533209 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-05 13:18:51.182150 | controller | changed 2025-12-05 13:18:51.231625 | 2025-12-05 13:18:51.231722 | PLAY RECAP 2025-12-05 13:18:51.231786 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-12-05 13:18:51.231816 | 2025-12-05 13:18:51.348179 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-12-05 13:18:51.351177 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-12-05 13:18:51.979128 | 2025-12-05 13:18:51.979238 | PLAY [localhost] 2025-12-05 13:18:51.996280 | 2025-12-05 13:18:51.996354 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-05 13:18:52.441433 | localhost | changed 2025-12-05 13:18:52.451795 | 2025-12-05 13:18:52.451951 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-05 13:18:52.487570 | localhost | ok 2025-12-05 13:18:52.505171 | 2025-12-05 13:18:52.505319 | TASK [add-fileserver : Create SSH private key tempfile] 2025-12-05 13:18:52.884810 | localhost | changed 2025-12-05 13:18:52.889647 | 2025-12-05 13:18:52.889751 | TASK [add-fileserver : Create SSH private key from secret] 2025-12-05 13:18:53.630710 | localhost | changed 2025-12-05 13:18:53.635837 | 2025-12-05 13:18:53.635904 | TASK [add-fileserver : Add fileserver ssh key] 2025-12-05 13:18:54.091582 | localhost | Identity added: /var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/work/tmp/ansible.tl0pba4w (/var/lib/zuul/builds/d74a4c9aa6fe4096aae18ec3883082ca/work/tmp/ansible.tl0pba4w) 2025-12-05 13:18:54.091817 | localhost | ok: Runtime: 0:00:00.013392 2025-12-05 13:18:54.096571 | 2025-12-05 13:18:54.096641 | TASK [add-fileserver : Remove SSH private key from disk] 2025-12-05 13:18:54.426102 | localhost | ok: Runtime: 0:00:00.008914 2025-12-05 13:18:54.436329 | 2025-12-05 13:18:54.436470 | TASK [add-fileserver : Add fileserver to inventory] 2025-12-05 13:18:54.493065 | localhost | changed 2025-12-05 13:18:54.503447 | 2025-12-05 13:18:54.503588 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-12-05 13:18:54.892394 | localhost | changed 2025-12-05 13:18:54.916231 | 2025-12-05 13:18:54.916323 | PLAY [localhost] 2025-12-05 13:18:54.932644 | 2025-12-05 13:18:54.932747 | TASK [Generate bulk log download script] 2025-12-05 13:18:54.951501 | localhost | ok 2025-12-05 13:18:54.963038 | 2025-12-05 13:18:54.963114 | TASK [local-log-download : Check API endpoint is defined] 2025-12-05 13:18:55.002059 | localhost | ok: All assertions passed 2025-12-05 13:18:55.007855 | 2025-12-05 13:18:55.007924 | TASK [local-log-download : Create download script] 2025-12-05 13:18:55.408081 | localhost -> localhost | changed 2025-12-05 13:18:55.418310 | 2025-12-05 13:18:55.418393 | TASK [Register quick-download link] 2025-12-05 13:18:55.473094 | localhost | ok 2025-12-05 13:18:55.488358 | 2025-12-05 13:18:55.488413 | PLAY [logserver.rdoproject.org] 2025-12-05 13:18:55.497798 | 2025-12-05 13:18:55.497860 | TASK [Set zuul-log-path fact] 2025-12-05 13:18:55.515113 | logserver.rdoproject.org | ok 2025-12-05 13:18:55.523743 | 2025-12-05 13:18:55.523807 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 13:18:55.550299 | logserver.rdoproject.org | ok 2025-12-05 13:18:55.555466 | 2025-12-05 13:18:55.555529 | TASK [upload-logs : Create log directories] 2025-12-05 13:18:56.403976 | logserver.rdoproject.org | changed 2025-12-05 13:18:56.410816 | 2025-12-05 13:18:56.410942 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-05 13:18:56.697058 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005419 2025-12-05 13:18:56.706892 | 2025-12-05 13:18:56.707025 | TASK [upload-logs : Upload logs to log server] 2025-12-05 13:18:57.394867 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-12-05 13:18:57.401267 | 2025-12-05 13:18:57.401402 | LOOP [upload-logs : Compress console log and json output] 2025-12-05 13:18:57.469064 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-05 13:18:57.480962 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-05 13:18:57.489074 | 2025-12-05 13:18:57.489245 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-05 13:18:57.537888 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-05 13:18:57.538345 | 2025-12-05 13:18:57.541050 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-05 13:18:57.556730 | 2025-12-05 13:18:57.556915 | LOOP [upload-logs : Upload console log and json output]