社区版OCP 3.3.0重启ocp容器报错

追逐着阳光与黑暗 · 2022 年9 月 29 日 11:01

【使用环境】测试环境
【 OB or 其他组件】ocp-server
【使用版本】3.3.0
【问题描述】因主机断电，后续开机后执行docker restart ocp命令，发现ocp容器起不来。查看ocp-server日志有如下报错：
:: Spring Boot :: (v2.3.9.RELEASE)
:: OCP Server :: (v3.3.0-20220427)

2022-09-29 10:22:59.462 INFO 4027 — [ main] o.s.c.c.s.e.NativeEnvironmentRepository : Adding property source: classpath:/application.properties
2022-09-29 10:23:00.032 ERROR 4027 — [ main] c.a.o.s.analyzer.OcpFailureAnalyzer : OCP startup check failed with cause:

org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection; nested exception is java.sql.SQLNonTransientConnectionException: Could not connect to address=(host=192.168.11.211)(port=2883)(type=master) : Could not connect to 192.168.11.211:2883 : unexpected end of stream, read 0 bytes from 4 (socket was closed by server)
at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:82) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:612) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:669) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:700) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:712) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.cloud.config.server.environment.JdbcEnvironmentRepository.findOne(JdbcEnvironmentRepository.java:102) ~[spring-cloud-config-server-2.2.5.RELEASE.jar!/:2.2.5.RELEASE]
at org.springframework.cloud.config.server.environment.EnvironmentRepository.findOne(EnvironmentRepository.java:31) ~[spring-cloud-config-server-2.2.5.RELEASE.jar!/:2.2.5.RELEASE]
at org.springframework.cloud.config.server.environment.CompositeEnvironmentRepository.findOne(CompositeEnvironmentRepository.java:66) ~[spring-cloud-config-server-2.2.5.RELEASE.jar!/:2.2.5.RELEASE]
at org.springframework.cloud.config.server.environment.EnvironmentRepositoryPropertySourceLocator.locate(EnvironmentRepositoryPropertySourceLocator.java:55) ~[spring-cloud-config-server-2.2.5.RELEASE.jar!/:2.2.5.RELEASE]
at org.springframework.cloud.bootstrap.config.PropertySourceLocator.locateCollection(PropertySourceLocator.java:52) ~[spring-cloud-context-2.2.5.RELEASE.jar!/:2.2.5.RELEASE]
at org.springframework.cloud.bootstrap.config.PropertySourceLocator.locateCollection(PropertySourceLocator.java:47) ~[spring-cloud-context-2.2.5.RELEASE.jar!/:2.2.5.RELEASE]
at org.springframework.cloud.bootstrap.config.PropertySourceBootstrapConfiguration.initialize(PropertySourceBootstrapConfiguration.java:98) ~[spring-cloud-context-2.2.5.RELEASE.jar!/:2.2.5.RELEASE]
at org.springframework.boot.SpringApplication.applyInitializers(SpringApplication.java:626) [spring-boot-2.3.9.RELEASE.jar!/:2.3.9.RELEASE]
at org.springframework.boot.SpringApplication.prepareContext(SpringApplication.java:370) [spring-boot-2.3.9.RELEASE.jar!/:2.3.9.RELEASE]
at org.springframework.boot.SpringApplication.run(SpringApplication.java:314) [spring-boot-2.3.9.RELEASE.jar!/:2.3.9.RELEASE]
at org.springframework.boot.SpringApplication.run(SpringApplication.java:1237) [spring-boot-2.3.9.RELEASE.jar!/:2.3.9.RELEASE]
at org.springframework.boot.SpringApplication.run(SpringApplication.java:1226) [spring-boot-2.3.9.RELEASE.jar!/:2.3.9.RELEASE]
at com.alipay.ocp.OcpServerApplication.main(OcpServerApplication.java:23) [classes!/:3.3.0-20220427]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_312]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_312]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_312]
at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_312]
at org.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:49) [ocp-server-3.3.0-20220427.jar:3.3.0-20220427]
at org.springframework.boot.loader.Launcher.launch(Launcher.java:107) [ocp-server-3.3.0-20220427.jar:3.3.0-20220427]
at org.springframework.boot.loader.Launcher.launch(Launcher.java:58) [ocp-server-3.3.0-20220427.jar:3.3.0-20220427]
at org.springframework.boot.loader.PropertiesLauncher.main(PropertiesLauncher.java:467) [ocp-server-3.3.0-20220427.jar:3.3.0-20220427]
Caused by: java.sql.SQLNonTransientConnectionException: Could not connect to address=(host=192.168.11.211)(port=2883)(type=master) : Could not connect to 192.168.11.211:2883 : unexpected end of stream, read 0 bytes from 4 (socket was closed by server)
at com.oceanbase.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:120) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:235) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.protocol.AbstractConnectProtocol.connectWithoutProxy(AbstractConnectProtocol.java:1505) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.util.Utils.retrieveProxy(Utils.java:1187) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.OceanBaseConnection.newConnection(OceanBaseConnection.java:294) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.Driver.connect(Driver.java:88) ~[oceanbase-client-2.2.7.jar!/:na]
at java.sql.DriverManager.getConnection(DriverManager.java:664) ~[na:1.8.0_312]
at java.sql.DriverManager.getConnection(DriverManager.java:208) ~[na:1.8.0_312]
at org.springframework.jdbc.datasource.DriverManagerDataSource.getConnectionFromDriverManager(DriverManagerDataSource.java:155) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.datasource.DriverManagerDataSource.getConnectionFromDriver(DriverManagerDataSource.java:146) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.datasource.AbstractDriverBasedDataSource.getConnectionFromDriver(AbstractDriverBasedDataSource.java:205) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.datasource.AbstractDriverBasedDataSource.getConnection(AbstractDriverBasedDataSource.java:169) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.datasource.DataSourceUtils.fetchConnection(DataSourceUtils.java:158) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.datasource.DataSourceUtils.doGetConnection(DataSourceUtils.java:116) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:79) ~[spring-jdbc-5.2.4.RELEASE.jar!/:5.2.4.RELEASE]
… 25 common frames omitted
Caused by: java.sql.SQLNonTransientConnectionException: Could not connect to 192.168.11.211:2883 : unexpected end of stream, read 0 bytes from 4 (socket was closed by server)
at com.oceanbase.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:120) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:225) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.protocol.AbstractConnectProtocol.createConnection(AbstractConnectProtocol.java:588) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.protocol.AbstractConnectProtocol.connectWithoutProxy(AbstractConnectProtocol.java:1500) ~[oceanbase-client-2.2.7.jar!/:na]
… 37 common frames omitted
Caused by: java.io.EOFException: unexpected end of stream, read 0 bytes from 4 (socket was closed by server)
at com.oceanbase.jdbc.internal.io.input.StandardPacketInputStream.getPacketArray(StandardPacketInputStream.java:249) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.io.input.StandardPacketInputStream.getPacket(StandardPacketInputStream.java:217) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.protocol.AbstractConnectProtocol.authenticationHandler(AbstractConnectProtocol.java:700) ~[oceanbase-client-2.2.7.jar!/:na]
at com.oceanbase.jdbc.internal.protocol.AbstractConnectProtocol.createConnection(AbstractConnectProtocol.java:576) ~[oceanbase-client-2.2.7.jar!/:na]
… 38 common frames omitted

2022-09-29 10:23:00.040 ERROR 4027 — [ main] o.s.b.d.LoggingFailureAnalysisReporter :

APPLICATION FAILED TO START

Description:

OCP application startup check failed.

Action:

Please check the stack trace above for the root cause.

【复现路径】
开机后，首先启动docker。然后启动/home/admin下的oceanbase、obproxy，使用的命令bin/observer，bin/obproxy
接着执行docker start ocp

【问题现象及影响】
使用mysql -h192.168.11.211 -P2883 -umeta_user@meta_tenant#obcluster -p -c -A oceanbase连接，提示ERROR 2013 (HY000): Lost connection to MySQL server at ‘reading authorization packet’, system error: 0

影响：无法访问ocp页面

【附件】

和顺 · 2022 年9 月 29 日 11:05

先验证一下ocp使用的meta OB是否正常
（1）直连observer (默认2881端口）验证，如果成功，再进行第（2）点
（2）确认ocp meta OB 使用的obproxy 是否启动成功，一般只要端口正常，默认端口2883
（3）看问题现象中提到 ERROR 2013 (HY000): Lost connection to MySQL server at ‘reading authorization packet’, system error: 0
请重新登录触发一下报错，然后将对应的obproxy的日志附件发出来看看:obproxy.log和obproxy_error.log

追逐着阳光与黑暗 · 2022 年9 月 29 日 11:09

直连报错如下：
[root@centos log]# mysql -h192.168.11.211 -P2881 -umeta_user@meta_tenant#obcluster -p -c -A oceanbase
Enter password:
ERROR 1045 (42000): Access denied for user ‘meta_user’@‘xxx.xxx.xxx.xxx’ (using password: YES)

和顺 · 2022 年9 月 29 日 11:35

直连的时候不能带（#集群名）。

追逐着阳光与黑暗 · 2022 年9 月 29 日 12:20

obproxy_error.log日志：
2022-09-29 00:18:04.899369,undefined,obcluster:monitor_tenant:,OB_MYSQL,OB_MYSQL_COM_LOGIN,failed,-4152,16312us,0us,0us,0us,Y0-7F088FF943A0,0,Null value
2022-09-29 00:18:07.645200,undefined,obcluster:monitor_tenant:,OB_MYSQL,OB_MYSQL_COM_LOGIN,failed,-4152,8892us,0us,0us,0us,Y0-7F08909F8260,0,Null value
2022-09-29 00:18:11.546987,undefined,obcluster:meta_tenant:,OB_MYSQL,OB_MYSQL_COM_LOGIN,failed,-4152,17333us,0us,0us,0us,Y0-7F088FF943A0,0,Null value

obproxy.log日志：
[2022-09-29 00:15:14.945069] INFO [PROXY.SOCK] ob_connection.cpp:367 [40932][Y0-0] [lt=41] [dc=0] connection accepted(client={192.168.11.211:46432}, server={0.0.0.0:2883}, accepted_fd=78, listen_fd=77)
[2022-09-29 00:15:14.945219] INFO [PROXY.NET] ob_mysql_session_accept.cpp:36 [40899][Y0-7F088FF962E0] [lt=9] [dc=0] [ObMysqlSessionAccept:main_event] accepted connection(netvc=0x7f088ff8fa30, client_ip={192.168.11.211:46432})
[2022-09-29 00:15:14.945296] INFO [PROXY.CS] ob_mysql_client_session.cpp:363 [40899][Y0-7F088FF962E0] [lt=30] [dc=0] client session born(cs_id=4762, proxy_sessid=0, is_local_connection=false, client_vc=0x7f088ff8fa30, client_fd=78, client_addr=“192.168.11.211:46432”)
[2022-09-29 00:15:14.945349] INFO [PROXY.CS] ob_mysql_client_session.cpp:234 [40899][Y0-7F088FF962E0] [lt=24] [dc=0] Starting new transaction using sm(cs_id=4762, get_transact_count()=0, sm_id=6200)
[2022-09-29 00:15:14.945374] INFO [PROXY.SM] ob_mysql_sm.cpp:474 [40899][Y0-7F088FF962E0] [lt=12] [dc=0] the request already in buffer, continue to handle it(buffer len=0, is_auth_rquest=true)
[2022-09-29 00:15:14.947715] INFO [PROXY] ob_vip_tenant_conn.cpp:160 [40899][Y0-7F088FF962E0] [lt=12] [dc=0] vip tenant connect is not in vip_tenant_conn_cache(key_name=meta_tenant#obcluster|, ret=-4018)
[2022-09-29 00:15:14.947748] INFO [PROXY.SM] ob_mysql_sm.cpp:2159 [40899][Y0-7F088FF962E0] [lt=29] [dc=0] client login audit(client_addr={192.168.11.211:46432}, hsr.cluster_name_=obcluster, hsr.tenant_name_=meta_tenant, hsr.user_name_=meta_user, status=“success”)
[2022-09-29 00:15:14.947787] INFO [PROXY] ob_resource_pool_processor.cpp:1980 [40899][Y0-7F088FF962E0] [lt=16] [dc=0] can not find cluster resource, maybe it has not been created yet(cluster_info_key={cluster_name:{config_string:“obcluster”}, cluster_id:0}, ret=-4018)
[2022-09-29 00:15:14.947807] INFO [PROXY] ob_resource_pool_processor.cpp:2049 [40899][Y0-7F088FF962E0] [lt=19] [dc=0] fail to acuqire avail cluster resource in local, will schedule task to create and init new cluster resource(cluster_name=obcluster, cluster_id=0)
[2022-09-29 00:15:14.947853] INFO [PROXY] ob_resource_pool_processor.cpp:1000 [40899][Y0-7F088FF962E0] [lt=7] [dc=0] ObClusterResourceCreateCont::main_handler(event=“CLUSTER_RESOURCE_CREATE_EVENT”, init_status=0, cluster_name=obcluster, cluster_id=0, data=0x7f0899c8d780)
[2022-09-29 00:15:14.947901] INFO [PROXY] ob_resource_pool_processor.cpp:2121 [40899][Y0-7F088FF962E0] [lt=41] [dc=0] will create new cluster resource(cluster_name=obcluster, cluster_id=0, cr_version=2051)
[2022-09-29 00:15:14.948214] INFO [PROXY] ob_route_utils.cpp:1056 [40899][Y0-7F088FF962E0] [lt=18] [dc=0] update sys tenant all_dummy succ((cluster_name=obcluster, tmp_entry={{this:0x7f0899b77fa0, ref_count:2, cr_version:0, cr_id:0, create_time_us:1664424914948164, last_valid_time_us:1664424914947847, last_access_time_us:1664424914947847, last_update_time_us:0, schema_version:0, tenant_version:0, time_for_expired:0, state:“AVAIL”}, this:0x7f0899b77fa0, is_inited:true, is_dummy_entry:true, is_entry_from_rslist:false, is_empty_entry_allowed:false, is_need_force_flush:false, has_dup_replica:false, cr_id:0, name:{cluster_name:“obcluster”, tenant_name:“sys”, database_name:“oceanbase”, package_name:"", table_name:“all_dummy"}, table_id:1099511627911, table_type:“UNKNOWN”, part_num:1, replica_num:1, buf_len:32, buf_start:0x7f0899b780a0, tenant_servers:{this:0x7f0899ae3070, is_inited:true, server_count:1, replica_count:1, partition_count:1, next_partition_idx:0, server_array:0x7f08918d86d0, server_array:[[0]{server:“192.168.11.211:2881”, is_dup_replica:false, role:“FOLLOWER”, type:“FULL”}]}})
[2022-09-29 00:15:14.948299] INFO [PROXY] ob_resource_pool_processor.cpp:844 [40899][Y0-7F088FF962E0] [lt=82] [dc=0] will add INIT_SS_INFO task(this=0x7f0891691b50, cluster_name=obcluster, cluster_id=0)
[2022-09-29 00:15:14.948353] INFO [PROXY.CS] ob_mysql_client_session.cpp:540 [40899][Y0-7F088FF962E0] [lt=11] [dc=0] proxy mysql client session born(cs_id=2147488411)
[2022-09-29 00:15:14.948378] INFO [PROXY.CS] ob_mysql_client_session.cpp:363 [40899][Y0-7F088FF962E0] [lt=13] [dc=0] client session born(cs_id=2147488411, proxy_sessid=0, is_local_connection=true, client_vc=0x7f08909a0590, client_fd=0, client_addr=“0.0.0.0”)
[2022-09-29 00:15:14.948407] INFO [PROXY.CS] ob_mysql_client_session.cpp:234 [40899][Y0-7F088FF962E0] [lt=13] [dc=0] Starting new transaction using sm(cs_id=2147488411, get_transact_count()=0, sm_id=6201)
[2022-09-29 00:15:14.948429] INFO [PROXY.SM] ob_mysql_sm.cpp:474 [40899][Y0-7F088FF962E0] [lt=12] [dc=0] the request already in buffer, continue to handle it(buffer len=0, is_auth_rquest=true)
[2022-09-29 00:15:14.948595] INFO [PROXY.CS] ob_mysql_client_session.cpp:1599 [40899][Y0-7F088FF962E0] [lt=24] [dc=0] base servers has not added, treat all tenant server as ok(tenant_server={this:0x7f0899ae3070, is_inited:true, server_count:1, replica_count:1, partition_count:1, next_partition_idx:0, server_array:0x7f08918d86d0, server_array:[[0]{server:“192.168.11.211:2881”, is_dup_replica:false, role:“FOLLOWER”, type:“FULL”}]}, ret=0)
[2022-09-29 00:15:14.948942] INFO [PROXY.SS] ob_mysql_server_session.cpp:105 [40899][Y0-7F088FF962E0] [lt=42] [dc=0] server session born(ss_id=4199, server_ip={192.168.11.211:2881}, cs_id=2147488411, proxy_sessid=0, server_type=1)
[2022-09-29 00:15:14.949162] INFO [PROXY.TXN] ob_mysql_transact.cpp:3516 [40899][Y0-7F088FF962E0] [lt=32] [dc=0] succ to set proxy_sessid(cs_id=2147488411, proxy_sessid=13882358852424503299, server_ip={192.168.11.211:2881}, ss_id=4199, server_sessid=3221493225, is_proxy_mysql_client=true, ss_fd=81, client_addr=“192.168.11.211:58774”)
[2022-09-29 00:15:14.951484] WARN [PROXY.SM] print_mysql_complete_log (ob_mysql_sm.cpp:4435) [40899][Y0-7F088FF962E0] [lt=62] [dc=0] finishing mysql tunnel((sm_id=6201, cs_id=2147488411, proxy_sessid=13882358852424503299, ss_id=4199, server_sessid=3221493225, client_ip={Not IP address [0]:0}, server_ip={192.168.11.211:2881}, server_trace_id=, proxy_user_name=proxyro@sys#obcluster, database_name=, is_flow_controlled=false, cpu_flow_control_count=0, memory_flow_control_count=0, sql=, sql_cmd=“Login”, result={is_trans_completed:true, is_resp_completed:true, ending_type:2, is_partition_hit:true, has_new_sys_var:false, has_proxy_idc_name_user_var:false, is_server_db_reset:false, reserved_len:0, connection_id:0, scramble_buf:”", is_resultset_resp:false, server_capabilities_lower.capability:0, ok_packet_action_type:2, last_ok_pkt_len:12, rewritten_last_ok_pkt_len:0, error_pkt:field_count:255, errcode:1045, sqlstate:“42000”, message:“Access denied for user ‘proxyro’@‘xxx.xxx.xxx.xxx’ (using password: NO)”})
[2022-09-29 00:15:14.951668] INFO [PROXY.SM] ob_mysql_sm.cpp:536 [40899][Y0-7F088FF962E0] [lt=141] [dc=0] ObMysqlSM::state_client_request_read(event=“VC_EVENT_EOS”, sm_id=6201, client_vc=0x7f08909a0590)
[2022-09-29 00:15:14.951700] INFO [PROXY.TXN] ob_mysql_transact.cpp:78 [40899][Y0-7F088FF962E0] [lt=29] [dc=0] [ObMysqlTransact::bad_request] parser marked request bad
[2022-09-29 00:15:14.951741] WARN [PROXY.SM] setup_error_transfer (ob_mysql_sm.cpp:7159) [40899][Y0-7F088FF962E0] [lt=39] [dc=0] [setup_error_transfer] Now closing connection(sm_id=6201, request_cmd=“Sleep”, sql_cmd=“End”, sql=)
[2022-09-29 00:15:14.951796] INFO [PROXY.SS] ob_mysql_server_session.cpp:145 [40899][Y0-7F088FF962E0] [lt=49] [dc=0] server session do_io_close((*this={ss_id:4199, server_sessid:3221493225, server_ip:{192.168.11.211:2881}, is_inited:true, magic:19136237, state:2, server_vc:0x7f08909b42d0, client_session:{this:0x7f08927a06b0, is_proxy_mysql_client:true, is_waiting_trans_first_request:false, need_delete_cluster:false, is_first_dml_sql_got:true, vc_ready_killed:false, active:false, magic:19132429, conn_decrease:true, current_tid:40899, cs_id:2147488411, proxy_sessid:13882358852424503299, session_info:{is_inited:true, priv_info:{has_all_privilege:false, cs_id:2147488411, user_priv_set:-1, cluster_name:“obcluster”, tenant_name:“sys”, user_name:“proxyro”}, version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:0, sys_var_version:0, user_var_version:0, db_name_version:0, last_insert_id_version:0}, hash_version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:0, sys_var_version:0, user_var_version:0, db_name_version:0, last_insert_id_version:0}, val_hash:{common_hot_sys_var_hash:0, common_cold_sys_var_hash:0, mysql_hot_sys_var_hash:0, mysql_cold_sys_var_hash:0, hot_sys_var_hash:0, cold_sys_var_hash:0, user_var_hash:0}, global_vars_version:-1, is_global_vars_changed:false, is_trans_specified:false, is_user_idc_name_set:false, is_read_consistency_set:false, idc_name:"", cluster_id:0, real_meta_cluster_name:"", safe_read_snapshot:0, syncing_safe_read_snapshot:0, route_policy:1, proxy_route_policy:3, user_identity:4, global_vars_version:-1, is_read_only_user:false, is_request_follower_user:false}, dummy_ldc:{use_ldc:false, idc_name:"", item_count:1, site_start_index_array:[[0]0, [1]1, [2]1, [3]1], item_array:[[0]{idc_type:“SAME_IDC”, zone_type:“ReadWrite”, replica:{server:“192.168.11.211:2881”, is_dup_replica:false, role:“FOLLOWER”, type:“FULL”}, is_merging:false, is_partition_server:false, is_force_congested:false, is_used:false}], pl:null, ts:0x7f0899ae3070, readonly_exist_status:“READONLY_ZONE_NOT_EXIST”}, dummy_entry:0x7f0899b77fa0, server_state_version:0, cur_ss:null, bound_ss:0x7f08909b48b0, lii_ss:null, cluster_resource:{this:0x7f0897fbf080, ref_count:5, is_inited:true, cluster_info_key:{cluster_name:{config_string:“obcloud”}, cluster_id:0}, cr_state:“CR_BORN”, version:1, last_access_time_ns:0, deleting_completed_thread_num:0, fetch_rslist_task_count:0, fetch_idc_list_task_count:0, last_idc_list_refresh_time_ns:0, last_rslist_refresh_time_ns:0, server_state_version:0}, client_vc:0x7f08909a0590, using_ldg:false, trace_stats:NULL}, transact_count:1, server_trans_stat:0, session_info:{cap:0, ob_server:“0.0.0.0”, version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:0, sys_var_version:0, user_var_version:0, db_name_version:0, last_insert_id_version:0}, val_hash:{common_hot_sys_var_hash:0, common_cold_sys_var_hash:0, mysql_hot_sys_var_hash:0, mysql_cold_sys_var_hash:0, hot_sys_var_hash:0, cold_sys_var_hash:0, user_var_hash:0}, checksum_switch:1, server_type:1}}, server_vc=0x7f08909b42d0, this=0x7f08909b48b0)
[2022-09-29 00:15:14.951958] INFO [PROXY.SS] ob_mysql_server_session.cpp:177 [40899][Y0-7F088FF962E0] [lt=152] [dc=0] server session is closing(ss_id=4199, server_sessid=3221493225, server_ip={192.168.11.211:2881}, cs_id=2147488411, proxy_sessid=13882358852424503299)
[2022-09-29 00:15:14.951987] INFO [PROXY.CS] ob_mysql_client_session.cpp:91 [40899][Y0-7F088FF962E0] [lt=10] [dc=0] client session destroy(cs_id=2147488411, proxy_sessid=13882358852424503299, client_vc=NULL)
[2022-09-29 00:15:14.952011] INFO [PROXY.SM] ob_mysql_sm.cpp:7696 [40899][Y0-7F088FF962E0] [lt=7] [dc=0] deallocating sm(sm_id=6201)
[2022-09-29 00:15:14.952048] WARN [PROXY] get_resultset_fetcher (ob_client_utils.cpp:244) [40899][Y0-7F088FF962E0] [lt=22] [dc=0] fail to execute sql(ret=-1045)
[2022-09-29 00:15:14.952099] WARN [PROXY] next (ob_client_utils.cpp:223) [40899][Y0-7F088FF962E0] [lt=49] [dc=0] fail to get rs_fetcher(ret=-1045)
[2022-09-29 00:15:14.952145] WARN [PROXY] finish_task (ob_resource_pool_processor.cpp:584) [40899][Y0-7F088FF962E0] [lt=45] [dc=0] fail to get server state info(ret=-1045)
[2022-09-29 00:15:14.952226] WARN [PROXY] handle_event_complete (ob_async_common_task.cpp:150) [40899][Y0-7F088FF962E0] [lt=74] [dc=0] fail to do finish task(task_name=“server_state_info_init_task”, ret=-1045)
[2022-09-29 00:15:14.952292] WARN [PROXY] main_handler (ob_async_common_task.cpp:59) [40899][Y0-7F088FF962E0] [lt=65] [dc=0] fail to handle event complete(ret=-1045)
[2022-09-29 00:15:14.952373] INFO [PROXY] ob_resource_pool_processor.cpp:1000 [40899][Y0-7F088FF962E0] [lt=77] [dc=0] ObClusterResourceCreateCont::main_handler(event=“ASYNC_TASK_DONE_EVENT”, init_status=3, cluster_name=obcluster, cluster_id=0, data=0x13074ed0)
[2022-09-29 00:15:14.952385] INFO [PROXY] ob_resource_pool_processor.cpp:1100 [40899][Y0-7F088FF962E0] [lt=11] [dc=0] local rs list cannot work, try to get newest rs list(init_status=3)
[2022-09-29 00:15:14.952394] INFO [PROXY] ob_resource_pool_processor.cpp:824 [40899][Y0-7F088FF962E0] [lt=8] [dc=0] will add INIT_RS task(this=0x7f0891691b50, cluster_name=obcluster, cluster_id=0)
[2022-09-29 00:15:14.952600] INFO [PROXY] ob_resource_pool_processor.cpp:1000 [40899][Y0-7F088FF962E0] [lt=8] [dc=0] ObClusterResourceCreateCont::main_handler(event=“ASYNC_TASK_DONE_EVENT”, init_status=1, cluster_name=obcluster, cluster_id=0, data=0x13074fb0)
[2022-09-29 00:15:14.952628] INFO [PROXY] ob_resource_pool_processor.cpp:844 [40899][Y0-7F088FF962E0] [lt=26] [dc=0] will add INIT_SS_INFO task(this=0x7f0891691b50, cluster_name=obcluster, cluster_id=0)
[2022-09-29 00:15:14.952708] INFO [PROXY.CS] ob_mysql_client_session.cpp:540 [40899][Y0-7F088FF962E0] [lt=9] [dc=0] proxy mysql client session born(cs_id=2147488412)
[2022-09-29 00:15:14.952723] INFO [PROXY.CS] ob_mysql_client_session.cpp:363 [40899][Y0-7F088FF962E0] [lt=7] [dc=0] client session born(cs_id=2147488412, proxy_sessid=0, is_local_connection=true, client_vc=0x7f08909a0590, client_fd=0, client_addr=“0.0.0.0”)
[2022-09-29 00:15:14.952759] INFO [PROXY.CS] ob_mysql_client_session.cpp:234 [40899][Y0-7F088FF962E0] [lt=22] [dc=0] Starting new transaction using sm(cs_id=2147488412, get_transact_count()=0, sm_id=6202)
[2022-09-29 00:15:14.952773] INFO [PROXY.SM] ob_mysql_sm.cpp:474 [40899][Y0-7F088FF962E0] [lt=9] [dc=0] the request already in buffer, continue to handle it(buffer len=0, is_auth_rquest=true)
[2022-09-29 00:15:14.952879] INFO [PROXY.CS] ob_mysql_client_session.cpp:1599 [40899][Y0-7F088FF962E0] [lt=16] [dc=0] base servers has not added, treat all tenant server as ok(tenant_server={this:0x7f0899ae3070, is_inited:true, server_count:1, replica_count:1, partition_count:1, next_partition_idx:0, server_array:0x7f08918d86d0, server_array_:[[0]{server:“192.168.11.211:2881”, is_dup_replica:false, role:“FOLLOWER”, type:“FULL”}]}, ret=0)
[2022-09-29 00:15:14.953149] INFO [PROXY.SS] ob_mysql_server_session.cpp:105 [40899][Y0-7F088FF962E0] [lt=34] [dc=0] server session born(ss_id=4200, server_ip={192.168.11.211:2881}, cs_id=2147488412, proxy_sessid=0, server_type=1)
[2022-09-29 00:15:14.953346] INFO [PROXY.TXN] ob_mysql_transact.cpp:3516 [40899][Y0-7F088FF962E0] [lt=27] [dc=0] succ to set proxy_sessid(cs_id=2147488412, proxy_sessid=13882358852424503300, server_ip={192.168.11.211:2881}, ss_id=4200, server_sessid=3221493226, is_proxy_mysql_client=true, ss_fd=82, client_addr=“192.168.11.211:58776”)
[2022-09-29 00:15:14.955322] WARN [PROXY.SM] print_mysql_complete_log (ob_mysql_sm.cpp:4435) [40899][Y0-7F088FF962E0] [lt=51] [dc=0] finishing mysql tunnel((sm_id=6202, cs_id=2147488412, proxy_sessid=13882358852424503300, ss_id=4200, server_sessid=3221493226, client_ip={Not IP address [0]:0}, server_ip={192.168.11.211:2881}, server_trace_id=, proxy_user_name=proxyro@sys#obcluster, database_name=, is_flow_controlled=false, cpu_flow_control_count=0, memory_flow_control_count=0, sql=, sql_cmd=“Login”, result={is_trans_completed:true, is_resp_completed:true, ending_type:2, is_partition_hit:true, has_new_sys_var:false, has_proxy_idc_name_user_var:false, is_server_db_reset:false, reserved_len:0, connection_id:0, scramble_buf:"", is_resultset_resp:false, server_capabilities_lower_.capability:0, ok_packet_action_type:2, last_ok_pkt_len:12, rewritten_last_ok_pkt_len:0, error_pkt:field_count:255, errcode:1045, sqlstate:“42000”, message:“Access denied for user ‘proxyro’@‘xxx.xxx.xxx.xxx’ (using password: NO)”})
[2022-09-29 00:15:14.955467] INFO [PROXY.SM] ob_mysql_sm.cpp:536 [40899][Y0-7F088FF962E0] [lt=110] [dc=0] ObMysqlSM::state_client_request_read(event=“VC_EVENT_EOS”, sm_id=6202, client_vc=0x7f08909a0590)
[2022-09-29 00:15:14.955481] INFO [PROXY.TXN] ob_mysql_transact.cpp:78 [40899][Y0-7F088FF962E0] [lt=13] [dc=0] [ObMysqlTransact::bad_request] parser marked request bad
[2022-09-29 00:15:14.955491] WARN [PROXY.SM] setup_error_transfer (ob_mysql_sm.cpp:7159) [40899][Y0-7F088FF962E0] [lt=8] [dc=0] [setup_error_transfer] Now closing connection(sm_id=6202, request_cmd=“Sleep”, sql_cmd=“End”, sql=)
[2022-09-29 00:15:14.955548] INFO [PROXY.SS] ob_mysql_server_session.cpp:145 [40899][Y0-7F088FF962E0] [lt=51] [dc=0] server session do_io_close((*this={ss_id:4200, server_sessid:3221493226, server_ip:{192.168.11.211:2881}, is_inited:true, magic:19136237, state:2, server_vc:0x7f08909a86d0, client_session:{this:0x7f08927a06b0, is_proxy_mysql_client:true, is_waiting_trans_first_request:false, need_delete_cluster:false, is_first_dml_sql_got:true, vc_ready_killed:false, active:false, magic:19132429, conn_decrease:true, current_tid:40899, cs_id:2147488412, proxy_sessid:13882358852424503300, session_info:{is_inited:true, priv_info:{has_all_privilege:false, cs_id:2147488412, user_priv_set:-1, cluster_name:“obcluster”, tenant_name:“sys”, user_name:“proxyro”}, version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:0, sys_var_version:0, user_var_version:0, db_name_version:0, last_insert_id_version:0}, hash_version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:0, sys_var_version:0, user_var_version:0, db_name_version:0, last_insert_id_version:0}, val_hash:{common_hot_sys_var_hash:0, common_cold_sys_var_hash:0, mysql_hot_sys_var_hash:0, mysql_cold_sys_var_hash:0, hot_sys_var_hash:0, cold_sys_var_hash:0, user_var_hash:0}, global_vars_version:-1, is_global_vars_changed:false, is_trans_specified:false, is_user_idc_name_set:false, is_read_consistency_set:false, idc_name:"", cluster_id:0, real_meta_cluster_name:"", safe_read_snapshot:0, syncing_safe_read_snapshot:0, route_policy:1, proxy_route_policy:3, user_identity:4, global_vars_version:-1, is_read_only_user:false, is_request_follower_user:false}, dummy_ldc:{use_ldc:false, idc_name:"", item_count:1, site_start_index_array:[[0]0, [1]1, [2]1, [3]1], item_array:[[0]{idc_type:“SAME_IDC”, zone_type:“ReadWrite”, replica:{server:“192.168.11.211:2881”, is_dup_replica:false, role:“FOLLOWER”, type:“FULL”}, is_merging:false, is_partition_server:false, is_force_congested:false, is_used:false}], pl:null, ts:0x7f0899ae3070, readonly_exist_status:“READONLY_ZONE_NOT_EXIST”}, dummy_entry:0x7f0899b77fa0, server_state_version:0, cur_ss:null, bound_ss:0x7f08909b48b0, lii_ss:null, cluster_resource:{this:0x7f0897fbf080, ref_count:5, is_inited:true, cluster_info_key:{cluster_name:{config_string:“obcloud”}, cluster_id:0}, cr_state:“CR_BORN”, version:1, last_access_time_ns:0, deleting_completed_thread_num:0, fetch_rslist_task_count:0, fetch_idc_list_task_count:0, last_idc_list_refresh_time_ns:0, last_rslist_refresh_time_ns:0, server_state_version:0}, client_vc:0x7f08909a0590, using_ldg:false, trace_stats:NULL}, transact_count:1, server_trans_stat:0, session_info:{cap:0, ob_server:“0.0.0.0”, version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:0, sys_var_version:0, user_var_version:0, db_name_version:0, last_insert_id_version:0}, val_hash:{common_hot_sys_var_hash:0, common_cold_sys_var_hash:0, mysql_hot_sys_var_hash:0, mysql_cold_sys_var_hash:0, hot_sys_var_hash:0, cold_sys_var_hash:0, user_var_hash:0}, checksum_switch:1, server_type:1}}, server_vc_=0x7f08909a86d0, this=0x7f08909b48b0)
[2022-09-29 00:15:14.955695] INFO [PROXY.SS] ob_mysql_server_session.cpp:177 [40899][Y0-7F088FF962E0] [lt=139] [dc=0] server session is closing(ss_id=4200, server_sessid=3221493226, server_ip={192.168.11.211:2881}, cs_id=2147488412, proxy_sessid=13882358852424503300)
[2022-09-29 00:15:14.955766] INFO [PROXY.CS] ob_mysql_client_session.cpp:91 [40899][Y0-7F088FF962E0] [lt=53] [dc=0] client session destroy(cs_id=2147488412, proxy_sessid=13882358852424503300, client_vc=NULL)
[2022-09-29 00:15:14.955785] INFO [PROXY.SM] ob_mysql_sm.cpp:7696 [40899][Y0-7F088FF962E0] [lt=7] [dc=0] deallocating sm(sm_id=6202)
[2022-09-29 00:15:14.955799] WARN [PROXY] get_resultset_fetcher (ob_client_utils.cpp:244) [40899][Y0-7F088FF962E0] [lt=4] [dc=0] fail to execute sql(ret=-1045)
[2022-09-29 00:15:14.955869] WARN [PROXY] next (ob_client_utils.cpp:223) [40899][Y0-7F088FF962E0] [lt=69] [dc=0] fail to get rs_fetcher(ret=-1045)
[2022-09-29 00:15:14.955961] WARN [PROXY] finish_task (ob_resource_pool_processor.cpp:584) [40899][Y0-7F088FF962E0] [lt=91] [dc=0] fail to get server state info(ret=-1045)
[2022-09-29 00:15:14.956018] WARN [PROXY] handle_event_complete (ob_async_common_task.cpp:150) [40899][Y0-7F088FF962E0] [lt=51] [dc=0] fail to do finish task(task_name=“server_state_info_init_task”, ret=-1045)
[2022-09-29 00:15:14.956099] WARN [PROXY] main_handler (ob_async_common_task.cpp:59) [40899][Y0-7F088FF962E0] [lt=80] [dc=0] fail to handle event complete(ret=-1045)
[2022-09-29 00:15:14.956146] INFO [PROXY] ob_resource_pool_processor.cpp:1000 [40899][Y0-7F088FF962E0] [lt=45] [dc=0] ObClusterResourceCreateCont::main_handler(event=“ASYNC_TASK_DONE_EVENT”, init_status=3, cluster_name=obcluster, cluster_id=0, data=0x13074ed0)
[2022-09-29 00:15:14.956157] INFO [PROXY] ob_resource_pool_processor.cpp:1227 [40899][Y0-7F088FF962E0] [lt=7] [dc=0] cluster resource create complete(created_cr={this:0x7f089811b580, ref_count:3, is_inited:true, cluster_info_key:{cluster_name:{config_string:“obcluster”}, cluster_id:0}, cr_state:“CR_INIT_FAILED”, version:2051, last_access_time_ns:0, deleting_completed_thread_num:0, fetch_rslist_task_count:0, fetch_idc_list_task_count:0, last_idc_list_refresh_time_ns:0, last_rslist_refresh_time_ns:1664424914951634340, server_state_version:0}, pending_list_count=0)
[2022-09-29 00:15:14.956174] INFO [PROXY] ob_resource_pool_processor.cpp:1656 [40899][Y0-7F088FF962E0] [lt=15] [dc=0] ObClusterResource will destroy, and wait to be free(this={this:0x7f089811b580, ref_count:0, is_inited:true, cluster_info_key:{cluster_name:{config_string:“obcluster”}, cluster_id:0}, cr_state:“CR_INIT_FAILED”, version:2051, last_access_time_ns:0, deleting_completed_thread_num:0, fetch_rslist_task_count:0, fetch_idc_list_task_count:0, last_idc_list_refresh_time_ns:0, last_rslist_refresh_time_ns:1664424914951634340, server_state_version:0})
[2022-09-29 00:15:14.956194] INFO [PROXY] ob_mysql_proxy.h:173 [40899][Y0-7F088FF962E0] [lt=9] [dc=0] client pool will be destroyed(client_pool={this:0x7f08981752c0, ref_count:4, is_inited:true, stop:false, mc_count:2, cluster_resource:0x7f0897fbf080})
[2022-09-29 00:15:14.956214] INFO [PROXY] ob_congestion_manager.cpp:103 [40899][Y0-7F088FF962E0] [lt=7] [dc=0] ObCongestionManager will destroy(this={this:0x7f089811c680, is_inited:true, is_base_servers_added:false, is_congestion_enabled:true, zone_count:0, config:{ref_count:1, this:0x7f0898189660, conn_failure_threshold:5, alive_failure_threshold:5, fail_window_sec:120, retry_interval_sec:20, min_keep_congestion_interval_sec:20}})
[2022-09-29 00:15:14.956252] INFO [PROXY] ob_resource_pool_processor.cpp:1614 [40899][Y0-7F088FF962E0] [lt=26] [dc=0] the cluster resource will free(this={this:0x7f089811b580, ref_count:0, is_inited:false, cluster_info_key:{cluster_name:{config_string:“obcluster”}, cluster_id:0}, cr_state:“CR_DEAD”, version:2051, last_access_time_ns:0, deleting_completed_thread_num:0, fetch_rslist_task_count:0, fetch_idc_list_task_count:0, last_idc_list_refresh_time_ns:0, last_rslist_refresh_time_ns:1664424914951634340, server_state_version:0})
[2022-09-29 00:15:14.956264] INFO [PROXY] ob_congestion_manager.cpp:103 [40899][Y0-7F088FF962E0] [lt=9] [dc=0] ObCongestionManager will destroy(this={this:0x7f089811c680, is_inited:false, is_base_servers_added:false, is_congestion_enabled:true, zone_count:0, config:NULL})
[2022-09-29 00:15:14.956342] INFO [PROXY] ob_resource_pool_processor.cpp:1000 [40899][Y0-7F088FF962E0] [lt=6] [dc=0] ObClusterResourceCreateCont::main_handler(event=“CLUSTER_RESOURCE_INFORM_OUT_EVENT”, init_status=3, cluster_name=obcluster, cluster_id=0, data=0x7f0899c8e0e0)
[2022-09-29 00:15:14.956374] INFO [PROXY] ob_mysql_client_pool.cpp:135 [40905][Y0-7F0891938410] [lt=85] [dc=0] all mysql client has been scheduled to destroy self(deleted_count=2)
[2022-09-29 00:15:14.956359] WARN [PROXY.SM] state_get_cluster_resource (ob_mysql_sm.cpp:1647) [40899][Y0-7F088FF962E0] [lt=14] [dc=0] data is NULL(sm_id=6200, ret=-4152)
[2022-09-29 00:15:14.956396] INFO [PROXY] ob_client_vc.cpp:587 [40905][Y0-7F089818C3C0] [lt=15] [dc=0] mysql client active timeout(active_timeout_ms=0, next_action=1, info={user_name:“proxyro@sys#obcluster:0”, database_name:“oceanbase”, request_param:{sql:"", is_deep_copy:false, current_idc_name:"", is_user_idc_name_set:false, need_print_trace_stat:false}})
[2022-09-29 00:15:14.956423] INFO [PROXY] ob_client_vc.cpp:1102 [40905][Y0-7F089818C3C0] [lt=26] [dc=0] mysql client will kill self(this=0x7f08981824a0)
[2022-09-29 00:15:14.956441] INFO [PROXY] ob_client_vc.cpp:587 [40905][Y0-7F089818C280] [lt=14] [dc=0] mysql client active timeout(active_timeout_ms=0, next_action=1, info={user_name:“proxyro@sys#obcluster:0”, database_name:“oceanbase”, request_param:{sql:"", is_deep_copy:false, current_idc_name:"", is_user_idc_name_set:false, need_print_trace_stat:false}})
[2022-09-29 00:15:14.956456] INFO [PROXY] ob_client_vc.cpp:1102 [40905][Y0-7F089818C280] [lt=13] [dc=0] mysql client will kill self(this=0x7f0898182ce0)
[2022-09-29 00:15:14.956465] INFO [PROXY] ob_mysql_client_pool.cpp:203 [40905][Y0-7F089818C280] [lt=7] [dc=0] client pool will be free(this={this:0x7f08981752c0, ref_count:0, is_inited:false, stop:true, mc_count:2, cluster_resource:0x7f0897fbf080})
[2022-09-29 00:15:14.956412] WARN [PROXY.TXN] handle_error_jump (ob_mysql_transact.cpp:65) [40899][Y0-7F088FF962E0] [lt=50] [dc=0] [ObMysqlTransact::handle_error_jump]
[2022-09-29 00:15:14.956483] WARN [PROXY.SM] setup_error_transfer (ob_mysql_sm.cpp:7159) [40899][Y0-7F088FF962E0] [lt=69] [dc=0] [setup_error_transfer] Now closing connection(sm_id=6200, request_cmd=“Sleep”, sql_cmd=“Login”, sql=OB_MYSQL_COM_LOGIN)
[2022-09-29 00:15:14.956596] INFO [PROXY.CS] ob_mysql_client_session.cpp:91 [40899][Y0-7F088FF962E0] [lt=5] [dc=0] client session destroy(cs_id=4762, proxy_sessid=0, client_vc=NULL)
[2022-09-29 00:15:14.956625] INFO [PROXY.SM] ob_mysql_sm.cpp:7696 [40899][Y0-7F088FF962E0] [lt=6] [dc=0] deallocating sm(sm_id=6200)
^C
[root@centos log]#

和顺 · 2022 年9 月 29 日 13:18

message:“Access denied for user ‘proxyro’@‘xxx.xxx.xxx.xxx’ (using password: NO)”})

直连是否正常呢？正常的话，确认一下：
select user,host,password from mysql.user where user=‘proxyro’;

另外登录到ocp meta OB使用的root@proxysys
mysql -h${obproxy_IP} -P2883 -uroot@proxysys -pxxx
执行：show proxyconfig like ‘observer_sys_password’;

追逐着阳光与黑暗 · 2022 年9 月 29 日 14:16

直连查询无结果：
MySQL [(none)]> select user,host,password from mysql.user where user=‘proxyro’;
Empty set (0.05 sec)

MySQL [(none)]>

使用root@proxysys登录到ocp meta OB：
[root@centos log]# mysql -h192.168.11.211 -P2883 -uroot@proxysys -p
Enter password:
ERROR 1045 (42000): Access denied for user ‘root@proxysys’@‘192.168.11.211’ (using password: YES)
[root@centos log]#

这个root@proxysys的密码是不是安装的时候config.yaml中ob_cluster.root_password？我用的这个报上述错误。

和顺 · 2022 年9 月 29 日 15:35

问题基本明确了，就是缺少proxyro用户相关的信息
1、ocp的版本是3.3.0 还是 3.3.0-bp1 ?
2、ocp meta OB是如何创建的呢？
3、提供一下ocp config.yaml附件
4、root@proxysys 的密码对应的是obproxy的参数：obproxy_sys_password
5、root_password 是对应的OB集群sys租户 root用户的密码

追逐着阳光与黑暗 · 2022 年9 月 29 日 15:41

ocp版本：ocp-3.3.0-ce-bp1-x86_64
ocp meta OB是执行安装命令自动建的：
./ocp_installer.sh install -c config.yaml -i ./ocp-installer.tar.gz -o ./ocp.tar.gz

ocp的config.yaml文件钉钉上已经私发给你了

和顺 · 2022 年9 月 29 日 15:50

代发附件config.yaml
config.yaml 2.zip (1.6 KB)

秃蛙 · 2022 年9 月 29 日 17:28

ocp节点的/home/admin/ocp-3.3.0-ce-bp1-x86_64/log/目录下的安装日志麻烦提供下

追逐着阳光与黑暗 · 2022 年9 月 30 日 08:29

00000000-0000-0000-0000-000000000000.log (128.2 KB)
安装日志文件

秃蛙 · 2022 年9 月 30 日 10:05

2022-09-08 21:22:57 - INFO - 1 - [proxyro_password_modify.py:41] - task finished with status: SUCCESSFUL

这个日志最新是9月8号的，单纯日志上确认proxyro用户是存在且可使用的。
需要确认下环境是否人为干涉过，日志时间是否是本机时间设置不对导致。该套环境是否9月8号部署之后正常使用，断电后用户丢失？

追逐着阳光与黑暗 · 2022 年9 月 30 日 10:35

重新开机后，机器时间没跟网络时间同步。我现在调整好了之后重新启动了observer跟obproxy后，用之前和顺老师提到的验证方式，直连跟proxy连都报错了。昨天直连没问题的
[root@centos obproxy]# mysql -h192.168.11.211 -P2881 -umeta_user@meta_tenant -p -c
Enter password:
ERROR 1045 (42000): Access denied for user ‘meta_user’@‘xxx.xxx.xxx.xxx’ (using password: YES)
[root@centos obproxy]#
[root@centos obproxy]#
[root@centos obproxy]# mysql -h192.168.11.211 -P2883 -umeta_user@meta_tenant#obcluster -p -c
Enter password:
ERROR 2013 (HY000): Lost connection to MySQL server at ‘reading authorization packet’, system error: 0
[root@centos obproxy]# netstat -ntlp
Active Internet connections (only servers)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name
tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN 1159/sshd
tcp 0 0 127.0.0.1:25 0.0.0.0:* LISTEN 1377/master
tcp 0 0 0.0.0.0:2881 0.0.0.0:* LISTEN 64198/bin/observer
tcp 0 0 0.0.0.0:2882 0.0.0.0:* LISTEN 64198/bin/observer
tcp 0 0 0.0.0.0:2883 0.0.0.0:* LISTEN 67612/bin/obproxy
tcp 0 0 0.0.0.0:2884 0.0.0.0:* LISTEN 67612/bin/obproxy
tcp6 0 0 :::22 :::* LISTEN 1159/sshd
tcp6 0 0 ::1:25 :::* LISTEN 1377/master
[root@centos obproxy]#

环境是否人为动过我还得去问问了解下；9.8部署完后是正常使用的，就这次断电后，想重新把容器起起来，发现不行。

追逐着阳光与黑暗 · 2022 年9 月 30 日 10:44

这会能直连上了，obproxy的还是不行。目前的情况看着跟昨天的一样了
MySQL [(none)]> select user,host,password from mysql.user where user=‘proxyro’;
Empty set (0.04 sec)