dhis2-devs team mailing list archive

Thread
Date
Re: Errors with latest version

To: dhis2-devs <dhis2-devs@xxxxxxxxxxxxxxxxxxx>
From: Jason Pickering <jason.p.pickering@xxxxxxxxx>
Date: Mon, 3 May 2010 12:44:49 +0200
In-reply-to: <g2z244b6a541005030244h640c9086l1caf44dff7c9290a@mail.gmail.com>
Duh, sorry for this. My own mistake, but at least it is documented now..

I was missing

hibernate.hbm2ddl.auto = update

in the hibernate.properties file.

Since this seems to be required, it might be a good idea to be sure it
is there before the app attempts to fire itself up!

Regards,
Jason


On Mon, May 3, 2010 at 11:44 AM, Jason Pickering
<jason.p.pickering@xxxxxxxxx> wrote:
> Hi there. I am having some issues with the latest version. Sorry for
> the lengthy mail, but I have copied and pasted a bunch of log files.
>
> I am using Postgres, Java 1.6.19, Tomcat 6.0.24 on Ubuntu.
>
> During startup on a clean DB, only these are the tables that are created.
>
> dhis2_tj=# \dt
>                     List of relations
>  Schema |             Name              | Type  |  Owner
> --------+-------------------------------+-------+----------
>  public | aggregateddatasetcompleteness | table | postgres
>  public | aggregateddatavalue           | table | postgres
>  public | aggregatedindicatorvalue      | table | postgres
>  public | categoryoptioncombo           | table | postgres
>  public | dataelement                   | table | postgres
>  public | datavaluearchive              | table | postgres
>  public | period                        | table | postgres
>  public | source                        | table | postgres
> (8 rows)
>
> DHIS2 appears to start correctly the application, I get this..
>
> May 3, 2010 10:48:05 AM org.apache.catalina.startup.HostConfig deployDirectory
> INFO: Deploying web application directory ROOT
> May 3, 2010 10:48:05 AM org.apache.catalina.startup.HostConfig deployDirectory
> INFO: Deploying web application directory docs
> May 3, 2010 10:48:05 AM org.apache.coyote.http11.Http11AprProtocol start
> INFO: Starting Coyote HTTP/1.1 on http-8080
> May 3, 2010 10:48:05 AM org.apache.coyote.ajp.AjpAprProtocol start
> INFO: Starting Coyote AJP/1.3 on ajp-8009
> May 3, 2010 10:48:05 AM org.apache.catalina.startup.Catalina start
> INFO: Server startup in 36108 ms
> May 3, 2010 11:35:12 AM org.apache.catalina.core.AprLifecycleListener init
> INFO: Loaded APR based Apache Tomcat Native library 1.1.20.
> May 3, 2010 11:35:12 AM org.apache.catalina.core.AprLifecycleListener init
> INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters
> [false], random [true].
> May 3, 2010 11:35:12 AM org.apache.catalina.core.AprLifecycleListener
> lifecycleEvent
> INFO: Failed to initialize the SSLEngine.
> May 3, 2010 11:35:12 AM org.apache.coyote.http11.Http11AprProtocol init
> INFO: Initializing Coyote HTTP/1.1 on http-8080
> May 3, 2010 11:35:12 AM org.apache.coyote.ajp.AjpAprProtocol init
> INFO: Initializing Coyote AJP/1.3 on ajp-8009
> May 3, 2010 11:35:12 AM org.apache.catalina.startup.Catalina load
> INFO: Initialization processed in 2020 ms
> May 3, 2010 11:35:13 AM org.apache.catalina.core.StandardService start
> INFO: Starting service Catalina
> May 3, 2010 11:35:13 AM org.apache.catalina.core.StandardEngine start
> INFO: Starting Servlet Engine: Apache Tomcat/6.0.26
> May 3, 2010 11:35:13 AM org.apache.catalina.startup.HostConfig deployDescriptor
> INFO: Deploying configuration descriptor manager.xml
> May 3, 2010 11:35:13 AM org.apache.catalina.startup.HostConfig deployDescriptor
> INFO: Deploying configuration descriptor host-manager.xml
> May 3, 2010 11:35:14 AM org.apache.catalina.startup.HostConfig deployWAR
> INFO: Deploying web application archive dhis.war
> May 3, 2010 11:35:17 AM org.apache.catalina.loader.WebappClassLoader
> validateJarFile
> INFO: validateJarFile(/usr/local/apache-tomcat-6.0.26/webapps/dhis/WEB-INF/lib/servlet-api-2.4.jar)
> - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending
> class: javax/servlet/Servlet.class
> log4j:WARN No such property [maxFileSize] in
> org.apache.log4j.DailyRollingFileAppender.
> log4j:WARN No such property [maxBackupIndex] in
> org.apache.log4j.DailyRollingFileAppender.
> * INFO  11:35:25,504 System property dhis2.home not set
> (DefaultLocationManager.java [main])
> * INFO  11:35:25,523 Environment variable DHIS2_HOME points to
> /usr/local/apache-tomcat-6.0.26/conf/dhis2/
> (DefaultLocationManager.java [main])
> * INFO  11:35:45,159 Executing startup routine [1 of 13, runlevel 0]:
> DataSetShortNamePopulator (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:45,383 Populated DataSet short name and code
> (DataSetShortNamePopulator.java [main])
> * INFO  11:35:45,384 Executing startup routine [2 of 13, runlevel 0]:
> UuidPopulator (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:45,392 Checked CategoryOption uuids (UuidPopulator.java [main])
> * INFO  11:35:45,400 Checked Category uuids (UuidPopulator.java [main])
> * INFO  11:35:45,413 Checked DataElement uuids (UuidPopulator.java [main])
> * INFO  11:35:45,413 Executing startup routine [3 of 13, runlevel 0]:
> OrganisationUnitHierarchyVerifier (DefaultStartupRoutineExecutor.java
> [main])
> * WARN  11:35:45,729 firstResult/maxResults specified with collection
> fetch; applying in memory! (QueryTranslatorImpl.java [main])
> * INFO  11:35:45,821 Added organistion unit hierarchy
> (OrganisationUnitHierarchyVerifier.java [main])
> * INFO  11:35:45,821 Executing startup routine [4 of 13, runlevel 0]:
> OrganisationUnitGroupSetPopulator (DefaultStartupRoutineExecutor.java
> [main])
> * INFO  11:35:45,841 Executing startup routine [5 of 13, runlevel 0]:
> OpenHealthDataSourceWriter (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:45,841 Environment variable OPENHEALTH_HOME not set
> (OpenHealthDataSourceWriter.java [main])
> * INFO  11:35:45,842 Executing startup routine [6 of 13, runlevel 0]:
> ReportTableUpgrader (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:45,845 Upgraded report tables (ReportTableUpgrader.java [main])
> * INFO  11:35:45,846 Executing startup routine [7 of 13, runlevel 1]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:46,183 Updated Category sort order and primary keys
> (OptionsCategoriesDefaultSortOrderPopulator.java [main])
> * INFO  11:35:46,184 Executing startup routine [8 of 13, runlevel 1]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:46,202 Executing startup routine [9 of 13, runlevel 1]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:46,203 Removing datasetid column from dataentryform
> table (DataEntryFormPopulator.java [main])
> * INFO  11:35:46,346 Executing startup routine [10 of 13, runlevel 2]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:46,383 Added default dataelement dimension
> (DataElementDefaultDimensionPopulator.java [main])
> * INFO  11:35:46,407 Executing startup routine [11 of 13, runlevel 2]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:46,434 Executing startup routine [12 of 13, runlevel 3]:
> TableCreator (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:46,438 Created table aggregateddatavalue
> (TableCreator.java [main])
> * INFO  11:35:46,441 Created table aggregatedindicatorvalue
> (TableCreator.java [main])
> * INFO  11:35:46,457 Created index crosstab on table datavalue
> (TableCreator.java [main])
> * INFO  11:35:46,460 Created table aggregateddatasetcompleteness
> (TableCreator.java [main])
> * INFO  11:35:46,473 Created table aggregateddatasetcompleteness
> (TableCreator.java [main])
> * INFO  11:35:46,473 Executing startup routine [13 of 13, runlevel
> 10]: I18nUpgrader (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:35:46,508 I18n Upgrader running using locale English
> (United Kingdom) (I18nUpgrader.java [main])
> * INFO  11:35:46,527 I18n Upgrader: OrganisationUnitGroupSet (2)
> (I18nUpgrader.java [main])
> * INFO  11:35:46,534 I81n Upgrader: DataElementCategory (1)
> (I18nUpgrader.java [main])
> * INFO  11:35:46,537 I81n Upgrader: DataElementCategoryOption (1)
> (I18nUpgrader.java [main])
> * INFO  11:35:46,540 I81n Upgrader: DataElementCategoryCombo (1)
> (I18nUpgrader.java [main])
> * INFO  11:35:46,541 All startup routines done
> (DefaultStartupRoutineExecutor.java [main])
> May 3, 2010 11:35:49 AM org.apache.catalina.startup.HostConfig deployDirectory
> INFO: Deploying web application directory examples
> May 3, 2010 11:35:49 AM org.apache.catalina.startup.HostConfig deployDirectory
> INFO: Deploying web application directory ROOT
> May 3, 2010 11:35:49 AM org.apache.catalina.startup.HostConfig deployDirectory
> INFO: Deploying web application directory docs
> May 3, 2010 11:35:49 AM org.apache.coyote.http11.Http11AprProtocol start
> INFO: Starting Coyote HTTP/1.1 on http-8080
> May 3, 2010 11:35:49 AM org.apache.coyote.ajp.AjpAprProtocol start
> INFO: Starting Coyote AJP/1.3 on ajp-8009
> May 3, 2010 11:35:49 AM org.apache.catalina.startup.Catalina start
> INFO: Server startup in 36984 ms
> * AUDIT_TRAIL 11:36:11,757 User  "null" added User "admin admin"
> (HibernateUserStore.java [http-8080-1])
> * INFO  11:36:17,940 User login success: 'admin'
> (DefaultUserAuditService.java [http-8080-1])
> * INFO  11:36:21,364 User logout: 'admin'
> (DefaultUserAuditService.java [http-8080-2])
>
> I was able to login, which seems very strange, as there is no user
> table. But when I logout I see this..
>
> INFO: Stopping service Catalina
> May 3, 2010 11:36:31 AM org.apache.catalina.loader.WebappClassLoader
> clearReferencesJdbc
> SEVERE: A web application registered the JBDC driver [org.h2.Driver]
> but failed to unregister it when the web application was stopped. To
> prevent a memory leak, the JDBC Driver has been forcibly unregistered.
> May 3, 2010 11:36:31 AM org.apache.catalina.loader.WebappClassLoader
> clearReferencesJdbc
> SEVERE: A web application registered the JBDC driver
> [com.mysql.jdbc.Driver] but failed to unregister it when the web
> application was stopped. To prevent a memory leak, the JDBC Driver has
> been forcibly unregistered.
> May 3, 2010 11:36:31 AM org.apache.catalina.loader.WebappClassLoader
> clearReferencesJdbc
> SEVERE: A web application registered the JBDC driver
> [org.postgresql.Driver] but failed to unregister it when the web
> application was stopped. To prevent a memory leak, the JDBC Driver has
> been forcibly unregistered.
> May 3, 2010 11:36:31 AM org.apache.catalina.loader.WebappClassLoader
> clearThreadLocalMap
> SEVERE: A web application created a ThreadLocal with key of type
> [null] (value [com.opensymphony.xwork2.inject.ContainerImpl$10@ffeba4])
> and a value of type [java.lang.Object[]] (value
> [[Ljava.lang.Object;@1c78066]) but failed to remove it when the web
> application was stopped. To prevent a memory leak, the ThreadLocal has
> been forcibly removed.
> May 3, 2010 11:36:31 AM org.apache.catalina.loader.WebappClassLoader
> clearThreadLocalMap
> SEVERE: A web application created a ThreadLocal with key of type
> [null] (value [com.opensymphony.xwork2.inject.ContainerImpl$10@becf68])
> and a value of type [java.lang.Object[]] (value
> [[Ljava.lang.Object;@122c082]) but failed to remove it when the web
> application was stopped. To prevent a memory leak, the ThreadLocal has
> been forcibly removed.
> May 3, 2010 11:36:31 AM org.apache.catalina.loader.WebappClassLoader
> clearThreadLocalMap
> SEVERE: A web application created a ThreadLocal with key of type
> [null] (value [com.opensymphony.xwork2.inject.ContainerImpl$10@becf68])
> and a value of type [java.lang.Object[]] (value
> [[Ljava.lang.Object;@1fd8905]) but failed to remove it when the web
> application was stopped. To prevent a memory leak, the ThreadLocal has
> been forcibly removed.
> No protocol specified
>
>
>
> Finally, when I try and start the application again, I get this..
>
> ction 9.7.2. Offending class: javax/servlet/Servlet.class
> log4j:WARN No such property [maxFileSize] in
> org.apache.log4j.DailyRollingFileAppender.
> log4j:WARN No such property [maxBackupIndex] in
> org.apache.log4j.DailyRollingFileAppender.
> * INFO  11:41:47,577 System property dhis2.home not set
> (DefaultLocationManager.java [main])
> * INFO  11:41:47,582 Environment variable DHIS2_HOME points to
> /usr/local/apache-tomcat-6.0.26/conf/dhis2/
> (DefaultLocationManager.java [main])
> * ERROR 11:41:56,075 Unsuccessful: create table categoryoptioncombo
> (categoryoptioncomboid int4 not null, primary key
> (categoryoptioncomboid)) (SchemaExport.java [main])
> * ERROR 11:41:56,076 ERROR: relation "categoryoptioncombo" already
> exists (SchemaExport.java [main])
> * ERROR 11:41:56,277 Unsuccessful: create table dataelement
> (dataelementid int4 not null, uuid varchar(40), name varchar(230) not
> null unique, alternativename varchar(230) unique, shortname
> varchar(25) not null unique, code varchar(100), description text,
> active bool, valuetype varchar(16) not null, domaintype varchar(16),
> aggregationtype varchar(16) not null, extendeddataelementid int4
> unique, categorycomboid int4, sortOrder int4, url varchar(255),
> lastUpdated timestamp, zeroIsSignificant bool, primary key
> (dataelementid)) (SchemaExport.java [main])
> * ERROR 11:41:56,279 ERROR: relation "dataelement" already exists
> (SchemaExport.java [main])
> * ERROR 11:41:57,400 Unsuccessful: create table period (periodid int4
> not null, periodtypeid int4, startdate date not null, enddate date not
> null, primary key (periodid), unique (periodtypeid, startdate,
> enddate)) (SchemaExport.java [main])
> * ERROR 11:41:57,402 ERROR: relation "period" already exists
> (SchemaExport.java [main])
> * ERROR 11:41:57,877 Unsuccessful: create table source (sourceid int4
> not null, primary key (sourceid)) (SchemaExport.java [main])
> * ERROR 11:41:57,879 ERROR: relation "source" already exists
> (SchemaExport.java [main])
> * INFO  11:42:08,405 Executing startup routine [1 of 13, runlevel 0]:
> DataSetShortNamePopulator (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:42:08,572 Populated DataSet short name and code
> (DataSetShortNamePopulator.java [main])
> * INFO  11:42:08,572 Executing startup routine [2 of 13, runlevel 0]:
> UuidPopulator (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:42:08,581 Checked CategoryOption uuids (UuidPopulator.java [main])
> * INFO  11:42:08,591 Checked Category uuids (UuidPopulator.java [main])
> * INFO  11:42:08,604 Checked DataElement uuids (UuidPopulator.java [main])
> * INFO  11:42:08,604 Executing startup routine [3 of 13, runlevel 0]:
> OrganisationUnitHierarchyVerifier (DefaultStartupRoutineExecutor.java
> [main])
> * WARN  11:42:08,901 firstResult/maxResults specified with collection
> fetch; applying in memory! (QueryTranslatorImpl.java [main])
> * INFO  11:42:08,975 Added organistion unit hierarchy
> (OrganisationUnitHierarchyVerifier.java [main])
> * INFO  11:42:08,975 Executing startup routine [4 of 13, runlevel 0]:
> OrganisationUnitGroupSetPopulator (DefaultStartupRoutineExecutor.java
> [main])
> * INFO  11:42:08,993 Executing startup routine [5 of 13, runlevel 0]:
> OpenHealthDataSourceWriter (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:42:08,993 Environment variable OPENHEALTH_HOME not set
> (OpenHealthDataSourceWriter.java [main])
> * INFO  11:42:08,994 Executing startup routine [6 of 13, runlevel 0]:
> ReportTableUpgrader (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:42:08,997 Upgraded report tables (ReportTableUpgrader.java [main])
> * INFO  11:42:08,997 Executing startup routine [7 of 13, runlevel 1]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:42:09,151 Updated Category sort order and primary keys
> (OptionsCategoriesDefaultSortOrderPopulator.java [main])
> * INFO  11:42:09,152 Executing startup routine [8 of 13, runlevel 1]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:42:09,166 Executing startup routine [9 of 13, runlevel 1]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:42:09,167 Removing datasetid column from dataentryform
> table (DataEntryFormPopulator.java [main])
> * INFO  11:42:09,286 Executing startup routine [10 of 13, runlevel 2]:
> $Proxy34 (DefaultStartupRoutineExecutor.java [main])
> * INFO  11:42:09,338 Added default dataelement dimension
> (DataElementDefaultDimensionPopulator.java [main])
> * WARN  11:42:09,352 SQL Error: 0, SQLState: 23505
> (JDBCExceptionReporter.java [main])
> * ERROR 11:42:09,353 Batch entry 0 insert into categoryoptioncombo
> (categoryoptioncomboid) values ('16') was aborted.  Call
> getNextException to see the cause. (JDBCExceptionReporter.java [main])
> * WARN  11:42:09,353 SQL Error: 0, SQLState: 23505
> (JDBCExceptionReporter.java [main])
> * ERROR 11:42:09,355 ERROR: duplicate key value violates unique
> constraint "categoryoptioncombo_pkey" (JDBCExceptionReporter.java
> [main])
> * ERROR 11:42:09,358 Could not synchronize database state with session
> (AbstractFlushingEventListener.java [main])
> org.hibernate.exception.ConstraintViolationException: Could not
> execute JDBC batch update
>        at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:71)
>        at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
>        at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:253)
>        at org.hibernate.jdbc.AbstractBatcher.prepareStatement(AbstractBatcher.java:92)
>        at org.hibernate.jdbc.AbstractBatcher.prepareStatement(AbstractBatcher.java:87)
>        at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2237)
>        at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2665)
>        at org.hibernate.action.EntityInsertAction.execute(EntityInsertAction.java:60)
>        at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:279)
>        at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:263)
>        at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:167)
>        at org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:298)
>        at org.hibernate.event.def.DefaultAutoFlushEventListener.onAutoFlush(DefaultAutoFlushEventListener.java:41)
>        at org.hibernate.impl.SessionImpl.autoFlushIfRequired(SessionImpl.java:969)
>        at org.hibernate.impl.SessionImpl.list(SessionImpl.java:1562)
>        at org.hibernate.impl.CriteriaImpl.list(CriteriaImpl.java:283)
>        at org.hibernate.impl.CriteriaImpl.uniqueResult(CriteriaImpl.java:305)
>        at org.hisp.dhis.hibernate.HibernateGenericStore.getObject(HibernateGenericStore.java:125)
>        at org.hisp.dhis.hibernate.HibernateGenericStore.getByName(HibernateGenericStore.java:178)
>        at org.hisp.dhis.dataelement.DefaultDataElementCategoryService.getDataElementCategoryComboByName(DefaultDataElementCategoryService.java:243)
>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>        at java.lang.reflect.Method.invoke(Method.java:597)
>        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182)
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149)
>        at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106)
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
>        at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:89)
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
>        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
>        at $Proxy15.getDataElementCategoryComboByName(Unknown Source)
>        at org.hisp.dhis.dataelement.DataElementDefaultDimensionPopulator.execute(DataElementDefaultDimensionPopulator.java:90)
>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>        at java.lang.reflect.Method.invoke(Method.java:597)
>        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182)
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149)
>        at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106)
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
>        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
>        at $Proxy34.execute(Unknown Source)
>        at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineExecutor.java:101)
>        at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineExecutor.java:77)
>        at org.hisp.dhis.system.startup.StartupListener.contextInitialized(StartupListener.java:57)
>        at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:3972)
>        at org.apache.catalina.core.StandardContext.start(StandardContext.java:4467)
>        at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:791)
>        at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:771)
>        at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:546)
>        at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:905)
>        at org.apache.catalina.startup.HostConfig.deployWARs(HostConfig.java:740)
>        at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:500)
>        at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1277)
>        at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:321)
>        at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:119)
>        at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
>        at org.apache.catalina.core.StandardHost.start(StandardHost.java:785)
>        at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1045)
>        at org.apache.catalina.core.StandardEngine.start(StandardEngine.java:443)
>        at org.apache.catalina.core.StandardService.start(StandardService.java:519)
>        at org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
>        at org.apache.catalina.startup.Catalina.start(Catalina.java:581)
>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>        at java.lang.reflect.Method.invoke(Method.java:597)
>        at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:289)
>        at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
> Caused by: java.sql.BatchUpdateException: Batch entry 0 insert into
> categoryoptioncombo (categoryoptioncomboid) values ('16') was aborted.
>  Call getNextException to see the cause.
>        at org.postgresql.jdbc2.AbstractJdbc2Statement$BatchResultHandler.handleError(AbstractJdbc2Statement.java:2569)
>        at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1796)
>        at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:407)
>        at org.postgresql.jdbc2.AbstractJdbc2Statement.executeBatch(AbstractJdbc2Statement.java:2708)
>        at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeBatch(NewProxyPreparedStatement.java:1723)
>        at org.hibernate.jdbc.BatchingBatcher.doExecuteBatch(BatchingBatcher.java:48)
>        at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:246)
>        ... 69 more
> May 3, 2010 11:42:09 AM org.apache.catalina.core.StandardContext start
> SEVERE: Error listenerStart
> May 3, 2010 11:42:09 AM org.apache.catalina.core.StandardContext start
> SEVERE: Context [/dhis] startup failed due to previous errors
> May 3, 2010 11:42:10 AM org.apache.catalina.loader.WebappClassLoader
> clearReferencesJdbc
> SEVERE: A web application registered the JBDC driver [org.h2.Driver]
> but failed to unregister it when the web application was stopped. To
> prevent a memory leak, the JDBC Driver has been forcibly unregistered.
> May 3, 2010 11:42:10 AM org.apache.catalina.loader.WebappClassLoader
> clearReferencesJdbc
> SEVERE: A web application registered the JBDC driver
> [com.mysql.jdbc.Driver] but failed to unregister it when the web
> application was stopped. To prevent a memory leak, the JDBC Driver has
> been forcibly unregistered.
> May 3, 2010 11:42:10 AM org.apache.catalina.loader.WebappClassLoader
> clearReferencesJdbc
> SEVERE: A web application registered the JBDC driver
> [org.postgresql.Driver] but failed to unregister it when the web
> application was stopped. To prevent a memory leak, the JDBC Driver has
> been forcibly unregistered.
> No protocol specified
> May 3, 2010 11:42:10 AM org.apache.catalina.startup.HostConfig deployDirectory
> INFO: Deploying web application directory examples
> May 3, 2010 11:42:11 AM org.apache.catalina.startup.HostConfig deployDirectory
> INFO: Deploying web application directory ROOT
> May 3, 2010 11:42:11 AM org.apache.catalina.startup.HostConfig deployDirectory
> INFO: Deploying web application directory docs
> May 3, 2010 11:42:11 AM org.apache.coyote.http11.Http11AprProtocol start
> INFO: Starting Coyote HTTP/1.1 on http-8080
> May 3, 2010 11:42:11 AM org.apache.coyote.ajp.AjpAprProtocol start
> INFO: Starting Coyote AJP/1.3 on ajp-8009
> May 3, 2010 11:42:11 AM org.apache.catalina.startup.Catalina start
> INFO: Server startup in 31159 ms
>
>
> Regards,
> Jason
>
>
> ---
> Jason P. Pickering
> email: jason.p.pickering@xxxxxxxxx
> tel:+260968395190
>



-- 
--
Jason P. Pickering
email: jason.p.pickering@xxxxxxxxx
tel:+260968395190
Follow ups

Re: Errors with latest version
From: Lars Helge Øverland, 2010-05-03
References

Errors with latest version
From: Jason Pickering, 2010-05-03