Details

    • Type: Bug
    • Status: Closed
    • Priority: Default
    • Resolution: Duplicate
    • Affects Version/s: 1.5.2
    • Fix Version/s: None
    • Component/s: Engine
    • Labels:
    • Environment:
      windows server 2008 r2 standard sp1

      Description

      Currently our prod env occur an issue about FIX Resend.
      1) Before 03:31:16.621, our quickfixj was disconnected by upstream fix engine.
      2) On 03:31:16.621, we re-connected.
      3) On 03:31:16.839, we(CT) send Resend Request with tag7=23152 and tag16=0.
      4) On 03:31:17.541, our customer returned from 23152 to 23974, then they send us 34=23977 and 34=23978, but SKIPPED 23975 and 23976.
      5) I found our quickfix found 23974 and 23975 from its own memory queue at the same time, but not found 23976. So our sides occur 'MsgSeqNum too high, expecting 23976 but received 23977', cannot receive subsequent orders.

      <fix event log>
      ------------------------------------------------------------------
      20131120-03:25:57.913: Disconnecting: Socket exception (/14.129.28.13:35416): java.io.IOException: An existing connection was forcibly closed by the remote host
      20131120-03:25:57.991: Already disconnected: Socket exception (/14.129.28.13:35416): java.io.IOException: An existing connection was forcibly closed by the remote host
      20131120-03:31:16.621: Accepting session FIX.4.2:CT->S_MHK from /14.129.28.13:36040

      <fix message log>
      ------------------------------------------------------------------
      20131120-03:31:16.621: 8=FIX.4.29=011435=A49=S_MHK56=CT34=2397450=desk143=N97=N122=20131120-03:31:1752=20131120-03:31:17108=6698=010=205
      20131120-03:31:16.839: 8=FIX.4.29=76 35=A34=5219849=CT52=20131120-03:31:16.83956=S_MHK98=0108=6610=000
      20131120-03:31:16.839: 8=FIX.4.29=77 35=234=5219949=CT52=20131120-03:31:16.83956=S_MHK7=2315216=010=024
      20131120-03:31:16.917: 8=FIX.4.29=010235=049=S_MHK56=CT34=2397550=desk143=N97=N122=20131120-03:31:1752=20131120-03:31:1710=152
      20131120-03:31:16.917: 8=FIX.4.29=011535=249=S_MHK56=CT34=2397650=desk143=N97=N122=20131120-03:31:1752=20131120-03:31:177=5212916=010=236

      20131120-03:31:16.980: 8=FIX.4.29=025235=D49=S_MHK56=CT34=2315250=desk143=Y97=Y122=20131120-03:25:4052=20131120-03:31:1711=00000000000276593764-00000115=CNY38=190040=244=000000003.3500000047=P54=155=60166859=060=20131120-03:25:40100=SS526=MHK0127658108421=110=070
      20131120-03:31:16.980: 8=FIX.4.29=025235=D49=S_MHK56=CT34=2315350=desk143=Y97=Y122=20131120-03:25:4052=20131120-03:31:1711=00000000000276593765-00000115=CNY38=250040=244=000000004.9800000047=P54=155=60002859=060=20131120-03:25:40100=SS526=MHK0127658105921=110=070
      .............................
      .............................
      .............................
      .............................
      .............................
      20131120-03:31:17.541: 8=FIX.4.29=025135=D49=S_MHK56=CT34=2397150=desk143=Y97=Y122=20131120-03:29:5452=20131120-03:31:1811=00000000000276597970-00000115=CNY38=20040=244=000000005.3000000047=P54=155=60189859=060=20131120-03:29:54100=SS526=MHK0127658108921=110=051
      20131120-03:31:17.541: 8=FIX.4.29=025135=D49=S_MHK56=CT34=2397250=desk143=Y97=Y122=20131120-03:29:5452=20131120-03:31:1811=00000000000276597971-00000115=CNY38=10040=244=000000004.2100000047=P54=155=60001959=060=20131120-03:29:54100=SS526=MHK0127658105821=110=031
      20131120-03:31:17.541: 8=FIX.4.29=025235=D49=S_MHK56=CT34=2397350=desk143=Y97=Y122=20131120-03:29:5752=20131120-03:31:1811=00000000000276597995-00000115=CNY38=270040=244=000000004.2700000047=P54=155=60180059=060=20131120-03:29:57100=SS526=MHK0127658108521=110=106
      20131120-03:31:17.541: 8=FIX.4.29=010735=449=S_MHK56=CT34=23974 43=Y97=Y122=20131120-03:31:1852=20131120-03:31:1836=23977123=Y10=111
      20131120-03:31:17.541: 8=FIX.4.29=025335=D49=S_MHK56=CT34=2397750=desk243=N97=N122=20131120-03:31:1852=20131120-03:31:1811=00000000000276599095-00000115=CNY38=70040=244=000000005.7000000047=P54=255=60037759=060=20131120-03:31:17100=SS526=MHK0127647435721=110=238
      20131120-03:31:17.541: 8=FIX.4.29=011135=149=S_MHK56=CT34=2397850=desk243=N97=N122=20131120-03:31:1852=20131120-03:31:18112=R110=203

      20131120-03:31:17.541: 8=FIX.4.29=7735=234=5224649=CT52=20131120-03:31:17.54156=S_MHK7=2397616=010=022

      <fix event log>
      ------------------------------------------------------------------
      20131120-03:31:17.339: Received SequenceReset FROM: 23466 TO: 23467
      20131120-03:31:17.417: Received SequenceReset FROM: 23665 TO: 23666
      20131120-03:31:17.479: Received SequenceReset FROM: 23887 TO: 23889
      20131120-03:31:17.541: ResendRequest for messages FROM 23152 TO 23973 has been satisfied.
      20131120-03:31:17.541: Processing queued message: 23974
      20131120-03:31:17.541: Processing queued message: 23975

      20131120-03:31:17.541: MsgSeqNum too high, expecting 23976 but received 23977: 8=FIX.4.29=25335=D34=2397743=N49=S_MHK50=kerridhu52=20131120-03:31:1856=CT97=N122=20131120-03:31:1811=00000000000276599095-00000115=CNY21=138=70040=244=000000005.7000000047=P54=255=60037759=060=20131120-03:31:17100=SS526=MHK0127647435710=190
      20131120-03:31:17.541: Enqueued at pos 23977: 8=FIX.4.29=25335=D34=2397743=N49=S_MHK50=desk252=20131120-03:31:1856=CT97=N122=20131120-03:31:1811=00000000000276599095-00000115=CNY21=138=70040=244=000000005.7000000047=P54=255=60037759=060=20131120-03:31:17100=SS526=MHK0127647435710=190
      20131120-03:31:17.541: Sent ResendRequest FROM: 23976 TO: 23976
      20131120-03:31:17.541: MsgSeqNum too high, expecting 23976 but received 23978: 8=FIX.4.29=11135=134=2397843=N49=S_MHK50=kerridhu52=20131120-03:31:1856=CT97=N122=20131120-03:31:18112=R110=155
      20131120-03:31:17.541: Enqueued at pos 23978: 8=FIX.4.29=11135=134=2397843=N49=S_MHK50=desk252=20131120-03:31:1856=CT97=N122=20131120-03:31:18112=R110=155
      20131120-03:31:17.541: Already sent ResendRequest FROM: 23976 TO: 23976. Not sending another.

        Attachments

          Issue Links

            Activity

              People

              • Assignee:
                chrjohn Christoph John
                Reporter:
                flowerknight Li,Wei
              • Votes:
                0 Vote for this issue
                Watchers:
                1 Start watching this issue

                Dates

                • Created:
                  Updated:
                  Resolved: