org.apache.axis2.transport.jms.AxisJMSException: Error acquiring a JMS connection to : QueueConnectionFactory using JNDI properties : {java.naming.factory.initial=org.apache.qpid.jndi.PropertiesFileInitialContextFactory, transport.jms.Password=admin, java.naming.provider.url=repository/conf/csg-qpid.properties, transport.jms.ConnectionFactory=SimpleStockQuoteServiceQueueConnectionFactory, transport.jms.UserName=admin, transport.jms.ConnectionFactoryType=queue, ServiceClass=samples.services.SimpleStockQuoteService}

incubator-qpid-users | Rajika Kumarasiri | 6 years ago
  1. 0

    Timed out occurs when connecting to Java broker over SSL

    incubator-qpid-users | 6 years ago | Rajika Kumarasiri
    org.apache.axis2.transport.jms.AxisJMSException: Error acquiring a JMS connection to : QueueConnectionFactory using JNDI properties : {java.naming.factory.initial=org.apache.qpid.jndi.PropertiesFileInitialContextFactory, transport.jms.Password=admin, java.naming.provider.url=repository/conf/csg-qpid.properties, transport.jms.ConnectionFactory=SimpleStockQuoteServiceQueueConnectionFactory, transport.jms.UserName=admin, transport.jms.ConnectionFactoryType=queue, ServiceClass=samples.services.SimpleStockQuoteService}
  2. 0

    Timed out occurs when connecting to Java broker over SSL

    qpid-users | 6 years ago | Rajika Kumarasiri
    org.apache.axis2.transport.jms.AxisJMSException: Error acquiring a JMS connection to : QueueConnectionFactory using JNDI properties : {java.naming.factory.initial=org.apache.qpid.jndi.PropertiesFileInitialContextFactory, transport.jms.Password=admin, java.naming.provider.url=repository/conf/csg-qpid.properties, transport.jms.ConnectionFactory=SimpleStockQuoteServiceQueueConnectionFactory, transport.jms.UserName=admin, transport.jms.ConnectionFactoryType=queue, ServiceClass=samples.services.SimpleStockQuoteService}
  3. 0

    If an IoSender#send suffers a timeout (IoSender.java#159) whilst awaiting space in the sender's buffer, the socket which was being written to is left open and a SenderException is thrown to the caller. The bytes that were to be sent are lost. If the socket is subsequent written to again, the peer may suffer an AMQFrameDecodingException as is tries to decode an incomplete stream of data. We saw this scenario in a support call. The working theory is that the application'sJVM (using a JMS consumer) was under pressue, and this caused TCP/IP back pressure to be felt by the broker. The Broker IoSender#send method timed-out, but as the socket remained open, when a later message was sent to the same JMS consumer application, the consuming application failed with an AMQFrameDecodingException: the lost bytes meant it tried to process message payload as if it were an AMQFrame. The two exceptions of interest are (reproduced on trunk): Broker side: {code} 2013-10-31 14:41:18,471 ERROR [IoReceiver - /127.0.0.1:63867] (v0_8.AMQProtocolEngine) - Error informing channel that receiving is complete. Channel: [/127.0.0.1:63867(guest):1]org.apache.qpid.transport.SenderException: write timed out: -2147471360, -2147475456 at org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:159) at org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:40) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.writeFrame(AMQProtocolEngine.java:689) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeFrame(ProtocolOutputConverterImpl.java:337) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDelivery(ProtocolOutputConverterImpl.java:127) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDelivery(ProtocolOutputConverterImpl.java:97) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeDeliver(ProtocolOutputConverterImpl.java:72) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine$WriteDeliverMethod.deliverToClient(AMQProtocolEngine.java:1679) at org.apache.qpid.server.protocol.v0_8.SubscriptionImpl.sendToClient(SubscriptionImpl.java:693) at org.apache.qpid.server.protocol.v0_8.SubscriptionImpl$AckSubscription.send(SubscriptionImpl.java:303) at org.apache.qpid.server.queue.SimpleAMQQueue.deliverMessage(SimpleAMQQueue.java:826) at org.apache.qpid.server.queue.SimpleAMQQueue.deliverToSubscription(SimpleAMQQueue.java:745) at org.apache.qpid.server.queue.SimpleAMQQueue.enqueue(SimpleAMQQueue.java:693) at org.apache.qpid.server.protocol.v0_8.AMQChannel$MessageDeliveryAction.postCommit(AMQChannel.java:1245) at org.apache.qpid.server.protocol.v0_8.AMQChannel$AsyncCommand.complete(AMQChannel.java:1623) at org.apache.qpid.server.protocol.v0_8.AMQChannel.sync(AMQChannel.java:1593) at org.apache.qpid.server.protocol.v0_8.AMQChannel.receivedComplete(AMQChannel.java:218) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.receivedComplete(AMQProtocolEngine.java:324) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.received(AMQProtocolEngine.java:304) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.received(AMQProtocolEngine.java:104) at org.apache.qpid.server.protocol.MultiVersionProtocolEngine.received(MultiVersionProtocolEngine.java:131) at org.apache.qpid.server.protocol.MultiVersionProtocolEngine.received(MultiVersionProtocolEngine.java:47) at org.apache.qpid.transport.network.io.IoReceiver.run(IoReceiver.java:161) at java.lang.Thread.run(Thread.java:662) {code} Then later client side: {code} 2013-10-31 14:47:49,099 DEBUG [Dispatcher-1-Conn-1] [Dispatcher] Dispatcher-1-Conn-1 thread terminating for channel 1:org.apache.qpid.client.AMQSession_0_8@560932fe javax.jms.JMSException: Message consumer forcibly closed due to error: org.apache.qpid.framing.AMQFrameDecodingException: End of frame marker not found. Read 53 length=65527 type=3 at org.apache.qpid.client.BasicMessageConsumer.returnMessageOrThrow(BasicMessageConsumer.java:531) at org.apache.qpid.client.BasicMessageConsumer.receive(BasicMessageConsumer.java:419) at org.apache.qpid.client.BasicMessageConsumer.receive(BasicMessageConsumer.java:393) at org.apache.qpid.example.Hello.runTest(Hello.java:60) at org.apache.qpid.example.Hello.main(Hello.java:40) Caused by: org.apache.qpid.framing.AMQFrameDecodingException: End of frame marker not found. Read 53 length=65527 type=3 at org.apache.qpid.framing.AMQDataBlockDecoder.createAndPopulateFrame(AMQDataBlockDecoder.java:104) at org.apache.qpid.codec.AMQDecoder.decodeBuffer(AMQDecoder.java:250) at org.apache.qpid.client.protocol.AMQProtocolHandler.received(AMQProtocolHandler.java:451) at org.apache.qpid.client.protocol.AMQProtocolHandler.received(AMQProtocolHandler.java:1) at org.apache.qpid.transport.network.io.IoReceiver.run(IoReceiver.java:161) at java.lang.Thread.run(Thread.java:662) {code}

    Apache's JIRA Issue Tracker | 3 years ago | Keith Wall
    org.apache.qpid.transport.SenderException: write timed out: -2147471360, -2147475456
  4. Speed up your debug routine!

    Automated exception search integrated into your IDE

  5. 0

    If an IoSender#send suffers a timeout (IoSender.java#159) whilst awaiting space in the sender's buffer, the socket which was being written to is left open and a SenderException is thrown to the caller. The bytes that were to be sent are lost. If the socket is subsequent written to again, the peer may suffer an AMQFrameDecodingException as is tries to decode an incomplete stream of data. We saw this scenario in a support call. The working theory is that the application'sJVM (using a JMS consumer) was under pressue, and this caused TCP/IP back pressure to be felt by the broker. The Broker IoSender#send method timed-out, but as the socket remained open, when a later message was sent to the same JMS consumer application, the consuming application failed with an AMQFrameDecodingException: the lost bytes meant it tried to process message payload as if it were an AMQFrame. The two exceptions of interest are (reproduced on trunk): Broker side: {code} 2013-10-31 14:41:18,471 ERROR [IoReceiver - /127.0.0.1:63867] (v0_8.AMQProtocolEngine) - Error informing channel that receiving is complete. Channel: [/127.0.0.1:63867(guest):1]org.apache.qpid.transport.SenderException: write timed out: -2147471360, -2147475456 at org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:159) at org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:40) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.writeFrame(AMQProtocolEngine.java:689) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeFrame(ProtocolOutputConverterImpl.java:337) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDelivery(ProtocolOutputConverterImpl.java:127) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDelivery(ProtocolOutputConverterImpl.java:97) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeDeliver(ProtocolOutputConverterImpl.java:72) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine$WriteDeliverMethod.deliverToClient(AMQProtocolEngine.java:1679) at org.apache.qpid.server.protocol.v0_8.SubscriptionImpl.sendToClient(SubscriptionImpl.java:693) at org.apache.qpid.server.protocol.v0_8.SubscriptionImpl$AckSubscription.send(SubscriptionImpl.java:303) at org.apache.qpid.server.queue.SimpleAMQQueue.deliverMessage(SimpleAMQQueue.java:826) at org.apache.qpid.server.queue.SimpleAMQQueue.deliverToSubscription(SimpleAMQQueue.java:745) at org.apache.qpid.server.queue.SimpleAMQQueue.enqueue(SimpleAMQQueue.java:693) at org.apache.qpid.server.protocol.v0_8.AMQChannel$MessageDeliveryAction.postCommit(AMQChannel.java:1245) at org.apache.qpid.server.protocol.v0_8.AMQChannel$AsyncCommand.complete(AMQChannel.java:1623) at org.apache.qpid.server.protocol.v0_8.AMQChannel.sync(AMQChannel.java:1593) at org.apache.qpid.server.protocol.v0_8.AMQChannel.receivedComplete(AMQChannel.java:218) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.receivedComplete(AMQProtocolEngine.java:324) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.received(AMQProtocolEngine.java:304) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.received(AMQProtocolEngine.java:104) at org.apache.qpid.server.protocol.MultiVersionProtocolEngine.received(MultiVersionProtocolEngine.java:131) at org.apache.qpid.server.protocol.MultiVersionProtocolEngine.received(MultiVersionProtocolEngine.java:47) at org.apache.qpid.transport.network.io.IoReceiver.run(IoReceiver.java:161) at java.lang.Thread.run(Thread.java:662) {code} Then later client side: {code} 2013-10-31 14:47:49,099 DEBUG [Dispatcher-1-Conn-1] [Dispatcher] Dispatcher-1-Conn-1 thread terminating for channel 1:org.apache.qpid.client.AMQSession_0_8@560932fe javax.jms.JMSException: Message consumer forcibly closed due to error: org.apache.qpid.framing.AMQFrameDecodingException: End of frame marker not found. Read 53 length=65527 type=3 at org.apache.qpid.client.BasicMessageConsumer.returnMessageOrThrow(BasicMessageConsumer.java:531) at org.apache.qpid.client.BasicMessageConsumer.receive(BasicMessageConsumer.java:419) at org.apache.qpid.client.BasicMessageConsumer.receive(BasicMessageConsumer.java:393) at org.apache.qpid.example.Hello.runTest(Hello.java:60) at org.apache.qpid.example.Hello.main(Hello.java:40) Caused by: org.apache.qpid.framing.AMQFrameDecodingException: End of frame marker not found. Read 53 length=65527 type=3 at org.apache.qpid.framing.AMQDataBlockDecoder.createAndPopulateFrame(AMQDataBlockDecoder.java:104) at org.apache.qpid.codec.AMQDecoder.decodeBuffer(AMQDecoder.java:250) at org.apache.qpid.client.protocol.AMQProtocolHandler.received(AMQProtocolHandler.java:451) at org.apache.qpid.client.protocol.AMQProtocolHandler.received(AMQProtocolHandler.java:1) at org.apache.qpid.transport.network.io.IoReceiver.run(IoReceiver.java:161) at java.lang.Thread.run(Thread.java:662) {code}

    Apache's JIRA Issue Tracker | 3 years ago | Keith Wall
    javax.jms.JMSException: Exception whilst sending:write timed out for socket localhost/127.0.0.1:5672: head -2146565522, tail -2146696594
  6. 0

    If an IoSender#send suffers a timeout (IoSender.java#159) whilst awaiting space in the sender's buffer, the socket which was being written to is left open and a SenderException is thrown to the caller. The bytes that were to be sent are lost. If the socket is subsequent written to again, the peer may suffer an AMQFrameDecodingException as is tries to decode an incomplete stream of data. We saw this scenario in a support call. The working theory is that the application'sJVM (using a JMS consumer) was under pressue, and this caused TCP/IP back pressure to be felt by the broker. The Broker IoSender#send method timed-out, but as the socket remained open, when a later message was sent to the same JMS consumer application, the consuming application failed with an AMQFrameDecodingException: the lost bytes meant it tried to process message payload as if it were an AMQFrame. The two exceptions of interest are (reproduced on trunk): Broker side: {code} 2013-10-31 14:41:18,471 ERROR [IoReceiver - /127.0.0.1:63867] (v0_8.AMQProtocolEngine) - Error informing channel that receiving is complete. Channel: [/127.0.0.1:63867(guest):1]org.apache.qpid.transport.SenderException: write timed out: -2147471360, -2147475456 at org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:159) at org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:40) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.writeFrame(AMQProtocolEngine.java:689) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeFrame(ProtocolOutputConverterImpl.java:337) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDelivery(ProtocolOutputConverterImpl.java:127) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDelivery(ProtocolOutputConverterImpl.java:97) at org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeDeliver(ProtocolOutputConverterImpl.java:72) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine$WriteDeliverMethod.deliverToClient(AMQProtocolEngine.java:1679) at org.apache.qpid.server.protocol.v0_8.SubscriptionImpl.sendToClient(SubscriptionImpl.java:693) at org.apache.qpid.server.protocol.v0_8.SubscriptionImpl$AckSubscription.send(SubscriptionImpl.java:303) at org.apache.qpid.server.queue.SimpleAMQQueue.deliverMessage(SimpleAMQQueue.java:826) at org.apache.qpid.server.queue.SimpleAMQQueue.deliverToSubscription(SimpleAMQQueue.java:745) at org.apache.qpid.server.queue.SimpleAMQQueue.enqueue(SimpleAMQQueue.java:693) at org.apache.qpid.server.protocol.v0_8.AMQChannel$MessageDeliveryAction.postCommit(AMQChannel.java:1245) at org.apache.qpid.server.protocol.v0_8.AMQChannel$AsyncCommand.complete(AMQChannel.java:1623) at org.apache.qpid.server.protocol.v0_8.AMQChannel.sync(AMQChannel.java:1593) at org.apache.qpid.server.protocol.v0_8.AMQChannel.receivedComplete(AMQChannel.java:218) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.receivedComplete(AMQProtocolEngine.java:324) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.received(AMQProtocolEngine.java:304) at org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.received(AMQProtocolEngine.java:104) at org.apache.qpid.server.protocol.MultiVersionProtocolEngine.received(MultiVersionProtocolEngine.java:131) at org.apache.qpid.server.protocol.MultiVersionProtocolEngine.received(MultiVersionProtocolEngine.java:47) at org.apache.qpid.transport.network.io.IoReceiver.run(IoReceiver.java:161) at java.lang.Thread.run(Thread.java:662) {code} Then later client side: {code} 2013-10-31 14:47:49,099 DEBUG [Dispatcher-1-Conn-1] [Dispatcher] Dispatcher-1-Conn-1 thread terminating for channel 1:org.apache.qpid.client.AMQSession_0_8@560932fe javax.jms.JMSException: Message consumer forcibly closed due to error: org.apache.qpid.framing.AMQFrameDecodingException: End of frame marker not found. Read 53 length=65527 type=3 at org.apache.qpid.client.BasicMessageConsumer.returnMessageOrThrow(BasicMessageConsumer.java:531) at org.apache.qpid.client.BasicMessageConsumer.receive(BasicMessageConsumer.java:419) at org.apache.qpid.client.BasicMessageConsumer.receive(BasicMessageConsumer.java:393) at org.apache.qpid.example.Hello.runTest(Hello.java:60) at org.apache.qpid.example.Hello.main(Hello.java:40) Caused by: org.apache.qpid.framing.AMQFrameDecodingException: End of frame marker not found. Read 53 length=65527 type=3 at org.apache.qpid.framing.AMQDataBlockDecoder.createAndPopulateFrame(AMQDataBlockDecoder.java:104) at org.apache.qpid.codec.AMQDecoder.decodeBuffer(AMQDecoder.java:250) at org.apache.qpid.client.protocol.AMQProtocolHandler.received(AMQProtocolHandler.java:451) at org.apache.qpid.client.protocol.AMQProtocolHandler.received(AMQProtocolHandler.java:1) at org.apache.qpid.transport.network.io.IoReceiver.run(IoReceiver.java:161) at java.lang.Thread.run(Thread.java:662) {code}

    Apache's JIRA Issue Tracker | 3 years ago | Keith Wall
    org.apache.qpid.transport.SenderException: write timed out for socket localhost/127.0.0.1:5672: head -2146696295, tail -2146827367

    Root Cause Analysis

    1. org.apache.qpid.transport.SenderException

      SSL Engine timed out waiting for a response.To get more info,run with -Djavax.net.debug=ssl

      at org.apache.qpid.transport.network.security.ssl.SSLSender.send()
    2. Qpid Common
      Connection.connect
      1. org.apache.qpid.transport.network.security.ssl.SSLSender.send(SSLSender.java:227)
      2. org.apache.qpid.transport.network.security.ssl.SSLSender.send(SSLSender.java:36)
      3. org.apache.qpid.transport.network.Disassembler.init(Disassembler.java:158)
      4. org.apache.qpid.transport.network.Disassembler.init(Disassembler.java:49)
      5. org.apache.qpid.transport.ProtocolHeader.delegate(ProtocolHeader.java:105)
      6. org.apache.qpid.transport.network.Disassembler.send(Disassembler.java:81)
      7. org.apache.qpid.transport.network.Disassembler.send(Disassembler.java:49)
      8. org.apache.qpid.transport.Connection.send(Connection.java:360)
      9. org.apache.qpid.transport.Connection.connect(Connection.java:238)
      9 frames
    3. Qpid AMQP 0-x JMS Client
      AMQConnectionFactory.createConnection
      1. org.apache.qpid.client.AMQConnectionDelegate_0_10.makeBrokerConnection(AMQConnectionDelegate_0_10.java:164)
      2. org.apache.qpid.client.AMQConnection.makeBrokerConnection(AMQConnection.java:761)
      3. org.apache.qpid.client.AMQConnection.<init>(AMQConnection.java:547)
      4. org.apache.qpid.client.AMQConnectionFactory.createConnection(AMQConnectionFactory.java:317)
      5. org.apache.qpid.client.AMQConnectionFactory.createConnection(AMQConnectionFactory.java:297)
      5 frames
    4. Apache Axis2 - Transport - JMS
      ServiceTaskManager$MessageListenerTask.run
      1. org.apache.axis2.transport.jms.JMSUtils.createConnection(JMSUtils.java:552)
      2. org.apache.axis2.transport.jms.ServiceTaskManager$MessageListenerTask.createConnection(ServiceTaskManager.java:804)
      3. org.apache.axis2.transport.jms.ServiceTaskManager$MessageListenerTask.getConnection(ServiceTaskManager.java:686)
      4. org.apache.axis2.transport.jms.ServiceTaskManager$MessageListenerTask.receiveMessage(ServiceTaskManager.java:484)
      5. org.apache.axis2.transport.jms.ServiceTaskManager$MessageListenerTask.run(ServiceTaskManager.java:412)
      5 frames
    5. Apache Axis2 - Transport - Base
      NativeWorkerPool$1.run
      1. org.apache.axis2.transport.base.threads.NativeWorkerPool$1.run(NativeWorkerPool.java:173)
      1 frame
    6. Java RT
      Thread.run
      1. java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
      2. java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
      3. java.lang.Thread.run(Thread.java:619)
      3 frames