From f870028fd26f8ac1a2fcb6e43e0d7d1c76c110ec Mon Sep 17 00:00:00 2001 From: Jeremy Harris Date: Sun, 11 Apr 2021 16:39:06 +0100 Subject: Log queue_time and queue_time_overall exclusive of receive time. Bug 2672 --- doc/doc-docbook/spec.xfpt | 10 +++------- doc/doc-txt/ChangeLog | 5 +++++ doc/doc-txt/NewStuff | 3 +++ 3 files changed, 11 insertions(+), 7 deletions(-) (limited to 'doc') diff --git a/doc/doc-docbook/spec.xfpt b/doc/doc-docbook/spec.xfpt index 437b13df0..36be62f7a 100644 --- a/doc/doc-docbook/spec.xfpt +++ b/doc/doc-docbook/spec.xfpt @@ -38672,6 +38672,7 @@ selection marked by asterisks: &` outgoing_port `& add remote port to => lines &`*queue_run `& start and end queue runs &` queue_time `& time on queue for one recipient +&`*queue_time_exclusive `& exclude recieve time from QT times &` queue_time_overall `& time on queue for whole message &` pid `& Exim process id &` pipelining `& PIPELINING use, on <= and => lines @@ -38913,18 +38914,13 @@ Delivery "L" fields have an asterisk appended if used. .cindex "log" "queue time" &%queue_time%&: The amount of time the message has been in the queue on the local host is logged as QT=<&'time'&> on delivery (&`=>`&) lines, for example, -&`QT=3m45s`&. The clock starts when Exim starts to receive the message, so it -includes reception time as well as the delivery time for the current address. -This means that it may be longer than the difference between the arrival and -delivery log line times, because the arrival log line is not written until the -message has been successfully received. +&`QT=3m45s`&. If millisecond logging is enabled, short times will be shown with greater precision, eg. &`QT=1.578s`&. .next &%queue_time_overall%&: The amount of time the message has been in the queue on the local host is logged as QT=<&'time'&> on &"Completed"& lines, for -example, &`QT=3m45s`&. The clock starts when Exim starts to receive the -message, so it includes reception time as well as the total delivery time. +example, &`QT=3m45s`&. .next .cindex "log" "receive duration" &%receive_time%&: For each message, the amount of real time it has taken to diff --git a/doc/doc-txt/ChangeLog b/doc/doc-txt/ChangeLog index db4735f8f..916a4c470 100644 --- a/doc/doc-txt/ChangeLog +++ b/doc/doc-txt/ChangeLog @@ -236,6 +236,11 @@ JH/49 Bug 2710: when using SOCKS for additional messages after the first (a transport executions. This also mean that the log lines for the messages can show the proxy information. +JH/50 Bug 2672: QT elements in log lines, unless disabled, now exclude the + receive time. With modern systems the difference is significant. + The historical behaviour can be restored by disabling (a new) log_selector + "queue_time_exclusive". + Exim version 4.94 diff --git a/doc/doc-txt/NewStuff b/doc/doc-txt/NewStuff index 50f7b4357..0ac271eaf 100644 --- a/doc/doc-txt/NewStuff +++ b/doc/doc-txt/NewStuff @@ -48,6 +48,9 @@ Version 4.95 13. Option "smtp_accept_msx_per_connection" is now expanded. +14. Log selector "queue_size_exclusive", enabled by default, to exclude the + time taken for reception from QT log elements. + Version 4.94 ------------ -- cgit v1.2.3