difference between SendingTime and received time #401

pe-ggy-lee · 2021-06-09T14:21:07Z

pe-ggy-lee
Jun 9, 2021

I am using the quickfix version ==> 1.6.3. thesedays we want to improve our recieve data speedy performance, we found that the server sending time and the quickfix receiving time differed by 40 milliseconds,how do i can improve this issue.

chrjohn · 2021-06-10T10:25:24Z

chrjohn
Jun 10, 2021
Maintainer

Hi @pe-ggy-lee ,

that is quite an old version that you got there. Did you try with a newer version?
However, I think this is no general problem but a problem related to either your setup or your application.
Are the server and your machine time synchronised?
Is the first message of the day (i.e. the Logon) also 40ms late?

Cheers,
Chris.

3 replies

pe-ggy-lee Jun 10, 2021
Author

can i contract with you? i'm using new version but tag 52 sendingtime format have millisecond, how can i process this??

pe-ggy-lee Jun 10, 2021
Author

server and client are in same machine

chrjohn Jun 10, 2021
Maintainer

OK, then I think the problem is application or machine-specific. In one of our applications we usually receive and forward messages from remote machines inside 1ms.
Are you able to provide a log file?

pe-ggy-lee · 2021-06-10T10:59:53Z

pe-ggy-lee
Jun 10, 2021
Author

Hello my log there~ Server log 09:01:21.053 [MSG] DeQ 8=FIX.4.3 9=340 35=UP10 49=SM03 56=GM960$ 34=506 52=20210601-01:01:21 80001=03 80002=08 80003=10 80014= 80024=090121 80004=0000 80005=0001 80006=04980 11=00260 81029=0004246 81039=00010.6500 81040=00005000 81041=00010.7500 81028=00005000 81048=090121028 81032=0004001 81042=00010.8500 81043=00005000 81044=00010.8500 81031=00005000 81049=090102146 10=255 Quickfixlog 20210601-01:01:21.101: 8=FIX.4.3 9=325 35=UP10 49=emgMsgSvr 56=960T1111 34=8214 52=20210601-01:01:21 80001=03 80002=08 80003=10 80014= 80024=090121 80004=0000 11=00260 81029=0004246 81039=00010.6500 81040=00005000 81041=00010.7500 81028=00005000 81048=090121028 81032=0004001 81042=00010.8500 81043=00005000 81044=00010.8500 81031=00005000 81049=090102146 10=241 Client log [log time is GMT+8] 2021-06-01 09:01:21.100|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:226)| parsed message: pos=348,lim=604,rem=256,offset=348,state=4 8=FIX.4.3 9=325 35=UP10 49=emgMsgSvr 56=960T1111 34=8214 52=20210601-01:01:21 80001=03 80002=08 80003=10 80014= 80024=090121 80004=0000 11=00260 81029=0004246 81039=00010.6500 81040=00005000 81041=00010.7500 81028=00005000 81048=090121028 81032=0004001 81042=00010.8500 81043=00005000 81044=00010.8500 81031=00005000 81049=090102146 10=241 2021-06-01 09:01:21.101|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:157)| detected header: pos=348,lim=604,rem=256,offset=348,state=1 2021-06-01 09:01:21.101|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:176)| body length = 233: pos=348,lim=604,rem=256,offset=364,state=3 2021-06-01 09:01:21.101|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:200)| message body found: pos=348,lim=604,rem=256,offset=597,state=4 2021-06-01 09:01:21.101|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:207)| found checksum: pos=348,lim=604,rem=256,offset=597,state=4 2021-06-01 09:01:21.101|QF/J Session dispatcher: FIX.4.3:960T1111->emgMsgSvrhread|com.fubon.rstsfix.RstsFIX$OTCFIX.fromApp(RstsFIX.java:1269)| QuickfixQueueSize:1 IN <- 8=FIX.4.3 9=325 35=UP10 34=8214 49=emgMsgSvr 52=20210601-01:01:21 56=960T1111 11=00260 80001=03 80002=08 80003=10 80004=0000 80014= 80024=090121 81028=00005000 81029=0004246 81031=00005000 81032=0004001 81039=00010.6500 81040=00005000 81041=00010.7500 81042=00010.8500 81043=00005000 81044=00010.8500 81048=090121028 81049=090102146 10=241 Christoph John ***@***.***> 於 2021年6月10日週四下午6:32寫道：

…

OK, then I think the problem is application or machine-specific. In one of our applications we usually receive and forward messages from remote machines inside 1ms. Are you able to provide a log file? — You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub <#401 (reply in thread)>, or unsubscribe <https://github.com/notifications/unsubscribe-auth/AUNJYNA3VSGRHHZWPPEQ5SLTSCICJANCNFSM46MEWGRQ> .

0 replies

pe-ggy-lee · 2021-06-10T11:03:58Z

pe-ggy-lee
Jun 10, 2021
Author

I have been looking for this problem for several days, and there is no problem sending the information, thank you for your help Peggy Lee ***@***.***> 於 2021年6月10日週四下午6:59寫道：

…

Hello my log there~ Server log 09:01:21.053 [MSG] DeQ 8=FIX.4.3 9=340 35=UP10 49=SM03 56=GM960$ 34=506 52=20210601-01:01:21 80001=03 80002=08 80003=10 80014= 80024=090121 80004=0000 80005=0001 80006=04980 11=00260 81029=0004246 81039=00010.6500 81040=00005000 81041=00010.7500 81028=00005000 81048=090121028 81032=0004001 81042=00010.8500 81043=00005000 81044=00010.8500 81031=00005000 81049=090102146 10=255 Quickfixlog 20210601-01:01:21.101: 8=FIX.4.3 9=325 35=UP10 49=emgMsgSvr 56=960T1111 34=8214 52=20210601-01:01:21 80001=03 80002=08 80003=10 80014= 80024=090121 80004=0000 11=00260 81029=0004246 81039=00010.6500 81040=00005000 81041=00010.7500 81028=00005000 81048=090121028 81032=0004001 81042=00010.8500 81043=00005000 81044=00010.8500 81031=00005000 81049=090102146 10=241 Client log [log time is GMT+8] 2021-06-01 09:01:21.100|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:226)| parsed message: pos=348,lim=604,rem=256,offset=348,state=4 8=FIX.4.3 9=325 35=UP10 49=emgMsgSvr 56=960T1111 34=8214 52=20210601-01:01:21 80001=03 80002=08 80003=10 80014= 80024=090121 80004=0000 11=00260 81029=0004246 81039=00010.6500 81040=00005000 81041=00010.7500 81028=00005000 81048=090121028 81032=0004001 81042=00010.8500 81043=00005000 81044=00010.8500 81031=00005000 81049=090102146 10=241 2021-06-01 09:01:21.101|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:157)| detected header: pos=348,lim=604,rem=256,offset=348,state=1 2021-06-01 09:01:21.101|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:176)| body length = 233: pos=348,lim=604,rem=256,offset=364,state=3 2021-06-01 09:01:21.101|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:200)| message body found: pos=348,lim=604,rem=256,offset=597,state=4 2021-06-01 09:01:21.101|SocketConnectorIoProcessor-0.0hread|quickfix.mina.message.FIXMessageDecoder.parseMessage(FIXMessageDecoder.java:207)| found checksum: pos=348,lim=604,rem=256,offset=597,state=4 2021-06-01 09:01:21.101|QF/J Session dispatcher: FIX.4.3:960T1111->emgMsgSvrhread|com.fubon.rstsfix.RstsFIX$OTCFIX.fromApp(RstsFIX.java:1269)| QuickfixQueueSize:1 IN <- 8=FIX.4.3 9=325 35=UP10 34=8214 49=emgMsgSvr 52=20210601-01:01:21 56=960T1111 11=00260 80001=03 80002=08 80003=10 80004=0000 80014= 80024=090121 81028=00005000 81029=0004246 81031=00005000 81032=0004001 81039=00010.6500 81040=00005000 81041=00010.7500 81042=00010.8500 81043=00005000 81044=00010.8500 81048=090121028 81049=090102146 10=241 Christoph John ***@***.***> 於 2021年6月10日週四下午6:32寫道： > OK, then I think the problem is application or machine-specific. In one > of our applications we usually receive and forward messages from remote > machines inside 1ms. > Are you able to provide a log file? > > — > You are receiving this because you were mentioned. > Reply to this email directly, view it on GitHub > <#401 (reply in thread)>, > or unsubscribe > <https://github.com/notifications/unsubscribe-auth/AUNJYNA3VSGRHHZWPPEQ5SLTSCICJANCNFSM46MEWGRQ> > . >

1 reply

chrjohn Jun 10, 2021
Maintainer

That's kind of hard to follow. The time difference is between the sending from the server (server log), and the client (quickfix log and client log)?
Maybe you can improve the speed already by turning off that DEBUG logging for each message?

Again, can you check the time difference on the Logon message after an application restart?

pe-ggy-lee · 2021-06-10T11:15:12Z

pe-ggy-lee
Jun 10, 2021
Author

Does this mean that writing files affects speed? ? I have been closed to DEBUG, but the situation is still the same.... Christoph John ***@***.***> 於 2021年6月10日週四下午7:11寫道：

…

That's kind of hard to follow. The time difference is between the sending from the server (server log), and the client (quickfix log and client log)? Maybe you can improve the speed already by turning off that DEBUG logging for each message? Again, can you check the time difference on the Logon message after an application restart? — You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub <#401 (reply in thread)>, or unsubscribe <https://github.com/notifications/unsubscribe-auth/AUNJYNHKTIUFFAPKPV4TJ43TSCMXLANCNFSM46MEWGRQ> .

0 replies

chrjohn · 2021-06-10T11:57:21Z

chrjohn
Jun 10, 2021
Maintainer

What do you mean? Every operation that you do will influence performance eventually. Please answer all of my other questions from before. Especially the one about the Logon. Thanks

0 replies

pe-ggy-lee · 2021-06-10T12:12:04Z

pe-ggy-lee
Jun 10, 2021
Author

sorry... that's kind of hard to follow. The time difference is between the sending from the server (server log), and the client (quickfix log and client log)? ==>yes, Maybe you can improve the speed already by turning off that DEBUG logging for each message? ==> Tried, but the same result Again, can you check the time difference on the Logon message after an application restart? ==>is it mean like this message? [image: image.png] Christoph John ***@***.***> 於 2021年6月10日週四下午7:57寫道：

…

What do you mean? Every operation that you do will influence performance eventually. Please answer all of my other questions from before. Especially the one about the Logon. Thanks — You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub <#401 (comment)>, or unsubscribe <https://github.com/notifications/unsubscribe-auth/AUNJYNEHO7VD6T2DWFTL7FLTSCSC7ANCNFSM46MEWGRQ> .

1 reply

chrjohn Jun 10, 2021
Maintainer

Again, can you check the time difference on the Logon message after an
application restart?

==>is it mean like this message?

There is no image shown. Can you maybe copy/paste the text directly from the log file?

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

difference between SendingTime and received time #401

{{title}}

Replies: 6 comments 5 replies

{{title}}

{{title}}

{{title}}

{{title}}

{{editor}}'s edit

{{editor}}'s edit

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

Select a reply

difference between SendingTime and received time #401

pe-ggy-lee Jun 9, 2021

Replies: 6 comments · 5 replies

chrjohn Jun 10, 2021 Maintainer

pe-ggy-lee Jun 10, 2021 Author

pe-ggy-lee Jun 10, 2021 Author

chrjohn Jun 10, 2021 Maintainer

pe-ggy-lee Jun 10, 2021 Author

pe-ggy-lee Jun 10, 2021 Author

chrjohn Jun 10, 2021 Maintainer

pe-ggy-lee Jun 10, 2021 Author

chrjohn Jun 10, 2021 Maintainer

pe-ggy-lee Jun 10, 2021 Author

chrjohn Jun 10, 2021 Maintainer

pe-ggy-lee
Jun 9, 2021

Replies: 6 comments 5 replies

chrjohn
Jun 10, 2021
Maintainer

pe-ggy-lee Jun 10, 2021
Author

pe-ggy-lee Jun 10, 2021
Author

chrjohn Jun 10, 2021
Maintainer

pe-ggy-lee
Jun 10, 2021
Author

pe-ggy-lee
Jun 10, 2021
Author

chrjohn Jun 10, 2021
Maintainer

pe-ggy-lee
Jun 10, 2021
Author

chrjohn
Jun 10, 2021
Maintainer

pe-ggy-lee
Jun 10, 2021
Author

chrjohn Jun 10, 2021
Maintainer