dhis2-devs team mailing list archive

Thread
Date
Datamart error

To: DHIS 2 developers <dhis2-devs@xxxxxxxxxxxxxxxxxxx>
From: Pramil Liyanage <pramilcl@xxxxxxxxx>
Date: Mon, 25 Apr 2016 19:09:59 +0530
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])
* ERROR 2016-04-25 18:40:07,718 Initialised statement manager
(StatementInterceptor.java [taskScheduler-1])
* ERROR 2016-04-25 18:40:08,232 Initialised statement manager
(StatementInterceptor.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,117 Crosstab table columns: 99, rows: 0
(DefaultCrossTabService.java [SimpleAsyncTaskExecutor-18])
* INFO  2016-04-25 18:41:27,118 Crosstab table columns: 99, rows: 0
(DefaultCrossTabService.java [SimpleAsyncTaskExecutor-21])
* INFO  2016-04-25 18:41:27,149 Crosstab table columns: 99, rows: 0
(DefaultCrossTabService.java [SimpleAsyncTaskExecutor-19])
* INFO  2016-04-25 18:41:27,166 Crosstab table columns: 99, rows: 0
(DefaultCrossTabService.java [SimpleAsyncTaskExecutor-20])
* 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
Follow ups

Re: Datamart error
From: Lars Helge Øverland, 2016-04-25