Re: Re: OOME when trying to install HISE

Peter Nabbefeld <[email protected]> Fri, 17 Jun 2011 11:39:18 +0200
Newsgroups gmane.comp.java.objectweb.jonas
Message-ID <[email protected]>
Guillaume Sauthier (OW2) schrieb:
> Your webapp is probably too big to fit in the available heap memory.
>
Sorry, should have mentioned it's an apache project:
     http://incubator.apache.org/hise/

> You can either:
> * Strip down your webapp by removing all unrequired jars

Don't know, how, if possible.

> * Augment heap memory of the JVM (Start JOnAs with -Xms256m -Xmx512m or
> more if needed)

Tried that, seems to work (setting Jonbas properties)

> * Do not deploy your app with the jonasAdmin UI: simply drop the war in
> deploy/ or use jonbas to deploy the war for you

Hm, would that work when starting Jonas from NetBeans, as memory 
settings will be the same?

However, installing seems to be possible after setting VM parameters - 
but there's another exception, related to logging, which still prevents 
me from installing hise, log attached.

Kind regards

Peter
install-hise.log (text/plain, 10.8 KB)
Welcome to OW2 JOnAS (Running on Felix v3.0.9).
-----------------------------------------------

2011-06-17 11:23:50,468 : NameServiceManager.startNonStartedNS : Name service for iiop is started on port ' 2001'.
2011-06-17 11:23:50,593 : NameServiceManager.startNonStartedNS : Name service for jrmp is started on port ' 1099'.
2011-06-17 11:23:50,593 : CarolRegistryService.__doStart : Carol Registry Service started
2011-06-17 11:23:51,406 : JOnASJMXService$2.execute : JMX security is disabled
2011-06-17 11:23:51,609 : JOnASJMXService$2.execute : JMX security is disabled
2011-06-17 11:23:51,625 : JOnASJMXService.__doStart : JMX Service started using connector(s)[service:jmx:iiop://localhost/jndi/iiop://localhost:2001/iiopconnector_jonas, service:jmx:rmi://localhost/jndi/rmi://localhost:1099/jrmpconnector_jonas]
2011-06-17 11:23:51,984 : JNDIInterceptorsComponent.__start : JNDI Interceptors component started
2011-06-17 11:23:52,031 : J2EEServer.__setStarting : JVM used is 1.6.0_11 version of Java HotSpot(TM) Client VM-11.0-b16/Sun Microsystems Inc. vendor on Windows XP 5.1/x86 OS.
2011-06-17 11:23:52,031 : J2EEServer.__info : JOnAS AS v5.2.0 named 'jonas' STARTING
2011-06-17 11:23:52,359 : PolicyProvider.init : Using JOnAS PolicyConfigurationFactory provider and JOnAS Policy provider
2011-06-17 11:23:52,765 : JonasSecurityServiceImpl.__doStart : Security Service started
2011-06-17 11:23:52,875 : JOnASWorkCleanerService.__doStart : WorkCleaner Service started.
2011-06-17 11:23:53,031 : TransactionRecoveryImpl.<init> : JOTM properties file= C:\Programme\OW2\JOnAS_5_BASE\conf\jotm.properties
2011-06-17 11:23:53,046 : Current.setDefaultRecovery : Jotm Recovery= false
2011-06-17 11:23:53,093 : JOTMTransactionService.__doStart : TransactionService started, default timeout= 60
2011-06-17 11:23:53,187 : HsqlDBServiceImpl.__doStart : Starting HSQLDB server 1.8.0 on port 9001
2011-06-17 11:23:53,562 : HsqlDBServiceImpl.__doStart : HSQLDB server started.
2011-06-17 11:23:53,578 : HsqlDBServiceImpl.__doStart : Dropping and adding user 'jonas' with password 'jonas'.
2011-06-17 11:23:53,656 : JOnASMailService.__doStart : Mail Service started
2011-06-17 11:23:53,843 : JOnASDataBaseManagerService.__createDataSource : Mapping ConnectionManager jdbc:hsqldb:hsql://localhost:9001/db_jonas on jdbc_1
2011-06-17 11:23:54,500 : JOnASDataBaseManagerService.__doStart : DBM Service started
2011-06-17 11:23:54,593 : JOnASWorkManagerService.__doStart : WorkManager Service started.
2011-06-17 11:23:54,828 : RARDeployer.doDeploy : Deploying jonas-jca-jdbc-cp-5.2.0.rar
2011-06-17 11:23:55,281 : Rar.processRar : jonas-jca-jdbc-cp-5.2.0.rar available
2011-06-17 11:23:55,359 : RARDeployer.doDeploy : Deploying jonas-jca-jdbc-ds-5.2.0.rar
2011-06-17 11:23:55,406 : Rar.processRar : jonas-jca-jdbc-ds-5.2.0.rar available
2011-06-17 11:23:55,484 : RARDeployer.doDeploy : Deploying jonas-jca-jdbc-dm-5.2.0.rar
2011-06-17 11:23:55,531 : Rar.processRar : jonas-jca-jdbc-dm-5.2.0.rar available
2011-06-17 11:23:55,625 : RARDeployer.doDeploy : Deploying jonas-jca-jdbc-xa-5.2.0.rar
2011-06-17 11:23:55,687 : Rar.processRar : jonas-jca-jdbc-xa-5.2.0.rar available
2011-06-17 11:23:55,687 : JOnASResourceService.__doStart : Resource Service started
2011-06-17 11:23:55,937 : JOnASEJBService.__doStart : EJB 2.1 Service started
2011-06-17 11:23:56,718 : EventComponent.start : started.
2011-06-17 11:23:56,765 : StatisticComponent.start : Statistics component started with factories: [org.ow2.easybeans.statistic.MeanCallTimeStatisticFactory, org.ow2.easybeans.statistic.CallCountStatisticFactory, org.ow2.easybeans.statistic.TotalCallTimeStatisticFactory]
2011-06-17 11:23:56,765 : ComponentManager.startComponents : [ Component(s) started : Quartz Event Carol RemoteJNDIResolver Jmx Statistic ]
2011-06-17 11:23:56,796 : Embedded.start : Startup of EasyBeans '1.2.0.0' was done in '406' ms.
2011-06-17 11:23:57,640 : BaseWebContainerService.doStart : OnDemand Feature enabled: Listening on '9000' port (internal:8991).
2011-06-17 11:23:58,187 : Http11Protocol.init : Initializing Coyote HTTP/1.1 on http-8991
2011-06-17 11:23:58,187 : StandardService.start : Starting service jonas
2011-06-17 11:23:58,187 : StandardEngine.start : Starting Servlet Engine: Apache Tomcat/6.0.32
2011-06-17 11:23:58,250 : Http11Protocol.start : Starting Coyote HTTP/1.1 on http-8991
2011-06-17 11:23:58,390 : AxisService.__doStart : Axis Service Started
2011-06-17 11:24:00,265 : CXFService.__doStart : Apache CXF 2.2.12 started
2011-06-17 11:24:00,390 : JOnASEARService.__doStart : EAR Service started
2011-06-17 11:24:00,453 : DeployableMonitorService.__doStart : Use the deploy directories '[]', development mode is 'true'
2011-06-17 11:24:01,531 : DeployableMonitor.detectNewArchives : Deployables to deploy at startup: [[C:\Programme\OW2\JOnAS_5_BASE\deploy\ctxroot.xml, C:\Programme\OW2\JOnAS_5_BASE\deploy\doc.xml, C:\Programme\OW2\JOnAS_5_BASE\deploy\jonasAdmin.xml, C:\Programme\OW2\JOnAS_5_BASE\deploy\mejb.xml]]
2011-06-17 11:24:01,578 : WARDeployer.doDeploy : Deploying jonas-ctxroot-5.2.0.war
2011-06-17 11:24:01,593 : HttpOnDemandProxy.addWar : The war file 'C:\Programme\OW2\JOnAS_5\repositories\maven2-internal\org\ow2\jonas\jonas-ctxroot\5.2.0\jonas-ctxroot-5.2.0.war' is available on demand at the context /
2011-06-17 11:24:01,828 : WARDeployer.doDeploy : Deploying jonas-doc-en-5.2.0.war
2011-06-17 11:24:01,828 : HttpOnDemandProxy.addWar : The war file 'C:\Programme\OW2\JOnAS_5\repositories\maven2-internal\org\ow2\jonas\documentation\jonas-doc-en\5.2.0\jonas-doc-en-5.2.0.war' is available on demand at the context /jonas-doc-en
2011-06-17 11:24:02,078 : WARDeployer.doDeploy : Deploying jonas-admin-5.2.0.war
2011-06-17 11:24:02,093 : HttpOnDemandProxy.addWar : The war file 'C:\Programme\OW2\JOnAS_5\repositories\maven2-internal\org\ow2\jonas\jonas-admin\5.2.0\jonas-admin-5.2.0.war' is available on demand at the context /jonasAdmin
2011-06-17 11:24:02,406 : EasyBeansDeployer.doDeploy : Deploying 'mejb-5.2.0.jar'...
2011-06-17 11:24:02,734 : Enhancer.enhance : Beans found are [MEJB]
2011-06-17 11:24:03,093 : JContainer3.start : Container 'C:\Programme\OW2\JOnAS_5_BASE\work\ejb3s\jonas\mejb-5.2.0_2011.04.04-14.06.08.jar' [1 SLSB, 0 SFSB, 0 MDB] started in 640 ms
2011-06-17 11:24:03,093 : EasyBeansDeployer.doDeploy : 'mejb-5.2.0.jar' EJB3 Deployable is now deployed
2011-06-17 11:24:03,343 : J2EEServer.__info : JOnAS AS v5.2.0 named 'jonas' RUNNING
2011-06-17 11:26:06,187 : WebappLoader.start : Dual registration of jndi stream handler: factory already defined
log4j:WARN No appenders could be found for logger (org.granite.config.GraniteConfigListener).
log4j:WARN Please initialize the log4j system properly.
2011-06-17 11:26:10,203 : BaseWebContainerService.registerWar : War jonas-admin-5.2.0.war available at the context /jonasAdmin.
2011-06-17 11:28:21,593 : J2EEServer.__sendFile : sendFile return directoryUploadedFile= C:\Programme\OW2\JOnAS_5_BASE\deploy\hise-web-0.3.0.war
2011-06-17 11:28:24,796 : WARDeployer.doDeploy : Deploying hise-web-0.3.0.war
2011-06-17 11:28:28,421 : JPersistenceUnitInfoLoader.loadPersistenceUnitInfoImplList : No transaction-type defined. Set to default JTA transaction-type
log4j:WARN No appenders could be found for logger (org.hibernate.ejb.packaging.AbstractJarVisitor).
log4j:WARN Please initialize the log4j system properly.
2011-06-17 11:28:29,828 : DeployableMonitor.checkNewArchives : Problem when trying to find and deploy new archives
org.ow2.jonas.deployablemonitor.DeployableMonitorException: Cannot deploy the deployable 'WARDeployableImpl[archive=C:\Programme\OW2\JOnAS_5_BASE\deploy\hise-web-0.3.0.war]'
	at org.ow2.jonas.deployablemonitor.DeployableMonitor.detectNewArchives(DeployableMonitor.java:502)
	at org.ow2.jonas.deployablemonitor.DeployableMonitor.checkNewArchives(DeployableMonitor.java:306)
	at org.ow2.jonas.deployablemonitor.DeployableMonitor.run(DeployableMonitor.java:216)
Caused by: org.ow2.util.ee.deploy.api.deployer.DeployerException: Unable to deploy deployable 'WARDeployableImpl[archive=C:\Programme\OW2\JOnAS_5_BASE\deploy\hise-web-0.3.0.war]'
	at org.ow2.util.ee.deploy.impl.deployer.AbsDeployer.deploy(AbsDeployer.java:105)
	at org.ow2.util.ee.deploy.impl.deployer.DeployerManager.deploy(DeployerManager.java:129)
	at org.ow2.jonas.deployablemonitor.DeployableMonitor.detectNewArchives(DeployableMonitor.java:490)
	... 2 more
Caused by: javax.persistence.PersistenceException: [PersistenceUnit: org.apache.hise] Unable to build EntityManagerFactory
	at org.hibernate.ejb.Ejb3Configuration.buildEntityManagerFactory(Ejb3Configuration.java:677)
	at org.hibernate.ejb.HibernatePersistence.createContainerEntityManagerFactory(HibernatePersistence.java:132)
	at org.ow2.easybeans.persistence.JPersistenceContext.init(JPersistenceContext.java:72)
	at org.ow2.easybeans.persistence.JPersistenceContext.<init>(JPersistenceContext.java:65)
	at org.ow2.easybeans.persistence.PersistenceUnitManager.addExtraPersistenceUnitInfos(PersistenceUnitManager.java:88)
	at org.ow2.easybeans.persistence.PersistenceUnitManager.<init>(PersistenceUnitManager.java:64)
	at org.ow2.easybeans.persistence.xml.PersistenceXmlFileAnalyzer.loadPersistenceProvider(PersistenceXmlFileAnalyzer.java:233)
	at org.ow2.jonas.ejb.easybeans.EasyBeansService.__getPersistenceUnitManager(EasyBeansService.java:882)
	at org.ow2.jonas.ejb.easybeans.EasyBeansService.getPersistenceUnitManager(EasyBeansService.java)
	at org.ow2.jonas.web.base.BaseWebContainerService.registerWar(BaseWebContainerService.java:821)
	at org.ow2.jonas.web.base.BaseWebContainerService.registerWar(BaseWebContainerService.java:1241)
	at org.ow2.jonas.web.base.proxy.HttpOnDemandProxy.addWar(HttpOnDemandProxy.java:352)
	at org.ow2.jonas.web.base.WARDeployer.doDeploy(WARDeployer.java:70)
	at org.ow2.util.ee.deploy.impl.deployer.AbsDeployer$1.execute(AbsDeployer.java:96)
	at org.ow2.util.ee.deploy.impl.deployer.AbsDeployer$1.execute(AbsDeployer.java:95)
	at org.ow2.util.execution.helper.RunnableHelper.execute(RunnableHelper.java:77)
	at org.ow2.util.ee.deploy.impl.deployer.AbsDeployer.deploy(AbsDeployer.java:94)
	... 4 more
Caused by: org.hibernate.MappingException: Could not determine type for: org.apache.commons.logging.Log, at table: HISE_TASK, for columns: [org.hibernate.mapping.Column(log)]
	at org.hibernate.mapping.SimpleValue.getType(SimpleValue.java:292)
	at org.hibernate.mapping.SimpleValue.isValid(SimpleValue.java:276)
	at org.hibernate.mapping.Property.isValid(Property.java:207)
	at org.hibernate.mapping.PersistentClass.validate(PersistentClass.java:458)
	at org.hibernate.mapping.RootClass.validate(RootClass.java:215)
	at org.hibernate.cfg.Configuration.validate(Configuration.java:1149)
	at org.hibernate.cfg.Configuration.buildSessionFactory(Configuration.java:1334)
	at org.hibernate.cfg.AnnotationConfiguration.buildSessionFactory(AnnotationConfiguration.java:867)
	at org.hibernate.ejb.Ejb3Configuration.buildEntityManagerFactory(Ejb3Configuration.java:669)
	... 20 more