LOADED org.apache.flink.cdc.connectors.mysql.source.MySqlSource file:/work/flink-cdc-article1-06wcq8ar/flink-cdc-045e8da45df4b1017849b04e2d8bfe8f0ed7936d/flink-cdc-connect/flink-cdc-source-connectors/flink-connector-mysql-cdc/target/classes/
LOADED org.apache.flink.cdc.connectors.mysql.debezium.reader.SnapshotSplitReader file:/work/flink-cdc-article1-06wcq8ar/flink-cdc-045e8da45df4b1017849b04e2d8bfe8f0ed7936d/flink-cdc-connect/flink-cdc-source-connectors/flink-connector-mysql-cdc/target/classes/
LOADED org.apache.flink.cdc.connectors.mysql.debezium.reader.BinlogSplitReader file:/work/flink-cdc-article1-06wcq8ar/flink-cdc-045e8da45df4b1017849b04e2d8bfe8f0ed7936d/flink-cdc-connect/flink-cdc-source-connectors/flink-connector-mysql-cdc/target/classes/
LOADED org.apache.flink.cdc.connectors.mysql.source.utils.RecordUtils file:/work/flink-cdc-article1-06wcq8ar/flink-cdc-045e8da45df4b1017849b04e2d8bfe8f0ed7936d/flink-cdc-connect/flink-cdc-source-connectors/flink-connector-mysql-cdc/target/classes/
LOADED org.apache.flink.cdc.connectors.paimon.sink.v2.PaimonWriter file:/work/flink-cdc-article1-06wcq8ar/flink-cdc-045e8da45df4b1017849b04e2d8bfe8f0ed7936d/flink-cdc-connect/flink-cdc-pipeline-connectors/flink-cdc-pipeline-connector-paimon/target/classes/
LOADED org.apache.flink.cdc.connectors.paimon.sink.v2.PreCommitOperator file:/work/flink-cdc-article1-06wcq8ar/flink-cdc-045e8da45df4b1017849b04e2d8bfe8f0ed7936d/flink-cdc-connect/flink-cdc-pipeline-connectors/flink-cdc-pipeline-connector-paimon/target/classes/
JOB_ID 54de47fccef9e896c072b641606ad206
TASK_OPEN attempt=0
READER_ADD attempt=0 splits=[MySqlSnapshotSplit{tableId=cdc_chunk_e2e.items, splitId='cdc_chunk_e2e.items:0', splitKeyType=[`c` INT NOT NULL], splitStart=null, splitEnd=[105], highWatermark=null}]
PRE_LOW attempt=0 MySqlSnapshotSplit{tableId=cdc_chunk_e2e.items, splitId='cdc_chunk_e2e.items:0', splitKeyType=[`c` INT NOT NULL], splitStart=null, splitEnd=[105], highWatermark=null}
POST_LOW cdc_chunk_e2e.items:0 offset={ts_sec=0, file=binlog.000003, pos=56654, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-203, row=0, event=0}
POST_HIGH cdc_chunk_e2e.items:0 offset={ts_sec=0, file=binlog.000003, pos=56654, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-203, row=0, event=0}
READER_ADD attempt=0 splits=[MySqlSnapshotSplit{tableId=cdc_chunk_e2e.items, splitId='cdc_chunk_e2e.items:1', splitKeyType=[`c` INT NOT NULL], splitStart=[105], splitEnd=null, highWatermark=null}]
PRE_LOW attempt=0 MySqlSnapshotSplit{tableId=cdc_chunk_e2e.items, splitId='cdc_chunk_e2e.items:1', splitKeyType=[`c` INT NOT NULL], splitStart=[105], splitEnd=null, highWatermark=null}
OBSERVER_STATE checkpoint=1 count=10
READER_STATE checkpoint=1 splits=[MySqlSnapshotSplit{tableId=cdc_chunk_e2e.items, splitId='cdc_chunk_e2e.items:1', splitKeyType=[`c` INT NOT NULL], splitStart=[105], splitEnd=null, highWatermark=null}]
CHECKPOINT_CALLBACK 1
GLOBAL_CHECKPOINT_FUTURE_COMPLETED callbacks=[1]
PRE_MIGRATION_COMPLETED checkpoint=1
MUTATIONS_COMMITTED before B LOW
POST_LOW cdc_chunk_e2e.items:1 offset={ts_sec=0, file=binlog.000003, pos=57596, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-206, row=0, event=0}
POST_HIGH cdc_chunk_e2e.items:1 offset={ts_sec=0, file=binlog.000003, pos=57596, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-206, row=0, event=0}
READER_ADD attempt=0 splits=[MySqlBinlogSplit{splitId='binlog-split', tables=[], offset={ts_sec=0, file=binlog.000003, pos=56654, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-203, row=0, event=0}, endOffset={ts_sec=0, file=, pos=-9223372036854775808, kind=NON_STOPPING, row=0, event=0}, isSuspended=false}]
OBSERVER_STATE checkpoint=2 count=21
READER_STATE checkpoint=2 splits=[MySqlBinlogSplit{splitId='binlog-split', tables=[cdc_chunk_e2e.items], offset={transaction_id=null, ts_sec=1792314835, file=binlog.000003, pos=57675, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-206, row=1, event=2, server_id=8675322}, endOffset={ts_sec=0, file=, pos=-9223372036854775808, kind=NON_STOPPING, row=0, event=0}, isSuspended=false}]
CHECKPOINT_CALLBACK 2
GLOBAL_CHECKPOINT_FUTURE_COMPLETED callbacks=[1, 2]
POST_MIGRATION_COMPLETED checkpoint=2
OBSERVER_STATE checkpoint=3 count=21
READER_STATE checkpoint=3 splits=[MySqlBinlogSplit{splitId='binlog-split', tables=[cdc_chunk_e2e.items], offset={transaction_id=null, ts_sec=1792314835, file=binlog.000003, pos=57675, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-206, row=1, event=2, server_id=8675322}, endOffset={ts_sec=0, file=, pos=-9223372036854775808, kind=NON_STOPPING, row=0, event=0}, isSuspended=false}]
FAULT_HELD checkpoint=3
EXTERNAL_SNAPSHOT_PUBLISHED snapshot=3 commitIdentifier=3 globalFuturePending=true
FAILED_CHECKPOINT_EXCEPTION org.apache.flink.runtime.checkpoint.CheckpointException: Checkpoint Coordinator is suspending.
RESTORED checkpoint=2 count=21
TASK_OPEN attempt=1
READER_ADD attempt=1 splits=[MySqlBinlogSplit{splitId='binlog-split', tables=[cdc_chunk_e2e.items], offset={transaction_id=null, ts_sec=1792314835, file=binlog.000003, pos=57675, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-206, row=1, event=2, server_id=8675322}, endOffset={ts_sec=0, file=, pos=-9223372036854775808, kind=NON_STOPPING, row=0, event=0}, isSuspended=false}]
RESTORED_READER_STATE_MATCH checkpoint=2
OBSERVER_STATE checkpoint=4 count=22
READER_STATE checkpoint=4 splits=[MySqlBinlogSplit{splitId='binlog-split', tables=[cdc_chunk_e2e.items], offset={transaction_id=null, ts_sec=1792314837, file=binlog.000003, pos=57989, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-207, row=1, event=2, server_id=8675322}, endOffset={ts_sec=0, file=, pos=-9223372036854775808, kind=NON_STOPPING, row=0, event=0}, isSuspended=false}]
CHECKPOINT_CALLBACK 4
GLOBAL_CHECKPOINT_FUTURE_COMPLETED callbacks=[1, 2, 4]
OBSERVER_STATE checkpoint=5 count=22
READER_STATE checkpoint=5 splits=[MySqlBinlogSplit{splitId='binlog-split', tables=[cdc_chunk_e2e.items], offset={transaction_id=null, ts_sec=1792314837, file=binlog.000003, pos=57989, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-207, row=1, event=2, server_id=8675322}, endOffset={ts_sec=0, file=, pos=-9223372036854775808, kind=NON_STOPPING, row=0, event=0}, isSuspended=false}]
CHECKPOINT_CALLBACK 5
GLOBAL_CHECKPOINT_FUTURE_COMPLETED callbacks=[1, 2, 4, 5]
BOUNDARY_ASSERTIONS_PASS H_A={ts_sec=0, file=binlog.000003, pos=56654, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-203, row=0, event=0} E_102={transaction_id=null, ts_sec=1792314833, file=binlog.000003, pos=56733, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-203, row=1, event=2, server_id=8675322} L_B={ts_sec=0, file=binlog.000003, pos=57596, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-206, row=0, event=0} H_B={ts_sec=0, file=binlog.000003, pos=57596, kind=SPECIFIC, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-206, row=0, event=0}
AUDIT_RAW SourceRecord{sourcePartition={server=mysql_binlog_source}, sourceOffset={transaction_id=null, ts_sec=1792314833, file=binlog.000003, pos=56733, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-203, row=1, server_id=8675322, event=2}} ConnectRecord{topic='mysql_binlog_source.cdc_chunk_e2e.items', kafkaPartition=null, key=Struct{id=102}, keySchema=Schema{mysql_binlog_source.cdc_chunk_e2e.items.Key:STRUCT}, value=Struct{before=Struct{id=102,c=110,amount=20},after=Struct{id=102,c=100,amount=20},source=Struct{version=1.9.8.Final,connector=mysql,name=mysql_binlog_source,ts_ms=1792314833000,db=cdc_chunk_e2e,table=items,server_id=8675322,gtid=cb0792da-cad3-11f1-9571-2658671ca05a:204,file=binlog.000003,pos=56875,row=0,thread=108},op=u,ts_ms=1792314839063}, valueSchema=Schema{mysql_binlog_source.cdc_chunk_e2e.items.Envelope:STRUCT}, timestamp=null, headers=ConnectHeaders(headers=)}
AUDIT_RAW SourceRecord{sourcePartition={server=mysql_binlog_source}, sourceOffset={transaction_id=null, ts_sec=1792314833, file=binlog.000003, pos=57047, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-204, row=1, server_id=8675322, event=2}} ConnectRecord{topic='mysql_binlog_source.cdc_chunk_e2e.items', kafkaPartition=null, key=Struct{id=101}, keySchema=Schema{mysql_binlog_source.cdc_chunk_e2e.items.Key:STRUCT}, value=Struct{before=Struct{id=101,c=100,amount=10},after=Struct{id=101,c=100,amount=11},source=Struct{version=1.9.8.Final,connector=mysql,name=mysql_binlog_source,ts_ms=1792314833000,db=cdc_chunk_e2e,table=items,server_id=8675322,gtid=cb0792da-cad3-11f1-9571-2658671ca05a:205,file=binlog.000003,pos=57189,row=0,thread=108},op=u,ts_ms=1792314839064}, valueSchema=Schema{mysql_binlog_source.cdc_chunk_e2e.items.Envelope:STRUCT}, timestamp=null, headers=ConnectHeaders(headers=)}
AUDIT_RAW SourceRecord{sourcePartition={server=mysql_binlog_source}, sourceOffset={transaction_id=null, ts_sec=1792314833, file=binlog.000003, pos=57361, gtids=cb0792da-cad3-11f1-9571-2658671ca05a:1-205, row=1, server_id=8675322, event=2}} ConnectRecord{topic='mysql_binlog_source.cdc_chunk_e2e.items', kafkaPartition=null, key=Struct{id=103}, keySchema=Schema{mysql_binlog_source.cdc_chunk_e2e.items.Key:STRUCT}, value=Struct{before=Struct{id=103,c=114,amount=30},after=Struct{id=103,c=114,amount=31},source=Struct{version=1.9.8.Final,connector=mysql,name=mysql_binlog_source,ts_ms=1792314833000,db=cdc_chunk_e2e,table=items,server_id=8675322,gtid=cb0792da-cad3-11f1-9571-2658671ca05a:206,file=binlog.000003,pos=57503,row=0,thread=108},op=u,ts_ms=1792314839065}, valueSchema=Schema{mysql_binlog_source.cdc_chunk_e2e.items.Envelope:STRUCT}, timestamp=null, headers=ConnectHeaders(headers=)}
CHARACTERIZATION_ASSERTIONS_PASS data_equal=false