quality@glassfish.java.net

Re: My first tests with FishCAT ...ouch

From: Jan Luehe <Jan.Luehe_at_Sun.COM>
Date: Wed, 18 Nov 2009 11:10:31 -0800

Jose,

On 11/18/09 10:33, Jose Noheda wrote:
> On Wed, Nov 18, 2009 at 6:55 PM, Jan Luehe <Jan.Luehe_at_sun.com
> <mailto:Jan.Luehe_at_sun.com>> wrote:
>
> Hi Jose,
>
> looks like we've made some progress, but we're not there yet.
>
>
> On 11/18/09 02:13, Jose Noheda wrote:
>> Finally I got the latest nightly and tested the deployment. We
>> have make progress indeed but..we are far from there yet)
>>
>> 1) I don't see the logs (my guess this is configurable somewhere)
>>
>> 2) I get this exception during deployment:
>
> Can you please file a new issue for this?
>
>
>>
>> org.hibernate.cache.CacheException:
>> org.jboss.cache.lock.TimeoutException: Unable to acquire lock on
>> Fqn [/org/internna/iwebmvc/model/Document/ENTITY] after [20000]
>> milliseconds for requestor
>> [Thread[org.springframework.scheduling.quartz.SchedulerFactoryBean#0_Worker-9,5,Grizzly]]!
>> Lock held by [GlobalTransaction:<null>:0]
>> at
>> org.hibernate.cache.jbc2.util.CacheHelper.removeAll(CacheHelper.java:380)
>> at
>> org.hibernate.cache.jbc2.util.CacheHelper.removeAll(CacheHelper.java:360)
>> at
>> org.hibernate.cache.jbc2.access.TransactionalAccessDelegate.evictOrRemoveAll(TransactionalAccessDelegate.java:146)
>> at
>> org.hibernate.cache.jbc2.access.TransactionalAccessDelegate.evictAll(TransactionalAccessDelegate.java:142)
>> at
>> org.hibernate.cache.jbc2.entity.TransactionalAccess.evictAll(TransactionalAccess.java:102)
>> at
>> org.hibernate.impl.SessionFactoryImpl.evictEntity(SessionFactoryImpl.java:870)
>> at
>> org.hibernate.action.BulkOperationCleanupAction.evictEntityRegions(BulkOperationCleanupAction.java:153)
>> at
>> org.hibernate.action.BulkOperationCleanupAction.afterTransactionCompletion(BulkOperationCleanupAction.java:132)
>> at
>> org.hibernate.engine.ActionQueue.afterTransactionCompletion(ActionQueue.java:198)
>> at
>> org.hibernate.impl.SessionImpl.afterTransactionCompletion(SessionImpl.java:451)
>> at
>> org.hibernate.jdbc.JDBCContext.afterTransactionCompletion(JDBCContext.java:252)
>> at
>> org.hibernate.transaction.CacheSynchronization.afterCompletion(CacheSynchronization.java:117)
>> at
>> com.sun.enterprise.transaction.JavaEETransactionImpl.commit(JavaEETransactionImpl.java:518)
>> at
>> com.sun.enterprise.transaction.JavaEETransactionManagerSimplified.commit(JavaEETransactionManagerSimplified.java:837)
>> at
>> com.sun.enterprise.transaction.UserTransactionImpl.commit(UserTransactionImpl.java:201)
>> at
>> org.springframework.transaction.jta.JtaTransactionManager.doCommit(JtaTransactionManager.java:1028)
>> at
>> org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:732)
>> at
>> org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:701)
>> at
>> org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:321)
>> at
>> org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:116)
>> at
>> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
>> at
>> org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
>> at $Proxy176.executeUpdate(Unknown Source)
>> at
>> org.internna.iwebmvc.schedule.jobs.TemporalFileSweeperImpl.sweepTempFiles(TemporalFileSweeperImpl.java:54)
>> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
>> Method)
>> at
>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>> at
>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>> at java.lang.reflect.Method.invoke(Method.java:597)
>> at
>> org.springframework.util.MethodInvoker.invoke(MethodInvoker.java:276)
>> at
>> org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean$MethodInvokingJob.executeInternal(MethodInvokingJobDetailFactoryBean.java:260)
>> at
>> org.springframework.scheduling.quartz.QuartzJobBean.execute(QuartzJobBean.java:86)
>> at org.quartz.core.JobRunShell.run(JobRunShell.java:203)
>> at
>> org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:520)
>> Caused by: org.jboss.cache.lock.TimeoutException: Unable to
>> acquire lock on Fqn [/org/internna/iwebmvc/model/Document/ENTITY]
>> after [20000] milliseconds for requestor
>> [Thread[org.springframework.scheduling.quartz.SchedulerFactoryBean#0_Worker-9,5,Grizzly]]!
>> Lock held by [GlobalTransaction:<null>:0]
>> at
>> org.jboss.cache.mvcc.MVCCNodeHelper.acquireLock(MVCCNodeHelper.java:157)
>> at
>> org.jboss.cache.mvcc.MVCCNodeHelper.wrapNodesRecursivelyForRemoval(MVCCNodeHelper.java:326)
>> at
>> org.jboss.cache.interceptors.MVCCLockingInterceptor.handleRemoveNodeCommand(MVCCLockingInterceptor.java:116)
>> at
>> org.jboss.cache.interceptors.base.PrePostProcessingCommandInterceptor.visitRemoveNodeCommand(PrePostProcessingCommandInterceptor.java:126)
>> at
>> org.jboss.cache.commands.write.RemoveNodeCommand.acceptVisitor(RemoveNodeCommand.java:125)
>> at
>> org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
>> at
>> org.jboss.cache.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:131)
>> at
>> org.jboss.cache.commands.AbstractVisitor.visitRemoveNodeCommand(AbstractVisitor.java:75)
>> at
>> org.jboss.cache.commands.write.RemoveNodeCommand.acceptVisitor(RemoveNodeCommand.java:125)
>> at
>> org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
>> at
>> org.jboss.cache.interceptors.TxInterceptor.attachGtxAndPassUpChain(TxInterceptor.java:301)
>> at
>> org.jboss.cache.interceptors.TxInterceptor.handleDefault(TxInterceptor.java:283)
>> at
>> org.jboss.cache.commands.AbstractVisitor.visitRemoveNodeCommand(AbstractVisitor.java:75)
>> at
>> org.jboss.cache.commands.write.RemoveNodeCommand.acceptVisitor(RemoveNodeCommand.java:125)
>> at
>> org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
>> at
>> org.jboss.cache.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:131)
>> at
>> org.jboss.cache.commands.AbstractVisitor.visitRemoveNodeCommand(AbstractVisitor.java:75)
>> at
>> org.jboss.cache.commands.write.RemoveNodeCommand.acceptVisitor(RemoveNodeCommand.java:125)
>> at
>> org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
>> at
>> org.jboss.cache.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:178)
>> at
>> org.jboss.cache.interceptors.InvocationContextInterceptor.visitRemoveNodeCommand(InvocationContextInterceptor.java:88)
>> at
>> org.jboss.cache.commands.write.RemoveNodeCommand.acceptVisitor(RemoveNodeCommand.java:125)
>> at
>> org.jboss.cache.interceptors.InterceptorChain.invoke(InterceptorChain.java:287)
>> at
>> org.jboss.cache.invocation.CacheInvocationDelegate.removeNode(CacheInvocationDelegate.java:478)
>> at
>> org.hibernate.cache.jbc2.util.CacheHelper.removeAll(CacheHelper.java:378)
>> ... 32 more
>>
>> 3) Once I access the application (/index.iwebmvc) the application
>> works. But accessing any page that needs a tag file fails (for
>> example /filteredgrid.iwebmvc)
>
> I suppose this is related to the 2nd stacktrace in your follow-up
> email, right?
>
> at
> org.glassfish.web.loader.WebappClassLoader.findResourceInternal(WebappClassLoader.java:2075)
>
> at
> org.glassfish.web.loader.WebappClassLoader.findResource(WebappClassLoader.java:1008)
>
> Can you please file a new issue for this as well?
>
>
> And here is the other
> one https://glassfish.dev.java.net/issues/show_bug.cgi?id=11083

 From looking at line 2075 in WebappClassLoader.java, it looks like the
JSP related
stack trace is triggered by an IllegalStateException regarding the fact
that the
WebappClassLoader that is being asked to retrieve the resource has
already been
stopped (since the app is being undeployed), right?
The IllegalStateException is missing from the top of your stack trace.
Can you please confirm that we're indeed dealing with an
IllegalStateException?

Thanks,

Jan

>
>
>>
>> Sorry to bear such bad news...
>
> That's OK! :)
>
> Thanks,
>
> Jan
>
>
>
>>
>> Regards
>>
>> On Tue, Nov 17, 2009 at 12:56 AM, Jan Luehe <Jan.Luehe_at_sun.com
>> <mailto:Jan.Luehe_at_sun.com>> wrote:
>>
>> Hi Jose,
>>
>> good news! :)
>>
>> Using the latest nightly v3 build (which contains Sahoo's
>> fix), I was able to deploy
>> your app successfully!
>>
>> Can you please verify yourself?
>>
>> With this, I'll go ahead and close
>>
>>
>> https://glassfish.dev.java.net/issues/show_bug.cgi?id=9894
>>
>> as fixed. Feel free to reopen if necessary.
>>
>> Thanks, as always! :)
>>
>>
>> Jan
>>
>>
>>
>>
>> ---------------------------------------------------------------------
>> To unsubscribe, e-mail:
>> quality-unsubscribe_at_glassfish.dev.java.net
>> <mailto:quality-unsubscribe_at_glassfish.dev.java.net>
>> For additional commands, e-mail:
>> quality-help_at_glassfish.dev.java.net
>> <mailto:quality-help_at_glassfish.dev.java.net>
>>
>>
>
>