Loading...

Type: Bug
Resolution: Unresolved
Priority: Major
Fix Version/s: 3.0.9.Final, 3.1.0.Beta1
Affects Version/s: 3.0.8.Final, 3.1.0.Alpha2
Component/s: oracle-connector
Labels:
None

Story Points:
2
Blocked:
False
Blocked Reason:
None
Ready:
False
Git Pull Request:
https://github.com/debezium/debezium/pull/6205
Intelligence Requested:
Market:

SFDC Cases Counter:
SFDC Cases Open:
SFDC Cases Links:

When a database is refreshed, a DBA may leave archive logs on the system with SCN ranges and sequences that numerically come after the current redo logs. In such a scenario, this will indefinitely cause the LogFileCollector consistency check to report an inconsistent redo thread.

As an example:

2025-02-27 09:35:05,622 DEBUG [dbz-connector-opus|task-0] Collecting logs based on the read SCN position 13137363462111. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,663 DEBUG [dbz-connector-opus|task-0] Thread 1: RedoThread{threadId=1, status='OPEN', enabled='PUBLIC', logGroups=8, instanceName='PREPROD', openTime=2025-02-26T12:02:32Z, currentGroupNumber=46, currentSequenceNumber=402, checkpointScn=13137361729075, checkpointTime=2025-02-27T12:54:21Z, enabledScn=13120958148602, enabledTime=2025-02-08T23:25:44Z, disabledScn=0, disabledTime=null, lastRedoSequenceNumber=402, lastRedoBlock=33666, lastRedoScn=13137363476386, lastRedoTime=2025-02-27T15:05:02Z, conId=0} (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,663 DEBUG [dbz-connector-opus|task-0] Thread 2: RedoThread{threadId=2, status='CLOSED', enabled='PUBLIC', logGroups=8, instanceName='PRODN2', openTime=2025-01-26T08:57:10Z, currentGroupNumber=0, currentSequenceNumber=1, checkpointScn=13120958148602, checkpointTime=2025-02-08T23:25:44Z, enabledScn=13120958148602, enabledTime=2025-02-08T23:25:44Z, disabledScn=0, disabledTime=null, lastRedoSequenceNumber=5733323, lastRedoBlock=486006, lastRedoScn=13110183868336, lastRedoTime=2025-01-28T17:51:15Z, conId=0} (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,880 DEBUG [dbz-connector-opus|task-0] Online redo log +ARCHDG1/PRSTBY2/ONLINELOG/group_49.1280.1191608433 with SCN range 13120958148602 to 13120958148610 (INACTIVE) sequence 1 to be excluded. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,880 DEBUG [dbz-connector-opus|task-0] Online redo log +ARCHDG1/PRSTBY2/ONLINELOG/group_46.6275.1191608427 with SCN range 13137363417171 to 9295429630892703743 (CURRENT) sequence 402 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,880 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758510.3813.1194106997 with SCN range 13137736796153 to 13137737311248 sequence 4758510 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,880 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758511.5078.1194107111 with SCN range 13137737311248 to 13137738596514 sequence 4758511 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,880 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758512.4753.1194107225 with SCN range 13137738596514 to 13137739590360 sequence 4758512 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,880 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758513.4510.1194107347 with SCN range 13137739590360 to 13137740170594 sequence 4758513 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,880 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758514.4264.1194107409 with SCN range 13137740170594 to 13137740470839 sequence 4758514 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,881 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758515.4083.1194107477 with SCN range 13137740470839 to 13137740983065 sequence 4758515 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,881 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758516.3012.1194107531 with SCN range 13137740983065 to 13137741400275 sequence 4758516 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,881 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758517.2969.1194107635 with SCN range 13137741400275 to 13137741918580 sequence 4758517 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,881 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758518.1909.1194107737 with SCN range 13137741918580 to 13137742517861 sequence 4758518 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,881 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_1_seq_4758519.2375.1194107875 with SCN range 13137742517861 to 13137767777626 sequence 4758519 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,881 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_2_seq_5756598.1255.1194107219 with SCN range 13137739008495 to 13137739561409 sequence 5756598 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,881 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_2_seq_5756599.2510.1194107317 with SCN range 13137739561409 to 13137740027898 sequence 5756599 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,882 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_2_seq_5756600.1721.1194107411 with SCN range 13137740027898 to 13137740477998 sequence 5756600 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,882 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_2_seq_5756601.464.1194107473 with SCN range 13137740477998 to 13137740959859 sequence 5756601 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,882 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_2_seq_5756602.1224.1194107533 with SCN range 13137740959859 to 13137741416034 sequence 5756602 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,882 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_2_seq_5756603.351.1194107623 with SCN range 13137741416034 to 13137741862575 sequence 5756603 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,882 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_2_seq_5756604.1153.1194107695 with SCN range 13137741862575 to 13137742282255 sequence 5756604 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
2025-02-27 09:35:05,882 DEBUG [dbz-connector-opus|task-0] Archive log /misbkp/standby_archive_41_116/thread_2_seq_5756605.6939.1194107759 with SCN range 13137742282255 to 13137742618507 sequence 5756605 to be added. (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]

This yielded this error:

2025-02-27 09:35:05,889 INFO [dbz-connector-opus|task-0] Redo Thread 1 is inconsistent; failed to find log with sequence 403 (io.debezium.connector.oracle.logminer.LogFileCollector) [debezium-oracleconnector-opus-change-event-source-coordinator]
io.debezium.DebeziumException: Redo Thread 1 is inconsistent; failed to find log with sequence 403

Details

Description

Attachments

Easy Agile Planning Poker

Activity

People

Dates