Uploaded image for project: 'ActiveMQ Classic'
  1. ActiveMQ Classic
  2. AMQ-3649

NPE when KahaDB fails to store to Journal with EOFException

    XMLWordPrintableJSON

Details

    • Bug
    • Status: Resolved
    • Trivial
    • Resolution: Fixed
    • 5.5.0
    • 5.6.0
    • Message Store
    • None
    • Patch Available

    Description

      2012-01-03 19:17:50,646 | DEBUG | commit: TX:ID:foo-7365-1325617993757-0:1:1 syncCount: 2 | org.apache.activemq.transaction.LocalTransaction | ActiveMQ Transport: tcp:///bar:13219
      2012-01-03 19:17:50,650 | ERROR | KahaDB failed to store to Journal | org.apache.activemq.store.kahadb.MessageDatabase | ActiveMQ Transport: tcp:///bar:13219
      java.io.EOFException
      	at java.io.RandomAccessFile.readFully(RandomAccessFile.java:383)
      	at java.io.RandomAccessFile.readFully(RandomAccessFile.java:361)
      	at org.apache.kahadb.page.PageFile.readPage(PageFile.java:779)
      	at org.apache.kahadb.page.Transaction$2.readPage(Transaction.java:440)
      	at org.apache.kahadb.page.Transaction$2.<init>(Transaction.java:431)
      	at org.apache.kahadb.page.Transaction.openInputStream(Transaction.java:428)
      	at org.apache.kahadb.page.Transaction.load(Transaction.java:404)
      	at org.apache.kahadb.page.Transaction.load(Transaction.java:361)
      	at org.apache.kahadb.index.BTreeIndex.loadNode(BTreeIndex.java:262)
      	at org.apache.kahadb.index.BTreeIndex.getRoot(BTreeIndex.java:174)
      	at org.apache.kahadb.index.BTreeIndex.put(BTreeIndex.java:189)
      	at org.apache.activemq.store.kahadb.MessageDatabase.upadateIndex(MessageDatabase.java:1026)
      	at org.apache.activemq.store.kahadb.MessageDatabase$AddOpperation.execute(MessageDatabase.java:1777)
      	at org.apache.activemq.store.kahadb.MessageDatabase$18.execute(MessageDatabase.java:976)
      	at org.apache.kahadb.page.Transaction.execute(Transaction.java:728)
      	at org.apache.activemq.store.kahadb.MessageDatabase.process(MessageDatabase.java:973)
      	at org.apache.activemq.store.kahadb.MessageDatabase$13.visit(MessageDatabase.java:874)
      	at org.apache.activemq.store.kahadb.data.KahaCommitCommand.visit(KahaCommitCommand.java:130)
      	at org.apache.activemq.store.kahadb.MessageDatabase.process(MessageDatabase.java:856)
      	at org.apache.activemq.store.kahadb.MessageDatabase.store(MessageDatabase.java:783)
      	at org.apache.activemq.store.kahadb.KahaDBTransactionStore.commit(KahaDBTransactionStore.java:270)
      	at org.apache.activemq.transaction.LocalTransaction.commit(LocalTransaction.java:72)
      	at org.apache.activemq.broker.TransactionBroker.commitTransaction(TransactionBroker.java:173)
      	at org.apache.activemq.broker.MutableBrokerFilter.commitTransaction(MutableBrokerFilter.java:103)
      	at org.apache.activemq.broker.TransportConnection.processCommitTransactionOnePhase(TransportConnection.java:420)
      	at org.apache.activemq.command.TransactionInfo.visit(TransactionInfo.java:100)
      	at org.apache.activemq.broker.TransportConnection.service(TransportConnection.java:306)
      	at org.apache.activemq.broker.TransportConnection$1.onCommand(TransportConnection.java:179)
      	at org.apache.activemq.transport.TransportFilter.onCommand(TransportFilter.java:69)
      	at org.apache.activemq.transport.WireFormatNegotiator.onCommand(WireFormatNegotiator.java:113)
      	at org.apache.activemq.transport.InactivityMonitor.onCommand(InactivityMonitor.java:227)
      	at org.apache.activemq.transport.TransportSupport.doConsume(TransportSupport.java:83)
      	at org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:220)
      	at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:202)
      	at java.lang.Thread.run(Thread.java:619)
      2012-01-03 19:17:50,650 | WARN  | Store COMMIT FAILED:  | org.apache.activemq.transaction.LocalTransaction | ActiveMQ Transport: tcp:///bar:13219
      java.lang.NullPointerException
      	at org.apache.activemq.util.DefaultIOExceptionHandler.handle(DefaultIOExceptionHandler.java:54)
      	at org.apache.activemq.broker.BrokerService.handleIOException(BrokerService.java:2193)
      	at org.apache.activemq.store.kahadb.MessageDatabase.store(MessageDatabase.java:804)
      	at org.apache.activemq.store.kahadb.KahaDBTransactionStore.commit(KahaDBTransactionStore.java:270)
      	at org.apache.activemq.transaction.LocalTransaction.commit(LocalTransaction.java:72)
      	at org.apache.activemq.broker.TransactionBroker.commitTransaction(TransactionBroker.java:173)
      	at org.apache.activemq.broker.MutableBrokerFilter.commitTransaction(MutableBrokerFilter.java:103)
      	at org.apache.activemq.broker.TransportConnection.processCommitTransactionOnePhase(TransportConnection.java:420)
      	at org.apache.activemq.command.TransactionInfo.visit(TransactionInfo.java:100)
      	at org.apache.activemq.broker.TransportConnection.service(TransportConnection.java:306)
      	at org.apache.activemq.broker.TransportConnection$1.onCommand(TransportConnection.java:179)
      	at org.apache.activemq.transport.TransportFilter.onCommand(TransportFilter.java:69)
      	at org.apache.activemq.transport.WireFormatNegotiator.onCommand(WireFormatNegotiator.java:113)
      	at org.apache.activemq.transport.InactivityMonitor.onCommand(InactivityMonitor.java:227)
      	at org.apache.activemq.transport.TransportSupport.doConsume(TransportSupport.java:83)
      	at org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:220)
      	at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:202)
      	at java.lang.Thread.run(Thread.java:619)
      2012-01-03 19:17:50,651 | DEBUG | rollback: TX:ID:foo-7365-1325617993757-0:1:1 syncCount: 2 | org.apache.activemq.transaction.LocalTransaction | ActiveMQ Transport: tcp:///bar:13219
      2012-01-03 19:17:50,651 | DEBUG | Error occured while processing sync command: TransactionInfo {commandId = 229, responseRequired = true, type = 2, connectionId = ID:foo-7365-1325617993757-0:1, transactionId = TX:ID:foo-7365-1325617993757-0:1:1}, exception: javax.transaction.xa.XAException: STORE COMMIT FAILED: Transaction rolled back. | org.apache.activemq.broker.TransportConnection.Service | ActiveMQ Transport: tcp:///bar:13219
      javax.transaction.xa.XAException: STORE COMMIT FAILED: Transaction rolled back.
      	at org.apache.activemq.transaction.LocalTransaction.commit(LocalTransaction.java:77)
      	at org.apache.activemq.broker.TransactionBroker.commitTransaction(TransactionBroker.java:173)
      	at org.apache.activemq.broker.MutableBrokerFilter.commitTransaction(MutableBrokerFilter.java:103)
      	at org.apache.activemq.broker.TransportConnection.processCommitTransactionOnePhase(TransportConnection.java:420)
      	at org.apache.activemq.command.TransactionInfo.visit(TransactionInfo.java:100)
      	at org.apache.activemq.broker.TransportConnection.service(TransportConnection.java:306)
      	at org.apache.activemq.broker.TransportConnection$1.onCommand(TransportConnection.java:179)
      	at org.apache.activemq.transport.TransportFilter.onCommand(TransportFilter.java:69)
      	at org.apache.activemq.transport.WireFormatNegotiator.onCommand(WireFormatNegotiator.java:113)
      	at org.apache.activemq.transport.InactivityMonitor.onCommand(InactivityMonitor.java:227)
      	at org.apache.activemq.transport.TransportSupport.doConsume(TransportSupport.java:83)
      	at org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:220)
      	at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:202)
      	at java.lang.Thread.run(Thread.java:619)
      Caused by: java.lang.NullPointerException
      	at org.apache.activemq.util.DefaultIOExceptionHandler.handle(DefaultIOExceptionHandler.java:54)
      	at org.apache.activemq.broker.BrokerService.handleIOException(BrokerService.java:2193)
      	at org.apache.activemq.store.kahadb.MessageDatabase.store(MessageDatabase.java:804)
      	at org.apache.activemq.store.kahadb.KahaDBTransactionStore.commit(KahaDBTransactionStore.java:270)
      	at org.apache.activemq.transaction.LocalTransaction.commit(LocalTransaction.java:72)
      	... 13 more
      

      Attachments

        Activity

          People

            Unassigned Unassigned
            sslavic Stevo Slavić
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: