5 Replies Latest reply on Dec 21, 2007 10:58 AM by adrian.brock

    Exiting on IOE : java.io.InterruptedIOException: Operation i

    vallamkondu

      Hi All

      We are getting below highlighted error when ever I am writing/publishing a serialized message on TOPIC

      We are experiencing this error in our customer box but not on our lab. I suspect the message size, but i am not sure what is the max size Jboss will alow.

      we are using JBOSS-3.2.5 version on sun solaris and we have more than 2GB swap space availble.

      2006-05-26 10:59:37,952 5300714 DEBUG [org.jboss.resource.adapter.jdbc.local.LocalManagedConnectionFactory] (Thread-39:) Using properties: {user=mcmast, password=--hidden--}
      2006-05-26 10:59:38,249 5301011 INFO [STDOUT] (Thread-39:) BatchRequestThread -> Placing MCDataContainer Version 1148659177945 on notification queue
      2006-05-26 10:59:38,249 5301011 DEBUG [org.jboss.mq.referenceable.SpyConnectionFactoryObjectFactory] (Thread-39:) Extracting SpyConnectionFactory from reference
      2006-05-26 10:59:38,264 5301026 DEBUG [org.jboss.mq.referenceable.SpyConnectionFactoryObjectFactory] (Thread-39:) The GenericConnectionFactory is: GenericConnectionFactory[server=org.jboss.mq.il.uil2.UILServerIL@908f05 connectionProperties={UIL_ADDRESS_KEY=97.60.20.41, UIL_CHUNKSIZE_KEY=1000000, UIL_TCPNODELAY_KEY=yes, ClientILService=org.jboss.mq.il.uil2.UILClientILService, UIL_PORT_KEY=8093, UIL_BUFFERSIZE_KEY=2048, PingPeriod=60000}]
      2006-05-26 10:59:38,265 5301027 DEBUG [org.jboss.mq.referenceable.SpyDestinationObjectFactory] (Thread-39:) SpyDestinationObjectFactory->getObjectInstance()
      2006-05-26 10:59:38,266 5301028 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.ReadTask#5 client=97.60.20.41:8093:) Begin ReadTask.run
      2006-05-26 10:59:38,266 5301028 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.ReadTask#6 client=97.60.20.41:33064:) Begin ReadTask.run
      2006-05-26 10:59:38,267 5301029 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.WriteTask#8 client=97.60.20.41:33064:) Begin WriteTask.run
      2006-05-26 10:59:38,267 5301029 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.WriteTask#8 client=97.60.20.41:33064:) Created ObjectOutputStream
      2006-05-26 10:59:38,267 5301029 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.WriteTask#7 client=97.60.20.41:8093:) Begin WriteTask.run
      2006-05-26 10:59:38,267 5301029 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.WriteTask#7 client=97.60.20.41:8093:) Created ObjectOutputStream
      2006-05-26 10:59:38,268 5301030 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.ReadTask#6 client=97.60.20.41:33064:) Created ObjectInputStream
      2006-05-26 10:59:38,270 5301032 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.ReadTask#5 client=97.60.20.41:8093:) Created ObjectInputStream
      2006-05-26 10:59:38,271 5301033 DEBUG [org.jboss.mq.il.uil2.UILClientILService] (Thread-39:) Starting
      2006-05-26 10:59:38,275 5301037 DEBUG [org.jboss.mq.il.uil2.ServerSocketManagerHandler] (Thread-42:) Setting up the UILClientIL Connection
      2006-05-26 10:59:38,275 5301037 DEBUG [org.jboss.mq.il.uil2.ServerSocketManagerHandler] (Thread-42:) The UILClientIL Connection is set up
      2006-05-26 10:59:38,481 5301243 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.WriteTask#8 client=97.60.20.41:33064:) End WriteTask.run

      2006-05-26 10:59:38,481 5301243 DEBUG [org.jboss.mq.il.uil2.ServerSocketManagerHandler] UIL2.SocketManager.ReadTask#6 client=97.60.20.41:33064:) Exiting on IOEjava.io.InterruptedIOException: Operation interrupted
      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)
      at org.jboss.util.stream.NotifyingBufferedInputStream.read(NotifyingBufferedInputStream.java:67)
      at java.io.ObjectInputStream$PeekInputStream.peek(ObjectInputStream.java:2133)
      at java.io.ObjectInputStream$BlockDataInputStream.readBlockHeader(ObjectInputStream.java:2313)
      at java.io.ObjectInputStream$BlockDataInputStream.refill(ObjectInputStream.java:2380)
      at java.io.ObjectInputStream$BlockDataInputStream.read(ObjectInputStream.java:2452)
      at java.io.ObjectInputStream$BlockDataInputStream.readByte(ObjectInputStream.java:2601)
      at java.io.ObjectInputStream.readByte(ObjectInputStream.java:845)
      at org.jboss.mq.il.uil2.SocketManager$ReadTask.run(SocketManager.java:279)
      at java.lang.Thread.run(Thread.java:534)

      2006-05-26 10:59:38,482 5301244 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.WriteTask#7 client=97.60.20.41:8093:) End WriteTask.run
      2006-05-26 10:59:38,482 5301244 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.ReadTask#6 client=97.60.20.41:33064:) End ReadTask.run
      2006-05-26 10:59:38,481 5301243 DEBUG [org.jboss.mq.il.uil2.UILClientILService] (Thread-39:) Stopping
      2006-05-26 10:59:38,482 5301244 DEBUG [org.jboss.mq.il.uil2.SocketManager] (UIL2.SocketManager.ReadTask#5 client=97.60.20.41:8093:) End ReadTask.run
      2006-05-26 10:59:38,482 5301244 INFO [STDOUT] (Thread-39:) BatchRequestThread -> Placed MCDataContainer Version 1148659177945 on notification queue



      Thanks in advance...

      Ram Vallamkondu

        • 1. Re: Exiting on IOE : java.io.InterruptedIOException: Operati
          genman

          DEBUG

          • 2. Re: Exiting on IOE : java.io.InterruptedIOException: Operati
            vallamkondu

            Genman,

            Yes, it?s a DEBUG Message but the message is not delivered to listeners at all.
            I see this debug exception only when i write / publish the message on topic & and I can?t ignore this message as it not delivered to other applications / listeners.

            Thanks
            Ram

            • 3. Re: Exiting on IOE : java.io.InterruptedIOException: Operati

              I encounter similar problem in our MDB onMessage. The mode is auto-acknowlegde and the destination is Queue. During process the message, I got the similar exception, but the message is finished processing and return correctly, but JBOSS/JMS somehow redelivered the same message again to our application.

              Do anybody have the same problem?

              [org.jboss.mq.referenceable.SpyDestinationObjectFactory] SpyDestinationObjectFactory->getObjectInstance()
              2006-06-15 14:43:25,165 DEBUG [org.jboss.mq.referenceable.SpyConnectionFactoryObjectFactory] Extracting SpyConnectionFactory from reference
              2006-06-15 14:43:25,167 DEBUG [org.jboss.mq.referenceable.SpyConnectionFactoryObjectFactory] The GenericConnectionFactory is: GenericConnectionFactory[server=org.jboss.mq.il.uil2.UILServerIL@13579e0 connectionProperties={UIL_PORT_KEY=8093, ClientILService=org.jboss.mq.il.uil2.UILClientILService, UIL_ADDRESS_KEY=10.31.76.203, UIL_TCPNODELAY_KEY=yes, PingPeriod=60000, UIL_CHUNKSIZE_KEY=1000000, UIL_RECEIVE_REPLIES_KEY=No, UIL_BUFFERSIZE_KEY=2048}]
              2006-06-15 14:43:25,169 DEBUG [org.jboss.mq.il.uil2.SocketManager] Begin WriteTask.run
              2006-06-15 14:43:25,169 DEBUG [org.jboss.mq.il.uil2.SocketManager] Begin WriteTask.run
              2006-06-15 14:43:25,170 DEBUG [org.jboss.mq.il.uil2.SocketManager] Begin ReadTask.run
              2006-06-15 14:43:25,170 DEBUG [org.jboss.mq.il.uil2.SocketManager] Created ObjectOutputStream
              2006-06-15 14:43:25,170 DEBUG [org.jboss.mq.il.uil2.SocketManager] Begin ReadTask.run
              2006-06-15 14:43:25,170 DEBUG [org.jboss.mq.il.uil2.SocketManager] Created ObjectOutputStream
              2006-06-15 14:43:25,170 DEBUG [org.jboss.mq.il.uil2.SocketManager] Created ObjectInputStream
              2006-06-15 14:43:25,172 DEBUG [org.jboss.mq.il.uil2.SocketManager] Created ObjectInputStream
              2006-06-15 14:43:25,173 DEBUG [org.jboss.mq.il.uil2.UILClientILService] Starting
              2006-06-15 14:43:25,174 DEBUG [org.jboss.mq.il.uil2.ServerSocketManagerHandler] Setting up the UILClientIL Connection
              2006-06-15 14:43:25,174 DEBUG [org.jboss.mq.il.uil2.ServerSocketManagerHandler] The UILClientIL Connection is set up
              2006-06-15 14:43:25,234 DEBUG [org.jboss.mq.il.uil2.SocketManager] End WriteTask.run
              2006-06-15 14:43:25,234 DEBUG [org.jboss.mq.il.uil2.SocketManager] End ReadTask.run
              2006-06-15 14:43:25,235 DEBUG [org.jboss.mq.il.uil2.ServerSocketManagerHandler] Exiting on IOE
              java.io.InterruptedIOException: Operation interrupted
              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)
              at org.jboss.util.stream.NotifyingBufferedInputStream.read(NotifyingBufferedInputStream.java:67)
              at java.io.ObjectInputStream$PeekInputStream.peek(ObjectInputStream.java:2133)
              at java.io.ObjectInputStream$BlockDataInputStream.readBlockHeader(ObjectInputStream.java:2313)
              at java.io.ObjectInputStream$BlockDataInputStream.refill(ObjectInputStream.java:2380)
              at java.io.ObjectInputStream$BlockDataInputStream.read(ObjectInputStream.java:2452)
              at java.io.ObjectInputStream$BlockDataInputStream.readByte(ObjectInputStream.java:2601)
              at java.io.ObjectInputStream.readByte(ObjectInputStream.java:845)
              at org.jboss.mq.il.uil2.SocketManager$ReadTask.run(SocketManager.java:290)
              at java.lang.Thread.run(Thread.java:534)
              2006-06-15 14:43:25,235 DEBUG [org.jboss.mq.il.uil2.SocketManager] End WriteTask.run
              2006-06-15 14:43:25,250 DEBUG [org.jboss.mq.il.uil2.SocketManager] End ReadTask.run
              2006-06-15 14:43:25,235 DEBUG [org.jboss.mq.il.uil2.UILClientILService] Stopping
              2006-06-15 14:43:40,742 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
              2006-06-15 14:46:40,233 DEBUG [org.jboss.mq.referenceable.SpyConnectionFactoryObjectFactory] Extracting SpyConnectionFactory from reference
              2006-06-15 14:46:40,236 DEBUG [org.jboss.mq.referenceable.SpyConnectionFactoryObjectFactory] The GenericConnectionFactory is: GenericConnectionFactory[server=org.jboss.mq.il.uil2.UILServerIL@137d9b1 connectionProperties={UIL_PORT_KEY=8093, ClientILService=org.jboss.mq.il.uil2.UILClientILService, UIL_ADDRESS_KEY=10.31.76.203, UIL_TCPNODELAY_KEY=yes, PingPeriod=60000, UIL_CHUNKSIZE_KEY=1000000, UIL_RECEIVE_REPLIES_KEY=No, UIL_BUFFERSIZE_KEY=2048}]
              2006-06-15 14:46:40,237 DEBUG [org.jboss.mq.il.uil2.SocketManager] Begin ReadTask.run
              2006-06-15 14:46:40,237 DEBUG [org.jboss.mq.il.uil2.SocketManager] Begin WriteTask.run
              2006-06-15 14:46:40,238 DEBUG [org.jboss.mq.il.uil2.SocketManager] Begin ReadTask.run
              2006-06-15 14:46:40,238 DEBUG [org.jboss.mq.il.uil2.SocketManager] Created ObjectOutputStream
              2006-06-15 14:46:40,238 DEBUG [org.jboss.mq.il.uil2.SocketManager] Begin WriteTask.run
              2006-06-15 14:46:40,238 DEBUG [org.jboss.mq.il.uil2.SocketManager] Created ObjectInputStream
              2006-06-15 14:46:40,238 DEBUG [org.jboss.mq.il.uil2.SocketManager] Created ObjectOutputStream
              2006-06-15 14:46:40,240 DEBUG [org.jboss.mq.il.uil2.SocketManager] Created ObjectInputStream
              2006-06-15 14:46:40,240 DEBUG [org.jboss.mq.il.uil2.UILClientILService] Starting
              2006-06-15 14:46:40,241 DEBUG [org.jboss.mq.il.uil2.ServerSocketManagerHandler] Setting up the UILClientIL Connection
              2006-06-15 14:46:40,241 DEBUG [org.jboss.mq.il.uil2.ServerSocketManagerHandler] The UILClientIL Connection is set up
              2006-06-15 14:46:40,272 DEBUG [org.jboss.mq.referenceable.SpyDestinationObjectFactory] SpyDestinationObjectFactory->getObjectInstance()

              • 4. Re: Exiting on IOE : java.io.InterruptedIOException: Operati
                kenubie

                Anyone knows the solution to the original post ?
                Does not seem like there was a solution?

                • 5. Re: Exiting on IOE : java.io.InterruptedIOException: Operati

                   

                  "kenubie" wrote:
                  Anyone knows the solution to the original post ?
                  Does not seem like there was a solution?


                  That because there is no problem. :-)
                  For the 10,000th time DEBUG != ERROR

                  Connection c = ConnectionFactory.createConnection(); // => DEBUG messages about connection construction
                  try
                  {
                   // do stuff
                  }
                  finally
                  {
                   c.close(); // => DEBUG messages about connection close (including IO/interrupted, etc)
                  }
                  


                  Now if you got an I/O execption when you didn't close the connection
                  then there might be problem, e.g. I/O read timeout => network split.
                  That's why the message is logged at DEBUG.