[xymon] Wrong (or badly interpreted) http response time with hobbit 4.2.0

[Benoit SCHMID]

-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1

Hello,

I have run the command but it returns a "correct" time:

2010-10-01 16:31:00 Adding tcp test IP=129.194.x.y, port=80,
service=http, silent=0
...
2010-10-01 16:31:00 TCP tests completed normally
Address=129.194.x.y:80, open=1, res=0, err=0, connecttime=0.000529,
totaltime=0.019607
httpstatus = 200, open=1, errcode=0, parsestatus=0
Response:
HTTP/1.1 200 OK
Date: Fri, 01 Oct 2010 14:31:00 GMT
Server: Oracle-Application-Server-10g/10.1.2.2.0 Oracle-HTTP-Server
Content-Location: index.html.en
Vary: negotiate,accept-language
TCN: choice
Last-Modified: Mon, 16 Nov 2009 11:13:38 GMT
ETag: "0-37a8-4b0133e2;4b0133e2"
Accept-Ranges: bytes
Content-Length: 14248
Connection: close
Content-Type: text/html
Content-Language: en

URL                      : http://x.unige.ch/
HTTP status              : 200
HTTP headers
HTTP/1.1 200 OK
Date: Fri, 01 Oct 2010 14:31:00 GMT
Server: Oracle-Application-Server-10g/10.1.2.2.0 Oracle-HTTP-Server
Content-Location: index.html.en
Vary: negotiate,accept-language
TCN: choice
Last-Modified: Mon, 16 Nov 2009 11:13:38 GMT
ETag: "0-37a8-4b0133e2;4b0133e2"
Accept-Ranges: bytes
Content-Length: 14248
Connection: close
Content-Type: text/html
Content-Language: en

HTTP output
(NULL)
- ---------------------------------------------
...
2010-10-01 16:31:00 Calc http color host x : 2010-10-01 16:31:00
http://x.unige.ch(green) 2010-10-01 16:31:00  --> green
2010-10-01 16:31:00 Adding to combo msg: status x.http green Fri Oct  1
 16:31:00 2010: OK
2010-10-01 16:31:00 Calc content color host x : 2010-10-01 16:31:00 Flu
shing combo message
      status x.http green Fri Oct  1 16:31:00 2010: OK
2010-10-01 16:31:00 Transport setup is:
2010-10-01 16:31:00 bbdportnumber = 1984
2010-10-01 16:31:00 bbdispproxyhost = NONE
2010-10-01 16:31:00 bbdispproxyport = 0
2010-10-01 16:31:00 Recipient listed as '10.194.x.y'
2010-10-01 16:31:00 Standard BB protocol on port 1984
2010-10-01 16:31:00 Will connect to address 10.194.x.y port 1984
2010-10-01 16:31:00 Connect status is 0
2010-10-01 16:31:00 Sent 517 bytes
2010-10-01 16:31:00 Closing connection
2010-10-01 16:31:00 1 status messages merged into 1 transmissions

Honestly, I do not not understand why It reports:
Seconds:     3.47
in hobbit as the bbnet reports
connecttime=0.000529, totaltime=0.019607

Thanks in advance for your help.

On 09/23/2010 02:56 PM, Henrik Størner wrote:
> In <4C848223.3060002 at unige.ch> Benoit SCHMID <Benoit.Schmid at unige.ch> writes:
> 
>> Has anyone an idea on how I could trace why I have these wrong response
>> time?
> 
> The only real way of tracing it is to run bbtest-net with "--debug".
> 
>  bbcmd bbtest-net --debug my.server.name
> 
> You'll probably want to dump that output to a file...
> 
> What you'll get from this looks something like this:
> 
>   2010-09-23 14:50:14 About to do 3 TCP tests running 256 in parallel, abs.max 1014
>   2010-09-23 14:50:14 3 tests pending - 3 active tests, 0 slow tests
> "3 active tests" means at this point the connection is being established.
> For debugging your http problems, it is probably best to trim your
> list of tests in the bb-hosts file so you only run one test.
> 
>   2010-09-23 14:50:14 Doing select with maxfd=4
> We're waiting for data from the server
> 
>   2010-09-23 14:50:14 select returned 1
>   2010-09-23 14:50:14 read 680 bytes from socket
> We now got 680 bytes.
> 
>   2010-09-23 14:50:14 HDC IN : state=0, leftinchunk=0, len=440
>   2010-09-23 14:50:14 HDC OUT: state=0, leftinchunk=0, len=0
> Xymon is decoding the "chunked data" sent by the HTTP server.
> 
>   2010-09-23 14:50:14 TCP tests completed normally
> Connection has been closed
> 
>   Address=172.16.10.2:80, open=1, res=0, err=0, connecttime=0.001439, totaltime=0.00351
> The time spent doing the connect, and the total time. The latter
> is the one that is reported to the Xymon server.
> 
> 
> Regards,
> Henrik
> 
> 
> To unsubscribe from the xymon list, send an e-mail to
> xymon-unsubscribe at xymon.com
> 
> 

- -- 
_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/

     Benoit Schmid              Tel: (++41-22) 379-7209

     University of Geneva - Information Technology Division

_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/_/
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.10 (GNU/Linux)
Comment: Using GnuPG with Mozilla - http://enigmail.mozdev.org/

iEYEARECAAYFAkyl8wIACgkQPzupdm8Bofxu7ACeM1HOE7o1dGQxV0oL2Hn8kwWp
cMQAoIWdj/YSGtyP6b4NN+zuTYFmvF+P
=Wr3s
-----END PGP SIGNATURE-----