从2.0升级到2.1后，insert into变慢非常多导致作业超时，升级步骤问题还是配置问题？

Question

两个环境同样的语法，在2.1版本执行13s，在2.0版本0.2s。现在生产升级到2.1了又无法回退。请救救我。

在doris-2.0.3-rc06和doris-2.1.5-rc02

-- 2.0版本的表结构
CREATE TABLE `fmp_account_book_2` (
  `id` largeint(40) NULL COMMENT '主键',
  `acc_id` largeint(40) NULL COMMENT '客户账户id',
  `account_type` varchar(150) NULL COMMENT '变动类型(字典 DEBT 待付款，REFOUND 待退款，BLOCKED 冻结，PERK 券补，GRANT 授信，TEMPORARY 临时授信，PAYABLE 往来应付，RECEIVABLE 往来应收)',
  `account_memo` varchar(150) NULL COMMENT '类型说明(冻结，券补等)',
  `before_amount` DECIMAL(18, 3) NULL COMMENT '变动前金额',
  `account_direction` int(11) NULL COMMENT '交易方向(1 增加 -1 减少)',
  `account_amount` DECIMAL(18, 3) NULL COMMENT '变动金额',
  `after_amount` DECIMAL(18, 3) NULL COMMENT '变动后金额',
  `acc_amount` DECIMAL(18, 3) NULL COMMENT '变动后账户余额',
  `available_amount` DECIMAL(18, 3) NULL COMMENT '变动可用余额',
  `account_abstract` varchar(300) NULL COMMENT '业务摘要',
  `sheet_code` varchar(300) NULL COMMENT '业务单据号',
  `ref_sheet_code` varchar(300) NULL COMMENT '关联业务单据号',
  `ref_sheet_memo` varchar(150) NULL COMMENT '业务单据说明',
  `oper_user` largeint(40) NULL COMMENT '操作人',
  `oper_user_name` varchar(150) NULL COMMENT '操作人名称',
  `oper_date` datetime(3) NULL COMMENT '操作时间',
  `serial_id` varchar(96) NULL COMMENT '操作流水号(生成)',
  `is_delete` bigint(20) NULL COMMENT '是否删除(0 否 1 删除)',
  `meta_code` varchar(108) NULL COMMENT '元数据编码',
  `gmt_create` datetime(3) NULL COMMENT '创建时间',
  `gmt_modified` datetime(3) NULL COMMENT '修改时间'
) ENGINE=OLAP
UNIQUE KEY(`id`)
COMMENT '合作伙伴账户账户余额变动记录'
DISTRIBUTED BY HASH(`id`) BUCKETS AUTO
PROPERTIES (
"replication_allocation" = "tag.location.default: 1",
"is_being_synced" = "false",
"storage_format" = "V2",
"light_schema_change" = "true",
"disable_auto_compaction" = "false",
"enable_single_replica_compaction" = "false"
);

-- 2.1版本的表结构
CREATE TABLE `fmp_account_book_2` (
  `id` LARGEINT NULL COMMENT '主键',
  `acc_id` LARGEINT NULL COMMENT '客户账户id',
  `account_type` VARCHAR(150) NULL COMMENT '变动类型(字典 DEBT 待付款，REFOUND 待退款，BLOCKED 冻结，PERK 券补，GRANT 授信，TEMPORARY 临时授信，PAYABLE 往来应付，RECEIVABLE 往来应收)',
  `account_memo` VARCHAR(150) NULL COMMENT '类型说明(冻结，券补等)',
  `before_amount` DECIMAL(18, 3) NULL COMMENT '变动前金额',
  `account_direction` INT NULL COMMENT '交易方向(1 增加 -1 减少)',
  `account_amount` DECIMAL(18, 3) NULL COMMENT '变动金额',
  `after_amount` DECIMAL(18, 3) NULL COMMENT '变动后金额',
  `acc_amount` DECIMAL(18, 3) NULL COMMENT '变动后账户余额',
  `available_amount` DECIMAL(18, 3) NULL COMMENT '变动可用余额',
  `account_abstract` VARCHAR(300) NULL COMMENT '业务摘要',
  `sheet_code` VARCHAR(300) NULL COMMENT '业务单据号',
  `ref_sheet_code` VARCHAR(300) NULL COMMENT '关联业务单据号',
  `ref_sheet_memo` VARCHAR(150) NULL COMMENT '业务单据说明',
  `oper_user` LARGEINT NULL COMMENT '操作人',
  `oper_user_name` VARCHAR(150) NULL COMMENT '操作人名称',
  `oper_date` DATETIME(3) NULL COMMENT '操作时间',
  `serial_id` VARCHAR(96) NULL COMMENT '操作流水号(生成)',
  `is_delete` BIGINT NULL COMMENT '是否删除(0 否 1 删除)',
  `meta_code` VARCHAR(108) NULL COMMENT '元数据编码',
  `gmt_create` DATETIME(3) NULL COMMENT '创建时间',
  `gmt_modified` DATETIME(3) NULL COMMENT '修改时间'
) ENGINE=OLAP
UNIQUE KEY(`id`)
COMMENT '合作伙伴账户账户余额变动记录'
DISTRIBUTED BY HASH(`id`) BUCKETS AUTO
PROPERTIES (
"replication_allocation" = "tag.location.default: 1",
"min_load_replica_num" = "-1",
"is_being_synced" = "false",
"storage_medium" = "hdd",
"storage_format" = "V2",
"inverted_index_storage_format" = "V1",
"enable_unique_key_merge_on_write" = "true",
"light_schema_change" = "true",
"disable_auto_compaction" = "false",
"enable_single_replica_compaction" = "false",
"group_commit_interval_ms" = "10000",
"group_commit_data_bytes" = "134217728",
"enable_mow_light_delete" = "false"
);

测试执行简单的导入

insert into fmp_account_book_2
select * from fmp_account_book

2.0

2.1

2.0执行计划

PLAN FRAGMENT 0
  OUTPUT EXPRS:
    `default_cluster:xxxx`.`fmp_account_book`.`id`
    `default_cluster:xxxx`.`fmp_account_book`.`acc_id`
    `default_cluster:xxxx`.`fmp_account_book`.`account_type`
    `default_cluster:xxxx`.`fmp_account_book`.`account_memo`
    `default_cluster:xxxx`.`fmp_account_book`.`before_amount`
    `default_cluster:xxxx`.`fmp_account_book`.`account_direction`
    `default_cluster:xxxx`.`fmp_account_book`.`account_amount`
    `default_cluster:xxxx`.`fmp_account_book`.`after_amount`
    `default_cluster:xxxx`.`fmp_account_book`.`acc_amount`
    `default_cluster:xxxx`.`fmp_account_book`.`available_amount`
    `default_cluster:xxxx`.`fmp_account_book`.`account_abstract`
    `default_cluster:xxxx`.`fmp_account_book`.`sheet_code`
    `default_cluster:xxxx`.`fmp_account_book`.`ref_sheet_code`
    `default_cluster:xxxx`.`fmp_account_book`.`ref_sheet_memo`
    `default_cluster:xxxx`.`fmp_account_book`.`oper_user`
    `default_cluster:xxxx`.`fmp_account_book`.`oper_user_name`
    CAST(`default_cluster:xxxx`.`fmp_account_book`.`oper_date` AS DATETIMEV2(3))
    `default_cluster:xxxx`.`fmp_account_book`.`serial_id`
    `default_cluster:xxxx`.`fmp_account_book`.`is_delete`
    `default_cluster:xxxx`.`fmp_account_book`.`meta_code`
    CAST(`default_cluster:xxxx`.`fmp_account_book`.`gmt_create` AS DATETIMEV2(3))
    CAST(`default_cluster:xxxx`.`fmp_account_book`.`gmt_modified` AS DATETIMEV2(3))
    0
    0
  PARTITION: HASH_PARTITIONED: `default_cluster:xxxx`.`fmp_account_book`.`id`

----------

  HAS_COLO_PLAN_NODE: false

  OLAP TABLE SINK
    TUPLE ID: 0
    RANDOM

  0:VOlapScanNode
     TABLE: default_cluster:fmp_account_book(fmp_account_book), PREAGGREGATION: OFF. Reason: __DORIS_DELETE_SIGN__ is used as conjuncts. No AggregateInfo
     PREDICATES: `default_cluster:xxxx`.`fmp_account_book`.`__DORIS_DELETE_SIGN__` = 0
     partitions=1/1 (fmp_account_book), tablets=10/10, tabletList=40130097,40130099,40130101 ...
     cardinality=43309, avgRowSize=575.8393, numNodes=1
     pushAggOp=NONE

2.1执行计划

PLAN FRAGMENT 0
  OUTPUT EXPRS:
    id[#24]
    acc_id[#25]
    account_type[#26]
    account_memo[#27]
    before_amount[#28]
    account_direction[#29]
    account_amount[#30]
    after_amount[#31]
    acc_amount[#32]
    available_amount[#33]
    account_abstract[#34]
    sheet_code[#35]
    ref_sheet_code[#36]
    ref_sheet_memo[#37]
    oper_user[#38]
    oper_user_name[#39]
    oper_date[#40]
    serial_id[#41]
    is_delete[#42]
    meta_code[#43]
    gmt_create[#44]
    gmt_modified[#45]
    __DORIS_DELETE_SIGN__[#46]
    cast(0 AS `__DORIS_VERSION_COL__` as BIGINT)[#47]
  PARTITION: HASH_PARTITIONED: id[#0]

  HAS_COLO_PLAN_NODE: false

  OLAP TABLE SINK
    TUPLE ID: 2
    RANDOM

  0:VOlapScanNode(141)
     TABLE: fmp_account_book(fmp_account_book), PREAGGREGATION: ON
     PREDICATES: (__DORIS_DELETE_SIGN__[#22] = 0)
     partitions=1/1 (fmp_account_book)
     tablets=10/10, tabletList=8824137,8824139,8824141 ...
     cardinality=40047, avgRowSize=0.0, numNodes=1
     pushAggOp=NONE
     final projections: id[#0], acc_id[#1], account_type[#2], account_memo[#3], before_amount[#4], account_direction[#5], account_amount[#6], after_amount[#7], acc_amount[#8], available_amount[#9], account_abstract[#10], sheet_code[#11], ref_sheet_code[#12], ref_sheet_memo[#13], oper_user[#14], oper_user_name[#15], oper_date[#16], serial_id[#17], is_delete[#18], meta_code[#19], gmt_create[#20], gmt_modified[#21], 0, CAST(0 AS BIGINT)
     final project output tuple id: 1


Statistics
 planed with unknown column statistics

问题：尝试关闭或修改2.1新特性，比如
enable_nereids_dml_with_pipeline
group_commit
等等，相关的参数后，仍然是13秒。
实在是困惑，和2.1宣称的insert into效率提升不符预期。

黄海军@SelectDB · Accepted Answer

用户开启了verbose log导致的，be.conf去掉sys_log_verbose_modules即可

Joey · Answer

INSERT INTO fmp_account_book (`id`, `acc_id`, `account_type`, `account_memo`, `before_amount`, `account_direction`, `account_amount`, `after_amount`, `acc_amount`, `available_amount`, `account_abstract`, `sheet_code`, `ref_sheet_code`, `ref_sheet_memo`, `oper_user`, `oper_user_name`, `oper_date`, `serial_id`, `is_delete`, `meta_code`, `gmt_create`, `gmt_modified`) 
VALUES ('639', '111', 'PAYABLE', '往来应付', 0.000, 1, 800.000, 800.000, 0.000, 0.000, '采购入库', 'PI230724000005', 'PO230723000001', NULL, '50', 'XXXXX', '2023-07-24 13:33:43.052', '16901768230521005204832919631', 0, 'ckp-16901768230541107212734629527', '2023-07-24 13:33:43.054', '2023-07-24 13:33:43.054')
,('640', '141', 'CHARGE', '充值', 0.000, 1, 15000.000, 15000.000, 15000.000, 15000.000, '余额充值', '', '', '', '106', 'XXXXX', '2023-07-24 13:33:59.365', '16901768393651641238535959134', 0, 'ckp-16901768393661288232938409618', '2023-07-24 13:33:59.366', '2023-07-24 13:33:59.366'),
('641', '142', 'CHARGE', '充值', 0.000, 1, 15000.000, 15000.000, 15000.000, 15000.000, '余额充值', '', '', '', '106', 'XXXXX', '2023-07-24 13:35:33.242', '16901769332421614238830409830', 0, 'ckp-16901769332431234246730149292', '2023-07-24 13:35:33.243', '2023-07-24 13:35:33.243'),
('642', '141', 'CHARGE', '充值', 15000.000, -1, 15000.000, 0.000, 0.000, 0.000, '余额充值作废', '', '', '', '106', 'XXXXX', '2023-07-24 13:37:26.735', '16901770467351785298038169575', 0, 'ckp-16901770467361918252033889287', '2023-07-24 13:37:26.736', '2023-07-24 13:37:26.736'),
('643', '111', 'PAYABLE', '往来应付', 800.000, 1, 11312.640, 12112.640, 0.000, 0.000, '采购入库', 'PI230724000006', 'PO230719000009', NULL, '50', 'XXXXX', '2023-07-24 13:38:19.455', '16901770994551215228434349930', 0, 'ckp-16901770994561112235539049492', '2023-07-24 13:38:19.456', '2023-07-24 13:38:19.456'),
('644', '142', 'CHARGE', '充值', 15000.000, -1, 15000.000, 0.000, 0.000, 0.000, '余额充值作废', '', '', '', '106', 'XXXXX', '2023-07-24 13:40:29.903', '16901772299031844282930169973', 0, 'ckp-16901772299041960238930879018', '2023-07-24 13:40:29.904', '2023-07-24 13:40:29.904'),
('645', '141', 'CHARGE', '充值', 0.000, 1, 15000.000, 15000.000, 15000.000, 15000.000, '余额充值', '', '', '', '106', 'XXXXX', '2023-07-24 13:40:55.947', '16901772559471898239634699448', 0, 'ckp-16901772559481805236539099610', '2023-07-24 13:40:55.948', '2023-07-24 13:40:55.948'),
('646', '111', 'PAYABLE', '往来应付', 12112.640, 1, 450.000, 12562.640, 0.000, 0.000, '采购入库', 'PI230724000007', 'PO230724000022', NULL, '50', 'XXXXX', '2023-07-24 14:36:28.506', '16901805885061322213133809632', 0, 'ckp-16901805885071152290333819345', '2023-07-24 14:36:28.507', '2023-07-24 14:36:28.507');

Joey · Answer

2.1

Summary:
      -  Profile  ID:  bc57d10ed09640b3-895c4c528b4a3fde
      -  Task  Type:  LOAD
      -  Start  Time:  2024-09-04  16:37:28
      -  End  Time:  2024-09-04  16:37:43
      -  Total:  14s95ms
      -  Task  State:  OK
      -  User:  root
      -  Default  Db:  mj_scm
      -  Sql  Statement:  insert  into  fmp_account_book_3
select  /*+  PROFILE()  */  *  from  fmp_account_book
Execution  Summary:
      -  Parse  SQL  Time:  0ms
      -  Nereids  Analysis  Time:  N/A
      -  Nereids  Rewrite  Time:  N/A
      -  Nereids  Optimize  Time:  N/A
      -  Nereids  Translate  Time:  N/A
      -  Workload  Group:  normal
      -  Analysis  Time:  2ms
      -  Plan  Time:  2ms
          -  JoinReorder  Time:  1ms
          -  CreateSingleNode  Time:  0ms
          -  QueryDistributed  Time:  1ms
          -  Init  Scan  Node  Time:  N/A
          -  Finalize  Scan  Node  Time:  N/A
              -  Get  Splits  Time:  N/A
                  -  Get  Partitions  Time:  N/A
                  -  Get  Partition  Files  Time:  N/A
              -  Create  Scan  Range  Time:  N/A
      -  Schedule  Time:  N/A
          -  Fragment  Assign  Time:  2ms
          -  Fragment  Serialize  Time:  1ms
          -  Fragment  RPC  Phase1  Time:  5ms
          -  Fragment  RPC  Phase2  Time:  N/A
          -  Fragment  Compressed  Size:  8.68  KB
          -  Fragment  RPC  Count:  1
      -  Wait  and  Fetch  Result  Time:  N/A
          -  Fetch  Result  Time:  0ms
          -  Write  Result  Time:  0ms
      -  Doris  Version:  doris-2.1.5-rc02-d5a02e095d
      -  Is  Nereids:  No
      -  Is  Pipeline:  Yes
      -  Is  Cached:  No
      -  Total  Instances  Num:  4
      -  Instances  Num  Per  BE:  172.20.11.191:8060:4
      -  Parallel  Fragment  Exec  Instance  Num:  4
      -  Trace  ID:  
      -  Transaction  Commit  Time:  N/A

  MergedProfile  
          Fragments:
              Fragment  0:
                  Pipeline  :  0(instance_num=4):
                      OLAP_TABLE_SINK_OPERATOR  (id=0):
                            -  CloseTime:  avg  2.286us,  max  3.961us,  min  1.143us
                            -  ExecTime:  avg  155.231us,  max  220.860us,  min  106.909us
                            -  InitTime:  avg  0ns,  max  0ns,  min  0ns
                            -  InputRows:  sum  40.047K  (40047),  avg  10.011K  (10011),  max  12.093K  (12093),  min  7.929K  (7929)
                            -  MemoryUsage:  sum  ,  avg  ,  max  ,  min  
                                -  PeakMemoryUsage:  sum  0.00  ,  avg  0.00  ,  max  0.00  ,  min  0.00  
                            -  OpenTime:  avg  34.207ms,  max  37.813ms,  min  29.164ms
                            -  WaitForDependency[AsyncWriterDependency]Time:  avg  0ns,  max  0ns,  min  0ns
                          OLAP_SCAN_OPERATOR  (id=0.  table  name  =  fmp_account_book(fmp_account_book)):
                                -  BlocksProduced:  sum  11,  avg  2,  max  4,  min  2
                                -  CloseTime:  avg  128.354us,  max  166.767us,  min  81.773us
                                -  ExecTime:  avg  57.752ms,  max  64.343ms,  min  44.895ms
                                -  InitTime:  avg  65.778us,  max  83.22us,  min  50.805us
                                -  MemoryUsage:  sum  ,  avg  ,  max  ,  min  
                                    -  PeakMemoryUsage:  sum  0.00  ,  avg  0.00  ,  max  0.00  ,  min  0.00  
                                -  OpenTime:  avg  989.134us,  max  2.772ms,  min  345.681us
                                -  ProjectionTime:  avg  0ns,  max  0ns,  min  0ns
                                -  RowsProduced:  sum  40.047K  (40047),  avg  10.011K  (10011),  max  12.093K  (12093),  min  7.929K  (7929)
                                -  RuntimeFilterInfo:  sum  ,  avg  ,  max  ,  min  
                                -  WaitForDependency[OLAP_SCAN_OPERATOR_DEPENDENCY]Time:  avg  56.475ms,  max  61.786ms,  min  44.344ms
                              VScanner:
                                    -  MemoryUsage:  sum  ,  avg  ,  max  ,  min  
                                        -  FreeBlocks:  sum  11.04  MB,  avg  2.76  MB,  max  3.43  MB,  min  2.03  MB

Execution  Profile  bc57d10ed09640b3-895c4c528b4a3fde:(Active:  14s96ms,  %  non-child:  0.00%)
    Fragments:
        Fragment  0:
            Pipeline  :0    (host=TNetworkAddress(hostname:172.20.11.191,  port:9050)):
                PipelineXTask  (index=0):(Active:  6.283ms,  %  non-child:  0.00%)
                      -  CoreChangeTimes:  0
                      -  ExecuteTime:  3.169ms
                          -  CloseTime:  173.333us
                          -  GetBlockTime:  122.249us
                          -  OpenTime:  2.794ms
                          -  PrepareTime:  140.523us
                          -  SinkTime:  220.520us
                      -  GetBlockCounter:  4
                      -  NumBlockedBySinkTimes:  0
                      -  NumBlockedBySrcTimes:  3
                      -  NumBlockedTimes:  4
                      -  NumScheduleTimes:  5
                      -  NumYieldTimes:  0
                      -  PendingFinishTimes:  1
                      -  TaskCpuTime:  1.364ms
                      -  WaitBfTime:  0ns
                      -  WaitBfTimes:  0
                      -  WaitDenpendencyTimes:  0
                      -  WaitWorkerTime:  62.297us
                    OLAP_TABLE_SINK_OPERATOR  (id=0):(Active:  14s31ms,  %  non-child:  0.00%)
                          -  CloseTime:  2.771us
                          -  CloseWaitTime:  35.804ms
                              -  CloseLoadTime:  9.977ms
                              -  CloseWriterTime:  25.656ms
                          -  ExecTime:  220.860us
                          -  InitTime:  0ns
                          -  InputRows:  12.093K  (12093)
                          -  MemoryUsage:  
                              -  PeakMemoryUsage:  0.00  
                          -  OpenTime:  32.751ms
                          -  PendingFinishDependency:  13s977ms
                          -  RowsFiltered:  0
                          -  RowsProduced:  12.093K  (12093)
                          -  RowsRead:  12.093K  (12093)
                          -  SendDataTime:  13s962ms
                              -  RowDistributionTime:  13s960ms
                              -  WaitMemLimitTime:  3.472us
                              -  WriteMemTableTime:  2.451ms
                          -  ValidateDataTime:  175.548us
                          -  WaitForDependency[AsyncWriterDependency]Time:  0ns
                        MemTableWriter  57407186:
                              -  CloseWaitTime:  570.213us
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  183ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  570.670us
                              -  MemTableSortTime:  208.627us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  569.14us
                              -  MergedRowNum:  0
                              -  RawRowNum:  4.019K  (4019)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  10.7ms
                        DeltaWriterV2  57407186:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  92ns
                              -  WriteMemTableTime:  628.499us
                        MemTableWriter  57407204:
                              -  CloseWaitTime:  727ns
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  159ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  433.850us
                              -  MemTableSortTime:  157.429us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  321ns
                              -  MergedRowNum:  0
                              -  RawRowNum:  3.964K  (3964)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  9.396ms
                        DeltaWriterV2  57407204:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  87ns
                              -  WriteMemTableTime:  678.218us
                        MemTableWriter  57407200:
                              -  CloseWaitTime:  619ns
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  175ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  661.326us
                              -  MemTableSortTime:  181.291us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  228ns
                              -  MergedRowNum:  0
                              -  RawRowNum:  3.985K  (3985)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  10.199ms
                        DeltaWriterV2  57407200:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  103ns
                              -  WriteMemTableTime:  640.882us
                        MemTableWriter  57407190:
                              -  CloseWaitTime:  9.331ms
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  197ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  695.869us
                              -  MemTableSortTime:  174.696us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  9.330ms
                              -  MergedRowNum:  0
                              -  RawRowNum:  3.965K  (3965)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  10.579ms
                        DeltaWriterV2  57407190:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  101ns
                              -  WriteMemTableTime:  826.558us
                        MemTableWriter  57407188:
                              -  CloseWaitTime:  940ns
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  194ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  891.919us
                              -  MemTableSortTime:  161.750us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  515ns
                              -  MergedRowNum:  0
                              -  RawRowNum:  4.01K  (4010)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  11.836ms
                        DeltaWriterV2  57407188:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  161ns
                              -  WriteMemTableTime:  1.6ms
                        MemTableWriter  57407194:
                              -  CloseWaitTime:  1.45us
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  173ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  711.520us
                              -  MemTableSortTime:  183.360us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  467ns
                              -  MergedRowNum:  0
                              -  RawRowNum:  3.998K  (3998)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  12.192ms
                        DeltaWriterV2  57407194:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  110ns
                              -  WriteMemTableTime:  589.298us
                        MemTableWriter  57407192:
                              -  CloseWaitTime:  840ns
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  194ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  591.806us
                              -  MemTableSortTime:  145.86us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  275ns
                              -  MergedRowNum:  0
                              -  RawRowNum:  4.054K  (4054)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  12.982ms
                        DeltaWriterV2  57407192:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  150ns
                              -  WriteMemTableTime:  753.50us
                        MemTableWriter  57407198:
                              -  CloseWaitTime:  904ns
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  184ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  381.133us
                              -  MemTableSortTime:  99.197us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  401ns
                              -  MergedRowNum:  0
                              -  RawRowNum:  3.964K  (3964)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  13.451ms
                        DeltaWriterV2  57407198:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  89ns
                              -  WriteMemTableTime:  752.215us
                        MemTableWriter  57407196:
                              -  CloseWaitTime:  1.69ms
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  186ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  477.95us
                              -  MemTableSortTime:  97.263us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  1.68ms
                              -  MergedRowNum:  0
                              -  RawRowNum:  4.012K  (4012)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  14.596ms
                        DeltaWriterV2  57407196:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  92ns
                              -  WriteMemTableTime:  893.950us
                        MemTableWriter  57407202:
                              -  CloseWaitTime:  14.227ms
                              -  DeleteBitmapTime:  0ns
                              -  LockTime:  304ns
                              -  MemTableAggTime:  0ns
                              -  MemTableAggTimes:  0
                              -  MemTableDurationTime:  0ns
                              -  MemTablePutIntoOutputTime:  570.339us
                              -  MemTableSortTime:  119.540us
                              -  MemTableSortTimes:  1
                              -  MemTableWaitFlushTime:  14.226ms
                              -  MergedRowNum:  0
                              -  RawRowNum:  4.076K  (4076)
                              -  SegmentNum:  1
                              -  SegmentWriterTime:  13.106ms
                        DeltaWriterV2  57407202:
                              -  CloseWaitTime:  0ns
                              -  WaitFlushLimitTime:  873ns
                              -  WriteMemTableTime:  981.948us
                        OLAP_SCAN_OPERATOR  (id=0.  table  name  =  fmp_account_book(fmp_account_book)):
                              -  RuntimeFilters:  :  
                              -  PushDownPredicates:  [{__DORIS_DELETE_SIGN__  IN  [0]}]
                              -  KeyRanges:  ScanKeys:ScanKey=[null(-170141183460469231731687303715884105728)  :  170141183460469231731687303715884105727]
                              -  TabletIds:  [8824137,  8824145,  8824153]
                              -  UseSpecificThreadToken:  False
                              -  AcquireRuntimeFilterTime:  414ns
                              -  BlocksProduced:  4
                              -  CloseTime:  166.767us
                              -  ExecTime:  64.343ms
                              -  InitTime:  83.22us
                              -  KeyRangesNum:  0
                              -  MaxScannerThreadNum:  3
                              -  MemoryUsage:  
                                  -  PeakMemoryUsage:  0.00  
                              -  NumScanners:  3
                              -  OpenTime:  2.772ms
                              -  ProcessConjunctTime:  152.836us
                              -  ProjectionTime:  0ns
                              -  RowsProduced:  12.093K  (12093)
                              -  RowsRead:  12.093K  (12093)
                              -  RuntimeFilterInfo:  
                              -  ScannerWorkerWaitTime:  5.649ms
                              -  TabletNum:  3
                              -  TotalReadThroughput:  0
                              -  WaitForDependency[OLAP_SCAN_OPERATOR_DEPENDENCY]Time:  61.202ms
                              -  WaitForRuntimeFilter:  0ns
                            VScanner:
                                  -  ReadColumns:  [id,  acc_id,  account_type,  account_memo,  before_amount,  account_direction,  account_amount,  after_amount,  acc_amount,  available_amount,  account_abstract
,  sheet_code,  ref_sheet_code,  ref_sheet_memo,  oper_user,  oper_user_name,  oper_date,  serial_id,  is_delete,  meta_code,  gmt_create,  gmt_modified
,  __DORIS_DELETE_SIGN__]
                                  -  PreEvaluatePredicates:  
ComparisonPredicateBase(TINYINT,  EQ),  column_id=22,  opposite=false
                                  -  PerScannerRunningTime:  [105.373us,  3.471ms,  1.624ms,  ]
                                  -  PerScannerRowsRead:  [4.02K,  4.00K,  4.08K,  ]
                                  -  PerScannerWaitTime:  [17.743us,  2.409ms,  3.222ms,  ]
                                  -  PerScannerProjectionTime:  [0.000ns,  0.000ns,  0.000ns,  ]
                                  -  BlockConvertTime:  0ns
                                  -  BlockFetchTime:  104.855us
                                  -  DeleteBitmapGetAggTime:  17.767us
                                  -  MemoryUsage:  
                                      -  FreeBlocks:  3.42  MB
                                  -  NewlyCreateFreeBlocksNum:  0
                                  -  NumScaleUpScanners:  0
                                  -  ReaderInitTime:  152.797ms
                                  -  RowsDelFiltered:  0
                                  -  ScannerBatchWaitTime:  248ns
                                  -  ScannerConvertBlockTime:  0ns
                                  -  ScannerCpuTime:  121.961ms
                                  -  ScannerCtxSchedTime:  5.646ms
                                  -  ScannerFilterTime:  16.901us
                                  -  ScannerGetBlockTime:  5.179ms
                                  -  ScannerInitTime:  216.648us
                                  -  ScannerPrefilterTime:  0ns
                                  -  ScannerSchedCount:  3
                                SegmentIterator:
                                      -  BitmapIndexFilterTimer:  1.153us
                                      -  BlockConditionsFilteredBloomFilterTime:  6.181us
                                      -  BlockConditionsFilteredDictTime:  2.181us
                                      -  BlockConditionsFilteredTime:  144.547us
                                      -  BlockConditionsFilteredZonemapRuntimePredicateTime:  0ns
                                      -  BlockConditionsFilteredZonemapTime:  113.490us
                                      -  BlockInitSeekCount:  0
                                      -  BlockInitSeekTime:  0ns
                                      -  BlockInitTime:  210.949us
                                      -  BlockLoadTime:  156.826ms
                                      -  BlocksLoad:  14
                                      -  CachedPagesNum:  0
                                      -  CollectIteratorMergeTime:  0ns
                                      -  CollectIteratorNormalTime:  0ns
                                      -  CompressedBytesRead:  1.27  MB
                                      -  DecompressorTimer:  1.115ms
                                      -  ExprFilterEvalTime:  0ns
                                      -  FirstReadSeekCount:  6
                                      -  FirstReadSeekTime:  88.7us
                                      -  FirstReadTime:  116.508us
                                      -  IOTimer:  831.368us
                                      -  InvertedIndexFilterTime:  6.571us
                                      -  InvertedIndexQueryBitmapCopyTime:  0ns
                                      -  InvertedIndexQueryBitmapOpTime:  0ns
                                      -  InvertedIndexQueryCacheHit:  0
                                      -  InvertedIndexQueryCacheMiss:  0
                                      -  InvertedIndexQueryTime:  0ns
                                      -  InvertedIndexSearcherOpenTime:  0ns
                                      -  InvertedIndexSearcherSearchTime:  0ns
                                      -  LazyReadSeekCount:  0
                                      -  LazyReadSeekTime:  0ns
                                      -  LazyReadTime:  12.261ms
                                      -  NumSegmentFiltered:  0
                                      -  NumSegmentTotal:  7
                                      -  OutputColumnTime:  15.823us
                                      -  OutputIndexResultColumnTimer:  844ns
                                      -  RawRowsRead:  12.093K  (12093)
                                      -  RowsBitmapIndexFiltered:  0
                                      -  RowsBloomFilterFiltered:  0
                                      -  RowsConditionsFiltered:  0
                                      -  RowsDictFiltered:  0
                                      -  RowsInvertedIndexFiltered:  0
                                      -  RowsKeyRangeFiltered:  0
                                      -  RowsShortCircuitPredFiltered:  0
                                      -  RowsShortCircuitPredInput:  0
                                      -  RowsStatsFiltered:  0
                                      -  RowsVectorPredFiltered:  0
                                      -  RowsVectorPredInput:  12.093K  (12093)
                                      -  RowsZonemapRuntimePredicateFiltered:  0
                                      -  SecondReadTime:  0ns
                                      -  ShortPredEvalTime:  248ns
                                      -  TotalPagesNum:  224
                                      -  UncompressedBytesRead:  1.57  MB
                                      -  VectorPredEvalTime:  12.121us
                PipelineXTask  (index=1):(Active:  1.448ms,  %  non-child:  0.00%)
                      -  CoreChangeTimes:  1
                      -  ExecuteTime:  707.716us
                          -  CloseTime:  178.905us
                          -  GetBlockTime:  99.512us
                          -  OpenTime:  446.166us
                          -  PrepareTime:  113.279us
                          -  SinkTime:  140.928us
                      -  GetBlockCounter:  3
                      -  NumBlockedBySinkTimes:  0
                      -  NumBlockedBySrcTimes:  2
                      -  NumBlockedTimes:  3
                      -  NumScheduleTimes:  4
                      -  NumYieldTimes:  0
                      -  PendingFinishTimes:  1
                      -  TaskCpuTime:  1.221ms
                      -  WaitBfTime:  0ns
                      -  WaitBfTimes:  0
                      -  WaitDenpendencyTimes:  0
                      -  WaitWorkerTime:  459.889us
                    OLAP_TABLE_SINK_OPERATOR  (id=0):(Active:  14s34ms,  %  non-child:  0.00%)
                          -  CloseTime:  3.961us
                          -  CloseWaitTime:  462.127ms
                              -  CloseLoadTime:  462.65ms
                              -  CloseWriterTime:  6.86us
                          -  ExecTime:  143.453us
                          -  InitTime:  0ns
                          -  InputRows:  11.986K  (11986)
                          -  MemoryUsage:  
                              -  PeakMemoryUsage:  0.00  
                          -  OpenTime:  37.813ms
                          -  PendingFinishDependency:  13s978ms
                          -  RowsFiltered:  0
                          -  RowsProduced:  11.986K  (11986)
                          -  RowsRead:  11.986K  (11986)
                          -  SendDataTime:  13s534ms
                              -  RowDistributionTime:  13s531ms
                              -  WaitMemLimitTime:  3.163us
                              -  WriteMemTableTime:  2.833ms
                          -  ValidateDataTime:  175.242us
                          -  WaitForDependency[AsyncWriterDependency]Time:  0ns
                        OLAP_SCAN_OPERATOR  (id=0.  table  name  =  fmp_account_book(fmp_account_book)):
                              -  RuntimeFilters:  :  
                              -  PushDownPredicates:  [{__DORIS_DELETE_SIGN__  IN  [0]}]
                              -  KeyRanges:  ScanKeys:ScanKey=[null(-170141183460469231731687303715884105728)  :  170141183460469231731687303715884105727]
                              -  TabletIds:  [8824139,  8824147,  8824155]
                              -  UseSpecificThreadToken:  False
                              -  AcquireRuntimeFilterTime:  383ns
                              -  BlocksProduced:  3
                              -  CloseTime:  162.535us
                              -  ExecTime:  62.550ms
                              -  InitTime:  73.643us
                              -  KeyRangesNum:  0
                              -  MaxScannerThreadNum:  3
                              -  MemoryUsage:  
                                  -  PeakMemoryUsage:  0.00  
                              -  NumScanners:  3
                              -  OpenTime:  430.419us
                              -  ProcessConjunctTime:  162.391us
                              -  ProjectionTime:  0ns
                              -  RowsProduced:  11.986K  (11986)
                              -  RowsRead:  11.986K  (11986)
                              -  RuntimeFilterInfo:  
                              -  ScannerWorkerWaitTime:  1.124ms
                              -  TabletNum:  3
                              -  TotalReadThroughput:  0
                              -  WaitForDependency[OLAP_SCAN_OPERATOR_DEPENDENCY]Time:  61.786ms
                              -  WaitForRuntimeFilter:  0ns
                            VScanner:
                                  -  ReadColumns:  [id,  acc_id,  account_type,  account_memo,  before_amount,  account_direction,  account_amount,  after_amount,  acc_amount,  available_amount,  account_abstract
,  sheet_code,  ref_sheet_code,  ref_sheet_memo,  oper_user,  oper_user_name,  oper_date,  serial_id,  is_delete,  meta_code,  gmt_create,  gmt_modified
,  __DORIS_DELETE_SIGN__]
                                  -  PreEvaluatePredicates:  
ComparisonPredicateBase(TINYINT,  EQ),  column_id=22,  opposite=false
                                  -  PerScannerRunningTime:  [70.988us,  2.348ms,  85.756us,  ]
                                  -  PerScannerRowsRead:  [4.01K,  4.01K,  3.96K,  ]
                                  -  PerScannerWaitTime:  [228.512us,  382.143us,  514.038us,  ]
                                  -  PerScannerProjectionTime:  [0.000ns,  0.000ns,  0.000ns,  ]
                                  -  BlockConvertTime:  0ns
                                  -  BlockFetchTime:  68.844us
                                  -  DeleteBitmapGetAggTime:  11.187us
                                  -  MemoryUsage:  
                                      -  FreeBlocks:  3.43  MB
                                  -  NewlyCreateFreeBlocksNum:  0
                                  -  NumScaleUpScanners:  0
                                  -  ReaderInitTime:  143.136ms
                                  -  RowsDelFiltered:  0
                                  -  ScannerBatchWaitTime:  178ns
                                  -  ScannerConvertBlockTime:  0ns
                                  -  ScannerCpuTime:  121.254ms
                                  -  ScannerCtxSchedTime:  1.119ms
                                  -  ScannerFilterTime:  11.854us
                                  -  ScannerGetBlockTime:  2.489ms
                                  -  ScannerInitTime:  229.151us
                                  -  ScannerPrefilterTime:  0ns
                                  -  ScannerSchedCount:  3
                                SegmentIterator:
                                      -  BitmapIndexFilterTimer:  888ns
                                      -  BlockConditionsFilteredBloomFilterTime:  4.56us
                                      -  BlockConditionsFilteredDictTime:  1.403us
                                      -  BlockConditionsFilteredTime:  98.555us
                                      -  BlockConditionsFilteredZonemapRuntimePredicateTime:  0ns
                                      -  BlockConditionsFilteredZonemapTime:  78.262us
                                      -  BlockInitSeekCount:  0
                                      -  BlockInitSeekTime:  0ns
                                      -  BlockInitTime:  145.996us
                                      -  BlockLoadTime:  144.680ms
                                      -  BlocksLoad:  10
                                      -  CachedPagesNum:  0
                                      -  CollectIteratorMergeTime:  0ns
                                      -  CollectIteratorNormalTime:  0ns
                                      -  CompressedBytesRead:  1.26  MB
                                      -  DecompressorTimer:  1.200ms
                                      -  ExprFilterEvalTime:  0ns
                                      -  FirstReadSeekCount:  5
                                      -  FirstReadSeekTime:  93.452us
                                      -  FirstReadTime:  110.323us
                                      -  IOTimer:  870.665us
                                      -  InvertedIndexFilterTime:  4.250us
                                      -  InvertedIndexQueryBitmapCopyTime:  0ns
                                      -  InvertedIndexQueryBitmapOpTime:  0ns
                                      -  InvertedIndexQueryCacheHit:  0
                                      -  InvertedIndexQueryCacheMiss:  0
                                      -  InvertedIndexQueryTime:  0ns
                                      -  InvertedIndexSearcherOpenTime:  0ns
                                      -  InvertedIndexSearcherSearchTime:  0ns
                                      -  LazyReadSeekCount:  0
                                      -  LazyReadSeekTime:  0ns
                                      -  LazyReadTime:  8.712ms
                                      -  NumSegmentFiltered:  0
                                      -  NumSegmentTotal:  5
                                      -  OutputColumnTime:  14.860us
                                      -  OutputIndexResultColumnTimer:  980ns
                                      -  RawRowsRead:  11.986K  (11986)
                                      -  RowsBitmapIndexFiltered:  0
                                      -  RowsBloomFilterFiltered:  0
                                      -  RowsConditionsFiltered:  0
                                      -  RowsDictFiltered:  0
                                      -  RowsInvertedIndexFiltered:  0
                                      -  RowsKeyRangeFiltered:  0
                                      -  RowsShortCircuitPredFiltered:  0
                                      -  RowsShortCircuitPredInput:  0
                                      -  RowsStatsFiltered:  0
                                      -  RowsVectorPredFiltered:  0
                                      -  RowsVectorPredInput:  11.986K  (11986)
                                      -  RowsZonemapRuntimePredicateFiltered:  0
                                      -  SecondReadTime:  0ns
                                      -  ShortPredEvalTime:  191ns
                                      -  TotalPagesNum:  160
                                      -  UncompressedBytesRead:  1.55  MB
                                      -  VectorPredEvalTime:  11.448us
                PipelineXTask  (index=2):(Active:  1.147ms,  %  non-child:  0.00%)
                      -  CoreChangeTimes:  0
                      -  ExecuteTime:  603.148us
                          -  CloseTime:  84.393us
                          -  GetBlockTime:  69.24us
                          -  OpenTime:  358.488us
                          -  PrepareTime:  97.600us
                          -  SinkTime:  149.987us
                      -  GetBlockCounter:  2
                      -  NumBlockedBySinkTimes:  0
                      -  NumBlockedBySrcTimes:  2
                      -  NumBlockedTimes:  3
                      -  NumScheduleTimes:  4
                      -  NumYieldTimes:  0
                      -  PendingFinishTimes:  1
                      -  TaskCpuTime:  997.523us
                      -  WaitBfTime:  0ns
                      -  WaitBfTimes:  0
                      -  WaitDenpendencyTimes:  0
                      -  WaitWorkerTime:  271.389us
                    OLAP_TABLE_SINK_OPERATOR  (id=0):(Active:  14s29ms,  %  non-child:  0.00%)
                          -  CloseTime:  1.272us
                          -  CloseWaitTime:  4s105ms
                              -  CloseLoadTime:  4s105ms
                              -  CloseWriterTime:  5.641us
                          -  ExecTime:  149.702us
                          -  InitTime:  0ns
                          -  InputRows:  7.929K  (7929)
                          -  MemoryUsage:  
                              -  PeakMemoryUsage:  0.00  
                          -  OpenTime:  29.164ms
                          -  PendingFinishDependency:  13s996ms
                          -  RowsFiltered:  0
                          -  RowsProduced:  7.929K  (7929)
                          -  RowsRead:  7.929K  (7929)
                          -  SendDataTime:  9s894ms
                              -  RowDistributionTime:  9s892ms
                              -  WaitMemLimitTime:  1.344us
                              -  WriteMemTableTime:  1.753ms
                          -  ValidateDataTime:  156.619us
                          -  WaitForDependency[AsyncWriterDependency]Time:  0ns
                        OLAP_SCAN_OPERATOR  (id=0.  table  name  =  fmp_account_book(fmp_account_book)):
                              -  RuntimeFilters:  :  
                              -  PushDownPredicates:  [{__DORIS_DELETE_SIGN__  IN  [0]}]
                              -  KeyRanges:  ScanKeys:ScanKey=[null(-170141183460469231731687303715884105728)  :  170141183460469231731687303715884105727]
                              -  TabletIds:  [8824141,  8824149]
                              -  UseSpecificThreadToken:  False
                              -  AcquireRuntimeFilterTime:  180ns
                              -  BlocksProduced:  2
                              -  CloseTime:  81.773us
                              -  ExecTime:  44.895ms
                              -  InitTime:  55.645us
                              -  KeyRangesNum:  0
                              -  MaxScannerThreadNum:  2
                              -  MemoryUsage:  
                                  -  PeakMemoryUsage:  0.00  
                              -  NumScanners:  2
                              -  OpenTime:  345.681us
                              -  ProcessConjunctTime:  133.912us
                              -  ProjectionTime:  0ns
                              -  RowsProduced:  7.929K  (7929)
                              -  RowsRead:  7.929K  (7929)
                              -  RuntimeFilterInfo:  
                              -  ScannerWorkerWaitTime:  67.991us
                              -  TabletNum:  2
                              -  TotalReadThroughput:  0
                              -  WaitForDependency[OLAP_SCAN_OPERATOR_DEPENDENCY]Time:  44.344ms
                              -  WaitForRuntimeFilter:  0ns
                            VScanner:
                                  -  ReadColumns:  [id,  acc_id,  account_type,  account_memo,  before_amount,  account_direction,  account_amount,  after_amount,  acc_amount,  available_amount,  account_abstract
,  sheet_code,  ref_sheet_code,  ref_sheet_memo,  oper_user,  oper_user_name,  oper_date,  serial_id,  is_delete,  meta_code,  gmt_create,  gmt_modified
,  __DORIS_DELETE_SIGN__]
                                  -  PreEvaluatePredicates:  
ComparisonPredicateBase(TINYINT,  EQ),  column_id=22,  opposite=false
                                  -  PerScannerRunningTime:  [90.656us,  60.281us,  ]
                                  -  PerScannerRowsRead:  [3.96K,  3.96K,  ]
                                  -  PerScannerWaitTime:  [35.336us,  32.655us,  ]
                                  -  PerScannerProjectionTime:  [0.000ns,  0.000ns,  ]
                                  -  BlockConvertTime:  0ns
                                  -  BlockFetchTime:  35.299us
                                  -  DeleteBitmapGetAggTime:  5.942us
                                  -  MemoryUsage:  
                                      -  FreeBlocks:  2.03  MB
                                  -  NewlyCreateFreeBlocksNum:  0
                                  -  NumScaleUpScanners:  0
                                  -  ReaderInitTime:  80.957ms
                                  -  RowsDelFiltered:  0
                                  -  ScannerBatchWaitTime:  134ns
                                  -  ScannerConvertBlockTime:  0ns
                                  -  ScannerCpuTime:  81.13ms
                                  -  ScannerCtxSchedTime:  63.919us
                                  -  ScannerFilterTime:  6.339us
                                  -  ScannerGetBlockTime:  141.403us
                                  -  ScannerInitTime:  165.12us
                                  -  ScannerPrefilterTime:  0ns
                                  -  ScannerSchedCount:  2
                                SegmentIterator:
                                      -  BitmapIndexFilterTimer:  326ns
                                      -  BlockConditionsFilteredBloomFilterTime:  1.563us
                                      -  BlockConditionsFilteredDictTime:  782ns
                                      -  BlockConditionsFilteredTime:  45.422us
                                      -  BlockConditionsFilteredZonemapRuntimePredicateTime:  0ns
                                      -  BlockConditionsFilteredZonemapTime:  36.553us
                                      -  BlockInitSeekCount:  0
                                      -  BlockInitSeekTime:  0ns
                                      -  BlockInitTime:  70.569us
                                      -  BlockLoadTime:  80.615ms
                                      -  BlocksLoad:  4
                                      -  CachedPagesNum:  0
                                      -  CollectIteratorMergeTime:  0ns
                                      -  CollectIteratorNormalTime:  0ns
                                      -  CompressedBytesRead:  847.62  KB
                                      -  DecompressorTimer:  799.320us
                                      -  ExprFilterEvalTime:  0ns
                                      -  FirstReadSeekCount:  2
                                      -  FirstReadSeekTime:  60.1us
                                      -  FirstReadTime:  71.578us
                                      -  IOTimer:  536.445us
                                      -  InvertedIndexFilterTime:  1.893us
                                      -  InvertedIndexQueryBitmapCopyTime:  0ns
                                      -  InvertedIndexQueryBitmapOpTime:  0ns
                                      -  InvertedIndexQueryCacheHit:  0
                                      -  InvertedIndexQueryCacheMiss:  0
                                      -  InvertedIndexQueryTime:  0ns
                                      -  InvertedIndexSearcherOpenTime:  0ns
                                      -  InvertedIndexSearcherSearchTime:  0ns
                                      -  LazyReadSeekCount:  0
                                      -  LazyReadSeekTime:  0ns
                                      -  LazyReadTime:  5.706ms
                                      -  NumSegmentFiltered:  0
                                      -  NumSegmentTotal:  2
                                      -  OutputColumnTime:  8.814us
                                      -  OutputIndexResultColumnTimer:  517ns
                                      -  RawRowsRead:  7.929K  (7929)
                                      -  RowsBitmapIndexFiltered:  0
                                      -  RowsBloomFilterFiltered:  0
                                      -  RowsConditionsFiltered:  0
                                      -  RowsDictFiltered:  0
                                      -  RowsInvertedIndexFiltered:  0
                                      -  RowsKeyRangeFiltered:  0
                                      -  RowsShortCircuitPredFiltered:  0
                                      -  RowsShortCircuitPredInput:  0
                                      -  RowsStatsFiltered:  0
                                      -  RowsVectorPredFiltered:  0
                                      -  RowsVectorPredInput:  7.929K  (7929)
                                      -  RowsZonemapRuntimePredicateFiltered:  0
                                      -  SecondReadTime:  0ns
                                      -  ShortPredEvalTime:  128ns
                                      -  TotalPagesNum:  64
                                      -  UncompressedBytesRead:  1.03  MB
                                      -  VectorPredEvalTime:  6.935us
                PipelineXTask  (index=3):(Active:  1.265ms,  %  non-child:  0.00%)
                      -  CoreChangeTimes:  0
                      -  ExecuteTime:  647.285us
                          -  CloseTime:  105.306us
                          -  GetBlockTime:  91.724us
                          -  OpenTime:  421.866us
                          -  PrepareTime:  88.237us
                          -  SinkTime:  107.160us
                      -  GetBlockCounter:  2
                      -  NumBlockedBySinkTimes:  0
                      -  NumBlockedBySrcTimes:  2
                      -  NumBlockedTimes:  3
                      -  NumScheduleTimes:  4
                      -  NumYieldTimes:  0
                      -  PendingFinishTimes:  1
                      -  TaskCpuTime:  1.49ms
                      -  WaitBfTime:  0ns
                      -  WaitBfTimes:  0
                      -  WaitDenpendencyTimes:  0
                      -  WaitWorkerTime:  227.956us
                    OLAP_TABLE_SINK_OPERATOR  (id=0):(Active:  14s35ms,  %  non-child:  0.00%)
                          -  CloseTime:  1.143us
                          -  CloseWaitTime:  4s128ms
                              -  CloseLoadTime:  4s128ms
                              -  CloseWriterTime:  5.966us
                          -  ExecTime:  106.909us
                          -  InitTime:  0ns
                          -  InputRows:  8.039K  (8039)
                          -  MemoryUsage:  
                              -  PeakMemoryUsage:  0.00  
                          -  OpenTime:  37.101ms
                          -  PendingFinishDependency:  13s982ms
                          -  RowsFiltered:  0
                          -  RowsProduced:  8.039K  (8039)
                          -  RowsRead:  8.039K  (8039)
                          -  SendDataTime:  9s870ms
                              -  RowDistributionTime:  9s868ms
                              -  WaitMemLimitTime:  2.49us
                              -  WriteMemTableTime:  1.566ms
                          -  ValidateDataTime:  134.384us
                          -  WaitForDependency[AsyncWriterDependency]Time:  0ns
                        OLAP_SCAN_OPERATOR  (id=0.  table  name  =  fmp_account_book(fmp_account_book)):
                              -  RuntimeFilters:  :  
                              -  PushDownPredicates:  [{__DORIS_DELETE_SIGN__  IN  [0]}]
                              -  KeyRanges:  ScanKeys:ScanKey=[null(-170141183460469231731687303715884105728)  :  170141183460469231731687303715884105727]
                              -  TabletIds:  [8824143,  8824151]
                              -  UseSpecificThreadToken:  False
                              -  AcquireRuntimeFilterTime:  126ns
                              -  BlocksProduced:  2
                              -  CloseTime:  102.344us
                              -  ExecTime:  59.219ms
                              -  InitTime:  50.805us
                              -  KeyRangesNum:  0
                              -  MaxScannerThreadNum:  2
                              -  MemoryUsage:  
                                  -  PeakMemoryUsage:  0.00  
                              -  NumScanners:  2
                              -  OpenTime:  408.171us
                              -  ProcessConjunctTime:  206.697us
                              -  ProjectionTime:  0ns
                              -  RowsProduced:  8.039K  (8039)
                              -  RowsRead:  8.039K  (8039)
                              -  RuntimeFilterInfo:  
                              -  ScannerWorkerWaitTime:  97.462us
                              -  TabletNum:  2
                              -  TotalReadThroughput:  0
                              -  WaitForDependency[OLAP_SCAN_OPERATOR_DEPENDENCY]Time:  58.568ms
                              -  WaitForRuntimeFilter:  0ns
                            VScanner:
                                  -  ReadColumns:  [id,  acc_id,  account_type,  account_memo,  before_amount,  account_direction,  account_amount,  after_amount,  acc_amount,  available_amount,  account_abstract
,  sheet_code,  ref_sheet_code,  ref_sheet_memo,  oper_user,  oper_user_name,  oper_date,  serial_id,  is_delete,  meta_code,  gmt_create,  gmt_modified
,  __DORIS_DELETE_SIGN__]
                                  -  PreEvaluatePredicates:  
ComparisonPredicateBase(TINYINT,  EQ),  column_id=22,  opposite=false
                                  -  PerScannerRunningTime:  [1.624ms,  134.560us,  ]
                                  -  PerScannerRowsRead:  [4.05K,  3.98K,  ]
                                  -  PerScannerWaitTime:  [48.818us,  48.644us,  ]
                                  -  PerScannerProjectionTime:  [0.000ns,  0.000ns,  ]
                                  -  BlockConvertTime:  0ns
                                  -  BlockFetchTime:  50.277us
                                  -  DeleteBitmapGetAggTime:  7.119us
                                  -  MemoryUsage:  
                                      -  FreeBlocks:  2.16  MB
                                  -  NewlyCreateFreeBlocksNum:  0
                                  -  NumScaleUpScanners:  0
                                  -  ReaderInitTime:  99.29ms
                                  -  RowsDelFiltered:  0
                                  -  ScannerBatchWaitTime:  117ns
                                  -  ScannerConvertBlockTime:  0ns
                                  -  ScannerCpuTime:  75.279ms
                                  -  ScannerCtxSchedTime:  94.184us
                                  -  ScannerFilterTime:  6.696us
                                  -  ScannerGetBlockTime:  1.749ms
                                  -  ScannerInitTime:  158.377us
                                  -  ScannerPrefilterTime:  0ns
                                  -  ScannerSchedCount:  2
                                SegmentIterator:
                                      -  BitmapIndexFilterTimer:  444ns
                                      -  BlockConditionsFilteredBloomFilterTime:  2.950us
                                      -  BlockConditionsFilteredDictTime:  1.772us
                                      -  BlockConditionsFilteredTime:  8.970ms
                                      -  BlockConditionsFilteredZonemapRuntimePredicateTime:  0ns
                                      -  BlockConditionsFilteredZonemapTime:  8.954ms
                                      -  BlockInitSeekCount:  0
                                      -  BlockInitSeekTime:  0ns
                                      -  BlockInitTime:  9.7ms
                                      -  BlockLoadTime:  100.20ms
                                      -  BlocksLoad:  6
                                      -  CachedPagesNum:  0
                                      -  CollectIteratorMergeTime:  0ns
                                      -  CollectIteratorNormalTime:  0ns
                                      -  CompressedBytesRead:  862.32  KB
                                      -  DecompressorTimer:  705.293us
                                      -  ExprFilterEvalTime:  0ns
                                      -  FirstReadSeekCount:  3
                                      -  FirstReadSeekTime:  69.758us
                                      -  FirstReadTime:  79.479us
                                      -  IOTimer:  484.117us
                                      -  InvertedIndexFilterTime:  2.797us
                                      -  InvertedIndexQueryBitmapCopyTime:  0ns
                                      -  InvertedIndexQueryBitmapOpTime:  0ns
                                      -  InvertedIndexQueryCacheHit:  0
                                      -  InvertedIndexQueryCacheMiss:  0
                                      -  InvertedIndexQueryTime:  0ns
                                      -  InvertedIndexSearcherOpenTime:  0ns
                                      -  InvertedIndexSearcherSearchTime:  0ns
                                      -  LazyReadSeekCount:  0
                                      -  LazyReadSeekTime:  0ns
                                      -  LazyReadTime:  4.658ms
                                      -  NumSegmentFiltered:  0
                                      -  NumSegmentTotal:  3
                                      -  OutputColumnTime:  8.966us
                                      -  OutputIndexResultColumnTimer:  632ns
                                      -  RawRowsRead:  8.039K  (8039)
                                      -  RowsBitmapIndexFiltered:  0
                                      -  RowsBloomFilterFiltered:  0
                                      -  RowsConditionsFiltered:  0
                                      -  RowsDictFiltered:  0
                                      -  RowsInvertedIndexFiltered:  0
                                      -  RowsKeyRangeFiltered:  0
                                      -  RowsShortCircuitPredFiltered:  0
                                      -  RowsShortCircuitPredInput:  0
                                      -  RowsStatsFiltered:  0
                                      -  RowsVectorPredFiltered:  0
                                      -  RowsVectorPredInput:  8.039K  (8039)
                                      -  RowsZonemapRuntimePredicateFiltered:  0
                                      -  SecondReadTime:  0ns
                                      -  ShortPredEvalTime:  114ns
                                      -  TotalPagesNum:  96
                                      -  UncompressedBytesRead:  1.04  MB
                                      -  VectorPredEvalTime:  7.634us
    LoadChannels:

Joey · Answer

2.0

Query:
    Summary:
          -  Profile  ID:  de5c12a2a94a18-b5c06597e57df822
          -  Task  Type:  LOAD
          -  Start  Time:  2024-09-04  16:40:08
          -  End  Time:  2024-09-04  16:40:08
          -  Total:  206ms
          -  Task  State:  OK
          -  User:  root
          -  Default  Db:  default_cluster:mj_cdc_scm
          -  Sql  Statement:  insert  into  fmp_account_book_2
select  *  from  fmp_account_book
    Execution  Summary:
          -  Workload  Group:  
          -  Analysis  Time:  0ms
          -  Plan  Time:  0ms
              -  JoinReorder  Time:  0ms
              -  CreateSingleNode  Time:  0ms
              -  QueryDistributed  Time:  0ms
              -  Init  Scan  Node  Time:  N/A
              -  Finalize  Scan  Node  Time:  N/A
                  -  Get  Splits  Time:  N/A
                      -  Get  PARTITIONS  Time:  N/A
                      -  Get  PARTITION  FILES  Time:  N/A
                  -  Create  Scan  Range  Time:  N/A
          -  Schedule  Time:  N/A
          -  Fetch  Result  Time:  0ms
          -  Write  Result  Time:  0ms
          -  Wait  and  Fetch  Result  Time:  N/A
          -  Doris  Version:  doris-2.0.3-rc06-37d31a5
          -  Is  Nereids:  No
          -  Is  Pipeline:  No
          -  Is  Cached:  No
          -  Total  Instances  Num:  1
          -  Instances  Num  Per  BE:  10.0.0.193:8060:1
          -  Parallel  Fragment  Exec  Instance  Num:  1
          -  Trace  ID:  
    Execution  Profile  de5c12a2a94a18-b5c06597e57df822:(Active:  214ms,  %  non-child:  0.00%)
        Fragments:
            Fragment  0:
                Instance  de5c12a2a94a18-b5c06597e57df823  (host=TNetworkAddress(hostname:10.0.0.193,  port:9060)):(Active:  181.928ms,  %  non-child:  0.00%)
                      -  DorisBeVersion:  37d31a5
                      -  BlocksProduced:  20
                      -  FragmentCpuTime:  29.153ms
                      -  RowsProduced:  43.428K  (43428)
                    OlapTableSink:(Active:  180.842ms,  %  non-child:  0.00%)
                          -  CloseWaitTime:  130.301ms
                          -  MaxAddBatchExecTime:  96.582ms
                          -  MaxWaitExecTime:  21.0us
                          -  NonBlockingSendTime:  99.272ms
                              -  NonBlockingSendWorkTime:  44.813ms
                                  -  SerializeBatchTime:  40.253ms
                          -  NumberBatchAdded:  6
                          -  NumberNodeChannels:  1
                          -  OpenTime:  21.902ms
                          -  RowsFiltered:  0
                          -  RowsRead:  43.428K  (43428)
                          -  RowsReturned:  43.428K  (43428)
                          -  SendDataTime:  26.938ms
                              -  AppendNodeChannelTime:  18.446ms
                              -  FilterTime:  0ns
                              -  RowDistributionTime:  8.412ms
                              -  WaitMemLimitTime:  0ns
                              -  WhereClauseTime:  0ns
                          -  TotalAddBatchExecTime:  96.582ms
                          -  TotalWaitExecTime:  21.0us
                          -  ValidateDataTime:  703.720us
                    VNewOlapScanNode(fmp_account_book)  (id=0):(Active:  996.847us,  %  non-child:  0.00%)
                          -  RuntimeFilters:  :  
                          -  PushDownPredicates:  [{__DORIS_DELETE_SIGN__  IN  [0]}]
                          -  KeyRanges:  ScanKeys:ScanKey=[null(-170141183460469231731687303715884105728)  :  170141183460469231731687303715884105727]
                          -  TabletIds:  [40130107,  40130113,  40130109,  40130115,  40130105,  40130097,  40130103,  40130101,  40130099,  40130111]
                          -  RemainedPredicates:  VectorizedFn[VectorizedFnCall[eq](arguments=__DORIS_DELETE_SIGN__,  Int8,return=UInt8)]{
SlotRef(slot_id=46  type=TINYINT),
VLiteral  (name  =  Int8,  type  =  Int8,  value  =  (0))}
                          -  UseSpecificThreadToken:  False
                          -  AcquireRuntimeFilterTime:  331ns
                          -  AllocateResourceTime:  174.225us
                          -  GetNextTime:  825.327us
                          -  MaxScannerThreadNum:  10
                          -  MemoryUsage:  
                              -  PeakMemoryUsage:  0.00  
                          -  NumScanners:  10
                          -  OpenTime:  174.592us
                          -  ProcessConjunctTime:  90.549us
                          -  ProjectionTime:  0ns
                          -  RowsReturned:  43.428K  (43428)
                          -  RowsReturnedRate:  43.565361M  /sec
                          -  ScanByteRead:  22.39  MB
                          -  ScanRowsRead:  43.428K  (43428)
                          -  ScannerWorkerWaitTime:  62.188ms
                          -  TabletNum:  10
                          -  TotalReadThroughput:  0
                        VScanner:
                              -  ReadColumns:  [id,  acc_id,  account_type,  account_memo,  before_amount,  account_direction,  account_amount,  after_amount,  acc_amount,  available_amount,  account_abstract
,  sheet_code,  ref_sheet_code,  ref_sheet_memo,  oper_user,  oper_user_name,  oper_date,  serial_id,  is_delete,  meta_code,  gmt_create,  gmt_modified
,  __DORIS_DELETE_SIGN__]
                              -  BlockConvertTime:  0ns
                              -  BlockFetchTime:  11.395ms
                              -  MemoryUsage:  
                                  -  FreeBlocks:  18.03  MB
                                  -  QueuedBlocks:  13.69  MB
                              -  NewlyCreateFreeBlocksNum:  16
                              -  ReaderInitTime:  0ns
                              -  RowsDelFiltered:  0
                              -  ScannerBatchWaitTime:  863ns
                              -  ScannerConvertBlockTime:  0ns
                              -  ScannerCpuTime:  101.930ms
                              -  ScannerCtxSchedCount:  11
                              -  ScannerCtxSchedTime:  10.406ms
                              -  ScannerFilterTime:  293.877us
                              -  ScannerGetBlockTime:  114.289ms
                              -  ScannerInitTime:  61.29us
                              -  ScannerPrefilterTime:  0ns
                              -  ScannerSchedCount:  10
                            SegmentIterator:
                                  -  BitmapIndexFilterTimer:  5.856us
                                  -  BlockConditionsFilteredTime:  226.552us
                                  -  BlockInitSeekCount:  238
                                  -  BlockInitSeekTime:  1.43ms
                                  -  BlockInitTime:  1.834ms
                                  -  BlockLoadTime:  30.688ms
                                  -  BlocksLoad:  267
                                  -  CachedPagesNum:  180
                                  -  CompressedBytesRead:  1.73  MB
                                  -  DecompressorTimer:  232.391us
                                  -  ExprFilterEvalTime:  0ns
                                  -  FirstReadSeekCount:  2.87K  (2870)
                                  -  FirstReadSeekTime:  7.666ms
                                  -  FirstReadTime:  10.709ms
                                  -  IOTimer:  1.414ms
                                  -  InvertedIndexFilterTime:  17.19us
                                  -  InvertedIndexQueryBitmapCopyTime:  0ns
                                  -  InvertedIndexQueryBitmapOpTime:  0ns
                                  -  InvertedIndexQueryCacheHit:  0
                                  -  InvertedIndexQueryCacheMiss:  0
                                  -  InvertedIndexQueryTime:  0ns
                                  -  InvertedIndexSearcherOpenTime:  0ns
                                  -  InvertedIndexSearcherSearchTime:  0ns
                                  -  LazyReadSeekCount:  0
                                  -  LazyReadSeekTime:  0ns
                                  -  LazyReadTime:  14.709ms
                                  -  NumSegmentFiltered:  0
                                  -  NumSegmentTotal:  37
                                  -  OutputColumnTime:  155.797us
                                  -  OutputIndexResultColumnTimer:  22.820us
                                  -  RawRowsRead:  43.428K  (43428)
                                  -  RowsBitmapIndexFiltered:  0
                                  -  RowsBloomFilterFiltered:  0
                                  -  RowsConditionsFiltered:  0
                                  -  RowsDictFiltered:  0
                                  -  RowsInvertedIndexFiltered:  0
                                  -  RowsKeyRangeFiltered:  0
                                  -  RowsShortCircuitPredFiltered:  0
                                  -  RowsShortCircuitPredInput:  0
                                  -  RowsStatsFiltered:  0
                                  -  RowsVectorPredFiltered:  0
                                  -  RowsVectorPredInput:  33.013K  (33013)
                                  -  SecondReadTime:  0ns
                                  -  ShortPredEvalTime:  4.432us
                                  -  TotalPagesNum:  1.184K  (1184)
                                  -  UncompressedBytesRead:  1.75  MB
                                  -  VectorPredEvalTime:  48.687us
        LoadChannels:
              -  HandleMemLimitTime:  1.975us
              -  LoadChannelMgrAddBatchTime:  36.350ms
            LoadChannel  load_id=00de5c12a2a94a18-b5c06597e57df822  (host=10.0.0.193,  backend_id=11438):
                  -  EosHost:  11438
                  -  AddBatchTime:  36.344ms
                      -  HandleEosTime:  0ns
                  -  AddBatchTimes:  6
                  -  NumberBatchAdded:  6
                  -  PeakMemoryUsage:  13.08  MB
                TabletsChannel  (load_id=00de5c12a2a94a18-b5c06597e57df822,  index_id=84852862):
                      -  AddBatchTime:  36.498ms
                      -  NumberBatchAdded:  6
                      -  SlaveReplicaTime:  0ns
                      -  WriteBlockTime:  20.528ms
                    DeltaWriter  84852881:
                          -  DeltaWriterCloseWaitTime:  1.221ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  259ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  2.427ms
                          -  MemTableSortTime:  210.700us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  839ns
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.274K  (4274)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  12.645ms
                    DeltaWriter  84852879:
                          -  DeltaWriterCloseWaitTime:  1.206ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  316ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.851ms
                          -  MemTableSortTime:  230.553us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  730ns
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.405K  (4405)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  13.141ms
                    DeltaWriter  84852877:
                          -  DeltaWriterCloseWaitTime:  1.153ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  292ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.867ms
                          -  MemTableSortTime:  213.734us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  913ns
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.314K  (4314)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  33.694ms
                    DeltaWriter  84852875:
                          -  DeltaWriterCloseWaitTime:  1.290ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  256ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.776ms
                          -  MemTableSortTime:  212.598us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  941ns
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.309K  (4309)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  12.613ms
                    DeltaWriter  84852873:
                          -  DeltaWriterCloseWaitTime:  1.104ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  494ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.749ms
                          -  MemTableSortTime:  174.765us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  869ns
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.349K  (4349)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  21.414ms
                    DeltaWriter  84852871:
                          -  DeltaWriterCloseWaitTime:  1.447ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  211ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.765ms
                          -  MemTableSortTime:  396.69us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  779ns
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.354K  (4354)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  12.182ms
                    DeltaWriter  84852869:
                          -  DeltaWriterCloseWaitTime:  1.186ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  296ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.918ms
                          -  MemTableSortTime:  208.721us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  751ns
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.397K  (4397)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  12.446ms
                    DeltaWriter  84852867:
                          -  DeltaWriterCloseWaitTime:  1.365ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  324ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.860ms
                          -  MemTableSortTime:  219.243us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  939ns
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.307K  (4307)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  12.490ms
                    DeltaWriter  84852865:
                          -  DeltaWriterCloseWaitTime:  1.369ms
                          -  LockTime:  1ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  341ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.931ms
                          -  MemTableSortTime:  207.236us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  1.619us
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.38K  (4380)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  15.215ms
                    DeltaWriter  84852863:
                          -  DeltaWriterCloseWaitTime:  1.404ms
                          -  LockTime:  0ns
                          -  MemTableAggTime:  0ns
                          -  MemTableAggTimes:  0
                          -  MemTableDeleteBitmapTime:  234ns
                          -  MemTableDurationTime:  0ns
                          -  MemTablePutIntoOutputTime:  1.373ms
                          -  MemTableSortTime:  230.322us
                          -  MemTableSortTimes:  1
                          -  MemTableWaitFlushTime:  40.632ms
                          -  MergedRowNum:  0
                          -  RawRowNum:  4.339K  (4339)
                          -  SegmentNum:  1
                          -  SegmentWriterTime:  8.836ms
                    PeakMemoryUsage:
                          -  Flush:  0.00  
                          -  MaxTablet:  2.24  MB
                          -  MaxTabletFlush:  0.00  
                          -  MaxTabletWrite:  2.24  MB
                          -  Total:  4.36  MB
                          -  Write:  4.36  MB

zclllyybb · Answer

结论：verbose log导致的。这个是调试环境使用的，开了以后的性能表现没有参考意义，符合预期。

从2.0升级到2.1后，insert into变慢非常多导致作业超时，升级步骤问题还是配置问题？

5 Answers