=============================================================================== . JBoss Bootstrap Environment . JBOSS_HOME: C:\Java\jboss-4.0.4.GA\bin\\.. . JAVA: C:\Program Files\Java\jdk1.5.0_07\bin\java . JAVA_OPTS: -Dhttp.proxyHost= -Dhttp.proxyPort= -Dhttp.nonProxyHosts="localhost|127.0.0.1|colossus" -Dhttps.proxyHost= -Dhttps.proxyPort= -Dprogram.name=run.bat -Xms128m -Xmx512m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 . CLASSPATH: C:\Program Files\Java\jdk1.5.0_07\lib\tools.jar;C:\Java\jboss-4.0.4.GA\bin\\run.jar . =============================================================================== . 12:47:29,296 INFO [Server] Starting JBoss (MX MicroKernel)... 12:47:29,296 INFO [Server] Release ID: JBoss [Zion] 4.0.4.GA (build: CVSTag=JBoss_4_0_4_GA date=200605151000) 12:47:29,312 INFO [Server] Home Dir: C:\Java\jboss-4.0.4.GA 12:47:29,312 INFO [Server] Home URL: file:/C:/Java/jboss-4.0.4.GA/ 12:47:29,312 INFO [Server] Patch URL: null 12:47:29,312 INFO [Server] Server Name: default 12:47:29,312 INFO [Server] Server Home Dir: C:\Java\jboss-4.0.4.GA\server\default 12:47:29,312 INFO [Server] Server Home URL: file:/C:/Java/jboss-4.0.4.GA/server/default/ 12:47:29,750 INFO [Server] Server Log Dir: C:\Java\jboss-4.0.4.GA\server\default\log 12:47:29,750 INFO [Server] Server Temp Dir: C:\Java\jboss-4.0.4.GA\server\default\tmp 12:47:29,750 INFO [Server] Root Deployment Filename: jboss-service.xml 12:47:30,171 INFO [ServerInfo] Java version: 1.5.0_07,Sun Microsystems Inc. 12:47:30,171 INFO [ServerInfo] Java VM: Java HotSpot(TM) Client VM 1.5.0_07-b03,Sun Microsystems Inc. 12:47:30,171 INFO [ServerInfo] OS-System: Windows XP 5.1,x86 12:47:31,781 INFO [Server] Core system initialized 12:47:33,453 INFO [Log4jService$URLWatchTimerTask] Configuring from URL: resource:log4j.xml 12:47:35,109 INFO [SocketServerInvoker] Invoker started for locator: InvokerLocator [socket://192.168.1.2:3873/] 12:47:35,796 INFO [AspectDeployer] Deployed AOP: file:/C:/Java/jboss-4.0.4.GA/server/default/deploy/ejb3-interceptors-aop.xml 12:47:37,750 INFO [AspectDeployer] Deployed AOP: file:/C:/Java/jboss-4.0.4.GA/server/default/deploy/tc5-cluster.sar/tc5-cluster.aop 12:47:38,000 INFO [TreeCache] setting cluster properties from xml to: UDP(down_thread=false;enable_bundling=true;ip_ttl=2;loopback=false;max_bundle_size=64000;max_bundle_timeout=30;mcast_addr=230.1.2.7;mcast_port=45577;mcast_recv_buf_size=25000000;mcast_send_buf_size=640000;ucast_recv_buf_size=20000000;ucast_send_buf_size=640000;up_thread=false;use_incoming_packet_handler=true;use_outgoing_packet_handler=true):PING(down_thread=false;num_initial_members=3;timeout=2000;up_thread=false):MERGE2(down_thread=false;max_interval=100000;min_interval=20000;up_thread=false):FD(down_thread=false;max_tries=5;shun=true;timeout=2500;up_thread=false):VERIFY_SUSPECT(down_thread=false;timeout=1500;up_thread=false):pbcast.NAKACK(discard_delivered_msgs=true;down_thread=false;gc_lag=50;max_xmit_size=60000;retransmit_timeout=100,200,300,600,1200,2400,4800;up_thread=false;use_mcast_xmit=false):UNICAST(down_thread=false;timeout=300,600,1200,2400,3600;up_thread=false):pbcast.STABLE(desired_avg_gossip=50000;down_thread=false;max_bytes=2100000;stability_delay=1000;up_thread=false):pbcast.GMS(down_thread=false;join_retry_timeout=2000;join_timeout=3000;print_local_addr=true;shun=true;up_thread=false):FC(down_thread=false;max_credits=10000000;min_threshold=0.20;up_thread=false):FRAG2(down_thread=false;frag_size=60000;up_thread=false):pbcast.STATE_TRANSFER(down_thread=false;up_thread=false) 12:47:38,843 INFO [WebService] Using RMI server codebase: http://colossus:8083/ 12:47:39,140 INFO [TreeCache] setting cluster properties from xml to: UDP(ip_mcast=true;ip_ttl=64;loopback=false;mcast_addr=228.1.2.3;mcast_port=45551;mcast_recv_buf_size=80000;mcast_send_buf_size=150000;ucast_recv_buf_size=80000;ucast_send_buf_size=150000):PING(down_thread=false;num_initial_members=3;timeout=2000;up_thread=false):MERGE2(max_interval=20000;min_interval=10000):FD(down_thread=true;shun=true;up_thread=true):VERIFY_SUSPECT(down_thread=false;timeout=1500;up_thread=false):pbcast.NAKACK(down_thread=false;gc_lag=50;max_xmit_size=8192;retransmit_timeout=600,1200,2400,4800;up_thread=false):UNICAST(down_thread=false;min_threshold=10;timeout=600,1200,2400;window_size=100):pbcast.STABLE(desired_avg_gossip=20000;down_thread=false;up_thread=false):FRAG(down_thread=false;frag_size=8192;up_thread=false):pbcast.GMS(join_retry_timeout=2000;join_timeout=5000;print_local_addr=true;shun=true):pbcast.STATE_TRANSFER(down_thread=false;up_thread=false) 12:47:39,312 INFO [TreeCache] setEvictionPolicyConfig(): [config: null] 12:47:39,328 WARN [TreeCache] No transaction manager lookup class has been defined. Transactions cannot be used 12:47:39,359 INFO [TreeCache] interceptor chain is: class org.jboss.cache.interceptors.CallInterceptor class org.jboss.cache.interceptors.PessimisticLockInterceptor class org.jboss.cache.interceptors.CacheLoaderInterceptor class org.jboss.cache.interceptors.UnlockInterceptor class org.jboss.cache.interceptors.ReplicationInterceptor class org.jboss.cache.interceptors.CacheStoreInterceptor 12:47:39,796 INFO [TreeCache] cache mode is REPL_SYNC 12:47:40,265 INFO [STDOUT] ------------------------------------------------------- GMS: address is colossus:4529 ------------------------------------------------------- 12:47:42,312 INFO [TreeCache] my local address is colossus:4529 12:47:42,312 INFO [TreeCache] viewAccepted(): [colossus:4529|0] [colossus:4529] 12:47:42,312 INFO [TreeCache] state could not be retrieved (must be first member in group) 12:47:42,312 INFO [TreeCache] new cache is null (may be first member in cluster) 12:47:42,312 INFO [LRUPolicy] Starting eviction policy using the provider: org.jboss.ejb3.cache.tree.StatefulEvictionPolicy 12:47:42,312 INFO [LRUPolicy] Starting a eviction timer with wake up interval of (secs) 1 12:47:42,796 INFO [TreeCache] Cache is started!! 12:47:42,875 INFO [TreeCache] setting cluster properties from xml to: UDP(ip_mcast=true;ip_ttl=2;loopback=false;mcast_addr=228.1.2.3;mcast_port=43333;mcast_recv_buf_size=80000;mcast_send_buf_size=150000;ucast_recv_buf_size=80000;ucast_send_buf_size=150000):PING(down_thread=false;num_initial_members=3;timeout=2000;up_thread=false):MERGE2(max_interval=20000;min_interval=10000):FD(down_thread=true;shun=true;up_thread=true):VERIFY_SUSPECT(down_thread=false;timeout=1500;up_thread=false):pbcast.NAKACK(down_thread=false;gc_lag=50;max_xmit_size=8192;retransmit_timeout=600,1200,2400,4800;up_thread=false):UNICAST(down_thread=false;min_threshold=10;timeout=600,1200,2400;window_size=100):pbcast.STABLE(desired_avg_gossip=20000;down_thread=false;up_thread=false):FRAG(down_thread=false;frag_size=8192;up_thread=false):pbcast.GMS(join_retry_timeout=2000;join_timeout=5000;print_local_addr=true;shun=true):pbcast.STATE_TRANSFER(down_thread=false;up_thread=false) 12:47:43,312 INFO [TreeCache] setEvictionPolicyConfig(): [config: null] 12:47:45,140 INFO [MailService] Mail Service bound to java:/Mail 12:47:45,296 INFO [DefaultPartition] Initializing 12:47:45,437 INFO [TreeCache] interceptor chain is: class org.jboss.cache.interceptors.CallInterceptor class org.jboss.cache.interceptors.PessimisticLockInterceptor class org.jboss.cache.interceptors.UnlockInterceptor class org.jboss.cache.interceptors.ReplicationInterceptor 12:47:45,437 INFO [TreeCache] cache mode is REPL_ASYNC 12:47:45,484 INFO [TreeCache] interceptor chain is: class org.jboss.cache.interceptors.CallInterceptor class org.jboss.cache.interceptors.PessimisticLockInterceptor class org.jboss.cache.interceptors.UnlockInterceptor class org.jboss.cache.interceptors.ReplicationInterceptor 12:47:45,796 INFO [TreeCache] cache mode is REPL_SYNC 12:47:46,109 INFO [NamingService] JNDI bootstrap JNP=/0.0.0.0:1099, RMI=/0.0.0.0:1098, backlog=50, no client SocketFactory, Server SocketFactory=class org.jboss.net.sockets.DefaultSocketFactory 12:47:46,125 INFO [SubscriptionManager] Bound event dispatcher to java:/EventDispatcher 12:47:46,156 INFO [STDOUT] ------------------------------------------------------- GMS: address is colossus:4534 (additional data: 16 bytes) ------------------------------------------------------- 12:47:48,312 INFO [DefaultPartition] Number of cluster members: 1 12:47:48,312 INFO [DefaultPartition] Other members: 0 12:47:48,312 INFO [DefaultPartition] Fetching state (will wait for 30000 milliseconds): 12:47:48,312 INFO [DefaultPartition] New cluster view for partition DefaultPartition (id: 0, delta: 0) : [192.168.1.2:1099] 12:47:48,312 INFO [DefaultPartition] I am (192.168.1.2:1099) received membershipChanged event: 12:47:48,312 INFO [DefaultPartition] Dead members: 0 ([]) 12:47:48,312 INFO [DefaultPartition] New Members : 0 ([]) 12:47:48,796 INFO [DefaultPartition] All Members : 1 ([192.168.1.2:1099]) 12:47:48,890 INFO [HANamingService] Started ha-jndi bootstrap jnpPort=1100, backlog=50, bindAddress=/0.0.0.0 12:47:48,906 INFO [DetachedHANamingService$AutomaticDiscovery] Listening on 0.0.0.0/0.0.0.0:1102, group=230.0.0.4, HA-JNDI address=192.168.1.2:1100 12:47:49,078 INFO [STDOUT] ------------------------------------------------------- GMS: address is colossus:4536 ------------------------------------------------------- 12:47:51,078 INFO [TreeCache] viewAccepted(): [colossus:4536|0] [colossus:4536] 12:47:51,078 INFO [TreeCache] my local address is colossus:4536 12:47:51,078 INFO [TreeCache] state could not be retrieved (must be first member in group) 12:47:51,078 INFO [TreeCache] new cache is null (may be first member in cluster) 12:47:51,078 INFO [TreeCache] Cache is started!! 12:47:51,140 INFO [STDOUT] ------------------------------------------------------- GMS: address is colossus:4538 ------------------------------------------------------- 12:47:53,312 INFO [TreeCache] my local address is colossus:4538 12:47:53,312 INFO [TreeCache] state could not be retrieved (must be first member in group) 12:47:53,312 INFO [LRUPolicy] Starting eviction policy using the provider: org.jboss.cache.eviction.LRUPolicy 12:47:53,312 INFO [LRUPolicy] Starting a eviction timer with wake up interval of (secs) 5 12:47:53,312 INFO [TreeCache] viewAccepted(): [colossus:4538|0] [colossus:4538] 12:47:53,312 INFO [TreeCache] new cache is null (may be first member in cluster) 12:47:53,312 INFO [TreeCache] Cache is started!! 12:47:53,875 INFO [Embedded] Catalina naming disabled 12:47:53,953 INFO [ClusterRuleSetFactory] Unable to find a cluster rule set in the classpath. Will load the default rule set. 12:47:53,953 INFO [ClusterRuleSetFactory] Unable to find a cluster rule set in the classpath. Will load the default rule set. 12:47:54,546 INFO [Http11BaseProtocol] Initializing Coyote HTTP/1.1 on http-0.0.0.0-8080 12:47:54,546 INFO [Catalina] Initialization processed in 593 ms 12:47:54,546 INFO [StandardService] Starting service jboss.web 12:47:54,562 INFO [StandardEngine] Starting Servlet Engine: Apache Tomcat/5.5.17 12:47:54,609 INFO [StandardHost] XML validation disabled 12:47:54,625 INFO [Catalina] Server startup in 79 ms 12:47:54,781 INFO [TomcatDeployer] deploy, ctxPath=/, warUrl=.../deploy/jbossweb-tomcat55.sar/ROOT.war/ 12:47:55,250 INFO [WebappLoader] Dual registration of jndi stream handler: factory already defined 12:47:55,718 INFO [TomcatDeployer] deploy, ctxPath=/jbossws, warUrl=.../tmp/deploy/tmp25385jbossws-exp.war/ 12:47:56,203 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-local-jdbc.rar 12:47:56,421 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jms/jms-ra.rar 12:47:56,515 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/quartz-ra.rar 12:47:56,531 INFO [QuartzResourceAdapter] start quartz!!! 12:47:56,625 INFO [SimpleThreadPool] Job execution threads will use class loader of thread: main 12:47:56,656 INFO [QuartzScheduler] Quartz Scheduler v.1.5.2 created. 12:47:56,656 INFO [RAMJobStore] RAMJobStore initialized. 12:47:56,828 INFO [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties' 12:47:56,828 INFO [StdSchedulerFactory] Quartz scheduler version: 1.5.2 12:47:56,828 INFO [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started. 12:47:58,218 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS' 12:47:58,578 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA' 12:47:58,703 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=PostgresDS' to JNDI name 'java:PostgresDS' 12:47:59,062 INFO [A] Bound to JNDI name: queue/A 12:47:59,062 INFO [B] Bound to JNDI name: queue/B 12:47:59,062 INFO [C] Bound to JNDI name: queue/C 12:47:59,078 INFO [D] Bound to JNDI name: queue/D 12:47:59,078 INFO [ex] Bound to JNDI name: queue/ex 12:47:59,078 INFO [MyQueue] Bound to JNDI name: queue/MyQueue 12:47:59,109 INFO [testTopic] Bound to JNDI name: topic/testTopic 12:47:59,109 INFO [securedTopic] Bound to JNDI name: topic/securedTopic 12:47:59,125 INFO [testDurableTopic] Bound to JNDI name: topic/testDurableTopic 12:47:59,343 INFO [testQueue] Bound to JNDI name: queue/testQueue 12:47:59,375 INFO [UILServerILService] JBossMQ UIL service available at : /0.0.0.0:8093 12:47:59,453 INFO [DLQ] Bound to JNDI name: queue/DLQ 12:47:59,484 INFO [TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/ 12:47:59,687 INFO [EARDeployer] Init J2EE application: file:/C:/Java/jboss-4.0.4.GA/server/default/deploy/TestApp.ear 12:48:00,375 INFO [Ejb3Deployment] EJB3 deployment time took: 438 12:48:00,546 WARN [EndpointMetaData] Cannot obtain style, using default: document 12:48:01,609 INFO [TomcatDeployer] deploy, ctxPath=/TestApp-ejb, warUrl=.../tmp/deploy/TestApp.ear-TestApp-ejb.jar-ws25421.war/ 12:48:01,734 INFO [JmxKernelAbstraction] installing MBean: persistence.units:ear=TestApp.ear,jar=TestApp-ejb.jar,unitName=TestApp with dependencies: 12:48:01,734 INFO [JmxKernelAbstraction] jboss.jca:name=PostgresDS,service=ManagedConnectionFactory 12:48:01,781 INFO [Version] Hibernate EntityManager 3.2.0.CR1 12:48:01,812 INFO [Version] Hibernate Annotations 3.2.0.CR1 12:48:01,812 INFO [Environment] Hibernate 3.2 cr2 12:48:01,843 INFO [Environment] hibernate.properties not found 12:48:01,859 INFO [Environment] Bytecode provider name : javassist 12:48:01,859 INFO [Environment] using JDK 1.4 java.sql.Timestamp handling 12:48:02,093 INFO [Ejb3Configuration] found EJB3 Entity bean: tutorial.MultiplyUsage 12:48:02,109 INFO [Ejb3Configuration] found EJB3 Entity bean: tutorial.Person 12:48:02,109 WARN [Ejb3Configuration] Persistence provider caller does not implements the EJB3 spec correctly. PersistenceUnitInfo.getNewTempClassLoader() is null. 12:48:02,468 INFO [Configuration] Reading mappings from resource: META-INF/orm.xml 12:48:02,468 INFO [Ejb3Configuration] [PersistenceUnit: TestApp] no META-INF/orm.xml found 12:48:02,562 INFO [AnnotationBinder] Binding entity from annotated class: tutorial.MultiplyUsage 12:48:02,578 INFO [QueryBinder] Binding Named query: findAllUsages => SELECT m FROM MultiplyUsage m 12:48:02,640 INFO [EntityBinder] Bind entity tutorial.MultiplyUsage on table MultiplyUsage 12:48:02,718 INFO [AnnotationBinder] Binding entity from annotated class: tutorial.Person 12:48:02,843 INFO [EntityBinder] Bind entity tutorial.Person on table Person 12:48:03,078 INFO [ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider 12:48:03,093 INFO [InjectedDataSourceConnectionProvider] Using provided datasource 12:48:03,109 INFO [SettingsFactory] RDBMS: PostgreSQL, version: 8.0.3 12:48:03,109 INFO [SettingsFactory] JDBC driver: PostgreSQL Native Driver, version: PostgreSQL 8.0 JDBC3 with SSL (build 317) 12:48:03,156 INFO [Dialect] Using dialect: org.hibernate.dialect.PostgreSQLDialect 12:48:03,359 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory 12:48:03,375 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 12:48:03,375 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 12:48:03,375 INFO [SettingsFactory] Automatic flush during beforeCompletion(): disabled 12:48:03,375 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 12:48:03,843 INFO [SettingsFactory] JDBC batch size: 15 12:48:03,843 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 12:48:03,843 INFO [SettingsFactory] Scrollable result sets: enabled 12:48:03,843 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 12:48:03,843 INFO [SettingsFactory] Connection release mode: auto 12:48:03,843 INFO [SettingsFactory] Default batch fetch size: 1 12:48:03,859 INFO [SettingsFactory] Generate SQL with comments: disabled 12:48:03,859 INFO [SettingsFactory] Order SQL updates by primary key: disabled 12:48:03,859 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 12:48:03,859 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 12:48:03,859 INFO [SettingsFactory] Query language substitutions: {} 12:48:03,859 INFO [SettingsFactory] Second-level cache: enabled 12:48:03,859 INFO [SettingsFactory] Query cache: disabled 12:48:03,859 INFO [SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider 12:48:03,875 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 12:48:03,875 INFO [SettingsFactory] Structured second-level cache entries: disabled 12:48:03,906 INFO [SettingsFactory] Statistics: disabled 12:48:03,906 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 12:48:03,906 INFO [SettingsFactory] Default entity-mode: pojo 12:48:03,968 INFO [SessionFactoryImpl] building session factory 12:48:04,343 INFO [SessionFactoryObjectFactory] Not binding factory to JNDI, no JNDI name configured 12:48:04,390 INFO [SchemaExport] Running hbm2ddl schema export 12:48:04,390 INFO [SchemaExport] exporting generated schema to database 12:48:04,468 INFO [SchemaExport] schema export complete 12:48:04,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} 12:48:05,203 INFO [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=TestApp.ear,jar=TestApp-ejb.jar,name=CalculatorBean,service=EJB3 with dependencies: 12:48:05,484 INFO [EJBContainer] STARTED EJB: tutorial.CalculatorBean ejbName: CalculatorBean 12:48:05,531 INFO [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=TestApp.ear,jar=TestApp-ejb.jar,name=MultiplyBean,service=EJB3 with dependencies: 12:48:05,531 INFO [JmxKernelAbstraction] persistence.units:ear=TestApp.ear,jar=TestApp-ejb.jar,unitName=TestApp 12:48:05,578 INFO [EJBContainer] STARTED EJB: tutorial.MultiplyBean ejbName: MultiplyBean 12:48:05,609 INFO [EJB3Deployer] Deployed: file:/C:/Java/jboss-4.0.4.GA/server/default/tmp/deploy/tmp25418TestApp.ear-contents/TestApp-ejb.jar 12:48:05,921 INFO [WSDLFilePublisher] WSDL published to: file:/C:/Java/jboss-4.0.4.GA/server/default/data/wsdl/TestApp.ear/TestApp-ejb.jar/MultiplyBeanService25419.wsdl 12:48:06,109 INFO [ServiceEndpointManager] WebService started: http://colossus:8080/TestApp-ejb/MultiplyBean 12:48:06,109 INFO [TomcatDeployer] deploy, ctxPath=/TestApp, warUrl=.../tmp/deploy/tmp25418TestApp.ear-contents/TestApp-war-exp.war/ 12:48:06,250 INFO [EARDeployer] Started J2EE application: file:/C:/Java/jboss-4.0.4.GA/server/default/deploy/TestApp.ear 12:48:06,437 INFO [Http11BaseProtocol] Starting Coyote HTTP/1.1 on http-0.0.0.0-8080 12:48:06,593 INFO [ChannelSocket] JK: ajp13 listening on /0.0.0.0:8009 12:48:06,609 INFO [JkMain] Jk running ID=0 time=0/78 config=null 12:48:06,625 INFO [Server] JBoss (MX MicroKernel) [4.0.4.GA (build: CVSTag=JBoss_4_0_4_GA date=200605151000)] Started in 36s:875ms