4 Replies Latest reply on Oct 25, 2009 10:04 PM by Stuart Douglas

    Application starts, then stops, then tries to start ...

    Donald Hook Newbie
      I created a new application using seam gen and Seam 2.2.0.  The application starts, then stops right away, then tries to restart.  This cycle continues until I kill the server. 

      I am not sure what would cause this and appreciate any insight.  The startup log is listed below.

      20:34:54,343 INFO  [ServerImpl] Starting JBoss (Microcontainer)...
      20:34:54,343 INFO  [ServerImpl] Release ID: JBoss [The Oracle] 5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)
      20:34:54,343 INFO  [ServerImpl] Bootstrap URL: null
      20:34:54,343 INFO  [ServerImpl] Home Dir: E:\jboss-5.1.0.GA
      20:34:54,343 INFO  [ServerImpl] Home URL: file:/E:/jboss-5.1.0.GA/
      20:34:54,343 INFO  [ServerImpl] Library URL: file:/E:/jboss-5.1.0.GA/lib/
      20:34:54,343 INFO  [ServerImpl] Patch URL: null
      20:34:54,359 INFO  [ServerImpl] Common Base URL: file:/E:/jboss-5.1.0.GA/common/
      20:34:54,359 INFO  [ServerImpl] Common Library URL: file:/E:/jboss-5.1.0.GA/common/lib/
      20:34:54,359 INFO  [ServerImpl] Server Name: default
      20:34:54,359 INFO  [ServerImpl] Server Base Dir: E:\jboss-5.1.0.GA\server
      20:34:54,359 INFO  [ServerImpl] Server Base URL: file:/E:/jboss-5.1.0.GA/server/
      20:34:54,359 INFO  [ServerImpl] Server Config URL: file:/E:/jboss-5.1.0.GA/server/default/conf/
      20:34:54,359 INFO  [ServerImpl] Server Home Dir: E:\jboss-5.1.0.GA\server\default
      20:34:54,359 INFO  [ServerImpl] Server Home URL: file:/E:/jboss-5.1.0.GA/server/default/
      20:34:54,359 INFO  [ServerImpl] Server Data Dir: E:\jboss-5.1.0.GA\server\default\data
      20:34:54,359 INFO  [ServerImpl] Server Library URL: file:/E:/jboss-5.1.0.GA/server/default/lib/
      20:34:54,359 INFO  [ServerImpl] Server Log Dir: E:\jboss-5.1.0.GA\server\default\log
      20:34:54,375 INFO  [ServerImpl] Server Native Dir: E:\jboss-5.1.0.GA\server\default\tmp\native
      20:34:54,375 INFO  [ServerImpl] Server Temp Dir: E:\jboss-5.1.0.GA\server\default\tmp
      20:34:54,375 INFO  [ServerImpl] Server Temp Deploy Dir: E:\jboss-5.1.0.GA\server\default\tmp\deploy
      20:34:55,156 INFO  [ServerImpl] Starting Microcontainer, bootstrapURL=file:/E:/jboss-5.1.0.GA/server/default/conf/bootstrap.xml
      20:34:55,750 INFO  [VFSCacheFactory] Initializing VFSCache [org.jboss.virtual.plugins.cache.CombinedVFSCache]
      20:34:55,750 INFO  [VFSCacheFactory] Using VFSCache [CombinedVFSCache[real-cache: null]]
      20:34:56,046 INFO  [CopyMechanism] VFS temp dir: E:\jboss-5.1.0.GA\server\default\tmp
      20:34:56,140 INFO  [ZipEntryContext] VFS force nested jars copy-mode is enabled.
      20:34:57,046 INFO  [ServerInfo] Java version: 1.6.0_10-rc,Sun Microsystems Inc.
      20:34:57,046 INFO  [ServerInfo] Java Runtime: Java(TM) SE Runtime Environment (build 1.6.0_10-rc-b28)
      20:34:57,046 INFO  [ServerInfo] Java VM: Java HotSpot(TM) Client VM 11.0-b15,Sun Microsystems Inc.
      20:34:57,046 INFO  [ServerInfo] OS-System: Windows XP 5.1,x86
      20:34:57,046 INFO  [ServerInfo] VM arguments: -Dprogram.name=JBossTools JBoss 5.0 Runtime -Xms256m -Xmx512m -XX:MaxPermSize=256m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Djava.endorsed.dirs=E:\jboss-5.1.0.GA\lib\endorsed -Dfile.encoding=Cp1252
      20:34:57,093 INFO  [JMXKernel] Legacy JMX core initialized
      20:34:58,656 INFO  [ProfileServiceBootstrap] Loading profile: ProfileKey@e8fdc9[domain=default, server=default, name=default]
      20:35:00,296 INFO  [WebService] Using RMI server codebase: http://localhost:8083/
      20:35:05,546 INFO  [NativeServerConfig] JBoss Web Services - Stack Native Core
      20:35:05,546 INFO  [NativeServerConfig] 3.1.2.GA
      20:35:06,515 INFO  [AttributeCallbackItem] Owner callback not implemented.
      20:35:08,218 INFO  [LogNotificationListener] Adding notification listener for logging mbean "jboss.system:service=Logging,type=Log4jService" to server org.jboss.mx.server.MBeanServerImpl@1b493c6[ defaultDomain='jboss' ]
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@3484646{vfsfile:/E:/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@3484646{vfsfile:/E:/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@3484646{vfsfile:/E:/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@3484646{vfsfile:/E:/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@11722055{vfsfile:/E:/jboss-5.1.0.GA/server/default/deploy/DDH.ear/DDH.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@11722055{vfsfile:/E:/jboss-5.1.0.GA/server/default/deploy/DDH.ear/DDH.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@11722055{vfsfile:/E:/jboss-5.1.0.GA/server/default/deploy/DDH.ear/DDH.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@11722055{vfsfile:/E:/jboss-5.1.0.GA/server/default/deploy/DDH.ear/DDH.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@14513719{vfszip:/E:/jboss-5.1.0.GA/server/default/deploy/DDH.ear/jboss-seam.jar/}
      20:35:41,765 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@14513719{vfszip:/E:/jboss-5.1.0.GA/server/default/deploy/DDH.ear/jboss-seam.jar/}
      20:35:44,718 INFO  [JMXConnectorServerService] JMX Connector server: service:jmx:rmi://localhost/jndi/rmi://localhost:1090/jmxconnector
      20:35:44,890 INFO  [MailService] Mail Service bound to java:/Mail
      20:36:17,921 WARN  [JBossASSecurityMetadataStore] WARNING! POTENTIAL SECURITY RISK. It has been detected that the MessageSucker component which sucks messages from one node to another has not had its password changed from the installation default. Please see the JBoss Messaging user guide for instructions on how to do this.
      20:36:17,953 WARN  [AnnotationCreator] No ClassLoader provided, using TCCL: org.jboss.managed.api.annotation.ManagementComponent
      20:36:18,062 WARN  [AnnotationCreator] No ClassLoader provided, using TCCL: org.jboss.managed.api.annotation.ManagementComponent
      20:36:18,125 INFO  [TransactionManagerService] JBossTS Transaction Service (JTA version - tag:JBOSSTS_4_6_1_GA) - JBoss Inc.
      20:36:18,125 INFO  [TransactionManagerService] Setting up property manager MBean and JMX layer
      20:36:18,375 INFO  [TransactionManagerService] Initializing recovery manager
      20:36:18,734 INFO  [TransactionManagerService] Recovery manager configured
      20:36:18,734 INFO  [TransactionManagerService] Binding TransactionManager JNDI Reference
      20:36:18,765 INFO  [TransactionManagerService] Starting transaction recovery manager
      20:36:19,281 INFO  [AprLifecycleListener] The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: C:\Program Files\Java\jre6\bin;.;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;C:/Program Files/Java/jre6/bin/client;C:/Program Files/Java/jre6/bin;E:\php-5.2.9.1\;C:\oracle\ora92\bin;C:\Program Files\Oracle\jre\1.1.8\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\Common Files\GTK\2.0\bin;C:\Program Files\QuickTime\QTSystem;;C:\Program Files\MBTrading\MBT Navigator;c:\adobe\Flex Builder 3\sdks\3.0.0\bin;C:\Program Files\Microsoft SQL Server\80\Tools\Binn\;E:\php-5.2.9.1\ext;C:\Program Files\Microsoft SQL Server\100\Tools\Binn\;C:\Program Files\Microsoft SQL Server\100\DTS\Binn\;C:\Program Files\Microsoft SQL Server\100\Tools\Binn\VSShell\Common7\IDE\;E:\Microsoft Visual Studio 8.0\Common7\IDE\PrivateAssemblies\;C:\WINDOWS\system32\WindowsPowerShell\v1.0;C:\Program Files\QuickTime\QTSystem\
      20:36:19,343 INFO  [Http11Protocol] Initializing Coyote HTTP/1.1 on http-localhost%2F127.0.0.1-8080
      20:36:19,359 INFO  [AjpProtocol] Initializing Coyote AJP/1.3 on ajp-localhost%2F127.0.0.1-8009
      20:36:19,375 INFO  [StandardService] Starting service jboss.web
      20:36:19,375 INFO  [StandardEngine] Starting Servlet Engine: JBoss Web/2.1.3.GA
      20:36:19,484 INFO  [Catalina] Server startup in 123 ms
      20:36:19,531 INFO  [TomcatDeployment] deploy, ctxPath=/web-console
      20:36:21,359 INFO  [TomcatDeployment] deploy, ctxPath=/jbossws
      20:36:21,421 INFO  [TomcatDeployment] deploy, ctxPath=/invoker
      20:36:21,578 INFO  [RARDeployment] Required license terms exist, view vfszip:/E:/jboss-5.1.0.GA/server/default/deploy/jboss-local-jdbc.rar/META-INF/ra.xml
      20:36:21,593 INFO  [RARDeployment] Required license terms exist, view vfszip:/E:/jboss-5.1.0.GA/server/default/deploy/jboss-xa-jdbc.rar/META-INF/ra.xml
      20:36:21,625 INFO  [RARDeployment] Required license terms exist, view vfszip:/E:/jboss-5.1.0.GA/server/default/deploy/jms-ra.rar/META-INF/ra.xml
      20:36:21,671 INFO  [RARDeployment] Required license terms exist, view vfszip:/E:/jboss-5.1.0.GA/server/default/deploy/mail-ra.rar/META-INF/ra.xml
      20:36:21,687 INFO  [RARDeployment] Required license terms exist, view vfszip:/E:/jboss-5.1.0.GA/server/default/deploy/quartz-ra.rar/META-INF/ra.xml
      20:36:21,828 INFO  [SimpleThreadPool] Job execution threads will use class loader of thread: main
      20:36:21,859 INFO  [QuartzScheduler] Quartz Scheduler v.1.5.2 created.
      20:36:21,859 INFO  [RAMJobStore] RAMJobStore initialized.
      20:36:21,859 INFO  [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
      20:36:21,859 INFO  [StdSchedulerFactory] Quartz scheduler version: 1.5.2
      20:36:21,859 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
      20:36:22,031 INFO  [WrapperDataSourceService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DDHDatasource' to JNDI name 'DDHDatasource'
      20:36:22,640 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS'
      20:36:24,015 INFO  [ServerPeer] JBoss Messaging 1.4.3.GA server [0] started
      20:36:24,125 INFO  [QueueService] Queue[queue/QuoteQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      20:36:24,218 INFO  [ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
      20:36:24,218 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@1ba78ff started
      20:36:24,218 INFO  [QueueService] Queue[queue/MailQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      20:36:24,218 INFO  [ConnectionFactoryJNDIMapper] supportsFailover attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non clustered. So connection factory will *not* support failover
      20:36:24,218 INFO  [ConnectionFactoryJNDIMapper] supportsLoadBalancing attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non clustered. So connection factory will *not* support load balancing
      20:36:24,218 INFO  [ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
      20:36:24,218 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@1854ae8 started
      20:36:24,218 INFO  [ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
      20:36:24,218 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@16b47f started
      20:36:24,218 INFO  [QueueService] Queue[queue/BacktestQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      20:36:24,281 INFO  [QueueService] Queue[/queue/DLQ] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      20:36:24,281 INFO  [QueueService] Queue[/queue/ExpiryQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      20:36:24,375 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=restbayDatasource' to JNDI name 'java:restbayDatasource'
      20:36:24,453 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
      20:36:39,968 INFO  [JBossASKernel] Created KernelDeployment for: profileservice-secured.jar
      20:36:39,984 INFO  [JBossASKernel] installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3
      20:36:39,984 INFO  [JBossASKernel]   with dependencies:
      20:36:39,984 INFO  [JBossASKernel]   and demands:
      20:36:39,984 INFO  [JBossASKernel]      jndi:SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView
      20:36:39,984 INFO  [JBossASKernel]      jboss.ejb:service=EJBTimerService
      20:36:39,984 INFO  [JBossASKernel]   and supplies:
      20:36:39,984 INFO  [JBossASKernel]      Class:org.jboss.profileservice.spi.ProfileService
      20:36:39,984 INFO  [JBossASKernel]      jndi:SecureProfileService/remote
      20:36:39,984 INFO  [JBossASKernel]      jndi:SecureProfileService/remote-org.jboss.profileservice.spi.ProfileService
      20:36:39,984 INFO  [JBossASKernel] Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3) to KernelDeployment of: profileservice-secured.jar
      20:36:39,984 INFO  [JBossASKernel] installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3
      20:36:39,984 INFO  [JBossASKernel]   with dependencies:
      20:36:39,984 INFO  [JBossASKernel]   and demands:
      20:36:39,984 INFO  [JBossASKernel]      jboss.ejb:service=EJBTimerService
      20:36:39,984 INFO  [JBossASKernel]   and supplies:
      20:36:39,984 INFO  [JBossASKernel]      jndi:SecureDeploymentManager/remote-org.jboss.deployers.spi.management.deploy.DeploymentManager
      20:36:39,984 INFO  [JBossASKernel]      Class:org.jboss.deployers.spi.management.deploy.DeploymentManager
      20:36:39,984 INFO  [JBossASKernel]      jndi:SecureDeploymentManager/remote
      20:36:39,984 INFO  [JBossASKernel] Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3) to KernelDeployment of: profileservice-secured.jar
      20:36:39,984 INFO  [JBossASKernel] installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3
      20:36:39,984 INFO  [JBossASKernel]   with dependencies:
      20:36:39,984 INFO  [JBossASKernel]   and demands:
      20:36:39,984 INFO  [JBossASKernel]      jboss.ejb:service=EJBTimerService
      20:36:39,984 INFO  [JBossASKernel]   and supplies:
      20:36:39,984 INFO  [JBossASKernel]      jndi:SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView
      20:36:39,984 INFO  [JBossASKernel]      Class:org.jboss.deployers.spi.management.ManagementView
      20:36:39,984 INFO  [JBossASKernel]      jndi:SecureManagementView/remote
      20:36:39,984 INFO  [JBossASKernel] Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3) to KernelDeployment of: profileservice-secured.jar
      20:36:40,000 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@b04679{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      20:36:40,000 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@69e42a{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      20:36:40,000 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@6fa8ea{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      20:36:40,140 INFO  [SessionSpecContainer] Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3
      20:36:40,140 INFO  [EJBContainer] STARTED EJB: org.jboss.profileservice.ejb.SecureDeploymentManager ejbName: SecureDeploymentManager
      20:36:40,218 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

              SecureDeploymentManager/remote - EJB3.x Default Remote Business Interface
              SecureDeploymentManager/remote-org.jboss.deployers.spi.management.deploy.DeploymentManager - EJB3.x Remote Business Interface

      20:36:40,296 INFO  [SessionSpecContainer] Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3
      20:36:40,312 INFO  [EJBContainer] STARTED EJB: org.jboss.profileservice.ejb.SecureManagementView ejbName: SecureManagementView
      20:36:40,312 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

              SecureManagementView/remote - EJB3.x Default Remote Business Interface
              SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView - EJB3.x Remote Business Interface

      20:36:40,390 INFO  [SessionSpecContainer] Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3
      20:36:40,390 INFO  [EJBContainer] STARTED EJB: org.jboss.profileservice.ejb.SecureProfileServiceBean ejbName: SecureProfileService
      20:36:40,406 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

              SecureProfileService/remote - EJB3.x Default Remote Business Interface
              SecureProfileService/remote-org.jboss.profileservice.spi.ProfileService - EJB3.x Remote Business Interface

      20:36:40,640 INFO  [TomcatDeployment] deploy, ctxPath=/admin-console
      20:36:40,843 INFO  [config] Initializing Mojarra (1.2_12-b01-FCS) for context '/admin-console'
      20:36:45,062 INFO  [TomcatDeployment] deploy, ctxPath=/
      20:36:45,171 INFO  [TomcatDeployment] deploy, ctxPath=/jmx-console
      20:36:47,937 INFO  [JBossASKernel] Created KernelDeployment for: DDH.jar
      20:36:47,937 INFO  [JBossASKernel] installing bean: jboss.j2ee:ear=DDH.ear,jar=DDH.jar,name=AuthenticatorBean,service=EJB3
      20:36:47,937 INFO  [JBossASKernel]   with dependencies:
      20:36:47,937 INFO  [JBossASKernel]   and demands:
      20:36:47,937 INFO  [JBossASKernel]      jboss.ejb:service=EJBTimerService
      20:36:47,937 INFO  [JBossASKernel]      persistence.unit:unitName=DDH.ear/DDH.jar#DDH
      20:36:47,937 INFO  [JBossASKernel]   and supplies:
      20:36:47,937 INFO  [JBossASKernel]      Class:com.ddh.web.Authenticator
      20:36:47,937 INFO  [JBossASKernel]      jndi:DDH/AuthenticatorBean/local
      20:36:47,937 INFO  [JBossASKernel]      jndi:DDH/AuthenticatorBean/remote
      20:36:47,937 INFO  [JBossASKernel]      jndi:DDH/AuthenticatorBean/local-com.ddh.web.Authenticator
      20:36:47,937 INFO  [JBossASKernel] Added bean(jboss.j2ee:ear=DDH.ear,jar=DDH.jar,name=AuthenticatorBean,service=EJB3) to KernelDeployment of: DDH.jar
      20:36:47,984 WARN  [InjectInterceptorsFactory] WEIRDNESS IN AOP: advisor org.jboss.ejb3.aop.ExtendedManagedObjectAdvisor@1eaf1d1
      20:36:48,015 WARN  [InjectInterceptorsFactory] WEIRDNESS IN AOP: advisor org.jboss.ejb3.aop.ExtendedManagedObjectAdvisor@1eaf1d1
      20:36:48,015 WARN  [InjectInterceptorsFactory] WEIRDNESS IN AOP: advisor org.jboss.ejb3.aop.ExtendedManagedObjectAdvisor@1eaf1d1
      20:36:48,015 WARN  [InjectInterceptorsFactory] WEIRDNESS IN AOP: advisor org.jboss.ejb3.aop.ExtendedManagedObjectAdvisor@1eaf1d1
      20:36:48,312 INFO  [JBossASKernel] Created KernelDeployment for: jboss-seam.jar
      20:36:48,312 INFO  [JBossASKernel] installing bean: jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=TimerServiceDispatcher,service=EJB3
      20:36:48,312 INFO  [JBossASKernel]   with dependencies:
      20:36:48,312 INFO  [JBossASKernel]   and demands:
      20:36:48,312 INFO  [JBossASKernel]      jboss.ejb:service=EJBTimerService
      20:36:48,312 INFO  [JBossASKernel]   and supplies:
      20:36:48,312 INFO  [JBossASKernel]      Class:org.jboss.seam.async.LocalTimerServiceDispatcher
      20:36:48,312 INFO  [JBossASKernel]      jndi:DDH/TimerServiceDispatcher/local-org.jboss.seam.async.LocalTimerServiceDispatcher
      20:36:48,312 INFO  [JBossASKernel]      jndi:DDH/TimerServiceDispatcher/remote
      20:36:48,312 INFO  [JBossASKernel]      jndi:DDH/TimerServiceDispatcher/local
      20:36:48,312 INFO  [JBossASKernel] Added bean(jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=TimerServiceDispatcher,service=EJB3) to KernelDeployment of: jboss-seam.jar
      20:36:48,312 INFO  [JBossASKernel] installing bean: jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=EjbSynchronizations,service=EJB3
      20:36:48,312 INFO  [JBossASKernel]   with dependencies:
      20:36:48,312 INFO  [JBossASKernel]   and demands:
      20:36:48,312 INFO  [JBossASKernel]      jboss.ejb:service=EJBTimerService
      20:36:48,312 INFO  [JBossASKernel]   and supplies:
      20:36:48,312 INFO  [JBossASKernel]      jndi:DDH/EjbSynchronizations/local
      20:36:48,312 INFO  [JBossASKernel]      jndi:DDH/EjbSynchronizations/local-org.jboss.seam.transaction.LocalEjbSynchronizations
      20:36:48,312 INFO  [JBossASKernel]      jndi:DDH/EjbSynchronizations/remote
      20:36:48,312 INFO  [JBossASKernel]      Class:org.jboss.seam.transaction.LocalEjbSynchronizations
      20:36:48,312 INFO  [JBossASKernel] Added bean(jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=EjbSynchronizations,service=EJB3) to KernelDeployment of: jboss-seam.jar
      20:36:48,312 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@17f5d9{name=jboss.j2ee:ear=DDH.ear,jar=DDH.jar,name=AuthenticatorBean,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      20:36:48,328 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@1746661{name=jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=EjbSynchronizations,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      20:36:48,328 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@1abb12{name=jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=TimerServiceDispatcher,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      20:36:48,375 INFO  [PersistenceUnitDeployment] Starting persistence unit persistence.unit:unitName=DDH.ear/DDH.jar#DDH
      20:36:48,484 INFO  [Version] Hibernate Annotations 3.4.0.GA
      20:36:48,500 INFO  [Environment] Hibernate 3.3.1.GA
      20:36:48,531 INFO  [Environment] hibernate.properties not found
      20:36:48,531 INFO  [Environment] Bytecode provider name : javassist
      20:36:48,546 INFO  [Environment] using JDK 1.4 java.sql.Timestamp handling
      20:36:49,625 INFO  [Version] Hibernate Commons Annotations 3.1.0.GA
      20:36:49,640 INFO  [Version] Hibernate EntityManager 3.4.0.GA
      20:36:49,671 INFO  [Ejb3Configuration] Processing PersistenceUnitInfo [
              name: DDH
              ...]
      20:36:49,921 WARN  [Ejb3Configuration] Persistence provider caller does not implement the EJB3 spec correctly. PersistenceUnitInfo.getNewTempClassLoader() is null.
      20:36:50,375 INFO  [AnnotationBinder] Binding entity from annotated class: com.ddh.model.BackTestEntryTrigger
      ....
      20:36:50,968 INFO  [CollectionBinder] Mapping collection: com.ddh.model.EtfFundFamily.etfs -> etf
      20:36:51,000 INFO  [Version] Hibernate Validator 3.1.0.GA
      20:36:51,250 INFO  [HibernateSearchEventListenerRegister] Unable to find org.hibernate.search.event.FullTextIndexEventListener on the classpath. Hibernate Search is not enabled.
      20:36:51,359 INFO  [ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
      20:36:51,375 INFO  [InjectedDataSourceConnectionProvider] Using provided datasource
      20:36:51,578 INFO  [SettingsFactory] RDBMS: MySQL, version: 5.1.35-community
      20:36:51,578 INFO  [SettingsFactory] JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-5.0.3 ( $Date: 2006-07-26 17:26:47 +0200 (Wed, 26 Jul 2006) $, $Revision: 5553 $ )
      20:36:51,609 INFO  [Dialect] Using dialect: org.hibernate.dialect.MySQLDialect
      20:36:51,609 INFO  [TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
      20:36:51,625 INFO  [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
      20:36:51,625 INFO  [TransactionManagerLookupFactory] instantiated TransactionManagerLookup
      20:36:51,625 INFO  [SettingsFactory] Automatic flush during beforeCompletion(): disabled
      20:36:51,625 INFO  [SettingsFactory] Automatic session close at end of transaction: disabled
      20:36:51,625 INFO  [SettingsFactory] JDBC batch size: 15
      20:36:51,625 INFO  [SettingsFactory] JDBC batch updates for versioned data: disabled
      20:36:51,625 INFO  [SettingsFactory] Scrollable result sets: enabled
      20:36:51,625 INFO  [SettingsFactory] JDBC3 getGeneratedKeys(): enabled
      20:36:51,625 INFO  [SettingsFactory] Connection release mode: auto
      20:36:51,625 INFO  [SettingsFactory] Default catalog: DDH_Trading_System
      20:36:51,625 INFO  [SettingsFactory] Maximum outer join fetch depth: 2
      20:36:51,625 INFO  [SettingsFactory] Default batch fetch size: 1
      20:36:51,625 INFO  [SettingsFactory] Generate SQL with comments: disabled
      20:36:51,625 INFO  [SettingsFactory] Order SQL updates by primary key: disabled
      20:36:51,625 INFO  [SettingsFactory] Order SQL inserts for batching: disabled
      20:36:51,625 INFO  [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
      20:36:51,640 INFO  [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
      20:36:51,640 INFO  [SettingsFactory] Query language substitutions: {}
      20:36:51,640 INFO  [SettingsFactory] JPA-QL strict compliance: enabled
      20:36:51,640 INFO  [SettingsFactory] Second-level cache: enabled
      20:36:51,640 INFO  [SettingsFactory] Query cache: disabled
      20:36:51,640 INFO  [SettingsFactory] Cache region factory : org.hibernate.cache.impl.bridge.RegionFactoryCacheProviderBridge
      20:36:51,656 INFO  [RegionFactoryCacheProviderBridge] Cache provider: org.hibernate.cache.HashtableCacheProvider
      20:36:51,656 INFO  [SettingsFactory] Optimize cache for minimal puts: disabled
      20:36:51,656 INFO  [SettingsFactory] Cache region prefix: persistence.unit:unitName=DDH.ear/DDH.jar#DDH
      20:36:51,656 INFO  [SettingsFactory] Structured second-level cache entries: disabled
      20:36:51,656 INFO  [SettingsFactory] Echoing all SQL to stdout
      20:36:51,656 INFO  [SettingsFactory] Statistics: disabled
      20:36:51,656 INFO  [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
      20:36:51,656 INFO  [SettingsFactory] Default entity-mode: pojo
      20:36:51,656 INFO  [SettingsFactory] Named query checking : enabled
      20:36:51,812 INFO  [SessionFactoryImpl] building session factory
      20:36:53,421 INFO  [SessionFactoryObjectFactory] Factory name: persistence.unit:unitName=DDH.ear/DDH.jar#DDH
      20:36:53,421 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      20:36:53,468 INFO  [NamingHelper] Creating subcontext: persistence.unit:unitName=DDH.ear
      20:36:53,468 INFO  [SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.unit:unitName=DDH.ear/DDH.jar#DDH
      20:36:53,468 WARN  [SessionFactoryObjectFactory] InitialContext did not implement EventContext
      20:36:53,468 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      20:36:53,531 INFO  [SessionSpecContainer] Starting jboss.j2ee:ear=DDH.ear,jar=DDH.jar,name=AuthenticatorBean,service=EJB3
      20:36:53,531 INFO  [EJBContainer] STARTED EJB: com.ddh.web.bean.AuthenticatorBean ejbName: AuthenticatorBean
      20:36:53,546 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

              DDH/AuthenticatorBean/local - EJB3.x Default Local Business Interface
              DDH/AuthenticatorBean/local-com.ddh.web.Authenticator - EJB3.x Local Business Interface

      20:36:53,640 INFO  [SessionSpecContainer] Starting jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=TimerServiceDispatcher,service=EJB3
      20:36:53,640 INFO  [EJBContainer] STARTED EJB: org.jboss.seam.async.TimerServiceDispatcher ejbName: TimerServiceDispatcher
      20:36:53,656 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

              DDH/TimerServiceDispatcher/local - EJB3.x Default Local Business Interface
              DDH/TimerServiceDispatcher/local-org.jboss.seam.async.LocalTimerServiceDispatcher - EJB3.x Local Business Interface

      20:36:53,734 INFO  [SessionSpecContainer] Starting jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=EjbSynchronizations,service=EJB3
      20:36:53,734 INFO  [EJBContainer] STARTED EJB: org.jboss.seam.transaction.EjbSynchronizations ejbName: EjbSynchronizations
      20:36:53,765 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

              DDH/EjbSynchronizations/local - EJB3.x Default Local Business Interface
              DDH/EjbSynchronizations/local-org.jboss.seam.transaction.LocalEjbSynchronizations - EJB3.x Local Business Interface

      20:36:54,015 INFO  [TomcatDeployment] deploy, ctxPath=/DDH
      20:36:54,140 INFO  [config] Initializing Mojarra (1.2_12-b01-FCS) for context '/DDH'
      20:36:56,812 INFO  [ServletContextListener] Welcome to Seam 2.2.0.GA
      20:37:06,781 WARN  [PersistentPermissionResolver] no permission store available - please install a PermissionStore with the name 'org.jboss.seam.security.jpaPermissionStore' if persistent permissions are required.
      20:37:07,375 INFO  [Http11Protocol] Starting Coyote HTTP/1.1 on http-localhost%2F127.0.0.1-8080
      20:37:07,406 INFO  [AjpProtocol] Starting Coyote AJP/1.3 on ajp-localhost%2F127.0.0.1-8009
      20:37:07,406 INFO  [ServerImpl] JBoss (Microcontainer) [5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)] Started in 2m:13s:31ms
      20:37:19,281 INFO  [TomcatDeployment] undeploy, ctxPath=/DDH
      20:37:19,328 INFO  [SessionSpecContainer] Stopping jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=EjbSynchronizations,service=EJB3
      20:37:19,328 INFO  [EJBContainer] STOPPED EJB: org.jboss.seam.transaction.EjbSynchronizations ejbName: EjbSynchronizations
      20:37:19,375 INFO  [SessionSpecContainer] Stopping jboss.j2ee:ear=DDH.ear,jar=jboss-seam.jar,name=TimerServiceDispatcher,service=EJB3
      20:37:19,406 INFO  [EJBContainer] STOPPED EJB: org.jboss.seam.async.TimerServiceDispatcher ejbName: TimerServiceDispatcher
      20:37:19,453 INFO  [SessionSpecContainer] Stopping jboss.j2ee:ear=DDH.ear,jar=DDH.jar,name=AuthenticatorBean,service=EJB3
      20:37:19,468 INFO  [EJBContainer] STOPPED EJB: com.ddh.web.bean.AuthenticatorBean ejbName: AuthenticatorBean
      20:37:19,515 INFO  [PersistenceUnitDeployment] Stopping persistence unit persistence.unit:unitName=DDH.ear/DDH.jar#DDH
      20:37:19,515 INFO  [SessionFactoryImpl] closing
      20:37:19,515 INFO  [SessionFactoryObjectFactory] Unbinding factory from JNDI name: persistence.unit:unitName=DDH.ear/DDH.jar#DDH
      20:37:19,515 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      20:37:19,515 INFO  [SessionFactoryObjectFactory] Unbound factory from JNDI name: persistence.unit:unitName=DDH.ear/DDH.jar#DDH