9:58 p.m.
Error 404 after successful cluster switch
-----------------------------------------
Key: MODCLUSTER-271
URL: https://issues.jboss.org/browse/MODCLUSTER-271
Project: mod_cluster
Issue Type: Bug
Affects Versions: 1.1.3.Final
Reporter: Erhard Siegl
Assignee: Jean-Frederic Clere
mod_cluster with two JBoss 4 as backend. A client continuousely hits the server.
When I shutdown the JBoss with the active session, the second takes over successfully. But
then sometimes I get a 404 for a single hit. Parts from the logfile (with debug):
[Thu Dec 29 19:16:07 2011] [debug] mod_proxy_ajp.c(644): proxy: AJP: serving URL
ajp://192.168.40.129:8109/demo/
...
[Thu Dec 29 19:16:07 2011] [debug] ajp_header.c(516): ajp_unmarshal_response: status =
200
... Shutdown of first node
[Thu Dec 29 19:16:07 2011] [debug] mod_manager.c(2296): manager_handler DISABLE-APP (/)
processing: "JVMRoute=cluster1&Alias=localhost&Context=%2Fdemo"
[Thu Dec 29 19:16:07 2011] [debug] mod_manager.c(2339): manager_handler DISABLE-APP OK
[Thu Dec 29 19:16:07 2011] [debug] mod_manager.c(1653): manager_trans STOP-APP (/)
[Thu Dec 29 19:16:07 2011] [debug] mod_manager.c(2296): manager_handler STOP-APP (/)
processing: "JVMRoute=cluster1&Alias=localhost&Context=%2Fdemo"
[Thu Dec 29 19:16:07 2011] [debug] mod_manager.c(2339): manager_handler STOP-APP OK
[Thu Dec 29 19:16:07 2011] [debug] mod_manager.c(1653): manager_trans REMOVE-APP (/)
[Thu Dec 29 19:16:07 2011] [debug] mod_manager.c(2296): manager_handler REMOVE-APP (/)
processing: "JVMRoute=cluster1&Alias=localhost&Context=%2Fdemo"
[Thu Dec 29 19:16:07 2011] [debug] mod_manager.c(2339): manager_handler REMOVE-APP OK
... Successfully removed route
[Thu Dec 29 19:16:08 2011] [debug] mod_proxy_ajp.c(644): proxy: AJP: serving URL
ajp://192.168.123.231:8209/demo/
...
[Thu Dec 29 19:16:08 2011] [debug] ajp_header.c(516): ajp_unmarshal_response: status =
200
... But then it uses ajp://192.168.40.129:8109/demo/ again and fails with 404
[Thu Dec 29 19:16:09 2011] [debug] proxy_util.c(1937): proxy: BALANCER: retrying the
worker for (192.168.40.129)
[Thu Dec 29 19:16:09 2011] [debug] proxy_util.c(1943): proxy: BALANCER: worker for
(192.168.40.129) has been marked for retry
[Thu Dec 29 19:16:09 2011] [debug] mod_proxy.c(993): Running scheme balancer handler
(attempt 0)
[Thu Dec 29 19:16:09 2011] [debug] mod_proxy_http.c(1930): proxy: HTTP: declining URL
ajp://192.168.40.129:8109/demo/
[Thu Dec 29 19:16:09 2011] [debug] mod_proxy_scgi.c(508): [client 127.0.0.1] proxy: SCGI:
declining URL ajp://192.168.40.129:8109/demo/
[Thu Dec 29 19:16:09 2011] [debug] mod_proxy_ajp.c(644): proxy: AJP: serving URL
ajp://192.168.40.129:8109/demo/
[Thu Dec 29 19:16:09 2011] [debug] proxy_util.c(1999): proxy: AJP: has acquired connection
for (192.168.40.129)
[Thu Dec 29 19:16:09 2011] [debug] proxy_util.c(2055): proxy: connecting
ajp://192.168.40.129:8109/demo/ to 192.168.40.129:8109
[Thu Dec 29 19:16:09 2011] [debug] proxy_util.c(2153): proxy: connected /demo/ to
192.168.40.129:8109
[Thu Dec 29 19:16:09 2011] [debug] ajp_utils.c(31): Into ajp_handle_cping_cpong
[Thu Dec 29 19:16:09 2011] [debug] ajp_utils.c(102): ajp_handle_cping_cpong: Done
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(224): Into ajp_marshal_into_msgb
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(290): ajp_marshal_into_msgb: Header[0]
[Accept-Encoding] = [identity]
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(290): ajp_marshal_into_msgb: Header[1]
[Host] = [devjava]
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(290): ajp_marshal_into_msgb: Header[2]
[Cookie] = [JSESSIONID=D6AcPj+99EObFqH+F9wjew**.cluster1]
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(290): ajp_marshal_into_msgb: Header[3]
[Connection] = [close]
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(290): ajp_marshal_into_msgb: Header[4]
[User-agent] = [Mozilla/4.0 (compatible; MSIE 5.5; Windows NT)]
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(450): ajp_marshal_into_msgb: Done
[Thu Dec 29 19:16:09 2011] [debug] mod_proxy_ajp.c(265): proxy: APR_BUCKET_IS_EOS
[Thu Dec 29 19:16:09 2011] [debug] mod_proxy_ajp.c(270): proxy: data to read (max 8186 at
4)
[Thu Dec 29 19:16:09 2011] [debug] mod_proxy_ajp.c(285): proxy: got 0 bytes of data
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(687): ajp_read_header: ajp_ilink_received
04
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(697): ajp_parse_type: got 04
[Thu Dec 29 19:16:09 2011] [debug] ajp_header.c(516): ajp_unmarshal_response: status =
404
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators:
https://issues.jboss.org/secure/ContactAdministrators!default.jspa
For more information on JIRA, see: http://www.atlassian.com/software/jira