Uploaded image for project: 'Debezium'
  1. Debezium
  2. DBZ-8093

Debezium Error with logminer - ORA-01291: missing log file

XMLWordPrintable

    • Icon: Bug Bug
    • Resolution: Duplicate
    • Icon: Major Major
    • None
    • None
    • oracle-connector
    • None
    • False
    • None
    • False
    • Critical

      In order to make your issue reports as actionable as possible, please provide the following information, depending on the issue type.

      Bug report

      For bug reports, provide this information, please:

      Debezium Throws error

      org.apache.kafka.connect.errors.RetriableException: An exception occurred in the change event producer. This connector will be restarted.
      	at io.debezium.pipeline.ErrorHandler.setProducerThrowable(ErrorHandler.java:63)
      	at io.debezium.connector.oracle.logminer.LogMinerStreamingChangeEventSource.execute(LogMinerStreamingChangeEventSource.java:267)
      	at io.debezium.connector.oracle.logminer.LogMinerStreamingChangeEventSource.execute(LogMinerStreamingChangeEventSource.java:61)
      	at io.debezium.pipeline.ChangeEventSourceCoordinator.streamEvents(ChangeEventSourceCoordinator.java:280)
      	at io.debezium.pipeline.ChangeEventSourceCoordinator.executeChangeEventSources(ChangeEventSourceCoordinator.java:197)
      	at io.debezium.pipeline.ChangeEventSourceCoordinator.lambda$start$0(ChangeEventSourceCoordinator.java:140)
      	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
      	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
      	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
      	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
      	at java.base/java.lang.Thread.run(Thread.java:829) Caused by: java.sql.SQLException: ORA-01291: missing log file ORA-06512:
      	at "SYS.DBMS_LOGMNR", line 72 ORA-06512:
      	at line 1
      	at oracle.jdbc.driver.T4CTTIoer11.processError(T4CTTIoer11.java:630)
      	at oracle.jdbc.driver.T4CTTIoer11.processError(T4CTTIoer11.java:564)
      	at oracle.jdbc.driver.T4C8Oall.processError(T4C8Oall.java:1151)
      	at oracle.jdbc.driver.T4CTTIfun.receive(T4CTTIfun.java:771)
      	at oracle.jdbc.driver.T4CTTIfun.doRPC(T4CTTIfun.java:299)
      	at oracle.jdbc.driver.T4C8Oall.doOALL(T4C8Oall.java:498)
      	at oracle.jdbc.driver.T4CStatement.doOall8(T4CStatement.java:112)
      	at oracle.jdbc.driver.T4CStatement.executeForRows(T4CStatement.java:1011)
      	at oracle.jdbc.driver.OracleStatement.executeSQLStatement(OracleStatement.java:1531)
      	at oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1311)
      	at oracle.jdbc.driver.OracleStatement.executeInternal(OracleStatement.java:2163)
      	at oracle.jdbc.driver.OracleStatement.execute(OracleStatement.java:2118)
      	at oracle.jdbc.driver.OracleStatementWrapper.execute(OracleStatementWrapper.java:328)
      	at io.debezium.jdbc.JdbcConnection.executeWithoutCommitting(JdbcConnection.java:1454)
      	at io.debezium.connector.oracle.logminer.LogMinerStreamingChangeEventSource.startMiningSession(LogMinerStreamingChangeEventSource.java:617)
      	at io.debezium.connector.oracle.logminer.LogMinerStreamingChangeEventSource.execute(LogMinerStreamingChangeEventSource.java:241) ... 9 more Caused by: Error : 1291, Position : 0, Sql = BEGIN sys.dbms_logmnr.start_logmnr(startScn => '350066823087', endScn => '350066823837', OPTIONS => DBMS_LOGMNR.DICT_FROM_ONLINE_CATALOG + DBMS_LOGMNR.NO_ROWID_IN_STMT);END;, OriginalSql = BEGIN sys.dbms_logmnr.start_logmnr(startScn => '350066823087', endScn => '350066823837', OPTIONS => DBMS_LOGMNR.DICT_FROM_ONLINE_CATALOG + DBMS_LOGMNR.NO_ROWID_IN_STMT);END;, Error Msg = ORA-01291: missing log file ORA-06512:
      	at "SYS.DBMS_LOGMNR", line 72 ORA-06512:
      	at line 1
      	at oracle.jdbc.driver.T4CTTIoer11.processError(T4CTTIoer11.java:637)
      

      What Debezium connector do you use and what version?

      2.6.1.Final

      What is the connector configuration?

      {
          "connector.class": "io.debezium.connector.oracle.OracleConnector",
          "key.converter": "io.confluent.connect.avro.AvroConverter",
          "key.converter.schema.registry.url": "http://swwkafp01s.suvanet.ch:8081",
          "value.converter": "io.confluent.connect.avro.AvroConverter",
          "value.converter.schema.registry.url": "http://swwkafp01s.suvanet.ch:8081",
          "schema.name.adjustment.mode": "avro",
          "database.hostname": "vip-primary-asep01.suvanet.ch",
          "database.port": "1521",
          "database.user": "C##DSL_RO",
          "database.password": 
          "database.dbname": "CASEP01A.suvanet.ch",
          "database.pdb.name": "ASEP01A",
          "topic.prefix": "ASE1",
          "table.include.list": "ASEDBUSR.ABRDVRS,ASEDBUSR.ABRDVRSUNT,ASEDBUSR.ACTIVITY,ASEDBUSR.ADRESSE,ASEDBUSR.ANTRFRAGENANTW,ASEDBUSR.ARBUN,ASEDBUSR.BANK,ASEDBUSR.BEZIEHUNG,ASEDBUSR.BILANZAUSGLEICH,ASEDBUSR.BUCHSTOFFV,ASEDBUSR.BUCHUNGSTOFF",
          "snapshot.select.statement.overrides": "ASEDBUSR.ABRDVRS,ASEDBUSR.ABRDVRSUNT,ASEDBUSR.ACTIVITY,ASEDBUSR.ADRESSE,ASEDBUSR.ANTRFRAGENANTW,ASEDBUSR.ARBUN,ASEDBUSR.BANK,ASEDBUSR.BEZIEHUNG,ASEDBUSR.BILANZAUSGLEICH,ASEDBUSR.BUCHSTOFFV,ASEDBUSR.BUCHUNGSTOFF",
          "snapshot.select.statement.overrides.ASEDBUSR.ABRDVRS": "SELECT * FROM ASEDBUSR.ABRDVRS ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.ABRDVRSUNT": "SELECT * FROM ASEDBUSR.ABRDVRSUNT ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.ACTIVITY": "SELECT * FROM ASEDBUSR.ACTIVITY ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.ADRESSE": "SELECT * FROM ASEDBUSR.ADRESSE ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.ANTRFRAGENANTW": "SELECT * FROM ASEDBUSR.ANTRFRAGENANTW ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.ARBUN": "SELECT * FROM ASEDBUSR.ARBUN ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.BANK": "SELECT * FROM ASEDBUSR.BANK ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.BEZIEHUNG": "SELECT * FROM ASEDBUSR.BEZIEHUNG ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.BILANZAUSGLEICH": "SELECT * FROM ASEDBUSR.BILANZAUSGLEICH ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.BUCHSTOFFV": "SELECT * FROM ASEDBUSR.BUCHSTOFFV ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.select.statement.overrides.ASEDBUSR.BUCHUNGSTOFF": "SELECT * FROM ASEDBUSR.BUCHUNGSTOFF ORDER BY CREATED ASC, PKEY ASC",
          "snapshot.fetch.size": "10000",
          "snapshot.max.threads": 3,
          "snapshot.mode": "initial",
          "snapshot.include.collection.list": ".*",
          "signal.data.collection": "ASEP01A.C##DSL_RO.DEBEZIUM_SIGNAL",
          "producer.override.batch.size": 1000000,
          "producer.override.linger.ms": 500,
          "producer.override.compression.type": "lz4",
          "event.processing.failure.handling.mode": "fail",
          "tombstones.on.delete": "true",
          "message.key.columns": "ASEDBUSR.ABRDVRS:BOID;ASEDBUSR.ABRDVRSUNT:BOID;ASEDBUSR.ACTIVITY:BOID;ASEDBUSR.ADRESSE:BOID;ASEDBUSR.ANTRFRAGENANTW:BOID;ASEDBUSR.ARBUN:BOID;ASEDBUSR.BANK:BOID;ASEDBUSR.BEZIEHUNG:BOID;ASEDBUSR.BILANZAUSGLEICH:BOID;ASEDBUSR.BUCHSTOFFV:BOID;ASEDBUSR.BUCHUNGSTOFF:BOID",
          "log.mining.strategy": "online_catalog",
          "log.mining.transaction.retention.ms": 86400000,
          "internal.log.mining.log.query.max.retries": "10",
          "archive.destination.name": "LOG_ARCHIVE_DEST_10",
          "lob.enabled": "true",
          "unavailable.value.placeholder": "previous_value_unchanged",
          "time.precision.mode": "connect",
          "tasks.max": "1",
          "schema.history.internal.store.only.captured.tables.ddl": "true",
          "schema.history.internal.kafka.bootstrap.servers": "swwkafp01.suvanet.ch:9092",
          "schema.history.internal.kafka.topic": "ase.schema-changes.asedbusr",
          "schema.history.internal.consumer.security.protocol": "SASL_SSL",
          "schema.history.internal.producer.security.protocol": "SASL_SSL",
          "schema.history.internal.consumer.sasl.mechanism": "SCRAM-SHA-512",
          "schema.history.internal.producer.sasl.mechanism": "SCRAM-SHA-512",
          "schema.history.internal.consumer.sasl.jaas.config": "ENC[AES256_GCM,data:GD4lVCHwqN6KwL1uAKzCBm/b5RSAbXBqOKJh3Zswt5or3lfWozBiycEkFSBmwY54Jj5L4EFMn4Mi/2ct2PJX3eQu1Lhd/meOMFXxFiUt5EsYPUMKcO8qwtj9JsL0xY51ZGyDERixe/ddEvyV4yh8RsDxAg==,iv:1sm9Ut6zUbKisyc53GfrxTNWRTE+Wm9PEHQEiicM+NE=,tag:KbFhrgrH7AI3J9hhc/lgjA==,type:str]",
          "schema.history.internal.producer.sasl.jaas.config": "ENC[AES256_GCM,data:zUJXRxZ6DPKT0gGh+mvu6CpE2pyIRl3kDwKBPIt/Lnnd98YTrIiw6MH6lsm2pSHihGk1dRJ6BmhQWLbpLloalezM9Fnjg5+95prpRRJHuMu4DoCF8gXlUY22DkAvsO/Gp0IbjNzYcjXxa79zk2+/0bQ6nw==,iv:srum+jjDBzuXP3wX4fMBksQnMMHKbIOR0ZUgTLj5nb8=,tag:mXfecAWIxueeUjVlNvmBNA==,type:str]",
          "notification.enabled.channels": "sink",
          "notification.sink.topic.name": "ASE1.SNAPSHOT.STATUS",
          "transforms": "changes,moveHeadersToValue,unwrap,filter",
          "transforms.changes.type": "io.debezium.transforms.ExtractChangedRecordState",
          "transforms.changes.header.changed.name": "Changed",
          "transforms.moveHeadersToValue.type": "io.debezium.transforms.HeaderToValue",
          "transforms.moveHeadersToValue.headers": "Changed",
          "transforms.moveHeadersToValue.fields": "changes",
          "transforms.moveHeadersToValue.operation": "move",
          "transforms.unwrap.type": "io.debezium.transforms.ExtractNewRecordState",
          "transforms.unwrap.add.fields": "source.table:META_SRC_TABLENAME,source.ts_ms:META_SRC_TS_MS,ts_ms:META_TS_MS,ts_us:META_TS_US,op:META_SRC_OP,source.scn:META_SRC_SCN,source.snapshot:META_SRC_SNAPSHOT,source.user_name:META_SRC_USER,changes:META_SRC_CHANGES",
          "transforms.unwrap.delete.tombstone.handling.mode": "rewrite-with-tombstone",
          "transforms.filter.type": "org.apache.kafka.connect.transforms.Filter",
          "transforms.filter.predicate": "isSignal",
          "predicates": "isSignal",
          "predicates.isSignal.type": "org.apache.kafka.connect.transforms.predicates.TopicNameMatches",
          "predicates.isSignal.pattern": ".*DEBEZIUM_SIGNAL",
          "sops": {
              "kms": null,
              "gcp_kms": null,
              "azure_kv": null,
              "hc_vault": null,
              "age": null,
              "lastmodified": "2024-03-04T14:28:39Z",
              "mac": "ENC[AES256_GCM,data:CcfIYZqM17ZlJ80T/8OXffe6Ij3b8iq3U2UrI20+wacxvcTzb5eWW1ufjPqCnIQ5+XUAP5fL395yinx7ExO2IcHvZacMQ3nIm+5c/AxJ9GrYHl1gMMSX+ww+XLv+oCkOjL0R+WaFJ/bji/pz0o0ahrUw6ChLlkFjTk7dDZJJMMQ=,iv:paBBtquogE7iaHZEvRybXBNqJPl4bTWv3e3zlcSHXTs=,tag:qDcK4Zxpofd2Q1NRot6QAw==,type:str]",
              "pgp": [
                 
      
      {                 "created_at": "2024-03-04T14:28:39Z",                 "enc": "-----BEGIN PGP MESSAGE-----\n\nhQEMA243CXYlIAr3AQgAqZBGhmII/XAoFzSL+8/YeDPV0XBsRhGXfQWmG735QUux\nF3dv7nvMAEEA1Hd7K/hGRTgakX///81eOvzYIp71kv9IyO4Z0ySz4rX13qe0toF8\nQ+UuABkvDM51DGFcfQUesppFnOlsshcciFrXL55NwViab8WCQfcUbWksQmU9MLIu\n2sOoVAwTUzbmn2ITlkxwIZqO87DhSIKU9lEtvrXp8OIr5i0ToM7DPgi7O/8LPutD\nI4P6XFbyboxuwdNeag+ybwduwbKCMKZw2+iTnkVPjHyyFp1VYNUR67zVrZ8U3KfR\nnIK32opaTGZbfxocMzRWHs0jaCaYFGpK5E0tg8WCJNJeAWS11wzYU6wyWe/x3sJQ\neEo3SwI+0o40wu8ZOO1uEM0CG6nXhsIKw6bF39OmDpUS4aFyhUTee/31L9wjWrS/\ntHsgqZCh5SMsR0MxZoaUZj+oieWwlZF7sXaBSN+uCg==\n=zgeG\n-----END PGP MESSAGE-----\n",                 "fp": "F7067DB106402AABEBEF13F8C6E64E19DC477D85"             }
      
              ],
              "encrypted_regex": "(database.password|schema.history.internal.consumer.sasl.jaas.config|schema.history.internal.producer.sasl.jaas.config)",
              "version": "3.7.1"
          }
      }
      

      What is the captured database version and mode of deployment?

      (E.g. on-premises, with a specific cloud provider, etc.)

      <Your answer>

      What behavior do you expect?

      No missing messages due to error mit logminer.

      What behavior do you see?

      Error happens continuously during all day. 

      Do you see the same behaviour using the latest released Debezium version?

      Yes.

      Do you have the connector logs, ideally from start till finish?

      (You might be asked later to provide DEBUG/TRACE level log)

      Yes, we have the log. example of error added to problem description.

      How to reproduce the issue using our tutorial deployment?

      <Your answer>

      Feature request or enhancement

      For feature requests or enhancements, provide this information, please:

      Which use case/requirement will be addressed by the proposed feature?

      <Your answer>

      Implementation ideas (optional)

      <Your answer>

        1. LogFileCollector with inconsistent Thread.csv
          58 kB
          Max Luethi
        2. missing_log_file_DBZ_8093.csv
          186 kB
          Max Luethi
        3. missing_log_file_DBZ_8093-2907.csv
          60 kB
          Max Luethi

              Unassigned Unassigned
              max.luethi@suva.ch Max Luethi (Inactive)
              Votes:
              0 Vote for this issue
              Watchers:
              5 Start watching this issue

                Created:
                Updated:
                Resolved: