2025-10-03 07:41:24.304566 | Job console starting... 2025-10-03 07:41:24.543630 | Updating repositories 2025-10-03 07:41:25.318597 | Preparing job workspace 2025-10-03 07:41:33.494050 | Running Ansible setup... 2025-10-03 07:41:37.196958 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-03 07:41:37.727779 | 2025-10-03 07:41:37.727895 | PLAY [localhost] 2025-10-03 07:41:37.736839 | 2025-10-03 07:41:37.736931 | TASK [Gathering Facts] 2025-10-03 07:41:38.563557 | localhost | ok 2025-10-03 07:41:38.577239 | 2025-10-03 07:41:38.577350 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-03 07:41:38.926372 | localhost -> localhost | changed 2025-10-03 07:41:38.931785 | 2025-10-03 07:41:38.931860 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-03 07:41:39.655241 | localhost -> localhost | changed 2025-10-03 07:41:39.663885 | 2025-10-03 07:41:39.663990 | TASK [Setup log path fact] 2025-10-03 07:41:39.680875 | localhost | ok 2025-10-03 07:41:39.692018 | 2025-10-03 07:41:39.692093 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-03 07:41:39.709558 | localhost | ok 2025-10-03 07:41:39.717070 | 2025-10-03 07:41:39.717142 | TASK [emit-job-header : Print job information] 2025-10-03 07:41:39.744347 | # Job Information 2025-10-03 07:41:39.744469 | Ansible Version: 2.15.12 2025-10-03 07:41:39.744499 | Job: cifmw-molecule-install_openstack_ca 2025-10-03 07:41:39.744522 | Pipeline: github-check 2025-10-03 07:41:39.744542 | Executor: ibm-bm4-ze.softwarefactory-project.io 2025-10-03 07:41:39.744561 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3362 2025-10-03 07:41:39.744581 | Log URL (when completed): https://logserver.rdoproject.org/8d5/rdoproject.org/8d54951453a84f74ac8a6f2f84727919/ 2025-10-03 07:41:39.744601 | Event ID: f958eab0-a02a-11f0-9ba1-0df9636946d8 2025-10-03 07:41:39.748316 | 2025-10-03 07:41:39.748382 | LOOP [emit-job-header : Print node information] 2025-10-03 07:41:39.835968 | localhost | ok: 2025-10-03 07:41:39.836125 | localhost | # Node Information 2025-10-03 07:41:39.836156 | localhost | Inventory Hostname: controller 2025-10-03 07:41:39.836181 | localhost | Hostname: np0005468242 2025-10-03 07:41:39.836202 | localhost | Username: zuul 2025-10-03 07:41:39.836223 | localhost | Distro: CentOS 9 2025-10-03 07:41:39.836242 | localhost | Provider: ibm-bm4-nodepool 2025-10-03 07:41:39.836260 | localhost | Region: regionOne 2025-10-03 07:41:39.836291 | localhost | Label: centos-9-stream-crc-2-48-0-3xl-ibm 2025-10-03 07:41:39.836309 | localhost | Product Name: OpenStack Compute 2025-10-03 07:41:39.836325 | localhost | Interface IP: 192.168.26.105 2025-10-03 07:41:39.861808 | 2025-10-03 07:41:39.861908 | PLAY [all] 2025-10-03 07:41:39.868394 | 2025-10-03 07:41:39.868457 | TASK [Gather network facts] 2025-10-03 07:41:40.304405 | controller | ok 2025-10-03 07:41:40.319722 | 2025-10-03 07:41:40.319818 | TASK [include_role : start-zuul-console] 2025-10-03 07:41:40.338896 | controller | ok 2025-10-03 07:41:40.350704 | 2025-10-03 07:41:40.350775 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-03 07:41:40.723814 | controller | ok 2025-10-03 07:41:40.733098 | 2025-10-03 07:41:40.733170 | TASK [include_role : add-build-sshkey] 2025-10-03 07:41:40.750985 | controller | ok 2025-10-03 07:41:40.765236 | 2025-10-03 07:41:40.765320 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-03 07:41:40.971027 | controller -> localhost | ok 2025-10-03 07:41:40.977063 | 2025-10-03 07:41:40.977138 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-03 07:41:40.996687 | controller | ok 2025-10-03 07:41:41.010102 | controller | included: /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-03 07:41:41.016588 | 2025-10-03 07:41:41.016660 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-03 07:41:41.394675 | controller -> localhost | Generating public/private rsa key pair. 2025-10-03 07:41:41.394852 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/work/8d54951453a84f74ac8a6f2f84727919_id_rsa. 2025-10-03 07:41:41.394902 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/work/8d54951453a84f74ac8a6f2f84727919_id_rsa.pub. 2025-10-03 07:41:41.394951 | controller -> localhost | The key fingerprint is: 2025-10-03 07:41:41.394980 | controller -> localhost | SHA256:LoV/Jxy6oNyDmzRU+jjK3cYjDLtO3HtYMDv4bvCBnxo zuul-build-sshkey 2025-10-03 07:41:41.395003 | controller -> localhost | The key's randomart image is: 2025-10-03 07:41:41.395024 | controller -> localhost | +---[RSA 3072]----+ 2025-10-03 07:41:41.395042 | controller -> localhost | | | 2025-10-03 07:41:41.395061 | controller -> localhost | | | 2025-10-03 07:41:41.395078 | controller -> localhost | | . | 2025-10-03 07:41:41.395095 | controller -> localhost | | oo . | 2025-10-03 07:41:41.395111 | controller -> localhost | | oo+. S . | 2025-10-03 07:41:41.395127 | controller -> localhost | | .=o+o.+ o . | 2025-10-03 07:41:41.395143 | controller -> localhost | | EO*O+ + + . | 2025-10-03 07:41:41.395160 | controller -> localhost | | o.*@O*o o o | 2025-10-03 07:41:41.395179 | controller -> localhost | | .*=O=oo. | 2025-10-03 07:41:41.395196 | controller -> localhost | +----[SHA256]-----+ 2025-10-03 07:41:41.395254 | controller -> localhost | ok: Runtime: 0:00:00.035361 2025-10-03 07:41:41.401474 | 2025-10-03 07:41:41.401540 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-03 07:41:41.419811 | controller | ok 2025-10-03 07:41:41.429983 | controller | included: /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-03 07:41:41.438617 | 2025-10-03 07:41:41.438684 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-03 07:41:41.453066 | controller | skipping: Conditional result was False 2025-10-03 07:41:41.459034 | 2025-10-03 07:41:41.459105 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-03 07:41:41.945213 | controller | changed 2025-10-03 07:41:41.949930 | 2025-10-03 07:41:41.949995 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-03 07:41:42.211801 | controller | ok 2025-10-03 07:41:42.217574 | 2025-10-03 07:41:42.217649 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-03 07:41:43.412568 | controller | changed 2025-10-03 07:41:43.418130 | 2025-10-03 07:41:43.418195 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-03 07:41:44.581983 | controller | changed 2025-10-03 07:41:44.586782 | 2025-10-03 07:41:44.586847 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-03 07:41:44.600116 | controller | skipping: Conditional result was False 2025-10-03 07:41:44.605902 | 2025-10-03 07:41:44.605985 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-03 07:41:44.923613 | controller -> localhost | changed 2025-10-03 07:41:44.933336 | 2025-10-03 07:41:44.933411 | TASK [add-build-sshkey : Add back temp key] 2025-10-03 07:41:45.160038 | controller -> localhost | Identity added: /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/work/8d54951453a84f74ac8a6f2f84727919_id_rsa (zuul-build-sshkey) 2025-10-03 07:41:45.160231 | controller -> localhost | ok: Runtime: 0:00:00.007333 2025-10-03 07:41:45.167057 | 2025-10-03 07:41:45.167124 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-03 07:41:45.560774 | controller | ok 2025-10-03 07:41:45.565703 | 2025-10-03 07:41:45.565780 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-03 07:41:45.595020 | controller | skipping: Conditional result was False 2025-10-03 07:41:45.605094 | 2025-10-03 07:41:45.605161 | TASK [include_role : validate-host] 2025-10-03 07:41:45.623698 | controller | ok 2025-10-03 07:41:45.643699 | 2025-10-03 07:41:45.643784 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-03 07:41:45.671860 | controller | ok 2025-10-03 07:41:45.676603 | 2025-10-03 07:41:45.676675 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-03 07:41:45.884476 | controller -> localhost | ok 2025-10-03 07:41:45.911587 | 2025-10-03 07:41:45.911685 | TASK [validate-host : Collect information about the host] 2025-10-03 07:41:46.600458 | controller | ok 2025-10-03 07:41:46.609528 | 2025-10-03 07:41:46.609598 | TASK [validate-host : Sanitize hostname] 2025-10-03 07:41:46.648714 | controller | ok 2025-10-03 07:41:46.653329 | 2025-10-03 07:41:46.653397 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-03 07:41:47.042837 | controller -> localhost | changed 2025-10-03 07:41:47.048022 | 2025-10-03 07:41:47.048097 | TASK [validate-host : Collect information about zuul worker] 2025-10-03 07:41:47.441132 | controller | ok 2025-10-03 07:41:47.446053 | 2025-10-03 07:41:47.446141 | TASK [validate-host : Write out all zuul information for each host] 2025-10-03 07:41:47.816399 | controller -> localhost | changed 2025-10-03 07:41:47.825804 | 2025-10-03 07:41:47.825870 | TASK [include_role : prepare-workspace-openshift] 2025-10-03 07:41:47.838553 | controller | skipping: Conditional result was False 2025-10-03 07:41:47.843203 | 2025-10-03 07:41:47.843264 | TASK [include_role : remove-zuul-sshkey] 2025-10-03 07:41:47.856086 | controller | skipping: Conditional result was False 2025-10-03 07:41:47.860878 | 2025-10-03 07:41:47.860961 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-03 07:41:48.118379 | controller | ok: "logs" 2025-10-03 07:41:48.118605 | controller | ok: All items complete 2025-10-03 07:41:48.118635 | 2025-10-03 07:41:48.356272 | controller | ok: "artifacts" 2025-10-03 07:41:48.604725 | controller | ok: "docs" 2025-10-03 07:41:48.611141 | 2025-10-03 07:41:48.611254 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-03 07:41:48.885249 | controller | changed: "logs" 2025-10-03 07:41:49.129845 | controller | changed: "artifacts" 2025-10-03 07:41:49.376267 | controller | changed: "docs" 2025-10-03 07:41:49.409563 | 2025-10-03 07:41:49.409702 | PLAY RECAP 2025-10-03 07:41:49.409751 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-03 07:41:49.409852 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-03 07:41:49.409972 | 2025-10-03 07:41:49.499234 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-03 07:41:49.500001 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-03 07:41:50.072859 | 2025-10-03 07:41:50.073029 | PLAY [all] 2025-10-03 07:41:50.093655 | 2025-10-03 07:41:50.093740 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-03 07:41:50.142710 | controller | ok 2025-10-03 07:41:50.147876 | 2025-10-03 07:41:50.147971 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-03 07:41:50.572475 | controller | changed 2025-10-03 07:41:50.578376 | 2025-10-03 07:41:50.578510 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-03 07:41:51.882920 | controller | changed 2025-10-03 07:41:51.893140 | 2025-10-03 07:41:51.893210 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-03 07:41:52.345358 | controller | changed: 2025-10-03 07:41:52.345537 | controller | { 2025-10-03 07:41:52.345571 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-03 07:41:52.345603 | controller | } 2025-10-03 07:41:52.630944 | controller | changed: 2025-10-03 07:41:52.631039 | controller | { 2025-10-03 07:41:52.631075 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-03 07:41:52.631098 | controller | } 2025-10-03 07:41:52.934757 | controller | changed: 2025-10-03 07:41:52.934851 | controller | { 2025-10-03 07:41:52.934879 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-10-03 07:41:52.934899 | controller | } 2025-10-03 07:41:53.223748 | controller | changed: 2025-10-03 07:41:53.223840 | controller | { 2025-10-03 07:41:53.223868 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-03 07:41:53.223891 | controller | } 2025-10-03 07:41:53.528670 | controller | changed: 2025-10-03 07:41:53.528766 | controller | { 2025-10-03 07:41:53.528794 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-03 07:41:53.528816 | controller | } 2025-10-03 07:41:53.828588 | controller | changed: 2025-10-03 07:41:53.828681 | controller | { 2025-10-03 07:41:53.828710 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-03 07:41:53.828731 | controller | } 2025-10-03 07:41:54.121589 | controller | changed: 2025-10-03 07:41:54.121684 | controller | { 2025-10-03 07:41:54.121712 | 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-10-03 07:41:54.121734 | controller | } 2025-10-03 07:41:54.433941 | controller | changed: 2025-10-03 07:41:54.434034 | controller | { 2025-10-03 07:41:54.434062 | 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-10-03 07:41:54.434084 | controller | } 2025-10-03 07:41:54.736425 | controller | changed: 2025-10-03 07:41:54.736527 | controller | { 2025-10-03 07:41:54.736556 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-03 07:41:54.736577 | controller | } 2025-10-03 07:41:55.051838 | controller | changed: 2025-10-03 07:41:55.052051 | controller | { 2025-10-03 07:41:55.052092 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-03 07:41:55.052116 | controller | } 2025-10-03 07:41:55.350760 | controller | changed: 2025-10-03 07:41:55.350988 | controller | { 2025-10-03 07:41:55.351035 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-03 07:41:55.351061 | controller | } 2025-10-03 07:41:55.647244 | controller | changed: 2025-10-03 07:41:55.647355 | controller | { 2025-10-03 07:41:55.647385 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-03 07:41:55.647407 | controller | } 2025-10-03 07:41:55.937743 | controller | changed: 2025-10-03 07:41:55.937834 | controller | { 2025-10-03 07:41:55.937860 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-03 07:41:55.937879 | controller | } 2025-10-03 07:41:56.244244 | controller | changed: 2025-10-03 07:41:56.244429 | controller | { 2025-10-03 07:41:56.244465 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-03 07:41:56.244487 | controller | } 2025-10-03 07:41:56.561287 | controller | changed: 2025-10-03 07:41:56.561402 | controller | { 2025-10-03 07:41:56.561428 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-03 07:41:56.561449 | controller | } 2025-10-03 07:41:56.873927 | controller | changed: 2025-10-03 07:41:56.874015 | controller | { 2025-10-03 07:41:56.874041 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-03 07:41:56.874060 | controller | } 2025-10-03 07:41:57.174577 | controller | changed: 2025-10-03 07:41:57.174667 | controller | { 2025-10-03 07:41:57.174696 | 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-10-03 07:41:57.174718 | controller | } 2025-10-03 07:41:57.493515 | controller | changed: 2025-10-03 07:41:57.493603 | controller | { 2025-10-03 07:41:57.493631 | 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-10-03 07:41:57.493661 | controller | } 2025-10-03 07:41:57.790407 | controller | changed: 2025-10-03 07:41:57.790500 | controller | { 2025-10-03 07:41:57.790527 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-03 07:41:57.790548 | controller | } 2025-10-03 07:41:58.103405 | controller | changed: 2025-10-03 07:41:58.103496 | controller | { 2025-10-03 07:41:58.103525 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-03 07:41:58.103546 | controller | } 2025-10-03 07:41:58.411685 | controller | changed: 2025-10-03 07:41:58.411773 | controller | { 2025-10-03 07:41:58.411799 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-03 07:41:58.411818 | controller | } 2025-10-03 07:41:58.764151 | controller | changed: 2025-10-03 07:41:58.764256 | controller | { 2025-10-03 07:41:58.764428 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-03 07:41:58.764460 | controller | } 2025-10-03 07:41:59.078174 | controller | changed: 2025-10-03 07:41:59.078263 | controller | { 2025-10-03 07:41:59.078290 | 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-10-03 07:41:59.078333 | controller | } 2025-10-03 07:41:59.399049 | controller | changed: 2025-10-03 07:41:59.399153 | controller | { 2025-10-03 07:41:59.399190 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-03 07:41:59.399214 | controller | } 2025-10-03 07:41:59.702050 | controller | changed: 2025-10-03 07:41:59.702139 | controller | { 2025-10-03 07:41:59.702166 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-03 07:41:59.702188 | controller | } 2025-10-03 07:42:00.029271 | controller | changed: 2025-10-03 07:42:00.029372 | controller | { 2025-10-03 07:42:00.029399 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-03 07:42:00.029419 | controller | } 2025-10-03 07:42:00.056133 | 2025-10-03 07:42:00.056237 | TASK [Set timezone to UTC] 2025-10-03 07:42:00.593002 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-03 07:42:00.599033 | 2025-10-03 07:42:00.599113 | TASK [Create nodepool directory] 2025-10-03 07:42:00.913368 | controller | changed 2025-10-03 07:42:00.919869 | 2025-10-03 07:42:00.919976 | TASK [Create nodepool sub_nodes file] 2025-10-03 07:42:01.922070 | controller | changed 2025-10-03 07:42:01.927086 | 2025-10-03 07:42:01.927178 | TASK [Create nodepool sub_nodes_private file] 2025-10-03 07:42:02.940803 | controller | changed 2025-10-03 07:42:02.945755 | 2025-10-03 07:42:02.945820 | LOOP [Populate nodepool sub_nodes file] 2025-10-03 07:42:02.975071 | 2025-10-03 07:42:02.975204 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-03 07:42:03.004083 | 2025-10-03 07:42:03.004216 | TASK [Create nodepool primary file] 2025-10-03 07:42:03.028099 | controller | skipping: Conditional result was False 2025-10-03 07:42:03.033623 | 2025-10-03 07:42:03.033700 | TASK [Create nodepool node_private for this node] 2025-10-03 07:42:04.096777 | controller | changed 2025-10-03 07:42:04.102404 | 2025-10-03 07:42:04.102473 | LOOP [Copy ssh keys to nodepool directory] 2025-10-03 07:42:04.507655 | controller | ok: Item: id_rsa Runtime: 0:00:00.005519 2025-10-03 07:42:04.507829 | 2025-10-03 07:42:04.748850 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.005517 2025-10-03 07:42:04.761009 | 2025-10-03 07:42:04.761127 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-03 07:42:05.838654 | controller | changed 2025-10-03 07:42:05.844618 | 2025-10-03 07:42:05.844712 | TASK [Validate sudoers config after edits] 2025-10-03 07:42:06.154324 | controller | /etc/sudoers: parsed OK 2025-10-03 07:42:06.154419 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-03 07:42:06.154430 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-03 07:42:06.154438 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-03 07:42:06.375695 | controller | ok: Runtime: 0:00:00.007693 2025-10-03 07:42:06.382184 | 2025-10-03 07:42:06.382254 | TASK [Show the environment passed in to job shell scripts] 2025-10-03 07:42:06.660242 | controller | SHELL=/bin/bash 2025-10-03 07:42:06.660304 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-03 07:42:06.660314 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-03 07:42:06.660321 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/62/3362/41f2edaa0ac45cd85919f70775e84cf472326a6e 2025-10-03 07:42:06.660327 | controller | PWD=/home/zuul 2025-10-03 07:42:06.660333 | controller | ZUUL_PIPELINE=github-check 2025-10-03 07:42:06.660339 | controller | LOGNAME=zuul 2025-10-03 07:42:06.660353 | controller | XDG_SESSION_TYPE=tty 2025-10-03 07:42:06.660366 | controller | _=/usr/bin/env 2025-10-03 07:42:06.660371 | controller | MOTD_SHOWN=pam 2025-10-03 07:42:06.660382 | controller | HOME=/home/zuul 2025-10-03 07:42:06.660393 | controller | LANG=en_US.UTF-8 2025-10-03 07:42:06.660405 | controller | SSH_CONNECTION=192.168.26.12 40968 192.168.26.105 22 2025-10-03 07:42:06.660416 | 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-10-03 07:42:06.660483 | controller | ZUUL_CHANGE_IDS=3362,41f2edaa0ac45cd85919f70775e84cf472326a6e 2025-10-03 07:42:06.660493 | controller | WORKSPACE=/home/zuul/workspace 2025-10-03 07:42:06.660499 | controller | XDG_SESSION_CLASS=user 2025-10-03 07:42:06.660505 | controller | SELINUX_ROLE_REQUESTED= 2025-10-03 07:42:06.660510 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-03 07:42:06.660516 | controller | USER=zuul 2025-10-03 07:42:06.660522 | controller | ZUUL_VOTING=True 2025-10-03 07:42:06.660527 | controller | BUILD_TIMEOUT=5400000 2025-10-03 07:42:06.660532 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-03 07:42:06.660538 | controller | SHLVL=1 2025-10-03 07:42:06.660543 | controller | ZUUL_PATCHSET=41f2edaa0ac45cd85919f70775e84cf472326a6e 2025-10-03 07:42:06.660549 | controller | XDG_SESSION_ID=1 2025-10-03 07:42:06.660555 | controller | ZUUL_BRANCH=main 2025-10-03 07:42:06.660560 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-03 07:42:06.660566 | controller | SSH_CLIENT=192.168.26.12 40968 22 2025-10-03 07:42:06.660571 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-03 07:42:06.660577 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-03 07:42:06.660582 | controller | which_declare=declare -f 2025-10-03 07:42:06.660588 | 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-10-03 07:42:06.660594 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-03 07:42:06.660599 | controller | ZUUL_CHANGE=3362 2025-10-03 07:42:06.660605 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-03 07:42:06.660610 | controller | ZUUL_UUID=8d54951453a84f74ac8a6f2f84727919 2025-10-03 07:42:06.660615 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-03 07:42:06.660623 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-03 07:42:06.660628 | controller | } 2025-10-03 07:42:06.911797 | controller | ok: Runtime: 0:00:00.007203 2025-10-03 07:42:06.917765 | 2025-10-03 07:42:06.917839 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-03 07:42:06.931487 | controller | skipping: Conditional result was False 2025-10-03 07:42:06.937693 | 2025-10-03 07:42:06.937771 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-03 07:42:07.489960 | controller | skipping: Conditional result was False 2025-10-03 07:42:07.496203 | 2025-10-03 07:42:07.496348 | TASK [Ensure legacy workspace directory] 2025-10-03 07:42:07.769845 | controller | changed 2025-10-03 07:42:07.791994 | 2025-10-03 07:42:07.792141 | PLAY RECAP 2025-10-03 07:42:07.792199 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-03 07:42:07.792224 | 2025-10-03 07:42:07.878653 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-03 07:42:07.879718 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-10-03 07:42:08.431500 | 2025-10-03 07:42:08.431603 | PLAY [all,!compute] 2025-10-03 07:42:08.451731 | 2025-10-03 07:42:08.451814 | TASK [Enable container-tools rhel-modules for c8/crc node] 2025-10-03 07:42:08.978694 | controller | skipping: Conditional result was False 2025-10-03 07:42:08.986402 | 2025-10-03 07:42:08.986494 | TASK [Install podman] 2025-10-03 07:42:09.021071 | controller | skipping: Conditional result was False 2025-10-03 07:42:09.027021 | 2025-10-03 07:42:09.027104 | TASK [Set var name for quay login zuul secret] 2025-10-03 07:42:09.070395 | controller | skipping: Conditional result was False 2025-10-03 07:42:09.081748 | 2025-10-03 07:42:09.081835 | TASK [Print the username] 2025-10-03 07:42:09.629228 | controller | skipping: Conditional result was False 2025-10-03 07:42:09.635583 | 2025-10-03 07:42:09.635655 | TASK [Fail when user or password is not set] 2025-10-03 07:42:09.679765 | controller | skipping: Conditional result was False 2025-10-03 07:42:09.686098 | 2025-10-03 07:42:09.686171 | TASK [Set vars for quay login] 2025-10-03 07:42:09.725721 | 2025-10-03 07:42:09.725854 | LOOP [Perform container registry login(s) with podman] 2025-10-03 07:42:09.764114 | 2025-10-03 07:42:09.764639 | LOOP [Perform container registry login(s) with buildah] 2025-10-03 07:42:09.803560 | 2025-10-03 07:42:09.803745 | TASK [Set Insecure registry for content provider] 2025-10-03 07:42:09.840079 | controller | skipping: Conditional result was False 2025-10-03 07:42:09.861654 | 2025-10-03 07:42:09.861712 | PLAY RECAP 2025-10-03 07:42:09.861755 | controller | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 9 rescued: 0 ignored: 0 2025-10-03 07:42:09.861779 | 2025-10-03 07:42:09.931228 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-10-03 07:42:09.932028 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/simple-start.yaml@master] 2025-10-03 07:42:10.473934 | 2025-10-03 07:42:10.474045 | PLAY [Prefer ipv4 over ipv6] 2025-10-03 07:42:10.493854 | 2025-10-03 07:42:10.493966 | TASK [Configure /etc/gai.conf to prever ipv4 over ipv6] 2025-10-03 07:42:10.533644 | controller | skipping: Conditional result was False 2025-10-03 07:42:10.554319 | 2025-10-03 07:42:10.554420 | PLAY [controller] 2025-10-03 07:42:10.569158 | 2025-10-03 07:42:10.569245 | TASK [Fail when openshift_pull_sec not provided] 2025-10-03 07:42:10.594090 | controller | skipping: Conditional result was False 2025-10-03 07:42:10.599641 | 2025-10-03 07:42:10.599720 | TASK [Clone repos in the job workspace] 2025-10-03 07:42:10.628806 | controller | ok 2025-10-03 07:42:10.645130 | 2025-10-03 07:42:10.645230 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-03 07:42:11.028530 | controller | ok 2025-10-03 07:42:11.035628 | 2025-10-03 07:42:11.035715 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-03 07:42:13.601194 | controller | Output suppressed because no_log was given 2025-10-03 07:42:13.613442 | 2025-10-03 07:42:13.613556 | TASK [Create pull-secret.txt file] 2025-10-03 07:42:15.023182 | controller | Output suppressed because no_log was given 2025-10-03 07:42:15.030175 | 2025-10-03 07:42:15.030257 | TASK [Apply CRC features and print image build date] 2025-10-03 07:42:15.061701 | controller | ok 2025-10-03 07:42:15.069293 | controller | included: /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/trusted/project_0/review.rdoproject.org/config/playbooks/crc/features.yaml 2025-10-03 07:42:15.075868 | 2025-10-03 07:42:15.075962 | TASK [Set additional parameters for crc - telemetry] 2025-10-03 07:42:15.627583 | controller | skipping: Conditional result was False 2025-10-03 07:42:15.655959 | 2025-10-03 07:42:15.656066 | TASK [Set additional parameters for crc - monitoring] 2025-10-03 07:42:16.191012 | controller | skipping: Conditional result was False 2025-10-03 07:42:16.197254 | 2025-10-03 07:42:16.197479 | TASK [Set minimum required memory to run the CRC when monitoring enabled] 2025-10-03 07:42:16.738517 | controller | skipping: Conditional result was False 2025-10-03 07:42:16.744310 | 2025-10-03 07:42:16.744398 | TASK [Set additional parameters for crc - enable microshift preset] 2025-10-03 07:42:17.277335 | controller | skipping: Conditional result was False 2025-10-03 07:42:17.283859 | 2025-10-03 07:42:17.283983 | TASK [Set additional parameters for crc - enable okd preset] 2025-10-03 07:42:17.817968 | controller | skipping: Conditional result was False 2025-10-03 07:42:17.823954 | 2025-10-03 07:42:17.824040 | TASK [Delete the cluster if there's a non-default bundle URL] 2025-10-03 07:42:18.354459 | controller | skipping: Conditional result was False 2025-10-03 07:42:18.361020 | 2025-10-03 07:42:18.361096 | TASK [Execute crc start command] 2025-10-03 07:45:56.693992 | controller | ok: Runtime: 0:03:37.734675 2025-10-03 07:45:56.699516 | 2025-10-03 07:45:56.699593 | TASK [Verify that OpenShift is up and running] 2025-10-03 07:45:56.718433 | controller | ok 2025-10-03 07:45:56.727720 | controller | included: /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/trusted/project_0/review.rdoproject.org/config/playbooks/crc/verify_openshift_start.yaml 2025-10-03 07:45:56.734564 | 2025-10-03 07:45:56.734644 | TASK [Create script to login and verify services] 2025-10-03 07:45:57.866798 | controller | changed 2025-10-03 07:45:57.872261 | 2025-10-03 07:45:57.872332 | TASK [Ensure that user is logged] 2025-10-03 07:45:58.241534 | controller | Checking login to the cluster 1... 2025-10-03 07:45:58.616747 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:45:58.662255 | controller | 2025-10-03 07:45:58.662324 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:45:58.665971 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:03.668497 | controller | Checking login to the cluster 2... 2025-10-03 07:46:03.752327 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:03.768090 | controller | 2025-10-03 07:46:03.768142 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:46:03.772329 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:08.774266 | controller | Checking login to the cluster 3... 2025-10-03 07:46:08.855850 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:08.870375 | controller | 2025-10-03 07:46:08.870417 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:46:08.874198 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:13.876007 | controller | Checking login to the cluster 4... 2025-10-03 07:46:13.960628 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:13.973764 | controller | 2025-10-03 07:46:13.973826 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:46:13.977470 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:18.979247 | controller | Checking login to the cluster 5... 2025-10-03 07:46:19.060223 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:19.073054 | controller | 2025-10-03 07:46:19.073095 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:46:19.077327 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:24.079020 | controller | Checking login to the cluster 6... 2025-10-03 07:46:24.183875 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:24.197064 | controller | 2025-10-03 07:46:24.197128 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:46:24.200685 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:29.202417 | controller | Checking login to the cluster 7... 2025-10-03 07:46:29.299754 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:29.312659 | controller | 2025-10-03 07:46:29.312698 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:46:29.316444 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:34.318141 | controller | Checking login to the cluster 8... 2025-10-03 07:46:34.416601 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:34.430033 | controller | 2025-10-03 07:46:34.430073 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:46:34.434035 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:39.435787 | controller | Checking login to the cluster 9... 2025-10-03 07:46:39.515596 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:39.530015 | controller | 2025-10-03 07:46:39.530060 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:46:39.534097 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:44.539777 | controller | Checking login to the cluster 10... 2025-10-03 07:46:44.620958 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:44.657612 | controller | 2025-10-03 07:46:44.657658 | controller | Error from server (InternalError): Internal error occurred: unexpected response: 503 2025-10-03 07:46:44.661643 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:49.664077 | controller | Checking login to the cluster 11... 2025-10-03 07:46:49.748148 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:49.782113 | controller | 2025-10-03 07:46:49.782178 | controller | Error from server (InternalError): Internal error occurred: unexpected response: 503 2025-10-03 07:46:49.786102 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:54.787851 | controller | Checking login to the cluster 12... 2025-10-03 07:46:54.867355 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:46:54.899931 | controller | 2025-10-03 07:46:54.900009 | controller | Error from server (InternalError): Internal error occurred: unexpected response: 503 2025-10-03 07:46:54.904435 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:46:59.906903 | controller | Checking login to the cluster 13... 2025-10-03 07:47:00.013915 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:00.080027 | controller | 2025-10-03 07:47:00.080093 | controller | Error from server (InternalError): Internal error occurred: unexpected response: 503 2025-10-03 07:47:00.084514 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:05.088499 | controller | Checking login to the cluster 14... 2025-10-03 07:47:05.197868 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:05.255022 | controller | 2025-10-03 07:47:05.255102 | controller | Error from server (InternalError): Internal error occurred: unexpected response: 503 2025-10-03 07:47:05.262061 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:10.264480 | controller | Checking login to the cluster 15... 2025-10-03 07:47:10.350100 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:10.401605 | controller | 2025-10-03 07:47:10.401689 | controller | Error from server (InternalError): Internal error occurred: unexpected response: 503 2025-10-03 07:47:10.405368 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:15.407411 | controller | Checking login to the cluster 16... 2025-10-03 07:47:15.575056 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:15.772331 | controller | 2025-10-03 07:47:15.772515 | controller | Error from server (InternalError): Internal error occurred: unexpected response: 503 2025-10-03 07:47:15.777433 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:20.779912 | controller | Checking login to the cluster 17... 2025-10-03 07:47:20.883041 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:21.054725 | controller | 2025-10-03 07:47:21.054836 | controller | Error from server (InternalError): Internal error occurred: unexpected response: 503 2025-10-03 07:47:21.058921 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:26.061581 | controller | Checking login to the cluster 18... 2025-10-03 07:47:26.177895 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:26.244747 | controller | 2025-10-03 07:47:26.244818 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:47:26.251364 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:31.254018 | controller | Checking login to the cluster 19... 2025-10-03 07:47:31.353146 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:31.390908 | controller | 2025-10-03 07:47:31.390973 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:47:31.395053 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:36.398205 | controller | Checking login to the cluster 20... 2025-10-03 07:47:36.586593 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:37.951560 | controller | 2025-10-03 07:47:37.951653 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:47:37.955689 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:42.957614 | controller | Checking login to the cluster 21... 2025-10-03 07:47:43.055501 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:43.118023 | controller | 2025-10-03 07:47:43.118103 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:47:43.121521 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:48.125240 | controller | Checking login to the cluster 22... 2025-10-03 07:47:48.301864 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:48.729479 | controller | 2025-10-03 07:47:48.729545 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:47:48.733667 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:53.736720 | controller | Checking login to the cluster 23... 2025-10-03 07:47:53.820644 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:53.854471 | controller | 2025-10-03 07:47:53.854533 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:47:53.858235 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:47:58.860234 | controller | Checking login to the cluster 24... 2025-10-03 07:47:58.954839 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:47:59.027464 | controller | 2025-10-03 07:47:59.027550 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:47:59.031433 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:48:04.033662 | controller | Checking login to the cluster 25... 2025-10-03 07:48:04.417879 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:48:04.889412 | controller | 2025-10-03 07:48:04.889503 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:48:04.893911 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:48:09.895987 | controller | Checking login to the cluster 26... 2025-10-03 07:48:09.981944 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:48:10.024468 | controller | 2025-10-03 07:48:10.024542 | controller | The connection to the server oauth-openshift.apps-crc.testing was refused - did you specify the right host or port? 2025-10-03 07:48:10.028145 | controller | Can not login to the CRC cluster. Sleeping... 2025-10-03 07:48:15.030722 | controller | Checking login to the cluster 27... 2025-10-03 07:48:15.136750 | controller | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-03 07:48:15.688383 | controller | 2025-10-03 07:48:15.688483 | controller | Login successful. 2025-10-03 07:48:15.737573 | controller | 2025-10-03 07:48:15.737652 | controller | You have access to 65 projects, the list has been suppressed. You can list all projects with 'oc projects' 2025-10-03 07:48:15.752107 | controller | 2025-10-03 07:48:15.752133 | controller | Using project "default". 2025-10-03 07:48:16.112027 | controller | changed 2025-10-03 07:48:16.118606 | 2025-10-03 07:48:16.118681 | TASK [Delete all openshift-marketplace pods] 2025-10-03 07:48:16.955673 | controller | pod "certified-operators-f8szs" deleted 2025-10-03 07:48:16.992620 | controller | pod "certified-operators-pdmgz" deleted 2025-10-03 07:48:17.007731 | controller | pod "community-operators-5zsqg" deleted 2025-10-03 07:48:17.025641 | controller | pod "community-operators-z46mz" deleted 2025-10-03 07:48:17.048291 | controller | pod "marketplace-operator-79b997595-d2lpl" deleted 2025-10-03 07:48:17.086239 | controller | pod "redhat-marketplace-4jzjv" deleted 2025-10-03 07:48:17.117792 | controller | pod "redhat-marketplace-ps6xk" deleted 2025-10-03 07:48:17.158007 | controller | pod "redhat-operators-lqrf5" deleted 2025-10-03 07:48:17.210269 | controller | pod "redhat-operators-tqxl9" deleted 2025-10-03 07:50:00.799349 | controller | ok 2025-10-03 07:50:00.805090 | 2025-10-03 07:50:00.805157 | TASK [Copy script ensure_services_up.sh] 2025-10-03 07:50:00.838810 | controller | skipping: Conditional result was False 2025-10-03 07:50:00.845369 | 2025-10-03 07:50:00.845441 | TASK [Ensure all pods are up and running] 2025-10-03 07:50:01.377845 | controller | skipping: Conditional result was False 2025-10-03 07:50:01.389576 | 2025-10-03 07:50:01.389683 | TASK [Check if there is a image build date file] 2025-10-03 07:50:01.683703 | controller | ok 2025-10-03 07:50:01.694277 | 2025-10-03 07:50:01.694404 | TASK [Print image date if available] 2025-10-03 07:50:01.962781 | controller | Tue Apr 1 06:17:46 PM EDT 2025 2025-10-03 07:50:02.220366 | controller | changed 2025-10-03 07:50:02.225830 | 2025-10-03 07:50:02.225895 | TASK [Fix machineconfigpool] 2025-10-03 07:50:02.260168 | controller | skipping: Conditional result was False 2025-10-03 07:50:02.267189 | 2025-10-03 07:50:02.267265 | TASK [Show available nodes] 2025-10-03 07:50:02.781847 | controller | NAME STATUS ROLES AGE VERSION 2025-10-03 07:50:02.783882 | controller | crc Ready control-plane,master,worker 222d v1.31.5 2025-10-03 07:50:02.821203 | controller | ok: Runtime: 0:00:00.213723 2025-10-03 07:50:02.830022 | 2025-10-03 07:50:02.830098 | TASK [Configure insecure registry inside crc vm] 2025-10-03 07:50:02.856027 | controller | skipping: Conditional result was False 2025-10-03 07:50:02.861868 | 2025-10-03 07:50:02.861972 | TASK [Catch CRC IP] 2025-10-03 07:50:03.224206 | controller | 192.168.130.11 2025-10-03 07:50:03.409510 | controller | changed 2025-10-03 07:50:03.415265 | 2025-10-03 07:50:03.415345 | TASK [Check if id_ed25519 key exists] 2025-10-03 07:50:03.717946 | controller | ok 2025-10-03 07:50:03.723529 | 2025-10-03 07:50:03.723600 | TASK [Set fact if new keypair exists] 2025-10-03 07:50:03.753876 | controller | ok 2025-10-03 07:50:03.759959 | 2025-10-03 07:50:03.760047 | TASK [Run crc] 2025-10-03 07:50:04.846478 | controller | 2025-10-03 07:50:19.183100 | controller | PLAY [OpenShift secret copy and CRC securitization] **************************** 2025-10-03 07:50:19.183225 | controller | 2025-10-03 07:50:19.183235 | controller | TASK [Gathering Facts] ********************************************************* 2025-10-03 07:50:19.183257 | controller | [WARNING]: Platform linux on host 192.168.130.11 is using the discovered Python 2025-10-03 07:50:19.223544 | controller | interpreter at /usr/bin/python3.9, but future installation of another Python 2025-10-03 07:50:19.223622 | controller | interpreter could change the meaning of that path. See 2025-10-03 07:50:19.223631 | controller | https://docs.ansible.com/ansible- 2025-10-03 07:50:19.223637 | controller | core/2.14/reference_appendices/interpreter_discovery.html for more information. 2025-10-03 07:50:19.223656 | controller | ok: [192.168.130.11] 2025-10-03 07:50:22.335195 | controller | 2025-10-03 07:50:22.335426 | controller | TASK [Copy pull-secret] ******************************************************** 2025-10-03 07:50:22.335450 | controller | changed: [192.168.130.11] 2025-10-03 07:50:23.695575 | controller | 2025-10-03 07:50:23.695625 | controller | TASK [Add crio config] ********************************************************* 2025-10-03 07:50:23.695651 | controller | changed: [192.168.130.11] 2025-10-03 07:50:28.638495 | controller | 2025-10-03 07:50:28.638611 | controller | TASK [Restart crio to pickup new configuration] ******************************** 2025-10-03 07:50:28.638653 | controller | changed: [192.168.130.11] 2025-10-03 07:50:28.697310 | controller | 2025-10-03 07:50:28.697473 | controller | PLAY RECAP ********************************************************************* 2025-10-03 07:50:28.697492 | controller | 192.168.130.11 : ok=4 changed=3 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2025-10-03 07:50:28.697502 | controller | 2025-10-03 07:50:28.822999 | controller | changed 2025-10-03 07:50:28.829076 | 2025-10-03 07:50:28.829223 | TASK [Set slower etcd profile] 2025-10-03 07:50:28.870204 | controller | ok 2025-10-03 07:50:28.895969 | 2025-10-03 07:50:28.896087 | TASK [prepare-crc-cloud : Set slower profile] 2025-10-03 07:50:29.400190 | controller | etcd.operator.openshift.io/cluster patched 2025-10-03 07:50:29.444346 | controller | ok 2025-10-03 07:50:29.449731 | 2025-10-03 07:50:29.449833 | TASK [prepare-crc-cloud : Wait 30 seconds to apply] 2025-10-03 07:50:59.479827 | controller | ok 2025-10-03 07:50:59.484618 | 2025-10-03 07:50:59.484684 | TASK [prepare-crc-cloud : Get pod phase status] 2025-10-03 07:54:49.177509 | controller | ok 2025-10-03 07:54:49.191618 | 2025-10-03 07:54:49.191730 | TASK [Set limit for disk usage - IOPS and Read/Write] 2025-10-03 07:54:49.282671 | controller | ok 2025-10-03 07:54:49.294760 | controller | included: /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/trusted/project_0/review.rdoproject.org/config/playbooks/crc/limit-disk-usage.yaml 2025-10-03 07:54:49.312796 | 2025-10-03 07:54:49.312922 | TASK [Set facts for disk limitation] 2025-10-03 07:54:49.350338 | controller | ok 2025-10-03 07:54:49.361358 | 2025-10-03 07:54:49.361452 | TASK [Print limits for the disk] 2025-10-03 07:54:49.396980 | controller | ok: Set limit to crc VM to the vda disk: iops 18000 read/write 262144000 2025-10-03 07:54:49.409591 | 2025-10-03 07:54:49.409705 | TASK [Set limit to crc VM to the vda disk] 2025-10-03 07:54:49.762382 | controller | 2025-10-03 07:54:49.959239 | controller | changed 2025-10-03 07:54:49.964967 | 2025-10-03 07:54:49.965068 | TASK [Pause machineconfigpool] 2025-10-03 07:54:50.016689 | controller | ok 2025-10-03 07:54:50.055731 | 2025-10-03 07:54:50.055844 | LOOP [prepare-crc-cloud : Pause the machineconfig configuration if mcp is not needed] 2025-10-03 07:55:50.441575 | controller | ERROR: Item: master 2025-10-03 07:55:50.441854 | controller | { 2025-10-03 07:55:50.441893 | controller | "ansible_loop_var": "item", 2025-10-03 07:55:50.441940 | controller | "delta": "0:01:00.098620", 2025-10-03 07:55:50.441964 | controller | "end": "2025-10-03 07:55:50.408375", 2025-10-03 07:55:50.441984 | controller | "failed_when_result": true, 2025-10-03 07:55:50.442002 | controller | "item": "master", 2025-10-03 07:55:50.442020 | controller | "msg": "non-zero return code", 2025-10-03 07:55:50.442038 | controller | "rc": 1, 2025-10-03 07:55:50.442056 | controller | "start": "2025-10-03 07:54:50.309755" 2025-10-03 07:55:50.442098 | controller | } 2025-10-03 07:55:55.253763 | controller | ok failure 2025-10-03 07:55:55.261648 | 2025-10-03 07:55:55.261718 | PLAY RECAP 2025-10-03 07:55:55.261765 | controller | ok: 23 changed: 10 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2025-10-03 07:55:55.261790 | 2025-10-03 07:55:55.359295 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/simple-start.yaml@master] 2025-10-03 07:55:55.360280 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-10-03 07:55:55.894288 | 2025-10-03 07:55:55.894429 | PLAY [Report DLRN results after job run] 2025-10-03 07:55:55.916347 | 2025-10-03 07:55:55.916442 | TASK [Report job status to DLRN] 2025-10-03 07:55:55.935136 | controller | ok 2025-10-03 07:55:55.959167 | 2025-10-03 07:55:55.959273 | TASK [dlrn_report : Warning if DLRN is not running] 2025-10-03 07:55:56.003394 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.009617 | 2025-10-03 07:55:56.009704 | TASK [dlrn_report : Install dlrnapi-client shyaml package] 2025-10-03 07:55:56.054099 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.060486 | 2025-10-03 07:55:56.060585 | TASK [dlrn_report : Install kinit related package] 2025-10-03 07:55:56.115045 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.121175 | 2025-10-03 07:55:56.121384 | TASK [dlrn_report : Install dlrn kerberos related packages] 2025-10-03 07:55:56.165702 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.172776 | 2025-10-03 07:55:56.172859 | TASK [Set zuul-log-path fact] 2025-10-03 07:55:56.217174 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.223465 | 2025-10-03 07:55:56.223558 | TASK [dlrn_report : Set the the value of cifmw_repo_setup_promotion when multiple dlrn tags are used] 2025-10-03 07:55:56.270250 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.276483 | 2025-10-03 07:55:56.276563 | TASK [Get hash related data from repo_setup role] 2025-10-03 07:55:56.315248 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.322019 | 2025-10-03 07:55:56.322110 | TASK [dlrn_report : Perform kinit for DLRN kerberos authentication] 2025-10-03 07:55:56.860544 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.866807 | 2025-10-03 07:55:56.867126 | TASK [dlrn_report : Set empty value for dlrnapi password] 2025-10-03 07:55:56.912490 | controller | skipping: Conditional result was False 2025-10-03 07:55:56.919349 | 2025-10-03 07:55:56.919447 | TASK [dlrn_report : Report results to dlrn for the tested hash] 2025-10-03 07:55:57.459371 | controller | skipping: Conditional result was False 2025-10-03 07:55:57.496304 | 2025-10-03 07:55:57.496449 | PLAY RECAP 2025-10-03 07:55:57.496506 | controller | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 10 rescued: 0 ignored: 0 2025-10-03 07:55:57.496532 | 2025-10-03 07:55:57.605615 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-10-03 07:55:57.606384 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-03 07:55:58.156029 | 2025-10-03 07:55:58.156151 | PLAY [all] 2025-10-03 07:55:58.175783 | 2025-10-03 07:55:58.175883 | TASK [include_role : fetch-output] 2025-10-03 07:55:58.205744 | controller | ok 2025-10-03 07:55:58.223410 | 2025-10-03 07:55:58.223514 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-03 07:55:58.278046 | controller | skipping: Conditional result was False 2025-10-03 07:55:58.283769 | 2025-10-03 07:55:58.283876 | TASK [fetch-output : Set log path for single node] 2025-10-03 07:55:58.322789 | controller | ok 2025-10-03 07:55:58.328044 | 2025-10-03 07:55:58.328141 | LOOP [fetch-output : Ensure local output dirs] 2025-10-03 07:55:58.705098 | controller -> localhost | ok: "/var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/work/logs" 2025-10-03 07:55:58.914175 | controller -> localhost | changed: "/var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/work/artifacts" 2025-10-03 07:55:59.123847 | controller -> localhost | changed: "/var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/work/docs" 2025-10-03 07:55:59.133600 | 2025-10-03 07:55:59.133673 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-03 07:55:59.871338 | controller | changed: .d..t...... ./ 2025-10-03 07:55:59.871645 | controller | changed: All items complete 2025-10-03 07:55:59.871680 | 2025-10-03 07:56:00.375169 | controller | changed: .d..t...... ./ 2025-10-03 07:56:00.898981 | controller | changed: .d..t...... ./ 2025-10-03 07:56:00.914056 | 2025-10-03 07:56:00.914163 | TASK [include_role : fetch-output-openshift] 2025-10-03 07:56:00.929506 | controller | skipping: Conditional result was False 2025-10-03 07:56:00.937708 | 2025-10-03 07:56:00.937793 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-03 07:56:01.302421 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006752 2025-10-03 07:56:01.502440 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006459 2025-10-03 07:56:01.531130 | 2025-10-03 07:56:01.531230 | PLAY [all] 2025-10-03 07:56:01.546282 | 2025-10-03 07:56:01.546405 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-03 07:56:02.022793 | controller | changed 2025-10-03 07:56:02.046415 | 2025-10-03 07:56:02.046511 | PLAY RECAP 2025-10-03 07:56:02.046556 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-03 07:56:02.046577 | 2025-10-03 07:56:02.128951 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-03 07:56:02.129717 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-03 07:56:02.736595 | 2025-10-03 07:56:02.736730 | PLAY [localhost] 2025-10-03 07:56:02.755854 | 2025-10-03 07:56:02.756023 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-03 07:56:03.089554 | localhost | changed 2025-10-03 07:56:03.094336 | 2025-10-03 07:56:03.094427 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-03 07:56:03.131776 | localhost | ok 2025-10-03 07:56:03.139627 | 2025-10-03 07:56:03.139702 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-03 07:56:03.472615 | localhost | changed 2025-10-03 07:56:03.478324 | 2025-10-03 07:56:03.478398 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-03 07:56:04.085400 | localhost | changed 2025-10-03 07:56:04.090362 | 2025-10-03 07:56:04.090432 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-03 07:56:04.437303 | localhost | Identity added: /var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/work/tmp/ansible.q42xey3p (/var/lib/zuul/builds/8d54951453a84f74ac8a6f2f84727919/work/tmp/ansible.q42xey3p) 2025-10-03 07:56:04.437473 | localhost | ok: Runtime: 0:00:00.008353 2025-10-03 07:56:04.441988 | 2025-10-03 07:56:04.442065 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-03 07:56:04.683077 | localhost | ok: Runtime: 0:00:00.004542 2025-10-03 07:56:04.687686 | 2025-10-03 07:56:04.687758 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-03 07:56:04.736245 | localhost | changed 2025-10-03 07:56:04.740337 | 2025-10-03 07:56:04.740406 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-03 07:56:05.092043 | localhost | changed 2025-10-03 07:56:05.112675 | 2025-10-03 07:56:05.112768 | PLAY [localhost] 2025-10-03 07:56:05.126728 | 2025-10-03 07:56:05.126808 | TASK [Generate bulk log download script] 2025-10-03 07:56:05.144899 | localhost | ok 2025-10-03 07:56:05.157578 | 2025-10-03 07:56:05.157668 | TASK [local-log-download : Check API endpoint is defined] 2025-10-03 07:56:05.185457 | localhost | ok: All assertions passed 2025-10-03 07:56:05.190370 | 2025-10-03 07:56:05.190452 | TASK [local-log-download : Create download script] 2025-10-03 07:56:05.589668 | localhost -> localhost | changed 2025-10-03 07:56:05.598903 | 2025-10-03 07:56:05.598996 | TASK [Register quick-download link] 2025-10-03 07:56:05.616337 | localhost | ok 2025-10-03 07:56:05.652973 | 2025-10-03 07:56:05.653062 | PLAY [logserver.rdoproject.org] 2025-10-03 07:56:05.662745 | 2025-10-03 07:56:05.662809 | TASK [Set zuul-log-path fact] 2025-10-03 07:56:05.689047 | logserver.rdoproject.org | ok 2025-10-03 07:56:05.699177 | 2025-10-03 07:56:05.699249 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-03 07:56:05.736057 | logserver.rdoproject.org | ok 2025-10-03 07:56:05.742215 | 2025-10-03 07:56:05.742284 | TASK [upload-logs : Create log directories] 2025-10-03 07:56:07.474204 | logserver.rdoproject.org | changed 2025-10-03 07:56:07.477584 | 2025-10-03 07:56:07.477649 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-03 07:56:07.706842 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.004293 2025-10-03 07:56:07.711519 | 2025-10-03 07:56:07.711583 | TASK [upload-logs : Upload logs to log server] 2025-10-03 07:56:09.163690 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-03 07:56:09.168414 | 2025-10-03 07:56:09.168488 | LOOP [upload-logs : Compress console log and json output] 2025-10-03 07:56:09.231477 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-03 07:56:09.241581 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-03 07:56:09.249971 | 2025-10-03 07:56:09.250071 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-03 07:56:09.309550 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-03 07:56:09.309797 | 2025-10-03 07:56:09.312347 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-03 07:56:09.324439 | 2025-10-03 07:56:09.324518 | LOOP [upload-logs : Upload console log and json output]