Hi team,
My Customer using UM 9.12 and IS 9.12. they face an issue where UM responds slowly until an error appears like the one below when they want to publish a message using pub.jms:send :
[2023-10-19 10:57:55.245] - [2023-10-19 11:00:55.259] - (2) Retry reach max. Fail callback to VMS (to inform order is completed). System/wM error [javax.jms.IllegalStateException: MessageProducerImpl.send failed: The server failed to respond within the time out value:180000 last ID = 3275 class com.pcbsys.nirvana.base.events.nTXPublishCommit com.wm.app.b2b.server.jms.ResourceUnavailableException: javax.jms.IllegalStateException: MessageProducerImpl.send failed: The server failed to respond within the time out value:180000 last ID = 3275 class com.pcbsys.nirvana.base.events.nTXPublishCommit ]
we also found an error and recorded it on nirvana.log
[Thu Oct 19 10:57:25 MYT 2023] [UM Server Status Generator] [com.pcbsys.foundation] - ServerStatusLog> Memory=721, Direct=1024, EventMemory=0, Disk=146190, CPU=1.5, Scheduled=749, Queued=0, Connections=351, BytesIn=3369242, BytesOut=4203699, Published=0, Consumed=145
[Thu Oct 19 10:57:27 MYT 2023] [ClosePool:0] [com.pcbsys.nirvana.server] - UserManager: User wmapp@10.200.76.31 Logged Out using nhp, Reason : java.io.EOFException Connection closed, session established for 1142 seconds, Session Id = 821e67bb00000000 ID: 10.200.76.31:38382
[Thu Oct 19 10:57:27 MYT 2023] [ClosePool:0] [com.pcbsys.nirvana.server] - Connection closed
java.io.EOFException: Connection closed
at com.pcbsys.foundation.drivers.nio.fBufferInputStream.allocateWorkingBuffer(fBufferInputStream.java:142)
at com.pcbsys.foundation.drivers.nio.fBufferInputStream.available(fBufferInputStream.java:48)
at com.pcbsys.foundation.drivers.fHTTPDSession$AsyncListener.dataReady(fHTTPDSession.java:440)
at com.pcbsys.foundation.drivers.nio.fChannelDriver.notifyListener(fChannelDriver.java:164)
at com.pcbsys.foundation.drivers.nio.fChannelDriver.packetArrived(fChannelDriver.java:240)
at com.pcbsys.foundation.drivers.nio.handlers.PacketChannel.processInBuffer(PacketChannel.java:96)
at com.pcbsys.foundation.drivers.nio.handlers.PacketChannel.handleRead(PacketChannel.java:73)
at com.pcbsys.foundation.drivers.nio.handlers.PlainChannel.handleRead(PlainChannel.java:74)
at com.pcbsys.foundation.drivers.nio.io.SelectorThread.processKey(SelectorThread.java:296)
at com.pcbsys.foundation.drivers.nio.io.SelectorThread.processSelectKeysIterator(SelectorThread.java:272)
at com.pcbsys.foundation.drivers.nio.io.SelectorThread.run(SelectorThread.java:177)
at com.pcbsys.foundation.threads.fThread.localRun(fThread.java:106)
at com.pcbsys.foundation.threads.hThread.run(hThread.java:102)
at java.lang.Thread.run(Thread.java:748)
[Thu Oct 19 10:57:27 MYT 2023] [ReadPool:25] [com.pcbsys.nirvana.server.handler] - Client session requested clean session close : wmapp@10.200.76.31 ID 10.200.76.31:38382
The error above happened after trying to create a topic directly from Enterprise Manager and Publish the message from IS using pub.jms:send as well.
I have done a few things, such as:
-Add EventTimeout to realm config to 180000 to 300000
-Create a new JMS in the IS admin and change the IP LB UM to the IP UM directly.
-Try to Create new topic from enterprise manager
this is my current ram stats, after 5 UM is running at the same time
[wmadmin@sgbbitwmbrks03 bin]$ free -m
total used free shared buff/cache available
Mem: 15884 6655 436 657 8792 8236
Swap: 3967 7 3960
what is the root cause of this problem?
and what is the solution?
does this happen because of the network?
really appreciate for the help!
Note:
I have suggested fixing the patch for version 9.12, but the customer will make that option the last option
Thanks,
Dimas