← Back to team overview

dhis2-devs team mailing list archive

  1. dhis2-devs team
  2. Mailing list archive
  3. Message #20781

[Bug 1110024] [NEW] datamart-completeness-process-SQL.-error

  Thread Previous • Date Previous • • Thread Next 
Public bug reported:

Version:
2.11-SNAPSHOT
Build revision:
9652

Dtamart process bombs during the dataset completeness phase.


 INFO  2013-01-30 15:48:45,588 Copied org unit indicator data from temporary table: 0:07:14.568 (Clock.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,589 [Level: INFO, category: DATAMART, time: Wed Jan 30 15:48:45 SBT 2013, message: Creating org unit indicator indexes] (InMemoryNotifier.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,686 Created org unit indicator index: 0:07:14.666 (Clock.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,687 Aggregated org unit data export done: 0:07:14.667 (Clock.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,833 Dropped crosstab table: 0:07:14.813 (Clock.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,833 Data mart export process completed: 0:07:14.813 (Clock.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,834 [Level: INFO, category: DATAMART, time: Wed Jan 30 15:48:45 SBT 2013, message: Data mart process completed] (InMemoryNotifier.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,841 Data completeness export process started, number of CPU cores: 4, Mem Total in JVM: 1386 Free in JVM: 330 Max Limit: 1820: 0:00:00.000 (Clock.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,841 [Level: INFO, category: DATAMART, time: Wed Jan 30 15:48:45 SBT 2013, message: Completeness export process started] (InMemoryNotifier.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,849 Dropped potential index: 0:00:00.009 (Clock.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,896 Deleted existing completeness data: 0:00:00.056 (Clock.java [taskScheduler-2])
* INFO  2013-01-30 15:48:45,897 [Level: INFO, category: DATAMART, time: Wed Jan 30 15:48:45 SBT 2013, message: Exporting completeness for data sets] (InMemoryNotifier.java [taskScheduler-2])
* ERROR 2013-01-30 15:48:46,207 Unexpected error occurred in scheduled task. (TaskUtils.java [taskScheduler-2])
java.lang.RuntimeException: Exception during execution
        at org.hisp.dhis.system.util.ConcurrentUtils.waitForCompletion(ConcurrentUtils.java:54)
        at org.hisp.dhis.completeness.engine.DefaultDataSetCompletenessEngine.exportDataSetCompleteness(DefaultDataSetCompletenessEngine.java:176)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:616)
        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
        at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:110)
        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
        at $Proxy144.exportDataSetCompleteness(Unknown Source)
        at org.hisp.dhis.system.scheduling.DataMartTask.run(DataMartTask.java:164)
        at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:53)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
        at java.util.concurrent.FutureTask.run(FutureTask.java:166)
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
        at java.lang.Thread.run(Thread.java:679)
Caused by: java.util.concurrent.ExecutionException: java.lang.RuntimeException: org.postgresql.util.PSQLException: ERROR: syntax error at or near ")"
  Position: 102
        at java.util.concurrent.FutureTask$Sync.innerGet(FutureTask.java:252)
        at java.util.concurrent.FutureTask.get(FutureTask.java:111)
        at org.hisp.dhis.system.util.ConcurrentUtils.waitForCompletion(ConcurrentUtils.java:50)
        ... 22 more
Caused by: java.lang.RuntimeException: org.postgresql.util.PSQLException: ERROR: syntax error at or near ")"
  Position: 102
        at org.amplecode.quick.statement.DefaultStatementHolder.queryForInteger(DefaultStatementHolder.java:116)
        at org.hisp.dhis.completeness.jdbc.JDBCDataSetCompletenessStore.getCompleteDataSetRegistrations(JDBCDataSetCompletenessStore.java:91)
        at org.hisp.dhis.completeness.impl.RegistrationDataSetCompletenessService.getRegistrations(RegistrationDataSetCompletenessService.java:44)
        at org.hisp.dhis.completeness.impl.AbstractDataSetCompletenessService.getDataSetCompleteness(AbstractDataSetCompletenessService.java:314)
        at org.hisp.dhis.completeness.impl.AbstractDataSetCompletenessService.exportDataSetCompleteness(AbstractDataSetCompletenessService.java:179)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:616)
        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
        at org.springframework.aop.aspectj.MethodInvocationProceedingJoinPoint.proceed(MethodInvocationProceedingJoinPoint.java:80)
        at org.amplecode.quick.StatementInterceptor.intercept(StatementInterceptor.java:71)
        at sun.reflect.GeneratedMethodAccessor902.invoke(Unknown Source)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:616)
        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:65)
        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
        at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:90)
        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
        at org.springframework.aop.interceptor.AsyncExecutionInterceptor$1.call(AsyncExecutionInterceptor.java:83)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
        at java.util.concurrent.FutureTask.run(FutureTask.java:166)
        ... 1 more
Caused by: org.postgresql.util.PSQLException: ERROR: syntax error at or near ")"
  Position: 102
        at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2103)
        at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1836)
        at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257)
        at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:512)
        at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:374)
        at org.postgresql.jdbc2.AbstractJdbc2Statement.executeQuery(AbstractJdbc2Statement.java:254)
        at org.amplecode.quick.statement.DefaultStatementHolder.queryForInteger(DefaultStatementHolder.java:108)
        ... 26 more

** Affects: dhis2
     Importance: Undecided
         Status: New

-- 
You received this bug notification because you are a member of DHIS 2
developers, which is subscribed to DHIS.
https://bugs.launchpad.net/bugs/1110024

Title:
  datamart-completeness-process-SQL.-error

Status in DHIS 2 - District Health Information Software:
  New

Bug description:
  Version:
  2.11-SNAPSHOT
  Build revision:
  9652

  Dtamart process bombs during the dataset completeness phase.

  
   INFO  2013-01-30 15:48:45,588 Copied org unit indicator data from temporary table: 0:07:14.568 (Clock.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,589 [Level: INFO, category: DATAMART, time: Wed Jan 30 15:48:45 SBT 2013, message: Creating org unit indicator indexes] (InMemoryNotifier.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,686 Created org unit indicator index: 0:07:14.666 (Clock.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,687 Aggregated org unit data export done: 0:07:14.667 (Clock.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,833 Dropped crosstab table: 0:07:14.813 (Clock.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,833 Data mart export process completed: 0:07:14.813 (Clock.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,834 [Level: INFO, category: DATAMART, time: Wed Jan 30 15:48:45 SBT 2013, message: Data mart process completed] (InMemoryNotifier.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,841 Data completeness export process started, number of CPU cores: 4, Mem Total in JVM: 1386 Free in JVM: 330 Max Limit: 1820: 0:00:00.000 (Clock.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,841 [Level: INFO, category: DATAMART, time: Wed Jan 30 15:48:45 SBT 2013, message: Completeness export process started] (InMemoryNotifier.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,849 Dropped potential index: 0:00:00.009 (Clock.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,896 Deleted existing completeness data: 0:00:00.056 (Clock.java [taskScheduler-2])
  * INFO  2013-01-30 15:48:45,897 [Level: INFO, category: DATAMART, time: Wed Jan 30 15:48:45 SBT 2013, message: Exporting completeness for data sets] (InMemoryNotifier.java [taskScheduler-2])
  * ERROR 2013-01-30 15:48:46,207 Unexpected error occurred in scheduled task. (TaskUtils.java [taskScheduler-2])
  java.lang.RuntimeException: Exception during execution
          at org.hisp.dhis.system.util.ConcurrentUtils.waitForCompletion(ConcurrentUtils.java:54)
          at org.hisp.dhis.completeness.engine.DefaultDataSetCompletenessEngine.exportDataSetCompleteness(DefaultDataSetCompletenessEngine.java:176)
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
          at java.lang.reflect.Method.invoke(Method.java:616)
          at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
          at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:110)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
          at $Proxy144.exportDataSetCompleteness(Unknown Source)
          at org.hisp.dhis.system.scheduling.DataMartTask.run(DataMartTask.java:164)
          at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:53)
          at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
          at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
          at java.util.concurrent.FutureTask.run(FutureTask.java:166)
          at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
          at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
          at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
          at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
          at java.lang.Thread.run(Thread.java:679)
  Caused by: java.util.concurrent.ExecutionException: java.lang.RuntimeException: org.postgresql.util.PSQLException: ERROR: syntax error at or near ")"
    Position: 102
          at java.util.concurrent.FutureTask$Sync.innerGet(FutureTask.java:252)
          at java.util.concurrent.FutureTask.get(FutureTask.java:111)
          at org.hisp.dhis.system.util.ConcurrentUtils.waitForCompletion(ConcurrentUtils.java:50)
          ... 22 more
  Caused by: java.lang.RuntimeException: org.postgresql.util.PSQLException: ERROR: syntax error at or near ")"
    Position: 102
          at org.amplecode.quick.statement.DefaultStatementHolder.queryForInteger(DefaultStatementHolder.java:116)
          at org.hisp.dhis.completeness.jdbc.JDBCDataSetCompletenessStore.getCompleteDataSetRegistrations(JDBCDataSetCompletenessStore.java:91)
          at org.hisp.dhis.completeness.impl.RegistrationDataSetCompletenessService.getRegistrations(RegistrationDataSetCompletenessService.java:44)
          at org.hisp.dhis.completeness.impl.AbstractDataSetCompletenessService.getDataSetCompleteness(AbstractDataSetCompletenessService.java:314)
          at org.hisp.dhis.completeness.impl.AbstractDataSetCompletenessService.exportDataSetCompleteness(AbstractDataSetCompletenessService.java:179)
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
          at java.lang.reflect.Method.invoke(Method.java:616)
          at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
          at org.springframework.aop.aspectj.MethodInvocationProceedingJoinPoint.proceed(MethodInvocationProceedingJoinPoint.java:80)
          at org.amplecode.quick.StatementInterceptor.intercept(StatementInterceptor.java:71)
          at sun.reflect.GeneratedMethodAccessor902.invoke(Unknown Source)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
          at java.lang.reflect.Method.invoke(Method.java:616)
          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:65)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
          at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:90)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
          at org.springframework.aop.interceptor.AsyncExecutionInterceptor$1.call(AsyncExecutionInterceptor.java:83)
          at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
          at java.util.concurrent.FutureTask.run(FutureTask.java:166)
          ... 1 more
  Caused by: org.postgresql.util.PSQLException: ERROR: syntax error at or near ")"
    Position: 102
          at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2103)
          at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1836)
          at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257)
          at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:512)
          at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:374)
          at org.postgresql.jdbc2.AbstractJdbc2Statement.executeQuery(AbstractJdbc2Statement.java:254)
          at org.amplecode.quick.statement.DefaultStatementHolder.queryForInteger(DefaultStatementHolder.java:108)
          ... 26 more

To manage notifications about this bug go to:
https://bugs.launchpad.net/dhis2/+bug/1110024/+subscriptions

Follow ups

References

  Thread Previous • Date Previous • • Thread Next