View Issue Details

Related ChangesetsJump to NotesJump to History
IDProjectCategoryView StatusDate SubmittedLast Update
0004945SymmetricDSBugpublic2021-04-10 15:522021-04-28 19:10
Reportersymds-tryout Assigned Toelong  
Prioritynormal 
Status closedResolutionfixed 
Product Version3.12.0 
Target Version3.12.9Fixed in Version3.12.9 
Summary0004945: USE_CHANGED_DATA / NEWER_WINS not working on Android
DescriptionAccording to the 3.12.x documentation, the standard for conflict detection and resolving is USE_CHANGED_DATA and NEWER_WINS.
I established this also explicitly in sym_conflict and made a test based on the old NotePad example.
Whenever I create a conflict, the older value wins - that's not what I expected, hope I didn't get the concepts wrong.

Log output always shows "local time" and "remote time" as "null" like in

2021-04-10 15:55:52,194 DEBUG [corp-000] [DefaultDatabaseWriterConflictResolver] [corp-000-dataloader-51] Winning row from batch 001-91 with local time of null and remote time of null for table notes and pk of {23}

This happens in isCaptureTimeNewer of org.jumpmind.symmetric.io.data.writer.DefaultDatabaseWriterConflictResolver.
loadingTs never seems to be present in passed in CsvData, and therefore existingTs is never retrieved from sym_data.

I assume without loadingTs and existingTs being set, the proper (?) decision cannot be made.

(Funny that before 3.12.x the documentation did not mention the default of USE_CHANGED_DATA / NEWER_WINS and that NEWER_WINS documentation only referred to USE_VERSION and USE_TIMESTAMP. Therefore might be a side effect of the 3.12.x changes ...?)
Steps To ReproduceScenario:
- 3.12.8 (with patch from ticket 4941) is running on PC with MySQL
- 3.12.8 is running in Android Notepad example on Android Studio Emulator
- System time is the same on PC and Android emulator

- Properly synced Note exists on both sides.
- Set Android into flight mode, update a Note on that side (title contains something like "Update Phone 9")
- wait a minute
- Update the same note on PC side (title contains something like "Update PC 9")
- wait a minute
- switch off Flight Mode in Android emulator

As a result, the older change from the Android emulator always "wins" (note on PC side has a title with "Update Phone 9") following log statements like the one in the description.
Additional InformationSee attached screenshot for the contents of sym_data on PC side.

Log output for that example:

2021-04-10 15:55:45,317 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Preparing dml: update `corp`.`notes` set `NOTE` = ?, `TITLE` = ?, `CREATED` = ?, `MODIFIED` = ? where `NOTE` = ? and `TITLE` = ? and `CREATED` = ? and `MODIFIED` = ? and `_ID` = ?
2021-04-10 15:55:45,317 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Submitting data ['Nummer 2 wirklich', 'Nummer 2 (Updated Phone 8)', '2021-04-05 13:18:06.0', '2021-04-10 15:51:05.388', 'Nummer 2 wirklich', 'Nummer 2 (Updated Phone 8)', '2021-04-05 13:18:06.0', '2021-04-10 14:54:49.0', '23'] with types [LONGVARCHAR, LONGVARCHAR, VARCHAR, VARCHAR, LONGVARCHAR, LONGVARCHAR, VARCHAR, VARCHAR, VARCHAR]
2021-04-10 15:55:45,317 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) update `corp`.`notes` set `NOTE` = 'Nummer 2 wirklich', `TITLE` = 'Nummer 2 (Updated Phone 8)', `CREATED` = '2021-04-05 13:18:06.0', `MODIFIED` = '2021-04-10 15:51:05.388' where `NOTE` = 'Nummer 2 wirklich' and `TITLE` = 'Nummer 2 (Updated Phone 8)' and `CREATED` = '2021-04-05 13:18:06.0' and `MODIFIED` = '2021-04-10 14:54:49.0' and `_ID` = '23'
2021-04-10 15:55:45,317 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Conflict detected: NOTES in batch 001-91 at line 1 for table corp.notes
2021-04-10 15:55:45,318 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Row data: "23","Nummer 2 wirklich","Nummer 2 (Updated Phone 8)","2021-04-05 13:18:06.0","2021-04-10 15:51:05.388"
2021-04-10 15:55:45,318 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Old data: "23","Nummer 2 wirklich","Nummer 2 (Updated Phone 8)","2021-04-05 13:18:06.0","2021-04-10 14:54:49.0"
2021-04-10 15:55:47,602 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-job-6] (0ms.) select node_id, queue from sym_extract_request where status='NE' and parent_request_id=0 group by node_id, queue
2021-04-10 15:55:47,632 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-job-17] (0ms.) select distinct channel_id from sym_data where ((data_id between 117 and 50000116))
2021-04-10 15:55:47,634 DEBUG [] [JdbcSqlTemplate] [corp-000-router-reader-46] (1ms.) select d.data_id, d.table_name, d.event_type, d.row_data as row_data, d.pk_data as pk_data, d.old_data as old_data, d.create_time, d.trigger_hist_id, d.channel_id, d.transaction_id, d.source_node_id, d.external_data, d.node_list, d.is_prerouted from sym_data d where d.channel_id='heartbeat' and ((d.data_id between 117 and 50000116)) order by d.data_id asc
2021-04-10 15:55:47,635 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-job-17] (0ms.) select c.node_id, c.node_group_id, c.external_id, c.sync_enabled, c.sync_url, c.schema_version, c.database_type, c.database_version, c.database_name, c.symmetric_version, c.created_at_node_id, c.batch_to_send_count, c.batch_in_error_count, c.deployment_type, c.deployment_sub_type, c.config_version from sym_node c where node_group_id = 'store' and sync_enabled=1 order by node_id
2021-04-10 15:55:47,636 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-job-17] (0ms.) select c.node_id, c.node_group_id, c.external_id, c.sync_enabled, c.sync_url, c.schema_version, c.database_type, c.database_version, c.database_name, c.symmetric_version, c.created_at_node_id, c.batch_to_send_count, c.batch_in_error_count, c.deployment_type, c.deployment_sub_type, c.config_version from sym_node c
2021-04-10 15:55:47,637 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-job-17] (0ms.) addBatch() insert into sym_outgoing_batch (batch_id, node_id, channel_id, status, load_id, extract_job_flag, load_flag, common_flag, reload_row_count, other_row_count, data_update_row_count, data_insert_row_count, data_delete_row_count, last_update_hostname, last_update_time, create_time, create_by, summary, data_row_count) values (257, '-1', 'heartbeat', 'RT', -1, 0, 0, 0, 0, 0, 1, 0, 0, 'ODYSSEUS', current_timestamp, current_timestamp, null, 'sym_node_host', 1)
2021-04-10 15:55:47,641 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-job-17] (0ms.) addBatch() insert into sym_data_event (data_id, batch_id, create_time) values(117, 257, current_timestamp)
2021-04-10 15:55:47,642 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-job-17] (0ms.) addBatch() update sym_outgoing_batch set status='OK', load_id=-1, extract_job_flag=0, load_flag=0, error_flag=0, byte_count=0, extract_count=0, sent_count=0, load_count=0, data_row_count=1, reload_row_count=0, data_insert_row_count=0, data_update_row_count=1, data_delete_row_count=0, other_row_count=0, ignore_count=0, router_millis=4, network_millis=0, filter_millis=0, load_millis=0, extract_millis=0, extract_start_time=null, transfer_start_time=null, load_start_time=null, sql_state=null, sql_code=0, sql_message=null, failed_data_id=0, failed_line_number=0, last_update_hostname='ODYSSEUS', last_update_time=current_timestamp, summary='sym_node_host', load_row_count=0, load_insert_row_count=0, load_update_row_count=0, load_delete_row_count=0, fallback_insert_count=0, fallback_update_count=0, ignore_row_count=0, missing_delete_count=0, skip_count=0, extract_row_count=0, extract_insert_row_count=0, extract_update_row_count=0, extract_delete_row_count=0, transform_extract_millis=0, transform_load_millis=0 where batch_id=257 and node_id='-1'
2021-04-10 15:55:47,643 INFO [corp-000] [RouterService] [corp-000-job-17] Routed 1 data events in 11 ms
2021-04-10 15:55:47,643 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-job-17] (0ms.) addBatch() delete from sym_data_gap where start_id=117 and end_id=50000116
2021-04-10 15:55:47,644 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-job-17] (0ms.) addBatch() insert into sym_data_gap (last_update_hostname, start_id, end_id, create_time) values('ODYSSEUS', 118, 50000117, {ts '2021-04-10 15:55:47.632'})
2021-04-10 15:55:47,696 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-job-15] (0ms.) select target_node_id, create_table, delete_first, reload_select, before_custom_sql, reload_time, channel_id, create_time, last_update_by, last_update_time, trigger_id, router_id, load_id from sym_table_reload_request where source_node_id='000' and processed = 0 order by create_time, target_node_id
2021-04-10 15:55:52,194 DEBUG [corp-000] [DefaultDatabaseWriterConflictResolver] [corp-000-dataloader-51] Winning row from batch 001-91 with local time of null and remote time of null for table notes and pk of {23}
2021-04-10 15:55:52,197 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_triggers_disabled=null
2021-04-10 15:55:52,197 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_node_disabled=null
2021-04-10 15:55:52,197 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Preparing dml: update `corp`.`notes` set `MODIFIED` = ? where `_ID` = ?
2021-04-10 15:55:52,197 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Submitting data ['2021-04-10 15:51:05.388', '23'] with types [VARCHAR, VARCHAR]
2021-04-10 15:55:52,199 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (1ms.) update `corp`.`notes` set `MODIFIED` = '2021-04-10 15:51:05.388' where `_ID` = '23'
2021-04-10 15:55:52,200 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-dataloader-51] (1ms.) select trigger_hist_id,trigger_id,source_table_name,table_hash,create_time,pk_column_names,column_names,last_trigger_build_reason,name_for_delete_trigger,name_for_insert_trigger,name_for_update_trigger,source_schema_name,source_catalog_name,trigger_row_hash,trigger_template_hash,error_message from sym_trigger_hist where (source_table_name='NOTES' OR source_table_name='notes' OR source_table_name='NOTES') and inactive_time is null
2021-04-10 15:55:52,203 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Preparing dml: update `corp`.`notes` set `NOTE` = ?, `TITLE` = ?, `CREATED` = ?, `MODIFIED` = ? where `NOTE` = ? and `TITLE` = ? and `CREATED` = ? and `MODIFIED` = ? and `_ID` = ?
2021-04-10 15:55:52,203 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Submitting data ['Nummer 2 wirklich', 'Nummer 2 (Updated Phone 9)', '2021-04-05 13:18:06.0', '2021-04-10 15:51:05.388', 'Nummer 2 wirklich', 'Nummer 2 (Updated Phone 8)', '2021-04-05 13:18:06.0', '2021-04-10 15:51:05.388', '23'] with types [LONGVARCHAR, LONGVARCHAR, VARCHAR, VARCHAR, LONGVARCHAR, LONGVARCHAR, VARCHAR, VARCHAR, VARCHAR]
2021-04-10 15:55:52,204 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) update `corp`.`notes` set `NOTE` = 'Nummer 2 wirklich', `TITLE` = 'Nummer 2 (Updated Phone 9)', `CREATED` = '2021-04-05 13:18:06.0', `MODIFIED` = '2021-04-10 15:51:05.388' where `NOTE` = 'Nummer 2 wirklich' and `TITLE` = 'Nummer 2 (Updated Phone 8)' and `CREATED` = '2021-04-05 13:18:06.0' and `MODIFIED` = '2021-04-10 15:51:05.388' and `_ID` = '23'
2021-04-10 15:55:52,204 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Conflict detected: NOTES in batch 001-91 at line 2 for table corp.notes
2021-04-10 15:55:52,204 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Row data: "23","Nummer 2 wirklich","Nummer 2 (Updated Phone 9)","2021-04-05 13:18:06.0","2021-04-10 15:51:05.388"
2021-04-10 15:55:52,204 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Old data: "23","Nummer 2 wirklich","Nummer 2 (Updated Phone 8)","2021-04-05 13:18:06.0","2021-04-10 15:51:05.388"
2021-04-10 15:55:52,655 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-job-2] (1ms.) select distinct channel_id from sym_data where ((data_id between 118 and 50000117))
2021-04-10 15:55:52,656 DEBUG [] [JdbcSqlTemplate] [corp-000-router-reader-46] (1ms.) select d.data_id, d.table_name, d.event_type, '' as row_data, '' as pk_data, '' as old_data, d.create_time, d.trigger_hist_id, d.channel_id, d.transaction_id, d.source_node_id, d.external_data, d.node_list, d.is_prerouted from sym_data d where d.channel_id='default' and ((d.data_id between 118 and 50000117)) order by d.data_id asc
2021-04-10 15:55:53,823 DEBUG [corp-000] [DefaultDatabaseWriterConflictResolver] [corp-000-dataloader-51] Winning row from batch 001-91 with local time of null and remote time of null for table notes and pk of {23}
2021-04-10 15:55:53,826 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_triggers_disabled=null
2021-04-10 15:55:53,826 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_node_disabled=null
2021-04-10 15:55:53,826 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Preparing dml: update `corp`.`notes` set `TITLE` = ? where `_ID` = ?
2021-04-10 15:55:53,827 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Submitting data ['Nummer 2 (Updated Phone 9)', '23'] with types [LONGVARCHAR, VARCHAR]
2021-04-10 15:55:53,827 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) update `corp`.`notes` set `TITLE` = 'Nummer 2 (Updated Phone 9)' where `_ID` = '23'
2021-04-10 15:55:53,828 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-dataloader-51] (1ms.) select trigger_hist_id,trigger_id,source_table_name,table_hash,create_time,pk_column_names,column_names,last_trigger_build_reason,name_for_delete_trigger,name_for_insert_trigger,name_for_update_trigger,source_schema_name,source_catalog_name,trigger_row_hash,trigger_template_hash,error_message from sym_trigger_hist where (source_table_name='NOTES' OR source_table_name='notes' OR source_table_name='NOTES') and inactive_time is null
2021-04-10 15:55:53,832 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Preparing dml: update `corp`.`notes` set `NOTE` = ?, `TITLE` = ?, `CREATED` = ?, `MODIFIED` = ? where `NOTE` = ? and `TITLE` = ? and `CREATED` = ? and `MODIFIED` = ? and `_ID` = ?
2021-04-10 15:55:53,832 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Submitting data ['Nummer 2 wirklich', 'Nummer 2 (Updated Phone 9)', '2021-04-05 13:18:06.0', '2021-04-10 15:51:12.734', 'Nummer 2 wirklich', 'Nummer 2 (Updated Phone 9)', '2021-04-05 13:18:06.0', '2021-04-10 15:51:05.388', '23'] with types [LONGVARCHAR, LONGVARCHAR, VARCHAR, VARCHAR, LONGVARCHAR, LONGVARCHAR, VARCHAR, VARCHAR, VARCHAR]
2021-04-10 15:55:53,832 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) update `corp`.`notes` set `NOTE` = 'Nummer 2 wirklich', `TITLE` = 'Nummer 2 (Updated Phone 9)', `CREATED` = '2021-04-05 13:18:06.0', `MODIFIED` = '2021-04-10 15:51:12.734' where `NOTE` = 'Nummer 2 wirklich' and `TITLE` = 'Nummer 2 (Updated Phone 9)' and `CREATED` = '2021-04-05 13:18:06.0' and `MODIFIED` = '2021-04-10 15:51:05.388' and `_ID` = '23'
2021-04-10 15:55:53,832 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Conflict detected: NOTES in batch 001-91 at line 3 for table corp.notes
2021-04-10 15:55:53,832 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Row data: "23","Nummer 2 wirklich","Nummer 2 (Updated Phone 9)","2021-04-05 13:18:06.0","2021-04-10 15:51:12.734"
2021-04-10 15:55:53,832 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Old data: "23","Nummer 2 wirklich","Nummer 2 (Updated Phone 9)","2021-04-05 13:18:06.0","2021-04-10 15:51:05.388"
2021-04-10 15:55:55,411 DEBUG [corp-000] [DefaultDatabaseWriterConflictResolver] [corp-000-dataloader-51] Winning row from batch 001-91 with local time of null and remote time of null for table notes and pk of {23}
2021-04-10 15:55:55,413 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_triggers_disabled=null
2021-04-10 15:55:55,414 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (1ms.) set @sync_node_disabled=null
2021-04-10 15:55:55,414 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Preparing dml: update `corp`.`notes` set `MODIFIED` = ? where `_ID` = ?
2021-04-10 15:55:55,414 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Submitting data ['2021-04-10 15:51:12.734', '23'] with types [VARCHAR, VARCHAR]
2021-04-10 15:55:55,414 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) update `corp`.`notes` set `MODIFIED` = '2021-04-10 15:51:12.734' where `_ID` = '23'
2021-04-10 15:55:55,415 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-dataloader-51] (0ms.) select trigger_hist_id,trigger_id,source_table_name,table_hash,create_time,pk_column_names,column_names,last_trigger_build_reason,name_for_delete_trigger,name_for_insert_trigger,name_for_update_trigger,source_schema_name,source_catalog_name,trigger_row_hash,trigger_template_hash,error_message from sym_trigger_hist where (source_table_name='NOTES' OR source_table_name='notes' OR source_table_name='NOTES') and inactive_time is null
2021-04-10 15:55:55,418 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Preparing dml: update `corp`.`notes` set `NOTE` = ?, `TITLE` = ?, `CREATED` = ?, `MODIFIED` = ? where `NOTE` = ? and `TITLE` = ? and `CREATED` = ? and `MODIFIED` = ? and `_ID` = ?
2021-04-10 15:55:55,418 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Submitting data ['Nummer 2 wirklich', 'Nummer 2 (Updated Phone 9)', '2021-04-05 13:18:06.0', '2021-04-10 15:51:12.74', 'Nummer 2 wirklich', 'Nummer 2 (Updated Phone 9)', '2021-04-05 13:18:06.0', '2021-04-10 15:51:12.734', '23'] with types [LONGVARCHAR, LONGVARCHAR, VARCHAR, VARCHAR, LONGVARCHAR, LONGVARCHAR, VARCHAR, VARCHAR, VARCHAR]
2021-04-10 15:55:55,419 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (1ms.) update `corp`.`notes` set `NOTE` = 'Nummer 2 wirklich', `TITLE` = 'Nummer 2 (Updated Phone 9)', `CREATED` = '2021-04-05 13:18:06.0', `MODIFIED` = '2021-04-10 15:51:12.74' where `NOTE` = 'Nummer 2 wirklich' and `TITLE` = 'Nummer 2 (Updated Phone 9)' and `CREATED` = '2021-04-05 13:18:06.0' and `MODIFIED` = '2021-04-10 15:51:12.734' and `_ID` = '23'
2021-04-10 15:55:55,419 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Conflict detected: NOTES in batch 001-91 at line 4 for table corp.notes
2021-04-10 15:55:55,419 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Row data: "23","Nummer 2 wirklich","Nummer 2 (Updated Phone 9)","2021-04-05 13:18:06.0","2021-04-10 15:51:12.74"
2021-04-10 15:55:55,419 DEBUG [corp-000] [AbstractDatabaseWriterConflictResolver] [corp-000-dataloader-51] Old data: "23","Nummer 2 wirklich","Nummer 2 (Updated Phone 9)","2021-04-05 13:18:06.0","2021-04-10 15:51:12.734"
2021-04-10 15:55:56,992 DEBUG [corp-000] [DefaultDatabaseWriterConflictResolver] [corp-000-dataloader-51] Winning row from batch 001-91 with local time of null and remote time of null for table notes and pk of {23}
2021-04-10 15:55:57,002 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_triggers_disabled=null
2021-04-10 15:55:57,002 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_node_disabled=null
2021-04-10 15:55:57,002 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Preparing dml: update `corp`.`notes` set `MODIFIED` = ? where `_ID` = ?
2021-04-10 15:55:57,002 DEBUG [corp-000] [DefaultDatabaseWriter] [corp-000-dataloader-51] Submitting data ['2021-04-10 15:51:12.74', '23'] with types [VARCHAR, VARCHAR]
2021-04-10 15:55:57,003 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (1ms.) update `corp`.`notes` set `MODIFIED` = '2021-04-10 15:51:12.74' where `_ID` = '23'
2021-04-10 15:55:57,004 DEBUG [corp-000] [JdbcSqlTemplate] [corp-000-dataloader-51] (1ms.) select trigger_hist_id,trigger_id,source_table_name,table_hash,create_time,pk_column_names,column_names,last_trigger_build_reason,name_for_delete_trigger,name_for_insert_trigger,name_for_update_trigger,source_schema_name,source_catalog_name,trigger_row_hash,trigger_template_hash,error_message from sym_trigger_hist where (source_table_name='NOTES' OR source_table_name='notes' OR source_table_name='NOTES') and inactive_time is null
2021-04-10 15:55:57,005 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_triggers_disabled=null
2021-04-10 15:55:57,005 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) set @sync_node_disabled=null
2021-04-10 15:55:57,008 DEBUG [corp-000] [JdbcSqlTransaction] [corp-000-dataloader-51] (0ms.) update sym_incoming_batch set status = 'OK', error_flag=0, network_millis = 0, filter_millis = 1, load_millis = 9, failed_row_number = 0, failed_line_number = 0, byte_count = 744, load_row_count = 4, fallback_insert_count = 0, fallback_update_count = 4, ignore_count = 0, ignore_row_count = 0, missing_delete_count = 0, skip_count = 0, sql_state = null, sql_code = 0, sql_message = null, last_update_hostname = 'ODYSSEUS', last_update_time = current_timestamp, summary = 'notes', load_flag = false, extract_count = 0, sent_count = 0, load_count = 0, load_id = -1, common_flag = false, router_millis = 0, extract_millis = 0, transform_extract_millis = 0, transform_load_millis = 61, reload_row_count = 0, other_row_count = 0, data_row_count = 0, data_insert_row_count = 0, data_update_row_count = 0, data_delete_row_count = 0, extract_row_count = 0, extract_insert_row_count = 0, extract_update_row_count = 0, extract_delete_row_count = 0, load_insert_row_count = 0, load_update_row_count = 4, load_delete_row_count = 0, failed_data_id = 0 where batch_id = 91 and node_id = '001'
2021-04-10 15:55:57,009 INFO [corp-000] [DataLoaderService] [qtp4079243-358] 5 data and 2 batches loaded during push request from store:001:001
TagsNo tags attached.

Activities

symds-tryout

2021-04-10 15:52

reporter  

symds5.jpg (235,279 bytes)   
symds5.jpg (235,279 bytes)   

pmarzullo

2021-04-14 18:16

developer   ~0001914

Can you set the following parameter on the Android side:

extract.row.capture.time=true

This will enable the use of the capture time for this conflict resolution.

We will set the default to true in the code, so that it won't be required to set this parameter on the Android parameters.

Related Changesets

SymmetricDS: 3.12 33212a92

2021-04-20 13:01:50

admin

Details Diff 		0004945: USE_CHANGED_DATA / NEWER_WINS not working on Android Affected Issues
0004945
mod - symmetric-core/src/main/java/org/jumpmind/symmetric/service/impl/DataExtractorService.java Diff File

Issue History

Date Modified Username Field Change
2021-04-10 15:52 symds-tryout New Issue
2021-04-10 15:52 symds-tryout File Added: symds5.jpg
2021-04-14 18:16 pmarzullo Note Added: 0001914
2021-04-20 13:02 elong Assigned To => elong
2021-04-20 13:02 elong Status new => resolved
2021-04-20 13:02 elong Resolution open => fixed
2021-04-20 13:02 elong Product Version 3.12.8 => 3.12.0
2021-04-20 13:02 elong Fixed in Version => 3.12.9
2021-04-20 13:02 elong Target Version => 3.12.9
2021-04-20 13:02 elong Summary USE_CHANGED_DATA / NEWER_WINS not working correctly? => USE_CHANGED_DATA / NEWER_WINS not working on Android
2021-04-20 14:00 admin Changeset attached => SymmetricDS 3.12 33212a92
2021-04-28 19:10 admin Status resolved => closed