Hi, 

On Resin 4, our web app is sometimes spontaneously being reloaded during  
request handling. What could be the cause of that? 


This happens once or twice a day, at irregular times and intervals, with  
Resin 4.0.41 on OpenJDK 6 on Linux, but doesn't happen in the same  
application with Resin 3.1.10 on Sun JDK 1.5 on Solaris. Application is  
deployed as a .war using web-app-deploy with redeploy-mode and redeploy- 
check-interval at their defaults, but the .war is never touched. Moreover,  
we've been logging at level finest for com.caucho, but there's no indication  
in the log file as to why the web app is reloading, nor is there any entry  
in the watchdog log file. This also happens for requests resulting in a  
redirect at resin config level, hence not even hitting our application code.  
Trimmed-down example log file in attachment. 


Could this reloading be a feature of the health system in Resin 4? What can  
we do to figure out what's triggering the reload, e.g. which metric is being  
hit? Tnx! 


Best regards, 

Tom 


2015-03-17 05:28:27,083 [resin-port-7005-248] FINE 
com.caucho.server.http.HttpResponseStream Http[xxxxxx, 14] close stream
2015-03-17 05:28:27,083 [resin-port-7005-248] FINER 
com.caucho.network.listen.TcpSocketLink TcpSocketLink[id=14,xxxxxx] closing 
connection TcpSocketLink[id=http://*:7005-14,http://*:7005,CLOSED], total=17
2015-03-17 05:30:48,514 [resin-1049] FINER 
com.caucho.server.distcache.CacheDataBackingImpl 
com.caucho.server.distcache.CacheDataBackingImpl$ReaperListener@59a735 starting 
mnode cache reaper run, current mnode count=0, reaperTimeout=300000ms, 
reaperCycleMaxActiveDuration=1000ms, reaperCycleIdleToActiveUtilizationRatio=2.0
2015-03-17 05:30:48,514 [resin-1049] FINER 
com.caucho.server.distcache.CacheDataBackingImpl 
com.caucho.server.distcache.CacheDataBackingImpl$ReaperListener@59a735 finished 
mnode cache reaper run, removed 0 expired entries in 0ms, current mnode 
count=0, total sleep duration=0ms
2015-03-17 05:32:40,933 [resin-port-7005-314] FINEST 
com.caucho.network.listen.TcpSocketLink TcpSocketLink[id=12,xxxxxx] starting 
connection TcpSocketLink[id=http://*:7005-12,http://*:7005,ACCEPT], total=17
2015-03-17 05:32:40,933 [resin-port-7005-314] FINER 
com.caucho.network.listen.TcpSocketLink 
TcpSocketLink[id=http://*:7005-12,http://*:7005,ACCEPT] accept from 
##.##.#.#:7005
2015-03-17 05:32:40,933 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] GET /xxxxxx HTTP/1.0
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] Remote-IP: ##.##.#.#:7005
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.network.listen.TcpSocketLink 
TcpSocketLink[id=http://*:7005-12,http://*:7005,REQUEST_ACTIVE_NKA] keepalive 
disabled from REQUEST_ACTIVE_KA, reason=http client version less than 1.1: 256
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] Host: www.xxxxxx.yyyyyy.com
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] X-Real-IP: ##.##.#.###
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] X-Forwarded-For: ##.##.#.###
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] Connection: close
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] Accept: 
text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] User-Agent: Mozilla/5.0 
(Windows NT 6.3; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) 
Chrome/41.0.2272.89 Safari/537.36
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] Referer: 
http://www.xxxxxx.yyyyyy.com/
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] Accept-Encoding: gzip, 
deflate, sdch
2015-03-17 05:32:40,934 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpRequest Http[xxxxxx, 12] Accept-Language: 
nl-NL,nl;q=0.8,en-US;q=0.6,en;q=0.4
2015-03-17 05:32:41,009 [resin-port-7005-314] FINEST 
com.caucho.server.webapp.WebAppController 
WebAppController$30332961[production/webapp/default/xxxxxx] stopping
2015-03-17 05:32:41,009 [resin-port-7005-314] FINEST 
com.caucho.server.webapp.WebAppController 
WebAppAdmin[resin:type=WebApp,Host=default,name=/xxxxxx] lifecycleEvent ACTIVE 
-> STOPPING
2015-03-17 05:32:41,009 [resin-port-7005-314] FINEST 
com.caucho.server.webapp.WebAppController 
WebAppController$30332961[production/webapp/default/xxxxxx] STOPPED
2015-03-17 05:32:41,010 [resin-port-7005-314] FINEST 
com.caucho.server.webapp.WebAppController 
WebAppAdmin[resin:type=WebApp,Host=default,name=/xxxxxx] lifecycleEvent 
STOPPING -> STOPPED
2015-03-17 05:32:41,010 [resin-port-7005-314] INFO 
com.caucho.server.webapp.WebApp WebApp[production/webapp/default/xxxxxx] 
stopping
2015-03-17 05:32:41,013 [resin-port-7005-314] FINEST 
com.caucho.server.cluster.ServletService ServletServer clearCache
2015-03-17 05:32:41,036 [resin-port-7005-314] FINEST 
com.caucho.jmx.AbstractMBeanServer 
resin:type=SessionManager,Host=default,WebApp=/xxxxxx unregistered from 
EnvironmentMBeanServer[]
--- snip ---
2015-03-17 05:32:41,185 [resin-port-7005-314] FINE 
com.caucho.server.webapp.WebAppController 
WebAppController$30332961[production/webapp/default/xxxxxx] starting
2015-03-17 05:32:41,185 [resin-port-7005-314] FINEST 
com.caucho.server.webapp.WebAppController 
WebAppAdmin[resin:type=WebApp,Host=default,name=/xxxxxx] lifecycleEvent STOPPED 
-> STARTING
2015-03-17 05:32:41,502 [resin-port-7005-314] FINE 
com.caucho.env.deploy.EnvironmentDeployController 
WebApp[production/webapp/default/xxxxxx,NEW] initializing
2015-03-17 05:32:41,502 [resin-port-7005-314] FINEST 
com.caucho.jmx.MBeanContext 
MBeanServerDelegateMBean[JMImplementation:type=MBeanServerDelegate] registered 
in 
MBeanContext[EnvironmentClassLoader[web-app:production/webapp/default/xxxxxx,NEW]]
2015-03-17 05:32:41,503 [resin-port-7005-314] FINEST 
com.caucho.jmx.MBeanContext 
MBeanServerDelegateMBean[JMImplementation:type=MBeanServerDelegate] registered 
in MBeanContext[SystemClassLoader[system,NEW]]
2015-03-17 05:32:41,505 [resin-port-7005-314] FINER 
com.caucho.config.inject.InjectManager 
InjectManager[web-app:production/webapp/default/xxxxxx] add bean 
SingletonBean[WebApp, {@Default(), @Any()}]
--- snip ---
2015-03-17 05:32:42,132 [resin-port-7005-314] FINER 
com.caucho.server.webapp.WebApp WebApp[production/webapp/default/xxxxxx] INIT
2015-03-17 05:32:42,132 [resin-port-7005-314] FINE 
com.caucho.server.webapp.WebApp WebApp[production/webapp/default/xxxxxx] 
starting
2015-03-17 05:32:42,135 [resin-1029] FINEST com.caucho.naming.ContextImpl JNDI 
rebind `BeanValidation' value: 
com.caucho.server.webapp.WebAppEnv$JndiFactoryBeanValidation@49f1af
--- snip ---
2015-03-17 05:32:58,446 [resin-1029] FINER 
com.caucho.server.dispatch.ServletConfigImpl Servlet[welcome] active
2015-03-17 05:32:58,446 [resin-1029] FINER 
com.caucho.server.dispatch.ServletConfigImpl Servlet[welcome] active
2015-03-17 05:32:58,447 [resin-1029] INFO com.caucho.server.webapp.WebApp 
WebApp[production/webapp/default/xxxxxx] active
2015-03-17 05:32:58,447 [resin-1029] FINEST 
com.caucho.server.cluster.ServletService ServletServer clearCache
2015-03-17 05:32:58,447 [resin-port-7005-314] FINEST 
com.caucho.server.webapp.WebAppController 
WebAppController$30332961[production/webapp/default/xxxxxx] active
2015-03-17 05:32:58,448 [resin-port-7005-314] FINEST 
com.caucho.server.webapp.WebAppController 
WebAppAdmin[resin:type=WebApp,Host=default,name=/xxxxxx] lifecycleEvent 
STARTING -> ACTIVE
2015-03-17 05:32:58,448 [resin-port-7005-314] FINEST 
com.caucho.server.cluster.ServletService ServletServer clearCache
2015-03-17 05:32:58,449 [resin-port-7005-314] FINEST 
com.caucho.server.rewrite.RewriteDispatch rewrite-dispatch check uri '/xxxxxx'
2015-03-17 05:32:58,449 [resin-port-7005-314] FINER 
com.caucho.server.rewrite.AbstractRuleWithConditions match .* '/xxxxxx' --> 
'/xxxxxx'
2015-03-17 05:32:58,449 [resin-port-7005-314] FINEST 
com.caucho.server.rewrite.AbstractRuleWithConditions redirect ^/xxxxxx/current/ 
does not match /xxxxxx
2015-03-17 05:32:58,449 [resin-port-7005-314] FINEST 
com.caucho.server.rewrite.AbstractRuleWithConditions redirect ^/xxxxxx/current$ 
does not match /xxxxxx
2015-03-17 05:32:58,449 [resin-port-7005-314] FINEST 
com.caucho.server.rewrite.AbstractRuleWithConditions redirect ^/xxxxxx/$ does 
not match /xxxxxx
2015-03-17 05:32:58,449 [resin-port-7005-314] FINER 
com.caucho.server.rewrite.AbstractRuleWithConditions redirect ^/xxxxxx$ 
'/xxxxxx' --> '/xxxxxx/002/'
2015-03-17 05:32:58,523 [resin-port-7005-314] FINER 
com.caucho.server.dispatch.ServletInvocation Dispatch '/xxxxxx' to 
WebAppFilterChain[http://localhost:7005/, 
next=com.caucho.server.rewrite.RedirectQueryFilterChain@1c4642a]
2015-03-17 05:32:58,524 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpResponse Http[xxxxxx, 12] HTTP/1.1 302 Found
2015-03-17 05:32:58,524 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpResponse Http[xxxxxx, 12] Location: 
http://www.xxxxxx.yyyyyy.com/xxxxxx/002/
2015-03-17 05:32:58,524 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpResponse Http[xxxxxx, 12] Content-Type: text/html; 
charset=utf-8
2015-03-17 05:32:58,524 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpResponse Http[xxxxxx, 12] Content-Length: 78
2015-03-17 05:32:58,524 [resin-port-7005-314] FINER 
com.caucho.server.http.HttpResponseStream Http[xxxxxx, 12] write-set-offset(271)
2015-03-17 05:32:58,525 [resin-port-7005-314] FINE 
com.caucho.server.http.HttpResponseStream Http[xxxxxx, 12] close stream
2015-03-17 05:32:58,525 [resin-port-7005-314] FINER 
com.caucho.network.listen.TcpSocketLink TcpSocketLink[id=12,xxxxxx] closing 
connection TcpSocketLink[id=http://*:7005-12,http://*:7005,CLOSED], total=17
2015-03-17 05:33:27,298 [resin-port-7005-380] FINEST 
com.caucho.network.listen.TcpSocketLink TcpSocketLink[id=9,xxxxxx] starting 
connection TcpSocketLink[id=http://*:7005-9,http://*:7005,ACCEPT], total=17
_______________________________________________
resin-interest mailing list
resin-interest@caucho.com
http://maillist.caucho.com/mailman/listinfo/resin-interest

Reply via email to