dhis2-devs team mailing list archive
-
dhis2-devs team
-
Mailing list archive
-
Message #39012
[Bug 1487121] [NEW] tomcat is not displaying dhis on web browser
Public bug reported:
Hello all,
I am trying to install Dhis on ubuntu desktop 14.04.I av installed
tomcat,java and copied the war file to webapps.The tomcat starts well
and deploys the war file.
But when i try to access the dhis from my webbrowser,it gives the error
below
HTTP Status 404 - /dhis
type Status report
message /dhis
description The requested resource is not available.
Apache Tomcat/7.0.42
I have tried it on several browsers,its the same thing.Can someone
please help me ?
This is a snap shot of the catalina.out result of the tomcat
Aug 20, 2015 4:21:00 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 20, 2015 4:21:00 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 375 ms
Aug 20, 2015 4:21:01 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 20, 2015 4:21:01 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.42
Aug 20, 2015 4:21:01 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /usr/share/apache-tomcat-7.0.42/webapps/dhis.war
* INFO 2015-08-20 16:21:11,055 System property dhis2.home not set (DefaultLocationManager.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:11,057 Environment variable DHIS2_HOME points to /home/inveneo/DHIS2_HOME/dhis (DefaultLocationManager.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:12,083 Hibernate configuration loaded, using dialect: org.hibernate.dialect.PostgreSQLDialect (DefaultHibernateConfigurationProvider.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,179 HHH000388: Unsuccessful: alter table completedatasetregistration add column attributeoptioncomboid int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,181 ERROR: column "attributeoptioncomboid" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,185 HHH000388: Unsuccessful: alter table datavalue add column attributeoptioncomboid int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,187 ERROR: column "attributeoptioncomboid" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,190 HHH000388: Unsuccessful: alter table minmaxdataelement add column minimumvalue int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,191 ERROR: column "minimumvalue" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,194 HHH000388: Unsuccessful: alter table minmaxdataelement add column maximumvalue int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,195 ERROR: column "maximumvalue" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,199 HHH000388: Unsuccessful: alter table translation add column translationid int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,199 ERROR: column "translationid" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,202 HHH000388: Unsuccessful: alter table completedatasetregistration add constraint fk_completedatasetregistration_attributeoptioncomboid foreign key (attributeoptioncomboid) references categoryoptioncombo (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,203 ERROR: column "attributeoptioncomboid" referenced in foreign key constraint does not exist (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,206 HHH000388: Unsuccessful: alter table datavalue add constraint fk_datavalue_attributeoptioncomboid foreign key (attributeoptioncomboid) references categoryoptioncombo (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,208 ERROR: column "attributeoptioncomboid" referenced in foreign key constraint does not exist (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,210 HHH000388: Unsuccessful: alter table programstage add constraint fk_programstage_dataentryform foreign key (dataentryformid) references dataentryform (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,211 ERROR: constraint "fk_programstage_dataentryform" for relation "programstage" already exists (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,215 HHH000388: Unsuccessful: alter table sqlviewusergroupaccesses add constraint FK_ftn43gpevax8by169pld7dl5d foreign key (sqlviewid) references sqlview (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,216 ERROR: constraint "fk_ftn43gpevax8by169pld7dl5d" for relation "sqlviewusergroupaccesses" already exists (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,219 HHH000388: Unsuccessful: alter table validationrulegroupmembers add constraint fk_validationrulegroupmembers_validationrulegroupid foreign key (validationgroupid) references validationrulegroup (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,221 ERROR: constraint "fk_validationrulegroupmembers_validationrulegroupid" for relation "validationrulegroupmembers" already exists (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,224 HHH000388: Unsuccessful: alter table validationrulegroupusergroupaccesses add constraint FK_932w5l8vbyvybhsrwwadjd3cp foreign key (validationrulegroupid) references validationrulegroup (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,225 ERROR: constraint "fk_932w5l8vbyvybhsrwwadjd3cp" for relation "validationrulegroupusergroupaccesses" already exists (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,228 HHH000388: Unsuccessful: alter table validationrulegroupusergroupstoalert add constraint fk_validationrulegroupusergroupstoalert_validationgroupid foreign key (validationgroupid) references validationrulegroup (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,229 ERROR: constraint "fk_validationrulegroupusergroupstoalert_validationgroupid" for relation "validationrulegroupusergroupstoalert" already exists (SchemaUpdate.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:26,000 Found the following message senders: [org.hisp.dhis.message.EmailMessageSender@7c267dd0, org.hisp.dhis.sms.SmsMessageSender@615318b9] (DefaultMessageService.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:31,908 Detected apps: [] (DefaultAppManager.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,190 Added logger: org.hisp.dhis.resourcetable using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis-analytics-table.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,191 Added logger: org.hisp.dhis.analytics.table using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis-analytics-table.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,191 Added logger: org.hisp.dhis.dxf2 using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis-data-exchange.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,191 Added logger: org.hisp.dhis.dxf2.synch using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis-data-sync.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,192 Added root logger using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* WARN 2015-08-20 16:21:33,724 RP discovery / realm validation disabled; (RealmVerifier.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,751 Executing startup routine [1 of 14, runlevel 1]: InitTableAlteror (DefaultStartupRoutineExecutor.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,950 Upgraded program stage data elements (InitTableAlteror.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,951 Executing startup routine [2 of 14, runlevel 2]: PeriodTypePopulator (DefaultStartupRoutineExecutor.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,969 Executing startup routine [3 of 14, runlevel 2]: DataElementDefaultDimensionPopulator (DefaultStartupRoutineExecutor.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:34,986 org.hibernate.PropertyAccessException: Null value was assigned to a property of primitive type setter of org.hisp.dhis.common.BaseDimensionalObject.dataDimension
at org.hibernate.property.BasicPropertyAccessor$BasicSetter.set(BasicPropertyAccessor.java:108)
at org.hibernate.tuple.entity.AbstractEntityTuplizer.setPropertyValues(AbstractEntityTuplizer.java:710)
at org.hibernate.tuple.entity.PojoEntityTuplizer.setPropertyValues(PojoEntityTuplizer.java:379)
at org.hibernate.persister.entity.AbstractEntityPersister.setPropertyValues(AbstractEntityPersister.java:4522)
at org.hibernate.engine.internal.TwoPhaseLoad.doInitializeEntity(TwoPhaseLoad.java:186)
at org.hibernate.engine.internal.TwoPhaseLoad.initializeEntity(TwoPhaseLoad.java:137)
at org.hibernate.loader.Loader.initializeEntitiesAndCollections(Loader.java:1112)
at org.hibernate.loader.Loader.processResultSet(Loader.java:969)
at org.hibernate.loader.Loader.doQuery(Loader.java:917)
at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:348)
at org.hibernate.loader.Loader.doList(Loader.java:2550)
at org.hibernate.loader.Loader.listUsingQueryCache(Loader.java:2395)
at org.hibernate.loader.Loader.list(Loader.java:2358)
at org.hibernate.loader.criteria.CriteriaLoader.list(CriteriaLoader.java:124)
at org.hibernate.internal.SessionImpl.list(SessionImpl.java:1623)
at org.hibernate.internal.CriteriaImpl.list(CriteriaImpl.java:374)
at org.hisp.dhis.common.hibernate.HibernateIdentifiableObjectStore.getAllEqName(HibernateIdentifiableObjectStore.java:180)
at org.hisp.dhis.dataelement.DefaultDataElementCategoryService.getDataElementCategoryByName(DefaultDataElementCategoryService.java:212)
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:606)
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.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.$Proxy38.getDataElementCategoryByName(Unknown Source)
at org.hisp.dhis.dataelement.DataElementDefaultDimensionPopulator.execute(DataElementDefaultDimensionPopulator.java:82)
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:606)
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.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207)
at com.sun.proxy.$Proxy84.execute(Unknown Source)
at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineExecutor.java:119)
at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineExecutor.java:88)
at org.hisp.dhis.system.startup.StartupListener.contextInitialized(StartupListener.java:68)
at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4939)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5434)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:901)
at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)
at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:633)
at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:976)
at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1653)
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.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:724)
Caused by: java.lang.IllegalArgumentException
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:606)
at org.hibernate.property.BasicPropertyAccessor$BasicSetter.set(BasicPropertyAccessor.java:65)
... 63 more
(StartupListener.java [localhost-startStop-1])
Aug 20, 2015 4:21:34 PM org.apache.catalina.core.StandardContext startInternal
SEVERE: Error listenerStart
Aug 20, 2015 4:21:34 PM org.apache.catalina.core.StandardContext startInternal
SEVERE: Context [/dhis] startup failed due to previous errors
* INFO 2015-08-20 16:21:34,993 De-registering jdbc driver: sun.jdbc.odbc.JdbcOdbcDriver@1629bc56 (StartupListener.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,993 De-registering jdbc driver: org.postgresql.Driver@14c944d8 (StartupListener.java [localhost-startStop-1])
Aug 20, 2015 4:21:35 PM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
SEVERE: The web application [/dhis] created a ThreadLocal with key of type [java.lang.ThreadLocal] (value [java.lang.ThreadLocal@726b1eee]) and a value of type [org.springframework.security.core.context.SecurityContextImpl] (value [org.springframework.security.core.context.SecurityContextImpl@ffffffff: Null authentication]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/ROOT
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/host-manager
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/examples
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/manager
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/docs
Aug 20, 2015 4:21:35 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 20, 2015 4:21:35 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 34288 ms
** 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/1487121
Title:
tomcat is not displaying dhis on web browser
Status in DHIS:
New
Bug description:
Hello all,
I am trying to install Dhis on ubuntu desktop 14.04.I av installed
tomcat,java and copied the war file to webapps.The tomcat starts well
and deploys the war file.
But when i try to access the dhis from my webbrowser,it gives the
error below
HTTP Status 404 - /dhis
type Status report
message /dhis
description The requested resource is not available.
Apache Tomcat/7.0.42
I have tried it on several browsers,its the same thing.Can someone
please help me ?
This is a snap shot of the catalina.out result of the tomcat
Aug 20, 2015 4:21:00 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 20, 2015 4:21:00 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 375 ms
Aug 20, 2015 4:21:01 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 20, 2015 4:21:01 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.42
Aug 20, 2015 4:21:01 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /usr/share/apache-tomcat-7.0.42/webapps/dhis.war
* INFO 2015-08-20 16:21:11,055 System property dhis2.home not set (DefaultLocationManager.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:11,057 Environment variable DHIS2_HOME points to /home/inveneo/DHIS2_HOME/dhis (DefaultLocationManager.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:12,083 Hibernate configuration loaded, using dialect: org.hibernate.dialect.PostgreSQLDialect (DefaultHibernateConfigurationProvider.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,179 HHH000388: Unsuccessful: alter table completedatasetregistration add column attributeoptioncomboid int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,181 ERROR: column "attributeoptioncomboid" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,185 HHH000388: Unsuccessful: alter table datavalue add column attributeoptioncomboid int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,187 ERROR: column "attributeoptioncomboid" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,190 HHH000388: Unsuccessful: alter table minmaxdataelement add column minimumvalue int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,191 ERROR: column "minimumvalue" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,194 HHH000388: Unsuccessful: alter table minmaxdataelement add column maximumvalue int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,195 ERROR: column "maximumvalue" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,199 HHH000388: Unsuccessful: alter table translation add column translationid int4 not null (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,199 ERROR: column "translationid" contains null values (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,202 HHH000388: Unsuccessful: alter table completedatasetregistration add constraint fk_completedatasetregistration_attributeoptioncomboid foreign key (attributeoptioncomboid) references categoryoptioncombo (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,203 ERROR: column "attributeoptioncomboid" referenced in foreign key constraint does not exist (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,206 HHH000388: Unsuccessful: alter table datavalue add constraint fk_datavalue_attributeoptioncomboid foreign key (attributeoptioncomboid) references categoryoptioncombo (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,208 ERROR: column "attributeoptioncomboid" referenced in foreign key constraint does not exist (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,210 HHH000388: Unsuccessful: alter table programstage add constraint fk_programstage_dataentryform foreign key (dataentryformid) references dataentryform (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,211 ERROR: constraint "fk_programstage_dataentryform" for relation "programstage" already exists (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,215 HHH000388: Unsuccessful: alter table sqlviewusergroupaccesses add constraint FK_ftn43gpevax8by169pld7dl5d foreign key (sqlviewid) references sqlview (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,216 ERROR: constraint "fk_ftn43gpevax8by169pld7dl5d" for relation "sqlviewusergroupaccesses" already exists (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,219 HHH000388: Unsuccessful: alter table validationrulegroupmembers add constraint fk_validationrulegroupmembers_validationrulegroupid foreign key (validationgroupid) references validationrulegroup (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,221 ERROR: constraint "fk_validationrulegroupmembers_validationrulegroupid" for relation "validationrulegroupmembers" already exists (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,224 HHH000388: Unsuccessful: alter table validationrulegroupusergroupaccesses add constraint FK_932w5l8vbyvybhsrwwadjd3cp foreign key (validationrulegroupid) references validationrulegroup (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,225 ERROR: constraint "fk_932w5l8vbyvybhsrwwadjd3cp" for relation "validationrulegroupusergroupaccesses" already exists (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,228 HHH000388: Unsuccessful: alter table validationrulegroupusergroupstoalert add constraint fk_validationrulegroupusergroupstoalert_validationgroupid foreign key (validationgroupid) references validationrulegroup (SchemaUpdate.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:22,229 ERROR: constraint "fk_validationrulegroupusergroupstoalert_validationgroupid" for relation "validationrulegroupusergroupstoalert" already exists (SchemaUpdate.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:26,000 Found the following message senders: [org.hisp.dhis.message.EmailMessageSender@7c267dd0, org.hisp.dhis.sms.SmsMessageSender@615318b9] (DefaultMessageService.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:31,908 Detected apps: [] (DefaultAppManager.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,190 Added logger: org.hisp.dhis.resourcetable using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis-analytics-table.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,191 Added logger: org.hisp.dhis.analytics.table using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis-analytics-table.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,191 Added logger: org.hisp.dhis.dxf2 using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis-data-exchange.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,191 Added logger: org.hisp.dhis.dxf2.synch using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis-data-sync.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:33,192 Added root logger using file: /home/inveneo/DHIS2_HOME/dhis/logs/dhis.log (Log4JLogConfigInitializer.java [localhost-startStop-1])
* WARN 2015-08-20 16:21:33,724 RP discovery / realm validation disabled; (RealmVerifier.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,751 Executing startup routine [1 of 14, runlevel 1]: InitTableAlteror (DefaultStartupRoutineExecutor.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,950 Upgraded program stage data elements (InitTableAlteror.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,951 Executing startup routine [2 of 14, runlevel 2]: PeriodTypePopulator (DefaultStartupRoutineExecutor.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,969 Executing startup routine [3 of 14, runlevel 2]: DataElementDefaultDimensionPopulator (DefaultStartupRoutineExecutor.java [localhost-startStop-1])
* ERROR 2015-08-20 16:21:34,986 org.hibernate.PropertyAccessException: Null value was assigned to a property of primitive type setter of org.hisp.dhis.common.BaseDimensionalObject.dataDimension
at org.hibernate.property.BasicPropertyAccessor$BasicSetter.set(BasicPropertyAccessor.java:108)
at org.hibernate.tuple.entity.AbstractEntityTuplizer.setPropertyValues(AbstractEntityTuplizer.java:710)
at org.hibernate.tuple.entity.PojoEntityTuplizer.setPropertyValues(PojoEntityTuplizer.java:379)
at org.hibernate.persister.entity.AbstractEntityPersister.setPropertyValues(AbstractEntityPersister.java:4522)
at org.hibernate.engine.internal.TwoPhaseLoad.doInitializeEntity(TwoPhaseLoad.java:186)
at org.hibernate.engine.internal.TwoPhaseLoad.initializeEntity(TwoPhaseLoad.java:137)
at org.hibernate.loader.Loader.initializeEntitiesAndCollections(Loader.java:1112)
at org.hibernate.loader.Loader.processResultSet(Loader.java:969)
at org.hibernate.loader.Loader.doQuery(Loader.java:917)
at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:348)
at org.hibernate.loader.Loader.doList(Loader.java:2550)
at org.hibernate.loader.Loader.listUsingQueryCache(Loader.java:2395)
at org.hibernate.loader.Loader.list(Loader.java:2358)
at org.hibernate.loader.criteria.CriteriaLoader.list(CriteriaLoader.java:124)
at org.hibernate.internal.SessionImpl.list(SessionImpl.java:1623)
at org.hibernate.internal.CriteriaImpl.list(CriteriaImpl.java:374)
at org.hisp.dhis.common.hibernate.HibernateIdentifiableObjectStore.getAllEqName(HibernateIdentifiableObjectStore.java:180)
at org.hisp.dhis.dataelement.DefaultDataElementCategoryService.getDataElementCategoryByName(DefaultDataElementCategoryService.java:212)
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:606)
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.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.$Proxy38.getDataElementCategoryByName(Unknown Source)
at org.hisp.dhis.dataelement.DataElementDefaultDimensionPopulator.execute(DataElementDefaultDimensionPopulator.java:82)
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:606)
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.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207)
at com.sun.proxy.$Proxy84.execute(Unknown Source)
at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineExecutor.java:119)
at org.hisp.dhis.system.startup.DefaultStartupRoutineExecutor.execute(DefaultStartupRoutineExecutor.java:88)
at org.hisp.dhis.system.startup.StartupListener.contextInitialized(StartupListener.java:68)
at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4939)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5434)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:901)
at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)
at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:633)
at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:976)
at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1653)
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.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:724)
Caused by: java.lang.IllegalArgumentException
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:606)
at org.hibernate.property.BasicPropertyAccessor$BasicSetter.set(BasicPropertyAccessor.java:65)
... 63 more
(StartupListener.java [localhost-startStop-1])
Aug 20, 2015 4:21:34 PM org.apache.catalina.core.StandardContext startInternal
SEVERE: Error listenerStart
Aug 20, 2015 4:21:34 PM org.apache.catalina.core.StandardContext startInternal
SEVERE: Context [/dhis] startup failed due to previous errors
* INFO 2015-08-20 16:21:34,993 De-registering jdbc driver: sun.jdbc.odbc.JdbcOdbcDriver@1629bc56 (StartupListener.java [localhost-startStop-1])
* INFO 2015-08-20 16:21:34,993 De-registering jdbc driver: org.postgresql.Driver@14c944d8 (StartupListener.java [localhost-startStop-1])
Aug 20, 2015 4:21:35 PM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
SEVERE: The web application [/dhis] created a ThreadLocal with key of type [java.lang.ThreadLocal] (value [java.lang.ThreadLocal@726b1eee]) and a value of type [org.springframework.security.core.context.SecurityContextImpl] (value [org.springframework.security.core.context.SecurityContextImpl@ffffffff: Null authentication]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/ROOT
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/host-manager
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/examples
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/manager
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /usr/share/apache-tomcat-7.0.42/webapps/docs
Aug 20, 2015 4:21:35 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 20, 2015 4:21:35 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 20, 2015 4:21:35 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 34288 ms
To manage notifications about this bug go to:
https://bugs.launchpad.net/dhis2/+bug/1487121/+subscriptions
Follow ups
