Does this issue just occur on the first request coming into your application or on every request?
This looks like a DeadlineExceededError, which will sometimes occur on a loading request due to the fact that initializing the Groovy interpreter as well as Grails can sometimes take many seconds. You may be able to get this under the deadline by using precompilation. Here's some information on precompilation: http://googleappengine.blogspot.com/2009/12/request-performance-in-java.html On Mon, Jan 25, 2010 at 5:13 AM, Max Lam <[email protected]> wrote: > Hi All, > > I'm running out of solution on how to fix the below. I had developed > my app with Grails 1.1.1, Grails AppEngine Plugin 0.8.5, GORM-JPA > plugin and Google AppEngine SDK 1.3 > > Through out the development process, I have never faced this problem > before and everything runs smoothly. But after deploying on the > production server, this is the problem that I encounter: > > No avail in searching through the groups so far...anybody has any > ideas? > ============================================== > javax.servlet.ServletContext log: Initializing Spring root > WebApplicationContext > W 01-25 05:02AM 52.910 > Failed startup of context > com.google.apphosting.utils.jetty.runtimeappenginewebappcont...@1be1041 > {/,/base/data/home/apps/christlifeliving316/1.339416368024565269} > org.springframework.beans.factory.access.BootstrapException: Error > executing bootstraps; nested exception is > org.codehaus.groovy.runtime.InvokerInvocationException: > com.google.apphosting.api.DeadlineExceededException: This request > (b6a473212ce94d91) started at 2010/01/25 13:02:24.393 UTC and was > still executing at 2010/01/25 13:02:52.847 UTC. > at > > org.codehaus.groovy.grails.web.context.GrailsContextLoader.createWebApplicationContext > (GrailsContextLoader.java:74) > at > org.springframework.web.context.ContextLoader.initWebApplicationContext > (ContextLoader.java:199) > at > org.springframework.web.context.ContextLoaderListener.contextInitialized > (ContextLoaderListener.java:45) > at org.mortbay.jetty.handler.ContextHandler.startContext > (ContextHandler.java:530) > at org.mortbay.jetty.servlet.Context.startContext(Context.java:135) > at org.mortbay.jetty.webapp.WebAppContext.startContext > (WebAppContext.java:1218) > at org.mortbay.jetty.handler.ContextHandler.doStart > (ContextHandler.java:500) > at > org.mortbay.jetty.webapp.WebAppContext.doStart(WebAppContext.java: > 448) > at org.mortbay.component.AbstractLifeCycle.start > (AbstractLifeCycle.java:40) > at > com.google.apphosting.runtime.jetty.AppVersionHandlerMap.createHandler > (AppVersionHandlerMap.java:191) > at > com.google.apphosting.runtime.jetty.AppVersionHandlerMap.getHandler > (AppVersionHandlerMap.java:168) > at > > com.google.apphosting.runtime.jetty.JettyServletEngineAdapter.serviceRequest > (JettyServletEngineAdapter.java:123) > at com.google.apphosting.runtime.JavaRuntime.handleRequest > (JavaRuntime.java:235) > at com.google.apphosting.base.RuntimePb$EvaluationRuntime > $6.handleBlockingRequest(RuntimePb.java:5235) > at com.google.apphosting.base.RuntimePb$EvaluationRuntime > $6.handleBlockingRequest(RuntimePb.java:5233) > at com.google.net.rpc.impl.BlockingApplicationHandler.handleRequest > (BlockingApplicationHandler.java:24) > at com.google.net.rpc.impl.RpcUtil.runRpcInApplication(RpcUtil.java: > 363) > at com.google.net.rpc.impl.Server$2.run(Server.java:838) > at com.google.tracing.LocalTraceSpanRunnable.run > (LocalTraceSpanRunnable.java:56) > at com.google.tracing.LocalTraceSpanBuilder.internalContinueSpan > (LocalTraceSpanBuilder.java:536) > at com.google.net.rpc.impl.Server.startRpc(Server.java:793) > at com.google.net.rpc.impl.Server.processRequest(Server.java:368) > at com.google.net.rpc.impl.ServerConnection.messageReceived > (ServerConnection.java:448) > at com.google.net.rpc.impl.RpcConnection.parseMessages > (RpcConnection.java:319) > at com.google.net.rpc.impl.RpcConnection.dataReceived > (RpcConnection.java:290) > at com.google.net.async.Connection.handleReadEvent(Connection.java: > 466) > at com.google.net.async.EventDispatcher.processNetworkEvents > (EventDispatcher.java:759) > at com.google.net.async.EventDispatcher.internalLoop > (EventDispatcher.java:205) > at com.google.net.async.EventDispatcher.loop(EventDispatcher.java: > 101) > at com.google.net.rpc.RpcService.runUntilServerShutdown > (RpcService.java:251) > at com.google.apphosting.runtime.JavaRuntime$RpcRunnable.run > (JavaRuntime.java:394) > at java.lang.Thread.run(Unknown Source) > Caused by: org.codehaus.groovy.runtime.InvokerInvocationException: > com.google.apphosting.api.DeadlineExceededException: This request > (b6a473212ce94d91) started at 2010/01/25 13:02:24.393 UTC and was > still executing at 2010/01/25 13:02:52.847 UTC. > ... 23 more > Caused by: com.google.apphosting.api.DeadlineExceededException: This > request (b6a473212ce94d91) started at 2010/01/25 13:02:24.393 UTC and > was still executing at 2010/01/25 13:02:52.847 UTC. > at java.util.TreeMap$PrivateEntryIterator.<init>(Unknown Source) > at java.util.TreeMap$ValueIterator.<init>(Unknown Source) > at java.util.TreeMap$Values.iterator(Unknown Source) > at java.util.AbstractCollection.toArray(Unknown Source) > at java.beans.Introspector.getTargetPropertyInfo(Unknown Source) > at java.beans.Introspector.getBeanInfo(Unknown Source) > at java.beans.Introspector.getBeanInfo(Unknown Source) > at > java.security.AccessController.doPrivileged(AccessController.java: > 64) > at SecurityFilters$_closure1_closure2.<init>(SecurityFilters.groovy) > at SecurityFilters$_closure1.doCall(SecurityFilters.groovy:4) > at SecurityFilters$_closure1.doCall(SecurityFilters.groovy) > ... 23 more > W 01-25 05:02AM 52.912 > Nested in org.springframework.beans.factory.access.BootstrapException: > Error executing bootstraps; nested exception is > org.codehaus.groovy.runtime.InvokerInvocationException: > com.google.apphosting.api.DeadlineExceededException: This request > (b6a473212ce94d91) started at 2010/01/25 13:02:24.393 UTC and was > still executing at 2010/01/25 13:02:52.847 UTC.: > com.google.apphosting.api.DeadlineExceededException: This request > (b6a473212ce94d91) started at 2010/01/25 13:02:24.393 UTC and was > still executing at 2010/01/25 13:02:52.847 UTC. > at java.util.TreeMap$PrivateEntryIterator.<init>(Unknown Source) > at java.util.TreeMap$ValueIterator.<init>(Unknown Source) > at java.util.TreeMap$Values.iterator(Unknown Source) > at java.util.AbstractCollection.toArray(Unknown Source) > at java.beans.Introspector.getTargetPropertyInfo(Unknown Source) > at java.beans.Introspector.getBeanInfo(Unknown Source) > at java.beans.Introspector.getBeanInfo(Unknown Source) > at > java.security.AccessController.doPrivileged(AccessController.java: > 64) > at SecurityFilters$_closure1_closure2.<init>(SecurityFilters.groovy) > at SecurityFilters$_closure1.doCall(SecurityFilters.groovy:4) > at SecurityFilters$_closure1.doCall(SecurityFilters.groovy) > at > com.google.apphosting.runtime.jetty.AppVersionHandlerMap.createHandler > (AppVersionHandlerMap.java:191) > at > com.google.apphosting.runtime.jetty.AppVersionHandlerMap.getHandler > (AppVersionHandlerMap.java:168) > at > > com.google.apphosting.runtime.jetty.JettyServletEngineAdapter.serviceRequest > (JettyServletEngineAdapter.java:123) > at com.google.apphosting.runtime.JavaRuntime.handleRequest > (JavaRuntime.java:235) > at com.google.apphosting.base.RuntimePb$EvaluationRuntime > $6.handleBlockingRequest(RuntimePb.java:5235) > at com.google.apphosting.base.RuntimePb$EvaluationRuntime > $6.handleBlockingRequest(RuntimePb.java:5233) > at com.google.net.rpc.impl.BlockingApplicationHandler.handleRequest > (BlockingApplicationHandler.java:24) > at com.google.net.rpc.impl.RpcUtil.runRpcInApplication(RpcUtil.java: > 363) > at com.google.net.rpc.impl.Server$2.run(Server.java:838) > at com.google.tracing.LocalTraceSpanRunnable.run > (LocalTraceSpanRunnable.java:56) > at com.google.tracing.LocalTraceSpanBuilder.internalContinueSpan > (LocalTraceSpanBuilder.java:536) > at com.google.net.rpc.impl.Server.startRpc(Server.java:793) > at com.google.net.rpc.impl.Server.processRequest(Server.java:368) > at com.google.net.rpc.impl.ServerConnection.messageReceived > (ServerConnection.java:448) > at com.google.net.rpc.impl.RpcConnection.parseMessages > (RpcConnection.java:319) > at com.google.net.rpc.impl.RpcConnection.dataReceived > (RpcConnection.java:290) > at com.google.net.async.Connection.handleReadEvent(Connection.java: > 466) > at com.google.net.async.EventDispatcher.processNetworkEvents > (EventDispatcher.java:759) > at com.google.net.async.EventDispatcher.internalLoop > (EventDispatcher.java:205) > at com.google.net.async.EventDispatcher.loop(EventDispatcher.java: > 101) > at com.google.net.rpc.RpcService.runUntilServerShutdown > (RpcService.java:251) > at com.google.apphosting.runtime.JavaRuntime$RpcRunnable.run > (JavaRuntime.java:394) > at java.lang.Thread.run(Unknown Source) > C 01-25 05:02AM 52.923 > Uncaught exception from servlet > javax.servlet.UnavailableException: Initialization failed. > at > com.google.apphosting.runtime.jetty.AppVersionHandlerMap.createHandler > (AppVersionHandlerMap.java:200) > at > com.google.apphosting.runtime.jetty.AppVersionHandlerMap.getHandler > (AppVersionHandlerMap.java:168) > at > > com.google.apphosting.runtime.jetty.JettyServletEngineAdapter.serviceRequest > (JettyServletEngineAdapter.java:123) > at com.google.apphosting.runtime.JavaRuntime.handleRequest > (JavaRuntime.java:235) > at com.google.apphosting.base.RuntimePb$EvaluationRuntime > $6.handleBlockingRequest(RuntimePb.java:5235) > at com.google.apphosting.base.RuntimePb$EvaluationRuntime > $6.handleBlockingRequest(RuntimePb.java:5233) > at com.google.net.rpc.impl.BlockingApplicationHandler.handleRequest > (BlockingApplicationHandler.java:24) > at com.google.net.rpc.impl.RpcUtil.runRpcInApplication(RpcUtil.java: > 363) > at com.google.net.rpc.impl.Server$2.run(Server.java:838) > at com.google.tracing.LocalTraceSpanRunnable.run > (LocalTraceSpanRunnable.java:56) > at com.google.tracing.LocalTraceSpanBuilder.internalContinueSpan > (LocalTraceSpanBuilder.java:536) > at com.google.net.rpc.impl.Server.startRpc(Server.java:793) > at com.google.net.rpc.impl.Server.processRequest(Server.java:368) > at com.google.net.rpc.impl.ServerConnection.messageReceived > (ServerConnection.java:448) > at com.google.net.rpc.impl.RpcConnection.parseMessages > (RpcConnection.java:319) > at com.google.net.rpc.impl.RpcConnection.dataReceived > (RpcConnection.java:290) > at com.google.net.async.Connection.handleReadEvent(Connection.java: > 466) > at com.google.net.async.EventDispatcher.processNetworkEvents > (EventDispatcher.java:759) > at com.google.net.async.EventDispatcher.internalLoop > (EventDispatcher.java:205) > at com.google.net.async.EventDispatcher.loop(EventDispatcher.java: > 101) > at com.google.net.rpc.RpcService.runUntilServerShutdown > (RpcService.java:251) > at com.google.apphosting.runtime.JavaRuntime$RpcRunnable.run > (JavaRuntime.java:394) > at java.lang.Thread.run(Unknown Source) > ============================================== > > -- > You received this message because you are subscribed to the Google Groups > "Google App Engine for Java" group. > To post to this group, send email to > [email protected]. > To unsubscribe from this group, send email to > [email protected]<google-appengine-java%[email protected]> > . > For more options, visit this group at > http://groups.google.com/group/google-appengine-java?hl=en. > > -- Ikai Lan Developer Programs Engineer, Google App Engine http://googleappengine.blogspot.com | http://twitter.com/app_engine -- You received this message because you are subscribed to the Google Groups "Google App Engine for Java" group. To post to this group, send email to [email protected]. To unsubscribe from this group, send email to [email protected]. For more options, visit this group at http://groups.google.com/group/google-appengine-java?hl=en.
