You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@qpid.apache.org by "Chuck Rolke (JIRA)" <ji...@apache.org> on 2018/08/01 20:07:00 UTC
[jira] [Commented] (DISPATCH-1094) Log file messages out of order
according to time stamps
[ https://issues.apache.org/jira/browse/DISPATCH-1094?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16565905#comment-16565905 ]
Chuck Rolke commented on DISPATCH-1094:
---------------------------------------
The log file in question had several backwards steps in time. These measurements were only for AMQP performatives and not for general log lines.
The largest backward step in time was *6.084 mS*.
{{new a_b. a: 2018-08-01 10:45:25.207209 b: 2018-08-01 10:45:25.206902 diff: 0:00:00.000307 a-lineno: 1440}}
{{2018-08-01 10:45:25.207209 -0400 SERVER (trace) [7]:0 <- @disposition(21) [role=true, first=5, last=7, settled=true,}}
{{2018-08-01 10:45:25.206902 -0400 SERVER (trace) [6]:0 -> @transfer(20) [handle=0, delivery-id=60,}}
{{new a_b. a: 2018-08-01 10:45:25.214388 b: 2018-08-01 10:45:25.213739 diff: 0:00:00.000649 a-lineno: 2040}}
{{2018-08-01 10:45:25.214388 -0400 SERVER (trace) [5]:0 <- @transfer(20) [handle=0, delivery-id=37,}}
{{2018-08-01 10:45:25.213739 -0400 SERVER (trace) [7]:0 -> @transfer(20) [handle=0, delivery-id=18,}}
{{new a_b. a: 2018-08-01 10:45:25.220572 b: 2018-08-01 10:45:25.214488 diff: 0:00:00.006084 a-lineno: 2093}}
{{2018-08-01 10:45:25.220572 -0400 SERVER (trace) [6]:0 <- @disposition(21) [role=true, first=0, last=4, settled=true}}
{{2018-08-01 10:45:25.214488 -0400 SERVER (trace) [7]:0 -> @transfer(20) [handle=0, delivery-id=19,}}
> Log file messages out of order according to time stamps
> -------------------------------------------------------
>
> Key: DISPATCH-1094
> URL: https://issues.apache.org/jira/browse/DISPATCH-1094
> Project: Qpid Dispatch
> Issue Type: Bug
> Affects Versions: 1.2.0
> Environment: Fedora 27
> Reporter: Chuck Rolke
> Priority: Major
>
> In a recent run with trace logging turned on the trace file had 5,335 lines with several hundred instances of non-increasing timestamps.
> {{2018-08-01 10:45:25.198173}}
> {{2018-08-01 10:45:25.198187}}
> {{2018-08-01 10:45:25.197941}}
> {{2018-08-01 10:45:25.197727}}
> {{2018-08-01 10:45:25.198238}}
> Log file readers need to know to SORT the log file before scrutinizing it too carefully.
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@qpid.apache.org
For additional commands, e-mail: dev-help@qpid.apache.org