tomcat-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From bugzi...@apache.org
Subject DO NOT REPLY [Bug 35461] - bad request http 400 using mod_jk 1.2.13. After downgrading to 1.3.33 and mod_jk 1.2.5 the problems have gone. Problems occur again after using the combination Apache Webserver 1.3.33 and mod_jk 1.2.10
Date Wed, 02 Nov 2005 19:01:12 GMT
DO NOT REPLY TO THIS EMAIL, BUT PLEASE POST YOUR BUG·
RELATED COMMENTS THROUGH THE WEB INTERFACE AVAILABLE AT
<http://issues.apache.org/bugzilla/show_bug.cgi?id=35461>.
ANY REPLY MADE TO THIS MESSAGE WILL NOT BE COLLECTED AND·
INSERTED IN THE BUG DATABASE.

http://issues.apache.org/bugzilla/show_bug.cgi?id=35461





------- Additional Comments From ejne@excite.com  2005-11-02 20:01 -------
...seems to still exist folks.  

my environment is solaris 10/sparc, apache ver 2.0.55 (worker mpm), mod_jk ver
1.2.14.1 (compiled locally), java ver 1.5.0_05, tomcat ver 5.5.12 (via jsvc). 
Apache and tomcat running on same box.



my httpd.conf relevent settings:

LoadModule jk_module modules/mod_jk.so

JkLogFile     "/usr/local/apache/logs/mod_jk.log"
JkLogLevel    error

#
# Prohibit public access to property files used by web applications.
#
<LocationMatch ".properties$">
        AllowOverride None
        Deny from all
</LocationMatch>

<LocationMatch ".*/WEB-INF/.*">
        AllowOverride None
        Deny from all
</LocationMatch>

<LocationMatch ".*/META-INF/.*">
        AllowOverride None
        Deny from all
</LocationMatch>

#
# Forward (everything) to tomcat:
#
JkMount /* myApp


# --------------------------------------------------------------------
#
# Note: "JkWorkerProperty" is a new directive available from JK 1.2.7
#       version. It is a convenient method for setting directives that
#       are usually set inside workers.propetiesfile. The parameter for
#       that directive is raw line from workers.properties file.
#
# --------------------------------------------------------------------

# In Unix, we use forward slashes:
JkWorkerProperty ps=/

# list the workers by name
JkWorkerProperty worker.list=myApp

# --------------------------------------------------------------------
# tomcat server instances:
#
# Note: The worker name should match the value of the "jvmRoute="
#       parameter found in the $TOMCAT_HOME/conf/server.xml file.
# --------------------------------------------------------------------

JkWorkerProperty worker.myApp.type=ajp13
JkWorkerProperty worker.myApp.lbfactor=1
JkWorkerProperty worker.myApp.cachesize=25
JkWorkerProperty worker.myApp.cache_timeout=0
JkWorkerProperty worker.myApp.port=8888
JkWorkerProperty worker.myApp.host=localhost

##### end of tomcat/mod_jk/workers.properties settings #####




my server.xml relevent settings:

    <!-- Define an AJP 1.3 Connector on port 8888 -->
    <Connector port="8888"
               maxThreads="150"
               minSpareThreads="25"
               maxSpareThreads="75"
               enableLookups="false"
               acceptCount="100"
               connectionTimeout="20000"
               redirectPort="8443"
               protocol="AJP/1.3" />

    <Engine name="Catalina" debug="0" defaultHost="localhost" jvmRoute="myApp">



error/warn/info messages in apache/logs/mod_jk.log:

[Tue Nov 01 23:18:39 2005] [16920:0019] [warn] 
ajp_get_endpoint::jk_ajp_common.c (2138): Unable to get the free endpoint for
worker myApp from 1 slots
[Tue Nov 01 23:18:39 2005] [16920:0019] [info] 
ajp_get_endpoint::jk_ajp_common.c (2152): can't find free endpoint
[Tue Nov 01 23:18:39 2005] [16920:0019] [error] jk_handler::mod_jk.c (1911):
Could not get endpoint for worker=myApp
[Tue Nov 01 23:18:39 2005] [16920:0019] [info]  jk_handler::mod_jk.c (1971):
Service error=0 for worker=myApp
[Tue Nov 01 23:18:41 2005] [16921:0019] [warn] 
ajp_get_endpoint::jk_ajp_common.c (2138): Unable to get the free endpoint for
worker myApp from 1 slots
[Tue Nov 01 23:18:41 2005] [16921:0019] [info] 
ajp_get_endpoint::jk_ajp_common.c (2152): can't find free endpoint
[Tue Nov 01 23:18:41 2005] [16921:0019] [error] jk_handler::mod_jk.c (1911):
Could not get endpoint for worker=myApp
[Tue Nov 01 23:18:41 2005] [16921:0019] [info]  jk_handler::mod_jk.c (1971):
Service error=0 for worker=myApp
[Tue Nov 01 23:18:46 2005] [16921:0019] [warn] 
ajp_get_endpoint::jk_ajp_common.c (2138): Unable to get the free endpoint for
worker myApp from 1 slots
[Tue Nov 01 23:18:46 2005] [16921:0019] [info] 
ajp_get_endpoint::jk_ajp_common.c (2152): can't find free endpoint
[Tue Nov 01 23:18:46 2005] [16921:0019] [error] jk_handler::mod_jk.c (1911):
Could not get endpoint for worker=myApp
[Tue Nov 01 23:18:46 2005] [16921:0019] [info]  jk_handler::mod_jk.c (1971):
Service error=0 for worker=myApp
[Tue Nov 01 23:18:52 2005] [16920:0019] [warn] 
ajp_get_endpoint::jk_ajp_common.c (2138): Unable to get the free endpoint for
worker myApp from 1 slots
[Tue Nov 01 23:18:52 2005] [16920:0019] [info] 
ajp_get_endpoint::jk_ajp_common.c (2152): can't find free endpoint
[Tue Nov 01 23:18:52 2005] [16920:0019] [error] jk_handler::mod_jk.c (1911):
Could not get endpoint for worker=myApp
[Tue Nov 01 23:18:52 2005] [16920:0019] [info]  jk_handler::mod_jk.c (1971):
Service error=0 for worker=myApp
...
[Tue Nov 01 23:27:06 2005] [16939:0022] [info] 
ajp_send_request::jk_ajp_common.c (1178): Socket 17 is not connected any more
(errno=-1)
[Tue Nov 01 23:27:06 2005] [16939:0022] [info] 
ajp_send_request::jk_ajp_common.c (1202): Error sending request. Will try
another pooled connection
[Tue Nov 01 23:27:06 2005] [16939:0022] [info] 
ajp_send_request::jk_ajp_common.c (1225): All endpoints are disconnected or dead
[Tue Nov 01 23:27:06 2005] [16939:0022] [info]  ajp_service::jk_ajp_common.c
(1749): Sending request to tomcat failed,  recoverable operation attempt=1
[Tue Nov 01 23:35:16 2005] [16939:0022] [info] 
ajp_send_request::jk_ajp_common.c (1178): Socket 22 is not connected any more
(errno=-1)
[Tue Nov 01 23:35:16 2005] [16939:0022] [info] 
ajp_send_request::jk_ajp_common.c (1202): Error sending request. Will try
another pooled connection
[Tue Nov 01 23:35:16 2005] [16939:0022] [info] 
ajp_send_request::jk_ajp_common.c (1225): All endpoints are disconnected or dead
[Tue Nov 01 23:35:16 2005] [16939:0022] [info]  ajp_service::jk_ajp_common.c
(1749): Sending request to tomcat failed,  recoverable operation attempt=1



error messages in apache/logs/error_log:

[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
map_uri_to_worker::jk_uri_worker_map.c (443): Removing Session path
';jsessionid=0418375B66D57231B89911A9C5340317.jvm1' URI
'/faces/finder/search/SearchMake
.jsp' failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
map_uri_to_worker::jk_uri_worker_map.c (449): Attempting to map URI
'/faces/finder/search/SearchMake.jsp;jsessionid=0418375B66D57231B89911A9C5340317.jvm1'
f
rom 1 maps failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
map_uri_to_worker::jk_uri_worker_map.c (461): Attempting to map context URI '/*'
failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
map_uri_to_worker::jk_uri_worker_map.c (475): Found a wildchar match myApp -> /*
failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug] jk_handler::mod_jk.c (1825):
Into handler jakarta-servlet worker=myApp r->proxyreq=0 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
wc_get_worker_for_name::jk_worker.c (111): found a worker myApp failed: File too
large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug] init_ws_service::mod_jk.c (517):
Service protocol=HTTP/1.1 method=POST host=(null) addrr=10.100.100.13
name=dev.myApp.com port=80 auth=(null) user=(null) la
ddr=10.100.100.69 raddr=10.100.100.13 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_get_endpoint::jk_ajp_common.c (2131): acquired connection cache slot=3
failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_marshal_into_msgb::jk_ajp_common.c (566): ajp marshaling done failed: File
too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug] ajp_service::jk_ajp_common.c
(1670): processing with 3 retries failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (909): sending to ajp13 pos=4
len=376 max=8192 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (909): 0000    12 34 01 74 02
04 00 08 48 54 54 50 2F 31 2E 31  - .4.t....HTTP/1.1 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (909): 0010    00 00 54 2F 66
61 63 65 73 2F 66 69 6E 64 65 72  - ..T/faces/finder failed: File too large
...
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_send_request::jk_ajp_common.c (1261): request body to send 185 - request
body to resend 0 failed: File too large
...
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_unmarshal_response::jk_ajp_common.c (621): status = 200 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_unmarshal_response::jk_ajp_common.c (628): Number of headers is = 2 failed:
File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_unmarshal_response::jk_ajp_common.c (684): Header[0] [Content-Type] =
[text/html;charset=UTF-8] failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_unmarshal_response::jk_ajp_common.c (684): Header[1] [Content-Language] =
[en] failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1037): received from ajp13
pos=0 len=8188 max=8192 failed: File too large
...
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug] ws_write::mod_jk.c (398):
written 8184 out of 8184 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1037): received from ajp13
pos=0 len=8188 max=8192 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug] ws_write::mod_jk.c (398):
written 8184 out of 8184 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1037): received from ajp13
pos=0 len=1731 max=8192 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug] ws_write::mod_jk.c (398):
written 1727 out of 1727 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1037): received from ajp13
pos=0 len=2 max=8192 failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1037): 0000    05 01 00 00 00
00 00 00 00 00 00 00 00 00 00 00  - ................ failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug] ajp_done::jk_ajp_common.c
(2074): recycling connection cache slot=2 for worker myApp failed: File too large
[Tue Nov 01 23:49:44 2005] [16939:0022] [debug] jk_handler::mod_jk.c (1955):
Service finished with status=200 for worker=myApp failed: File too large



These errors manifest during sustained load (19.35805 hits/second), the
application is a relatively simple database query form, server cpu ~65% busy.

Thanks,
-Eddie





-- 
Configure bugmail: http://issues.apache.org/bugzilla/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are the assignee for the bug, or are watching the assignee.

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@tomcat.apache.org
For additional commands, e-mail: dev-help@tomcat.apache.org


Mime
View raw message