导入数据(load data infile)报没有权限

呵呵呵 · 2022 年8 月 19 日 11:48

【使用环境】测试环境
【 OB or 其他组件】obd搭建的三节点集群
【使用版本】oceanbase-ce-3.1.4,libobclient-2.0.2
【问题描述】使用load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”;导入语句报:ERROR 1227 (42501): Access denied
【复现路径】使用sys租户建立了一个ly用户.使用ly用户使用上面的load data导入tpc-h生成的数据
【问题现象及影响】
操作记录:
Welcome to the OceanBase. Commands end with ; or \g.
Your OceanBase connection id is 3221498788
Server version: 5.7.25 OceanBase 3.1.4 (r10000092022071511-b4bfa011ceaef428782dcb65ae89190c40b78c2f) (Built Jul 15 2022 11:45:14)

Type ‘help;’ or ‘\h’ for help. Type ‘\c’ to clear the current input statement.

obclient [(none)]> use tp;
Reading table information for completion of table and column names
You can turn off this feature to get a quicker startup with -A

Database changed
obclient [tp]> set global secure_file_priv = “”;
Query OK, 0 rows affected (0.695 sec)

obclient [tp]> grant file on *.* to ly;
Query OK, 0 rows affected (0.224 sec)

obclient [tp]> load data infile “/opt/part.tbl” into table PART fields terminated by “|”;
ERROR 1227 (42501): Access denied
obclient [tp]> load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”;
ERROR 1227 (42501): Access denied
obclient [tp]>

本机文件权限检查:
[root@ob2 ~]# ll /opt/
total 23572
-rwxrwxrwx 1 admin admin 24135125 Aug 18 16:27 part.tbl
[root@ob2 ~]# ll /
total 16
lrwxrwxrwx. 1 root root 7 Aug 16 15:51 bin → usr/bin
dr-xr-xr-x. 5 root root 4096 Aug 17 11:25 boot
drwxr-xr-x 5 admin admin 62 Aug 18 16:12 data
drwxr-xr-x 21 root root 3280 Aug 17 11:24 dev
drwxr-xr-x. 77 root root 8192 Aug 17 17:47 etc
drwxr-xr-x. 3 root root 19 Aug 17 11:03 home
lrwxrwxrwx. 1 root root 7 Aug 16 15:51 lib → usr/lib
lrwxrwxrwx. 1 root root 9 Aug 16 15:51 lib64 → usr/lib64
drwxr-xr-x. 2 root root 6 Apr 11 2018 media
drwxr-xr-x. 2 root root 6 Apr 11 2018 mnt
drwxrwxrwx. 2 root root 22 Aug 18 16:35 opt
dr-xr-xr-x 181 root root 0 Aug 17 11:24 proc
dr-xr-x—. 4 root root 197 Aug 18 18:02 root
drwxr-xr-x 25 root root 700 Aug 17 17:47 run
lrwxrwxrwx. 1 root root 8 Aug 16 15:51 sbin → usr/sbin
drwxr-xr-x. 2 root root 6 Apr 11 2018 srv
dr-xr-xr-x 13 root root 0 Aug 18 16:41 sys
drwxrwxrwt. 8 root root 211 Aug 19 11:20 tmp
drwxr-xr-x 4 root root 35 Aug 17 17:13 u01
drwxr-xr-x. 14 root root 166 Aug 17 17:08 usr
drwxr-xr-x. 19 root root 267 Aug 16 17:07 var

ly用户被授予的权限检查:
obclient [tp]> SHOW GRANTS FOR ly;
±--------------------------------------------------------------+
| Grants for ly@% |
±--------------------------------------------------------------+
| GRANT ALL PRIVILEGES ON *.* TO ‘ly’ WITH GRANT OPTION |
| GRANT ALL PRIVILEGES ON tp.* TO ‘ly’ |
| GRANT ALL PRIVILEGES ON data_ny.* TO ‘ly’ WITH GRANT OPTION |
±--------------------------------------------------------------+
3 rows in set (0.018 sec)

检查ly用户所拥有的用户级权限
obclient [tp]> SELECT * FROM mysql.user WHERE user=‘ly’\G;
*************************** 1. row ***************************
host: %
user: ly
password: *737b6baf309fc303c962e168d64ba5384faa4f75
select_priv: Y
insert_priv: Y
update_priv: Y
delete_priv: Y
create_priv: Y
drop_priv: Y
reload_priv: N
shutdown_priv: N
process_priv: Y
file_priv: Y
grant_priv: Y
reference_priv: N
index_priv: Y
alter_priv: Y
show_db_priv: Y
super_priv: Y
create_tmp_table_priv: N
lock_tables_priv: N
execute_priv: N
repl_slave_priv: N
repl_client_priv: N
create_view_priv: Y
show_view_priv: Y
create_routine_priv: N
alter_routine_priv: N
create_user_priv: Y
event_priv: N
trigger_priv: N
create_tablespace_priv: N
ssl_type:
ssl_cipher:
x509_issuer:
x509_subject:
max_questions: 0
max_updates: 0
max_connections: 0
max_user_connections: 0
plugin: ob_native_password
authentication_string:
password_expired:
1 row in set (0.046 sec)

ERROR: No query specified

集群安装列表检查:
[root@ob2 ~]# su admin
[admin@ob2 root]$ obd cluster display obtest;
Get local repositories and plugins ok
Open ssh connection ok
Cluster status check ok
Connect to observer ok
Wait for observer init ok
±-----------------------------------------------+
| observer |
±-------------±--------±-----±------±-------+
| ip | version | port | zone | status |
±-------------±--------±-----±------±-------+
| 192.168.0.48 | 3.1.4 | 2881 | zone1 | active |
| 192.168.0.49 | 3.1.4 | 2881 | zone1 | active |
| 192.168.0.67 | 3.1.4 | 2881 | zone1 | active |
±-------------±--------±-----±------±-------+

Connect to obproxy ok
±-----------------------------------------------+
| obproxy |
±-------------±-----±----------------±-------+
| ip | port | prometheus_port | status |
±-------------±-----±----------------±-------+
| 192.168.0.49 | 2883 | 2884 | active |
±-------------±-----±----------------±-------+

系统环境检查:
[admin@ob2 root]$ cat /etc/redhat-release
CentOS Linux release 7.9.2009 (Core)
[admin@ob2 root]$ uname -r
3.10.0-1160.el7.x86_64
[admin@ob2 root]$ free -g
total used free shared buff/cache available
Mem: 15 7 3 0 4 2
Swap: 0 0 0
[admin@ob2 root]$

【附件】

xuyu · 2022 年8 月 19 日 11:56

请问你的数据文件和执行机器是在哪，目前ob只直接数据文件在observer上，并且直连对应的节点load, 另外Built Jul 15 2022 11:45:14这个时间左右我们刚好patch了一个bug，能否再拉一下代码

xuyu · 2022 年8 月 19 日 11:57

另外，有报错请抓下相关的错误日志方便我定位

呵呵呵 · 2022 年8 月 19 日 13:43

obclient与observer在同一个服务器,另外安装包在这两天在官网下载的集体版本号见截图查了一下日志这里也贴一下:
[2022-08-19 13:31:40.954278] WARN [SQL] stmt_query (ob_sql.cpp:171) [23707][1073][YB42C0A80030-0005E68F981C2496] [lt=7] [dc=0] fail to handle text query(stmt=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”, ret=-5036)
[2022-08-19 13:31:40.954303] WARN [SERVER] test_and_save_retry_state (ob_query_retry_ctrl.cpp:180) [23707][1073][YB42C0A80030-0005E68F981C2496] [lt=8] [dc=0] schema error, but do not need retry(client_ret=-5036, err=-5036, retry_type_=0, local_tenant_version_start=1660879420927992, global_tenant_version_start=1660879420927992, local_tenant_version_latest=1660879420927992, local_sys_version_start=1660879420927992, global_sys_version_start=1660879420927992, local_sys_version_latest=1660879420927992)
[2022-08-19 13:31:40.954335] INFO [SERVER] ob_query_retry_ctrl.cpp:460 [23707][1073][YB42C0A80030-0005E68F981C2496] [lt=21] [dc=0] check if need retry(client_ret=-5036, err=-5036, retry_type_=0, retry_times=1, multi_stmt_item={is_part_of_multi_stmt:true, seq_num:0, sql:“load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|””})
[2022-08-19 13:31:40.954351] WARN [SERVER] do_process (obmp_query.cpp:638) [23707][1073][YB42C0A80030-0005E68F981C2496] [lt=10] [dc=0] run stmt_query failed, check if need retry(ret=-5036, cli_ret=-5036, retry_ctrl_.need_retry()=0, sql=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”)
[2022-08-19 13:31:40.954380] WARN [SERVER] do_process (obmp_query.cpp:745) [23707][1073][YB42C0A80030-0005E68F981C2496] [lt=12] [dc=0] query failed(ret=-5036, retry_ctrl_.need_retry()=0)
[2022-08-19 13:31:40.954468] INFO [SERVER] obmp_base.cpp:1163 [23707][1073][YB42C0A80030-0005E68F981C2496] [lt=12] [dc=0] sending error packet(err=-5036, bt=“0x9a98e9e 0x9506b06 0x952d452 0x9529b67 0x9bc719c 0x9311c1f 0x92f21db 0x931087f 0x92f0004 0x92f05e7 0x2cabf02 0x9820da5 0x981f792 0x981c24f”, extra_err_info=0x7f5006d748c8)
[2022-08-19 13:31:40.954493] INFO [SERVER] obmp_base.cpp:1237 [23707][1073][YB42C0A80030-0005E68F981C2496] [lt=18] [dc=0] send error package.(user_error_code=1227, err=-5036, sql_state=“42501”, message=Access denied)
[2022-08-19 13:31:40.954558] WARN [SERVER] process (obmp_query.cpp:291) [23707][1073][YB42C0A80030-0005E68F981C2496] [lt=9] [dc=0] fail execute sql(sql_id="", sql=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”, sessid=3221498788, ret=-5036, ret=“OB_ERR_NO_PRIVILEGE”, need_disconnect=false)
[2022-08-19 13:31:40.957026] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AD4B30] [lt=16] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:11084959175367213803, inc:294546, addr:“192.168.0.48:2882”, t:1660887100956734}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660887130956549, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660887100956453}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30213485, ctx:0x7f4f2d440a10, bucket_idx:2790, run_ticket:332177426235, is_scheduled:true, prev:0x7f502e963dc0, next:0x7f502e963dc0}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str_.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660887100894300, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30213485, ctx:0x7f4f2d440a10, bucket_idx:2790, run_ticket:332177426235, is_scheduled:true, prev:0x7f502e963dc0, next:0x7f502e963dc0}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660887100956861, last_ask_scheduler_status_response_ts:1660887100956862, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 13:31:40.960000] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=63] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update __all_weak_read_service set min_version=1660887100734214, max_version=1660887100734214 where level_id = 0 and level_value = ‘’ and min_version = 1660887100695794 and max_version = 1660887100695794 ")

xuyu · 2022 年8 月 19 日 13:54

日志不完整，只有最浅层的日志

xuyu · 2022 年8 月 19 日 13:56

set ob_enable_trace_log=1; 执行load xxx 会报错; 再执行show trace; ，用trace_id去grep完整日志

呵呵呵 · 2022 年8 月 19 日 14:01

[2022-08-19 13:58:31.586324] WARN [SQL.RESV] resolve (ob_load_data_resolver.cpp:132) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=41] [dc=0] no priv(ret=-5036, secure_file_priv=NULL, full_file_path=/opt/part.tbl)
[2022-08-19 13:58:31.586356] WARN [SQL.RESV] stmt_resolver_func (ob_resolver.cpp:126) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=26] [dc=0] execute stmt_resolver failed(ret=-5036, parse_tree.type_=3758)
[2022-08-19 13:58:31.586374] WARN [SQL] generate_stmt (ob_sql.cpp:1440) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=10] [dc=0] failed to resolve(ret=-5036)
[2022-08-19 13:58:31.586387] WARN [SQL] generate_physical_plan (ob_sql.cpp:1528) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=9] [dc=0] Failed to generate stmt(ret=-5036, result.get_exec_context().need_disconnect()=false)
[2022-08-19 13:58:31.586401] WARN [SQL] handle_physical_plan (ob_sql.cpp:3228) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=9] [dc=0] Failed to generate plan(ret=-5036, result.get_exec_context().need_disconnect()=false)
[2022-08-19 13:58:31.586439] WARN [SQL] handle_text_query (ob_sql.cpp:1209) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=35] [dc=0] fail to handle physical plan(ret=-5036)
[2022-08-19 13:58:31.586456] WARN [SQL] stmt_query (ob_sql.cpp:171) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=12] [dc=0] fail to handle text query(stmt=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”, ret=-5036)
[2022-08-19 13:58:31.586481] WARN [SERVER] test_and_save_retry_state (ob_query_retry_ctrl.cpp:180) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=8] [dc=0] schema error, but do not need retry(client_ret=-5036, err=-5036, retry_type_=0, local_tenant_version_start=1660879420927992, global_tenant_version_start=1660879420927992, local_tenant_version_latest=1660879420927992, local_sys_version_start=1660879420927992, global_sys_version_start=1660879420927992, local_sys_version_latest=1660879420927992)
[2022-08-19 13:58:31.586510] INFO [SERVER] ob_query_retry_ctrl.cpp:460 [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=19] [dc=0] check if need retry(client_ret=-5036, err=-5036, retry_type_=0, retry_times=1, multi_stmt_item={is_part_of_multi_stmt:true, seq_num:0, sql:“load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|””})
[2022-08-19 13:58:31.586524] WARN [SERVER] do_process (obmp_query.cpp:638) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=8] [dc=0] run stmt_query failed, check if need retry(ret=-5036, cli_ret=-5036, retry_ctrl_.need_retry()=0, sql=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”)
[2022-08-19 13:58:31.586549] WARN [SERVER] do_process (obmp_query.cpp:745) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=9] [dc=0] query failed(ret=-5036, retry_ctrl_.need_retry()=0)
[2022-08-19 13:58:31.586601] INFO [SERVER] obmp_base.cpp:1163 [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=16] [dc=0] sending error packet(err=-5036, bt=“0x9a98e9e 0x9506b06 0x952d452 0x9529b67 0x9bc719c 0x9311c1f 0x92f21db 0x931087f 0x92f0004 0x92f05e7 0x2cabf02 0x9820da5 0x981f792 0x981c24f”, extra_err_info=0x7f4ea0ebf8c8)
[2022-08-19 13:58:31.586617] INFO [SERVER] obmp_base.cpp:1237 [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=9] [dc=0] send error package.(user_error_code=1227, err=-5036, sql_state=“42501”, message=Access denied)
[2022-08-19 13:58:31.586646] INFO [SQL.SESSION] ob_sql_session_info.cpp:90 [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=7] [dc=0] revert schema guard success by sql(session_id=3221498788, tenant_id=1, schema_version=1660879420927992)
[2022-08-19 13:58:31.586714] TRACE [TRACE]obmp_base.cpp:1688 [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=9] [dc=0] [show trace](TRACE=begin_ts=1660888711586089 2022-08-19 05:58:31.586089|[process_begin] u=0 in_queue_time:53, receive_ts:1660888711586033, enqueue_ts:1660888711586036|[start_sql] u=2 addr:{ip:“192.168.0.48”, port:38104}|[query_begin] u=1 trace_id:YB42C0A80030-0005E68F981C2498|[before_processor_run] u=11 |[session] u=10 sid:3221498788, tenant_id:1|[parse_begin] u=50 stmt:“load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|””, stmt_len:73|[cache_get_plan_begin] u=8 |[cache_get_plan_end] u=37 |[transform_with_outline_begin] u=3 |[transform_with_outline_end] u=45 |[resolve_begin] u=32 |[resolve_end] u=82 |[query_end] u=309 |total_timeu=590)
[2022-08-19 13:58:31.586734] WARN [SERVER] process (obmp_query.cpp:291) [23707][1073][YB42C0A80030-0005E68F981C2498] [lt=10] [dc=0] fail execute sql(sql_id="", sql=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”, sessid=3221498788, ret=-5036, ret=“OB_ERR_NO_PRIVILEGE”, need_disconnect=false)
[2022-08-19 13:58:31.589725] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=41] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 13:58:31.594423] INFO [STORAGE] ob_freeze_info_snapshot_mgr.cpp:955 [23348][384][Y0-0000000000000000] [lt=23] [dc=0] start reload freeze info and snapshots(is_remote_=false)
[2022-08-19 13:58:31.602312] INFO [STORAGE] ob_freeze_info_snapshot_mgr.cpp:741 [23348][384][Y0-0000000000000000] [lt=44] [dc=0] update info commit(snapshot_gc_ts_=1660888704124083, snapshot_gc_ts=1660888706204811)
[2022-08-19 13:58:31.609902] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=39] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 13:58:31.630075] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=40] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 13:58:31.630902] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AD86F3] [lt=21] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d43ef50, ctx_type:2, trans_id:{hash:15145844366255742390, inc:348130, addr:“192.168.0.48:2882”, t:1660888711630750}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660888741630640, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660888711628875}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30742218, ctx:0x7f4f2d43ef50, bucket_idx:5031, run_ticket:332177748475, is_scheduled:true, prev:0x7f502ebcce80, next:0x7f502ebcce80}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str_.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660888711565694, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30742218, ctx:0x7f4f2d43ef50, bucket_idx:5031, run_ticket:332177748475, is_scheduled:true, prev:0x7f502ebcce80, next:0x7f502ebcce80}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660888711630808, last_ask_scheduler_status_response_ts:1660888711630809, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:
false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:false, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 13:58:31.650254] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=43] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 13:58:31.670459] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=39] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 13:58:31.671245] WARN [CLOG] finish_timer (ob_log_timer_utility.h:42) [23359][0][Y0-0000000000000000] [lt=43] [dc=0] cost too much time(file="/home/jenkins/agent/workspace/rpm-oceanbase-ce-3.1.4-1.1.5/ob_source_code_dir/src/clog
/ob_clog_file_writer.cpp", line=688, time=39895)
[2022-08-19 13:58:31.671343] INFO [CLOG] ob_log_callback_engine.cpp:85 [23359][0][Y0-0000000000000000] [lt=44] [dc=0] callback queue task number(clog=-3, ret=0)
[2022-08-19 13:58:31.671391] INFO [CLOG] ob_clog_writer.cpp:294 [23359][0][Y0-0000000000000000] [lt=31] [dc=0] ObCLogWriter get_queued_item_cnt(queued_cnt=0)
[2022-08-19 13:58:31.671532] INFO [CLOG] ob_log_flush_task.cpp:180 [23366][418][Y0-0000000000000000] [lt=36] [dc=0] clog flush cb cost time(flush_cb_cnt=12, flush_cb_cost_time=2085, avg time=160)
[2022-08-19 13:58:31.671617] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=28] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update all_weak_read_service set min_version=1660888711465813, max_version=1660888711465813 where level_id = 0 and level_value = ‘’ and min_version = 1660888711315558 and max_version = 1660888711315558 ")
[2022-08-19 13:58:31.671695] WARN [LIB] ~ObTimeGuard (utility.h:761) [23538][762][Y0-0000000000000000] [lt=17] [dc=0] destruct(*this=time guard ‘[WRS] [TENANT_WEAK_READ_SERVICE] tenant_id=1, thread_timer_task’ cost too much time, used=41792
, time_dist: generate_cluster_version=41788)
[2022-08-19 13:58:31.671745] INFO [STORAGE.TRANS] ob_tenant_weak_read_service.cpp:496 [23538][762][Y0-0000000000000000] [lt=20] [dc=0] [WRS] [TENANT_WEAK_READ_SERVICE] [STAT](tenant_id=1, server_version={version:1660888711465813, total_part
count:1203, valid_inner_part_count:1200, valid_user_part_count:3}, server_version_delta=205907, in_cluster_service=true, cluster_version=1660888711465813, min_cluster_version=1660888711465813, max_cluster_version=1660888711465813, get_cluster_version_err=0, cluster_version_delta=205907, cluster_service_master=“192.168.0.48:2882”, cluster_service_pkey={tid:1099511628002, partition_id:0, part_cnt:0}, post_cluster_heartbeat_count=160334, succ_cluster_heartbeat_count=536, cluster
heartbeat_interval=50000, local_cluster_version=0, local_cluster_delta=1660888711671720, force_self_check=false, weak_read_refresh_interval=50000)
[2022-08-19 13:58:31.681866] INFO [STORAGE.TRANS] ob_tenant_weak_read_cluster_service.cpp:872 [23538][762][Y0-0000000000000000] [lt=20] [dc=0] [WRS] [TENANT_WEAK_READ_SERVICE] [CLUSTER_SERVICE] [SELF_CHECK] done(ret=0, ret=“OB_SUCCESS”, tenant_id=1, need_start_service=false, need_stop_service=false, need_change_leader=false, is_in_service()=true, can_update_version=true, cur_leader_epoch=1660879262000000, start_service_tstamp=1660879267720878, error_count_for_change_leader=0
, last_error_tstamp_for_change_leader_=0)
[2022-08-19 13:58:31.690649] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=46] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 13:58:31.708101] INFO [SHARE] ob_bg_thread_monitor.cpp:294 [23800][1203][Y0-0000000000000000] [lt=27] [dc=0] current monitor number(seq_=4)
[2022-08-19 13:58:31.710824] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=38] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 13:58:31.731135] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=43] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 13:58:31.732441] INFO [COMMON] ob_kvcache_store.cpp:799 [23203][100][Y0-0000000000000000] [lt=9] [dc=0] Wash compute wash size(sys_total_wash_size=-73400320, global_cache_size=178241920, tenant_max_wash_size=178241920, tenant_mi
:6

xuyu · 2022 年8 月 19 日 14:28

看起来走到了一处不合理的路径，可能是个bug, 麻烦到github提个准确复现的bug，我再看看是不是一个问题，但你的情况应该可以绕过，假设的你文件目录是/tmp/aa.txt, 执行set global secure_file_priv = “/tmp”; 这样应该就不会走进这个判空了，记得用绝对路径。

呵呵呵 · 2022 年8 月 19 日 14:46

我试过了,还是不行,执行记录如下:
obclient [tp]> set global secure_file_priv = ‘/opt’;
Query OK, 0 rows affected (0.211 sec)

日志如下:
[2022-08-19 14:35:15.670387] WARN [SQL.RESV] resolve (ob_load_data_resolver.cpp:132) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=44] [dc=0] no priv(ret=-5036, secure_file_priv=NULL, full_file_path=/opt/part.tbl)
[2022-08-19 14:35:15.670475] WARN [SQL.RESV] stmt_resolver_func (ob_resolver.cpp:126) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=78] [dc=0] execute stmt_resolver failed(ret=-5036, parse_tree.type_=3758)
[2022-08-19 14:35:15.670510] WARN [SQL] generate_stmt (ob_sql.cpp:1440) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=20] [dc=0] failed to resolve(ret=-5036)
[2022-08-19 14:35:15.670533] WARN [SQL] generate_physical_plan (ob_sql.cpp:1528) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=16] [dc=0] Failed to generate stmt(ret=-5036, result.get_exec_context().need_disconnect()=false)
[2022-08-19 14:35:15.670554] WARN [SQL] handle_physical_plan (ob_sql.cpp:3228) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=15] [dc=0] Failed to generate plan(ret=-5036, result.get_exec_context().need_disconnect()=false)
[2022-08-19 14:35:15.670574] WARN [SQL] handle_text_query (ob_sql.cpp:1209) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=15] [dc=0] fail to handle physical plan(ret=-5036)
[2022-08-19 14:35:15.670616] WARN [SQL] stmt_query (ob_sql.cpp:171) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=32] [dc=0] fail to handle text query(stmt=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”, ret=-5036)
[2022-08-19 14:35:15.670656] WARN [SERVER] test_and_save_retry_state (ob_query_retry_ctrl.cpp:180) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=15] [dc=0] schema error, but do not need retry(client_ret=-5036, err=-5036, retry_type_=0, local_tenant_version_start=1660890903730136, global_tenant_version_start=1660890903730136, local_tenant_version_latest=1660890903730136, local_sys_version_start=1660890903730136, global_sys_version_start=1660890903730136, local_sys_version_latest=1660890903730136)
[2022-08-19 14:35:15.670695] INFO [SERVER] ob_query_retry_ctrl.cpp:460 [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=24] [dc=0] check if need retry(client_ret=-5036, err=-5036, retry_type_=0, retry_times=1, multi_stmt_item={is_part_of_multi_stmt:true, seq_num:0, sql:“load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|””})
[2022-08-19 14:35:15.670720] WARN [SERVER] do_process (obmp_query.cpp:638) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=16] [dc=0] run stmt_query failed, check if need retry(ret=-5036, cli_ret=-5036, retry_ctrl_.need_retry()=0, sql=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”)
[2022-08-19 14:35:15.670779] WARN [SERVER] do_process (obmp_query.cpp:745) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=32] [dc=0] query failed(ret=-5036, retry_ctrl_.need_retry()=0)
[2022-08-19 14:35:15.670872] INFO [SERVER] obmp_base.cpp:1163 [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=30] [dc=0] sending error packet(err=-5036, bt=“0x9a98e9e 0x9506b06 0x952d452 0x9529b67 0x9bc719c 0x9311c1f 0x92f21db 0x931087f 0x92f0004 0x92f05e7 0x2cabf02 0x9820da5 0x981f792 0x981c24f”, extra_err_info=0x7f4f1b6c18c8)
[2022-08-19 14:35:15.670916] INFO [SERVER] obmp_base.cpp:1237 [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=32] [dc=0] send error package.(user_error_code=1227, err=-5036, sql_state=“42501”, message=Access denied)
[2022-08-19 14:35:15.670964] INFO [SQL.SESSION] ob_sql_session_info.cpp:90 [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=16] [dc=0] revert schema guard success by sql(session_id=3221498788, tenant_id=1, schema_version=1660879420927992)
[2022-08-19 14:35:15.671080] TRACE [TRACE]obmp_base.cpp:1688 [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=31] [dc=0] [show trace](TRACE=begin_ts=1660890915669950 2022-08-19 06:35:15.669950|[process_begin] u=0 in_queue_time:64, receive_ts:1660890915669880, enqueue_ts:1660890915669885|[start_sql] u=2 addr:{ip:“192.168.0.48”, port:38104}|[query_begin] u=3 trace_id:YB42C0A80030-0005E68F981C249B|[before_processor_run] u=18 |[session] u=14 sid:3221498788, tenant_id:1|[parse_begin] u=91 stmt:“load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|””, stmt_len:73|[cache_get_plan_begin] u=14 |[cache_get_plan_end] u=46 |[transform_with_outline_begin] u=4 |[transform_with_outline_end] u=107 |[resolve_begin] u=46 |[resolve_end] u=209 |[query_end] u=527 |total_timeu=1081)
[2022-08-19 14:35:15.671134] WARN [SERVER] process (obmp_query.cpp:291) [23707][1073][YB42C0A80030-0005E68F981C249B] [lt=36] [dc=0] fail execute sql(sql_id="", sql=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”, sessid=3221498788, ret=-5036, ret=“OB_ERR_NO_PRIVILEGE”, need_disconnect=false)
[2022-08-19 14:35:15.673011] INFO [CLOG] ob_log_state_mgr.cpp:2285 [23780][1167][Y0-0000000000000000] [lt=25] [dc=0] check_leader_sliding_window_not_slide_(partition_key={tid:1099511627971, partition_id:14, part_cnt:0})
[2022-08-19 14:35:15.674006] INFO [LIB] ob_work_queue.cpp:24 [23235][164][Y0-0000000000000000] [lt=38] [dc=0] add async task(this=tasktype:N9oceanbase10rootserver17ObCheckServerTaskE)
[2022-08-19 14:35:15.683486] INFO [STORAGE.TRANS] ob_tenant_weak_read_server_version_mgr.cpp:130 [23792][1191][Y0-0000000000000000] [lt=12] [dc=0] [WRS] update tenant weak read server version(tenant_id=1, server_version={version:1660890915468977, total_part_count:1203, valid_inner_part_count:1200, valid_user_part_count:3, epoch_tstamp:1660890915649697}, version_delta=214490)
[2022-08-19 14:35:15.683697] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93ADD81C] [lt=41] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:3782057873673413588, inc:421374, addr:“192.168.0.48:2882”, t:1660890915683339}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660890945683132, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660890915682591}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30413209, ctx:0x7f4f2d440a10, bucket_idx:5777, run_ticket:332178189220, is_scheduled:true, prev:0x7f502efefe00, next:0x7f502efefe00}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str_.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660890915605175, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30413209, ctx:0x7f4f2d440a10, bucket_idx:5777, run_ticket:332178189220, is_scheduled:true, prev:0x7f502efefe00, next:0x7f502efefe00}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660890915683502, last_ask_scheduler_status_response_ts:1660890915683503, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 14:35:15.686289] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=39] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 14:35:15.704838] INFO [STORAGE.TRANS] ob_gts_source.cpp:627 [23549][784][Y0-0000000000000000] [lt=17] [dc=0] refresh gts(ret=0, ret=“OB_SUCCESS”, tenant_id=1, need_refresh=false, gts_local_cache={srr:{mts:1660890915704724}, gts:1660890915704738, local_trans_version:0, barrier_ts:0, latest_srr:{mts:1660890915704724}})
[2022-08-19 14:35:15.704888] INFO [STORAGE.TRANS] ob_ha_gts_source.cpp:399 [23549][784][Y0-0000000000000000] [lt=33] [dc=0] refresh ha gts(ret=0, ret=“OB_SUCCESS”, tenant_id=1, need_refresh=false, gts_local_cache={srr:{mts:0}, gts:0, local_trans_version:0, barrier_ts:0, latest_srr:{mts:0}})
[2022-08-19 14:35:15.706462] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=41] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 14:35:15.725541] WARN [CLOG] finish_timer (ob_log_timer_utility.h:42) [23359][0][Y0-0000000000000000] [lt=48] [dc=0] cost too much time(file="/home/jenkins/agent/workspace/rpm-oceanbase-ce-3.1.4-1.1.5/ob_source_code_dir/src/clog/ob_clog_file_writer.cpp", line=688, time=40943)
[2022-08-19 14:35:15.726036] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=54] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update all_weak_read_service set min_version=1660890915468977, max_version=1660890915468977 where level_id = 0 and level_value = ‘’ and min_version = 1660890915441184 and max_version = 1660890915441184 ")
[2022-08-19 14:35:15.726298] WARN [LIB] ~ObTimeGuard (utility.h:761) [23538][762][Y0-0000000000000000] [lt=31] [dc=0] destruct(*this=time guard ‘[WRS] [TENANT_WEAK_READ_SERVICE] tenant_id=1, thread_timer_task’ cost too much time, used=44621, time_dist: do_cluster_heartbeat=27, generate_cluster_version=44586)
[2022-08-19 14:35:15.726623] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=28] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 14:35:15.730187] INFO [COMMON] ob_kvcache_store.cpp:799 [23203][100][Y0-0000000000000000] [lt=12] [dc=0] Wash compute wash size(sys_total_wash_size=-65011712, global_cache_size=163562304, tenant_max_wash_size=163562304, tenant_min_wash_size=0, tenant_ids=[1, 500])
[2022-08-19 14:35:15.730264] INFO [COMMON] ob_kvcache_store.cpp:323 [23203][100][Y0-0000000000000000] [lt=47] [dc=0] Wash time detail, (refresh_score_time=71, compute_wash_size_time=289, wash_sort_time=16, wash_time=3)
[2022-08-19 14:35:15.735694] INFO [SERVER] ob_eliminate_task.cpp:200 [23540][766][Y0-0000000000000000] [lt=27] [dc=0] sql audit evict task end(evict_high_level=46137345, evict_batch_count=0, elapse_time=3, size_used=0, mem_used=0)
[2022-08-19 14:35:15.746783] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=23] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 14:35:15.747007] INFO [STORAGE.TRANS] ob_tenant_weak_read_service.cpp:496 [23538][762][Y0-0000000000000000] [lt=20] [dc=0] [WRS] [TENANT_WEAK_READ_SERVICE] [STAT](tenant_id=1, server_version={version:1660890915672647, total_part_count:1203, valid_inner_part_count:1200, valid_user_part_count:3}, server_version_delta=74284, in_cluster_service=true, cluster_version=1660890915468977, min_cluster_version=1660890915468977, max_cluster_version=1660890915468977, get_cluster_version_err=0, cluster_version_delta=277954, cluster_service_master=“192.168.0.48:2882”, cluster_service_pkey={tid:1099511628002, partition_id:0, part_cnt:0}, post_cluster_heartbeat_count=197037, succ_cluster_heartbeat_count=536, cluster_heartbeat_interval=50000, local_cluster_version=0, local_cluster_delta=1660890915746931, force_self_check=false, weak_read_refresh_interval=50000)
[2022-08-19 14:35:15.749603] INFO [STORAGE] ob_freeze_info_snapshot_mgr.cpp:955 [23349][386][Y0-0000000000000000] [lt=40] [dc=0] start reload freeze info and snapshots(is_remote=true)
[2022-08-19 14:35:15.766959] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=34] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 14:35:15.779925] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93ADD81D] [lt=49] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:9109227418466565242, inc:421375, addr:“192.168.0.48:2882”, t:1660890915779589}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660890945779225, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660890915779414}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30564729, ctx:0x7f4f2d440a10, bucket_idx:5825, run_ticket:332178189269, is_scheduled:true, prev:0x7f502ebf2200, next:0x7f502ebf2200}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str_.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660890915683720, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30564729, ctx:0x7f4f2d440a10, bucket_idx:5825, run_ticket:332178189269, is_scheduled:true, prev:0x7f502ebf2200, next:0x7f502ebf2200}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660890915779730, last_ask_scheduler_status_response_ts:1660890915779732, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 14:35:15.787110] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=27] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 14:35:15.820129] WARN [CLOG] finish_timer (ob_log_timer_utility.h:42) [23359][0][Y0-0000000000000000] [lt=42] [dc=0] cost too much time(file="/home/jenkins/agent/workspace/rpm-oceanbase-ce-3.1.4-1.1.5/ob_source_code_dir/src/clog/ob_clog_file_writer.cpp", line=688, time=38430)
[2022-08-19 14:35:15.820233] INFO [CLOG] ob_log_callback_engine.cpp:85 [23359][0][Y0-0000000000000000] [lt=50] [dc=0] callback queue task number(clog=-3, ret=0)
[2022-08-19 14:35:15.820267] INFO [CLOG] ob_clog_writer.cpp:294 [23359][0][Y0-0000000000000000] [lt=19] [dc=0] ObCLogWriter get_queued_item_cnt(queued_cnt=0)

另外:发现启动ob后info日志疯狂写入,导致iops都满了,我们测试环境iops最大为2500
启动后又没有做任何操作,数据库也没有任何数据,这样感觉有点不太正常

xuyu · 2022 年8 月 19 日 14:55

set global是需要先断开session再重开的，可以show variables like “%secure_file%”;来查看

xuyu · 2022 年8 月 19 日 14:57

第二个问题需要再分析下，你的机器配置是怎么样的？另外你也可以看到你的日志里面有warn级别的日志了，可以排查下日志级别到底设置了什么？另外疯狂打日志能从重复的日志条目看下是哪条trace_id,再抓出来看看是在执行什么东西，这样好下一步分析

xuyu · 2022 年8 月 19 日 14:59

另外，其实不需要自己导tpch ，ob已经提供了便携的方式供大家测试ob的性能 obd test tpch，文档参考https://www.oceanbase.com/docs/community/observer-cn/V3.1.4/10000000000450308#OBD%20一键测试

呵呵呵 · 2022 年8 月 19 日 15:18

log:
[2022-08-19 15:14:45.875684] ERROR [SQL.RESV] resolve (ob_load_data_resolver.cpp:139) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=36] [dc=0] stat error(ret=-4016, secure_file_priv=/opt) BACKTRACE:0x9a98e9e 0x986d141 0x22e245f 0x22e20ab 0x22e1e72 0x232d45b 0x4b2b005 0x522d344 0x51c8736 0x5a6fbd7 0x5a72bfd 0x5a719ea 0x5ae0e19 0x5a6952a 0x952b71b 0x9529b67 0x9bc719c 0x9311c1f 0x92f21db 0x931087f 0x92f0004 0x92f05e7 0x2cabf02 0x9820da5 0x981f792 0x981c24f
[2022-08-19 15:14:45.875856] WARN [SQL.RESV] stmt_resolver_func (ob_resolver.cpp:126) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=163] [dc=0] execute stmt_resolver failed(ret=-4016, parse_tree.type_=3758)
[2022-08-19 15:14:45.875915] WARN [SQL] generate_stmt (ob_sql.cpp:1440) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=19] [dc=0] failed to resolve(ret=-4016)
[2022-08-19 15:14:45.875942] WARN [SQL] generate_physical_plan (ob_sql.cpp:1528) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=18] [dc=0] Failed to generate stmt(ret=-4016, result.get_exec_context().need_disconnect()=false)
[2022-08-19 15:14:45.875965] WARN [SQL] handle_physical_plan (ob_sql.cpp:3228) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=16] [dc=0] Failed to generate plan(ret=-4016, result.get_exec_context().need_disconnect()=false)
[2022-08-19 15:14:45.875984] WARN [SQL] handle_text_query (ob_sql.cpp:1209) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=15] [dc=0] fail to handle physical plan(ret=-4016)
[2022-08-19 15:14:45.876032] WARN [SQL] stmt_query (ob_sql.cpp:171) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=15] [dc=0] fail to handle text query(stmt=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”, ret=-4016)
[2022-08-19 15:14:45.876092] WARN [SERVER] test_and_save_retry_state (ob_query_retry_ctrl.cpp:446) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=33] [dc=0] do not need retry(client_ret=-4016, err=-4016, expected_stmt=false, THIS_WORKER.get_timeout_ts()=1660893295875104, retry_type_=0, result.get_stmt_type()=161, result.get_exec_context().need_change_timeout_ret()=true, session->get_retry_info().get_last_query_retry_err()=0)
[2022-08-19 15:14:45.876156] INFO [SERVER] ob_query_retry_ctrl.cpp:460 [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=47] [dc=0] check if need retry(client_ret=-4016, err=-4016, retry_type_=0, retry_times=1, multi_stmt_item={is_part_of_multi_stmt:true, seq_num:0, sql:“load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|””})
[2022-08-19 15:14:45.876184] WARN [SERVER] do_process (obmp_query.cpp:638) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=19] [dc=0] run stmt_query failed, check if need retry(ret=-4016, cli_ret=-4016, retry_ctrl_.need_retry()=0, sql=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”)
[2022-08-19 15:14:45.876280] WARN [SERVER] do_process (obmp_query.cpp:745) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=40] [dc=0] query failed(ret=-4016, retry_ctrl_.need_retry()=0)
[2022-08-19 15:14:45.876376] INFO [SERVER] obmp_base.cpp:1163 [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=19] [dc=0] sending error packet(err=-4016, bt=“0x9a98e9e 0x9506b06 0x952d452 0x9529b67 0x9bc719c 0x9311c1f 0x92f21db 0x931087f 0x92f0004 0x92f05e7 0x2cabf02 0x9820da5 0x981f792 0x981c24f”, extra_err_info=0x7f4f162c18c8)
[2022-08-19 15:14:45.876420] INFO [SERVER] obmp_base.cpp:1237 [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=31] [dc=0] send error package.(user_error_code=4016, err=-4016, sql_state=“HY000”, message=Internal error)
[2022-08-19 15:14:45.876643] TRACE [TRACE]obmp_base.cpp:1688 [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=15] [dc=0] [show trace](TRACE=begin_ts=1660893285875150 2022-08-19 07:14:45.875150|[process_begin] u=0 in_queue_time:37, receive_ts:1660893285875104, enqueue_ts:1660893285875110|[start_sql] u=2 addr:{ip:“192.168.0.48”, port:38126}|[query_begin] u=5 trace_id:YB42C0A80030-0005E68F980C248C|[before_processor_run] u=25 |[session] u=16 sid:3221623816, tenant_id:1|[parse_begin] u=85 stmt:“load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|””, stmt_len:73|[cache_get_plan_begin] u=17 |[cache_get_plan_end] u=102 |[transform_with_outline_begin] u=5 |[transform_with_outline_end] u=111 |[resolve_begin] u=81 |[resolve_end] u=285 |[query_end] u=662 |total_timeu=1396)
[2022-08-19 15:14:45.876696] WARN [SERVER] process (obmp_query.cpp:291) [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=34] [dc=0] fail execute sql(sql_id="", sql=load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|”, sessid=3221623816, ret=-4016, ret=“OB_ERR_UNEXPECTED”, need_disconnect=false)
[2022-08-19 15:14:45.876828] TRACE [TRACE]obmp_base.cpp:915 [23738][1135][YB42C0A80030-0005E68F980C248C] [lt=61] [dc=0] [err query](TRACE=begin_ts=1660893285875150 2022-08-19 07:14:45.875150|[process_begin] u=0 in_queue_time:37, receive_ts:1660893285875104, enqueue_ts:1660893285875110|[start_sql] u=2 addr:{ip:“192.168.0.48”, port:38126}|[query_begin] u=5 trace_id:YB42C0A80030-0005E68F980C248C|[before_processor_run] u=25 |[session] u=16 sid:3221623816, tenant_id:1|[parse_begin] u=85 stmt:“load data infile ‘/opt/part.tbl’ into table PART fields terminated by “|””, stmt_len:73|[cache_get_plan_begin] u=17 |[cache_get_plan_end] u=102 |[transform_with_outline_begin] u=5 |[transform_with_outline_end] u=111 |[resolve_begin] u=81 |[resolve_end] u=285 |[query_end] u=662 |[process_end] u=243 run_ts:1660893285875185|[process_ret] u=5 process_ret:-4016|total_timeu=1644)
[2022-08-19 15:14:45.878834] INFO [STORAGE] ob_freeze_info_snapshot_mgr.cpp:741 [23348][384][Y0-0000000000000000] [lt=25] [dc=0] update info commit(snapshot_gc_ts_=1660893278333242, snapshot_gc_ts=1660893280406092)
[2022-08-19 15:14:45.880801] INFO [STORAGE.TRANS] ob_tenant_weak_read_service.cpp:496 [23538][762][Y0-0000000000000000] [lt=63] [dc=0] [WRS] [TENANT_WEAK_READ_SERVICE] [STAT](tenant_id=1, server_version={version:1660893285788000, total_part_count:1203, valid_inner_part_count:1200, valid_user_part_count:3}, server_version_delta=92749, in_cluster_service=true, cluster_version=1660893285588486, min_cluster_version=1660893285588486, max_cluster_version=1660893285588486, get_cluster_version_err=0, cluster_version_delta=292263, cluster_service_master=“192.168.0.48:2882”, cluster_service_pkey={tid:1099511628002, partition_id:0, part_cnt:0}, post_cluster_heartbeat_count=235219, succ_cluster_heartbeat_count=536, cluster_heartbeat_interval=50000, local_cluster_version=0, local_cluster_delta=1660893285880749, force_self_check=false, weak_read_refresh_interval=50000)
[2022-08-19 15:14:45.882963] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AE2BAB] [lt=50] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:4458034128951638093, inc:499257, addr:“192.168.0.48:2882”, t:1660893285882650}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660893315882396, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660893285881708}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30637706, ctx:0x7f4f2d440a10, bucket_idx:9861, run_ticket:332178663305, is_scheduled:true, prev:0x7f502eeaf500, next:0x7f502eeaf500}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str_.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660893285720010, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30637706, ctx:0x7f4f2d440a10, bucket_idx:9861, run_ticket:332178663305, is_scheduled:true, prev:0x7f502eeaf500, next:0x7f502eeaf500}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660893285882773, last_ask_scheduler_status_response_ts:1660893285882775, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 15:14:45.896003] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=69] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:45.902630] INFO memory_dump.cpp:522 [23173][40][Y0-0000000000000000] [lt=34] [dc=0] statistics:
tenant_cnt: 14, max_chunk_cnt: 524288
tenant_id ctx_id chunk_cnt label_cnt segv_cnt
1 0 120 24 0
1 1 165 1 0
1 6 2 1 0
1 22 14 2 0
1 24 4 1 0
1 29 2 2 0
500 0 494 254 0
500 14 10 3 0
500 15 22 3 0
500 17 5 1 0
500 24 8 1 0
500 25 325 2 0
500 28 28 2 0
500 30 10 2 0
501 0 1 1 0
502 0 1 1 0
503 0 1 1 0
504 0 1 1 0
505 0 1 1 0
506 0 1 1 0
507 0 1 1 0
508 0 1 1 0
509 0 1 1 0
510 0 1 1 0
512 0 1 1 0
999 0 2 4 0
cost_time: 126049
[2022-08-19 15:14:45.916163] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=42] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:45.918870] INFO [COMMON] ob_kvcache_store.cpp:799 [23203][100][Y0-0000000000000000] [lt=17] [dc=0] Wash compute wash size(sys_total_wash_size=-54525952, global_cache_size=140494336, tenant_max_wash_size=140494336, tenant_min_wash_size=0, tenant_ids_=[1, 500])
[2022-08-19 15:14:45.918913] INFO [COMMON] ob_kvcache_store.cpp:323 [23203][100][Y0-0000000000000000] [lt=25] [dc=0] Wash time detail, (refresh_score_time=36, compute_wash_size_time=150, wash_sort_time=8, wash_time=2)
[2022-08-19 15:14:45.936504] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=62] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:45.942872] INFO [LIB] ob_work_queue.cpp:24 [23240][174][Y0-0000000000000000] [lt=23] [dc=0] add async task(this=tasktype:N9oceanbase10rootserver21ObPurgeRecyclebinTaskE)
[2022-08-19 15:14:45.956673] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=39] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:45.960283] WARN [CLOG] finish_timer (ob_log_timer_utility.h:42) [23359][0][Y0-0000000000000000] [lt=42] [dc=0] cost too much time(file="/home/jenkins/agent/workspace/rpm-oceanbase-ce-3.1.4-1.1.5/ob_source_code_dir/src/clog/ob_clog_file_writer.cpp", line=688, time=76292)
[2022-08-19 15:14:45.960500] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=53] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update all_weak_read_service set min_version=1660893285788000, max_version=1660893285788000 where level_id = 0 and level_value = ‘’ and min_version = 1660893285588486 and max_version = 1660893285588486 ")
[2022-08-19 15:14:45.960618] WARN [LIB] ~ObTimeGuard (utility.h:761) [23538][762][Y0-0000000000000000] [lt=31] [dc=0] destruct(*this=time guard ‘[WRS] [TENANT_WEAK_READ_SERVICE] tenant_id=1, thread_timer_task’ cost too much time, used=79864, time_dist: print_stat=107, do_cluster_heartbeat=19, generate_cluster_version=79734)
[2022-08-19 15:14:45.976787] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=36] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:45.989028] INFO [CLOG] ob_log_state_driver_runnable.cpp:212 [23780][1167][Y0-0000000000000000] [lt=36] [dc=0] ObLogStateDriverRunnable round_cost_time(round_cost_time=27413, sleep_ts=172587, clog_keepalive_interval=50000)
[2022-08-19 15:14:45.996956] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=37] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:46.018160] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=36] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:46.033980] INFO [STORAGE.TRANS] ob_gts_source.cpp:627 [23549][784][Y0-0000000000000000] [lt=34] [dc=0] refresh gts(ret=0, ret=“OB_SUCCESS”, tenant_id=1, need_refresh=false, gts_local_cache={srr:{mts:1660893286033927}, gts:1660893286033935, local_trans_version:0, barrier_ts:0, latest_srr:{mts:1660893286033927}})
[2022-08-19 15:14:46.034014] INFO [STORAGE.TRANS] ob_ha_gts_source.cpp:399 [23549][784][Y0-0000000000000000] [lt=24] [dc=0] refresh ha gts(ret=0, ret=“OB_SUCCESS”, tenant_id=1, need_refresh=false, gts_local_cache={srr:{mts:0}, gts:0, local_trans_version:0, barrier_ts:0, latest_srr:{mts:0}})
[2022-08-19 15:14:46.038274] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=26] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:46.039321] INFO [STORAGE.TRANS] ob_tenant_weak_read_server_version_mgr.cpp:130 [23792][1191][Y0-0000000000000000] [lt=34] [dc=0] [WRS] update tenant weak read server version(tenant_id=1, server_version={version:1660893285988994, total_part_count:1203, valid_inner_part_count:1200, valid_user_part_count:3, epoch_tstamp:1660893286020972}, version_delta=50316)
[2022-08-19 15:14:46.058391] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=23] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:46.061397] INFO [SERVER] ob_backup_operator.cpp:3306 [23268][228][Y0-0000000000000000] [lt=24] [dc=0] get backup info string value(sql=select value from all_backup_info where name = ‘inner_table_version’, name=“inner_table_version”, real_length=1, buf=“3”)
[2022-08-19 15:14:46.062773] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AE2BAC] [lt=28] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:966305092043412143, inc:499262, addr:“192.168.0.48:2882”, t:1660893286062569}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660893316062452, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660893286062416}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30411950, ctx:0x7f4f2d440a10, bucket_idx:9850, run_ticket:332178663295, is_scheduled:true, prev:0x7f502eaaecc0, next:0x7f502eaaecc0}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str.ptr():“data_size:0, data:”, bqual_str.ptr():“data_size:0, data:”}}, snapshot_version:1660893285882860, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30411950, ctx:0x7f4f2d440a10, bucket_idx:9850, run_ticket:332178663295, is_scheduled:true, prev:0x7f502eaaecc0, next:0x7f502eaaecc0}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660893286062640, last_ask_scheduler_status_response_ts:1660893286062641, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 15:14:46.064872] INFO [SHARE] ob_log_archive_backup_info_mgr.cpp:924 [23268][228][Y0-0000000000000000] [lt=22] [dc=0] get status(tmp_status=1, value_str=“STOP”)
[2022-08-19 15:14:46.064911] INFO [SHARE] ob_log_archive_backup_info_mgr.cpp:634 [23268][228][Y0-0000000000000000] [lt=22] [dc=0] succeed to get backup log archive backup status(sql=select backup_dest, tenant_id, incarnation, log_archive_round, time_to_usec(min_first_time) min_first_time, time_to_usec(max_next_time) max_next_time, status , is_mount_file_created, compatible, backup_piece_id, start_piece_id from __all_backup_log_archive_status_v2 where tenant_id=1 , info={status:{tenant_id:1, copy_id:0, start_ts:0, checkpoint_ts:0, status:1, incarnation:1, round:0, status_str:“STOP”, is_mark_deleted:false, is_mount_file_created:false, compatible:0, backup_piece_id:0, start_piece_id:0}, backup_dest:""})
[2022-08-19 15:14:46.079197] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=14] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:14:46.147300] WARN [CLOG] finish_timer (ob_log_timer_utility.h:42) [23359][0][Y0-0000000000000000] [lt=25] [dc=0] cost too much time(file="/home/jenkins/agent/workspace/rpm-oceanbase-ce-3.1.4-1.1.5/ob_source_code_dir/src/clog/ob_clog_file_writer.cpp", line=688, time=81772)
[2022-08-19 15:14:46.147360] INFO [CLOG] ob_log_callback_engine.cpp:85 [23359][0][Y0-0000000000000000] [lt=30] [dc=0] callback queue task number(clog=-3, ret=0)
[2022-08-19 15:14:46.147380] INFO [CLOG] ob_clog_writer.cpp:294 [23359][0][Y0-0000000000000000] [lt=10] [dc=0] ObCLogWriter get_queued_item_cnt(queued_cnt=0)
[2022-08-19 15:14:46.147550] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=22] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update __all_weak_read_service set min_version=1660893285795084, max_version=1660893285795084 where level_id = 0 and level_value = ‘’ and min_version = 1660893285788000 and max_version = 1660893285788000 ")

呵呵呵 · 2022 年8 月 19 日 15:34

日志等级没有改过,使用obd部署的应该是默认的等级,也不知道怎么查
日志看起来都是正常的服务记录正常日志,刷新数据很快这里上传一段日志:
[2022-08-19 15:19:39.799967] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=29] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:19:39.811748] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AE358D] [lt=90] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:4149364238157967241, inc:508796, addr:“192.168.0.48:2882”, t:1660893579811375}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660893609811177, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660893579810475}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30966868, ctx:0x7f4f2d440a10, bucket_idx:8712, run_ticket:332178722156, is_scheduled:true, prev:0x7f502ee79740, next:0x7f502ee79740}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str_.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660893579701271, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30966868, ctx:0x7f4f2d440a10, bucket_idx:8712, run_ticket:332178722156, is_scheduled:true, prev:0x7f502ee79740, next:0x7f502ee79740}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660893579811541, last_ask_scheduler_status_response_ts:1660893579811543, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 15:19:39.815937] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=56] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update all_weak_read_service set min_version=1660893579592968, max_version=1660893579592968 where level_id = 0 and level_value = ‘’ and min_version = 1660893579520275 and max_version = 1660893579520275 ")
[2022-08-19 15:19:39.820250] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=29] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:19:39.824376] WARN load_file_to_string (utility.h:549) [23153][2][Y0-0000000000000000] [lt=15] [dc=0] read /sys/class/net/eth0/speed failed, errno 22
[2022-08-19 15:19:39.824422] WARN get_ethernet_speed (utility.cpp:619) [23153][2][Y0-0000000000000000] [lt=29] [dc=0] load file /sys/class/net/eth0/speed failed, rc -4000
[2022-08-19 15:19:39.824585] WARN [SERVER] get_network_speed_from_sysfs (ob_server.cpp:1736) [23153][2][Y0-0000000000000000] [lt=126] [dc=0] cannot get Ethernet speed, use default(tmp_ret=0, devname=“eth0”)
[2022-08-19 15:19:39.824609] WARN [SERVER] runTimerTask (ob_server.cpp:2213) [23153][2][Y0-0000000000000000] [lt=18] [dc=0] ObRefreshNetworkSpeedTask reload bandwidth throttle limit failed(ret=-4000)
[2022-08-19 15:19:39.836644] INFO [COMMON] ob_kvcache_store.cpp:799 [23203][100][Y0-0000000000000000] [lt=18] [dc=0] Wash compute wash size(sys_total_wash_size=-100663296, global_cache_size=140494336, tenant_max_wash_size=140494336, tenant_min_wash_size=0, tenant_ids=[1, 500])
[2022-08-19 15:19:39.836723] INFO [COMMON] ob_kvcache_store.cpp:323 [23203][100][Y0-0000000000000000] [lt=49] [dc=0] Wash time detail, (refresh_score_time=70, compute_wash_size_time=329, wash_sort_time=15, wash_time=3)
[2022-08-19 15:19:39.840472] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=28] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:19:39.860715] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=74] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:19:39.881001] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=29] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:19:39.901363] INFO [STORAGE] ob_pg_sstable_garbage_collector.cpp:188 [23285][262][Y0-0000000000000000] [lt=58] [dc=0] do one gc free sstable by queue(ret=0, free sstable cnt=0)
[2022-08-19 15:19:39.924479] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AE358E] [lt=40] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:2143853587154960686, inc:508798, addr:“192.168.0.48:2882”, t:1660893579923950}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660893609923568, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660893579923569}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30960049, ctx:0x7f4f2d440a10, bucket_idx:8733, run_ticket:332178722177, is_scheduled:true, prev:0x7f502ec7a700, next:0x7f502ec7a700}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660893579811595, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30960049, ctx:0x7f4f2d440a10, bucket_idx:8733, run_ticket:332178722177, is_scheduled:true, prev:0x7f502ec7a700, next:0x7f502ec7a700}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660893579924163, last_ask_scheduler_status_response_ts:1660893579924165, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 15:19:39.955605] INFO [SHARE] ob_bg_thread_monitor.cpp:294 [23800][1203][Y0-0000000000000000] [lt=17] [dc=0] current monitor number(seq_=4)
[2022-08-19 15:19:39.957950] INFO [STORAGE] ob_trans_checkpoint_worker.cpp:104 [23788][1183][Y0-0000000000000000] [lt=40] [dc=0] transaction checkpoint worker statistics(avg_time=1, valid_user_part_count=0, valid_inner_part_count=0)
[2022-08-19 15:19:39.959011] INFO [STORAGE] ob_store_file_system.cpp:303 [23766][1139][Y0-0000000000000000] [lt=42] [dc=0] ERRSIM bad block: start check macro block, (total_macro_block_count=81, macro_block_info={ref_cnt:1, write_seq:0, is_free:false, access_time:0})
[2022-08-19 15:19:39.959093] INFO [STORAGE] ob_store_file_system.cpp:309 [23766][1139][Y0-0000000000000000] [lt=71] [dc=0] check macro block, (macro_block_info={ref_cnt:1, write_seq:0, is_free:false, access_time:0}, time_interval=1660893579958662)
[2022-08-19 15:19:39.959596] WARN [CLOG] finish_timer (ob_log_timer_utility.h:42) [23359][0][Y0-0000000000000000] [lt=51] [dc=0] cost too much time(file="/home/jenkins/agent/workspace/rpm-oceanbase-ce-3.1.4-1.1.5/ob_source_code_dir/src/clog/ob_clog_file_writer.cpp", line=688, time=33582)
[2022-08-19 15:19:39.960024] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=56] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update all_weak_read_service set min_version=1660893579718814, max_version=1660893579718814 where level_id = 0 and level_value = ‘’ and min_version = 1660893579592968 and max_version = 1660893579592968 “)
[2022-08-19 15:19:39.960233] WARN [LIB] ~ObTimeGuard (utility.h:761) [23538][762][Y0-0000000000000000] [lt=31] [dc=0] destruct(*this=time guard ‘[WRS] [TENANT_WEAK_READ_SERVICE] tenant_id=1, thread_timer_task’ cost too much time, used=38367, time_dist: generate_cluster_version=38360)
[2022-08-19 15:19:39.966977] INFO [STORAGE] ob_store_file_system.cpp:323 [23766][1139][Y0-0000000000000000] [lt=19] [dc=0] inspect_bad_block cost time, (cost_time=8303, check_count=1, total_macro_block_count=81)
[2022-08-19 15:19:40.003196] INFO [CLOG.EXTLOG] ob_external_fetcher.cpp:270 [23327][342][Y0-0000000000000000] [lt=44] [dc=0] [FETCH_LOG_STREAM] Wash Stream: wash expired stream success(count=0, retired_arr=[])
[2022-08-19 15:19:40.013891] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AE358F] [lt=20] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:7407885826003363598, inc:508799, addr:“192.168.0.48:2882”, t:1660893580013419}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660893610012981, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660893580012677}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30362922, ctx:0x7f4f2d440a10, bucket_idx:8632, run_ticket:332178722076, is_scheduled:true, prev:0x7f502ec75b40, next:0x7f502ec75b40}, xid:{gtrid_str:”", bqual_str:"", format_id:1, gtrid_str.ptr():“data_size:0, data:”, bqual_str.ptr():“data_size:0, data:”}}, snapshot_version:1660893579924685, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30362922, ctx:0x7f4f2d440a10, bucket_idx:8632, run_ticket:332178722076, is_scheduled:true, prev:0x7f502ec75b40, next:0x7f502ec75b40}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660893580013618, last_ask_scheduler_status_response_ts:1660893580013649, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 15:19:40.043564] INFO [SERVER] ob_eliminate_task.cpp:200 [23537][760][Y0-0000000000000000] [lt=32] [dc=0] sql audit evict task end(evict_high_level=128849018, evict_batch_count=0, elapse_time=2, size_used=5952, mem_used=73113600)
[2022-08-19 15:19:40.048463] WARN [CLOG] finish_timer (ob_log_timer_utility.h:42) [23359][0][Y0-0000000000000000] [lt=32] [dc=0] cost too much time(file="/home/jenkins/agent/workspace/rpm-oceanbase-ce-3.1.4-1.1.5/ob_source_code_dir/src/clog/ob_clog_file_writer.cpp", line=688, time=31464)
[2022-08-19 15:19:40.050808] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=64] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update all_weak_read_service set min_version=1660893579722884, max_version=1660893579722884 where level_id = 0 and level_value = ‘’ and min_version = 1660893579718814 and max_version = 1660893579718814 ")
[2022-08-19 15:19:40.050950] WARN [LIB] ~ObTimeGuard (utility.h:761) [23538][762][Y0-0000000000000000] [lt=30] [dc=0] destruct(*this=time guard ‘[WRS] [TENANT_WEAK_READ_SERVICE] tenant_id=1, thread_timer_task’ cost too much time, used=40065, time_dist: generate_cluster_version=40057)
[2022-08-19 15:19:40.052295] INFO [STORAGE.TRANS] ob_tenant_weak_read_server_version_mgr.cpp:130 [23792][1191][Y0-0000000000000000] [lt=49] [dc=0] [WRS] update tenant weak read server version(tenant_id=1, server_version={version:1660893579924675, total_part_count:1203, valid_inner_part_count:1200, valid_user_part_count:3, epoch_tstamp:1660893580018269}, version_delta=127599)
[2022-08-19 15:19:40.061136] INFO [STORAGE.TRANS] ob_tenant_weak_read_service.cpp:496 [23538][762][Y0-0000000000000000] [lt=19] [dc=0] [WRS] [TENANT_WEAK_READ_SERVICE] [STAT](tenant_id=1, server_version={version:1660893579924675, total_part_count:1203, valid_inner_part_count:1200, valid_user_part_count:3}, server_version_delta=136416, in_cluster_service=true, cluster_version=1660893579722884, min_cluster_version=1660893579722884, max_cluster_version=1660893579722884, get_cluster_version_err=0, cluster_version_delta=338207, cluster_service_master=“192.168.0.48:2882”, cluster_service_pkey={tid:1099511628002, partition_id:0, part_cnt:0}, post_cluster_heartbeat_count=240116, succ_cluster_heartbeat_count=536, cluster_heartbeat_interval=50000, local_cluster_version=0, local_cluster_delta=1660893580061091, force_self_check=false, weak_read_refresh_interval=50000)
[2022-08-19 15:19:40.072404] INFO [CLOG] ob_clog_mgr.cpp:618 [23377][440][Y0-0000000000000000] [lt=14] [dc=0] begin run_check_log_file_collect_task(begin_ts=1660893580072390, collect_task_run_times=14021)
[2022-08-19 15:19:40.072639] INFO [CLOG] ob_log_engine.cpp:2147 [23377][440][Y0-0000000000000000] [lt=42] [dc=0] need_freeze_based_on_used_space(is_need=false, clog_used_space=402653184, ilog_used_space=31891456, total_space=213591252992)
[2022-08-19 15:19:40.082861] INFO [CLOG] ob_info_block_handler.cpp:1174 [23377][440][Y0-0000000000000000] [lt=38] [dc=0] can_skip_based_on_log_id failed because of last_replay_log_id(partition_key={tid:1099511627968, partition_id:11, part_cnt:0}, last_replay_log_id=18, max_log_id=19, replica_type=0, need_record=false)
[2022-08-19 15:19:40.087021] INFO [CLOG] ob_log_engine.cpp:504 [23377][440][Y0-0000000000000000] [lt=321] [dc=0] clog update min using file id success(min_file_id=1, max_file_id=11, file_id=6)
[2022-08-19 15:19:40.087515] INFO [CLOG] ob_log_engine.cpp:2112 [23377][440][Y0-0000000000000000] [lt=33] [dc=0] set_need_freeze_partition_array(ret=0, need_freeze_partition_array=[])
[2022-08-19 15:19:40.087551] INFO [CLOG] ob_clog_mgr.cpp:640 [23377][440][Y0-0000000000000000] [lt=20] [dc=0] finish run_check_log_file_collect_task(ret=0, begin_ts=1660893580072390, end_ts=1660893580087539, task_cost_time=15149, collect_task_run_times=14021)
[2022-08-19 15:19:40.087573] INFO [CLOG] ob_clog_mgr.cpp:973 [23377][440][Y0-0000000000000000] [lt=16] [dc=0] run_check_log_file_collect_task success
[2022-08-19 15:19:40.106285] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AE3590] [lt=36] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:4740215199760602528, inc:508800, addr:“192.168.0.48:2882”, t:1660893580105866}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660893610105537, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660893580102690}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30602038, ctx:0x7f4f2d440a10, bucket_idx:8699, run_ticket:332178722142, is_scheduled:true, prev:0x7f502f078d80, next:0x7f502f078d80}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str_.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660893580013772, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30602038, ctx:0x7f4f2d440a10, bucket_idx:8699, run_ticket:332178722142, is_scheduled:true, prev:0x7f502f078d80, next:0x7f502f078d80}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660893580106018, last_ask_scheduler_status_response_ts:1660893580106020, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 15:19:40.110680] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=37] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update all_weak_read_service set min_version=1660893579920769, max_version=1660893579920769 where level_id = 0 and level_value = ‘’ and min_version = 1660893579722884 and max_version = 1660893579722884 ")
[2022-08-19 15:19:40.200229] INFO [COMMON] ob_kvcache_store.cpp:799 [23203][100][Y0-0000000000000000] [lt=17] [dc=0] Wash compute wash size(sys_total_wash_size=-100663296, global_cache_size=140494336, tenant_max_wash_size=140494336, tenant_min_wash_size=0, tenant_ids=[1, 500])
[2022-08-19 15:19:40.200317] INFO [COMMON] ob_kvcache_store.cpp:323 [23203][100][Y0-0000000000000000] [lt=56] [dc=0] Wash time detail, (refresh_score_time=70, compute_wash_size_time=310, wash_sort_time=15, wash_time=4)
[2022-08-19 15:19:40.221370] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AE3591] [lt=41] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:5156600185500132803, inc:508802, addr:“192.168.0.48:2882”, t:1660893580220980}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660893610220672, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660893580220092}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30132339, ctx:0x7f4f2d440a10, bucket_idx:8626, run_ticket:332178722071, is_scheduled:true, prev:0x7f502ea756c0, next:0x7f502ea756c0}, xid:{gtrid_str:"", bqual_str:"", format_id:1, gtrid_str.ptr():“data_size:0, data:”, bqual_str_.ptr():“data_size:0, data:”}}, snapshot_version:1660893580102710, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30132339, ctx:0x7f4f2d440a10, bucket_idx:8626, run_ticket:332178722071, is_scheduled:true, prev:0x7f502ea756c0, next:0x7f502ea756c0}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660893580221127, last_ask_scheduler_status_response_ts:1660893580221128, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 15:19:40.242987] WARN [CLOG] finish_timer (ob_log_timer_utility.h:42) [23359][0][Y0-0000000000000000] [lt=30] [dc=0] cost too much time(file="/home/jenkins/agent/workspace/rpm-oceanbase-ce-3.1.4-1.1.5/ob_source_code_dir/src/clog/ob_clog_file_writer.cpp", line=688, time=20575)
[2022-08-19 15:19:40.243514] INFO [SERVER] ob_inner_sql_connection.cpp:1300 [23538][762][Y0-0000000000000000] [lt=91] [dc=0] execute write sql(ret=0, tenant_id=1, affected_rows=1, sql=" update all_weak_read_service set min_version=1660893579993103, max_version=1660893579993103 where level_id = 0 and level_value = ‘’ and min_version = 1660893579920769 and max_version = 1660893579920769 “)
[2022-08-19 15:19:40.243731] WARN [LIB] ~ObTimeGuard (utility.h:761) [23538][762][Y0-0000000000000000] [lt=47] [dc=0] destruct(*this=time guard ‘[WRS] [TENANT_WEAK_READ_SERVICE] tenant_id=1, thread_timer_task’ cost too much time, used=24863, time_dist: generate_cluster_version=24856)
[2022-08-19 15:19:40.296772] INFO [STORAGE.TRANS] ob_trans_part_ctx.cpp:731 [23538][762][YB42C0A80030-0005E68F93AE3592] [lt=37] [dc=0] update gts cache success(updated=false, context={ObDistTransCtx:{ObTransCtx:{this:0x7f4f2d440a10, ctx_type:2, trans_id:{hash:16237452538447464071, inc:508804, addr:“192.168.0.48:2882”, t:1660893580296382}, tenant_id:1, is_exiting:false, trans_type:0, is_readonly:false, trans_expired_time:1660893610296164, self:{tid:1099511628002, partition_id:0, part_cnt:0}, state:{prepare_version:-1, state:0}, cluster_version:12884967428, trans_need_wait_wrap:{receive_gts_ts:{mts:0}, need_wait_interval_us:0}, trans_param:[access_mode=1, type=2, isolation=1, magic=17361641481138401520, autocommit=1, consistency_type=0(CURRENT_READ), read_snapshot_type=2(PARTICIPANT_SNAPSHOT), cluster_version=12884967428, is_inner_trans=1], can_elr:false, uref:1073741825, ctx_create_time:1660893580295594}, scheduler:“192.168.0.48:2882”, coordinator:{tid:18446744073709551615, partition_id:-1, part_idx:268435455, subpart_idx:268435455}, participants:[{tid:1099511628002, partition_id:0, part_cnt:0}], request_id:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30463629, ctx:0x7f4f2d440a10, bucket_idx:8708, run_ticket:332178722153, is_scheduled:true, prev:0x7f502ea79440, next:0x7f502ea79440}, xid:{gtrid_str:”", bqual_str:"", format_id:1, gtrid_str.ptr():“data_size:0, data:”, bqual_str.ptr():“data_size:0, data:”}}, snapshot_version:1660893580283864, local_trans_version:-1, submit_log_pending_count:0, submit_log_count:0, stmt_info:{sql_no:0, start_task_cnt:0, end_task_cnt:0, need_rollback:false, task_info:{tasks_:[]}}, global_trans_version:-1, redo_log_no:0, mutator_log_no:0, session_id:1, is_gts_waiting:false, part_trans_action:-1, timeout_task:{is_inited:true, is_registered:true, is_running:false, delay:30463629, ctx:0x7f4f2d440a10, bucket_idx:8708, run_ticket:332178722153, is_scheduled:true, prev:0x7f502ea79440, next:0x7f502ea79440}, batch_commit_trans:false, batch_commit_state:0, is_dup_table_trans:false, last_ask_scheduler_status_ts:1660893580296598, last_ask_scheduler_status_response_ts:1660893580296600, ctx_dependency_wrap:{prev_trans_arr:[], next_trans_arr:[], prev_trans_commit_count:0}, preassigned_log_meta:{log_id_:18446744073709551615, submit_timestamp_:-1, proposal_id_:{time_to_usec:-1, server:“0.0.0.0”}}, is_dup_table_prepare:false, dup_table_syncing_log_id:18446744073709551615, is_prepare_leader_revoke:false, is_local_trans:true, forbidden_sql_no:-1, is_dirty_:false, undo_status:{undo_action_arr:[]}, max_durable_sql_no:0, max_durable_log_ts:0, mt_ctx_.get_checksum_log_ts():0, is_changing_leader:false, has_trans_state_log:false, is_trans_state_sync_finished:false, status:0, same_leader_batch_partitions_count:0, is_hazardous_ctx:false, mt_ctx_.get_callback_count():0, in_xa_prepare_state:false, is_listener:false, last_replayed_redo_log_id:0, status:0, is_xa_trans_prepared:true, redo_log_id_serialize_size:1, participants_serialize_size:1, undo_serialize_size:7})
[2022-08-19 15:19:40.300993] INFO [SHARE.SCHEMA] ob_schema_store.cpp:63 [23795][1197][Y0-0000000000000000] [lt=61] [dc=0] [SCHEMA_STORE] schema store update version(tenant_id=1, version=1660890903730136, received_version=1660890903730136)
[2022-08-19 15:19:40.301046] INFO [SHARE.SCHEMA] ob_multi_version_schema_service.cpp:4296 [23795][1197][Y0-0000000000000000] [lt=45] [dc=0] try to set tenant received_broadcast_version(ret=0, tenant_id=1, version=1660890903730136)
[2022-08-19 15:19:40.301088] INFO [SERVER] ob_server_schema_updater.cpp:518 [23795][1197][Y0-0000000000000000] [lt=17] [dc=0] schedule fetch new schema task(ret=0, ret=“OB_SUCCESS”, schema_info={schema_version:1660890903730136, tenant_id:1, sequence_id:3298534883331, split_schema_version:0})
[2022-08-19 15:19:40.301113] INFO [SERVER] ob_heartbeat.cpp:184 [23795][1197][Y0-0000000000000000] [lt=15] [dc=0] try reload schema success(schema_version=1660890903730136, refresh_schema_info={schema_version:1660890903730136, tenant_id:1, sequence_id:3298534883331, split_schema_version:0}, schema_ret=0)
[2022-08-19 15:19:40.301344] INFO [CLOG] ob_batch_submit_ctx.cpp:575 [23783][1173][Y0-0000000000000000] [lt=11] [dc=0] ObBatchSubmitCtxFactory statistics(alloc_cnt_=0, free_cnt_=0, using_cnt=0)
[2022-08-19 15:19:40.301397] INFO [CLOG] ob_batch_submit_task.cpp:208 [23783][1173][Y0-0000000000000000] [lt=44] [dc=0] ObBatchSubmitDiskTaskFactory statistics(alloc_cnt_=0, free_cnt_=0, using_cnt=0)
[2022-08-19 15:19:40.301653] INFO [SERVER] ob_server_schema_updater.cpp:226 [23220][134][YB42C0A80030-0005E68F95EC4087] [lt=19] [dc=0] [REFRESH_SCHEMA] start to process schema refresh task(ret=0, ret=“OB_SUCCESS”, schema_info={schema_version:1660890903730136, tenant_id:1, sequence_id:3298534883331, split_schema_version:0})
[2022-08-19 15:19:40.301711] INFO [SERVER] ob_server_schema_updater.cpp:293 [23220][134][YB42C0A80030-0005E68F95EC4087] [lt=42] [dc=0] [REFRESH_SCHEMA] local schema info is newer, no need to refresh schema(ret=0, ret=“OB_SUCCESS”, local_schema_info={schema_version:1660890903730136, tenant_id:1, sequence_id:3298534883331, split_schema_version:0}, schema_info={schema_version:1660890903730136, tenant_id:1, sequence_id:3298534883331, split_schema_version:0})
[2022-08-19 15:19:40.303006] INFO ob_th_worker.cpp:338 [23732][1123][Y0-0000000000000000] [lt=43] [dc=0] worker= 48 thd_flag=1 total=8192 used=408 pm_hold=2097152
[2022-08-19 15:19:40.303246] INFO [SHARE] ob_alive_server_tracer.cpp:384 [23156][8][YB42C0A80030-0005E68F940C2FC0] [lt=32] [dc=0] refresh primary cluster finish(ret=0, primary_cluster_id_=1)

xuyu · 2022 年8 月 19 日 15:46

这个stat error此处是调用的一个系统函数检查文件路径是否存在，此处我是不能复现你的问题的，这可能与环境相关了

xuyu · 2022 年8 月 19 日 15:47

你是用obd部署的么，obd.yml可以提供下

xuyu · 2022 年8 月 19 日 15:49

另外确认下你数据库的user是否有权限操作/opt这个目录？这个是root路径，你如果是linux普通用户是没权限的，stat函数自然报错

呵呵呵 · 2022 年8 月 19 日 15:50

ODB部署配置文件:

Only need to configure when remote login is required

user:
username: admin
password: *****

key_file: your ssh-key file path if need

port: your ssh port, default 22

timeout: ssh connection timeout (second), default 30

oceanbase-ce:
servers:
- name: server1
# Please don’t use hostname, only IP can be supported
ip: 192.168.0.48
- name: server2
ip: 192.168.0.49
- name: server3
ip: 192.168.0.67
global:
# The working directory for OceanBase Database. OceanBase Database is started under this directory. This is a required field.
home_path: /home/admin/oceanbase/ob
# The directory for data storage. The default value is $home_path/store.
# data_dir: /data/data
# The directory for clog, ilog, and slog. The default value is the same as the data_dir value.
# redo_dir: /data/redo
# Please set devname as the network adaptor’s name whose ip is in the setting of severs.
# if set severs as “127.0.0.1”, please set devname as “lo”
# if current ip is 192.168.1.10, and the ip’s network adaptor’s name is “eth0”, please use “eth0”
devname: eth0
# External port for OceanBase Database. The default value is 2881.DO NOT change this value after the cluster is started.
# mysql_port: 2881
# Internal port for OceanBase Database. The default value is 2882. DO NOT change this value after the cluster is started.
# rpc_port: 2882
# Defines the zone for an observer. The default value is zone1.
# zone: zone1
# The maximum running memory for an observer. When ignored, autodeploy calculates this value based on the current server available resource.
# memory_limit: 58G
# The percentage of the maximum available memory to the total memory. This value takes effect only when memory_limit is 0. The default value is 80.
# memory_limit_percentage: 80
# The reserved system memory. system_memory is reserved for general tenants. The default value is 30G. Autodeploy calculates this value based on the current server available resource.
# system_memory: 22G
# The size of a data file. When ignored, autodeploy calculates this value based on the current server available resource.
# datafile_size: 200G
# The percentage of the data_dir space to the total disk space. This value takes effect only when datafile_size is 0. The default value is 90.
# datafile_disk_percentage: 90
# System log level. The default value is INFO.
# syslog_level: INFO
# Print system logs whose levels are higher than WARNING to a separate log file. The default value is true. The default value for autodeploy mode is false.
# enable_syslog_wf: false
# Enable auto system log recycling or not. The default value is false. The default value for autodeploy mode is on.
# enable_syslog_recycle: true
# The maximum number of reserved log files before enabling auto recycling. When set to 0, no logs are deleted. The default value for autodeploy mode is 4.
# max_syslog_file_count: 4
# Cluster name for OceanBase Database. The default value is obcluster. When you deploy OceanBase Database and obproxy, this value must be the same as the cluster_name for obproxy.
# appname: obcluster
# Password for root. The default value is empty.
# root_password:
# Password for proxyro. proxyro_password must be the same as observer_sys_password. The default value is empty.
# proxyro_password:
server1:
zone: zone1
server2:
zone: zone1
server3:
zone: zone1
obproxy-ce:
depends:
- oceanbase-ce
servers:
- 192.168.0.49
global:
# The working directory for obproxy. Obproxy is started under this directory. This is a required field.
home_path: /home/admin/oceanbase/obproxy
skip_proxy_sys_private_check: true
enable_strict_kernel_release: false
# External port. The default value is 2883.
# listen_port: 2883
# The Prometheus port. The default value is 2884.
# prometheus_listen_port: 2884
# rs_list is the root server list for observers. The default root server is the first server in the zone.
# The format for rs_list is observer_ip:observer_mysql_port;observer_ip:observer_mysql_port.
# Ignore this value in autodeploy mode.
# rs_list: 127.0.0.1:2881
# Cluster name for the proxy OceanBase Database. The default value is obcluster. This value must be set to the same with the appname for OceanBase Database.
# cluster_name: obcluster
# Password for obproxy system tenant. The default value is empty.
# obproxy_sys_password:
# Password for proxyro. proxyro_password must be the same with proxyro_password. The default value is empty.
# observer_sys_password:

呵呵呵 · 2022 年8 月 19 日 15:54

系统用户权限有开最上面有贴用户文件系统权限的检查详情

xuyu · 2022 年8 月 19 日 15:55

在github上看到你的问题了，你的 admin用户没权限stat root 下的/opt路径的，这个不是数据库开权限的问题