I am getting this error when trying to run the datamart in 2.19. (Database postgres)
2016-04-25 13:11:27Process failed: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
2016-04-25 13:11:26
Populating crosstabulation table
What could be the reason? The second part of the object is a category option combo. Below is the log.
Regards
Pramil
INFO 2016-04-25 18:40:07,553 Using periods: [[Quarterly: Fri Apr 01 00:00:00 IST 2016 - Thu Jun 30 00:00:00 IST 2016]] (DataMartTask.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,351 Data mart export process started, number of CPU cores: 4, Mem Total in JVM: 4959 Free in JVM: 3514 Max Limit: 6667: 00:00:00.000 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,351 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:08 IST 2016, message: Data mart export process started] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,440 Recreated temporary tables: 00:00:00.089 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,441 Data elements: 89, indicators: 182, periods: 1, org units: 453: 00:00:00.090 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,552 Retrieved meta-data objects, using periods: [[Quarterly: 2016-04-01 - 2016-06-30]]: 00:00:00.201 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,552 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:08 IST 2016, message: Filtering meta-data] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,798 Filtered objects: 00:00:35.447 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,860 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:43 IST 2016, message: Loading indicators] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,947 Exploded indicator expressions: 00:00:35.596 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,947 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:43 IST 2016, message: Loading data elements] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,111 Retrieved operands: 1002: 00:01:15.760 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,299 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:24 IST 2016, message: Loading periods] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,904 Number of periods: 1: 00:01:16.553 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,905 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:24 IST 2016, message: Filtering data elements without data] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:26,062 Number of operands with data: 97, Mem Total in JVM: 4944 Free in JVM: 3350 Max Limit: 6667: 00:01:17.711 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:26,062 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:26 IST 2016, message: Populating crosstabulation table] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,166 Populated crosstab table, Mem Total in JVM: 4944 Free in JVM: 3333 Max Limit: 6667: 00:01:18.815 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,284 [Level: ERROR, category: DATAMART, time: Mon Apr 25 18:41:27 IST 2016, message: Process failed: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,716 SMSLib: A Java API library for sending and receiving SMS via a GSM modem or other supported gateways.
This software is distributed under the terms of the Apache v2.0 License.
Web Site: http://smslib.org (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 Version: 3.5.3 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 JRE Version: 1.8.0_77 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 JRE Impl Version: 25.77-b03 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 O/S: Linux / amd64 / 3.13.0-85-generic (Service.java [taskScheduler-1])
ERROR 2016-04-25 18:41:27,956 Unexpected error occurred in scheduled task. (TaskUtils.java [taskScheduler-1])
java.lang.RuntimeException: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:96)
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:80)
at org.hisp.dhis.datamart.crosstab.jdbc.JDBCCrossTabStore.createAggregatedDataCache(JDBCCrossTabStore.java:106)
at org.hisp.dhis.datamart.crosstab.DefaultCrossTabService.createAggregatedDataCache(DefaultCrossTabService.java:196)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:201)
at com.sun.proxy.$Proxy119.createAggregatedDataCache(Unknown Source)
at org.hisp.dhis.datamart.engine.DefaultDataMartEngine.export(DefaultDataMartEngine.java:343)
at org.hisp.dhis.datamart.engine.DefaultDataMartEngine.export(DefaultDataMartEngine.java:205)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157)
at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:99)
at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:281)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.aspectj.MethodInvocationProceedingJoinPoint.proceed(MethodInvocationProceedingJoinPoint.java:85)
at org.amplecode.quick.StatementInterceptor.intercept(StatementInterceptor.java:71)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.aspectj.AbstractAspectJAdvice.invokeAdviceMethodWithGivenArgs(AbstractAspectJAdvice.java:621)
at org.springframework.aop.aspectj.AbstractAspectJAdvice.invokeAdviceMethod(AbstractAspectJAdvice.java:610)
at org.springframework.aop.aspectj.AspectJAroundAdvice.invoke(AspectJAroundAdvice.java:68)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207)
at com.sun.proxy.$Proxy122.export(Unknown Source)
at org.hisp.dhis.scheduling.DataMartTask.run(DataMartTask.java:112)
at org.hisp.dhis.scheduling.ScheduledTasks.run(ScheduledTasks.java:60)
at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
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: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)
at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)
at org.hsqldb.jdbc.JDBCStatement.fetchResult(Unknown Source)
at org.hsqldb.jdbc.JDBCStatement.executeUpdate(Unknown Source)
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:87)
… 47 more
Caused by: org.hsqldb.HsqlException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.hsqldb.error.Error.error(Unknown Source)
at org.hsqldb.error.Error.error(Unknown Source)
at org.hsqldb.Table.addColumn(Unknown Source)
at org.hsqldb.ParserDDL.compileCreateTableBody(Unknown Source)
at org.hsqldb.ParserDDL.compileCreateTable(Unknown Source)
at org.hsqldb.ParserDDL.compileCreate(Unknown Source)
at org.hsqldb.ParserCommand.compilePart(Unknown Source)
at org.hsqldb.ParserCommand.compileStatements(Unknown Source)
at org.hsqldb.Session.executeDirectStatement(Unknown Source)
at org.hsqldb.Session.execute(Unknown Source)
… 50 more
do you think you could upgrade your instance to a recent DHIS 2 version? That way it is easier for us to help you. We usually support the three last releases.
On Mon, Apr 25, 2016 at 3:39 PM, Pramil Liyanage pramilcl@gmail.com wrote:
Hi all,
I am getting this error when trying to run the datamart in 2.19. (Database postgres)
2016-04-25 13:11:27Process failed: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
2016-04-25 13:11:26
Populating crosstabulation table
What could be the reason? The second part of the object is a category option combo. Below is the log.
Regards
Pramil
INFO 2016-04-25 18:40:07,553 Using periods: [[Quarterly: Fri Apr 01 00:00:00 IST 2016 - Thu Jun 30 00:00:00 IST 2016]] (DataMartTask.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,351 Data mart export process started, number of CPU cores: 4, Mem Total in JVM: 4959 Free in JVM: 3514 Max Limit: 6667: 00:00:00.000 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,351 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:08 IST 2016, message: Data mart export process started] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,440 Recreated temporary tables: 00:00:00.089 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,441 Data elements: 89, indicators: 182, periods: 1, org units: 453: 00:00:00.090 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,552 Retrieved meta-data objects, using periods: [[Quarterly: 2016-04-01 - 2016-06-30]]: 00:00:00.201 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,552 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:08 IST 2016, message: Filtering meta-data] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,798 Filtered objects: 00:00:35.447 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,860 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:43 IST 2016, message: Loading indicators] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,947 Exploded indicator expressions: 00:00:35.596 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,947 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:43 IST 2016, message: Loading data elements] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,111 Retrieved operands: 1002: 00:01:15.760 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,299 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:24 IST 2016, message: Loading periods] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,904 Number of periods: 1: 00:01:16.553 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,905 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:24 IST 2016, message: Filtering data elements without data] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:26,062 Number of operands with data: 97, Mem Total in JVM: 4944 Free in JVM: 3350 Max Limit: 6667: 00:01:17.711 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:26,062 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:26 IST 2016, message: Populating crosstabulation table] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,166 Populated crosstab table, Mem Total in JVM: 4944 Free in JVM: 3333 Max Limit: 6667: 00:01:18.815 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,284 [Level: ERROR, category: DATAMART, time: Mon Apr 25 18:41:27 IST 2016, message: Process failed: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,716 SMSLib: A Java API library for sending and receiving SMS via a GSM modem or other supported gateways.
This software is distributed under the terms of the Apache v2.0 License.
Web Site: http://smslib.org (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 Version: 3.5.3 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 JRE Version: 1.8.0_77 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 JRE Impl Version: 25.77-b03 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 O/S: Linux / amd64 / 3.13.0-85-generic (Service.java [taskScheduler-1])
ERROR 2016-04-25 18:41:27,956 Unexpected error occurred in scheduled task. (TaskUtils.java [taskScheduler-1])
java.lang.RuntimeException: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:96)
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:80)
at org.hisp.dhis.datamart.crosstab.jdbc.JDBCCrossTabStore.createAggregatedDataCache(JDBCCrossTabStore.java:106)
at org.hisp.dhis.datamart.crosstab.DefaultCrossTabService.createAggregatedDataCache(DefaultCrossTabService.java:196)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:201)
at com.sun.proxy.$Proxy119.createAggregatedDataCache(Unknown Source)
at org.hisp.dhis.datamart.engine.DefaultDataMartEngine.export(DefaultDataMartEngine.java:343)
at org.hisp.dhis.datamart.engine.DefaultDataMartEngine.export(DefaultDataMartEngine.java:205)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157)
at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:99)
at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:281)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.aspectj.MethodInvocationProceedingJoinPoint.proceed(MethodInvocationProceedingJoinPoint.java:85)
at org.amplecode.quick.StatementInterceptor.intercept(StatementInterceptor.java:71)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.aspectj.AbstractAspectJAdvice.invokeAdviceMethodWithGivenArgs(AbstractAspectJAdvice.java:621)
at org.springframework.aop.aspectj.AbstractAspectJAdvice.invokeAdviceMethod(AbstractAspectJAdvice.java:610)
at org.springframework.aop.aspectj.AspectJAroundAdvice.invoke(AspectJAroundAdvice.java:68)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207)
at com.sun.proxy.$Proxy122.export(Unknown Source)
at org.hisp.dhis.scheduling.DataMartTask.run(DataMartTask.java:112)
at org.hisp.dhis.scheduling.ScheduledTasks.run(ScheduledTasks.java:60)
at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
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: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)
at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)
at org.hsqldb.jdbc.JDBCStatement.fetchResult(Unknown Source)
at org.hsqldb.jdbc.JDBCStatement.executeUpdate(Unknown Source)
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:87)
… 47 more
Caused by: org.hsqldb.HsqlException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.hsqldb.error.Error.error(Unknown Source)
at org.hsqldb.error.Error.error(Unknown Source)
at org.hsqldb.Table.addColumn(Unknown Source)
at org.hsqldb.ParserDDL.compileCreateTableBody(Unknown Source)
at org.hsqldb.ParserDDL.compileCreateTable(Unknown Source)
at org.hsqldb.ParserDDL.compileCreate(Unknown Source)
at org.hsqldb.ParserCommand.compilePart(Unknown Source)
at org.hsqldb.ParserCommand.compileStatements(Unknown Source)
at org.hsqldb.Session.executeDirectStatement(Unknown Source)
at org.hsqldb.Session.execute(Unknown Source)
… 50 more
I upgraded to 2.22. But the issue after that was data not showing in the dataset reports and pivot tables. Analytics complete since there is no datamart so I thought this is the issue.
···
On Mon, Apr 25, 2016 at 7:19 PM, Lars Helge Øverland lars@dhis2.org wrote:
Hi Pramil,
do you think you could upgrade your instance to a recent DHIS 2 version? That way it is easier for us to help you. We usually support the three last releases.
On Mon, Apr 25, 2016 at 3:39 PM, Pramil Liyanage pramilcl@gmail.com wrote:
Hi all,
I am getting this error when trying to run the datamart in 2.19. (Database postgres)
2016-04-25 13:11:27Process failed: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
2016-04-25 13:11:26
Populating crosstabulation table
What could be the reason? The second part of the object is a category option combo. Below is the log.
Regards
Pramil
INFO 2016-04-25 18:40:07,553 Using periods: [[Quarterly: Fri Apr 01 00:00:00 IST 2016 - Thu Jun 30 00:00:00 IST 2016]] (DataMartTask.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,351 Data mart export process started, number of CPU cores: 4, Mem Total in JVM: 4959 Free in JVM: 3514 Max Limit: 6667: 00:00:00.000 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,351 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:08 IST 2016, message: Data mart export process started] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,440 Recreated temporary tables: 00:00:00.089 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,441 Data elements: 89, indicators: 182, periods: 1, org units: 453: 00:00:00.090 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,552 Retrieved meta-data objects, using periods: [[Quarterly: 2016-04-01 - 2016-06-30]]: 00:00:00.201 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:08,552 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:08 IST 2016, message: Filtering meta-data] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,798 Filtered objects: 00:00:35.447 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,860 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:43 IST 2016, message: Loading indicators] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,947 Exploded indicator expressions: 00:00:35.596 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:40:43,947 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:40:43 IST 2016, message: Loading data elements] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,111 Retrieved operands: 1002: 00:01:15.760 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,299 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:24 IST 2016, message: Loading periods] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,904 Number of periods: 1: 00:01:16.553 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:24,905 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:24 IST 2016, message: Filtering data elements without data] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:26,062 Number of operands with data: 97, Mem Total in JVM: 4944 Free in JVM: 3350 Max Limit: 6667: 00:01:17.711 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:26,062 [Level: INFO, category: DATAMART, time: Mon Apr 25 18:41:26 IST 2016, message: Populating crosstabulation table] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,166 Populated crosstab table, Mem Total in JVM: 4944 Free in JVM: 3333 Max Limit: 6667: 00:01:18.815 (Clock.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,284 [Level: ERROR, category: DATAMART, time: Mon Apr 25 18:41:27 IST 2016, message: Process failed: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR] (InMemoryNotifier.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,716 SMSLib: A Java API library for sending and receiving SMS via a GSM modem or other supported gateways.
This software is distributed under the terms of the Apache v2.0 License.
Web Site: http://smslib.org (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 Version: 3.5.3 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 JRE Version: 1.8.0_77 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 JRE Impl Version: 25.77-b03 (Service.java [taskScheduler-1])
INFO 2016-04-25 18:41:27,717 O/S: Linux / amd64 / 3.13.0-85-generic (Service.java [taskScheduler-1])
ERROR 2016-04-25 18:41:27,956 Unexpected error occurred in scheduled task. (TaskUtils.java [taskScheduler-1])
java.lang.RuntimeException: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:96)
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:80)
at org.hisp.dhis.datamart.crosstab.jdbc.JDBCCrossTabStore.createAggregatedDataCache(JDBCCrossTabStore.java:106)
at org.hisp.dhis.datamart.crosstab.DefaultCrossTabService.createAggregatedDataCache(DefaultCrossTabService.java:196)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:201)
at com.sun.proxy.$Proxy119.createAggregatedDataCache(Unknown Source)
at org.hisp.dhis.datamart.engine.DefaultDataMartEngine.export(DefaultDataMartEngine.java:343)
at org.hisp.dhis.datamart.engine.DefaultDataMartEngine.export(DefaultDataMartEngine.java:205)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157)
at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:99)
at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:281)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.aspectj.MethodInvocationProceedingJoinPoint.proceed(MethodInvocationProceedingJoinPoint.java:85)
at org.amplecode.quick.StatementInterceptor.intercept(StatementInterceptor.java:71)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.aop.aspectj.AbstractAspectJAdvice.invokeAdviceMethodWithGivenArgs(AbstractAspectJAdvice.java:621)
at org.springframework.aop.aspectj.AbstractAspectJAdvice.invokeAdviceMethod(AbstractAspectJAdvice.java:610)
at org.springframework.aop.aspectj.AspectJAroundAdvice.invoke(AspectJAroundAdvice.java:68)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207)
at com.sun.proxy.$Proxy122.export(Unknown Source)
at org.hisp.dhis.scheduling.DataMartTask.run(DataMartTask.java:112)
at org.hisp.dhis.scheduling.ScheduledTasks.run(ScheduledTasks.java:60)
at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
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: java.sql.SQLSyntaxErrorException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)
at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)
at org.hsqldb.jdbc.JDBCStatement.fetchResult(Unknown Source)
at org.hsqldb.jdbc.JDBCStatement.executeUpdate(Unknown Source)
at org.amplecode.quick.statement.DefaultStatementHolder.executeUpdate(DefaultStatementHolder.java:87)
… 47 more
Caused by: org.hsqldb.HsqlException: object name already exists: DEYVNZPZ39W2Y_P79KWQPTZRR
at org.hsqldb.error.Error.error(Unknown Source)
at org.hsqldb.error.Error.error(Unknown Source)
at org.hsqldb.Table.addColumn(Unknown Source)
at org.hsqldb.ParserDDL.compileCreateTableBody(Unknown Source)
at org.hsqldb.ParserDDL.compileCreateTable(Unknown Source)
at org.hsqldb.ParserDDL.compileCreate(Unknown Source)
at org.hsqldb.ParserCommand.compilePart(Unknown Source)
at org.hsqldb.ParserCommand.compileStatements(Unknown Source)
at org.hsqldb.Session.executeDirectStatement(Unknown Source)
at org.hsqldb.Session.execute(Unknown Source)
… 50 more
Thanks for the reply. Same issue is there in 2.20 also. When upgraded to 2.22 there are no errors in the analytic table update, but data entered in the dataset is not available in reports. Log also attached.
On Mon, Apr 25, 2016 at 7:53 PM, Pramil Liyanage pramilcl@gmail.com wrote:
Hi Lars,
Thanks for the reply. Same issue is there in 2.20 also. When upgraded to 2.22 there are no errors in the analytic table update, but data entered in the dataset is not available in reports. Log also attached.