I0620 15:16:59.777510 1 log.go:26] update status StatefulApp sapp-ob-test {"cluster":"cn","clusterStatus":"Prepareing","subsets":[{"name":"zone1","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone1-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone1-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-obagent-conf-file","phase":"Pending"}]}]},{"name":"zone2","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone2-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone2-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-obagent-conf-file","phase":"Pending"}]}]},{"name":"zone3","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone3-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone3-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-obagent-conf-file","phase":"Pending"}]}]}]}
I0620 15:17:04.805994 1 log.go:26] update status StatefulApp sapp-ob-test {"cluster":"cn","clusterStatus":"Prepareing","subsets":[{"name":"zone1","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone1-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone1-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone2","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone2-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone2-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone3","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone3-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone3-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-obagent-conf-file","phase":"Pending"}]}]}]}
I0620 15:17:14.861043 1 log.go:26] update status StatefulApp sapp-ob-test {"cluster":"cn","clusterStatus":"Prepareing","subsets":[{"name":"zone1","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone1-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone1-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone2","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone2-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone2-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone3","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone3-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone3-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-data-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-obagent-conf-file","phase":"Bound"}]}]}]}
I0620 15:17:24.916263 1 log.go:26] update status StatefulApp sapp-ob-test {"cluster":"cn","clusterStatus":"Prepareing","subsets":[{"name":"zone1","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone1-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone1-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-log","phase":"Pending"},{"name":"sapp-ob-test-cn-zone1-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone2","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone2-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone2-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone3","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone3-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone3-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone3-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-obagent-conf-file","phase":"Bound"}]}]}]}
I0620 15:17:29.947631 1 log.go:26] update status StatefulApp sapp-ob-test {"cluster":"cn","clusterStatus":"Prepareing","subsets":[{"name":"zone1","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone1-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"172.16.44.133","pvcs":[{"name":"sapp-ob-test-cn-zone1-0-data-file","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone2","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone2-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"","pvcs":[{"name":"sapp-ob-test-cn-zone2-0-data-file","phase":"Pending"},{"name":"sapp-ob-test-cn-zone2-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone3","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone3-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"172.16.44.135","pvcs":[{"name":"sapp-ob-test-cn-zone3-0-data-file","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-obagent-conf-file","phase":"Bound"}]}]}]}
I0620 15:17:34.972000 1 log.go:26] update status StatefulApp sapp-ob-test {"cluster":"cn","clusterStatus":"Prepareing","subsets":[{"name":"zone1","region":"region1","expectedReplicas":1,"availableReplicas":1,"pods":[{"name":"sapp-ob-test-cn-zone1-0","index":0,"podPhase":"Running","podIP":"172.18.251.65","nodeIP":"172.16.44.133","pvcs":[{"name":"sapp-ob-test-cn-zone1-0-data-file","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone2","region":"region1","expectedReplicas":1,"availableReplicas":0,"pods":[{"name":"sapp-ob-test-cn-zone2-0","index":0,"podPhase":"Pending","podIP":"","nodeIP":"172.16.44.134","pvcs":[{"name":"sapp-ob-test-cn-zone2-0-data-file","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone3","region":"region1","expectedReplicas":1,"availableReplicas":1,"pods":[{"name":"sapp-ob-test-cn-zone3-0","index":0,"podPhase":"Running","podIP":"172.18.75.172","nodeIP":"172.16.44.135","pvcs":[{"name":"sapp-ob-test-cn-zone3-0-data-file","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-obagent-conf-file","phase":"Bound"}]}]}]}
I0620 15:17:34.980342 1 log.go:26] update status StatefulApp sapp-ob-test {"cluster":"cn","clusterStatus":"Prepareing","subsets":[{"name":"zone1","region":"region1","expectedReplicas":1,"availableReplicas":1,"pods":[{"name":"sapp-ob-test-cn-zone1-0","index":0,"podPhase":"Running","podIP":"172.18.251.65","nodeIP":"172.16.44.133","pvcs":[{"name":"sapp-ob-test-cn-zone1-0-data-file","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone1-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone2","region":"region1","expectedReplicas":1,"availableReplicas":1,"pods":[{"name":"sapp-ob-test-cn-zone2-0","index":0,"podPhase":"Running","podIP":"172.18.11.50","nodeIP":"172.16.44.134","pvcs":[{"name":"sapp-ob-test-cn-zone2-0-data-file","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone2-0-obagent-conf-file","phase":"Bound"}]}]},{"name":"zone3","region":"region1","expectedReplicas":1,"availableReplicas":1,"pods":[{"name":"sapp-ob-test-cn-zone3-0","index":0,"podPhase":"Running","podIP":"172.18.75.172","nodeIP":"172.16.44.135","pvcs":[{"name":"sapp-ob-test-cn-zone3-0-data-file","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-data-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-log","phase":"Bound"},{"name":"sapp-ob-test-cn-zone3-0-obagent-conf-file","phase":"Bound"}]}]}]}
E0620 15:17:35.289786 1 service.go:51] Service "svc-ob-test" not found
E0620 15:17:35.289808 1 service.go:51] Service "svc-ob-test" not found
I0620 15:17:35.297205 1 log.go:28] core.(*OBClusterCtrl).ResourcePrepareingEffectorForBootstrap update OBCluster ob-test to Resource Ready Zone Status
E0620 15:17:35.778523 1 service.go:51] Service "svc-ob-test" not found
E0620 15:17:35.778543 1 service.go:51] Service "svc-ob-test" not found
E0620 15:17:35.779054 1 cable_executer.go:49] OBCluster observer 172.18.251.65 starting not ready
I0620 15:17:35.780327 1 cable_executer.go:41] start observer 172.18.251.65 succeed {"clusterId":1,"clusterName":"ob-test","cpuLimit":8,"customParameters":[{"name":"log_disk_size","value":"250G"}],"memoryLimit":64,"rsList":"172.18.251.65:2882:2881;172.18.11.50:2882:2881;172.18.75.172:2882:2881","version":"4.1.0.0","zoneName":"zone1"}
E0620 15:17:35.781005 1 cable_executer.go:49] OBCluster observer 172.18.11.50 starting not ready
I0620 15:17:35.782391 1 cable_executer.go:41] start observer 172.18.11.50 succeed {"clusterId":1,"clusterName":"ob-test","cpuLimit":8,"customParameters":[{"name":"log_disk_size","value":"250G"}],"memoryLimit":64,"rsList":"172.18.251.65:2882:2881;172.18.11.50:2882:2881;172.18.75.172:2882:2881","version":"4.1.0.0","zoneName":"zone2"}
E0620 15:17:35.782917 1 cable_executer.go:49] OBCluster observer 172.18.75.172 starting not ready
I0620 15:17:35.783946 1 cable_executer.go:41] start observer 172.18.75.172 succeed {"clusterId":1,"clusterName":"ob-test","cpuLimit":8,"customParameters":[{"name":"log_disk_size","value":"250G"}],"memoryLimit":64,"rsList":"172.18.251.65:2882:2881;172.18.11.50:2882:2881;172.18.75.172:2882:2881","version":"4.1.0.0","zoneName":"zone3"}
I0620 15:17:35.787938 1 log.go:28] core.(*OBClusterCtrl).ResourceReadyEffectorForBootstrap update OBCluster ob-test to OBServer Prepareing Zone Status
E0620 15:17:35.788656 1 cable_executer.go:49] OBCluster ob-test observer 172.18.251.65 starting not ready
E0620 15:17:40.116602 1 cable_executer.go:49] OBCluster ob-test observer 172.18.251.65 starting not ready
E0620 15:17:44.942632 1 cable_executer.go:49] OBCluster ob-test observer 172.18.251.65 starting not ready
E0620 15:17:49.768326 1 cable_executer.go:49] OBCluster ob-test observer 172.18.251.65 starting not ready
E0620 15:17:54.595742 1 service.go:51] Service "svc-ob-test" not found
E0620 15:17:54.595760 1 service.go:51] Service "svc-ob-test" not found
I0620 15:17:54.601343 1 log.go:28] core.(*OBClusterCtrl).OBServerPrepareingEffectorForBootstrap update OBCluster ob-test to OBServer Ready Zone Status
I0620 15:17:54.601531 1 cable_converter.go:104] OBCluster bootstrap args ALTER SYSTEM BOOTSTRAP REGION 'region1' ZONE 'zone1' SERVER '172.18.251.65:2882', REGION 'region1' ZONE 'zone2' SERVER '172.18.11.50:2882', REGION 'region1' ZONE 'zone3' SERVER '172.18.75.172:2882'
E0620 15:17:54.601597 1 service.go:51] Service "svc-ob-test" not found
E0620 15:17:54.601617 1 service.go:51] Service "svc-ob-test" not found
I0620 15:17:54.609150 1 log.go:28] core.(*OBClusterCtrl).OBServerReadyEffectorForBootstrap update OBCluster ob-test to OBCluster Bootstraping Zone Status
E0620 15:17:54.609261 1 secret.go:51] Secret "secret-ob-test-sys-admin" not found
E0620 15:17:54.974262 1 conn.go:38] 1049 Unknown database 'oceanbase'
I0620 15:17:54.974289 1 pod_controller.go:84] try empty database
E0620 15:18:05.031688 1 sql_operator.go:49] execute sql: ALTER SYSTEM BOOTSTRAP REGION 'region1' ZONE 'zone1' SERVER '172.18.251.65:2882', REGION 'region1' ZONE 'zone2' SERVER '172.18.11.50:2882', REGION 'region1' ZONE 'zone3' SERVER '172.18.75.172:2882' failed
E0620 15:18:05.031703 1 sql_operator.go:50] 4012 Timeout
(/workspace/pkg/controllers/observer/sql/sql_operator.go:46)
[2023-06-20 15:18:05] Error 4012: Timeout