dhis2-devs team mailing list archive

Thread
Date
update from dhis2 2.28 to 2.29 error

To: "DHIS 2 developers" <dhis2-devs@xxxxxxxxxxxxxxxxxxx>, "dhis2-users@xxxxxxxxxxxxxxxxxxx" <dhis2-users@xxxxxxxxxxxxxxxxxxx>, "lars@xxxxxxxxx" <lars@xxxxxxxxx>
From: 林晓东 <lin_xd@xxxxxxx>
Date: Mon, 9 Apr 2018 12:14:03 +0800 (CST)

hi,all


  when I upgrade from dhis2 2.28 to 2.29 I got error as fellowing:
   all I done:  dump from 2.28 db ,restore to a new db, execute the script: https://github.com/dhis2/dhis2-utils/blob/master/resources/sql/upgrade-229.sql
then start, got  error : 
----------console:------------------
* INFO  2018-04-09 12:01:18,383 Executing startup routine [7 of 18, runlevel 5]: SchedulerUpgrade (DefaultStartupRoutineExecutor.java [localhost-startStop-1])
* INFO  2018-04-09 12:01:18,393 Porting old jobs (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,473 Could not map job type '[scheduledProgramNotificationsTask]' with cron '0 0 5 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,473 Could not map job type '[scheduledProgramNotificationsTask]' with cron '0 0 5 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* INFO  2018-04-09 12:01:18,473 'system-process' create org.hisp.dhis.scheduling.JobConfiguration, name: Scheduled program notifications, uid: vaX5VXYvoro (AuditLogUtil.java [localhost-startStop-1])
* INFO  2018-04-09 12:01:18,513 'system-process' create org.hisp.dhis.scheduling.JobConfiguration, name: Analytics, uid: AeAgqSz6Vci (AuditLogUtil.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,543 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,553 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-
1])
* ERROR 2018-04-09 12:01:18,553 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-
1])
* ERROR 2018-04-09 12:01:18,553 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-
1])
* INFO  2018-04-09 12:01:18,553 'system-process' create org.hisp.dhis.scheduling.JobConfiguration, name: Monitoring, uid: d72z7q0iyd8 (AuditLogUtil.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,583 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-
1])
* INFO  2018-04-09 12:01:18,583 'system-process' create org.hisp.dhis.scheduling.JobConfiguration, name: Data synchronization, uid: Y5Jff0sMAbP (AuditLogUtil.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,603 Could not map job type '[analyticsAllTask, monitoringLastDayTask, da
taSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,603 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,603 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,613 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,613 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,613 Could not map job type '[analyticsAllTask, monitoringLastDayTask, dataSynchTask, metadataSyncTask]' with cron '0 0 0 * * ?' (SchedulerUpgrade.java [localhost-startStop-1])
* INFO  2018-04-09 12:01:18,613 'system-process' create org.hisp.dhis.scheduling.JobConfiguration, name: Metadata sync, uid: PoFQxtHy0Y1 (AuditLogUtil.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,643 Could not map job type '[resourceTableTask]' with cron '0 0 23 * * ?
' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,643 Could not map job type '[resourceTableTask]' with cron '0 0 23 * * ?
' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,643 Could not map job type '[resourceTableTask]' with cron '0 0 23 * * ?
' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,643 Could not map job type '[resourceTableTask]' with cron '0 0 23 * * ?
' (SchedulerUpgrade.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,653 Could not map job type '[resourceTableTask]' with cron '0 0 23 * * ?
' (SchedulerUpgrade.java [localhost-startStop-1])
* INFO  2018-04-09 12:01:18,653 'system-process' create org.hisp.dhis.scheduling.JobConfiguration, n
ame: Resource table, uid: ICVMtrnF7HN (AuditLogUtil.java [localhost-startStop-1])
* INFO  2018-04-09 12:01:18,683 Porting to new scheduler finished. Setting system settings key 'keyS
chedTasks' to 'ported'. (SchedulerUpgrade.java [localhost-startStop-1])
* WARN  2018-04-09 12:01:18,713 SQL Error: 0, SQLState: 23502 (SqlExceptionHelper.java [localhost-st
artStop-1])
* ERROR 2018-04-09 12:01:18,713 ERROR: null value in column "configurable" violates not-null constra
int
  详细：Failing row contains (87233656, vaX5VXYvoro, null, 2018-04-09 12:01:18.473, 2018-04-09 12:01
:18.473, null, Scheduled program notifications, 0 0 5 * * ?, \xaced00057e7200206f72672e686973702e646
869732e7363686564756c696e..., \xaced00057e7200226f72672e686973702e646869732e7363686564756c696e..., \
xaced00057e7200226f72672e686973702e646869732e7363686564756c696e..., 2018-04-09 05:00:00.012, null, 2
018-04-10 05:00:00, f, null, t, null). (SqlExceptionHelper.java [localhost-startStop-1])
* ERROR 2018-04-09 12:01:18,713 HHH000346: Error during managed flush [org.hibernate.exception.Const
raintViolationException: could not execute statement] (ExceptionMapperStandardImpl.java [localhost-s
tartStop-1])
* ERROR 2018-04-09 12:01:18,733 org.springframework.dao.DataIntegrityViolationException: could not e
xecute statement; SQL [n/a]; constraint [configurable]; nested exception is org.hibernate.exception.
ConstraintViolationException: could not execute statement
        at org.springframework.orm.hibernate5.SessionFactoryUtils.convertHibernateAccessException(Se
ssionFactoryUtils.java:241)
        at org.springframework.orm.hibernate5.HibernateTransactionManager.convertHibernateAccessExce
ption(HibernateTransactionManager.java:755)
        at org.springframework.orm.hibernate5.HibernateTransactionManager.doCommit(HibernateTransact
ionManager.java:594)
        at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(
AbstractPlatformTransactionManager.java:761)
        at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(Abstrac
tPlatformTransactionManager.java:730)
        at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAft
erReturning(TransactionAspectSupport.java:518)
        at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransact
ion(TransactionAspectSupport.java:292)
        at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInte
rceptor.java:96)
        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvo
cation.java:179)
        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:213)
        at com.sun.proxy.$Proxy243.execute(Unknown Source)
        at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineE
xecutor.java:113)
        at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineE
xecutor.java:70)
        at org.hisp.dhis.system.startup.StartupListener.contextInitialized(StartupListener.java:71)
        at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4745)
        at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5207)
        at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
        at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:752)
        at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:728)
        at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:734)
        at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:986)
        at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1857)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
Caused by: org.hibernate.exception.ConstraintViolationException: could not execute statement
        at org.hibernate.exception.internal.SQLStateConversionDelegate.convert(SQLStateConversionDel
egate.java:112)
        at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExcepti
onConverter.java:42)
        at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:111)
        at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:97)
        at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.
java:178)
        at org.hibernate.engine.jdbc.batch.internal.NonBatchingBatch.addToBatch(NonBatchingBatch.jav
a:45)




------------------log:----------------
09-Apr-2018 11:21:01.987 信息 [localhost-startStop-1] org.apache.catalina.core.ApplicationContext.log Initializing Spring root WebApplicationContext
09-Apr-2018 11:24:21.337 严重 [localhost-startStop-1] org.apache.catalina.core.StandardContext.listenerStart Exception sending context initialized event to listener instance of class [org.hisp.dhis.system.startup.StartupListener]
 java.lang.RuntimeException: Failed to run startup routines: could not execute statement; SQL [n/a]; constraint [configurable]; nested exception is org.hibernate.exception.ConstraintViolationException: could not execute statement
at org.hisp.dhis.system.startup.StartupListener.contextInitialized(StartupListener.java:77)
at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4745)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5207)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:752)
at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:728)
at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:734)
at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:986)
at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1857)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: org.springframework.dao.DataIntegrityViolationException: could not execute statement; SQL [n/a]; constraint [configurable]; nested exception is org.hibernate.exception.ConstraintViolationException: could not execute statement
at org.springframework.orm.hibernate5.SessionFactoryUtils.convertHibernateAccessException(SessionFactoryUtils.java:241)
at org.springframework.orm.hibernate5.HibernateTransactionManager.convertHibernateAccessException(HibernateTransactionManager.java:755)
at org.springframework.orm.hibernate5.HibernateTransactionManager.doCommit(HibernateTransactionManager.java:594)
at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:761)
at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:730)
at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:518)
at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:292)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:213)
at com.sun.proxy.$Proxy243.execute(Unknown Source)
at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineExecutor.java:113)
at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineExecutor.java:70)
at org.hisp.dhis.system.startup.StartupListener.contextInitialized(StartupListener.java:71)
... 13 more
Caused by: org.hibernate.exception.ConstraintViolationException: could not execute statement
at org.hibernate.exception.internal.SQLStateConversionDelegate.convert(SQLStateConversionDelegate.java:112)
at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:42)
at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:111)
at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:97)
at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:178)
at org.hibernate.engine.jdbc.batch.internal.NonBatchingBatch.addToBatch(NonBatchingBatch.java:45)
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:3013)
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:3513)
at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:89)
at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:589)
at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:463)
at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:337)
at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:39)
at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1437)
at org.hibernate.internal.SessionImpl.managedFlush(SessionImpl.java:493)
at org.hibernate.internal.SessionImpl.flushBeforeTransactionCompletion(SessionImpl.java:3207)
at org.hibernate.internal.SessionImpl.beforeTransactionCompletion(SessionImpl.java:2413)
at org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl.beforeTransactionCompletion(JdbcCoordinatorImpl.java:467)
at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.beforeCompletionCallback(JdbcResourceLocalTransactionCoordinatorImpl.java:156)
at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.access$100(JdbcResourceLocalTransactionCoordinatorImpl.java:38)
at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.commit(JdbcResourceLocalTransactionCoordinatorImpl.java:231)
at org.hibernate.engine.transaction.internal.TransactionImpl.commit(TransactionImpl.java:68)
at org.springframework.orm.hibernate5.HibernateTransactionManager.doCommit(HibernateTransactionManager.java:582)
... 24 more
Caused by: org.postgresql.util.PSQLException: ERROR: null value in column "configurable" violates not-null constraint
  详细：Failing row contains (87233650, yjyjwjKas1s, null, 2018-04-09 11:24:20.767, 2018-04-09 11:24:20.767, null, Scheduled program notifications, 0 0 5 * * ?, \xaced00057e7200206f72672e686973702e646869732e7363686564756c696e..., \xaced00057e7200226f72672e686973702e646869732e7363686564756c696e..., \xaced00057e7200226f72672e686973702e646869732e7363686564756c696e..., 2018-04-09 05:00:00.012, null, 2018-04-10 05:00:00, f, null, t, null).
at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2422)




--

此致

   林晓东

莫愁前路无知己，天下谁人不识君。
Follow ups

Re: update from dhis2 2.28 to 2.29 error
From: Henning Håkonsen, 2018-04-09