Details

    • Branch Version/s:
      6.0.x
    • Backported to Branch:
      Committed

      Description

      Jonas fails to start with the following exception:

      Welcome to OW2 JOnAS (Running on Felix v3.0.9).
      -----------------------------------------------
      
      12/17/11 2:56:33 AM (I) ExtensionLoaderComponent.__start : Some jars have been found in [/home/konias/git/6.1.x/bundles/jonas-5.2.1/lib/ext]. They have been transformed into bundles (see /home/konias/git/6.1.x/bundles/jonas-5.2.1/work/ext-bundles directory).This is NOT the preferred way to extend JOnAS libraries, prefer to use carefully created and tested bundles, and place them in your deploy/ directory.
      12/17/11 2:56:33 AM (I) ExtensionLoaderComponent.__start : file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/work/ext-bundles/hsql.jar installed as a bundle.
      12/17/11 2:56:33 AM (I) ExtensionLoaderComponent.__start : file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/work/ext-bundles/postgresql.jar installed as a bundle.
      12/17/11 2:56:33 AM (I) ExtensionLoaderComponent.__start : file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/work/ext-bundles/mysql.jar installed as a bundle.
      12/17/11 2:56:33 AM (I) ExtensionLoaderComponent.__start : file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/work/ext-bundles/portal-service.jar installed as a bundle.
      12/17/11 2:56:33 AM (I) ExtensionLoaderComponent.__start : file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/work/ext-bundles/jtds.jar installed as a bundle.
      12/17/11 2:56:33 AM (I) ExtensionLoaderComponent.__start : file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/work/ext-bundles/portlet.jar installed as a bundle.
      2011-12-17 02:56:33,538 : NameServiceManager.startNonStartedNS : Name service for jrmp is started on port ' 1099'.
      2011-12-17 02:56:33,542 : CarolRegistryService.__doStart : Carol Registry Service started
      2011-12-17 02:56:33,773 : JOnASJMXService$2.execute : JMX security is disabled
      2011-12-17 02:56:33,774 : JOnASJMXService.__doStart : JMX Service started using connector(s)[service:jmx:rmi://localhost/jndi/rmi://localhost:1099/jrmpconnector_jonas]
      2011-12-17 02:56:33,917 : PolicyProvider.init : Using JOnAS PolicyConfigurationFactory provider and JOnAS Policy provider
      2011-12-17 02:56:34,022 : J2EEServer.__setStarting : JVM used is 1.6.0_29 version of Java HotSpot(TM) 64-Bit Server VM-20.4-b02/Sun Microsystems Inc. vendor on Linux 3.0.0-14-generic/amd64 OS.
      2011-12-17 02:56:34,026 : J2EEServer.__info : JOnAS AS v5.2.1 named 'jonas' STARTING
      2011-12-17 02:56:34,162 : JonasSecurityServiceImpl.__doStart : Security Service started
      2011-12-17 02:56:34,274 : JNDIInterceptorsComponent.__start : JNDI Interceptors component started
      2011-12-17 02:56:34,344 : JOnASWorkCleanerService.__doStart : WorkCleaner Service started.
      2011-12-17 02:56:34,516 : TransactionRecoveryImpl.<init> : JOTM properties file= /home/konias/git/6.1.x/bundles/jonas-5.2.1/conf/jotm.properties
      2011-12-17 02:56:34,517 : Current.setDefaultRecovery : Jotm Recovery= false
      2011-12-17 02:56:34,527 : JOTMTransactionService.__doStart : TransactionService started, default timeout= 60
      2011-12-17 02:56:34,930 : JOnASWorkManagerService.__doStart : WorkManager Service started.
      2011-12-17 02:56:35,173 : RARDeployer.doDeploy : Deploying jonas-jca-jdbc-cp-5.2.1.rar
      2011-12-17 02:56:35,566 : Rar.processRar : jonas-jca-jdbc-cp-5.2.1.rar available
      2011-12-17 02:56:35,569 : RARDeployer.doDeploy : Deploying jonas-jca-jdbc-ds-5.2.1.rar
      2011-12-17 02:56:35,707 : Rar.processRar : jonas-jca-jdbc-ds-5.2.1.rar available
      2011-12-17 02:56:35,709 : RARDeployer.doDeploy : Deploying jonas-jca-jdbc-dm-5.2.1.rar
      2011-12-17 02:56:35,829 : Rar.processRar : jonas-jca-jdbc-dm-5.2.1.rar available
      2011-12-17 02:56:35,832 : RARDeployer.doDeploy : Deploying jonas-jca-jdbc-xa-5.2.1.rar
      2011-12-17 02:56:35,960 : Rar.processRar : jonas-jca-jdbc-xa-5.2.1.rar available
      2011-12-17 02:56:35,961 : JOnASResourceService.__doStart : Resource Service started
      2011-12-17 02:56:36,311 : EventComponent.start : started.
      2011-12-17 02:56:36,323 : StatisticComponent.start : Statistics component started with factories: [org.ow2.easybeans.statistic.MeanCallTimeStatisticFactory, org.ow2.easybeans.statistic.CallCountStatisticFactory, org.ow2.easybeans.statistic.TotalCallTimeStatisticFactory]
      2011-12-17 02:56:36,324 : ComponentManager.startComponents : [ Component(s) started : Quartz Event Carol RemoteJNDIResolver Jmx Statistic ]
      2011-12-17 02:56:36,351 : Embedded.start : Startup of EasyBeans '1.2.1.0' was done in '141' ms.
      2011-12-17 02:56:37,103 : CXFService.__doStart : Apache CXF 2.2.12 started
      2011-12-17 02:56:37,299 : BaseWebContainerService.doStart : OnDemand Feature enabled: Listening on '8080' port (internal:8951).
      2011-12-17 02:56:37,520 : Http11Protocol.init : Initializing Coyote HTTP/1.1 on http-8951
      2011-12-17 02:56:37,530 : StandardService.start : Starting service jonas
      2011-12-17 02:56:37,531 : StandardEngine.start : Starting Servlet Engine: Apache Tomcat/6.0.32
      2011-12-17 02:56:37,570 : Http11Protocol.start : Starting Coyote HTTP/1.1 on http-8951
      2011-12-17 02:56:37,664 : JOnASEARService.__doStart : EAR Service started
      2011-12-17 02:56:37,723 : DeployableMonitorService.__doStart : Use the deploy directories '[]', development mode is 'true'
      2011-12-17 02:56:39,143 : DeployableMonitor.detectNewArchives : Deployables to deploy at startup: [[/home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/joram.xml, /home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/mejb.xml, /home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/scout.xml, /home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/liferay-portal.war]]
      2011-12-17 02:56:39,168 : RARDeployer.doDeploy : Deploying joram-jca-jonas-5.5.0.rar
      2011-12-17 02:56:39,834 : Rar.processRar : joram-jca-jonas-5.5.0.rar available
      2011-12-17 02:56:40,030 : EasyBeansDeployer.doDeploy : Deploying 'mejb-5.2.1.jar'...
      2011-12-17 02:56:40,184 : Enhancer.enhance : Beans found are [MEJB]
      2011-12-17 02:56:40,410 : JContainer3.start : Container '/home/konias/git/6.1.x/bundles/jonas-5.2.1/work/ejb3s/jonas/mejb-5.2.1_2011.06.22-16.58.12.jar' [1 SLSB, 0 SFSB, 0 MDB] started in 365 ms
      2011-12-17 02:56:40,412 : EasyBeansDeployer.doDeploy : 'mejb-5.2.1.jar' EJB3 Deployable is now deployed
      2011-12-17 02:56:40,571 : RARDeployer.doDeploy : Deploying jonas-jca-scout-rar-5.2.1.rar
      2011-12-17 02:56:40,676 : JAXRResourceAdapter.start : Starting Scout ResourceAdapter
      2011-12-17 02:56:40,691 : Rar.processRar : jonas-jca-scout-rar-5.2.1.rar available
      2011-12-17 02:56:41,093 : WARDeployer.doDeploy : Deploying liferay-portal.war
      2011-12-17 02:56:51,183 : BaseWebContainerService.registerWar : The application /home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/liferay-portal.war/ has its java2-delegation-model parameter set to false. JOnAS 5 offers a new possibility called the filtering class loader that can replace this parameter and doesn't suffer from the many unexpected behaviours caused by class loader inversion. Please see to JOnAS configuration guide for details.
      2011-12-17 02:56:51,315 : WebappLoader.start : Dual registration of jndi stream handler: factory already defined
      2011-12-17 02:56:52,210 : Jdk14LogImpl.info : Initializing hot deploy manager 1994294174
      Loading jar:file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/liferay-portal.war/WEB-INF/lib/portal-impl.jar!/system.properties
      2011-12-17 02:56:52,251 : Jdk14LogImpl.info : Detected server jonas
      2011-12-17 02:56:52,276 : Jdk14LogImpl.info : Global lib directory 
      2011-12-17 02:56:52,278 : Jdk14LogImpl.info : Portal lib directory /home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/liferay-portal.war/WEB-INF/lib/
      02:56:52,364 INFO  [EasyConf:122] Refreshed the configuration of all components
      02:56:52,670 INFO  [ConfigurationLoader:56] Properties for jar:file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/liferay-portal.war/WEB-INF/lib/portal-impl.jar!/portal loaded from [jar:file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/liferay-portal.war/WEB-INF/lib/portal-impl.jar!/portal.properties]
      Loading jar:file:/home/konias/git/6.1.x/bundles/jonas-5.2.1/deploy/liferay-portal.war/WEB-INF/lib/portal-impl.jar!/portal.properties
      02:56:52,913 ERROR [ClassPathUtil:143] Class javax.servlet.ServletException is not loaded from a standard location (/WEB-INF/classes)
      02:56:52,917 ERROR [ClassPathUtil:143] Class com.liferay.portal.kernel.exception.PortalException is not loaded from a standard location (/WEB-INF/classes)
      2011-12-17 02:56:52,988 : ApplicationContext.log : Initializing Spring root WebApplicationContext
      02:56:58,236 INFO  [DialectDetector:80] Determine dialect for HSQL Database Engine 2
      02:56:58,237 WARN  [DialectDetector:95] Liferay is configured to use Hypersonic as its database. Do NOT use Hypersonic in production. Hypersonic is an embedded database useful for development and demo'ing purposes. The database settings can be changed in portal-ext.properties.
      02:56:58,280 INFO  [DialectDetector:145] Found dialect org.hibernate.dialect.HSQLDialect
      Starting Liferay Portal Community Edition 6.1.0 CE (Paton / Build 6100 / December 15, 2011)
      02:57:16,554 INFO  [BaseDB:406] Database supports case sensitive queries
      02:57:17,616 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyProcessSuite
      02:57:17,617 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyProperties
      02:57:17,623 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyMySQL
      02:57:17,624 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifySQLServer
      02:57:17,624 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyCounter
      02:57:17,642 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyUUID
      02:57:17,650 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyPermission
      02:57:18,585 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyRole
      02:57:18,785 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyAsset
      02:57:18,789 INFO  [UpgradeProcess:205] Upgrading com.liferay.portal.upgrade.util.UpgradeAssetPublisherManualEntries
      02:57:18,793 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyBlogs
      02:57:18,798 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyBookmarks
      02:57:18,802 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyCalendar
      02:57:18,811 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyDocumentLibrary
      02:57:18,831 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyGroup
      02:57:18,949 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyJournal
      02:57:18,966 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyLayout
      02:57:18,972 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyMessageBoards
      02:57:18,990 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyOrganization
      02:57:19,022 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyResourcePermissions
      02:57:19,873 INFO  [VerifyResourcePermissions:147] Processed 100 resource permissions for com.liferay.portal.model.User
      02:57:20,557 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifySocial
      02:57:20,558 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyUser
      02:57:20,578 INFO  [VerifyProcess:76] Verifying com.liferay.portal.verify.VerifyWiki
      02:57:20,610 INFO  [PluginPackageUtil:1096] Reading plugin package for the root context
      02:57:22,951 INFO  [PluginPackageUtil:1280] Reloading repositories
      02:57:26,113 INFO  [AutoDeployDir:105] Auto deploy scanner started for /home/konias/git/6.1.x/bundles/deploy
      2011-12-17 02:57:33,278 : ApplicationContext.log : Initializing Spring FrameworkServlet 'Remoting Servlet'
      2011-12-17 02:57:34,963 : BaseWebContainerService.registerWar : War liferay-portal.war available at the context /.
      2011-12-17 02:57:35,725 : J2EEServer.__info : JOnAS AS v5.2.1 named 'jonas' RUNNING
      konias@KOnias:~/git/6.1.x/bundles/jonas-5.2.1/bin$ 2011-12-17 02:57:35,742 : StandardWrapperValve.invoke : Servlet.service() for servlet jsp threw exception
      java.lang.NullPointerException
      	at com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.getInvokerFilterChain(InvokerFilter.java:176)
      	at com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.doFilter(InvokerFilter.java:62)
      	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
      	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
      	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
      	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
      	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:470)
      	at org.ow2.jonas.web.tomcat6.CheckOpenResourcesValve.invoke(CheckOpenResourcesValve.java:73)
      	at org.ow2.jonas.web.tomcat6.tx.TransactionValve.invoke(TransactionValve.java:90)
      	at org.ow2.jonas.web.tomcat6.ResetAuthenticationValve.invoke(ResetAuthenticationValve.java:95)
      	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
      	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
      	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
      	at org.ow2.jonas.web.tomcat6.versioning.VersioningValve.invoke(VersioningValve.java:75)
      	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298)
      	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:859)
      	at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:588)
      	at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:489)
      	at java.lang.Thread.run(Thread.java:662)
      2011-12-17 02:57:38,752 : StandardWrapperValve.invoke : Servlet.service() for servlet jsp threw exception
      java.lang.NullPointerException
      	at com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.getInvokerFilterChain(InvokerFilter.java:176)
      	at com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.doFilter(InvokerFilter.java:62)
      	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
      	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
      	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
      	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
      	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:470)
      	at org.ow2.jonas.web.tomcat6.CheckOpenResourcesValve.invoke(CheckOpenResourcesValve.java:73)
      	at org.ow2.jonas.web.tomcat6.tx.TransactionValve.invoke(TransactionValve.java:90)
      	at org.ow2.jonas.web.tomcat6.ResetAuthenticationValve.invoke(ResetAuthenticationValve.java:95)
      	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
      	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
      	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
      	at org.ow2.jonas.web.tomcat6.versioning.VersioningValve.invoke(VersioningValve.java:75)
      	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298)
      	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:859)
      	at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:588)
      	at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:489)
      	at java.lang.Thread.run(Thread.java:662)
      2011-12-17 02:57:41,761 : StandardWrapperValve.invoke : Servlet.service() for servlet jsp threw exception
      java.lang.NullPointerException
      	at com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.getInvokerFilterChain(InvokerFilter.java:176)
      	at com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.doFilter(InvokerFilter.java:62)
      	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
      	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
      	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
      	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
      	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:470)
      	at org.ow2.jonas.web.tomcat6.CheckOpenResourcesValve.invoke(CheckOpenResourcesValve.java:73)
      	at org.ow2.jonas.web.tomcat6.tx.TransactionValve.invoke(TransactionValve.java:90)
      	at org.ow2.jonas.web.tomcat6.ResetAuthenticationValve.invoke(ResetAuthenticationValve.java:95)
      	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
      	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
      	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
      	at org.ow2.jonas.web.tomcat6.versioning.VersioningValve.invoke(VersioningValve.java:75)
      	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298)
      	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:859)
      	at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:588)
      	at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:489)
      	at java.lang.Thread.run(Thread.java:662)
      2011-12-17 02:59:39,486 : StandardWrapperValve.invoke : Servlet.service() for servlet jsp threw exception
      java.lang.NullPointerException
      	at com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.getInvokerFilterChain(InvokerFilter.java:176)
      	at com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.doFilter(InvokerFilter.java:62)
      	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
      	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
      	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
      	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
      	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:470)
      	at org.ow2.jonas.web.tomcat6.CheckOpenResourcesValve.invoke(CheckOpenResourcesValve.java:73)
      	at org.ow2.jonas.web.tomcat6.tx.TransactionValve.invoke(TransactionValve.java:90)
      	at org.ow2.jonas.web.tomcat6.ResetAuthenticationValve.invoke(ResetAuthenticationValve.java:95)
      	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
      	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
      	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
      	at org.ow2.jonas.web.tomcat6.versioning.VersioningValve.invoke(VersioningValve.java:75)
      	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298)
      	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:859)
      	at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:588)
      	at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:489)
      	at java.lang.Thread.run(Thread.java:662)
      
      

        Attachments

          Issue Links

            Activity

              People

              • Votes:
                0 Vote for this issue
                Watchers:
                0 Start watching this issue

                Dates

                • Created:
                  Updated:
                  Resolved:
                  Days since last comment:
                  7 years, 18 weeks, 4 days ago