1 2 Previous Next 18 Replies Latest reply on Apr 20, 2004 9:58 AM by norrin88

    JMS appears to hang

    moppersmurf Newbie

      Hi,

      We're using jboss 3.2.2 and depend heavily on JMS.

      A request is received by a session bean which sends it to a topic, a MDB does some things and sends a message to a queue. Another MDB gets this message, also does some things and returns it.

      After approx. 1000-2000 requests JMS appears to hang (and therefore the entire system). After up to a few minutes the system continues and messages like below appear in the logfile.

      13:59:48,456 DEBUG [Test] publishing
      13:59:48,862 DEBUG [Test] publishing
      ...
      WARN [org.jboss.tm.TransactionImpl] Transaction TransactionImpl:XidImpl [FormatId=257, GlobalId=test-dev//283915, BranchQual=] timed out. status=STATUS_ACTIVE
      ....
      12:59:49,109 ERROR [BeanLock] Saw rolled back tx=TransactionImpl:XidImpl [FormatId=257, GlobalId=test//252465, BranchQual=]
      ...
      12:59:49,109 ERROR [LogInterceptor] TransactionRolledbackException in method: public abstract Logging LoggingHome.create(java.lang.String,java.lang.String,java.lang.String) throws javax.ejb.CreateException,java.rmi.RemoteException, causedBy:
      java.lang.RuntimeException: Transaction marked for rollback, possibly a timeout
      ...
      13:03:44,562 DEBUG [Test] published
      13:03:44,563 DEBUG [Test] published

      After these warnings and errors the JMS goes on and messages are published. As you can see it took about 4 minutes for the messages to get published. Both messages sent to the topic and the queue are 'hanging' so it appear JMS is hanging.


      Anyone any idea?

        • 1. Re: JMS appears to hang
          moppersmurf Newbie

          Btw it is running on:
          Windows 2000
          j2sdk 1.4.2_03
          the messages are non-persistent

          • 2. Re: JMS appears to hang
            moppersmurf Newbie

            Dump (small part)

            Full thread dump Java HotSpot(TM) Client VM (1.4.2_03-b02 mixed mode):

            "RMI ConnectionExpiration-[192.168.25.32:4444]" daemon prio=5 tid=0x037b9a28 nid=0x72c waiting on condition [ac7f000..ac7fd88]
            at java.lang.Thread.sleep(Native Method)
            at sun.rmi.transport.tcp.TCPChannel$Reaper.run(TCPChannel.java:447)
            at java.lang.Thread.run(Thread.java:534)

            "RMI TCP Connection(123)-192.168.25.32" daemon prio=5 tid=0x035a2410 nid=0x1bac runnable [ac3f000..ac3fd88]
            at java.net.SocketInputStream.socketRead0(Native Method)
            at java.net.SocketInputStream.read(SocketInputStream.java:129)
            at java.io.BufferedInputStream.fill(BufferedInputStream.java:183)
            at java.io.BufferedInputStream.read(BufferedInputStream.java:201)
            - locked <0x10014af0> (a java.io.BufferedInputStream)
            at java.io.FilterInputStream.read(FilterInputStream.java:66)
            at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:442)
            at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:701)
            at java.lang.Thread.run(Thread.java:534)

            "JNP Server" prio=5 tid=0x081c1ca8 nid=0x1bd0 runnable [abbf000..abbfd88]
            at java.net.PlainSocketImpl.socketAccept(Native Method)
            at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:353)
            - locked <0x17771018> (a java.net.PlainSocketImpl)
            at java.net.ServerSocket.implAccept(ServerSocket.java:448)
            at java.net.ServerSocket.accept(ServerSocket.java:419)
            at org.jnp.server.Main.run(Main.java:281)
            at java.lang.Thread.run(Thread.java:534)

            "RMI RenewClean-[192.168.25.32:1098]" daemon prio=5 tid=0x035cbd50 nid=0x1b28 in Object.wait() [a97f000..a97fd88]
            at java.lang.Object.wait(Native Method)
            at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
            - locked <0x1b83b3c0> (a java.lang.ref.ReferenceQueue$Lock)
            at sun.rmi.transport.DGCClient$EndpointEntry$RenewCleanThread.run(DGCClient.java:500)
            at java.lang.Thread.run(Thread.java:534)

            "Thread Pool Worker-31" prio=5 tid=0x037d2178 nid=0x9a0 waiting for monitor entry [68df000..68dfd88]
            at org.jboss.mq.server.MessageCache.validateSoftReferenceDepth(MessageCache.java:271)
            - waiting to lock <0x17a9da40> (a org.jboss.mq.server.MessageCache$LRUCache)
            ... - locked <0x180cc3a0> (a java.util.LinkedList)
            at org.jboss.jms.asf.StdServerSession.run(StdServerSession.java:180)
            at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:732)
            at java.lang.Thread.run(Thread.java:534)

            "OILClientILService-12" daemon prio=5 tid=0x037aca60 nid=0x1b74 runnable [600f000..600fd88]
            at java.net.SocketInputStream.socketRead0(Native Method)
            at java.net.SocketInputStream.read(SocketInputStream.java:129)
            at java.io.BufferedInputStream.fill(BufferedInputStream.java:183)
            at java.io.BufferedInputStream.read(BufferedInputStream.java:201)
            - locked <0x18e85358> (a java.io.BufferedInputStream)
            ... at java.lang.Thread.run(Thread.java:534)

            etc

            • 3. Re: JMS appears to hang
              moppersmurf Newbie

              When i log the mq the following lines keep repeating for thousands of times:

              ...........
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=1.0
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] Need to soften 2 messages
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock acquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] makeSoft lock aquire 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageReference] saveToStorage rejected by cache 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] soften lock release 4268 msg=8250 hard NOT_STORED PERSISTENT queue=QUEUE.testQueue priority=4 hashCode=12569355
              2004-03-26 18:20:03,937 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth

              .........

              • 4. Re: JMS appears to hang
                Adrian Brock Master

                This was a known bug with 3.2.2, try 3.2.3

                If you have configured the MessageCache to aggressively soften it can
                thrash trying to soften persistent messages that don't need to be softened.

                Regards,
                Adrian

                • 5. Re: JMS appears to hang
                  moppersmurf Newbie

                   

                  "adrian@jboss.org" wrote:
                  This was a known bug with 3.2.2, try 3.2.3

                  If you have configured the MessageCache to aggressively soften it can
                  thrash trying to soften persistent messages that don't need to be softened.

                  Regards,
                  Adrian


                  Thanks. We're installing 3.2.3 right now


                  • 6. Re: JMS appears to hang
                    norrin88 Newbie

                    Hi all

                    Well, I'm using the 3.2.3 version of JBoss and I'm experiencing the same

                    ... msg=whatever hard NOT_STORED PERSISTENT queue=QUEUE.testQueue...

                    problems. It only happens when a lot of messages have been sent to the queue. Is there any workaround for this? (apart from disabling messaging, of course)

                    Best regards,
                    Juanma

                    • 7. Re: JMS appears to hang
                      Adrian Brock Master

                      Post the log.

                      Regards,
                      Adrian

                      • 8. Re: JMS appears to hang
                        norrin88 Newbie

                        Ok, here it is:

                        2004-04-01 17:48:04,383 WARN [org.jboss.mq.il.oil.OILServerILService] Client request resulted in a server exception:
                        org.jboss.mq.SpyJMSException: Could not store message: 1521 msg=1520 hard NOT_STORED PERSISTENT queue=TOPIC.Logger.ID:1.-2147483648 priority=4 hashCode=8647660; - nested throwable: (java.sql.SQLException: Invalid argument value, message from server: "Duplicate entry '1520-TOPIC.Logger.ID:1.-2147483648' for key 1")
                        at org.jboss.mq.pm.jdbc2.PersistenceManager.saveToStorage(PersistenceManager.java:1224)
                        at org.jboss.mq.server.MessageCache.saveToStorage(MessageCache.java:393)
                        at org.jboss.mq.server.MessageReference.makeSoft(MessageReference.java:250)
                        at org.jboss.mq.server.MessageCache.validateSoftReferenceDepth(MessageCache.java:328)
                        at org.jboss.mq.server.MessageCache.addInternal(MessageCache.java:127)
                        at org.jboss.mq.server.MessageCache.add(MessageCache.java:97)
                        at org.jboss.mq.server.JMSTopic.addMessage(JMSTopic.java:364)
                        at org.jboss.mq.server.JMSDestinationManager.addMessage(JMSDestinationManager.java:407)
                        at org.jboss.mq.server.JMSDestinationManager.addMessage(JMSDestinationManager.java:383)
                        at org.jboss.mq.server.JMSServerInterceptorSupport.addMessage(JMSServerInterceptorSupport.java:136)
                        at org.jboss.mq.security.ServerSecurityInterceptor.addMessage(ServerSecurityInterceptor.java:162)
                        at org.jboss.mq.server.TracingInterceptor.addMessage(TracingInterceptor.java:270)
                        at org.jboss.mq.server.JMSServerInvoker.addMessage(JMSServerInvoker.java:136)
                        at org.jboss.mq.il.oil.OILServerILService$Client.run(OILServerILService.java:249)
                        at java.lang.Thread.run(Thread.java:534)
                        Caused by: java.sql.SQLException: Invalid argument value, message from server: "Duplicate entry '1520-TOPIC.Logger.ID:1.-2147483648' for key 1"
                        at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:1876)
                        at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:1098)
                        at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:1192)
                        at com.mysql.jdbc.Connection.execSQL(Connection.java:2051)
                        at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:1680)
                        at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:1527)
                        at org.jboss.resource.adapter.jdbc.WrappedPreparedStatement.executeUpdate(WrappedPreparedStatement.java:324)
                        at org.jboss.mq.pm.jdbc2.PersistenceManager.add(PersistenceManager.java:783)
                        at org.jboss.mq.pm.jdbc2.PersistenceManager.saveToStorage(PersistenceManager.java:1210)
                        ... 14 more
                        2004-04-01 17:48:04,445 ERROR [STDERR] org.jboss.mq.SpyJMSException: Could not store message: 1521 msg=1520 hard NOT_STORED PERSISTENT queue=TOPIC.Logger.ID:1.-2147483648 priority=4 hashCode=8647660; - nested throwable: (java.sql.SQLException: Invalid argument value, message from server: "Duplicate entry '1520-TOPIC.Logger.ID:1.-2147483648' for key 1")
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.pm.jdbc2.PersistenceManager.saveToStorage(PersistenceManager.java:1224)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.MessageCache.saveToStorage(MessageCache.java:393)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.MessageReference.makeSoft(MessageReference.java:250)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.MessageCache.validateSoftReferenceDepth(MessageCache.java:328)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.MessageCache.addInternal(MessageCache.java:127)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.MessageCache.add(MessageCache.java:97)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.JMSTopic.addMessage(JMSTopic.java:364)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.JMSDestinationManager.addMessage(JMSDestinationManager.java:407)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.JMSDestinationManager.addMessage(JMSDestinationManager.java:383)
                        2004-04-01 17:48:04,446 ERROR [STDERR] at org.jboss.mq.server.JMSServerInterceptorSupport.addMessage(JMSServerInterceptorSupport.java:136)
                        2004-04-01 17:48:04,447 ERROR [STDERR] at org.jboss.mq.security.ServerSecurityInterceptor.addMessage(ServerSecurityInterceptor.java:162)
                        2004-04-01 17:48:04,447 ERROR [STDERR] at org.jboss.mq.server.TracingInterceptor.addMessage(TracingInterceptor.java:270)
                        2004-04-01 17:48:04,447 ERROR [STDERR] at org.jboss.mq.server.JMSServerInvoker.addMessage(JMSServerInvoker.java:136)
                        2004-04-01 17:48:04,447 ERROR [STDERR] at org.jboss.mq.il.oil.OILServerILService$Client.run(OILServerILService.java:249)
                        2004-04-01 17:48:04,447 ERROR [STDERR] at java.lang.Thread.run(Thread.java:534)
                        2004-04-01 17:48:04,447 ERROR [STDERR] Caused by: java.sql.SQLException: Invalid argument value, message from server: "Duplicate entry '1520-TOPIC.Logger.ID:1.-2147483648' for key 1"
                        2004-04-01 17:48:04,467 ERROR [STDERR] at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:1876)
                        2004-04-01 17:48:04,467 ERROR [STDERR] at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:1098)
                        2004-04-01 17:48:04,467 ERROR [STDERR] at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:1192)
                        2004-04-01 17:48:04,467 ERROR [STDERR] at com.mysql.jdbc.Connection.execSQL(Connection.java:2051)
                        2004-04-01 17:48:04,467 ERROR [STDERR] at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:1680)
                        2004-04-01 17:48:04,467 ERROR [STDERR] at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:1527)
                        2004-04-01 17:48:04,467 ERROR [STDERR] at org.jboss.resource.adapter.jdbc.WrappedPreparedStatement.executeUpdate(WrappedPreparedStatement.java:324)
                        2004-04-01 17:48:04,467 ERROR [STDERR] at org.jboss.mq.pm.jdbc2.PersistenceManager.add(PersistenceManager.java:783)
                        2004-04-01 17:48:04,468 ERROR [STDERR] at org.jboss.mq.pm.jdbc2.PersistenceManager.saveToStorage(PersistenceManager.java:1210)
                        2004-04-01 17:48:04,468 ERROR [STDERR] ... 14 more


                        Then, again the same sequence of warnings and errors, although the mext message which cannot be stored has id 1532.

                        What's happening?

                        Regards,

                        Juanma

                        • 9. Re: JMS appears to hang
                          norrin88 Newbie

                          No answers? So I assume that once again a jboss module doesn't work under heavy requirements. So the only workaround is disabling messaging.

                          Awesome.

                          • 10. Re: JMS appears to hang
                            Adrian Brock Master

                            FLAME BAIT will get you nowhere on free forums.

                            You got ignored because this is not your thread.
                            You have hijacked somebody else's thread.

                            Here's a link to help you understand how free forums work.
                            http://www.catb.org/~esr/faqs/smart-questions.html

                            To (not) answer your question, use search.
                            This question was answered recently, it relates to two JBoss instances
                            trying to share the same JMS tables.

                            Regards,
                            Adrian

                            • 11. Re: JMS appears to hang
                              norrin88 Newbie

                              Hi again

                              Well, I already read your smart URL the previous time I posted a question. In fact, this is the only forum in the world where I am having this sort of troubles. I asked my psychiatrist whether my personality is getting too strong to write in forums, but he told me that I'm ok. After reading some other threads I realize that it's necessary to have got a way with posts in order to get something other than raw answers from the jboss gurus...

                              By the way, I started a separate thread of my own about this problem, but it has strangely vanished. Sorry if I hijacked someone's thread, but, at the problem keeps unsolved, I found it logic. And I have also looked for a existing thread with a solution, and I found one, but the thread was expired or something, because I only got a blank page with "/thread.jsp" and nothing else.

                              So please, my kind question is, would you please provide me a working link to the solution?

                              Thanks.

                              Best regards,
                              Juanma


                              PS. I have already borrowed 7 o 8 netiquette tutorials and almost end memoryzing the http://www.catb.org/~esr/faqs/smart-questions.html content. I don't trust my psychiatrist, it has to be my fault...

                              • 12. Re: JMS appears to hang
                                norrin88 Newbie

                                When I said "at the problem keeps unsolved" I mean to say
                                "since the problem keeps unsolved".

                                Sorry.

                                • 13. Re: JMS appears to hang
                                  Gokturk Ozer Newbie

                                  I was having a similar problem. JMS was hanging with the same warning message. I think the difference with the original post is that my persistent store is oracle. I solved my problem by changing the type of MESSAGEBLOB to LONG RAW. Most likely oracle thin driver has some issues with BLOB type when message size gets bigger, it was working fine with messages with small size.

                                  • 14. Re: JMS appears to hang
                                    norrin88 Newbie

                                    Hello, gokTurk

                                    Well, in my case I'm using MySQL and the size of the messages is always the same. So I don't understand why I get this error only a while after publishing/getting messages. Nevertheless, I'll give a try to your workaround, since as you can see no one at JBoss is able to provide an answer (even although I posted the log). Disabling messaging seems to be the only solution for me (and for everyone with similar problems; I couldn't find a working thread with a solution, but many with the same problem).

                                    Many thanks, gokTurk

                                    Best regards,
                                    Juanma

                                    1 2 Previous Next