<div dir="ltr">Hi Geoff & Team,<div><br></div><div>Please help with understanding.</div><div><br></div><div>Thank you</div><div>Hardik</div></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Tue, 19 Mar 2019 at 11:48, Hardik <<a href="mailto:hetardik.p@gmail.com">hetardik.p@gmail.com</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div dir="ltr">This line is creating confusion for me..<br><div><a href="https://github.com/jib/libvmod-timers/blob/master/src/vmod_timers.c" target="_blank"><br class="gmail-m_-5117430617507739981m_3318608176332205223gmail-Apple-interchange-newline">https://github.com/jib/libvmod-timers/blob/master/src/vmod_timers.c</a><br></div><div><div>The sixth and last number (0.000025988) is the time from we start delivering the object until the request completes.</div></div><div><br></div><div>Thanks</div><div>Hardik</div></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Mon, 18 Mar 2019 at 21:20, Hardik <<a href="mailto:hetardik.p@gmail.com" target="_blank">hetardik.p@gmail.com</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div dir="ltr">Hi Geoff,<div><br></div><div>Thanks for reply. I understood meaning of the fields in varnish 6.</div><div><br></div><div>One answer I got that we should consider 0.048125 as total response time. But my actual question is different.<br></div><div>I am not getting difference between varnish 3 and varnish 6.  </div><div> <br></div><div>Exact question if I ask..<br><br></div><div><div><b>varnish 3</b></div><div><span style="font-family:SFMono-Regular,Consolas,"Liberation Mono",Menlo,Courier,monospace;font-size:12px;white-space:pre-wrap"><font color="#000000">ReqEnd c 877345549 1233949945.075706005 1233949945.075754881 0.017112017 0.000022888 <b>0.000025988</b></font></span>  <br></div><div><br></div><div><b>varnish 6.1</b></div><div>Timestamp Resp: 1501601912.806787<font color="#cc0000"><b> 0.048125</b></font> <b>0.000037</b></div></div><div><b><br></b></div><div><b>0.000025988 (varnish 3) is equivalent to 0.048125 or 0.000037 (varnish 6) ?</b></div><div><b><br></b></div><div>we have upgraded from 3 to 6 so not able to decide exact field which I was reading in case of varnish 3.</div><div><b><br></b></div><div><b>Thank you</b></div><div><b>Hardik</b></div><div><b><br></b></div><div><b><br></b></div></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Mon, 18 Mar 2019 at 16:52, Geoff Simmons <<a href="mailto:geoff@uplex.de" target="_blank">geoff@uplex.de</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex">On 3/18/19 12:09, Hardik wrote:<br>
> <br>
> *varnish 6.1*<br>
> Timestamp Resp: 1501601912.806787 0.048125 *0.000037*<br>
> <br>
> <a href="https://feryn.eu/blog/varnishlog-measure-varnish-cache-performance/#The_Timestamp_tag" rel="noreferrer" target="_blank">https://feryn.eu/blog/varnishlog-measure-varnish-cache-performance/#The_Timestamp_tag</a><br>
> <br>
> <br>
> -> Are both fields give same values, means same meaning or both are<br>
> different? In varnish 3 I was reading last field. And as per explanation<br>
> its time from delivery to end of request ( and not total time from start of<br>
> request till end, plz correct if wrong). Based on this explanation I am<br>
> reading resp time only and no total time in resp tag. Do I have to read<br>
> 0.048125 to be compatible with varnish 3 or I am doing correct ?<br>
<br>
man vsl(7) is your friend here:<br>
<br>
              The format is:<br>
<br>
                 %s: %f %f %f<br>
                 |   |  |  |<br>
                 |   |  |  +- Time since last timestamp<br>
                 |   |  +---- Time since start of work unit<br>
                 |   +------- Absolute time of event<br>
                 +----------- Event label<br>
<br>
So the second number is the time since request processing began, and the<br>
third number is the time since the previous timestamp.<br>
<br>
Timestamp:Resp usually comes after Timestamp:Process:<br>
<br>
       Process<br>
              Processing finished, ready to deliver the client response.<br>
<br>
       Resp   Delivery of response to the client finished.<br>
<br>
So in your example, it's 48.125ms since the start of request processing,<br>
and 37µs since the previous timestamp, usually meaning 37µs for response<br>
delivery.<br>
<br>
The second field of Timestamp:Resp (48ms here) is a good measure of the<br>
total time to process the request.<br>
<br>
<br>
HTH,<br>
Geoff<br>
-- <br>
** * * UPLEX - Nils Goroll Systemoptimierung<br>
<br>
Scheffelstraße 32<br>
22301 Hamburg<br>
<br>
Tel +49 40 2880 5731<br>
Mob +49 176 636 90917<br>
Fax +49 40 42949753<br>
<br>
<a href="http://uplex.de" rel="noreferrer" target="_blank">http://uplex.de</a><br>
<br>
</blockquote></div>
</blockquote></div>
</blockquote></div>