You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@geronimo.apache.org by Ivan <xh...@gmail.com> on 2010/12/17 09:18:56 UTC
Re: EOFException in ActiveMQ 4.1.2
Sorry for the repeated sending, just add geronimo mail list.
2010/12/17 Ivan <xh...@gmail.com>
> After adding some outputs, the error seems to happen after the socket of
> the server side received the wireformatinfo, then on the next call of
> readCommand, it fails to read bytes ...
>
> -->
> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
> [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE [/
> 127.0.0.1:2843]]
> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Sending:
> WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
> TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true,
> MaxInactivityDuration=30000, SizePrefixDisabled=false, CacheEnabled=true},
> magic=[A,c,t,i,v,e,M,Q]}
> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN
> writeInt() v = [174]
> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END
> writeInt()
> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN
> write(byte[] b, int off, int len) b = [ [B@73507350] off = [0] len = [174]
> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END
> write(byte[] b, int off, int len)
> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
> [1292553733046-98-1] Receive command [LOCAL [/127.0.0.1:2843 ] REMOTE
> [localhost/127.0.0.1:61616]]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [178]
> position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpTransport] command [WireFormatInfo {
> version=2, properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true,
> CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000,
> SizePrefixDisabled=false, CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}] is
> send correctly [LOCAL [/127.0.0.1:2843 ] REMOTE [localhost/127.0.0.1:61616
> ]]
> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG
> [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE [/
> 127.0.0.1:2843]] command = [WireFormatInfo { version=2,
> properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true,
> CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000,
> CacheEnabled=true, SizePrefixDisabled=false}, magic=[A,c,t,i,v,e,M,Q]}]
> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Received WireFormat:
> WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
> TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true,
> MaxInactivityDuration=30000, CacheEnabled=true, SizePrefixDisabled=false},
> magic=[A,c,t,i,v,e,M,Q]}
> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [
> 0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] before negotiation:
> OpenWireFormat{version=2, cacheEnabled=false, stackTraceEnabled=false,
> tightEncodingEnabled=false, sizePrefixDisabled=false}
> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [
> 0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] after negotiation:
> OpenWireFormat{version=2, cacheEnabled=true, stackTraceEnabled=true,
> tightEncodingEnabled=true, sizePrefixDisabled=false}
> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
> [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ]
> REMOTE [/127.0.0.1:2843]]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
> position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
> position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
> position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
> position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG
> [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ]
> REMOTE [/127.0.0.1:2843]]
>
> java.io.EOFException
> at java.io.DataInputStream.readInt(DataInputStream.java:387)
> at
> org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
> at
> org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:268)
> at
> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:244)
>
> at java.lang.Thread.run(Thread.java:736)
> <--
>
> 2010/12/17 Ivan <xh...@gmail.com>
>
> Hi,
>> I am using Geronimo 2.1.7, which shipped ActiveMQ 4.1.2, it sometimes
>> reported the error below after deploying a MDB. I know that ActiveMQ 4.1.2
>> is a very very old version, but ....
>> I hope some one could help to give some hints, so that I could port some
>> changes from the trunk.
>> Thanks.
>> --->
>> 2010-12-17 09:56:56,875 ERROR [TransportConnector] Could not accept
>> connection from /127.0.0.1:1823: java.io.IOException: The transport is n
>> ot running.
>> java.io.IOException: The transport is not running.
>> at
>> org.apache.activemq.transport.TransportSupport.checkStarted(TransportSupport.java:103)
>> at
>> org.apache.activemq.transport.tcp.TcpTransport.oneway(TcpTransport.java:125)
>> at
>> org.apache.activemq.transport.InactivityMonitor.oneway(InactivityMonitor.java:145)
>> at
>> org.apache.activemq.transport.TransportFilter.oneway(TransportFilter.java:80)
>> at
>> org.apache.activemq.transport.WireFormatNegotiator.oneway(WireFormatNegotiator.java:93)
>> at
>> org.apache.activemq.transport.MutexTransport.oneway(MutexTransport.java:47)
>> at
>> org.apache.activemq.broker.TransportConnection.dispatch(TransportConnection.java:1138)
>> at
>> org.apache.activemq.broker.TransportConnection.processDispatch(TransportConnection.java:805)
>> at
>> org.apache.activemq.broker.TransportConnection.start(TransportConnection.java:885)
>> at
>> org.apache.activemq.broker.TransportConnector$1.onAccept(TransportConnector.java:148)
>> at
>> org.apache.activemq.transport.tcp.TcpTransportServer.run(TcpTransportServer.java:162)
>> at java.lang.Thread.run(Thread.java:736)
>> <---
>>
>> Also, I could find the exception message below in the log
>> --->
>> java.io.EOFException
>> at java.io.DataInputStream.readInt(DataInputStream.java:387)
>> at
>> org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
>> at
>> org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:269)
>> at
>> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:245)
>> at java.lang.Thread.run(Thread.java:736)
>> <---
>> --
>> Ivan
>>
>
>
>
> --
> Ivan
>
--
Ivan
Fwd: EOFException in ActiveMQ 4.1.2
Posted by Ivan <xh...@gmail.com>.
Forgot to cc activemq user list.
---------- Forwarded message ----------
From: Ivan <xh...@gmail.com>
Date: 2010/12/21
Subject: Re: EOFException in ActiveMQ 4.1.2
To: dev@geronimo.apache.org
Finally, I found the codes caused this, it is related to activemq resource
adapter.
In the finally block, connection.close() is called, while at this time, the
wireformat handshake might not finished, closing the client socket might
caused the EOF exception or reset exception on the server side.
Another issue is that, I found that the return value of makeConnection() is
an instance of ActiveMQConnection, not the ActiveMQXAConnection, so it never
returns the XAResource used for transcation recovery.
Thougths ? thanks.
--->
ActiveMQResourceAdapter.java
public XAResource[] getXAResources(ActivationSpec[] activationSpecs) throws
ResourceException {
Connection connection = null;
try {
connection = makeConnection();
if (connection instanceof XAConnection) {
XASession session = ((XAConnection)
connection).createXASession();
XAResource xaResource = session.getXAResource();
return new XAResource[] { xaResource };
} else {
return new XAResource[] {};
}
} catch (JMSException e) {
throw new ResourceException(e);
} finally {
try {
connection.close();
} catch (Throwable ignore) {
}
}
}
<---
2010/12/20 Ivan <xh...@gmail.com>
No, you might find those error messages while restarting the deployed
> application sometimes.
>
> 2010/12/20 Kevan Miller <ke...@gmail.com>
>
>
>> On Dec 19, 2010, at 7:19 AM, Shawn Jiang wrote:
>>
>> > Similar exceptions in geronimo 2.2.1 when connecting to derby during a
>> recovery process.
>> >
>> > https://issues.apache.org/jira/browse/GERONIMO-5736
>> >
>> > Is it possible that some context is not there when txmanager is trying
>> to do the recovery ?
>>
>> The Derby issue seems different to me, though the underlying processing
>> (transaction recovery) is the same. The Derby problem seems to be an
>> authentication issue:
>>
>> [INFO] Caused by: java.sql.SQLException: Connection authentication failure
>> occurred. Reason: Invalid authentication..
>> [INFO] at
>> org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown
>> Source)
>> [INFO] at
>> org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown
>> Source)
>> [INFO] ... 62 more
>>
>> I assume we're missing appropriate configuration with the recent Embedded
>> Derby authentication changes.
>>
>> The ActiveMQ problem sounds like a timing issue: I would guess that
>> perhaps the Server is not always fully started when the managed connections
>> are being created? I assume this only happens once and then the problem
>> disappears?
>>
>> --kevan
>
>
>
>
> --
> Ivan
>
--
Ivan
--
Ivan
Fwd: EOFException in ActiveMQ 4.1.2
Posted by Ivan <xh...@gmail.com>.
Forgot to cc activemq user list.
---------- Forwarded message ----------
From: Ivan <xh...@gmail.com>
Date: 2010/12/21
Subject: Re: EOFException in ActiveMQ 4.1.2
To: dev@geronimo.apache.org
Finally, I found the codes caused this, it is related to activemq resource
adapter.
In the finally block, connection.close() is called, while at this time, the
wireformat handshake might not finished, closing the client socket might
caused the EOF exception or reset exception on the server side.
Another issue is that, I found that the return value of makeConnection() is
an instance of ActiveMQConnection, not the ActiveMQXAConnection, so it never
returns the XAResource used for transcation recovery.
Thougths ? thanks.
--->
ActiveMQResourceAdapter.java
public XAResource[] getXAResources(ActivationSpec[] activationSpecs) throws
ResourceException {
Connection connection = null;
try {
connection = makeConnection();
if (connection instanceof XAConnection) {
XASession session = ((XAConnection)
connection).createXASession();
XAResource xaResource = session.getXAResource();
return new XAResource[] { xaResource };
} else {
return new XAResource[] {};
}
} catch (JMSException e) {
throw new ResourceException(e);
} finally {
try {
connection.close();
} catch (Throwable ignore) {
}
}
}
<---
2010/12/20 Ivan <xh...@gmail.com>
No, you might find those error messages while restarting the deployed
> application sometimes.
>
> 2010/12/20 Kevan Miller <ke...@gmail.com>
>
>
>> On Dec 19, 2010, at 7:19 AM, Shawn Jiang wrote:
>>
>> > Similar exceptions in geronimo 2.2.1 when connecting to derby during a
>> recovery process.
>> >
>> > https://issues.apache.org/jira/browse/GERONIMO-5736
>> >
>> > Is it possible that some context is not there when txmanager is trying
>> to do the recovery ?
>>
>> The Derby issue seems different to me, though the underlying processing
>> (transaction recovery) is the same. The Derby problem seems to be an
>> authentication issue:
>>
>> [INFO] Caused by: java.sql.SQLException: Connection authentication failure
>> occurred. Reason: Invalid authentication..
>> [INFO] at
>> org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown
>> Source)
>> [INFO] at
>> org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown
>> Source)
>> [INFO] ... 62 more
>>
>> I assume we're missing appropriate configuration with the recent Embedded
>> Derby authentication changes.
>>
>> The ActiveMQ problem sounds like a timing issue: I would guess that
>> perhaps the Server is not always fully started when the managed connections
>> are being created? I assume this only happens once and then the problem
>> disappears?
>>
>> --kevan
>
>
>
>
> --
> Ivan
>
--
Ivan
--
Ivan
Re: EOFException in ActiveMQ 4.1.2
Posted by Ivan <xh...@gmail.com>.
Finally, I found the codes caused this, it is related to activemq resource
adapter.
In the finally block, connection.close() is called, while at this time, the
wireformat handshake might not finished, closing the client socket might
caused the EOF exception or reset exception on the server side.
Another issue is that, I found that the return value of makeConnection() is
an instance of ActiveMQConnection, not the ActiveMQXAConnection, so it never
returns the XAResource used for transcation recovery.
Thougths ? thanks.
--->
ActiveMQResourceAdapter.java
public XAResource[] getXAResources(ActivationSpec[] activationSpecs) throws
ResourceException {
Connection connection = null;
try {
connection = makeConnection();
if (connection instanceof XAConnection) {
XASession session = ((XAConnection)
connection).createXASession();
XAResource xaResource = session.getXAResource();
return new XAResource[] { xaResource };
} else {
return new XAResource[] {};
}
} catch (JMSException e) {
throw new ResourceException(e);
} finally {
try {
connection.close();
} catch (Throwable ignore) {
}
}
}
<---
2010/12/20 Ivan <xh...@gmail.com>
> No, you might find those error messages while restarting the deployed
> application sometimes.
>
> 2010/12/20 Kevan Miller <ke...@gmail.com>
>
>
>> On Dec 19, 2010, at 7:19 AM, Shawn Jiang wrote:
>>
>> > Similar exceptions in geronimo 2.2.1 when connecting to derby during a
>> recovery process.
>> >
>> > https://issues.apache.org/jira/browse/GERONIMO-5736
>> >
>> > Is it possible that some context is not there when txmanager is trying
>> to do the recovery ?
>>
>> The Derby issue seems different to me, though the underlying processing
>> (transaction recovery) is the same. The Derby problem seems to be an
>> authentication issue:
>>
>> [INFO] Caused by: java.sql.SQLException: Connection authentication failure
>> occurred. Reason: Invalid authentication..
>> [INFO] at
>> org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown
>> Source)
>> [INFO] at
>> org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown
>> Source)
>> [INFO] ... 62 more
>>
>> I assume we're missing appropriate configuration with the recent Embedded
>> Derby authentication changes.
>>
>> The ActiveMQ problem sounds like a timing issue: I would guess that
>> perhaps the Server is not always fully started when the managed connections
>> are being created? I assume this only happens once and then the problem
>> disappears?
>>
>> --kevan
>
>
>
>
> --
> Ivan
>
--
Ivan
Re: EOFException in ActiveMQ 4.1.2
Posted by Ivan <xh...@gmail.com>.
No, you might find those error messages while restarting the deployed
application sometimes.
2010/12/20 Kevan Miller <ke...@gmail.com>
>
> On Dec 19, 2010, at 7:19 AM, Shawn Jiang wrote:
>
> > Similar exceptions in geronimo 2.2.1 when connecting to derby during a
> recovery process.
> >
> > https://issues.apache.org/jira/browse/GERONIMO-5736
> >
> > Is it possible that some context is not there when txmanager is trying to
> do the recovery ?
>
> The Derby issue seems different to me, though the underlying processing
> (transaction recovery) is the same. The Derby problem seems to be an
> authentication issue:
>
> [INFO] Caused by: java.sql.SQLException: Connection authentication failure
> occurred. Reason: Invalid authentication..
> [INFO] at
> org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown
> Source)
> [INFO] at
> org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown
> Source)
> [INFO] ... 62 more
>
> I assume we're missing appropriate configuration with the recent Embedded
> Derby authentication changes.
>
> The ActiveMQ problem sounds like a timing issue: I would guess that perhaps
> the Server is not always fully started when the managed connections are
> being created? I assume this only happens once and then the problem
> disappears?
>
> --kevan
--
Ivan
Re: EOFException in ActiveMQ 4.1.2
Posted by Kevan Miller <ke...@gmail.com>.
On Dec 19, 2010, at 7:19 AM, Shawn Jiang wrote:
> Similar exceptions in geronimo 2.2.1 when connecting to derby during a recovery process.
>
> https://issues.apache.org/jira/browse/GERONIMO-5736
>
> Is it possible that some context is not there when txmanager is trying to do the recovery ?
The Derby issue seems different to me, though the underlying processing (transaction recovery) is the same. The Derby problem seems to be an authentication issue:
[INFO] Caused by: java.sql.SQLException: Connection authentication failure occurred. Reason: Invalid authentication..
[INFO] at org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown Source)
[INFO] at org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown Source)
[INFO] ... 62 more
I assume we're missing appropriate configuration with the recent Embedded Derby authentication changes.
The ActiveMQ problem sounds like a timing issue: I would guess that perhaps the Server is not always fully started when the managed connections are being created? I assume this only happens once and then the problem disappears?
--kevan
Re: EOFException in ActiveMQ 4.1.2
Posted by David Jencks <da...@yahoo.com>.
To provide some context, what is supposed to be happening here is that when a connector starts, it registers with the transaction manager by providing a NamedXAResourceFactory that the tm can use to try to get a useable XAResource that it can use for recovery. The tm tries immediately but if it encounters any errors it just waits and tries again later. So as long as no threads are hanging and, in this case, we can eventually connect to AMQ then recovery should eventually complete. You can expect to get these exceptions in the log while remote resources are not available. You can also get them if a remote resource becomes unavailable with a transaction that is prepared but not committed.
I'm starting to wonder if these exception traces appear to be too alarming even if they don't indicate an actual problem :-)
thanks
david jencks
On Dec 19, 2010, at 4:19 AM, Shawn Jiang wrote:
> Similar exceptions in geronimo 2.2.1 when connecting to derby during a recovery process.
>
> https://issues.apache.org/jira/browse/GERONIMO-5736
>
> Is it possible that some context is not there when txmanager is trying to do the recovery ?
>
> On Sat, Dec 18, 2010 at 8:59 PM, Ivan <xh...@gmail.com> wrote:
> Seems that Geronimo 2.1.7 will try to do a recovery while a MDB is deployed, the error occurs in the process, I hope that any one could help to shed me some lights,
> thanks.
> --->
> 2010-12-15 12:59:05,156 INFO [TcpTransport] TcpTransport is created LOCAL [0.0.0.0/0.0.0.0:-1 ] REMOTE [null:0]
> java.lang.Throwable
> at org.apache.activemq.transport.tcp.TcpTransport.<init>(TcpTransport.java:95)
> at org.apache.activemq.transport.tcp.TcpTransportFactory.createTcpTransport(TcpTransportFactory.java:131)
> at org.apache.activemq.transport.tcp.TcpTransportFactory.createTransport(TcpTransportFactory.java:116)
> at org.apache.activemq.transport.TransportFactory.doConnect(TransportFactory.java:116)
> at org.apache.activemq.transport.TransportFactory.doConnect(TransportFactory.java:43)
> at org.apache.activemq.transport.TransportFactory.connect(TransportFactory.java:77)
> at org.apache.activemq.ActiveMQConnectionFactory.createTransport(ActiveMQConnectionFactory.java:230)
> at org.apache.activemq.ActiveMQConnectionFactory.createActiveMQConnection(ActiveMQConnectionFactory.java:245)
> at org.apache.activemq.ActiveMQConnectionFactory.createConnection(ActiveMQConnectionFactory.java:168)
> at org.apache.activemq.ra.ActiveMQResourceAdapter.makeConnection(ActiveMQResourceAdapter.java:108)
> at org.apache.activemq.ra.ActiveMQResourceAdapter.makeConnection(ActiveMQResourceAdapter.java:102)
> at org.apache.activemq.ra.ActiveMQManagedConnectionFactory.createManagedConnection(ActiveMQManagedConnectionFactory.java:109)
> at org.apache.geronimo.connector.outbound.MCFConnectionInterceptor.getConnection(MCFConnectionInterceptor.java:49)
> at org.apache.geronimo.connector.outbound.XAResourceInsertionInterceptor.getConnection(XAResourceInsertionInterceptor.java:41)
> at org.apache.geronimo.connector.outbound.SinglePoolConnectionInterceptor.internalGetConnection(SinglePoolConnectionInterceptor.java:69)
> at org.apache.geronimo.connector.outbound.AbstractSinglePoolConnectionInterceptor.getConnection(AbstractSinglePoolConnectionInterceptor.java:80)
> at org.apache.geronimo.connector.outbound.TransactionEnlistingInterceptor.getConnection(TransactionEnlistingInterceptor.java:49)
> at org.apache.geronimo.connector.outbound.TransactionCachingInterceptor.getConnection(TransactionCachingInterceptor.java:109)
> at org.apache.geronimo.connector.outbound.TCCLInterceptor.getConnection(TCCLInterceptor.java:39)
> at org.apache.geronimo.connector.outbound.OutboundNamedXAResourceFactory.getNamedXAResource(OutboundNamedXAResourceFactory.java:56)
> at org.apache.geronimo.transaction.manager.RecoverTask.run(RecoverTask.java:49)
> at org.apache.geronimo.transaction.manager.TransactionManagerImpl.registerNamedXAResourceFactory(TransactionManagerImpl.java:353)
> at org.apache.geronimo.connector.outbound.AbstractConnectionManager.doRecovery(AbstractConnectionManager.java:65)
> at org.apache.geronimo.connector.outbound.ManagedConnectionFactoryWrapper.doStart(ManagedConnectionFactoryWrapper.java:166)
> at org.apache.geronimo.gbean.runtime.GBeanInstance.createInstance(GBeanInstance.java:998)
> at org.apache.geronimo.gbean.runtime.GBeanInstanceState.attemptFullStart(GBeanInstanceState.java:268)
> at org.apache.geronimo.gbean.runtime.GBeanInstanceState.start(GBeanInstanceState.java:102)
> at org.apache.geronimo.gbean.runtime.GBeanInstance.start(GBeanInstance.java:541)
> at org.apache.geronimo.gbean.runtime.GBeanDependency.attemptFullStart(GBeanDependency.java:111)
> at org.apache.geronimo.gbean.runtime.GBeanDependency.addTarget(GBeanDependency.java:146)
> at org.apache.geronimo.gbean.runtime.GBeanDependency$1.running(GBeanDependency.java:120)
> at org.apache.geronimo.kernel.basic.BasicLifecycleMonitor.fireRunningEvent(BasicLifecycleMonitor.java:176)
> at org.apache.geronimo.kernel.basic.BasicLifecycleMonitor.access$300(BasicLifecycleMonitor.java:44)
> at org.apache.geronimo.kernel.basic.BasicLifecycleMonitor$RawLifecycleBroadcaster.fireRunningEvent(BasicLifecycleMonitor.java:254)
> at org.apache.geronimo.gbean.runtime.GBeanInstanceState.attemptFullStart(GBeanInstanceState.java:294)
> at org.apache.geronimo.gbean.runtime.GBeanInstanceState.start(GBeanInstanceState.java:102)
> at org.apache.geronimo.gbean.runtime.GBeanInstanceState.startRecursive(GBeanInstanceState.java:124)
> at org.apache.geronimo.gbean.runtime.GBeanInstance.startRecursive(GBeanInstance.java:555)
> at org.apache.geronimo.kernel.basic.BasicKernel.startRecursiveGBean(BasicKernel.java:379)
> at org.apache.geronimo.kernel.config.ConfigurationUtil.startConfigurationGBeans(ConfigurationUtil.java:456)
> at org.apache.geronimo.kernel.config.KernelConfigurationManager.start(KernelConfigurationManager.java:188)
> at org.apache.geronimo.kernel.config.SimpleConfigurationManager.startConfiguration(SimpleConfigurationManager.java:563)
> at sun.reflect.GeneratedMethodAccessor31.invoke(Unknown Source)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
> at java.lang.reflect.Method.invoke(Method.java:600)
> at org.apache.geronimo.gbean.runtime.ReflectionMethodInvoker.invoke(ReflectionMethodInvoker.java:34)
> at org.apache.geronimo.gbean.runtime.GBeanOperation.invoke(GBeanOperation.java:124)
> at org.apache.geronimo.gbean.runtime.GBeanInstance.invoke(GBeanInstance.java:832)
> at org.apache.geronimo.gbean.runtime.RawInvoker.invoke(RawInvoker.java:57)
> at org.apache.geronimo.kernel.basic.RawOperationInvoker.invoke(RawOperationInvoker.java:35)
> at org.apache.geronimo.kernel.basic.ProxyMethodInterceptor.intercept(ProxyMethodInterceptor.java:96)
> at org.apache.geronimo.kernel.config.EditableConfigurationManager$$EnhancerByCGLIB$$ac8e3b68.startConfiguration(<generated>)
> at org.apache.geronimo.system.main.EmbeddedDaemon.doStartup(EmbeddedDaemon.java:206)
> at org.apache.geronimo.system.main.EmbeddedDaemon.execute(EmbeddedDaemon.java:89)
> at org.apache.geronimo.kernel.util.MainConfigurationBootstrapper.main(MainConfigurationBootstrapper.java:45)
> at org.apache.geronimo.cli.AbstractCLI.executeMain(AbstractCLI.java:67)
> at org.apache.geronimo.cli.daemon.DaemonCLI.main(DaemonCLI.java:30)
>
>
> 2010/12/17 Ivan <xh...@gmail.com>
> Sorry for the repeated sending, just add geronimo mail list.
>
>
> 2010/12/17 Ivan <xh...@gmail.com>
> After adding some outputs, the error seems to happen after the socket of the server side received the wireformatinfo, then on the next call of readCommand, it fails to read bytes ...
>
> -->
> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE [/127.0.0.1:2843]]
> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Sending: WireFormatInfo { version=2, properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000, SizePrefixDisabled=false, CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}
> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN writeInt() v = [174]
> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END writeInt()
> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN write(byte[] b, int off, int len) b = [ [B@73507350] off = [0] len = [174]
> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END write(byte[] b, int off, int len)
> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG [1292553733046-98-1] Receive command [LOCAL [/127.0.0.1:2843 ] REMOTE [localhost/127.0.0.1:61616]]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [178] position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpTransport] command [WireFormatInfo { version=2, properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000, SizePrefixDisabled=false, CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}] is send correctly [LOCAL [/127.0.0.1:2843 ] REMOTE [localhost/127.0.0.1:61616]]
> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE [/127.0.0.1:2843]] command = [WireFormatInfo { version=2, properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000, CacheEnabled=true, SizePrefixDisabled=false}, magic=[A,c,t,i,v,e,M,Q]}]
> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Received WireFormat: WireFormatInfo { version=2, properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000, CacheEnabled=true, SizePrefixDisabled=false}, magic=[A,c,t,i,v,e,M,Q]}
> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] before negotiation: OpenWireFormat{version=2, cacheEnabled=false, stackTraceEnabled=false, tightEncodingEnabled=false, sizePrefixDisabled=false}
> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] after negotiation: OpenWireFormat{version=2, cacheEnabled=true, stackTraceEnabled=true, tightEncodingEnabled=true, sizePrefixDisabled=false}
> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843]]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1] position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1] position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1] position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1] position = [0] count = [0] thread id = [99]
> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843]]
>
> java.io.EOFException
> at java.io.DataInputStream.readInt(DataInputStream.java:387)
> at org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
> at org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:268)
> at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:244)
>
> at java.lang.Thread.run(Thread.java:736)
> <--
>
> 2010/12/17 Ivan <xh...@gmail.com>
>
> Hi,
> I am using Geronimo 2.1.7, which shipped ActiveMQ 4.1.2, it sometimes reported the error below after deploying a MDB. I know that ActiveMQ 4.1.2 is a very very old version, but ....
> I hope some one could help to give some hints, so that I could port some changes from the trunk.
> Thanks.
> --->
> 2010-12-17 09:56:56,875 ERROR [TransportConnector] Could not accept connection from /127.0.0.1:1823: java.io.IOException: The transport is n
> ot running.
> java.io.IOException: The transport is not running.
> at org.apache.activemq.transport.TransportSupport.checkStarted(TransportSupport.java:103)
> at org.apache.activemq.transport.tcp.TcpTransport.oneway(TcpTransport.java:125)
> at org.apache.activemq.transport.InactivityMonitor.oneway(InactivityMonitor.java:145)
> at org.apache.activemq.transport.TransportFilter.oneway(TransportFilter.java:80)
> at org.apache.activemq.transport.WireFormatNegotiator.oneway(WireFormatNegotiator.java:93)
> at org.apache.activemq.transport.MutexTransport.oneway(MutexTransport.java:47)
> at org.apache.activemq.broker.TransportConnection.dispatch(TransportConnection.java:1138)
> at org.apache.activemq.broker.TransportConnection.processDispatch(TransportConnection.java:805)
> at org.apache.activemq.broker.TransportConnection.start(TransportConnection.java:885)
> at org.apache.activemq.broker.TransportConnector$1.onAccept(TransportConnector.java:148)
> at org.apache.activemq.transport.tcp.TcpTransportServer.run(TcpTransportServer.java:162)
> at java.lang.Thread.run(Thread.java:736)
> <---
>
> Also, I could find the exception message below in the log
> --->
> java.io.EOFException
> at java.io.DataInputStream.readInt(DataInputStream.java:387)
> at org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
> at org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:269)
> at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:245)
> at java.lang.Thread.run(Thread.java:736)
> <---
> --
> Ivan
>
>
>
> --
> Ivan
>
>
>
> --
> Ivan
>
>
>
> --
> Ivan
>
>
>
> --
> Shawn
Re: EOFException in ActiveMQ 4.1.2
Posted by Shawn Jiang <ge...@gmail.com>.
Similar exceptions in geronimo 2.2.1 when connecting to derby during a
recovery process.
https://issues.apache.org/jira/browse/GERONIMO-5736
<https://issues.apache.org/jira/browse/GERONIMO-5736>Is it possible that
some context is not there when txmanager is trying to do the recovery ?
On Sat, Dec 18, 2010 at 8:59 PM, Ivan <xh...@gmail.com> wrote:
> Seems that Geronimo 2.1.7 will try to do a recovery while a MDB is
> deployed, the error occurs in the process, I hope that any one could help to
> shed me some lights,
> thanks.
> --->
> 2010-12-15 12:59:05,156 INFO [TcpTransport] TcpTransport is created LOCAL
> [0.0.0.0/0.0.0.0:-1 ] REMOTE [null:0]
> java.lang.Throwable
> at
> org.apache.activemq.transport.tcp.TcpTransport.<init>(TcpTransport.java:95)
> at
> org.apache.activemq.transport.tcp.TcpTransportFactory.createTcpTransport(TcpTransportFactory.java:131)
> at
> org.apache.activemq.transport.tcp.TcpTransportFactory.createTransport(TcpTransportFactory.java:116)
> at
> org.apache.activemq.transport.TransportFactory.doConnect(TransportFactory.java:116)
> at
> org.apache.activemq.transport.TransportFactory.doConnect(TransportFactory.java:43)
> at
> org.apache.activemq.transport.TransportFactory.connect(TransportFactory.java:77)
> at
> org.apache.activemq.ActiveMQConnectionFactory.createTransport(ActiveMQConnectionFactory.java:230)
> at
> org.apache.activemq.ActiveMQConnectionFactory.createActiveMQConnection(ActiveMQConnectionFactory.java:245)
> at
> org.apache.activemq.ActiveMQConnectionFactory.createConnection(ActiveMQConnectionFactory.java:168)
> at
> org.apache.activemq.ra.ActiveMQResourceAdapter.makeConnection(ActiveMQResourceAdapter.java:108)
> at
> org.apache.activemq.ra.ActiveMQResourceAdapter.makeConnection(ActiveMQResourceAdapter.java:102)
> at
> org.apache.activemq.ra.ActiveMQManagedConnectionFactory.createManagedConnection(ActiveMQManagedConnectionFactory.java:109)
> at
> org.apache.geronimo.connector.outbound.MCFConnectionInterceptor.getConnection(MCFConnectionInterceptor.java:49)
> at
> org.apache.geronimo.connector.outbound.XAResourceInsertionInterceptor.getConnection(XAResourceInsertionInterceptor.java:41)
> at
> org.apache.geronimo.connector.outbound.SinglePoolConnectionInterceptor.internalGetConnection(SinglePoolConnectionInterceptor.java:69)
> at
> org.apache.geronimo.connector.outbound.AbstractSinglePoolConnectionInterceptor.getConnection(AbstractSinglePoolConnectionInterceptor.java:80)
> at
> org.apache.geronimo.connector.outbound.TransactionEnlistingInterceptor.getConnection(TransactionEnlistingInterceptor.java:49)
> at
> org.apache.geronimo.connector.outbound.TransactionCachingInterceptor.getConnection(TransactionCachingInterceptor.java:109)
> at
> org.apache.geronimo.connector.outbound.TCCLInterceptor.getConnection(TCCLInterceptor.java:39)
> at
> org.apache.geronimo.connector.outbound.OutboundNamedXAResourceFactory.getNamedXAResource(OutboundNamedXAResourceFactory.java:56)
> at
> org.apache.geronimo.transaction.manager.RecoverTask.run(RecoverTask.java:49)
> at
> org.apache.geronimo.transaction.manager.TransactionManagerImpl.registerNamedXAResourceFactory(TransactionManagerImpl.java:353)
> at
> org.apache.geronimo.connector.outbound.AbstractConnectionManager.doRecovery(AbstractConnectionManager.java:65)
> at
> org.apache.geronimo.connector.outbound.ManagedConnectionFactoryWrapper.doStart(ManagedConnectionFactoryWrapper.java:166)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstance.createInstance(GBeanInstance.java:998)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstanceState.attemptFullStart(GBeanInstanceState.java:268)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstanceState.start(GBeanInstanceState.java:102)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstance.start(GBeanInstance.java:541)
> at
> org.apache.geronimo.gbean.runtime.GBeanDependency.attemptFullStart(GBeanDependency.java:111)
> at
> org.apache.geronimo.gbean.runtime.GBeanDependency.addTarget(GBeanDependency.java:146)
> at
> org.apache.geronimo.gbean.runtime.GBeanDependency$1.running(GBeanDependency.java:120)
> at
> org.apache.geronimo.kernel.basic.BasicLifecycleMonitor.fireRunningEvent(BasicLifecycleMonitor.java:176)
> at
> org.apache.geronimo.kernel.basic.BasicLifecycleMonitor.access$300(BasicLifecycleMonitor.java:44)
> at
> org.apache.geronimo.kernel.basic.BasicLifecycleMonitor$RawLifecycleBroadcaster.fireRunningEvent(BasicLifecycleMonitor.java:254)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstanceState.attemptFullStart(GBeanInstanceState.java:294)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstanceState.start(GBeanInstanceState.java:102)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstanceState.startRecursive(GBeanInstanceState.java:124)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstance.startRecursive(GBeanInstance.java:555)
> at
> org.apache.geronimo.kernel.basic.BasicKernel.startRecursiveGBean(BasicKernel.java:379)
> at
> org.apache.geronimo.kernel.config.ConfigurationUtil.startConfigurationGBeans(ConfigurationUtil.java:456)
> at
> org.apache.geronimo.kernel.config.KernelConfigurationManager.start(KernelConfigurationManager.java:188)
> at
> org.apache.geronimo.kernel.config.SimpleConfigurationManager.startConfiguration(SimpleConfigurationManager.java:563)
> at sun.reflect.GeneratedMethodAccessor31.invoke(Unknown Source)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
> at java.lang.reflect.Method.invoke(Method.java:600)
> at
> org.apache.geronimo.gbean.runtime.ReflectionMethodInvoker.invoke(ReflectionMethodInvoker.java:34)
> at
> org.apache.geronimo.gbean.runtime.GBeanOperation.invoke(GBeanOperation.java:124)
> at
> org.apache.geronimo.gbean.runtime.GBeanInstance.invoke(GBeanInstance.java:832)
> at
> org.apache.geronimo.gbean.runtime.RawInvoker.invoke(RawInvoker.java:57)
> at
> org.apache.geronimo.kernel.basic.RawOperationInvoker.invoke(RawOperationInvoker.java:35)
> at
> org.apache.geronimo.kernel.basic.ProxyMethodInterceptor.intercept(ProxyMethodInterceptor.java:96)
> at
> org.apache.geronimo.kernel.config.EditableConfigurationManager$$EnhancerByCGLIB$$ac8e3b68.startConfiguration(<generated>)
> at
> org.apache.geronimo.system.main.EmbeddedDaemon.doStartup(EmbeddedDaemon.java:206)
> at
> org.apache.geronimo.system.main.EmbeddedDaemon.execute(EmbeddedDaemon.java:89)
> at
> org.apache.geronimo.kernel.util.MainConfigurationBootstrapper.main(MainConfigurationBootstrapper.java:45)
> at org.apache.geronimo.cli.AbstractCLI.executeMain(AbstractCLI.java:67)
> at org.apache.geronimo.cli.daemon.DaemonCLI.main(DaemonCLI.java:30)
>
>
> 2010/12/17 Ivan <xh...@gmail.com>
>
>> Sorry for the repeated sending, just add geronimo mail list.
>>
>>
>> 2010/12/17 Ivan <xh...@gmail.com>
>>
>>> After adding some outputs, the error seems to happen after the socket of
>>> the server side received the wireformatinfo, then on the next call of
>>> readCommand, it fails to read bytes ...
>>>
>>> -->
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>>> [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE
>>> [/127.0.0.1:2843]]
>>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Sending:
>>> WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
>>> TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true,
>>> MaxInactivityDuration=30000, SizePrefixDisabled=false, CacheEnabled=true},
>>> magic=[A,c,t,i,v,e,M,Q]}
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN
>>> writeInt() v = [174]
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END
>>> writeInt()
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN
>>> write(byte[] b, int off, int len) b = [ [B@73507350] off = [0] len =
>>> [174]
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END
>>> write(byte[] b, int off, int len)
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>>> [1292553733046-98-1] Receive command [LOCAL [/127.0.0.1:2843 ] REMOTE
>>> [localhost/127.0.0.1:61616]]
>>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [178]
>>> position = [0] count = [0] thread id = [99]
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport] command [WireFormatInfo {
>>> version=2, properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true,
>>> CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000,
>>> SizePrefixDisabled=false, CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}] is
>>> send correctly [LOCAL [/127.0.0.1:2843 ] REMOTE [localhost/
>>> 127.0.0.1:61616]]
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG
>>> [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE
>>> [/127.0.0.1:2843]] command = [WireFormatInfo { version=2,
>>> properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true,
>>> CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000,
>>> CacheEnabled=true, SizePrefixDisabled=false}, magic=[A,c,t,i,v,e,M,Q]}]
>>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Received WireFormat:
>>> WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
>>> TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true,
>>> MaxInactivityDuration=30000, CacheEnabled=true, SizePrefixDisabled=false},
>>> magic=[A,c,t,i,v,e,M,Q]}
>>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [
>>> 0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] before negotiation:
>>> OpenWireFormat{version=2, cacheEnabled=false, stackTraceEnabled=false,
>>> tightEncodingEnabled=false, sizePrefixDisabled=false}
>>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [
>>> 0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] after negotiation:
>>> OpenWireFormat{version=2, cacheEnabled=true, stackTraceEnabled=true,
>>> tightEncodingEnabled=true, sizePrefixDisabled=false}
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>>> [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ]
>>> REMOTE [/127.0.0.1:2843]]
>>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>>> position = [0] count = [0] thread id = [99]
>>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>>> position = [0] count = [0] thread id = [99]
>>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>>> position = [0] count = [0] thread id = [99]
>>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>>> position = [0] count = [0] thread id = [99]
>>> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG
>>> [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ]
>>> REMOTE [/127.0.0.1:2843]]
>>>
>>> java.io.EOFException
>>> at java.io.DataInputStream.readInt(DataInputStream.java:387)
>>> at
>>> org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:268)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:244)
>>>
>>> at java.lang.Thread.run(Thread.java:736)
>>> <--
>>>
>>> 2010/12/17 Ivan <xh...@gmail.com>
>>>
>>> Hi,
>>>> I am using Geronimo 2.1.7, which shipped ActiveMQ 4.1.2, it sometimes
>>>> reported the error below after deploying a MDB. I know that ActiveMQ 4.1.2
>>>> is a very very old version, but ....
>>>> I hope some one could help to give some hints, so that I could port
>>>> some changes from the trunk.
>>>> Thanks.
>>>> --->
>>>> 2010-12-17 09:56:56,875 ERROR [TransportConnector] Could not accept
>>>> connection from /127.0.0.1:1823: java.io.IOException: The transport is
>>>> n
>>>> ot running.
>>>> java.io.IOException: The transport is not running.
>>>> at
>>>> org.apache.activemq.transport.TransportSupport.checkStarted(TransportSupport.java:103)
>>>> at
>>>> org.apache.activemq.transport.tcp.TcpTransport.oneway(TcpTransport.java:125)
>>>> at
>>>> org.apache.activemq.transport.InactivityMonitor.oneway(InactivityMonitor.java:145)
>>>> at
>>>> org.apache.activemq.transport.TransportFilter.oneway(TransportFilter.java:80)
>>>> at
>>>> org.apache.activemq.transport.WireFormatNegotiator.oneway(WireFormatNegotiator.java:93)
>>>> at
>>>> org.apache.activemq.transport.MutexTransport.oneway(MutexTransport.java:47)
>>>> at
>>>> org.apache.activemq.broker.TransportConnection.dispatch(TransportConnection.java:1138)
>>>> at
>>>> org.apache.activemq.broker.TransportConnection.processDispatch(TransportConnection.java:805)
>>>> at
>>>> org.apache.activemq.broker.TransportConnection.start(TransportConnection.java:885)
>>>> at
>>>> org.apache.activemq.broker.TransportConnector$1.onAccept(TransportConnector.java:148)
>>>> at
>>>> org.apache.activemq.transport.tcp.TcpTransportServer.run(TcpTransportServer.java:162)
>>>> at java.lang.Thread.run(Thread.java:736)
>>>> <---
>>>>
>>>> Also, I could find the exception message below in the log
>>>> --->
>>>> java.io.EOFException
>>>> at java.io.DataInputStream.readInt(DataInputStream.java:387)
>>>> at
>>>> org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
>>>> at
>>>> org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:269)
>>>> at
>>>> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:245)
>>>> at java.lang.Thread.run(Thread.java:736)
>>>> <---
>>>> --
>>>> Ivan
>>>>
>>>
>>>
>>>
>>> --
>>> Ivan
>>>
>>
>>
>>
>> --
>> Ivan
>>
>
>
>
> --
> Ivan
>
--
Shawn
Re: EOFException in ActiveMQ 4.1.2
Posted by Ivan <xh...@gmail.com>.
Seems that Geronimo 2.1.7 will try to do a recovery while a MDB is deployed,
the error occurs in the process, I hope that any one could help to shed me
some lights,
thanks.
--->
2010-12-15 12:59:05,156 INFO [TcpTransport] TcpTransport is created LOCAL [
0.0.0.0/0.0.0.0:-1 ] REMOTE [null:0]
java.lang.Throwable
at
org.apache.activemq.transport.tcp.TcpTransport.<init>(TcpTransport.java:95)
at
org.apache.activemq.transport.tcp.TcpTransportFactory.createTcpTransport(TcpTransportFactory.java:131)
at
org.apache.activemq.transport.tcp.TcpTransportFactory.createTransport(TcpTransportFactory.java:116)
at
org.apache.activemq.transport.TransportFactory.doConnect(TransportFactory.java:116)
at
org.apache.activemq.transport.TransportFactory.doConnect(TransportFactory.java:43)
at
org.apache.activemq.transport.TransportFactory.connect(TransportFactory.java:77)
at
org.apache.activemq.ActiveMQConnectionFactory.createTransport(ActiveMQConnectionFactory.java:230)
at
org.apache.activemq.ActiveMQConnectionFactory.createActiveMQConnection(ActiveMQConnectionFactory.java:245)
at
org.apache.activemq.ActiveMQConnectionFactory.createConnection(ActiveMQConnectionFactory.java:168)
at
org.apache.activemq.ra.ActiveMQResourceAdapter.makeConnection(ActiveMQResourceAdapter.java:108)
at
org.apache.activemq.ra.ActiveMQResourceAdapter.makeConnection(ActiveMQResourceAdapter.java:102)
at
org.apache.activemq.ra.ActiveMQManagedConnectionFactory.createManagedConnection(ActiveMQManagedConnectionFactory.java:109)
at
org.apache.geronimo.connector.outbound.MCFConnectionInterceptor.getConnection(MCFConnectionInterceptor.java:49)
at
org.apache.geronimo.connector.outbound.XAResourceInsertionInterceptor.getConnection(XAResourceInsertionInterceptor.java:41)
at
org.apache.geronimo.connector.outbound.SinglePoolConnectionInterceptor.internalGetConnection(SinglePoolConnectionInterceptor.java:69)
at
org.apache.geronimo.connector.outbound.AbstractSinglePoolConnectionInterceptor.getConnection(AbstractSinglePoolConnectionInterceptor.java:80)
at
org.apache.geronimo.connector.outbound.TransactionEnlistingInterceptor.getConnection(TransactionEnlistingInterceptor.java:49)
at
org.apache.geronimo.connector.outbound.TransactionCachingInterceptor.getConnection(TransactionCachingInterceptor.java:109)
at
org.apache.geronimo.connector.outbound.TCCLInterceptor.getConnection(TCCLInterceptor.java:39)
at
org.apache.geronimo.connector.outbound.OutboundNamedXAResourceFactory.getNamedXAResource(OutboundNamedXAResourceFactory.java:56)
at
org.apache.geronimo.transaction.manager.RecoverTask.run(RecoverTask.java:49)
at
org.apache.geronimo.transaction.manager.TransactionManagerImpl.registerNamedXAResourceFactory(TransactionManagerImpl.java:353)
at
org.apache.geronimo.connector.outbound.AbstractConnectionManager.doRecovery(AbstractConnectionManager.java:65)
at
org.apache.geronimo.connector.outbound.ManagedConnectionFactoryWrapper.doStart(ManagedConnectionFactoryWrapper.java:166)
at
org.apache.geronimo.gbean.runtime.GBeanInstance.createInstance(GBeanInstance.java:998)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.attemptFullStart(GBeanInstanceState.java:268)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.start(GBeanInstanceState.java:102)
at
org.apache.geronimo.gbean.runtime.GBeanInstance.start(GBeanInstance.java:541)
at
org.apache.geronimo.gbean.runtime.GBeanDependency.attemptFullStart(GBeanDependency.java:111)
at
org.apache.geronimo.gbean.runtime.GBeanDependency.addTarget(GBeanDependency.java:146)
at
org.apache.geronimo.gbean.runtime.GBeanDependency$1.running(GBeanDependency.java:120)
at
org.apache.geronimo.kernel.basic.BasicLifecycleMonitor.fireRunningEvent(BasicLifecycleMonitor.java:176)
at
org.apache.geronimo.kernel.basic.BasicLifecycleMonitor.access$300(BasicLifecycleMonitor.java:44)
at
org.apache.geronimo.kernel.basic.BasicLifecycleMonitor$RawLifecycleBroadcaster.fireRunningEvent(BasicLifecycleMonitor.java:254)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.attemptFullStart(GBeanInstanceState.java:294)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.start(GBeanInstanceState.java:102)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.startRecursive(GBeanInstanceState.java:124)
at
org.apache.geronimo.gbean.runtime.GBeanInstance.startRecursive(GBeanInstance.java:555)
at
org.apache.geronimo.kernel.basic.BasicKernel.startRecursiveGBean(BasicKernel.java:379)
at
org.apache.geronimo.kernel.config.ConfigurationUtil.startConfigurationGBeans(ConfigurationUtil.java:456)
at
org.apache.geronimo.kernel.config.KernelConfigurationManager.start(KernelConfigurationManager.java:188)
at
org.apache.geronimo.kernel.config.SimpleConfigurationManager.startConfiguration(SimpleConfigurationManager.java:563)
at sun.reflect.GeneratedMethodAccessor31.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:600)
at
org.apache.geronimo.gbean.runtime.ReflectionMethodInvoker.invoke(ReflectionMethodInvoker.java:34)
at
org.apache.geronimo.gbean.runtime.GBeanOperation.invoke(GBeanOperation.java:124)
at
org.apache.geronimo.gbean.runtime.GBeanInstance.invoke(GBeanInstance.java:832)
at
org.apache.geronimo.gbean.runtime.RawInvoker.invoke(RawInvoker.java:57)
at
org.apache.geronimo.kernel.basic.RawOperationInvoker.invoke(RawOperationInvoker.java:35)
at
org.apache.geronimo.kernel.basic.ProxyMethodInterceptor.intercept(ProxyMethodInterceptor.java:96)
at
org.apache.geronimo.kernel.config.EditableConfigurationManager$$EnhancerByCGLIB$$ac8e3b68.startConfiguration(<generated>)
at
org.apache.geronimo.system.main.EmbeddedDaemon.doStartup(EmbeddedDaemon.java:206)
at
org.apache.geronimo.system.main.EmbeddedDaemon.execute(EmbeddedDaemon.java:89)
at
org.apache.geronimo.kernel.util.MainConfigurationBootstrapper.main(MainConfigurationBootstrapper.java:45)
at org.apache.geronimo.cli.AbstractCLI.executeMain(AbstractCLI.java:67)
at org.apache.geronimo.cli.daemon.DaemonCLI.main(DaemonCLI.java:30)
2010/12/17 Ivan <xh...@gmail.com>
> Sorry for the repeated sending, just add geronimo mail list.
>
>
> 2010/12/17 Ivan <xh...@gmail.com>
>
>> After adding some outputs, the error seems to happen after the socket of
>> the server side received the wireformatinfo, then on the next call of
>> readCommand, it fails to read bytes ...
>>
>> -->
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>> [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE [/
>> 127.0.0.1:2843]]
>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Sending:
>> WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
>> TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true,
>> MaxInactivityDuration=30000, SizePrefixDisabled=false, CacheEnabled=true},
>> magic=[A,c,t,i,v,e,M,Q]}
>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN
>> writeInt() v = [174]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END
>> writeInt()
>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN
>> write(byte[] b, int off, int len) b = [ [B@73507350] off = [0] len =
>> [174]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END
>> write(byte[] b, int off, int len)
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>> [1292553733046-98-1] Receive command [LOCAL [/127.0.0.1:2843 ] REMOTE
>> [localhost/127.0.0.1:61616]]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [178]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] command [WireFormatInfo {
>> version=2, properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true,
>> CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000,
>> SizePrefixDisabled=false, CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}] is
>> send correctly [LOCAL [/127.0.0.1:2843 ] REMOTE [localhost/
>> 127.0.0.1:61616]]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG
>> [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE [/
>> 127.0.0.1:2843]] command = [WireFormatInfo { version=2,
>> properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true,
>> CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000,
>> CacheEnabled=true, SizePrefixDisabled=false}, magic=[A,c,t,i,v,e,M,Q]}]
>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Received WireFormat:
>> WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
>> TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true,
>> MaxInactivityDuration=30000, CacheEnabled=true, SizePrefixDisabled=false},
>> magic=[A,c,t,i,v,e,M,Q]}
>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [
>> 0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] before negotiation:
>> OpenWireFormat{version=2, cacheEnabled=false, stackTraceEnabled=false,
>> tightEncodingEnabled=false, sizePrefixDisabled=false}
>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [
>> 0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] after negotiation:
>> OpenWireFormat{version=2, cacheEnabled=true, stackTraceEnabled=true,
>> tightEncodingEnabled=true, sizePrefixDisabled=false}
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>> [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ]
>> REMOTE [/127.0.0.1:2843]]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG
>> [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ]
>> REMOTE [/127.0.0.1:2843]]
>>
>> java.io.EOFException
>> at java.io.DataInputStream.readInt(DataInputStream.java:387)
>> at
>> org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
>> at
>> org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:268)
>> at
>> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:244)
>>
>> at java.lang.Thread.run(Thread.java:736)
>> <--
>>
>> 2010/12/17 Ivan <xh...@gmail.com>
>>
>> Hi,
>>> I am using Geronimo 2.1.7, which shipped ActiveMQ 4.1.2, it sometimes
>>> reported the error below after deploying a MDB. I know that ActiveMQ 4.1.2
>>> is a very very old version, but ....
>>> I hope some one could help to give some hints, so that I could port
>>> some changes from the trunk.
>>> Thanks.
>>> --->
>>> 2010-12-17 09:56:56,875 ERROR [TransportConnector] Could not accept
>>> connection from /127.0.0.1:1823: java.io.IOException: The transport is n
>>> ot running.
>>> java.io.IOException: The transport is not running.
>>> at
>>> org.apache.activemq.transport.TransportSupport.checkStarted(TransportSupport.java:103)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransport.oneway(TcpTransport.java:125)
>>> at
>>> org.apache.activemq.transport.InactivityMonitor.oneway(InactivityMonitor.java:145)
>>> at
>>> org.apache.activemq.transport.TransportFilter.oneway(TransportFilter.java:80)
>>> at
>>> org.apache.activemq.transport.WireFormatNegotiator.oneway(WireFormatNegotiator.java:93)
>>> at
>>> org.apache.activemq.transport.MutexTransport.oneway(MutexTransport.java:47)
>>> at
>>> org.apache.activemq.broker.TransportConnection.dispatch(TransportConnection.java:1138)
>>> at
>>> org.apache.activemq.broker.TransportConnection.processDispatch(TransportConnection.java:805)
>>> at
>>> org.apache.activemq.broker.TransportConnection.start(TransportConnection.java:885)
>>> at
>>> org.apache.activemq.broker.TransportConnector$1.onAccept(TransportConnector.java:148)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransportServer.run(TcpTransportServer.java:162)
>>> at java.lang.Thread.run(Thread.java:736)
>>> <---
>>>
>>> Also, I could find the exception message below in the log
>>> --->
>>> java.io.EOFException
>>> at java.io.DataInputStream.readInt(DataInputStream.java:387)
>>> at
>>> org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:269)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:245)
>>> at java.lang.Thread.run(Thread.java:736)
>>> <---
>>> --
>>> Ivan
>>>
>>
>>
>>
>> --
>> Ivan
>>
>
>
>
> --
> Ivan
>
--
Ivan
Re: EOFException in ActiveMQ 4.1.2
Posted by Ivan <xh...@gmail.com>.
Seems that Geronimo 2.1.7 will try to do a recovery while a MDB is deployed,
the error occurs in the process, I hope that any one could help to shed me
some lights,
thanks.
--->
2010-12-15 12:59:05,156 INFO [TcpTransport] TcpTransport is created LOCAL [
0.0.0.0/0.0.0.0:-1 ] REMOTE [null:0]
java.lang.Throwable
at
org.apache.activemq.transport.tcp.TcpTransport.<init>(TcpTransport.java:95)
at
org.apache.activemq.transport.tcp.TcpTransportFactory.createTcpTransport(TcpTransportFactory.java:131)
at
org.apache.activemq.transport.tcp.TcpTransportFactory.createTransport(TcpTransportFactory.java:116)
at
org.apache.activemq.transport.TransportFactory.doConnect(TransportFactory.java:116)
at
org.apache.activemq.transport.TransportFactory.doConnect(TransportFactory.java:43)
at
org.apache.activemq.transport.TransportFactory.connect(TransportFactory.java:77)
at
org.apache.activemq.ActiveMQConnectionFactory.createTransport(ActiveMQConnectionFactory.java:230)
at
org.apache.activemq.ActiveMQConnectionFactory.createActiveMQConnection(ActiveMQConnectionFactory.java:245)
at
org.apache.activemq.ActiveMQConnectionFactory.createConnection(ActiveMQConnectionFactory.java:168)
at
org.apache.activemq.ra.ActiveMQResourceAdapter.makeConnection(ActiveMQResourceAdapter.java:108)
at
org.apache.activemq.ra.ActiveMQResourceAdapter.makeConnection(ActiveMQResourceAdapter.java:102)
at
org.apache.activemq.ra.ActiveMQManagedConnectionFactory.createManagedConnection(ActiveMQManagedConnectionFactory.java:109)
at
org.apache.geronimo.connector.outbound.MCFConnectionInterceptor.getConnection(MCFConnectionInterceptor.java:49)
at
org.apache.geronimo.connector.outbound.XAResourceInsertionInterceptor.getConnection(XAResourceInsertionInterceptor.java:41)
at
org.apache.geronimo.connector.outbound.SinglePoolConnectionInterceptor.internalGetConnection(SinglePoolConnectionInterceptor.java:69)
at
org.apache.geronimo.connector.outbound.AbstractSinglePoolConnectionInterceptor.getConnection(AbstractSinglePoolConnectionInterceptor.java:80)
at
org.apache.geronimo.connector.outbound.TransactionEnlistingInterceptor.getConnection(TransactionEnlistingInterceptor.java:49)
at
org.apache.geronimo.connector.outbound.TransactionCachingInterceptor.getConnection(TransactionCachingInterceptor.java:109)
at
org.apache.geronimo.connector.outbound.TCCLInterceptor.getConnection(TCCLInterceptor.java:39)
at
org.apache.geronimo.connector.outbound.OutboundNamedXAResourceFactory.getNamedXAResource(OutboundNamedXAResourceFactory.java:56)
at
org.apache.geronimo.transaction.manager.RecoverTask.run(RecoverTask.java:49)
at
org.apache.geronimo.transaction.manager.TransactionManagerImpl.registerNamedXAResourceFactory(TransactionManagerImpl.java:353)
at
org.apache.geronimo.connector.outbound.AbstractConnectionManager.doRecovery(AbstractConnectionManager.java:65)
at
org.apache.geronimo.connector.outbound.ManagedConnectionFactoryWrapper.doStart(ManagedConnectionFactoryWrapper.java:166)
at
org.apache.geronimo.gbean.runtime.GBeanInstance.createInstance(GBeanInstance.java:998)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.attemptFullStart(GBeanInstanceState.java:268)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.start(GBeanInstanceState.java:102)
at
org.apache.geronimo.gbean.runtime.GBeanInstance.start(GBeanInstance.java:541)
at
org.apache.geronimo.gbean.runtime.GBeanDependency.attemptFullStart(GBeanDependency.java:111)
at
org.apache.geronimo.gbean.runtime.GBeanDependency.addTarget(GBeanDependency.java:146)
at
org.apache.geronimo.gbean.runtime.GBeanDependency$1.running(GBeanDependency.java:120)
at
org.apache.geronimo.kernel.basic.BasicLifecycleMonitor.fireRunningEvent(BasicLifecycleMonitor.java:176)
at
org.apache.geronimo.kernel.basic.BasicLifecycleMonitor.access$300(BasicLifecycleMonitor.java:44)
at
org.apache.geronimo.kernel.basic.BasicLifecycleMonitor$RawLifecycleBroadcaster.fireRunningEvent(BasicLifecycleMonitor.java:254)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.attemptFullStart(GBeanInstanceState.java:294)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.start(GBeanInstanceState.java:102)
at
org.apache.geronimo.gbean.runtime.GBeanInstanceState.startRecursive(GBeanInstanceState.java:124)
at
org.apache.geronimo.gbean.runtime.GBeanInstance.startRecursive(GBeanInstance.java:555)
at
org.apache.geronimo.kernel.basic.BasicKernel.startRecursiveGBean(BasicKernel.java:379)
at
org.apache.geronimo.kernel.config.ConfigurationUtil.startConfigurationGBeans(ConfigurationUtil.java:456)
at
org.apache.geronimo.kernel.config.KernelConfigurationManager.start(KernelConfigurationManager.java:188)
at
org.apache.geronimo.kernel.config.SimpleConfigurationManager.startConfiguration(SimpleConfigurationManager.java:563)
at sun.reflect.GeneratedMethodAccessor31.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:600)
at
org.apache.geronimo.gbean.runtime.ReflectionMethodInvoker.invoke(ReflectionMethodInvoker.java:34)
at
org.apache.geronimo.gbean.runtime.GBeanOperation.invoke(GBeanOperation.java:124)
at
org.apache.geronimo.gbean.runtime.GBeanInstance.invoke(GBeanInstance.java:832)
at
org.apache.geronimo.gbean.runtime.RawInvoker.invoke(RawInvoker.java:57)
at
org.apache.geronimo.kernel.basic.RawOperationInvoker.invoke(RawOperationInvoker.java:35)
at
org.apache.geronimo.kernel.basic.ProxyMethodInterceptor.intercept(ProxyMethodInterceptor.java:96)
at
org.apache.geronimo.kernel.config.EditableConfigurationManager$$EnhancerByCGLIB$$ac8e3b68.startConfiguration(<generated>)
at
org.apache.geronimo.system.main.EmbeddedDaemon.doStartup(EmbeddedDaemon.java:206)
at
org.apache.geronimo.system.main.EmbeddedDaemon.execute(EmbeddedDaemon.java:89)
at
org.apache.geronimo.kernel.util.MainConfigurationBootstrapper.main(MainConfigurationBootstrapper.java:45)
at org.apache.geronimo.cli.AbstractCLI.executeMain(AbstractCLI.java:67)
at org.apache.geronimo.cli.daemon.DaemonCLI.main(DaemonCLI.java:30)
2010/12/17 Ivan <xh...@gmail.com>
> Sorry for the repeated sending, just add geronimo mail list.
>
>
> 2010/12/17 Ivan <xh...@gmail.com>
>
>> After adding some outputs, the error seems to happen after the socket of
>> the server side received the wireformatinfo, then on the next call of
>> readCommand, it fails to read bytes ...
>>
>> -->
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>> [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE [/
>> 127.0.0.1:2843]]
>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Sending:
>> WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
>> TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true,
>> MaxInactivityDuration=30000, SizePrefixDisabled=false, CacheEnabled=true},
>> magic=[A,c,t,i,v,e,M,Q]}
>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN
>> writeInt() v = [174]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END
>> writeInt()
>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] BEGIN
>> write(byte[] b, int off, int len) b = [ [B@73507350] off = [0] len =
>> [174]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport$MonitorDataOutput] END
>> write(byte[] b, int off, int len)
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>> [1292553733046-98-1] Receive command [LOCAL [/127.0.0.1:2843 ] REMOTE
>> [localhost/127.0.0.1:61616]]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [178]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] command [WireFormatInfo {
>> version=2, properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true,
>> CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000,
>> SizePrefixDisabled=false, CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}] is
>> send correctly [LOCAL [/127.0.0.1:2843 ] REMOTE [localhost/
>> 127.0.0.1:61616]]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG
>> [1292553733046-99-1] Receive command [LOCAL [/127.0.0.1:61616 ] REMOTE [/
>> 127.0.0.1:2843]] command = [WireFormatInfo { version=2,
>> properties={TightEncodingEnabled=true, TcpNoDelayEnabled=true,
>> CacheSize=1024, StackTraceEnabled=true, MaxInactivityDuration=30000,
>> CacheEnabled=true, SizePrefixDisabled=false}, magic=[A,c,t,i,v,e,M,Q]}]
>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] Received WireFormat:
>> WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
>> TcpNoDelayEnabled=true, CacheSize=1024, StackTraceEnabled=true,
>> MaxInactivityDuration=30000, CacheEnabled=true, SizePrefixDisabled=false},
>> magic=[A,c,t,i,v,e,M,Q]}
>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [
>> 0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] before negotiation:
>> OpenWireFormat{version=2, cacheEnabled=false, stackTraceEnabled=false,
>> tightEncodingEnabled=false, sizePrefixDisabled=false}
>> 2010-12-17 10:42:13,046 DEBUG [WireFormatNegotiator] LOCAL [
>> 0.0.0.0/0.0.0.0:61616 ] REMOTE [/127.0.0.1:2843] after negotiation:
>> OpenWireFormat{version=2, cacheEnabled=true, stackTraceEnabled=true,
>> tightEncodingEnabled=true, sizePrefixDisabled=false}
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] BEGIN TAG
>> [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ]
>> REMOTE [/127.0.0.1:2843]]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpBufferedInputStream] fill() n = [-1]
>> position = [0] count = [0] thread id = [99]
>> 2010-12-17 10:42:13,046 INFO [TcpTransport] END TAG
>> [1292553733046-99-2] Receive command [LOCAL [0.0.0.0/0.0.0.0:61616 ]
>> REMOTE [/127.0.0.1:2843]]
>>
>> java.io.EOFException
>> at java.io.DataInputStream.readInt(DataInputStream.java:387)
>> at
>> org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
>> at
>> org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:268)
>> at
>> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:244)
>>
>> at java.lang.Thread.run(Thread.java:736)
>> <--
>>
>> 2010/12/17 Ivan <xh...@gmail.com>
>>
>> Hi,
>>> I am using Geronimo 2.1.7, which shipped ActiveMQ 4.1.2, it sometimes
>>> reported the error below after deploying a MDB. I know that ActiveMQ 4.1.2
>>> is a very very old version, but ....
>>> I hope some one could help to give some hints, so that I could port
>>> some changes from the trunk.
>>> Thanks.
>>> --->
>>> 2010-12-17 09:56:56,875 ERROR [TransportConnector] Could not accept
>>> connection from /127.0.0.1:1823: java.io.IOException: The transport is n
>>> ot running.
>>> java.io.IOException: The transport is not running.
>>> at
>>> org.apache.activemq.transport.TransportSupport.checkStarted(TransportSupport.java:103)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransport.oneway(TcpTransport.java:125)
>>> at
>>> org.apache.activemq.transport.InactivityMonitor.oneway(InactivityMonitor.java:145)
>>> at
>>> org.apache.activemq.transport.TransportFilter.oneway(TransportFilter.java:80)
>>> at
>>> org.apache.activemq.transport.WireFormatNegotiator.oneway(WireFormatNegotiator.java:93)
>>> at
>>> org.apache.activemq.transport.MutexTransport.oneway(MutexTransport.java:47)
>>> at
>>> org.apache.activemq.broker.TransportConnection.dispatch(TransportConnection.java:1138)
>>> at
>>> org.apache.activemq.broker.TransportConnection.processDispatch(TransportConnection.java:805)
>>> at
>>> org.apache.activemq.broker.TransportConnection.start(TransportConnection.java:885)
>>> at
>>> org.apache.activemq.broker.TransportConnector$1.onAccept(TransportConnector.java:148)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransportServer.run(TcpTransportServer.java:162)
>>> at java.lang.Thread.run(Thread.java:736)
>>> <---
>>>
>>> Also, I could find the exception message below in the log
>>> --->
>>> java.io.EOFException
>>> at java.io.DataInputStream.readInt(DataInputStream.java:387)
>>> at
>>> org.apache.activemq.openwire.OpenWireFormat.unmarshal(OpenWireFormat.java:267)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:269)
>>> at
>>> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:245)
>>> at java.lang.Thread.run(Thread.java:736)
>>> <---
>>> --
>>> Ivan
>>>
>>
>>
>>
>> --
>> Ivan
>>
>
>
>
> --
> Ivan
>
--
Ivan