7 Replies Latest reply on Oct 1, 2003 8:11 PM by tsg26

    5 minutes to start - normal??

    tcn

      Hi!

      I run linux on a 1 GHz Athlon and have 1.4.2_01 installed. Starting an out-of-the-box JBoss 4.0DR2 in its default configuration (./run.sh) takes nearly 5 minutes!

      This isn't normal, is it?

        • 1. Re: 5 minutes to start - normal??

          Yes u are right this is not normal, it is beyond its abnormality :-).

          • 2. Re: 5 minutes to start - normal??
            tcn

            So, what am I going to do now? Switching to Windows? If it helps I'll print the startup output here...

            • 3. Re: 5 minutes to start - normal??

              No, i didn't say that, its better you post yr stack trace of server.log available under server/default/log.
              It will have all the messages in it while starting up.
              Probably then some one can pin point whats happening.

              • 4. Re: 5 minutes to start - normal??
                tcn

                This time it took "only" 213 seconds which I probably due the fact that it did not startup clearly...

                Unfortunately server.log is with 11MByte (!) to big to upload, here's the console output:

                # ./run.sh
                ================================================================================

                JBoss Bootstrap Environment

                JBOSS_HOME: /opt/jboss

                JAVA: /usr/local/java/j2sdk/bin/java

                JAVA_OPTS: -server -Dprogram.name=run.sh

                CLASSPATH: /opt/jboss/bin/run.jar:/usr/local/java/j2sdk/lib/tools.jar

                ================================================================================

                /usr/local/java/j2sdk/bin/java
                -server -Dprogram.name=run.sh
                09:46:54,800 INFO [Server] Starting JBoss (MX MicroKernel)...
                09:46:54,819 INFO [Server] Release ID: JBoss [Matrix2] 4.0.0DR2 (build: CVSTag=JBoss_4_0_0_DR2 date=200307030107)
                09:46:54,940 INFO [Server] Home Dir: /opt/jboss-4.0.0DR2
                09:46:54,946 INFO [Server] Home URL: file:/opt/jboss-4.0.0DR2/
                09:46:54,950 INFO [Server] Library URL: file:/opt/jboss-4.0.0DR2/lib/
                09:46:54,961 INFO [Server] Patch URL: null
                09:46:54,962 INFO [Server] Server Name: default
                09:46:54,963 INFO [Server] Server Home Dir: /opt/jboss-4.0.0DR2/server/default
                09:46:54,964 INFO [Server] Server Home URL: file:/opt/jboss-4.0.0DR2/server/default/
                09:46:54,965 INFO [Server] Server Data Dir: /opt/jboss-4.0.0DR2/server/default/data
                09:46:54,966 INFO [Server] Server Temp Dir: /opt/jboss-4.0.0DR2/server/default/tmp
                09:46:54,967 INFO [Server] Server Config URL: file:/opt/jboss-4.0.0DR2/server/default/conf/
                09:46:54,968 INFO [Server] Server Library URL: file:/opt/jboss-4.0.0DR2/server/default/lib/
                09:46:54,969 INFO [Server] Root Deployemnt Filename: jboss-service.xml
                09:46:55,068 INFO [Server] Starting General Purpose Architecture (GPA)...
                09:46:57,227 INFO [ServerInfo] Java version: 1.4.2_01,Sun Microsystems Inc.
                09:46:57,228 INFO [ServerInfo] Java VM: Java HotSpot(TM) Server VM 1.4.2_01-b06,Sun Microsystems Inc.
                09:46:57,229 INFO [ServerInfo] OS-System: Linux 2.4.20-tcn,i386
                09:46:57,687 INFO [ServiceController] Controller MBean online
                09:46:58,244 INFO [MainDeployer] Started jboss.system:service=MainDeployer
                09:46:58,897 INFO [JARDeployer] Started jboss.system:service=JARDeployer
                09:46:59,432 INFO [SARDeployer] Started jboss.system:service=ServiceDeployer
                09:46:59,433 INFO [Server] Core system initialized
                09:46:59,594 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/conf/jboss-service.xml
                09:47:18,494 INFO [Log4jService$URLWatchTimerTask] Configuring from URL: resource:log4j.xml
                09:47:24,338 INFO [AbstractDeploymentScanner$ScannerThread] Running
                09:47:24,443 INFO [AspectManagerService] Started jboss.aop:service=AspectManager
                09:47:26,526 INFO [AspectDeployer] Started jboss.aop:service=AspectDeployer
                09:47:28,524 INFO [Log4jService] Started jboss.system:type=Log4jService,service=Logging
                09:47:32,260 INFO [LocalJBossServerDomain] Started jboss.management.local:j2eeType=J2EEDomain,name=Manager
                09:47:33,257 INFO [NamingService] Starting jnp server
                09:47:33,917 INFO [NamingService] Started jnpPort=1099, rmiPort=0, backlog=50, bindAddress=null, Client SocketFactory=null, Server SocketFactory=null
                09:47:34,120 INFO [NamingService] Listening on port 1099
                09:47:34,227 INFO [NamingService] Started jboss:service=Naming
                09:47:34,837 INFO [JNDIView] Started jboss:service=JNDIView
                09:47:35,374 INFO [ScheduleManager] Started jboss:service=EJBTimerManager
                09:47:35,510 INFO [FilePersistenceManager] Using data directory: /opt/jboss-4.0.0DR2/server/default/data
                09:47:35,516 INFO [FilePersistenceManager] Started jboss:service=TimePersistenceManager,type=File
                09:47:35,518 INFO [SchedulerTimerSource] Started jboss:service=EJBTimerService
                09:47:37,788 INFO [SecurityConfig] Started jboss.security:service=SecurityConfig
                09:47:39,277 INFO [XMLLoginConfig] Started jboss.security:service=XMLLoginConfig
                09:47:39,939 INFO [JaasSecurityManagerService] Started jboss.security:service=JaasSecurityManager
                09:47:40,344 INFO [EARDeployer] Started jboss.j2ee:service=EARDeployer
                09:47:40,803 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/console-mgr.sar
                09:47:42,088 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/console-mgr.sar
                09:47:42,099 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/
                09:48:08,889 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jboss-net.war/
                09:48:08,900 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jmx-net.wsr/
                09:48:09,213 INFO [AxisService] About to deploy axis descriptor { 'jmx-net.wsr' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jmx-net.wsr/' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jmx-net.wsr/' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jmx-net.wsr/META-INF/web-service.xml' SubDeployer: org.jboss.net.axis.server.AxisService@db3331 }, create step.
                09:48:09,216 INFO [AxisService] About to deploy axis descriptor { 'jmx-net.wsr' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jmx-net.wsr/' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jmx-net.wsr/' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jmx-net.wsr/META-INF/web-service.xml' SubDeployer: org.jboss.net.axis.server.AxisService@db3331 }, start step.
                09:48:09,636 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jmx-net.wsr/
                09:48:09,637 INFO [AxisService] Started jboss.net:service=Axis
                09:48:09,777 INFO [Adaptor] Started jboss.net:service=Adaptor
                09:48:10,444 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/
                09:48:10,446 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/
                09:48:12,341 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/commons-logging.jar
                09:48:12,419 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/commons-logging.jar
                09:48:12,428 INFO [MainDeployer] Package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/commons-logging.jar is already deployed
                09:48:12,684 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/tomcat-coyote.jar
                09:48:12,796 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/tomcat-coyote.jar
                09:48:12,797 INFO [MainDeployer] Package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/tomcat-coyote.jar is already deployed
                09:48:15,536 INFO [MainDeployer] Package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/commons-logging.jar is already deployed
                09:48:16,383 INFO [MainDeployer] Package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/tomcat-coyote.jar is already deployed
                09:48:20,406 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossweb.sar/
                09:48:20,409 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossdo.sar
                09:48:21,751 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jboss-net.war/
                09:48:21,753 INFO [JDODeployer] Started jboss.jbossdo:service=JDODeployer
                09:48:21,803 INFO [JDOEnhancer] Started jboss.jbossdo:service=JDOEnhancer
                09:48:21,989 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossdo.sar
                09:48:21,995 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-connector-server.sar
                09:48:22,316 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-connector-server.sar
                09:48:22,318 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-rmi-adaptor.sar
                09:48:22,776 INFO [RMIAdaptorService] Started jboss.jmx:type=Connector,name=RMI
                09:48:23,260 INFO [PluginManager] Started jboss.admin:service=PluginManager
                09:48:23,279 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-rmi-adaptor.sar
                09:48:23,287 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-jca.sar
                09:48:27,588 INFO [CachedConnectionManager] Started jboss.jca:service=CachedConnectionManager
                09:48:30,578 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jboss-net.war/
                09:48:30,581 INFO [RARDeployer] Started jboss.jca:service=RARClassesDeployer
                09:48:31,191 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jboss-net.war/
                09:48:31,194 INFO [XSLSubDeployer] Started jboss.jca:service=DataSourceDeployer
                09:48:31,327 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jboss-net.war/
                09:48:31,329 INFO [XSLSubDeployer] Started jboss.jca:service=RARDeployer
                09:48:31,636 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-jca.sar
                09:48:31,639 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/object-copier.sar
                09:48:32,068 INFO [ObjectCopier] Started jboss:service=ObjectCopier
                09:48:32,154 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/object-copier.sar
                09:48:32,156 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-local-jdbc.rar
                09:48:32,899 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-local-jdbc.rar
                09:48:32,907 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-xa-jdbc.rar
                09:48:33,687 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-xa-jdbc.rar
                09:48:33,689 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jms-ra.rar
                09:48:34,335 INFO [JavaBeanPropertyTypeURIResolver] Resolve called with href: jboss-jbpt://org.jboss.resource.adapter.jms.JmsActivationSpec, base: null
                09:48:34,530 INFO [JavaBeanPropertyTypeURIResolver] attributeName: Password
                09:48:34,531 INFO [JavaBeanPropertyTypeURIResolver] attributeName: Password
                09:48:34,533 INFO [JavaBeanPropertyTypeURIResolver] attributeName: ResourceAdapter
                09:48:34,534 INFO [JavaBeanPropertyTypeURIResolver] attributeName: ResourceAdapter
                09:48:34,534 INFO [JavaBeanPropertyTypeURIResolver] attributeName: Destination
                09:48:34,535 INFO [JavaBeanPropertyTypeURIResolver] attributeName: Destination
                09:48:34,607 INFO [JavaBeanPropertyTypeURIResolver] attributeName: DestinationType
                09:48:34,607 INFO [JavaBeanPropertyTypeURIResolver] attributeName: DestinationType
                09:48:34,608 INFO [JavaBeanPropertyTypeURIResolver] attributeName: ConnectionFactory
                09:48:34,609 INFO [JavaBeanPropertyTypeURIResolver] attributeName: ConnectionFactory
                09:48:34,610 INFO [JavaBeanPropertyTypeURIResolver] attributeName: UserName
                09:48:34,610 INFO [JavaBeanPropertyTypeURIResolver] attributeName: UserName
                09:48:34,616 INFO [JavaBeanPropertyTypeURIResolver] attributeName: ClientId
                09:48:34,617 INFO [JavaBeanPropertyTypeURIResolver] attributeName: ClientId
                09:48:34,618 INFO [JavaBeanPropertyTypeURIResolver] attributeName: MessageSelector
                09:48:34,619 INFO [JavaBeanPropertyTypeURIResolver] attributeName: MessageSelector
                09:48:34,619 INFO [JavaBeanPropertyTypeURIResolver] attributeName: AcknowledgeMode
                09:48:34,620 INFO [JavaBeanPropertyTypeURIResolver] attributeName: AcknowledgeMode
                09:48:34,623 INFO [JavaBeanPropertyTypeURIResolver] attributeName: SubscriptionName
                09:48:34,624 INFO [JavaBeanPropertyTypeURIResolver] attributeName: SubscriptionName
                09:48:34,624 INFO [JavaBeanPropertyTypeURIResolver] attributeName: SubscriptionDurability
                09:48:34,625 INFO [JavaBeanPropertyTypeURIResolver] attributeName: SubscriptionDurability
                09:48:34,626 INFO [JavaBeanPropertyTypeURIResolver] attributeName: Class
                09:48:34,810 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jms-ra.rar
                09:48:34,818 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/hsqldb-ds.xml
                09:48:34,964 INFO [DeploymentInfoURIResolverFactory$DeploymentInfoURIResolver] xpath is ra-xmbean-dds/outbound-adapters/connectionfactory-interface/mbean
                09:48:36,718 INFO [JBossManagedConnectionPool] Started jboss.jca:service=ManagedConnectionPool,name=DefaultDS
                09:48:36,785 INFO [HypersonicDatabase] Started jboss:service=Hypersonic
                09:48:36,792 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/hsqldb-ds.xml
                09:48:36,795 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jms-ds.xml
                09:48:36,956 INFO [STDOUT] server.properties not found, using command line or default properties
                09:48:36,957 INFO [STDOUT] Opening database: /opt/jboss-4.0.0DR2/server/default/data/hypersonic/default
                09:48:36,958 INFO [STDOUT] HSQLDB server 1.7.1 is running
                09:48:36,959 INFO [STDOUT] Use SHUTDOWN to close normally. Use [Ctrl]+[C] to abort abruptly
                09:48:38,828 INFO [DeploymentInfoURIResolverFactory$DeploymentInfoURIResolver] xpath is ra-xmbean-dds/resource-adapter/mbean
                09:48:38,919 INFO [DeploymentInfoURIResolverFactory$DeploymentInfoURIResolver] xpath is ra-xmbean-dds/resource-adapter/mbean
                09:48:39,056 INFO [DeploymentInfoURIResolverFactory$DeploymentInfoURIResolver] xpath is ra-xmbean-dds/outbound-adapters/connectionfactory-interface/mbean[../@connectionfactory-interface=''|count(/ra-xmbean-dds/outbound-adapters/connectionfactory-interface/mbean)=1]
                09:48:39,196 INFO [DeploymentInfoURIResolverFactory$DeploymentInfoURIResolver] xpath is ra-xmbean-dds/outbound-adapters/connectionfactory-interface/mbean[../@connectionfactory-interface=''|count(/ra-xmbean-dds/outbound-adapters/connectionfactory-interface/mbean)=1]
                09:48:40,657 INFO [JMSProviderLoader] Bound adapter to java:/DefaultJMSProvider
                09:48:40,658 INFO [JMSProviderLoader] Started jboss.mq:service=JMSProviderLoader,name=JBossMQProvider
                09:48:40,746 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jms-ds.xml
                09:48:40,749 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossmq-service.xml
                09:48:42,679 INFO [STDOUT] Wed Oct 01 09:48:42 CEST 2003 Listening for connections ...
                09:48:51,069 INFO [MessageCache] Started jboss.mq:service=MessageCache
                09:48:51,484 INFO [DynamicStateManager] Started jboss.mq:service=StateManager
                09:48:53,021 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossmq-service.xml
                09:48:53,025 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/hilo-idgen-service.xml
                09:48:54,128 INFO [HiLoIDGeneratorFactory] Started jboss.persistence:service=IDGeneratorFactory,type=HiLo
                09:48:54,209 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/hilo-idgen-service.xml
                09:48:54,219 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/mail-service.xml
                09:48:55,075 INFO [MailService] Mail Service bound to java:/Mail
                09:48:55,076 INFO [MailService] Started jboss:service=Mail
                09:48:55,170 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/mail-service.xml
                09:48:55,178 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/counter-service.xml
                09:48:55,347 INFO [CounterService] Started jboss:service=Counter
                09:48:55,455 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/counter-service.xml
                09:48:55,457 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/remoting-service.xml
                09:48:57,237 INFO [InvokerRegistry] Failed to load soap remoting transport: javax/xml/rpc/ServiceException
                09:48:57,765 INFO [BlockingServer] Remoting 'async' protocol available at: /0.0.0.0:8085
                09:48:57,766 INFO [BlockingServer] Remoting 'async' protocol clients will connect to: InvokerLocator [async://127.0.0.2/?compression=-1&tcp.nodelay=true]
                09:48:58,279 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/remoting-service.xml
                09:48:58,286 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/mbean-info-db-service.xml
                09:48:58,560 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/mbean-info-db-service.xml
                09:48:58,568 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossmq-destinations-service.xml
                09:49:01,645 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jbossmq-destinations-service.xml
                09:49:01,649 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-service.xml
                09:49:02,740 INFO [WebService] Started WebServer with address: 127.0.0.2:8083
                09:49:02,838 INFO [WebService] Using RMI server codebase: http://tcn:8083/
                09:49:02,839 INFO [WebService] Started jboss:service=WebService
                09:49:03,749 INFO [LocalInvoker] Started jboss:service=invoker,type=local
                09:49:04,017 INFO [EJBSubsystemInvocationHandler] Started jboss.ejb:service=RemotingToEJBAdapter
                09:49:04,673 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-service.xml
                09:49:04,678 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/user-service.xml
                09:49:04,858 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/user-service.xml
                09:49:04,867 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/transaction-service.xml
                09:49:12,355 INFO [NoLogTxLogger] Started jboss.tm:service=NoLogTxLogger
                09:49:12,936 INFO [LoggingTxLogger] Started jboss.tm:service=TxLogger
                09:49:13,054 INFO [JBossXidFactory] Started jboss.tm:service=XidFactory
                09:49:13,237 INFO [TransactionManagerService] Started jboss.tm:service=TransactionManagerService
                09:49:13,495 INFO [DTXATerminatorServerInvocationHandler] Started jboss.tm:service=XATerminatorServerInvocationHandler,subsystem=DTM
                09:49:13,497 INFO [DTXAWorkServerInterceptor] Started jboss.tm:service=XAWorkInterceptor
                09:49:13,508 INFO [UserTransactionImpl] TransactionManagerName is : jboss.tm:service=TransactionManagerService
                09:49:13,646 INFO [UserTransactionImpl] Started jboss.tm:service=UserTransaction
                09:49:14,340 INFO [DTXAResourceInterceptor] Started jboss.tm:service=DTXAResourceInterceptor
                09:49:14,345 INFO [RemotingAdapter] Started jboss.ejb:service=RemotingAdapter
                09:49:18,709 INFO [STDOUT] Apache Tomcat/4.1.24-LE-jdk14
                09:49:21,758 INFO [Http11Protocol] Initializing Coyote HTTP/1.1 on port 8080
                09:49:22,184 INFO [Http11Protocol] Starting Coyote HTTP/1.1 on port 8080
                09:49:23,230 WARN [JkMain] No properties file found /opt/jboss-4.0.0DR2/server/conf/jk2.properties
                09:49:23,350 INFO [ChannelSocket] JK2: ajp13 listening on /0.0.0.0:8009
                09:49:23,446 INFO [JkMain] Jk running ID=0 time=5/212 config=null
                09:49:23,449 INFO [EmbeddedCatalinaService41] OK
                09:49:23,453 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jboss-net.war/
                09:49:24,499 INFO [EmbeddedCatalinaService41] deploy, ctxPath=/jboss-net, warUrl=file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jboss-net.war/
                09:49:31,488 INFO [Engine] ContextConfig[/jboss-net]: Added certificates -> request attribute Valve
                09:49:32,778 INFO [Engine] ContextConfig[/jboss-net]: Configured an authenticator for method BASIC
                09:49:33,067 WARN [EmbeddedCatalinaService41] Unable to invoke setDelegate on class loader:java.net.FactoryURLClassLoader@1e45e3
                09:49:33,068 INFO [Engine] StandardManager[/jboss-net]: Seeding random number generator class java.security.SecureRandom
                09:49:33,073 INFO [Engine] StandardManager[/jboss-net]: Seeding of random number generator has been completed
                09:49:33,226 INFO [Engine] StandardWrapper[/jboss-net:default]: Loading container servlet default
                09:49:33,580 INFO [Engine] StandardWrapper[/jboss-net:invoker]: Loading container servlet invoker
                09:49:36,059 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jboss-net.sar/jboss-net.war/
                09:49:36,061 INFO [EmbeddedCatalinaService41] Started jboss.web:service=WebServer
                09:49:36,066 INFO [BaseWorkManager] Started jboss.jca:service=BaseWorkManager
                09:49:36,067 INFO [BaseBootstrapContext] Started jboss.jca:service=BaseBootstrapContext
                09:49:36,070 INFO [JmsResourceAdapter] Starting
                09:49:36,077 INFO [JmsResourceAdapter] Started
                09:49:36,088 INFO [JBossManagedConnectionPool] Started jboss.jca:service=ManagedConnectionPool,name=JmsXA
                09:49:36,228 INFO [JaasSecurityManagerService] Created securityMgr=org.jboss.security.plugins.JaasSecurityManager@13d4c49
                09:49:36,310 INFO [JaasSecurityManagerService] setCachePolicy, c=org.jboss.util.TimedCachePolicy@1f2bc83
                09:49:36,316 INFO [JaasSecurityManagerService] Added JmsXARealm, org.jboss.security.plugins.SecurityDomainContext@1364ee5 to map
                09:49:36,427 INFO [JmsXA] Bound connection factory for resource adapter for ConnectionManager 'jboss.jca:service=TxCM,name=JmsXA to JNDI name 'java:/JmsXA'
                09:49:36,429 INFO [TxConnectionManager] Started jboss.jca:service=TxCM,name=JmsXA
                09:49:36,595 INFO [JaasSecurityManagerService] Created securityMgr=org.jboss.security.plugins.JaasSecurityManager@f51766
                09:49:36,597 INFO [JaasSecurityManagerService] setCachePolicy, c=org.jboss.util.TimedCachePolicy@d35f5f
                09:49:36,598 INFO [JaasSecurityManagerService] Added HsqlDbRealm, org.jboss.security.plugins.SecurityDomainContext@11a700a to map
                09:49:36,697 INFO [DefaultDS] Bound connection factory for resource adapter for ConnectionManager 'jboss.jca:service=LocalTxCM,name=DefaultDS to JNDI name 'java:/DefaultDS'
                09:49:36,699 INFO [TxConnectionManager] Started jboss.jca:service=LocalTxCM,name=DefaultDS
                09:49:37,956 INFO [PersistenceManager] Started jboss.mq:service=PersistenceManager
                09:49:38,117 INFO [DestinationManager] Started jboss.mq:service=DestinationManager
                09:49:38,287 INFO [D] Bound to JNDI name: queue/D
                09:49:38,289 INFO [D] Started jboss.mq.destination:service=Queue,name=D
                09:49:38,354 INFO [C] Bound to JNDI name: queue/C
                09:49:38,355 INFO [C] Started jboss.mq.destination:service=Queue,name=C
                09:49:38,961 INFO [B] Bound to JNDI name: queue/B
                09:49:38,962 INFO [B] Started jboss.mq.destination:service=Queue,name=B
                09:49:38,967 INFO [A] Bound to JNDI name: queue/A
                09:49:38,968 INFO [A] Started jboss.mq.destination:service=Queue,name=A
                09:49:39,047 INFO [ex] Bound to JNDI name: queue/ex
                09:49:39,048 INFO [ex] Started jboss.mq.destination:service=Queue,name=ex
                09:49:39,113 INFO [testObjectMessage] Bound to JNDI name: queue/testObjectMessage
                09:49:39,114 INFO [testObjectMessage] Started jboss.mq.destination:service=Queue,name=testObjectMessage
                09:49:39,229 INFO [JaasSecurityManagerService] Created securityMgr=org.jboss.security.plugins.JaasSecurityManager@1104da7
                09:49:39,280 INFO [JaasSecurityManagerService] setCachePolicy, c=org.jboss.util.TimedCachePolicy@15a3a92
                09:49:39,286 INFO [JaasSecurityManagerService] Added jbossmq, org.jboss.security.plugins.SecurityDomainContext@bb5859 to map
                09:49:39,721 INFO [SecurityManager] Started jboss.mq:service=SecurityManager
                09:49:39,723 INFO [InterceptorLoader] Started jboss.mq:service=TracingInterceptor
                09:49:39,725 INFO [Invoker] Started jboss.mq:service=Invoker
                09:49:39,728 INFO [OIL2ServerILService] JBossMQ OIL2 service available at : 0.0.0.0/0.0.0.0:8092
                09:49:40,170 INFO [OIL2ServerILService] Started jboss.mq:service=InvocationLayer,type=OIL2
                09:49:40,588 INFO [RMIServerILService] Started jboss.mq:service=InvocationLayer,type=RMI
                09:49:40,668 INFO [JVMServerILService] Started jboss.mq:service=InvocationLayer,type=JVM
                09:49:40,670 INFO [OILServerILService] JBossMQ OIL service available at : 0.0.0.0/0.0.0.0:8090
                09:49:40,860 INFO [OILServerILService] Started jboss.mq:service=InvocationLayer,type=OIL
                09:49:40,863 INFO [UILServerILService] JBossMQ UIL service available at : 0.0.0.0/0.0.0.0:8093
                09:49:41,279 INFO [UILServerILService] Started jboss.mq:service=InvocationLayer,type=UIL2
                09:49:41,287 INFO [UILServerILService] JBossMQ UIL service available at : 0.0.0.0/0.0.0.0:8091
                09:49:41,388 INFO [UILServerILService] Started jboss.mq:service=InvocationLayer,type=UIL
                09:49:41,476 INFO [testDurableTopic] Bound to JNDI name: topic/testDurableTopic
                09:49:41,527 INFO [testDurableTopic] Started jboss.mq.destination:service=Topic,name=testDurableTopic
                09:49:41,674 INFO [DLQ] Bound to JNDI name: queue/DLQ
                09:49:41,675 INFO [DLQ] Started jboss.mq.destination:service=Queue,name=DLQ
                09:49:41,687 INFO [testQueue] Bound to JNDI name: queue/testQueue
                09:49:41,689 INFO [testQueue] Started jboss.mq.destination:service=Queue,name=testQueue
                09:49:41,765 INFO [testTopic] Bound to JNDI name: topic/testTopic
                09:49:41,766 INFO [testTopic] Started jboss.mq.destination:service=Topic,name=testTopic
                09:49:41,769 INFO [securedTopic] Bound to JNDI name: topic/securedTopic
                09:49:41,770 INFO [securedTopic] Started jboss.mq.destination:service=Topic,name=securedTopic
                09:49:43,894 INFO [UUID] org.juddi.uuidgen.className = org.juddi.uuidgen.JavaUUIDGen
                09:49:43,895 INFO [UUID] org.juddi.uuidgen.cacheSize = 20
                09:49:43,896 INFO [UUID] org.juddi.uuidgen.napTime: = 10000
                09:49:49,400 INFO [Auth] org.juddi.authenticator.className = org.jboss.net.uddi.server.JBossSecurityDomainAuthenticator
                09:49:49,559 INFO [JaasSecurityManagerService] Created securityMgr=org.jboss.security.plugins.JaasSecurityManager@104d976
                09:49:49,569 INFO [JaasSecurityManagerService] setCachePolicy, c=org.jboss.util.TimedCachePolicy@161100c
                09:49:49,569 INFO [JaasSecurityManagerService] Added other, org.jboss.security.plugins.SecurityDomainContext@1649b1a to map
                09:49:49,694 INFO [UddiService] Started jboss.net:service=Uddi
                09:49:50,873 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/transaction-service.xml
                09:49:50,874 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/scheduler-service.xml
                09:49:51,393 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/scheduler-service.xml
                09:49:51,395 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/cache-invalidation-service.xml
                09:49:51,868 INFO [InvalidationManager] Starting Invalidation Manager jboss.cache:service=InvalidationManager
                09:49:51,958 INFO [InvalidationManager] Started jboss.cache:service=InvalidationManager
                09:49:52,048 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/cache-invalidation-service.xml
                09:49:52,050 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/schedule-manager-service.xml
                09:49:53,066 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/schedule-manager-service.xml
                09:49:53,068 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/properties-service.xml
                09:49:53,868 INFO [PropertyEditorManagerService] Started jboss:type=Service,name=PropertyEditorManager
                09:49:54,194 INFO [SystemPropertiesService] Started jboss:type=Service,name=SystemProperties
                09:49:54,360 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/properties-service.xml
                09:49:54,366 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar
                09:49:55,357 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar
                09:49:55,415 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/web-console.war
                09:49:55,417 ERROR [MainDeployer] Could not make local copy for file:/opt/jboss-4.0.0DR2/server/default/deploy/web-console.war
                java.io.FileNotFoundException: /opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/web-console.war/61.web-console.war (Is a directory)
                at java.io.FileOutputStream.open(Native Method)
                at java.io.FileOutputStream.(FileOutputStream.java:179)
                at java.io.FileOutputStream.(FileOutputStream.java:131)
                at org.jboss.deployment.MainDeployer.copy(MainDeployer.java:1147)
                at org.jboss.deployment.MainDeployer.makeLocalCopy(MainDeployer.java:1101)
                at org.jboss.deployment.MainDeployer.init(MainDeployer.java:630)
                at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:582)
                at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:558)
                at sun.reflect.GeneratedMethodAccessor23.invoke(Unknown Source)
                at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
                at java.lang.reflect.Method.invoke(Method.java:324)
                at org.jboss.mx.server.ReflectedDispatcher.dispatch(ReflectedDispatcher.java:72)
                at org.jboss.mx.server.Invocation.dispatch(Invocation.java:45)
                at org.jboss.mx.server.Invocation.invoke(Invocation.java:70)
                at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:155)
                at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:544)
                at org.jboss.util.jmx.MBeanProxy.invoke(MBeanProxy.java:172)
                at $Proxy9.deploy(Unknown Source)
                at org.jboss.deployment.scanner.URLDeploymentScanner.deploy(URLDeploymentScanner.java:405)
                at org.jboss.deployment.scanner.URLDeploymentScanner.scan(URLDeploymentScanner.java:529)
                at org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread.doScan(AbstractDeploymentScanner.java:200)
                at org.jboss.deployment.scanner.AbstractDeploymentScanner.startService(AbstractDeploymentScanner.java:273)
                at org.jboss.system.ServiceMBeanSupport.start(ServiceMBeanSupport.java:233)
                at sun.reflect.GeneratedMethodAccessor6.invoke(Unknown Source)
                at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
                at java.lang.reflect.Method.invoke(Method.java:324)
                at org.jboss.mx.server.ReflectedDispatcher.dispatch(ReflectedDispatcher.java:72)
                at org.jboss.mx.server.Invocation.dispatch(Invocation.java:45)
                at org.jboss.mx.server.Invocation.invoke(Invocation.java:70)
                at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:155)
                at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:544)
                at org.jboss.system.ServiceController$ServiceProxy.invoke(ServiceController.java:1036)
                at $Proxy1.start(Unknown Source)
                at org.jboss.system.ServiceController.start(ServiceController.java:401)
                at sun.reflect.GeneratedMethodAccessor5.invoke(Unknown Source)
                at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
                at java.lang.reflect.Method.invoke(Method.java:324)
                at org.jboss.mx.server.ReflectedDispatcher.dispatch(ReflectedDispatcher.java:72)
                at org.jboss.mx.server.Invocation.dispatch(Invocation.java:45)
                at org.jboss.mx.server.Invocation.invoke(Invocation.java:70)
                at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:155)
                at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:544)
                at org.jboss.util.jmx.MBeanProxy.invoke(MBeanProxy.java:172)
                at $Proxy6.start(Unknown Source)
                at org.jboss.deployment.SARDeployer.start(SARDeployer.java:227)
                at org.jboss.deployment.DeploymentInfo.start(DeploymentInfo.java:255)
                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:324)
                at org.jboss.mx.server.ReflectedDispatcher.dispatch(ReflectedDispatcher.java:72)
                at org.jboss.mx.server.Invocation.dispatch(Invocation.java:45)
                at org.jboss.mx.server.Invocation.invoke(Invocation.java:70)
                at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:155)
                at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:544)
                at org.jboss.system.ServiceController$ServiceProxy.invoke(ServiceController.java:1036)
                at $Proxy1.start(Unknown Source)
                at org.jboss.system.ServiceController.start(ServiceController.java:401)
                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:324)
                at org.jboss.mx.server.ReflectedDispatcher.dispatch(ReflectedDispatcher.java:72)
                at org.jboss.mx.server.Invocation.dispatch(Invocation.java:45)
                at org.jboss.mx.server.Invocation.invoke(Invocation.java:70)
                at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:155)
                at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:544)
                at org.jboss.deployment.MainDeployer.start(MainDeployer.java:798)
                at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:594)
                at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:558)
                at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:542)
                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:324)
                at org.jboss.mx.server.ReflectedDispatcher.dispatch(ReflectedDispatcher.java:72)
                at org.jboss.mx.server.Invocation.dispatch(Invocation.java:45)
                at org.jboss.mx.server.Invocation.invoke(Invocation.java:70)
                at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:155)
                at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:544)
                at org.jboss.util.jmx.MBeanProxy.invoke(MBeanProxy.java:172)
                at $Proxy7.deploy(Unknown Source)
                at org.jboss.system.server.ServerImpl.doStart(ServerImpl.java:333)
                at org.jboss.system.server.ServerImpl.start(ServerImpl.java:241)
                at org.jboss.Main.boot(Main.java:165)
                at org.jboss.Main$1.run(Main.java:403)
                at java.lang.Thread.run(Thread.java:534)
                09:49:57,998 INFO [EmbeddedCatalinaService41] deploy, ctxPath=/web-console, warUrl=file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/web-console.war/61.web-console.war/
                09:50:03,375 INFO [Engine] ContextConfig[/web-console]: Added certificates -> request attribute Valve
                09:50:04,180 WARN [EmbeddedCatalinaService41] Unable to invoke setDelegate on class loader:java.net.FactoryURLClassLoader@c9537b
                09:50:04,187 INFO [Engine] StandardManager[/web-console]: Seeding random number generator class java.security.SecureRandom
                09:50:04,189 INFO [Engine] StandardManager[/web-console]: Seeding of random number generator has been completed
                09:50:06,326 INFO [Engine] StandardWrapper[/web-console:default]: Loading container servlet default
                09:50:06,900 INFO [Engine] StandardWrapper[/web-console:invoker]: Loading container servlet invoker
                09:50:09,970 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/web-console.war
                09:50:09,980 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-console.war/
                09:50:10,348 INFO [EmbeddedCatalinaService41] deploy, ctxPath=/jmx-console, warUrl=file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-console.war/
                09:50:13,006 INFO [Engine] ContextConfig[/jmx-console]: Added certificates -> request attribute Valve
                09:50:13,124 WARN [EmbeddedCatalinaService41] Unable to invoke setDelegate on class loader:java.net.FactoryURLClassLoader@f9748f
                09:50:13,125 INFO [Engine] StandardManager[/jmx-console]: Seeding random number generator class java.security.SecureRandom
                09:50:13,127 INFO [Engine] StandardManager[/jmx-console]: Seeding of random number generator has been completed
                09:50:13,135 INFO [Engine] StandardWrapper[/jmx-console:default]: Loading container servlet default
                09:50:13,137 INFO [Engine] StandardWrapper[/jmx-console:invoker]: Loading container servlet invoker
                09:50:14,438 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-console.war/
                09:50:14,447 ERROR [URLDeploymentScanner] MBeanException: Incomplete Deployment listing:
                Packages waiting for a deployer:
                [{ 'ejb-management.jar' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/ejb-management.jar/59.ejb-management.jar' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar' SubDeployer: null }, { 'jmx-ejb-adaptor.jar' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/jmx-ejb-adaptor.jar/60.jmx-ejb-adaptor.jar' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar' SubDeployer: null }]
                Incompletely deployed packages:
                [{ 'ejb-management.jar' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/ejb-management.jar/59.ejb-management.jar' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar' SubDeployer: null }, { 'jmx-ejb-adaptor.jar' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/jmx-ejb-adaptor.jar/60.jmx-ejb-adaptor.jar' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar' SubDeployer: null }]
                MBeans waiting for classes:

                MBeans waiting for other MBeans:

                { objectName: jboss.system:service=DeploymentInfoURIResolver
                state: CREATED
                Waiting for me:
                jboss.net:service=WS4EEDeployer state: CREATED
                } org.jboss.system.ServiceContext@fd645de3,


                { objectName: jboss.net:service=WS4EEDeployer
                state: CREATED
                I am waiting for:
                jboss.net:service=WebServiceEntityResolver state: RUNNING,
                jboss.system:service=DeploymentInfoURIResolver state: CREATED,
                jboss.net:service=Axis state: RUNNING
                Waiting for me:
                jboss.ejb:service=EJBDeployer state: CREATED
                } org.jboss.system.ServiceContext@118ae5d0,


                { objectName: jboss.ejb:service=EJBDeployer
                state: CREATED
                I am waiting for:
                jboss.net:service=WS4EEDeployer state: CREATED,
                jboss:service=WebService state: RUNNING,
                jboss.tm:service=TransactionManagerService state: RUNNING
                Waiting for me:
                jboss.ejb:service=ActivationSpecDeployer state: CREATED
                } org.jboss.system.ServiceContext@17342155,


                { objectName: jboss.ejb:service=ActivationSpecDeployer
                state: CREATED
                I am waiting for:
                jboss.ejb:service=EJBEntityResolver state: RUNNING,
                jboss.jca:service=RaURIResolver state: RUNNING,
                jboss.ejb:service=EJBDeployer state: CREATED
                } org.jboss.system.ServiceContext@aaac0461,


                Cause: Incomplete Deployment listing:
                Packages waiting for a deployer:
                [{ 'ejb-management.jar' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/ejb-management.jar/59.ejb-management.jar' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar' SubDeployer: null }, { 'jmx-ejb-adaptor.jar' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/jmx-ejb-adaptor.jar/60.jmx-ejb-adaptor.jar' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar' SubDeployer: null }]
                Incompletely deployed packages:
                [{ 'ejb-management.jar' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/ejb-management.jar/59.ejb-management.jar' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar' SubDeployer: null }, { 'jmx-ejb-adaptor.jar' URL: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar' localURL: 'file:/opt/jboss-4.0.0DR2/server/default/tmp/deploy/server/default/deploy/jmx-ejb-adaptor.jar/60.jmx-ejb-adaptor.jar' watching: 'file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar' SubDeployer: null }]
                MBeans waiting for classes:

                MBeans waiting for other MBeans:

                { objectName: jboss.system:service=DeploymentInfoURIResolver
                state: CREATED
                Waiting for me:
                jboss.net:service=WS4EEDeployer state: CREATED
                } org.jboss.system.ServiceContext@fd645de3,


                { objectName: jboss.net:service=WS4EEDeployer
                state: CREATED
                I am waiting for:
                jboss.net:service=WebServiceEntityResolver state: RUNNING,
                jboss.system:service=DeploymentInfoURIResolver state: CREATED,
                jboss.net:service=Axis state: RUNNING
                Waiting for me:
                jboss.ejb:service=EJBDeployer state: CREATED
                } org.jboss.system.ServiceContext@118ae5d0,


                { objectName: jboss.ejb:service=EJBDeployer
                state: CREATED
                I am waiting for:
                jboss.net:service=WS4EEDeployer state: CREATED,
                jboss:service=WebService state: RUNNING,
                jboss.tm:service=TransactionManagerService state: RUNNING
                Waiting for me:
                jboss.ejb:service=ActivationSpecDeployer state: CREATED
                } org.jboss.system.ServiceContext@17342155,


                { objectName: jboss.ejb:service=ActivationSpecDeployer
                state: CREATED
                I am waiting for:
                jboss.ejb:service=EJBEntityResolver state: RUNNING,
                jboss.jca:service=RaURIResolver state: RUNNING,
                jboss.ejb:service=EJBDeployer state: CREATED
                } org.jboss.system.ServiceContext@aaac0461,


                09:50:14,564 INFO [URLDeploymentScanner] Started jboss.deployment:type=DeploymentScanner,flavor=URL
                09:50:15,055 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar
                09:50:15,058 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar
                09:50:15,066 INFO [WS4EEDeployer] Started jboss.net:service=WS4EEDeployer
                09:50:15,149 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar
                09:50:19,748 INFO [EjbModule] Deploying MEJB
                09:50:21,388 INFO [EjbModule] Started jboss.j2ee:module=ejb-management.jar,service=EjbModule
                09:50:21,399 INFO [TxInterceptorCMT] Setting TxSupport map for container: org.jboss.ejb.StatelessSessionContainer@f23491
                09:50:26,214 INFO [StatelessSessionInstancePool] Started null
                09:50:26,215 INFO [StatelessSessionContainer] Started jboss.j2ee:jndiName=ejb/mgmt/MEJB,service=EJB
                09:50:26,284 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/ejb-management.jar
                09:50:26,285 INFO [MainDeployer] Starting deployment of package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar
                09:50:27,700 INFO [EjbModule] Deploying jmx/ejb/Adaptor
                09:50:27,846 INFO [EjbModule] Started jboss.j2ee:module=jmx-ejb-adaptor.jar,service=EjbModule
                09:50:28,073 INFO [TxInterceptorCMT] Setting TxSupport map for container: org.jboss.ejb.StatelessSessionContainer@5f634c
                09:50:28,264 INFO [StatelessSessionInstancePool] Started null
                09:50:28,265 INFO [StatelessSessionContainer] Started jboss.j2ee:jndiName=ejb/jmx/ejb/Adaptor,service=EJB
                09:50:28,302 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/deploy/jmx-ejb-adaptor.jar
                09:50:28,304 INFO [EJBDeployer] Started jboss.ejb:service=EJBDeployer
                09:50:28,306 INFO [XSLSubDeployer] Started jboss.ejb:service=ActivationSpecDeployer
                09:50:28,503 INFO [MainDeployer] Deployed package: file:/opt/jboss-4.0.0DR2/server/default/conf/jboss-service.xml
                09:50:28,510 INFO [Server] JBoss started in 213s:439ms

                • 5. Re: 5 minutes to start - normal??
                  fbiaggi

                  Hi,
                  seem to be a directory authority problem.
                  Hope this helps.
                  Ciao.

                  • 6. Re: 5 minutes to start - normal??
                    tcn

                    Well, I started jboss as root - there should not authority problems at all.

                    But in any event it does not explain why jboss starts up so slowly :-(

                    • 7. Re: 5 minutes to start - normal??
                      tsg26

                      Hi ,

                      your jboss does not start up cleanly , that explain why you took so long to boot up , try deleting all the work file under jboss directory jboss/default/tmp and jboss/work and see whether it helps . Remember to temporary remove any user ear file under deploy directory before executing , malfunction ear would prolong the startup time too