You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@activemq.apache.org by ajitgirish <aj...@infosys.com> on 2009/10/07 10:42:22 UTC
Active MQ 5.2 crash
Hi ,
I am getting the following error in the ActiveMq logs.
2009-09-25 15:35:20,414 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- dataFilesInProgress.values: (0) []
2009-09-25 15:35:20,415 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- lastDataFile: 1
2009-09-25 15:35:20,416 [iveMQ Scheduler] DEBUG AsyncDataManager
- lastFileId=0, purgeList: (0) []
2009-09-25 15:35:20,422 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:35:20,422 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:35:21,311 [1.211.234:50029] DEBUG Transport
java.io.EOFException
at java.io.DataInputStream.readByte(DataInputStream.java:250)
at
org.apache.activemq.transport.stomp.StompWireFormat.readLine(StompWireFormat.java:186)
at
org.apache.activemq.transport.stomp.StompWireFormat.unmarshal(StompWireFormat.java:94)
at
org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:210)
at
org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:202)
at
org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:185)
at java.lang.Thread.run(Thread.java:619)
2009-09-25 15:35:21,358 [115.12.62:60205] DEBUG Transport
- Transport failed: java.io.EOFException
java.io.EOFException
at java.io.DataInputStream.readByte(DataInputStream.java:250)
at
org.apache.activemq.transport.stomp.StompWireFormat.readLine(StompWireFormat.java:186)
at
org.apache.activemq.transport.stomp.StompWireFormat.unmarshal(StompWireFormat.java:94)
at
org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:210)
at
org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:202)
at
org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:185)
at java.lang.Thread.run(Thread.java:619)
2009-09-25 15:35:21,584 [1.211.231:36383] DEBUG TransportConnection
- Setting up new connection: /xxxxx:36383
2009-09-25 15:35:21,597 [115.12.63:41433] DEBUG Transport
- Transport failed: java.io.EOFException
java.io.EOFException
at java.io.DataInputStream.readByte(DataInputStream.java:250)
at
org.apache.activemq.transport.stomp.StompWireFormat.readLine(StompWireFormat.java:186)
at
org.apache.activemq.transport.stomp.StompWireFormat.unmarshal(StompWireFormat.java:94)
at
org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:210)
at
org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:202)
at
org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:185)
at java.lang.Thread.run(Thread.java:619)
2009-09-25 15:35:22,636 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- dataFilesInProgress.values: (0) []
2009-09-25 15:35:22,636 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- lastDataFile: 1
2009-09-25 15:35:22,637 [iveMQ Scheduler] DEBUG AsyncDataManager
- lastFileId=0, purgeList: (0) []
2009-09-25 15:35:22,638 [115.12.62:60205] DEBUG TransportConnection
- Stopping connection: /yyyyyy:60205
2009-09-25 15:35:22,638 [115.12.62:60205] DEBUG TcpTransport
- Stopping transport tcp:///zzzzzzz:60205
2009-09-25 15:35:22,672 [1.211.234:50029] DEBUG TransportConnection
- Stopping connection: /qqqqqqq:50029
2009-09-25 15:35:22,672 [1.211.234:50029] DEBUG TcpTransport
- Stopping transport tcp:///rrrrrrr:50029
2009-09-25 15:35:22,775 [1.211.234:33435] DEBUG TransportConnection
- Setting up new connection: /xxxxxx:33435
2009-09-25 15:35:22,837 [115.12.62:48216] DEBUG TransportConnection
- Setting up new connection: /xxxxxx:48216
2009-09-25 15:35:23,787 [1.211.231:48547] DEBUG Transport
- Transport failed: java.io.EOFException
java.io.EOFException
at java.io.DataInputStream.readByte(DataInputStream.java:250)
at
org.apache.activemq.transport.stomp.StompWireFormat.readLine(StompWireFormat.java:186)
at
org.apache.activemq.transport.stomp.StompWireFormat.unmarshal(StompWireFormat.java:94)
at
org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:210)
at
org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:202)
at
org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:185)
at java.lang.Thread.run(Thread.java:619)
2009-09-25 15:35:30,672 [115.12.63:53051] DEBUG TransportConnection
- Setting up new connection: /XXXXXX:53051
2009-09-25 15:35:30,745 [115.12.62:60205] DEBUG TransportConnection
- Stopped transport: /YYYY:60205
2009-09-25 15:35:30,753 [115.12.62:60205] DEBUG TransportConnection
- Cleaning up connection resources: /YYYY:60205
2009-09-25 15:35:30,754 [115.12.62:60205] DEBUG TransportConnection
- Connection Stopped: /YYYY:60205
2009-09-25 15:35:34,188 [1.211.234:50029] DEBUG TransportConnection
- Stopped transport: /ZZZZ:50029
2009-09-25 15:35:34,210 [115.12.63:41433] DEBUG TransportConnection
- Stopping connection: /XXXXXX:41433
2009-09-25 15:35:34,418 [115.12.63:41433] DEBUG TcpTransport
- Stopping transport tcp:///XXXXXX:41433
2009-09-25 15:35:34,418 [1.211.231:48547] DEBUG TransportConnection
- Stopping connection: /WWWWW:48547
2009-09-25 15:35:34,418 [1.211.231:48547] DEBUG TcpTransport
- Stopping transport tcp:///WWWWW:48547
2009-09-25 15:35:34,418 [115.12.63:41433] DEBUG TransportConnection
- Stopped transport: /XXXXXX:41433
2009-09-25 15:35:34,419 [1.211.231:48547] DEBUG TransportConnection
- Stopped transport: /WWWWW:48547
2009-09-25 15:35:34,471 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:35:34,472 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:35:34,492 [1.211.231:48547] DEBUG TransportConnection
- Cleaning up connection resources: /WWWWW:48547
2009-09-25 15:35:34,493 [1.211.231:48547] DEBUG TransportConnection
- Connection Stopped: /WWWWW:48547
2009-09-25 15:35:34,493 [1.211.234:50029] DEBUG TransportConnection
- Cleaning up connection resources: /ZZZZ:50029
2009-09-25 15:35:34,493 [1.211.234:50029] DEBUG TransportConnection
- Connection Stopped: /ZZZZ:50029
2009-09-25 15:36:53,967 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- dataFilesInProgress.values: (0) []
2009-09-25 15:36:53,973 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- lastDataFile: 1
2009-09-25 15:36:54,146 [115.12.63:41433] DEBUG TransportConnection
- Cleaning up connection resources: /XXXXXX:41433
2009-09-25 15:37:05,214 [115.12.63:41433] DEBUG TransportConnection
- Connection Stopped: /XXXXXX:41433
2009-09-25 15:37:05,213 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:37:01,326 [iveMQ Scheduler] DEBUG AsyncDataManager
- lastFileId=0, purgeList: (0) []
2009-09-25 15:37:05,273 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- dataFilesInProgress.values: (0) []
2009-09-25 15:37:05,274 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- lastDataFile: 1
2009-09-25 15:37:05,274 [iveMQ Scheduler] DEBUG AsyncDataManager
- lastFileId=0, purgeList: (0) []
2009-09-25 15:37:05,274 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- dataFilesInProgress.values: (0) []
2009-09-25 15:37:05,274 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- lastDataFile: 1
2009-09-25 15:37:05,274 [iveMQ Scheduler] DEBUG AsyncDataManager
- lastFileId=0, purgeList: (0) []
2009-09-25 15:37:05,276 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:37:05,276 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:37:05,276 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:37:44,873 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- dataFilesInProgress.values: (0) []
2009-09-25 15:37:44,945 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- lastDataFile: 1
2009-09-25 15:37:44,946 [iveMQ Scheduler] DEBUG AsyncDataManager
- lastFileId=0, purgeList: (0) []
2009-09-25 15:37:44,945 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:37:45,024 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:37:45,025 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:37:45,025 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:37:52,402 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- dataFilesInProgress.values: (0) []
2009-09-25 15:38:18,424 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- lastDataFile: 1
2009-09-25 15:38:18,524 [iveMQ Scheduler] DEBUG AsyncDataManager
- lastFileId=0, purgeList: (0) []
2009-09-25 15:37:52,710 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:38:18,524 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:38:18,525 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:38:18,525 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:38:23,171 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- dataFilesInProgress.values: (0) []
2009-09-25 15:38:27,644 [iveMQ Scheduler] DEBUG AMQPersistenceAdapter
- lastDataFile: 1
2009-09-25 15:38:27,648 [iveMQ Scheduler] DEBUG AsyncDataManager
- lastFileId=0, purgeList: (0) []
2009-09-25 15:38:32,373 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:38:32,374 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:40:54,506 [erSimpleAppMain] DEBUG XBeanBrokerFactory
- Now attempting to figure out the type of resource:
file:/home/dg/sorter/activemq/conf/sorter.xml
2009-09-25 15:40:58,292 [erSimpleAppMain] ERROR BrokerService
- Broker Name: %HOSTNAME% contained illegal characters - replaced with
_HOSTNAME_
2009-09-25 15:40:58,582 [erSimpleAppMain] INFO BrokerService
- Using Persistence Adapter:
AMQPersistenceAdapter(/home/dg/sorter/activemq/data/_HOSTNAME_)
2009-09-25 15:40:58,747 [erSimpleAppMain] INFO AMQPersistenceAdapter
- AMQStore starting using directory:
/home/dg/sorter/activemq/data/_HOSTNAME_
2009-09-25 15:40:58,936 [erSimpleAppMain] INFO KahaStore
- Kaha Store using data directory
/home/dg/sorter/activemq/data/_HOSTNAME_/kr-store/state
2009-09-25 15:40:59,849 [erSimpleAppMain] INFO AMQPersistenceAdapter
- Active data files: []
2009-09-25 15:40:59,854 [erSimpleAppMain] WARN AMQPersistenceAdapter
- The ReferenceStore is not valid - recovering ...
2009-09-25 15:40:59,863 [erSimpleAppMain] INFO KahaStore
- Kaha Store successfully deleted data directory
/home/dg/sorter/activemq/data/_HOSTNAME_/kr-store/data
2009-09-25 15:40:59,868 [erSimpleAppMain] INFO AMQPersistenceAdapter
- Journal Recovery Started from: DataManager:(data-)
2009-09-25 15:40:59,871 [erSimpleAppMain] DEBUG AMQPersistenceAdapter
- TRACE Entry: RECOVERED Tue Sep 22 01:50:52 EST 2009
2009-09-25 15:40:59,879 [erSimpleAppMain] INFO AMQPersistenceAdapter
- Recovered 0 operations from redo log in 0.01 seconds.
2009-09-25 15:40:59,879 [erSimpleAppMain] INFO AMQPersistenceAdapter
- Finished recovering the ReferenceStore
2009-09-25 15:40:59,884 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint started.
2009-09-25 15:40:59,886 [eckpoint Worker] DEBUG AMQPersistenceAdapter
- Checkpoint done.
2009-09-25 15:41:00,434 [erSimpleAppMain] DEBUG ManagementContext
- Probably not using JRE 1.4: mx4j.tools.naming.NamingService
2009-09-25 15:41:00,495 [erSimpleAppMain] DEBUG ManagementContext
- Failed to create local registry
java.rmi.server.ExportException: internal error: ObjID already in use
at sun.rmi.transport.ObjectTable.putTarget(ObjectTable.java:169)
at sun.rmi.transport.Transport.exportObject(Transport.java:74)
at sun.rmi.transport.tcp.TCPTransport.exportObject(TCPTransport.java:229)
at sun.rmi.transport.tcp.TCPEndpoint.exportObject(TCPEndpoint.java:393)
at sun.rmi.transport.LiveRef.exportObject(LiveRef.java:129)
at sun.rmi.server.UnicastServerRef.exportObject(UnicastServerRef.java:190)
at sun.rmi.registry.RegistryImpl.setup(RegistryImpl.java:92)
at sun.rmi.registry.RegistryImpl.<init>(RegistryImpl.java:78)
at java.rmi.registry.LocateRegistry.createRegistry(LocateRegistry.java:186)
at
org.apache.activemq.broker.jmx.ManagementContext.createConnector(ManagementContext.java:365)
at
org.apache.activemq.broker.jmx.ManagementContext.findMBeanServer(ManagementContext.java:293)
at
org.apache.activemq.broker.jmx.ManagementContext.getMBeanServer(ManagementContext.java:148)
at
org.apache.activemq.broker.jmx.ManagementContext.start(ManagementContext.java:77)
at org.apache.activemq.broker.BrokerService.start(BrokerService.java:465)
at
org.apache.activemq.xbean.XBeanBrokerService.afterPropertiesSet(XBeanBrokerService.java:52)
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1368)
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1334)
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:473)
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$1.run(AbstractAutowireCapableBeanFactory.java:409)
at java.security.AccessController.doPrivileged(Native Method)
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:380)
at
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:264)
at
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:221)
at
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:261)
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:185)
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:164)
at
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:429)
at
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:729)
at
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:381)
at
org.apache.xbean.spring.context.ResourceXmlApplicationContext.<init>(ResourceXmlApplicationContext.java:64)
at
org.apache.xbean.spring.context.ResourceXmlApplicationContext.<init>(ResourceXmlApplicationContext.java:52)
at
org.apache.activemq.xbean.XBeanBrokerFactory.createApplicationContext(XBeanBrokerFactory.java:96)
at
org.apache.activemq.xbean.XBeanBrokerFactory.createBroker(XBeanBrokerFactory.java:52)
at
org.apache.activemq.broker.BrokerFactory.createBroker(BrokerFactory.java:71)
at
org.apache.activemq.broker.BrokerFactory.createBroker(BrokerFactory.java:54)
at
org.apache.activemq.console.command.StartCommand.startBroker(StartCommand.java:115)
at
org.apache.activemq.console.command.StartCommand.runTask(StartCommand.java:91)
at
org.apache.activemq.console.command.AbstractCommand.execute(AbstractCommand.java:57)
at
org.apache.activemq.console.command.ShellCommand.runTask(ShellCommand.java:129)
at
org.apache.activemq.console.command.AbstractCommand.execute(AbstractCommand.java:57)
at
org.apache.activemq.console.command.ShellCommand.main(ShellCommand.java:79)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.apache.activemq.console.Main.runTaskClass(Main.java:225)
at org.apache.activemq.console.Main.main(Main.java:106)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at
org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:240)
at java.lang.Thread.run(Thread.java:619)
2009-09-25 15:41:00,550 [erSimpleAppMain] INFO BrokerService
- ActiveMQ 5.2.0 JMS Message Broker (_HOSTNAME_) is starting
2009-09-25 15:41:00,552 [erSimpleAppMain] INFO BrokerService
- For help or more information please see: http://activemq.apache.org/
2009-09-25 15:41:01,399 [erSimpleAppMain] INFO KahaStore
- Kaha Store using data directory
/home/dg/sorter/activemq/data/_HOSTNAME_/kr-store/data
2009-09-25 15:41:01,606 [JMX connector ] INFO ManagementContext
- JMX consoles can connect to
service:jmx:rmi:///jndi/rmi://localhost:1099/jmxrmi
2009-09-25 15:41:01,608 [erSimpleAppMain] INFO TransportServerThreadSupport
- Listening for connections at:
stomp://dgce-ora-00.networks.in.telstra.com.au:61613
2009-09-25 15:41:01,610 [erSimpleAppMain] INFO TransportConnector
- Connector stomp Started
2009-09-25 15:41:01,662 [erSimpleAppMain] INFO TransportServerThreadSupport
- Listening for connections at:
tcp://dgce-ora-00.networks.in.telstra.com.au:61616?wireFormat.maxInactivityDuration=-1
2009-09-25 15:41:01,663 [erSimpleAppMain] INFO TransportConnector
- Connector openwire Started
This is happening again and again . After a while we have a scenario our
server crashed.
Any one has any idea how to resolve such issues. I am using Active Mq for my
message flow within the servers.
Thanks in Advance
Ajit.
--
View this message in context: http://www.nabble.com/Active-MQ-5.2-crash-tp25782731p25782731.html
Sent from the ActiveMQ - User mailing list archive at Nabble.com.