[Mifos-developer] Job Scheduler Issues

瀏覽次數:68 次
跳到第一則未讀訊息

Ippez Robert

未讀,
2016年3月24日 凌晨3:51:052016/3/24
收件者:mifos...@lists.sourceforge.net、mifos-d...@lists.sourceforge.net
Hi,
I was going through Fineract log, an found the following error about some jobs and i think these jobs are not being executed, Is this a bug?

09:30:00.166 [Scheduler1_Worker-2] ERROR org.quartz.core.ErrorLogger - Unable to notify JobListener(s) of Job to be executed: (Job will NOT be executed!). trigger= DEFAULT.Pay Due Savings ChargesTrigger1 job= DEFAULT.Pay Due Savings ChargesJobDetail1
org.quartz.SchedulerException: JobListener 'Global Listner' threw exception: null
        at org.quartz.core.QuartzScheduler.notifyJobListenersToBeExecuted(QuartzScheduler.java:1899) ~[quartz-2.1.7.jar:na]
        at org.quartz.core.JobRunShell.notifyListenersBeginning(JobRunShell.java:345) [quartz-2.1.7.jar:na]
        at org.quartz.core.JobRunShell.run(JobRunShell.java:180) [quartz-2.1.7.jar:na]
        at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz-2.1.7.jar:na]
Caused by: org.apache.fineract.useradministration.exception.UserNotFoundException: null
        at org.apache.fineract.useradministration.domain.AppUserRepositoryWrapper.fetchSystemUser(AppUserRepositoryWrapper.java:39) ~[AppUserRepositoryWrapper.class:na]
        at org.apache.fineract.infrastructure.jobs.service.SchedulerJobListener.jobToBeExecuted(SchedulerJobListener.java:73) ~[SchedulerJobListener.class:na]
        at org.quartz.core.QuartzScheduler.notifyJobListenersToBeExecuted(QuartzScheduler.java:1897) ~[quartz-2.1.7.jar:na]
        ... 3 common frames omitted
09:30:00.181 [Scheduler1_Worker-1] ERROR org.quartz.core.ErrorLogger - Unable to notify JobListener(s) of Job to be executed: (Job will NOT be executed!). trigger= DEFAULT.Apply Holidays To LoansTrigger1 job= DEFAULT.Apply Holidays To LoansJobDetail1
org.quartz.SchedulerException: JobListener 'Global Listner' threw exception: null
        at org.quartz.core.QuartzScheduler.notifyJobListenersToBeExecuted(QuartzScheduler.java:1899) ~[quartz-2.1.7.jar:na]
        at org.quartz.core.JobRunShell.notifyListenersBeginning(JobRunShell.java:345) [quartz-2.1.7.jar:na]
        at org.quartz.core.JobRunShell.run(JobRunShell.java:180) [quartz-2.1.7.jar:na]
        at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz-2.1.7.jar:na]
Caused by: org.apache.fineract.useradministration.exception.UserNotFoundException: null
        at org.apache.fineract.useradministration.domain.AppUserRepositoryWrapper.fetchSystemUser(AppUserRepositoryWrapper.java:39) ~[AppUserRepositoryWrapper.class:na]
        at org.apache.fineract.infrastructure.jobs.service.SchedulerJobListener.jobToBeExecuted(SchedulerJobListener.java:73) ~[SchedulerJobListener.class:na]
        at org.quartz.core.QuartzScheduler.notifyJobListenersToBeExecuted(QuartzScheduler.java:1897) ~[quartz-2.1.7.jar:na]
        ... 3 common frames omitted



Thanks
Ippez Robert

Adi Raju

未讀,
2016年3月24日 凌晨4:02:002016/3/24
收件者:Mifos software development、mifos...@lists.sourceforge.net

Yes, job is failing. Schedule jobs use a app user by name “system”. Looks like that user is deleted on this particular tenant instance.

1.       Recreate the system user

2.       Make sure others do not delete user.

 

Regards,

Adi

Ippez Robert

未讀,
2016年3月24日 清晨7:55:582016/3/24
收件者:Mifos Developer、mifos-d...@lists.sourceforge.net、mifos...@lists.sourceforge.net
Hi, Adi,
Thanks for that quick shot. I recreated the user and things seem to have worked pretty fine. However when i checked the fineract.log file i found out the below error threads. Can this affect the overall aim and results of all jobs? Is there another configuration that i need to do further to avoid this error log?


304958 [Scheduler1group3_Worker-1] WARN  o.h.e.jdbc.spi.SqlExceptionHelper - SQL Error: 1213, SQLState: 40001
304989 [Scheduler1group3_Worker-1] ERROR o.h.e.jdbc.spi.SqlExceptionHelper - Deadlock found when trying to get lock; try restarting transaction
305099 [Scheduler1group3_Worker-1] ERROR org.quartz.core.ErrorLogger - Unable to notify TriggerListener(s) while firing trigger (Trigger and Job will NOT be fired!). trigger= DEFAULT.MT_1absvk13dtavq job= DEFAULT.Add Accrual TransactionsJobDetail1
org.quartz.SchedulerException: TriggerListener 'Global trigger Listner' threw exception: could not extract ResultSet; SQL [n/a]; nested exception is org.hibernate.exception.LockAcquisitionException: could not extract ResultSet
    at org.quartz.core.QuartzScheduler.notifyTriggerListenersFired(QuartzScheduler.java:1836) ~[quartz-2.1.7.jar:na]
    at org.quartz.core.JobRunShell.notifyListenersBeginning(JobRunShell.java:317) [quartz-2.1.7.jar:na]

    at org.quartz.core.JobRunShell.run(JobRunShell.java:180) [quartz-2.1.7.jar:na]
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz-2.1.7.jar:na]
Caused by: org.springframework.dao.CannotAcquireLockException: could not extract ResultSet; SQL [n/a]; nested exception is org.hibernate.exception.LockAcquisitionException: could not extract ResultSet
    at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:180) ~[spring-orm-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:155) ~[spring-orm-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.translateExceptionIfPossible(AbstractEntityManagerFactoryBean.java:417) ~[spring-orm-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.dao.support.ChainedPersistenceExceptionTranslator.translateExceptionIfPossible(ChainedPersistenceExceptionTranslator.java:59) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.dao.support.DataAccessUtils.translateIfNecessary(DataAccessUtils.java:213) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:147) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodIntercceptor.invoke(CrudMethodMetadataPostProcessor.java:111) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at com.sun.proxy.$Proxy198.findByJobKeyWithLock(Unknown Source) ~[na:na]
    at org.apache.fineract.infrastructure.jobs.service.SchedularWritePlatformServiceJpaRepositoryImpl.processJobDetailForExecution(SchedularWritePlatformServiceJpaRepositoryImpl.java:137) ~[SchedularWritePlatformServiceJpaRepositoryImpl.class:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_74]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_74]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:98) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:262) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:95) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at com.sun.proxy.$Proxy201.processJobDetailForExecution(Unknown Source) ~[na:na]
    at org.apache.fineract.infrastructure.jobs.service.SchedulerTriggerListener.vetoJobExecution(SchedulerTriggerListener.java:71) ~[SchedulerTriggerListener.class:na]
    at org.quartz.core.QuartzScheduler.notifyTriggerListenersFired(QuartzScheduler.java:1832) ~[quartz-2.1.7.jar:na]

    ... 3 common frames omitted
Caused by: org.hibernate.exception.LockAcquisitionException: could not extract ResultSet
    at org.hibernate.dialect.MySQLDialect$1.convert(MySQLDialect.java:451) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:49) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:126) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:112) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.extract(ResultSetReturnImpl.java:91) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.getResultSet(Loader.java:2065) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.executeQueryStatement(Loader.java:1862) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.executeQueryStatement(Loader.java:1838) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.doQuery(Loader.java:909) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:354) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.doList(Loader.java:2553) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.doList(Loader.java:2539) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.listIgnoreQueryCache(Loader.java:2369) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.list(Loader.java:2364) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.hql.QueryLoader.list(QueryLoader.java:496) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.hql.internal.ast.QueryTranslatorImpl.list(QueryTranslatorImpl.java:387) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.engine.query.spi.HQLQueryPlan.performList(HQLQueryPlan.java:231) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.internal.SessionImpl.list(SessionImpl.java:1264) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.internal.QueryImpl.list(QueryImpl.java:103) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.jpa.internal.QueryImpl.list(QueryImpl.java:573) ~[hibernate-entitymanager-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.jpa.internal.QueryImpl.getSingleResult(QueryImpl.java:495) ~[hibernate-entitymanager-4.3.6.Final.jar:4.3.6.Final]
    at org.springframework.data.jpa.repository.query.JpaQueryExecution$SingleEntityExecution.doExecute(JpaQueryExecution.java:168) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.data.jpa.repository.query.JpaQueryExecution.execute(JpaQueryExecution.java:59) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.data.jpa.repository.query.AbstractJpaQuery.doExecute(AbstractJpaQuery.java:97) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.data.jpa.repository.query.AbstractJpaQuery.execute(AbstractJpaQuery.java:88) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.data.repository.core.support.RepositoryFactorySupport$QueryExecutorMethodInterceptor.doInvoke(RepositoryFactorySupport.java:384) ~[spring-data-commons-1.8.4.RELEASE.jar:na]
    at org.springframework.data.repository.core.support.RepositoryFactorySupport$QueryExecutorMethodInterceptor.invoke(RepositoryFactorySupport.java:344) ~[spring-data-commons-1.8.4.RELEASE.jar:na]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:98) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:262) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:95) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:136) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    ... 26 common frames omitted
Caused by: java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction
    at org.drizzle.jdbc.internal.SQLExceptionMapper.get(SQLExceptionMapper.java:101) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.DrizzlePreparedStatement.executeQuery(DrizzlePreparedStatement.java:105) ~[drizzle-jdbc-1.3.jar:na]
    at sun.reflect.GeneratedMethodAccessor74.invoke(Unknown Source) ~[na:na]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.apache.tomcat.jdbc.pool.interceptor.AbstractQueryReport$StatementProxy.invoke(AbstractQueryReport.java:235) ~[tomcat-jdbc-7.0.55.jar:na]
    at com.sun.proxy.$Proxy202.executeQuery(Unknown Source) ~[na:na]
    at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.extract(ResultSetReturnImpl.java:82) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    ... 54 common frames omitted
Caused by: org.drizzle.jdbc.internal.common.QueryException: Deadlock found when trying to get lock; try restarting transaction
    at org.drizzle.jdbc.internal.mysql.MySQLProtocol.createDrizzleQueryResult(MySQLProtocol.java:313) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.internal.mysql.MySQLProtocol.executeQuery(MySQLProtocol.java:480) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.DrizzlePreparedStatement.executeQuery(DrizzlePreparedStatement.java:102) ~[drizzle-jdbc-1.3.jar:na]
    ... 60 common frames omitted
305130 [Scheduler1_Worker-7] INFO  o.a.f.s.s.ScheduledJobRunnerServiceImpl - Default Demo Tenant: Deposit accounts affected by update: 0
305834 [Scheduler1_Worker-5] WARN  o.a.t.j.p.i.SlowQueryReport - Failed Query Report SQL=select scheduledj0_.id as id1_12_, scheduledj0_.is_active as is_activ2_12_, scheduledj0_.create_time as create_t3_12_, scheduledj0_.cron_expression as cron_exp4_12_, scheduledj0_.currently_running as currentl5_12_, scheduledj0_.initializing_errorlog as initiali6_12_, scheduledj0_.group_name as group_na7_12_, scheduledj0_.display_name as display_8_12_, scheduledj0_.job_key as job_key9_12_, scheduledj0_.name as name10_12_, scheduledj0_.next_run_time as next_ru11_12_, scheduledj0_.previous_run_start_time as previou12_12_, scheduledj0_.scheduler_group as schedul13_12_, scheduledj0_.task_priority as task_pr14_12_, scheduledj0_.is_misfired as is_misf15_12_, scheduledj0_.updates_allowed as updates16_12_ from job scheduledj0_ where scheduledj0_.job_key=? for update; time=532 ms;
305850 [Scheduler1_Worker-5] WARN  o.h.e.jdbc.spi.SqlExceptionHelper - SQL Error: 1213, SQLState: 40001
305850 [Scheduler1_Worker-5] ERROR o.h.e.jdbc.spi.SqlExceptionHelper - Deadlock found when trying to get lock; try restarting transaction
305868 [Scheduler1_Worker-5] ERROR org.quartz.core.ErrorLogger - Unable to notify TriggerListener(s) while firing trigger (Trigger and Job will NOT be fired!). trigger= DEFAULT.MT_27d6g0nfcmuof job= DEFAULT.Apply penalty to overdue loansJobDetail1
org.quartz.SchedulerException: TriggerListener 'Global trigger Listner' threw exception: could not extract ResultSet; SQL [n/a]; nested exception is org.hibernate.exception.LockAcquisitionException: could not extract ResultSet
    at org.quartz.core.QuartzScheduler.notifyTriggerListenersFired(QuartzScheduler.java:1836) ~[quartz-2.1.7.jar:na]
    at org.quartz.core.JobRunShell.notifyListenersBeginning(JobRunShell.java:317) [quartz-2.1.7.jar:na]

    at org.quartz.core.JobRunShell.run(JobRunShell.java:180) [quartz-2.1.7.jar:na]
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz-2.1.7.jar:na]
Caused by: org.springframework.dao.CannotAcquireLockException: could not extract ResultSet; SQL [n/a]; nested exception is org.hibernate.exception.LockAcquisitionException: could not extract ResultSet
    at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:180) ~[spring-orm-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:155) ~[spring-orm-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.translateExceptionIfPossible(AbstractEntityManagerFactoryBean.java:417) ~[spring-orm-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.dao.support.ChainedPersistenceExceptionTranslator.translateExceptionIfPossible(ChainedPersistenceExceptionTranslator.java:59) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.dao.support.DataAccessUtils.translateIfNecessary(DataAccessUtils.java:213) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:147) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodIntercceptor.invoke(CrudMethodMetadataPostProcessor.java:111) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at com.sun.proxy.$Proxy198.findByJobKeyWithLock(Unknown Source) ~[na:na]
    at org.apache.fineract.infrastructure.jobs.service.SchedularWritePlatformServiceJpaRepositoryImpl.processJobDetailForExecution(SchedularWritePlatformServiceJpaRepositoryImpl.java:137) ~[SchedularWritePlatformServiceJpaRepositoryImpl.class:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_74]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_74]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:98) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:262) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:95) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at com.sun.proxy.$Proxy201.processJobDetailForExecution(Unknown Source) ~[na:na]
    at org.apache.fineract.infrastructure.jobs.service.SchedulerTriggerListener.vetoJobExecution(SchedulerTriggerListener.java:71) ~[SchedulerTriggerListener.class:na]
    at org.quartz.core.QuartzScheduler.notifyTriggerListenersFired(QuartzScheduler.java:1832) ~[quartz-2.1.7.jar:na]

    ... 3 common frames omitted
Caused by: org.hibernate.exception.LockAcquisitionException: could not extract ResultSet
    at org.hibernate.dialect.MySQLDialect$1.convert(MySQLDialect.java:451) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:49) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:126) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:112) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.extract(ResultSetReturnImpl.java:91) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.getResultSet(Loader.java:2065) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.executeQueryStatement(Loader.java:1862) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.executeQueryStatement(Loader.java:1838) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.doQuery(Loader.java:909) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:354) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.doList(Loader.java:2553) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.doList(Loader.java:2539) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.listIgnoreQueryCache(Loader.java:2369) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.Loader.list(Loader.java:2364) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.loader.hql.QueryLoader.list(QueryLoader.java:496) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.hql.internal.ast.QueryTranslatorImpl.list(QueryTranslatorImpl.java:387) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.engine.query.spi.HQLQueryPlan.performList(HQLQueryPlan.java:231) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.internal.SessionImpl.list(SessionImpl.java:1264) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.internal.QueryImpl.list(QueryImpl.java:103) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.jpa.internal.QueryImpl.list(QueryImpl.java:573) ~[hibernate-entitymanager-4.3.6.Final.jar:4.3.6.Final]
    at org.hibernate.jpa.internal.QueryImpl.getSingleResult(QueryImpl.java:495) ~[hibernate-entitymanager-4.3.6.Final.jar:4.3.6.Final]
    at org.springframework.data.jpa.repository.query.JpaQueryExecution$SingleEntityExecution.doExecute(JpaQueryExecution.java:168) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.data.jpa.repository.query.JpaQueryExecution.execute(JpaQueryExecution.java:59) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.data.jpa.repository.query.AbstractJpaQuery.doExecute(AbstractJpaQuery.java:97) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.data.jpa.repository.query.AbstractJpaQuery.execute(AbstractJpaQuery.java:88) ~[spring-data-jpa-1.6.4.RELEASE.jar:na]
    at org.springframework.data.repository.core.support.RepositoryFactorySupport$QueryExecutorMethodInterceptor.doInvoke(RepositoryFactorySupport.java:384) ~[spring-data-commons-1.8.4.RELEASE.jar:na]
    at org.springframework.data.repository.core.support.RepositoryFactorySupport$QueryExecutorMethodInterceptor.invoke(RepositoryFactorySupport.java:344) ~[spring-data-commons-1.8.4.RELEASE.jar:na]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:98) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:262) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:95) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:136) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    ... 26 common frames omitted
Caused by: java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction
    at org.drizzle.jdbc.internal.SQLExceptionMapper.get(SQLExceptionMapper.java:101) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.DrizzlePreparedStatement.executeQuery(DrizzlePreparedStatement.java:105) ~[drizzle-jdbc-1.3.jar:na]
    at sun.reflect.GeneratedMethodAccessor74.invoke(Unknown Source) ~[na:na]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.apache.tomcat.jdbc.pool.interceptor.AbstractQueryReport$StatementProxy.invoke(AbstractQueryReport.java:235) ~[tomcat-jdbc-7.0.55.jar:na]
    at com.sun.proxy.$Proxy202.executeQuery(Unknown Source) ~[na:na]
    at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.extract(ResultSetReturnImpl.java:82) ~[hibernate-core-4.3.6.Final.jar:4.3.6.Final]
    ... 54 common frames omitted
Caused by: org.drizzle.jdbc.internal.common.QueryException: Deadlock found when trying to get lock; try restarting transaction
    at org.drizzle.jdbc.internal.mysql.MySQLProtocol.createDrizzleQueryResult(MySQLProtocol.java:313) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.internal.mysql.MySQLProtocol.executeQuery(MySQLProtocol.java:480) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.DrizzlePreparedStatement.executeQuery(DrizzlePreparedStatement.java:102) ~[drizzle-jdbc-1.3.jar:na]
    ... 60 common frames omitted
306949 [Scheduler1_Worker-7] INFO  o.a.f.s.s.ScheduledJobRunnerServiceImpl - Default Demo Tenant: Savings accounts affected by update: 0
307558 [Scheduler1_Worker-4] WARN  o.a.t.j.p.i.SlowQueryReport - Slow Query Report SQL=select MIN(je.entry_date) as entityDate from acc_gl_journal_entry  je where je.is_running_balance_calculated=0 ; time=2843 ms;
307777 [Scheduler1group1_Worker-1] WARN  o.a.t.j.p.i.SlowQueryReport - Slow Query Report SQL=select savingsacc0_.id as id2_116_, savingsacc0_.account_no as account_3_116_, savingsacc0_.account_type_enum as account_4_116_, savingsacc0_.activatedon_userid as activat46_116_, savingsacc0_.activatedon_date as activate5_116_, savingsacc0_.allow_overdraft as allow_ov6_116_, savingsacc0_.approvedon_userid as approve47_116_, savingsacc0_.approvedon_date as approved7_116_, savingsacc0_.client_id as client_48_116_, savingsacc0_.closedon_userid as closedo49_116_, savingsacc0_.closedon_date as closedon8_116_, savingsacc0_.currency_code as currency9_116_, savingsacc0_.currency_digits as currenc10_116_, savingsacc0_.currency_multiplesof as currenc11_116_, savingsacc0_.deposit_type_enum as deposit_1_116_, savingsacc0_.enforce_min_required_balance as enforce12_116_, savingsacc0_.external_id as externa13_116_, savingsacc0_.group_id as group_i50_116_, savingsacc0_.interest_calculation_days_in_year_type_enum as interes14_116_, savingsacc0_.interest_calculation_type_enum as interes15_116_, savingsacc0_.interest_compounding_period_enum as interes16_116_, savingsacc0_.interest_posting_period_enum as interes17_116_, savingsacc0_.lockedin_until_date_derived as lockedi18_116_, savingsacc0_.lockin_period_frequency as lockin_19_116_, savingsacc0_.lockin_period_frequency_enum as lockin_20_116_, savingsacc0_.min_balance_for_interest_calculation as min_bal21_116_, savingsacc0_.min_overdraft_for_interest_calculation as min_ove22_116_, savingsacc0_.min_required_balance as min_req23_116_, savingsacc0_.min_required_opening_balance as min_req24_116_, savingsacc0_.nominal_annual_interest_rate as nominal25_116_, savingsacc0_.nominal_annual_interest_rate_overdraft as nominal26_116_, savingsacc0_.on_hold_funds_derived as on_hold27_116_, savingsacc0_.overdraft_limit as overdra28_116_, savingsacc0_.product_id as product51_116_, savingsacc0_.rejectedon_userid as rejecte52_116_, savingsacc0_.rejectedon_date as rejecte29_116_, savingsacc0_.field_officer_id as field_o53_116_, savingsacc0_.start_interest_calculation_date as start_i30_116_, savingsacc0_.status_enum as status_31_116_, savingsacc0_.submittedon_userid as submitt54_116_, savingsacc0_.submittedon_date as submitt32_116_, savingsacc0_.account_balance_derived as account33_116_, savingsacc0_.total_annual_fees_derived as total_a34_116_, savingsacc0_.total_deposits_derived as total_d35_116_, savingsacc0_.total_fees_charge_derived as total_f36_116_, savingsacc0_.total_interest_earned_derived as total_i37_116_, savingsacc0_.total_interest_posted_derived as total_i38_116_, savingsacc0_.total_overdraft_interest_derived as total_o39_116_, savingsacc0_.total_penalty_charge_derived as total_p40_116_, savingsacc0_.total_withdrawal_fees_derived as total_w41_116_, savingsacc0_.total_withdrawals_derived as total_w42_116_, savingsacc0_.version as version43_116_, savingsacc0_.withdrawal_fee_for_transfer as withdra44_116_, savingsacc0_.withdrawnon_userid as withdra55_116_, savingsacc0_.withdrawnon_date as withdra45_116_ from m_savings_account savingsacc0_ where savingsacc0_.status_enum=?; time=2971 ms;
308386 [Scheduler1_Worker-6] WARN  o.a.t.j.p.i.SlowQueryReport - Slow Query Report SQL=truncate table m_loan_paid_in_advance; time=1516 ms;
310056 [Scheduler1_Worker-4] WARN  o.a.t.j.p.i.SlowQueryReport - Slow Query Report SQL=select je.organization_running_balance as runningBalance,je.account_id as accountId from acc_gl_journal_entry je inner join (select max(id) as id from acc_gl_journal_entry where entry_date < ? group by account_id,entry_date) je2 inner join (select max(entry_date) as date from acc_gl_journal_entry where entry_date < ? group by account_id) je3 where je2.id = je.id and je.entry_date = je3.date group by je.id order by je.entry_date DESC limit 0, 10000; time=2498 ms;
311681 [Scheduler1_Worker-2] WARN  o.a.t.j.p.i.SlowQueryReport - Slow Query Report SQL=batch; time=6966 ms;
311681 [Scheduler1_Worker-2] INFO  o.a.f.s.s.ScheduledJobRunnerServiceImpl - Default Demo Tenant: Results affected by update: 1118
311963 [Scheduler1group3_Worker-1] WARN  o.d.j.internal.mysql.MySQLProtocol - Could not execute query org.drizzle.jdbc.internal.common.query.DrizzleQuery@266c110c: Deadlock found when trying to get lock; try restarting transaction
311963 [Scheduler1group3_Worker-1] WARN  o.a.t.j.p.i.SlowQueryReport - Failed Query Report SQL=update m_loan loan left join m_loan_arrears_aging laa on laa.loan_id = loan.id inner join m_product_loan mpl on mpl.id = loan.product_id and mpl.overdue_days_for_npa is not null set loan.is_npa = 0 where  loan.loan_status_id = 300 and mpl.account_moves_out_of_npa_only_on_arrears_completion = 0 or (mpl.account_moves_out_of_npa_only_on_arrears_completion = 1 and laa.overdue_since_date_derived is null); time=5093 ms;
311978 [Scheduler1group3_Worker-1] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [org/springframework/jdbc/support/sql-error-codes.xml]
312025 [Scheduler1group3_Worker-1] INFO  o.s.j.support.SQLErrorCodesFactory - SQLErrorCodes loaded: [DB2, Derby, H2, HSQL, Informix, MS-SQL, MySQL, Oracle, PostgreSQL, Sybase]
312041 [Scheduler1group3_Worker-1] ERROR org.quartz.core.JobRunShell - Job DEFAULT.Update Non Performing AssetsJobDetail1 threw an unhandled Exception:
org.springframework.scheduling.quartz.JobMethodInvocationFailedException: Invocation of method 'updateNPA' on target class [class com.sun.proxy.$Proxy224] failed; nested exception is org.springframework.dao.DeadlockLoserDataAccessException: StatementCallback; SQL [update m_loan loan left join m_loan_arrears_aging laa on laa.loan_id = loan.id inner join m_product_loan mpl on mpl.id = loan.product_id and mpl.overdue_days_for_npa is not null set loan.is_npa = 0 where  loan.loan_status_id = 300 and mpl.account_moves_out_of_npa_only_on_arrears_completion = 0 or (mpl.account_moves_out_of_npa_only_on_arrears_completion = 1 and laa.overdue_since_date_derived is null)]; Deadlock found when trying to get lock; try restarting transaction; nested exception is java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction
    at org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean$MethodInvokingJob.executeInternal(MethodInvokingJobDetailFactoryBean.java:331) ~[spring-context-support-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.scheduling.quartz.QuartzJobBean.execute(QuartzJobBean.java:112) ~[spring-context-support-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213) ~[quartz-2.1.7.jar:na]

    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz-2.1.7.jar:na]
Caused by: org.springframework.dao.DeadlockLoserDataAccessException: StatementCallback; SQL [update m_loan loan left join m_loan_arrears_aging laa on laa.loan_id = loan.id inner join m_product_loan mpl on mpl.id = loan.product_id and mpl.overdue_days_for_npa is not null set loan.is_npa = 0 where  loan.loan_status_id = 300 and mpl.account_moves_out_of_npa_only_on_arrears_completion = 0 or (mpl.account_moves_out_of_npa_only_on_arrears_completion = 1 and laa.overdue_since_date_derived is null)]; Deadlock found when trying to get lock; try restarting transaction; nested exception is java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction
    at org.springframework.jdbc.support.SQLErrorCodeSQLExceptionTranslator.doTranslate(SQLErrorCodeSQLExceptionTranslator.java:263) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:73) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:413) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.core.JdbcTemplate.update(JdbcTemplate.java:546) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.apache.fineract.scheduledjobs.service.ScheduledJobRunnerServiceImpl.updateNPA(ScheduledJobRunnerServiceImpl.java:268) ~[ScheduledJobRunnerServiceImpl.class:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_74]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_74]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:98) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:262) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:95) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at com.sun.proxy.$Proxy224.updateNPA(Unknown Source) ~[na:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_74]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_74]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.springframework.util.MethodInvoker.invoke(MethodInvoker.java:269) ~[spring-core-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean$MethodInvokingJob.executeInternal(MethodInvokingJobDetailFactoryBean.java:322) ~[spring-context-support-4.0.7.RELEASE.jar:4.0.7.RELEASE]

    ... 3 common frames omitted
Caused by: java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction
    at org.drizzle.jdbc.internal.SQLExceptionMapper.get(SQLExceptionMapper.java:101) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.DrizzleStatement.executeUpdate(DrizzleStatement.java:178) ~[drizzle-jdbc-1.3.jar:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_74]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_74]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.apache.tomcat.jdbc.pool.interceptor.AbstractQueryReport$StatementProxy.invoke(AbstractQueryReport.java:235) ~[tomcat-jdbc-7.0.55.jar:na]
    at com.sun.proxy.$Proxy329.executeUpdate(Unknown Source) ~[na:na]
    at org.springframework.jdbc.core.JdbcTemplate$1UpdateStatementCallback.doInStatement(JdbcTemplate.java:535) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.core.JdbcTemplate$1UpdateStatementCallback.doInStatement(JdbcTemplate.java:532) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:402) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    ... 24 common frames omitted
Caused by: org.drizzle.jdbc.internal.common.QueryException: Deadlock found when trying to get lock; try restarting transaction
    at org.drizzle.jdbc.internal.mysql.MySQLProtocol.executeQuery(MySQLProtocol.java:464) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.DrizzleStatement.executeUpdate(DrizzleStatement.java:173) ~[drizzle-jdbc-1.3.jar:na]
    ... 33 common frames omitted
312056 [Scheduler1group3_Worker-1] ERROR org.quartz.core.ErrorLogger - Job (DEFAULT.Update Non Performing AssetsJobDetail1 threw an exception.
org.quartz.SchedulerException: Job threw an unhandled exception.
    at org.quartz.core.JobRunShell.run(JobRunShell.java:224) ~[quartz-2.1.7.jar:na]

    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz-2.1.7.jar:na]
Caused by: org.springframework.scheduling.quartz.JobMethodInvocationFailedException: Invocation of method 'updateNPA' on target class [class com.sun.proxy.$Proxy224] failed; nested exception is org.springframework.dao.DeadlockLoserDataAccessException: StatementCallback; SQL [update m_loan loan left join m_loan_arrears_aging laa on laa.loan_id = loan.id inner join m_product_loan mpl on mpl.id = loan.product_id and mpl.overdue_days_for_npa is not null set loan.is_npa = 0 where  loan.loan_status_id = 300 and mpl.account_moves_out_of_npa_only_on_arrears_completion = 0 or (mpl.account_moves_out_of_npa_only_on_arrears_completion = 1 and laa.overdue_since_date_derived is null)]; Deadlock found when trying to get lock; try restarting transaction; nested exception is java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction
    at org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean$MethodInvokingJob.executeInternal(MethodInvokingJobDetailFactoryBean.java:331) ~[spring-context-support-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.scheduling.quartz.QuartzJobBean.execute(QuartzJobBean.java:112) ~[spring-context-support-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213) ~[quartz-2.1.7.jar:na]
    ... 1 common frames omitted
Caused by: org.springframework.dao.DeadlockLoserDataAccessException: StatementCallback; SQL [update m_loan loan left join m_loan_arrears_aging laa on laa.loan_id = loan.id inner join m_product_loan mpl on mpl.id = loan.product_id and mpl.overdue_days_for_npa is not null set loan.is_npa = 0 where  loan.loan_status_id = 300 and mpl.account_moves_out_of_npa_only_on_arrears_completion = 0 or (mpl.account_moves_out_of_npa_only_on_arrears_completion = 1 and laa.overdue_since_date_derived is null)]; Deadlock found when trying to get lock; try restarting transaction; nested exception is java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction
    at org.springframework.jdbc.support.SQLErrorCodeSQLExceptionTranslator.doTranslate(SQLErrorCodeSQLExceptionTranslator.java:263) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:73) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:413) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.core.JdbcTemplate.update(JdbcTemplate.java:546) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.apache.fineract.scheduledjobs.service.ScheduledJobRunnerServiceImpl.updateNPA(ScheduledJobRunnerServiceImpl.java:268) ~[ScheduledJobRunnerServiceImpl.class:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_74]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_74]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:98) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:262) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:95) ~[spring-tx-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207) ~[spring-aop-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at com.sun.proxy.$Proxy224.updateNPA(Unknown Source) ~[na:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_74]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_74]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.springframework.util.MethodInvoker.invoke(MethodInvoker.java:269) ~[spring-core-4.0.8.RELEASE.jar:4.0.8.RELEASE]
    at org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean$MethodInvokingJob.executeInternal(MethodInvokingJobDetailFactoryBean.java:322) ~[spring-context-support-4.0.7.RELEASE.jar:4.0.7.RELEASE]

    ... 3 common frames omitted
Caused by: java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction
    at org.drizzle.jdbc.internal.SQLExceptionMapper.get(SQLExceptionMapper.java:101) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.DrizzleStatement.executeUpdate(DrizzleStatement.java:178) ~[drizzle-jdbc-1.3.jar:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_74]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_74]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_74]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_74]
    at org.apache.tomcat.jdbc.pool.interceptor.AbstractQueryReport$StatementProxy.invoke(AbstractQueryReport.java:235) ~[tomcat-jdbc-7.0.55.jar:na]
    at com.sun.proxy.$Proxy329.executeUpdate(Unknown Source) ~[na:na]
    at org.springframework.jdbc.core.JdbcTemplate$1UpdateStatementCallback.doInStatement(JdbcTemplate.java:535) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.core.JdbcTemplate$1UpdateStatementCallback.doInStatement(JdbcTemplate.java:532) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:402) ~[spring-jdbc-4.0.7.RELEASE.jar:4.0.7.RELEASE]
    ... 24 common frames omitted
Caused by: org.drizzle.jdbc.internal.common.QueryException: Deadlock found when trying to get lock; try restarting transaction
    at org.drizzle.jdbc.internal.mysql.MySQLProtocol.executeQuery(MySQLProtocol.java:464) ~[drizzle-jdbc-1.3.jar:na]
    at org.drizzle.jdbc.DrizzleStatement.executeUpdate(DrizzleStatement.java:173) ~[drizzle-jdbc-1.3.jar:na]
    ... 33 common frames omitted


Thanks
Regards
Ippez

Adi Raju

未讀,
2016年3月24日 上午8:17:132016/3/24
收件者:Mifos software development、mifos-users、Mifos Developer

In case of deadlock, transaction is re-tried and generally succeeds.

------------------------------------------------------------------------------
Transform Data into Opportunity.
Accelerate data analysis in your applications with
Intel Data Analytics Acceleration Library.
Click to learn more.
http://pubads.g.doubleclick.net/gampad/clk?id=278785351&iu=/4140
Mifos-developer mailing list
mifos-d...@lists.sourceforge.net
Unsubscribe or change settings at:
https://lists.sourceforge.net/lists/listinfo/mifos-developer

Ippez Robert

未讀,
2016年3月24日 上午9:23:292016/3/24
收件者:Mifos Developer、mifos-d...@lists.sourceforge.net、mifos...@lists.sourceforge.net
Surely, all of them ran when i checked from the community-app expect for one job i.e "Update Non Performing Assets" below is the error thread.


org.springframework.dao.DeadlockLoserDataAccessException: StatementCallback; SQL [update m_loan loan left join m_loan_arrears_aging laa on laa.loan_id = loan.id inner join m_product_loan mpl on mpl.id = loan.product_id and mpl.overdue_days_for_npa is not null set loan.is_npa = 0 where loan.loan_status_id = 300 and mpl.account_moves_out_of_npa_only_on_arrears_completion = 0 or (mpl.account_moves_out_of_npa_only_on_arrears_completion = 1 and laa.overdue_since_date_derived is null)]; Deadlock found when trying to get lock; try restarting transaction; nested exception is java.sql.SQLTransactionRollbackException: Deadlock found when trying to get lock; try restarting transaction at org.springframework.jdbc.support.SQLErrorCodeSQLExceptionTranslator.doTranslate(263) at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(73) at org.springframework.jdbc.core.JdbcTemplate.execute(413) at org.springframework.jdbc.core.JdbcTemplate.update(546) at org.apache.fineract.scheduledjobs.service.ScheduledJobRunnerServiceImpl.updateNPA(268) at sun.reflect.NativeMethodAccessorImpl.invoke0(-2) at sun.reflect.NativeMethodAccessorImpl.invoke(62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(43) at java.lang.reflect.Method.invoke(498) at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(317) at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(190) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(157) at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(98) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(262) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(95) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(179) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(207) at com.sun.proxy.$Proxy224.updateNPA(-1) at sun.reflect.NativeMethodAccessorImpl.invoke0(-2) at sun.reflect.NativeMethodAccessorImpl.invoke(62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(43) at java.lang.reflect.Method.invoke(498) at org.springframework.util.MethodInvoker.invoke(269) at org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean$MethodInvokingJob.executeInternal(322) at org.springframework.scheduling.quartz.QuartzJobBean.execute(112) at org.quartz.core.JobRunShell.run(213) at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(557)


Thanks
Ippez
回覆所有人
回覆作者
轉寄
0 則新訊息