Fix RangeTestCase and AsynchroneTestCase

[thboileau]

At this time, the RangeTestCase#testPut and AsynchroneTestCase#testPut test cases fail. There is an issue when using the HttpUrlConnection-base client which leads the server to be unable to get the incoming entity.
The sequence of requests is: GET request, then PUT, then POST. The test hangs on the PUT request.

[thboileau]

The following Wireshark trace shows that the entity is no sent by the client connector, although the "Content-Length: 7" header.

PUT /?item=0 HTTP/1.1
Date: Sat, 25 Jan 2014 21:05:45 GMT
Content-Type: text/plain; charset=UTF-8
Accept: */*
User-Agent: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@
Cache-Control: no-cache
Pragma: no-cache
Host: localhost:1337
Connection: keep-alive
Content-Length: 7

HTTP/1.1 200 OK
Content-type: text/plain; charset=UTF-8
Content-length: 128
Server: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@
Date: Sat, 25 Jan 2014 21:06:25 GMT

Resource URI:  http://localhost:1337/?item=0
Base URI:      http://localhost:1337
Remaining part: /?item=0
Method name: PUT

[thboileau]

turn on debug traces for all packages.

Setting up test org.restlet.test.engine.connector.AsynchroneTestCase#testGet
25-Jan-2014 22:05:45 sun.net.httpserver.ServerImpl <init>
CONFIG: HttpServer created http 0.0.0.0/0.0.0.0:1337
25-Jan-2014 22:05:45 sun.net.httpserver.ServerImpl createContext
CONFIG: context created: /
25-Jan-2014 22:05:45 org.restlet.engine.net.NetServerHelper start
INFO: Starting the internal [HTTP/1.1] server on port 1337
25-Jan-2014 22:05:45 org.restlet.engine.net.HttpClientHelper start
INFO: Starting the internal HTTP client
25-Jan-2014 22:05:45 org.restlet.engine.component.ClientRoute score
FINER: Call score for the "[HTTP/1.1]" client: 1.0
25-Jan-2014 22:05:45 org.restlet.engine.component.ClientRouter logRoute
FINE: This client was selected: "[HTTP/1.1]"
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: ProxySelector Request for http://localhost:1337/?item=0
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: Proxy used: DIRECT
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: sun.net.www.MessageHeader@e61fd18 pairs: {GET /?item=0 HTTP/1.1: null}{Date: Sat, 25 Jan 2014 21:05:45 GMT}{Accept: */*}{User-Agent: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@}{Cache-Control: no-cache}{Pragma: no-cache}{Host: localhost:1337}{Connection: keep-alive}
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: HttpClient.writeRequests() streaming=false
25-Jan-2014 22:05:45 org.restlet.engine.log.LogFilter beforeHandle
FINE: Processing request to: "http://localhost:1337/?item=0"
25-Jan-2014 22:05:45 org.restlet.engine.component.HostRoute score
FINER: Call score for the "org.restlet.routing.VirtualHost@17e4ca" host: 1.0
25-Jan-2014 22:05:45 org.restlet.engine.component.ServerRouter logRoute
FINE: Default virtual host selected
25-Jan-2014 22:05:45 org.restlet.engine.component.HostRoute beforeHandle
FINE: Base URI: "http://localhost:1337". Remaining part: "/?item=0"
25-Jan-2014 22:05:45 org.restlet.routing.TemplateRoute score
FINER: Call score for the "" URI pattern: 0.5
25-Jan-2014 22:05:45 org.restlet.routing.Router logRoute
FINE: The default route was selected
25-Jan-2014 22:05:45 org.restlet.routing.TemplateRoute beforeHandle
FINER: No characters were matchedhttp://localhost:1337/?item=0 /
25-Jan-2014 22:05:45 org.restlet.engine.log.LogFilter afterHandle
INFO: 2014-01-25    22:05:45    127.0.0.1   -   -   1337    GET /   item=0  200 124 0   6   http://localhost:1337   Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@   -
25-Jan-2014 22:05:45 sun.net.httpserver.ServerImpl logReply
FINE: GET /?item=0 HTTP/1.1 [200  OK] ()
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: KeepAlive (0) stream used: http://localhost:1337/?item=0
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: sun.net.www.MessageHeader@e069405 pairs: {null: HTTP/1.1 200 OK}{Content-type: text/plain; charset=UTF-8}{Content-length: 124}{Server: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@}{Date: Sat, 25 Jan 2014 21:05:45 GMT}
25-Jan-2014 22:05:45 org.restlet.engine.net.HttpClientHelper stop
INFO: Stopping the internal HTTP client
25-Jan-2014 22:05:45 org.restlet.engine.net.NetServerHelper stop
INFO: Stopping the internal server
Setting up test org.restlet.test.engine.connector.AsynchroneTestCase#testPut25-Jan-2014 22:05:45 sun.net.httpserver.HttpConnection close
FINEST: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:1337 remote=/127.0.0.1:43689]

25-Jan-2014 22:05:45 sun.net.httpserver.ServerImpl <init>
CONFIG: HttpServer created http 0.0.0.0/0.0.0.0:1337
25-Jan-2014 22:05:45 sun.net.httpserver.ServerImpl createContext
CONFIG: context created: /
25-Jan-2014 22:05:45 org.restlet.engine.net.NetServerHelper start
INFO: Starting the internal [HTTP/1.1] server on port 1337
25-Jan-2014 22:05:45 org.restlet.engine.net.HttpClientHelper start
INFO: Starting the internal HTTP client
25-Jan-2014 22:05:45 org.restlet.engine.component.ClientRoute score
FINER: Call score for the "[HTTP/1.1]" client: 1.0
25-Jan-2014 22:05:45 org.restlet.engine.component.ClientRouter logRoute
FINE: This client was selected: "[HTTP/1.1]"
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: ProxySelector Request for http://localhost:1337/?item=0
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: Proxy used: DIRECT
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: sun.net.www.MessageHeader@100ebec10 pairs: {PUT /?item=0 HTTP/1.1: null}{Date: Sat, 25 Jan 2014 21:05:45 GMT}{Content-Type: text/plain; charset=UTF-8}{Accept: */*}{User-Agent: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@}{Cache-Control: no-cache}{Pragma: no-cache}{Host: localhost:1337}{Connection: keep-alive}{Content-Length: 7}
25-Jan-2014 22:05:45 sun.net.www.http.HttpCapture finest
FINEST: HttpClient.writeRequests() streaming=true
25-Jan-2014 22:05:45 org.restlet.engine.log.LogFilter beforeHandle
FINE: Processing request to: "http://localhost:1337/?item=0"
25-Jan-2014 22:05:45 org.restlet.engine.component.HostRoute score
FINER: Call score for the "org.restlet.routing.VirtualHost@6295eb" host: 1.0
25-Jan-2014 22:05:45 org.restlet.engine.component.ServerRouter logRoute
FINE: Default virtual host selected
25-Jan-2014 22:05:45 org.restlet.engine.component.HostRoute beforeHandle
FINE: Base URI: "http://localhost:1337". Remaining part: "/?item=0"
25-Jan-2014 22:05:45 org.restlet.routing.TemplateRoute score
FINER: Call score for the "" URI pattern: 0.5
25-Jan-2014 22:05:45 org.restlet.routing.Router logRoute
FINE: The default route was selected
25-Jan-2014 22:05:45 org.restlet.routing.TemplateRoute beforeHandle
FINER: No characters were matchedhttp://localhost:1337/?item=0 /
25-Jan-2014 22:06:25 org.restlet.engine.log.LogFilter afterHandle
INFO: 2014-01-25    22:06:25    127.0.0.1   -   -   1337    PUT /   item=0  200 128 7   40037   http://localhost:1337   Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@   -
25-Jan-2014 22:06:25 sun.net.httpserver.ServerImpl logReply
FINE: PUT /?item=0 HTTP/1.1 [200  OK] ()
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: KeepAlive (0) stream used: http://localhost:1337/?item=0
25-Jan-2014 22:06:25 sun.net.httpserver.HttpConnection close
FINEST: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:1337 remote=/127.0.0.1:43690]
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: sun.net.www.MessageHeader@26e9f95 pairs: {null: HTTP/1.1 200 OK}{Content-type: text/plain; charset=UTF-8}{Content-length: 128}{Server: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@}{Date: Sat, 25 Jan 2014 21:06:25 GMT}
25-Jan-2014 22:06:25 org.restlet.engine.net.HttpClientHelper stop
INFO: Stopping the internal HTTP client
25-Jan-2014 22:06:25 org.restlet.engine.net.NetServerHelper stop
INFO: Stopping the internal server
Setting up test org.restlet.test.engine.connector.AsynchroneTestCase#testPost
25-Jan-2014 22:06:25 sun.net.httpserver.ServerImpl <init>
CONFIG: HttpServer created http 0.0.0.0/0.0.0.0:1337
25-Jan-2014 22:06:25 sun.net.httpserver.ServerImpl createContext
CONFIG: context created: /
25-Jan-2014 22:06:25 org.restlet.engine.net.NetServerHelper start
INFO: Starting the internal [HTTP/1.1] server on port 1337
25-Jan-2014 22:06:25 org.restlet.engine.net.HttpClientHelper start
INFO: Starting the internal HTTP client
25-Jan-2014 22:06:25 org.restlet.engine.component.ClientRoute score
FINER: Call score for the "[HTTP/1.1]" client: 1.0
25-Jan-2014 22:06:25 org.restlet.engine.component.ClientRouter logRoute
FINE: This client was selected: "[HTTP/1.1]"
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: ProxySelector Request for http://localhost:1337/?item=0
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: HttpClient.available(): read returned -1: not available
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: Proxy used: DIRECT
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: sun.net.www.MessageHeader@8ceeea10 pairs: {POST /?item=0 HTTP/1.1: null}{Date: Sat, 25 Jan 2014 21:06:25 GMT}{Content-Type: text/plain; charset=UTF-8}{Accept: */*}{User-Agent: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@}{Cache-Control: no-cache}{Pragma: no-cache}{Host: localhost:1337}{Connection: keep-alive}{Content-Length: 7}
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: HttpClient.writeRequests() streaming=true
25-Jan-2014 22:06:25 org.restlet.engine.log.LogFilter beforeHandle
FINE: Processing request to: "http://localhost:1337/?item=0"
25-Jan-2014 22:06:25 org.restlet.engine.component.HostRoute score
FINER: Call score for the "org.restlet.routing.VirtualHost@1329642" host: 1.0
25-Jan-2014 22:06:25 org.restlet.engine.component.ServerRouter logRoute
FINE: Default virtual host selected
25-Jan-2014 22:06:25 org.restlet.engine.component.HostRoute beforeHandle
FINE: Base URI: "http://localhost:1337". Remaining part: "/?item=0"
25-Jan-2014 22:06:25 org.restlet.routing.TemplateRoute score
FINER: Call score for the "" URI pattern: 0.5
25-Jan-2014 22:06:25 org.restlet.routing.Router logRoute
FINE: The default route was selected
25-Jan-2014 22:06:25 org.restlet.routing.TemplateRoute beforeHandle
FINER: No characters were matchedhttp://localhost:1337/?item=0 /
25-Jan-2014 22:06:25 org.restlet.engine.log.LogFilter afterHandle
INFO: 2014-01-25    22:06:25    127.0.0.1   -   -   1337    POST    /   item=0  204 0   7   1   http://localhost:1337   Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@   -
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: sun.net.www.MessageHeader@1c505074 pairs: {null: HTTP/1.1 204 No Content}{Content-length: 0}{Server: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@}{Date: Sat, 25 Jan 2014 21:06:25 GMT}
25-Jan-2014 22:06:25 org.restlet.engine.net.HttpClientHelper stop
INFO: Stopping the internal HTTP client
25-Jan-2014 22:06:25 org.restlet.engine.net.NetServerHelper stop
INFO: Stopping the internal server
25-Jan-2014 22:06:25 sun.net.httpserver.ServerImpl logReply
FINE: POST /?item=0 HTTP/1.1 [204  No Content] ()
25-Jan-2014 22:06:25 sun.net.httpserver.HttpConnection close
FINEST: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:1337 remote=/127.0.0.1:43691]
Setting up test org.restlet.test.engine.connector.AsynchroneTestCase#testDelete
25-Jan-2014 22:06:25 sun.net.httpserver.ServerImpl <init>
CONFIG: HttpServer created http 0.0.0.0/0.0.0.0:1337
25-Jan-2014 22:06:25 sun.net.httpserver.ServerImpl createContext
CONFIG: context created: /
25-Jan-2014 22:06:25 org.restlet.engine.net.NetServerHelper start
INFO: Starting the internal [HTTP/1.1] server on port 1337
25-Jan-2014 22:06:25 org.restlet.engine.net.HttpClientHelper start
INFO: Starting the internal HTTP client
25-Jan-2014 22:06:25 org.restlet.engine.component.ClientRoute score
FINER: Call score for the "[HTTP/1.1]" client: 1.0
25-Jan-2014 22:06:25 org.restlet.engine.component.ClientRouter logRoute
FINE: This client was selected: "[HTTP/1.1]"
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: ProxySelector Request for http://localhost:1337/?item=0
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: Proxy used: DIRECT
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: sun.net.www.MessageHeader@7eb3668 pairs: {DELETE /?item=0 HTTP/1.1: null}{Date: Sat, 25 Jan 2014 21:06:25 GMT}{Accept: */*}{User-Agent: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@}{Cache-Control: no-cache}{Pragma: no-cache}{Host: localhost:1337}{Connection: keep-alive}
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: HttpClient.writeRequests() streaming=false
25-Jan-2014 22:06:25 org.restlet.engine.log.LogFilter beforeHandle
FINE: Processing request to: "http://localhost:1337/?item=0"
25-Jan-2014 22:06:25 org.restlet.engine.component.HostRoute score
FINER: Call score for the "org.restlet.routing.VirtualHost@da18ac" host: 1.0
25-Jan-2014 22:06:25 org.restlet.engine.component.ServerRouter logRoute
FINE: Default virtual host selected
25-Jan-2014 22:06:25 org.restlet.engine.component.HostRoute beforeHandle
FINE: Base URI: "http://localhost:1337". Remaining part: "/?item=0"
25-Jan-2014 22:06:25 org.restlet.routing.TemplateRoute score
FINER: Call score for the "" URI pattern: 0.5
25-Jan-2014 22:06:25 org.restlet.routing.Router logRoute
FINE: The default route was selected
25-Jan-2014 22:06:25 org.restlet.routing.TemplateRoute beforeHandle
FINER: No characters were matchedhttp://localhost:1337/?item=0 /
25-Jan-2014 22:06:25 org.restlet.engine.log.LogFilter afterHandle
INFO: 2014-01-25    22:06:25    127.0.0.1   -   -   1337    DELETE  /   item=0  204 0   0   1   http://localhost:1337   Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@   -
25-Jan-2014 22:06:25 sun.net.httpserver.ServerImpl logReply
FINE: DELETE /?item=0 HTTP/1.1 [204  No Content] ()
25-Jan-2014 22:06:25 sun.net.www.http.HttpCapture finest
FINEST: sun.net.www.MessageHeader@941db64 pairs: {null: HTTP/1.1 204 No Content}{Content-length: 0}{Server: Restlet-Framework/@major-number@.@minor-number@@release-type@@release-number@}{Date: Sat, 25 Jan 2014 21:06:25 GMT}
25-Jan-2014 22:06:25 sun.net.httpserver.HttpConnection close
FINEST: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:1337 remote=/127.0.0.1:43692]
25-Jan-2014 22:06:25 org.restlet.engine.net.HttpClientHelper stop
INFO: Stopping the internal HTTP client
25-Jan-2014 22:06:25 org.restlet.engine.net.NetServerHelper stop
INFO: Stopping the internal server

[thboileau]

In order to have a clearer point of view, I've divided the test code in two parts : client and server. I've was able to reproduce the issue several times but after a while the behaviour changed.