You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@qpid.apache.org by Martin Ritchie <ri...@mac.com> on 2007/03/07 00:04:22 UTC
Re: Intermittent failure of org.apache.qpid.test.unit.basic.PropertyValueTest
I have seen this a couple of times as well. It occurs when the
message reference count goes negative.. which clearly shouldn't
happen. Guess there is a issue some where with the reference counting.
On 6 Mar 2007, at 20:55, Alan Conway wrote:
> I'm also seeing this failure intermittently. Is someone looking
> into it?
> A quick search didn't turn up a JIRA for it. I get the following
> output
> at the end of mvn test and then it just hangs:
>
> -------------------------------------------------------
> T E S T S
> -------------------------------------------------------
> Running
> org.apache.qpid.test.unit.client.destinationurl.DestinationURLTest
> log4j:WARN No appenders could be found for logger
> (org.apache.qpid.url.AMQBindingURL).
> log4j:WARN Please initialize the log4j system properly.
> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.043
> sec
> Running org.apache.qpid.test.unit.basic.PubSubTwoConnectionTest
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.178
> sec
> Running org.apache.qpid.test.unit.basic.LargeMessageTest
> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.563
> sec
> Running org.apache.qpid.test.unit.client.connection.ConnectionTest
> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.629
> sec
> Running org.apache.qpid.test.unit.transacted.CommitRollbackTest
> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.518
> sec
> Running org.apache.qpid.test.unit.topic.TopicPublisherTest
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.075
> sec
> Running org.apache.qpid.test.unit.basic.MapMessageTest
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.589
> sec
> Running org.apache.qpid.test.unit.basic.MultipleConnectionTest
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed:
> 0.33 sec
> Running org.apache.qpid.client.DispatcherTest
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.921
> sec
> Running org.apache.qpid.test.unit.message.MessageConverterTest
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007
> sec
> Running org.apache.qpid.test.unit.client.AMQSessionTest
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.313
> sec
> Running org.apache.qpid.test.unit.basic.PropertyValueTest
> java.lang.Exception: Stack trace
> at java.lang.Thread.dumpStack(Thread.java:1158)
> at
> org.apache.qpid.server.queue.AMQMessage.decrementReference
> (AMQMessage.java:416)
> at
> org.apache.qpid.server.ack.UnacknowledgedMessage.discard
> (UnacknowledgedMessage.java:66)
> at
> org.apache.qpid.server.txn.NonTransactionalContext.acknowledgeMessage(
> NonTransactionalContext.java:184)
> at
> org.apache.qpid.server.ack.UnacknowledgedMessageMapImpl.acknowledgeMes
> sage(UnacknowledgedMessageMapImpl.java:151)
> at
> org.apache.qpid.server.AMQChannel.acknowledgeMessage
> (AMQChannel.java:763)
> at
> org.apache.qpid.server.handler.BasicAckMethodHandler.methodReceived
> (BasicAckMethodHandler.java:65)
> at
> org.apache.qpid.server.state.AMQStateManager.methodReceived
> (AMQStateManager.java:222)
> at
> org.apache.qpid.server.protocol.AMQMinaProtocolSession.methodFrameRece
> ived(AMQMinaProtocolSession.java:308)
> at
> org.apache.qpid.server.protocol.AMQMinaProtocolSession.frameReceived
> (AMQMinaProtocolSession.java:215)
> at
> org.apache.qpid.server.protocol.AMQMinaProtocolSession.dataBlockReceiv
> ed(AMQMinaProtocolSession.java:193)
> at
> org.apache.qpid.server.protocol.AMQPFastProtocolHandler.messageReceive
> d(AMQPFastProtocolHandler.java:206)
> at org.apache.mina.common.support.AbstractIoFilterChain
> $2.messageReceived(AbstractIoFilterChain.java:189)
> at
> org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRe
> ceived(AbstractIoFilterChain.java:502)
> at org.apache.mina.common.support.AbstractIoFilterChain.access
> $1000(AbstractIoFilterChain.java:52)
> at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl
> $1.messageReceived(AbstractIoFilterChain.java:777)
> at
> org.apache.mina.filter.codec.support.SimpleProtocolDecoderOutput.flush
> (SimpleProtocolDecoderOutput.java:60)
> at
> org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived
> (ProtocolCodecFilter.java:185)
> at
> org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRe
> ceived(AbstractIoFilterChain.java:502)
> at org.apache.mina.common.support.AbstractIoFilterChain.access
> $1000(AbstractIoFilterChain.java:52)
> at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl
> $1.messageReceived(AbstractIoFilterChain.java:777)
> at
> org.apache.qpid.pool.PoolingFilter.messageReceived
> (PoolingFilter.java:145)
> at
> org.apache.mina.filter.ReferenceCountingIoFilter.messageReceived
> (ReferenceCountingIoFilter.java:96)
> at
> org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRe
> ceived(AbstractIoFilterChain.java:502)
> at org.apache.mina.common.support.AbstractIoFilterChain.access
> $1000(AbstractIoFilterChain.java:52)
> at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl
> $1.messageReceived(AbstractIoFilterChain.java:777)
> at org.apache.qpid.pool.Event$ReceivedEvent.process(Event.java:53)
> at org.apache.qpid.pool.Job.processAll(Job.java:80)
> at org.apache.qpid.pool.Job.run(Job.java:102)
> at java.util.concurrent.ThreadPoolExecutor
> $Worker.runTask(ThreadPoolExecutor.java:650)
> at java.util.concurrent.ThreadPoolExecutor
> $Worker.run(ThreadPoolExecutor.java:675)
> at java.lang.Thread.run(Thread.java:595)
> mvn test gives
>
Re: Intermittent failure of org.apache.qpid.test.unit.basic.PropertyValueTest
Posted by Robert Godfrey <ro...@gmail.com>.
Building off trunk I'm also getting
Running org.apache.qpid.test.unit.transacted.CommitRollbackTest
Tests run: 9, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 5.015 sec
<<< FAILURE!
testSend2ThenRollback(
org.apache.qpid.test.unit.transacted.CommitRollbackTest)
Time elapsed: 0.078 sec <<< FAILURE!
junit.framework.ComparisonFailure: expected:<1> but was:<2>
at junit.framework.Assert.assertEquals(Assert.java:81)
at junit.framework.Assert.assertEquals(Assert.java:87)
at
org.apache.qpid.test.unit.transacted.CommitRollbackTest.testSend2ThenRollback
(CommitRollbackTest.java:357)
:-( Also seeing occaisional reference counting errors...
Anyone who has done any recent work on trunk know anything that might be
causing this?
-- Rob
On 06/03/07, Martin Ritchie <ri...@mac.com> wrote:
>
> I have seen this a couple of times as well. It occurs when the
> message reference count goes negative.. which clearly shouldn't
> happen. Guess there is a issue some where with the reference counting.
>
> On 6 Mar 2007, at 20:55, Alan Conway wrote:
>
> > I'm also seeing this failure intermittently. Is someone looking
> > into it?
> > A quick search didn't turn up a JIRA for it. I get the following
> > output
> > at the end of mvn test and then it just hangs:
> >
> > -------------------------------------------------------
> > T E S T S
> > -------------------------------------------------------
> > Running
> > org.apache.qpid.test.unit.client.destinationurl.DestinationURLTest
> > log4j:WARN No appenders could be found for logger
> > (org.apache.qpid.url.AMQBindingURL).
> > log4j:WARN Please initialize the log4j system properly.
> > Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.043
> > sec
> > Running org.apache.qpid.test.unit.basic.PubSubTwoConnectionTest
> > Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.178
> > sec
> > Running org.apache.qpid.test.unit.basic.LargeMessageTest
> > Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.563
> > sec
> > Running org.apache.qpid.test.unit.client.connection.ConnectionTest
> > Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.629
> > sec
> > Running org.apache.qpid.test.unit.transacted.CommitRollbackTest
> > Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.518
> > sec
> > Running org.apache.qpid.test.unit.topic.TopicPublisherTest
> > Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.075
> > sec
> > Running org.apache.qpid.test.unit.basic.MapMessageTest
> > Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.589
> > sec
> > Running org.apache.qpid.test.unit.basic.MultipleConnectionTest
> > Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed:
> > 0.33 sec
> > Running org.apache.qpid.client.DispatcherTest
> > Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.921
> > sec
> > Running org.apache.qpid.test.unit.message.MessageConverterTest
> > Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007
> > sec
> > Running org.apache.qpid.test.unit.client.AMQSessionTest
> > Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.313
> > sec
> > Running org.apache.qpid.test.unit.basic.PropertyValueTest
> > java.lang.Exception: Stack trace
> > at java.lang.Thread.dumpStack(Thread.java:1158)
> > at
> > org.apache.qpid.server.queue.AMQMessage.decrementReference
> > (AMQMessage.java:416)
> > at
> > org.apache.qpid.server.ack.UnacknowledgedMessage.discard
> > (UnacknowledgedMessage.java:66)
> > at
> > org.apache.qpid.server.txn.NonTransactionalContext.acknowledgeMessage(
> > NonTransactionalContext.java:184)
> > at
> > org.apache.qpid.server.ack.UnacknowledgedMessageMapImpl.acknowledgeMes
> > sage(UnacknowledgedMessageMapImpl.java:151)
> > at
> > org.apache.qpid.server.AMQChannel.acknowledgeMessage
> > (AMQChannel.java:763)
> > at
> > org.apache.qpid.server.handler.BasicAckMethodHandler.methodReceived
> > (BasicAckMethodHandler.java:65)
> > at
> > org.apache.qpid.server.state.AMQStateManager.methodReceived
> > (AMQStateManager.java:222)
> > at
> > org.apache.qpid.server.protocol.AMQMinaProtocolSession.methodFrameRece
> > ived(AMQMinaProtocolSession.java:308)
> > at
> > org.apache.qpid.server.protocol.AMQMinaProtocolSession.frameReceived
> > (AMQMinaProtocolSession.java:215)
> > at
> > org.apache.qpid.server.protocol.AMQMinaProtocolSession.dataBlockReceiv
> > ed(AMQMinaProtocolSession.java:193)
> > at
> > org.apache.qpid.server.protocol.AMQPFastProtocolHandler.messageReceive
> > d(AMQPFastProtocolHandler.java:206)
> > at org.apache.mina.common.support.AbstractIoFilterChain
> > $2.messageReceived(AbstractIoFilterChain.java:189)
> > at
> > org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRe
> > ceived(AbstractIoFilterChain.java:502)
> > at org.apache.mina.common.support.AbstractIoFilterChain.access
> > $1000(AbstractIoFilterChain.java:52)
> > at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl
> > $1.messageReceived(AbstractIoFilterChain.java:777)
> > at
> > org.apache.mina.filter.codec.support.SimpleProtocolDecoderOutput.flush
> > (SimpleProtocolDecoderOutput.java:60)
> > at
> > org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived
> > (ProtocolCodecFilter.java:185)
> > at
> > org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRe
> > ceived(AbstractIoFilterChain.java:502)
> > at org.apache.mina.common.support.AbstractIoFilterChain.access
> > $1000(AbstractIoFilterChain.java:52)
> > at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl
> > $1.messageReceived(AbstractIoFilterChain.java:777)
> > at
> > org.apache.qpid.pool.PoolingFilter.messageReceived
> > (PoolingFilter.java:145)
> > at
> > org.apache.mina.filter.ReferenceCountingIoFilter.messageReceived
> > (ReferenceCountingIoFilter.java:96)
> > at
> > org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRe
> > ceived(AbstractIoFilterChain.java:502)
> > at org.apache.mina.common.support.AbstractIoFilterChain.access
> > $1000(AbstractIoFilterChain.java:52)
> > at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl
> > $1.messageReceived(AbstractIoFilterChain.java:777)
> > at org.apache.qpid.pool.Event$ReceivedEvent.process(Event.java:53)
> > at org.apache.qpid.pool.Job.processAll(Job.java:80)
> > at org.apache.qpid.pool.Job.run(Job.java:102)
> > at java.util.concurrent.ThreadPoolExecutor
> > $Worker.runTask(ThreadPoolExecutor.java:650)
> > at java.util.concurrent.ThreadPoolExecutor
> > $Worker.run(ThreadPoolExecutor.java:675)
> > at java.lang.Thread.run(Thread.java:595)
> > mvn test gives
> >
>
>