IBM Support

JR51170: UNEXPECTED PARSING ERROR, CDC FAILS WITH ARRAYINDEXOUTOFBOUNDSEXCEPTION EXCEPTION

Subscribe to this APAR

By subscribing, you receive periodic emails alerting you to the status of the APAR, along with a link to the fix after it becomes available. You can track this item individually or track all items by product.

Notify me when this APAR changes.

Notify me when an APAR for this component changes.

 

APAR status

  • Closed as program error.

Error description

  • Here is the exception :

475711 2014-08-12 18:06:01.133 SHAREDSCRAPE LOG PARSER{218069}
com.datamirror.ts.eventlog.EventLogger logActualEvent()
Unexpected parsing error for table YNCW.NBI_DISTRIBUTE_DATAPKG
at log entry Log Entry - operation: J txid: 10.1.806755
12583065;12584052;1 currLogPosition:
13429675876.1.3.31306.424.1.0 prevLogPosition: 0.0.0.0.0.0.0
object id: 70851 imageLength: 367
User Name {} Program name {null} Time in milliseconds
{1407837771000} CommitCycleId {-1} Job name {null} Job User
{null} Journal Name {null} User name {} Program name {null}
journal id:
0 in transaction Log Entry - operation: C txid: 10.1.806755
12583065;12584052;1 currLogPosition:
13429675890.1.1.31307.452.1.0 prevLogPosition: 0.0.0.0.0.0.0
object id: 0 imageLength: 93
User Name {} Program name {null} Time in milliseconds
{1407837771000} CommitCycleId {-1} Job name {null} Job User
{null} Journal Name {null} User name {} Program name {null}
journal id:
0 . com.datamirror.ts.scrapers.cdc.LogParserException Unexpected
parsing error for table YNCW.NBI_DISTRIBUTE_DATAPKG at log entry
Log Entry - operation: J txid: 10.1.806755
12583065;12584052;1 currLogPosition:
13429675876.1.3.31306.424.1.0 prevLogPosition: 0.0.0.0.0.0.0
object id: 70851 imageLength: 367 User Name {} Program name
{null} Time in milliseconds
{1407837771000} CommitCycleId {-1} Job name {null} Job User
{null} Journal Name {null} User name {} Program name {null}
journal id: 0 in transaction Log Entry - operation: C txid:
10.1.806755 12583065;12584052;1 currLogPosition:
13429675890.1.1.31307.452.1.0 prevLogPosition: 0.0.0.0.0.0.0
object id: 0 imageLength: 93 User Name {} Program name {null}
Time in
milliseconds {1407837771000} CommitCycleId {-1} Job name {null}
Job User {null} Journal Name {null} User name {} Program name
{null} journal id: 0 .|Error: null| at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.continueParsingADmlTransaction(OracleRedoLogParser.java:923)|
at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.parseCommittedTxn(OracleRedoLogParser.java:376)| at
com.datamirror.ts.scrapers.cdc.LogParser.handleCommitEntry(LogPa
rser.java:2275)| at
com.datamirror.ts.scrapers.cdc.LogParser.execute(LogParser.java:
533)| at
com.datamirror.ts.scrapers.cdc.LogParser$LogParserPipelineJob.ex
ecute(LogParser.java:142)| at
com.datamirror.ts.engine.component.PipelineThread.runThread(Pipe
lineThread.java:205)|
at com.datamirror.ts.util.TsThread.run(TsThread.java:81)|Caused
by: java.lang.ArrayIndexOutOfBoundsException | at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawRedo
$PartsList.moveToPart(RawRedo.java:66)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawRedo
$PartsList.get(RawRedo.java:77)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.extractSuppleInfoFromPayLoad(RawDmlWithUndo.java:954)|
at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.TableDa
ta.extractColumnInfoFromPayLoad(TableData.java:334)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.extractColumnInfoFromPayLoad(RawDmlWithUndo.java:1118)|
at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.setImplementation(RawDmlWithUndo.java:1197)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.checkSplit(RawDmlWithUndo.java:940)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.<init>(RawDmlWithUndo.java:837)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawRedo
.setImplementation(RawRedo.java:167)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawRedo
.<init>(RawRedo.java:134)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.Logical
LogEntry.createImpl(LogicalLogEntry.java:201)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.Logical
LogEntry.setImplementation(LogicalLogEntry.java:162)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.Logical
LogEntry.<init>(LogicalLogEntry.java:92)| at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.buildAUnit(OracleRedoLogParser.java:409)| at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.continueParsingADmlTransaction(OracleRedoLogParser.java:864)|
at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.parseCommittedTxn(OracleRedoLogParser.java:376)| at
com.datamirror.ts.scrapers.cdc.LogParser.handleCommitEntry(LogPa
rser.java:2275)| at
com.datamirror.ts.scrapers.cdc.LogParser.execute(LogParser.java:
533)| at

Local fix

  • A fix is needed.

Problem summary

  • ISCDC 6.5.2 for Oracle Redo stops declaring an "Unexpected
parsing error" and the following stack in the trace:
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.continueParsingADmlTransaction(OracleRedoLogParser.java:923)|
at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.parseCommittedTxn(OracleRedoLogParser.java:376)| at
com.datamirror.ts.scrapers.cdc.LogParser.handleCommitEntry(LogPa
rser.java:2275)| at
com.datamirror.ts.scrapers.cdc.LogParser.execute(LogParser.java:
533)| at
com.datamirror.ts.scrapers.cdc.LogParser$LogParserPipelineJob.ex
ecute(LogParser.java:142)| at
com.datamirror.ts.engine.component.PipelineThread.runThread(Pipe
lineThread.java:205)|
at com.datamirror.ts.util.TsThread.run(TsThread.java:81)|Caused
by: java.lang.ArrayIndexOutOfBoundsException | at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawRedo
$PartsList.moveToPart(RawRedo.java:66)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawRedo
$PartsList.get(RawRedo.java:77)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.extractSuppleInfoFromPayLoad(RawDmlWithUndo.java:954)|
at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.TableDa
ta.extractColumnInfoFromPayLoad(TableData.java:334)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.extractColumnInfoFromPayLoad(RawDmlWithUndo.java:1118)|
at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.setImplementation(RawDmlWithUndo.java:1197)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.checkSplit(RawDmlWithUndo.java:940)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawDmlW
ithUndo.<init>(RawDmlWithUndo.java:837)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawRedo
.setImplementation(RawRedo.java:167)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.RawRedo
.<init>(RawRedo.java:134)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.Logical
LogEntry.createImpl(LogicalLogEntry.java:201)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.Logical
LogEntry.setImplementation(LogicalLogEntry.java:162)| at
com.datamirror.ts.scrapers.oraclescraper.redo.logicallog.Logical
LogEntry.<init>(LogicalLogEntry.java:92)| at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.buildAUnit(OracleRedoLogParser.java:409)| at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.continueParsingADmlTransaction(OracleRedoLogParser.java:864)|
at
com.datamirror.ts.scrapers.oraclescraper.redo.OracleRedoLogParse
r.parseCommittedTxn(OracleRedoLogParser.java:376)| at
com.datamirror.ts.scrapers.cdc.LogParser.handleCommitEntry(LogPa
rser.java:2275)| at
com.datamirror.ts.scrapers.cdc.LogParser.execute(LogParser.java:
533)| at

This issue affect users running ISCDC 6.5.2 Interim Fix 42 for
Oracle Redo (and lower).

Problem conclusion

  • This issue is fixed by applying ISCDC 6.5.2 Interim Fix 43 for
Oracle Redo.

Temporary fix

  • 



Comments


    

  • 



APAR Information




    

  • APAR number
    JR51170
    • 

  • Reported component name
    IS CDC ORACLE
    • 

  • Reported component ID
    5724U7008
    • 

  • Reported release
    652
    • 

  • Status
    CLOSED  PER
    • 

  • PE
    NoPE
    • 

  • HIPER
    NoHIPER
    • 

  • Special Attention
    NoSpecatt
    • 

  • Submitted date
    2014-09-03
    • 

  • Closed date
    2014-09-22
    • 

  • Last modified date
    2014-09-22
    • 





    

  • APAR is sysrouted FROM one or more of the following:
    

    • 

  • APAR is sysrouted TO one or more of the following:
    

    • 



Fix information


    

  • Fixed component name
    IS CDC ORACLE
    • 

  • Fixed component ID
    5724U7008
    • 



Applicable component levels


    

  • R652  PSY
       UP
    • 








      
              
                            

              

              [{"Business Unit":{"code":"BU059","label":"IBM Software w\/o TPS"},"Product":{"code":"SSX3HK","label":"InfoSphere Change Data Capture"},"Component":"","ARM Category":[],"Platform":[{"code":"PF025","label":"Platform Independent"}],"Version":"652","Edition":"","Line of Business":{"code":"LOB10","label":"Data and AI"}}]
              

                                                                    

          
 
        

      

    

      

        

          

            
Document Information


            

            


                        

            Modified date:
            

            22 September 2014
            

            
                      

        


        

        


      

    

  



    

  

  
    
            

          
Page Feedback