You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@jmeter.apache.org by Bruno Michaud <Br...@cn.ca> on 2015/04/01 19:17:41 UTC
RE: Debugging a timeout problem
Thanks,
That is what I needed.
ecprod.cn.ca is the website, and with the debug options you gave me, it looks like it has nothing to do with proxy or firewall.
I simplified the matters by using a straight HTTP instead of HTTPS but I get the same results.
I now have a good starting point to go discuss the issue with the application support. Maybe they can trace their entry point to see what the trouble is.
This is a log that fails (windows workstation)
2015/04/01 11:15:24 INFO - jmeter.protocol.http.sampler.HTTPHCAbstractImpl: Local host = C305827
2015/04/01 11:15:24 INFO - jmeter.protocol.http.sampler.HTTPHC4Impl: HTTP request retry count = 0
2015/04/01 11:15:24 INFO - jmeter.protocol.http.sampler.HTTPHC4Impl: Setting up HTTPS TrustAll scheme
2015/04/01 11:15:25 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: notifyFirstSampleAfterLoopRestart
2015/04/01 11:15:25 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: Start : sample http://ecprod.cn.ca/quickLogin_en.html 2015/04/01 11:15:25 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: method GET followingRedirect false depth 0
2015/04/01 11:15:25 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: Created new HttpClient: @1347218262 http://ecprod.cn.ca
2015/04/01 11:15:25 DEBUG - jmeter.protocol.http.control.HC3CookieHandler: Found 0 cookies for http://ecprod.cn.ca/quickLogin_en.html
2015/04/01 11:15:25 DEBUG - org.apache.http.impl.conn.PoolingClientConnectionManager: Connection request: [route: {}->http://ecprod.cn.ca][total kept alive: 0; route allocated: 0 of 2; total allocated: 0 of 20]
2015/04/01 11:15:25 DEBUG - org.apache.http.impl.conn.PoolingClientConnectionManager: Connection leased: [id: 0][route: {}->http://ecprod.cn.ca][total kept alive: 0; route allocated: 1 of 2; total allocated: 1 of 20]
2015/04/01 11:15:25 DEBUG - org.apache.http.impl.conn.DefaultClientConnectionOperator: Connecting to ecprod.cn.ca:80
2015/04/01 11:15:26 DEBUG - org.apache.http.impl.conn.DefaultClientConnection: Connection org.apache.http.impl.conn.DefaultClientConnection@402e5bfe closed
2015/04/01 11:15:26 DEBUG - org.apache.http.impl.conn.DefaultClientConnection: Connection org.apache.http.impl.conn.DefaultClientConnection@402e5bfe shut down
2015/04/01 11:15:26 DEBUG - org.apache.http.impl.conn.DefaultClientConnection: Connection org.apache.http.impl.conn.DefaultClientConnection@402e5bfe closed
2015/04/01 11:15:26 DEBUG - org.apache.http.impl.conn.PoolingClientConnectionManager: Connection released: [id: 0][route: {}->http://ecprod.cn.ca][total kept alive: 0; route allocated: 0 of 2; total allocated: 0 of 20]
2015/04/01 11:15:26 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: IOException org.apache.http.conn.ConnectTimeoutException: Connect to ecprod.cn.ca:80 timed out
at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:129)
at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:180)
at org.apache.http.impl.conn.ManagedClientConnectionImpl.open(ManagedClientConnectionImpl.java:294)
at org.apache.http.impl.client.DefaultRequestDirector.tryConnect(DefaultRequestDirector.java:643)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:479)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
at org.apache.jmeter.protocol.http.sampler.HTTPHC4Impl.executeRequest(HTTPHC4Impl.java:505)
at org.apache.jmeter.protocol.http.sampler.HTTPHC4Impl.sample(HTTPHC4Impl.java:328)
at org.apache.jmeter.protocol.http.sampler.HTTPSamplerProxy.sample(HTTPSamplerProxy.java:74)
at org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1141)
at org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1130)
at org.apache.jmeter.threads.JMeterThread.process_sampler(JMeterThread.java:431)
at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:258)
at java.lang.Thread.run(Unknown Source)
Caused by: java.net.SocketTimeoutException: connect timed out
at java.net.DualStackPlainSocketImpl.waitForConnect(Native Method)
at java.net.DualStackPlainSocketImpl.socketConnect(Unknown Source)
at java.net.AbstractPlainSocketImpl.doConnect(Unknown Source)
at java.net.AbstractPlainSocketImpl.connectToAddress(Unknown Source)
at java.net.AbstractPlainSocketImpl.connect(Unknown Source)
at java.net.PlainSocketImpl.connect(Unknown Source)
at java.net.SocksSocketImpl.connect(Unknown Source)
at java.net.Socket.connect(Unknown Source)
at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:127)
... 14 more
And this is a log that works (Linux server or Windows server)
2015/04/01 11:35:51 INFO - jmeter.protocol.http.sampler.HTTPHCAbstractImpl: Local host = MTL-HQ-A315
2015/04/01 11:35:51 INFO - jmeter.protocol.http.sampler.HTTPHC4Impl: HTTP request retry count = 0
2015/04/01 11:35:51 INFO - jmeter.protocol.http.sampler.HTTPHC4Impl: Setting up HTTPS TrustAll scheme
2015/04/01 11:35:51 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: notifyFirstSampleAfterLoopRestart
2015/04/01 11:35:51 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: Start : sample http://ecprod.cn.ca/quickLogin_en.html
2015/04/01 11:35:51 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: method GET followingRedirect false depth 0
2015/04/01 11:35:51 DEBUG - jmeter.protocol.http.sampler.HTTPHC4Impl: Created new HttpClient: @31190396 http://ecprod.cn.ca
2015/04/01 11:35:51 DEBUG - jmeter.protocol.http.control.HC3CookieHandler: Found 0 cookies for http://ecprod.cn.ca/quickLogin_en.html
2015/04/01 11:35:51 DEBUG - org.apache.http.impl.conn.PoolingClientConnectionManager: Connection request: [route: {}->http://ecprod.cn.ca][total kept alive: 0; route allocated: 0 of 2; total allocated: 0 of 20]
2015/04/01 11:35:51 DEBUG - org.apache.http.impl.conn.PoolingClientConnectionManager: Connection leased: [id: 0][route: {}->http://ecprod.cn.ca][total kept alive: 0; route allocated: 1 of 2; total allocated: 1 of 20]
2015/04/01 11:35:51 DEBUG - org.apache.http.impl.conn.DefaultClientConnectionOperator: Connecting to ecprod.cn.ca:80
2015/04/01 11:35:51 DEBUG - org.apache.http.client.protocol.RequestAddCookies: CookieSpec selected: ignoreCookies
2015/04/01 11:35:51 DEBUG - org.apache.http.client.protocol.RequestAuthCache: Auth cache not set in the context
2015/04/01 11:35:51 DEBUG - org.apache.http.client.protocol.RequestTargetAuthentication: Target auth state: UNCHALLENGED
2015/04/01 11:35:51 DEBUG - org.apache.http.client.protocol.RequestProxyAuthentication: Proxy auth state: UNCHALLENGED
2015/04/01 11:35:51 DEBUG - org.apache.http.impl.conn.DefaultClientConnection: Sending request: GET /quickLogin_en.html HTTP/1.1
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "GET /quickLogin_en.html HTTP/1.1[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "Connection: keep-alive[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "Accept-Language: en-US, en-CA[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "Accept: text/html, application/xhtml+xml, */*[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "User-Agent: Mozilla/5.0 (Windows NT 6.1; Trident/7.0; rv:11.0) like Gecko[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "Accept-Encoding: gzip, deflate[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "DNT: 1[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "Pragma: no-cache[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "Cache-Control: no-cache[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "Host: ecprod.cn.ca[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: >> "[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> GET /quickLogin_en.html HTTP/1.1
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> Connection: keep-alive
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> Accept-Language: en-US, en-CA
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> Accept: text/html, application/xhtml+xml, */*
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> User-Agent: Mozilla/5.0 (Windows NT 6.1; Trident/7.0; rv:11.0) like Gecko
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> Accept-Encoding: gzip, deflate
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> DNT: 1
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> Pragma: no-cache
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> Cache-Control: no-cache
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: >> Host: ecprod.cn.ca
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: << "HTTP/1.1 200 OK[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: << "content-length: 1344[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: << "content-type: text/html[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: << "date: Wed, 01 Apr 2015 15:35:51 GMT[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: << "last-modified: Fri, 28 Aug 2009 15:10:05 GMT[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: << "p3p: CP="NON CUR OTPi OUR NOR UNI"[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.wire: << "[\r][\n]"
2015/04/01 11:35:51 DEBUG - org.apache.http.impl.conn.DefaultClientConnection: Receiving response: HTTP/1.1 200 OK
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: << HTTP/1.1 200 OK
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: << content-length: 1344
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: << content-type: text/html
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: << date: Wed, 01 Apr 2015 15:35:51 GMT
2015/04/01 11:35:51 DEBUG - org.apache.http.headers: << last-modified: Fri, 28 Aug 2009 15:10:05 GMT
Best regards,
Bruno Michaud
-----Original Message-----
From: UBIK LOAD PACK Support [mailto:support@ubikloadpack.com]
Sent: Tuesday, March 31, 2015 4:07 PM
To: JMeter Users List
Subject: Re: Debugging a timeout problem
Hi,
What is ecprod.cn.ca:443 ? is it your proxy or target server ?
1/ Double check that you didn't make a mistake when launching jmeter on Windows 2/ Double check there is no Firewall on Windows machine that blocks IP
To debug this, add to user.properties:
log_level.org.apache.http=DEBUG
log_level.org.apache.http.wire=DEBUG
Regards
@ubikloadpack
On Tue, Mar 31, 2015 at 8:37 PM, Bruno Michaud <Br...@cn.ca> wrote:
> Hello all,
> I am having a peculiar problem and I don't know how to approach it.
> This is the scenario: I run a very simple script that does a single
> GET page on an internal server. My command to invoke JMeter includes
> the "-H proxyname -P portnumber -N *.ourdomainname", so I think I
> should be bypassing the proxy.
>
> If I run this on a Linux box, it works just fine: I get the page I
> expected with a return code 200.
>
> If I run it on my Windows workstation I get the following error in the
> Sampler result:
> Response code: Non HTTP response code:
> org.apache.http.conn.ConnectTimeoutException
> Response message: Non HTTP response message: Connect to
> ecprod.cn.ca:443 timed out And I get this in the Response data:
> org.apache.http.conn.ConnectTimeoutException: Connect
> to
> ecprod.cn.ca:443 timed out
> at
> org.apache.http.conn.ssl.SSLSocketFactory.connectSocket(SSLSocketFactory.java:416)
> at
> org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:180)
> at
> org.apache.http.impl.conn.ManagedClientConnectionImpl.open(ManagedClientConnectionImpl.java:294)
> at
> org.apache.jmeter.protocol.http.sampler.MeasuringConnectionManager$MeasuredConnection.open(MeasuringConnectionManager.java:107)
> at
> org.apache.http.impl.client.DefaultRequestDirector.tryConnect(DefaultRequestDirector.java:643)
> at
> org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:479)
> at
> org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
> at
> org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
> at
> org.apache.jmeter.protocol.http.sampler.HTTPHC4Impl.executeRequest(HTTPHC4Impl.java:517)
> at
> org.apache.jmeter.protocol.http.sampler.HTTPHC4Impl.sample(HTTPHC4Impl.java:331)
> at
> org.apache.jmeter.protocol.http.sampler.HTTPSamplerProxy.sample(HTTPSamplerProxy.java:74)
> at
> org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1146)
> at
> org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1135)
> at
> org.apache.jmeter.threads.JMeterThread.process_sampler(JMeterThread.java:434)
> at
> org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:261)
> at java.lang.Thread.run(Unknown Source)
> Caused by: java.net.SocketTimeoutException: connect timed out
> at
> java.net.DualStackPlainSocketImpl.waitForConnect(Native
> Method)
> at
> java.net.DualStackPlainSocketImpl.socketConnect(Unknown
> Source)
> at java.net.AbstractPlainSocketImpl.doConnect(Unknown
> Source)
> at
> java.net.AbstractPlainSocketImpl.connectToAddress(Unknown Source)
> at java.net.AbstractPlainSocketImpl.connect(Unknown Source)
> at java.net.PlainSocketImpl.connect(Unknown Source)
> at java.net.SocksSocketImpl.connect(Unknown Source)
> at java.net.Socket.connect(Unknown Source)
> at sun.security.ssl.SSLSocketImpl.connect(Unknown Source)
> at
> org.apache.http.conn.ssl.SSLSocketFactory.connectSocket(SSLSocketFactory.java:414)
> ... 15 more
>
> My JMeter is the same version on both Linux and Windows (2.12), with
> the same Java version and build (1.7.0_21-b11). The jmeter.properties
> and system.properties are also identical.
> Of course Windows and Linux are two very different animals, but
> everything else being the same, I don't know how to approach this problem.
> I tried turning on the "DEBUG" options but that generates so much data
> that it is very hard to decipher what's good and what's not.
> Could anyone suggest how I can go about debugging this ? Maybe only
> specific "log_level.jmeter.??=DEBUG" but I don't know which ones to pick.
> Any other suggestions ?
>
>
> Thanks & Regards,
> Bruno Michaud
>
--
Regards
Ubik Load Pack <http://ubikloadpack.com> Team Follow us on Twitter <http://twitter.com/ubikloadpack>
Cordialement
L'équipe Ubik Load Pack <http://ubikloadpack.com> Suivez-nous sur Twitter <http://twitter.com/ubikloadpack>
---------------------------------------------------------------------
To unsubscribe, e-mail: user-unsubscribe@jmeter.apache.org
For additional commands, e-mail: user-help@jmeter.apache.org