使用JPOS仅发送一笔购买请求却出现重复请求的问题

问题现象 #

仅通过JPOS发送一笔购买请求，但日志中出现重复请求记录，同时触发unconnected ISOChannel错误，相关日志如下：

<log realm="simulator_10000.server.session/127.0.0.1:50948" at="2023-05-01T09:09:25.736368">
   <session-start/>
 </log>
 <log realm="simulator_10000.server.session/127.0.0.1:50960" at="2023-05-01T09:09:25.743136">
   <session-start/>
 </log>
 <log realm="org.jpos.transaction.TransactionManager" at="2023-05-01T09:09:26.002006" lifespan="431ms">
   <abort>
     txnmgr-2:idle:12
     <context>
       CC_TR_REQUEST(P): 
        <isomsg direction="outgoing">
          <!-- net.shamirix.utils.CustomPacker1993 -->
          <field id="0" value="1200"/>
          <field id="2" value="2223600089700011"/>
          <field id="3" value="000000"/>
          <field id="4" value="000000000014"/>
          <field id="7" value="0501090925"/>
         …
          <field id="64" value="10011001"/>
          <field id="128" value="A8CDDA88FFFFFFFF" type="binary"/>
        </isomsg>
       
       CC_ISO_SOURCE: org.jpos.iso.channel.XMLChannel@1089f917
       RESPONSE: 
        <isomsg direction="incoming">
          <!-- net.shamirix.utils.CustomPacker1993 -->
          <field id="0" value="1210"/>
          <field id="2" value="2223600089700011"/>
          <field id="3" value="000000"/>
          <field id="4" value="000000000014"/>
          <field id="7" value="0501090925"/>
          …
          <field id="64" value="3130303131303031" type="binary"/>
          <field id="128" value="A8CDDA88FFFFFFFF" type="binary"/>
        </isomsg>

       
       DESTINATION: jPOS-AUTORESPONDER
       REQUEST(P): 
        <isomsg direction="outgoing">
          <!-- net.shamirix.utils.CustomPacker1993 -->
          <field id="0" value="1200"/>
          <field id="2" value="2223600089700011"/>
          <field id="3" value="000000"/>
          <field id="4" value="000000000014"/>
          <field id="7" value="0501090925"/>
          …
          <field id="64" value="10011001"/>
          <field id="128" value="A8CDDA88FFFFFFFF" type="binary"/>
        </isomsg>
       
       PAYMENT_PROCESSOR_RESPONSE: 
        <isomsg direction="incoming">
          <!-- net.shamirix.utils.CustomPacker1993 -->
          <field id="0" value="1210"/>
          <field id="2" value="2223600089700011"/>
          <field id="3" value="000000"/>
          <field id="4" value="000000000014"/>
          <field id="7" value="0501090925"/>
          …
          <field id="64" value="3130303131303031" type="binary"/>
          <field id="128" value="A8CDDA88FFFFFFFF" type="binary"/>
        </isomsg>
       
       Error: unconnected ISOChannel
     </context>
                 in-transit=3/4, head=14, tail=10, paused=0, outstanding=0, active-sessions=4/250, tps=0, peak=2, avg=0.01, elapsed=431ms
     
   </abort>
 </log>

问题根因分析 #

1. 重复Session启动：日志显示两个Session在7ms内先后启动（端口50948和50960），说明连接机制可能触发了重复连接——比如重连逻辑未正确判断连接状态，或是连接池存在无效连接被重复初始化。
2. 通道未连接导致事务中止：unconnected ISOChannel错误表明发送请求时，XMLChannel未处于已连接状态，可能是通道初始化超时、连接被意外断开，或是事务流程中未提前校验通道状态就发起请求。
3. 重复请求触发：第一次请求因通道未连接失败，若事务配置了重试机制，会自动重新发送请求，最终导致日志中出现重复的请求记录。

解决建议 #

• 校验ISOChannel配置：检查XMLChannel的连接参数（connectTimeout、reconnectInterval等），确保通道能正常建立并维持连接；在发送请求前添加通道连接状态校验逻辑，比如调用isConnected()方法确认状态，未连接时先执行connect()。
• 优化事务管理器逻辑：检查TransactionManager的重试配置，避免在通道未连接时盲目重试；调整事务流程，确保只有在通道正常连接时才发起请求。
• 排查连接池问题：若使用连接池管理ISOChannel，检查池的大小、空闲连接回收策略，清理无效连接，避免复用未连接的通道实例。
• 增强日志监控：在通道连接、断开、重连等关键节点添加日志输出，便于追踪连接状态变化，快速定位问题。

内容的提问来源于stack exchange，提问作者Ahmed Hasan