Re: Error accesing application on GAE

[Fábio Peruchi]

Hi!

I'm having this error below on my first access to my GAE application after I migrated my application from Master/Slave Datastore to High Replication Datastore. Can you help me with this?

1. 2012-07-30 06:49:36.444

   Nested in org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.web.servlet.mvc.annotation.AnnotationMethodHandlerAdapter#0': Instantiation of bean failed; nested exception is org.springframework.beans.BeanInstantiationException: Could not instantiate bean class [org.springframework.web.servlet.mvc.annotation.AnnotationMethodHandlerAdapter]: Constructor threw exception; nested exception is com.google.apphosting.api.DeadlineExceededException: This request (4c21034ba773768f) started at 2012/07/30 13:48:36.877 UTC and was still executing at 2012/07/30 13:49:36.351 UTC.:
   com.google.apphosting.api.DeadlineExceededException: This request (4c21034ba773768f) started at 2012/07/30 13:48:36.877 UTC and was still executing at 2012/07/30 13:49:36.351 UTC.
   	at java.util.zip.ZipFile.open(Native Method)
   	at java.util.zip.ZipFile.<init>(ZipFile.java:143)
   	at java.util.jar.JarFile.<init>(JarFile.java:150)
   	at java.util.jar.JarFile.<init>(JarFile.java:87)
   	at sun.misc.URLClassPath$JarLoader.getJarFile(URLClassPath.java:919)
   	at sun.misc.URLClassPath$JarLoader.access$900(URLClassPath.java:723)
   	at sun.misc.URLClassPath$JarLoader$1.run(URLClassPath.java:854)
   	at java.security.AccessController.doPrivileged(Native Method)
   	at sun.misc.URLClassPath$JarLoader.ensureOpenSynchronized(URLClassPath.java:846)
   	at sun.misc.URLClassPath$JarLoader.ensureOpen(URLClassPath.java:838)
   	at sun.misc.URLClassPath$JarLoader.getResource(URLClassPath.java:1026)
   	at sun.misc.URLClassPath$2.next(URLClassPath.java:300)
   	at sun.misc.URLClassPath$2.hasMoreElements(URLClassPath.java:310)
   	at java.lang.ClassLoader$2.hasMoreElements(ClassLoader.java:1129)
   	at sun.misc.CompoundEnumeration.next(CompoundEnumeration.java:45)
   	at sun.misc.CompoundEnumeration.hasMoreElements(CompoundEnumeration.java:54)
   	at sun.misc.CompoundEnumeration.next(CompoundEnumeration.java:45)
   	at sun.misc.CompoundEnumeration.hasMoreElements(CompoundEnumeration.java:54)
   	at java.util.ServiceLoader$LazyIterator.hasNext(ServiceLoader.java:346)
   	at java.util.ServiceLoader$1.hasNext(ServiceLoader.java:432)
   	at java.nio.charset.Charset$1.getNext(Charset.java:336)
   	at java.nio.charset.Charset$1.hasNext(Charset.java:351)
   	at java.nio.charset.Charset$4.run(Charset.java:572)
   	at java.nio.charset.Charset$4.run(Charset.java:566)
   	at java.security.AccessController.doPrivileged(Native Method)
   	at java.nio.charset.Charset.availableCharsets(Charset.java:565)
   	at org.springframework.http.converter.StringHttpMessageConverter.<init>(StringHttpMessageConverter.java:52)
   	at org.springframework.web.servlet.mvc.annotation.AnnotationMethodHandlerAdapter.<init>(AnnotationMethodHandlerAdapter.java:194)
   	at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
   	at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:57)
   	at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
   	at java.lang.reflect.Constructor.newInstance(Constructor.java:33)
   	at org.springframework.beans.BeanUtils.instantiateClass(BeanUtils.java:126)
   	at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:74)
   	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$3.run(AbstractAutowireCapableBeanFactory.java:953)
   	at java.security.AccessController.doPrivileged(Native Method)
   	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:951)
   	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:911)
   	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:485)
   	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:456)
   	at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:291)
   	at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
   	at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:288)
   	at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:190)
   	at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:580)
   	at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:895)
   	at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:425)
   	at org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:276)
   	at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:197)
   	at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:47)
   	at org.mortbay.jetty.handler.ContextHandler.startContext(ContextHandler.java:548)
   	at org.mortbay.jetty.servlet.Context.startContext(Context.java:136)
   	at org.mortbay.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1250)
   	at org.mortbay.jetty.handler.ContextHandler.doStart(ContextHandler.java:517)
   	at org.mortbay.jetty.webapp.WebAppContext.doStart(WebAppContext.java:467)
   	at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:50)
   	at com.google.tracing.TraceContext$TraceContextRunnable.runInContext(TraceContext.java:449)
   	at com.google.tracing.TraceContext$TraceContextRunnable$1.run(TraceContext.java:455)
   	at com.google.tracing.TraceContext.runInContext(TraceContext.java:695)
   	at com.google.tracing.TraceContext$AbstractTraceContextCallback.runInInheritedContextNoUnref(TraceContext.java:333)
   	at com.google.tracing.TraceContext$AbstractTraceContextCallback.runInInheritedContext(TraceContext.java:325)
   	at com.google.tracing.TraceContext$TraceContextRunnable.run(TraceContext.java:453)
   	at java.lang.Thread.run(Thread.java:679)
   

2. C2012-07-30 06:49:36.455

   Uncaught exception from servlet
   javax.servlet.UnavailableException: Initialization failed.
   	at com.google.apphosting.runtime.jetty.AppVersionHandlerMap.createHandler(AppVersionHandlerMap.java:211)
   	at com.google.apphosting.runtime.jetty.AppVersionHandlerMap.getHandler(AppVersionHandlerMap.java:171)
   	at com.google.apphosting.runtime.jetty.JettyServletEngineAdapter.serviceRequest(JettyServletEngineAdapter.java:123)
   	at com.google.apphosting.runtime.JavaRuntime$RequestRunnable.run(JavaRuntime.java:477)
   	at com.google.tracing.TraceContext$TraceContextRunnable.runInContext(TraceContext.java:449)
   	at com.google.tracing.TraceContext$TraceContextRunnable$1.run(TraceContext.java:455)
   	at com.google.tracing.TraceContext.runInContext(TraceContext.java:695)
   	at com.google.tracing.TraceContext$AbstractTraceContextCallback.runInInheritedContextNoUnref(TraceContext.java:333)
   	at com.google.tracing.TraceContext$AbstractTraceContextCallback.runInInheritedContext(TraceContext.java:325)
   	at com.google.tracing.TraceContext$TraceContextRunnable.run(TraceContext.java:453)
   	at com.google.apphosting.runtime.ThreadGroupPool$PoolEntry.run(ThreadGroupPool.java:251)
   	at java.lang.Thread.run(Thread.java:679)
   

3. I2012-07-30 06:49:36.461

   This request caused a new process to be started for your application, and thus caused your application code to be loaded for the first time. This request may thus take longer and use more CPU than a typical request for your application.

4. W2012-07-30 06:49:36.461

   A problem was encountered with the process that handled this request, causing it to exit. This is likely to cause a new process to be used for the next request to your application. If you see this message frequently, you may be throwing exceptions during the initialization of your application. (Error code 104)

Best regards,

Fábio Peruchi