https://issues.apache.org/bugzilla/show_bug.cgi?id=55993
Bug ID: 55993
Summary: Apache SSL new request sends junk values
Product: Apache httpd-2
Version: 2.2.25
Hardware: Other
Status: NEW
Severity: major
Priority: P2
Component: mod_ssl
Assignee: [email protected]
Reporter: [email protected]
Hi,
I use apache http server 2.2.25 for windows 32 bit
This is used to reverse proxy to weblogic environment , using weblogic plugin
version 1.1
http in the same configuration works fine
pasting logfile
014-01-12T11:33:38.0588-04:00 <4968413895408182> ================New Request:
[€F] =================
2014-01-12T11:33:38.0588-04:00 <4968413895408182> INFO: SSL is configured
2014-01-12T11:33:38.0588-04:00 <4968413895408182> Using Uri /
2014-01-12T11:33:38.0588-04:00 <4968413895408182> After trimming path: '/'
2014-01-12T11:33:38.0588-04:00 <4968413895408182> The final request string is
'/'
2014-01-12T11:33:38.0588-04:00 <4968413895408182> parseServerList: Socket
Address hostnames 'gafindev.arielre.com:11200'
2014-01-12T11:33:38.0598-04:00 <4968413895408182> Host extracted from
serverlist is [gafindev.arielre.com]
2014-01-12T11:33:38.0598-04:00 <4968413895408182> parseServerList: trying IP
addr 127.0.0.1
2014-01-12T11:33:38.0598-04:00 <4968413895408182> parseServerList: socket and
connect succeeded
2014-01-12T11:33:38.0608-04:00 <4968413895408182> parseServerList: IP from
socket Address [127.0.0.1]
2014-01-12T11:33:38.0608-04:00 <4968413895408182> Initializing lastIndex=0 for
a list of length=1
2014-01-12T11:33:38.0618-04:00 <4968413895408182> getListNode: created a new
server node: id='gafindev.arielre.com:11200'
server_name='SVRGAWEB01.ariel.internal', port='80'
2014-01-12T11:33:38.0618-04:00 <4968413895408182> attempt #0 out of a max of 5
2014-01-12T11:33:38.0618-04:00 <4968413895408182> keepAlive = 1, canRecycle = 1
2014-01-12T11:33:38.0618-04:00 <4968413895408183> ================New Request:
[€F] =================
2014-01-12T11:33:38.0618-04:00 <4968413895408182> Trying a pooled connection
for '127.0.0.1/11200/11200'
2014-01-12T11:33:38.0618-04:00 <4968413895408183> INFO: SSL is configured
2014-01-12T11:33:38.0618-04:00 <4968413895408182> getPooledConn: found a host
and port/securePort match
2014-01-12T11:33:38.0618-04:00 <4968413895408183> Using Uri /
2014-01-12T11:33:38.0618-04:00 <4968413895408182> getPooledConn: No more
connections in the pool for Host[127.0.0.1] Port[11200] SecurePort[11200]
2014-01-12T11:33:38.0618-04:00 <4968413895408183> After trimming path: '/'
2014-01-12T11:33:38.0618-04:00 <4968413895408182> general list: trying connect
to '127.0.0.1'/11200/11200 at line 2384 for '/'
2014-01-12T11:33:38.0618-04:00 <4968413895408183> The final request string is
'/'
2014-01-12T11:33:38.0618-04:00 <4968413895408183> SEARCHING
id=[gafindev.arielre.com:11200] from current ID=[gafindev.arielre.com:11200]
2014-01-12T11:33:38.0618-04:00 <4968413895408183> The two ids matched
2014-01-12T11:33:38.0618-04:00 <4968413895408183>
@@@FOUND...id=[gafindev.arielre.com:11200],
server_name=[SVRGAWEB01.ariel.internal], server_port=[80]
2014-01-12T11:33:38.0618-04:00 <4968413895408183> attempt #0 out of a max of 5
2014-01-12T11:33:38.0618-04:00 <4968413895408183> keepAlive = 1, canRecycle = 1
2014-01-12T11:33:38.0618-04:00 <4968413895408183> Trying a pooled connection
for '127.0.0.1/11200/11200'
2014-01-12T11:33:38.0618-04:00 <4968413895408183> getPooledConn: found a host
and port/securePort match
2014-01-12T11:33:38.0618-04:00 <4968413895408183> getPooledConn: No more
connections in the pool for Host[127.0.0.1] Port[11200] SecurePort[11200]
2014-01-12T11:33:38.0618-04:00 <4968413895408183> general list: trying connect
to '127.0.0.1'/11200/11200 at line 2384 for '/'
2014-01-12T11:33:38.0628-04:00 <4968413895408182> URL::Connect: Connected
successfully
2014-01-12T11:33:38.0628-04:00 <4968413895408183> URL::Connect: Connected
successfully
2014-01-12T11:33:38.0968-04:00 <4968413895407971> mod_weblogic(ssl): SSL
Handshake successful
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Local Port of the socket is
61093
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Remote Host 127.0.0.1 Remote
Port 61093
2014-01-12T11:33:38.0968-04:00 <4968413895408182> general list: created a new
connection to '127.0.0.1'/11200 for '/', Local port:61093
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Entering method
BaseProxy::sendRequest
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Entering method
BaseProxy::parse_headers
2014-01-12T11:33:38.0968-04:00 <4968413895408182> No of headers =0
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Exiting method
BaseProxy::parse_headers
2014-01-12T11:33:38.0968-04:00 <4968413895408182> parse_client_headers is done
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Method is €F
2014-01-12T11:33:38.0968-04:00 <4968413895408182> URL::sendHeaders():
meth='€F' file='/' protocol='HTTP/0.9'
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[Connection]=[Keep-Alive]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[WL-Proxy-SSL]=[true]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[Host]=[SVRGAWEB01.ariel.internal:80]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[X-Forwarded-For]=[127.0.0.1]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[WL-Proxy-Client-IP]=[127.0.0.1]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[Proxy-Client-IP]=[127.0.0.1]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[WL-Proxy-Client-Port]=[61090]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[X-WebLogic-KeepAliveSecs]=[30]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Header to WLS:
[X-WebLogic-Force-JVMID]=[unset]
2014-01-12T11:33:38.0968-04:00 <4968413895408182> Need to send 268
2014-01-12T11:33:38.0978-04:00 <4968413895408182> SSLWrite sent 268, Error = 0
2014-01-12T11:33:38.0978-04:00 <4968413895408182> SSLWrite completed, sent 268
2014-01-12T11:33:38.0978-04:00 <4968413895408182> About to call parseHeaders
2014-01-12T11:33:38.0978-04:00 <4968413895408182> Reader::fill(): first=0
last=0 toRead=4096
2014-01-12T11:33:38.1048-04:00 <4968413895408182> URL::parseHeaders:
CompleteStatusLine set to [HTTP/1.1 400 Bad Request]
2014-01-12T11:33:38.1048-04:00 <4968413895408182> URL::parseHeaders: StatusLine
set to [400 Bad Request]
2014-01-12T11:33:38.1048-04:00 <4968413895408182> URL::parseHeaders:
StatusLineWithoutStatusCode set to [Bad Request]
2014-01-12T11:33:38.1048-04:00 <4968413895408182> Header from
WLS:[Connection]=[close]
2014-01-12T11:33:38.1048-04:00 <4968413895408182> parsed all headers OK
2014-01-12T11:33:38.1048-04:00 <4968413895408182> Exiting method
BaseProxy::sendRequest
2014-01-12T11:33:38.1048-04:00 <4968413895408182> sendResponse() : r->status =
'400'
2014-01-12T11:33:38.1048-04:00 <4968413895408182> Reader::fill(): first=0
last=0 toRead=4096
2014-01-12T11:33:38.1058-04:00 <4968413895408182> calling closeConn() with
non-null URL* at 637
2014-01-12T11:33:38.1058-04:00 <4968413895408182> canRecycle: conn=1 status=400
isKA=0 clen=-1 isCTE=0
2014-01-12T11:33:38.1058-04:00 <4968413895408182> closeConn: URL.canRecycle()
returns false, deleting URL '127.0.0.1/11200'
2014-01-12T11:33:38.1058-04:00 <4968413895407971> INFO: Closing SSL context
2014-01-12T11:33:38.1058-04:00 <4968413895408182> request [/] processed
successfully..................
2014-01-12T11:33:38.1058-04:00 <4968413895407971> BEFORE acquire_lock
2014-01-12T11:33:38.1068-04:00 <4968413895407971> AFTER acquire_lock
2014-01-12T11:33:38.1068-04:00 <4968413895407971> List size is 1
2014-01-12T11:33:38.1068-04:00 <4968413895407971> Cleaning up the list node
'gafindev.arielre.com:11200'list Length '1'
2014-01-12T11:33:38.1068-04:00 <4968413895407971> mod_weblogic(ssl): SSL
Handshake successful
2014-01-12T11:33:38.1068-04:00 <4968413895408183> Local Port of the socket is
61094
2014-01-12T11:33:38.1068-04:00 <4968413895408183> Remote Host 127.0.0.1 Remote
Port 61094
2014-01-12T11:33:38.1068-04:00 <4968413895408183> general list: created a new
connection to '127.0.0.1'/11200 for '/', Local port:61094
2014-01-12T11:33:38.1068-04:00 <4968413895408183> Entering method
BaseProxy::sendRequest
2014-01-12T11:33:38.1068-04:00 <4968413895408183> Entering method
BaseProxy::parse_headers
2014-01-12T11:33:38.1068-04:00 <4968413895408183> No of headers =0
2014-01-12T11:33:38.1068-04:00 <4968413895408183> Exiting method
BaseProxy::parse_headers
2014-01-12T11:33:38.1068-04:00 <4968413895408183> parse_client_headers is done
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Method is €F
2014-01-12T11:33:38.1078-04:00 <4968413895408183> URL::sendHeaders():
meth='€F' file='/' protocol='HTTP/0.9'
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[Connection]=[Keep-Alive]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[WL-Proxy-SSL]=[true]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[Host]=[SVRGAWEB01.ariel.internal:80]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[X-Forwarded-For]=[127.0.0.1]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[WL-Proxy-Client-IP]=[127.0.0.1]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[Proxy-Client-IP]=[127.0.0.1]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[WL-Proxy-Client-Port]=[61091]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[X-WebLogic-KeepAliveSecs]=[30]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Header to WLS:
[X-WebLogic-Force-JVMID]=[unset]
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Need to send 268
2014-01-12T11:33:38.1078-04:00 <4968413895408183> SSLWrite sent 268, Error = 0
2014-01-12T11:33:38.1078-04:00 <4968413895408183> SSLWrite completed, sent 268
2014-01-12T11:33:38.1078-04:00 <4968413895408183> About to call parseHeaders
2014-01-12T11:33:38.1078-04:00 <4968413895408183> Reader::fill(): first=0
last=0 toRead=4096
2014-01-12T11:33:38.1088-04:00 <4968413895408183> URL::parseHeaders:
CompleteStatusLine set to [HTTP/1.1 400 Bad Request]
2014-01-12T11:33:38.1098-04:00 <4968413895408183> URL::parseHeaders: StatusLine
set to [400 Bad Request]
2014-01-12T11:33:38.1098-04:00 <4968413895408183> URL::parseHeaders:
StatusLineWithoutStatusCode set to [Bad Request]
2014-01-12T11:33:38.1098-04:00 <4968413895408183> Header from
WLS:[Connection]=[close]
2014-01-12T11:33:38.1098-04:00 <4968413895408183> parsed all headers OK
2014-01-12T11:33:38.1098-04:00 <4968413895408183> Exiting method
BaseProxy::sendRequest
2014-01-12T11:33:38.1098-04:00 <4968413895408183> sendResponse() : r->status =
'400'
2014-01-12T11:33:38.1098-04:00 <4968413895408183> Reader::fill(): first=0
last=0 toRead=4096
2014-01-12T11:33:38.1098-04:00 <4968413895408183> calling closeConn() with
non-null URL* at 637
2014-01-12T11:33:38.1098-04:00 <4968413895408183> canRecycle: conn=1 status=400
isKA=0 clen=-1 isCTE=0
2014-01-12T11:33:38.1098-04:00 <4968413895408183> closeConn: URL.canRecycle()
returns false, deleting URL '127.0.0.1/11200'
2014-01-12T11:33:38.1098-04:00 <4968413895407971> INFO: Closing SSL context
2014-01-12T11:33:38.1098-04:00 <4968413895408183> request [/] processed
successfully..................
2014-01-12T11:33:38.1108-04:00 <4968413895407971> BEFORE acquire_lock
2014-01-12T11:33:38.1108-04:00 <4968413895407971> AFTER acquire_lock
2014-01-12T11:33:38.1108-04:00 <4968413895407971> List size is 1
2014-01-12T11:33:38.1108-04:00 <4968413895407971> Cleaning up the list node
'gafindev.arielre.com:11200'list Length '1'
--
You are receiving this mail because:
You are the assignee for the bug.
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
