Sep 17, 2010 2:03:25 PM com.sun.enterprise.admin.launcher.GFLauncherLogger info INFO: JVM invocation command line: /export/ha/jdk/bin/java -cp /export/jmscvs/glassfishv3/glassfish/modules/glassfish.jar -XX:+UnlockDiagnosticVMOptions -XX:MaxPermSize=192m -XX:NewRatio=2 -Xmx512m -javaagent:/export/jmscvs/glassfishv3/glassfish/lib/monitor/btrace-agent.jar=unsafe=true,noServer=true -server -Dosgi.shell.telnet.maxconn=1 -Djdbc.drivers=org.apache.derby.jdbc.ClientDriver -Dfelix.fileinstall.dir=/export/jmscvs/glassfishv3/glassfish/modules/autostart/ -Djavax.net.ssl.keyStore=/export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102/config/keystore.jks -Dosgi.shell.telnet.port=26667 -Djava.security.policy=/export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102/config/server.policy -Dfelix.fileinstall.log.level=3 -Dfelix.fileinstall.poll=5000 -Dcom.sun.aas.instanceRoot=/export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102 -Dcom.sun.enterprise.config.config_environment_factory_class=com.sun.enterprise.config.serverbeans.AppserverConfigEnvironmentFactory -Dosgi.shell.telnet.ip=127.0.0.1 -Djava.endorsed.dirs=/export/jmscvs/glassfishv3/glassfish/modules/endorsed:/export/jmscvs/glassfishv3/glassfish/lib/endorsed -Dcom.sun.aas.installRoot=/export/jmscvs/glassfishv3/glassfish -Dfelix.fileinstall.bundles.startTransient=true -Djava.ext.dirs=/export/ha/jdk/lib/ext:/export/ha/jdk/jre/lib/ext:/export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102/lib/ext -Dfelix.fileinstall.bundles.new.start=true -Djavax.net.ssl.trustStore=/export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102/config/cacerts.jks -Dcom.sun.enterprise.security.httpsOutboundKeyAlias=s1as -Djava.security.auth.login.config=/export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102/config/login.conf -DANTLR_USE_DIRECT_CLASS_LOADING=true -Djava.library.path=/export/jmscvs/glassfishv3/glassfish/lib:/export/ha/jdk/jre/lib/sparc/server:/export/ha/jdk/jre/lib/sparc:/export/ha/jdk/lib/sparc:/export/ha/jdk/jre/lib/sparc/client:/usr/jdk/packages/lib/sparc:/lib:/usr/lib com.sun.enterprise.glassfish.bootstrap.ASMain -asadmin-args --host,,,hat2k1,,,--port,,,4848,,,--secure=false,,,--terse=false,,,--echo=false,,,--interactive=false,,,start-local-instance,,,--verbose=false,,,--debug=false,,,--nosync=false,,,--node,,,agent1,,,instance102 -instancename instance102 -verbose false -debug false -asadmin-classpath /export/jmscvs/glassfishv3/glassfish/modules/admin-cli.jar -asadmin-classname com.sun.enterprise.admin.cli.AsadminMain -upgrade false -type INSTANCE -instancedir /export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102 -read-stdin true Sep 17, 2010 2:03:25 PM com.sun.enterprise.admin.launcher.GFLauncherLogger info INFO: Successfully launched in 110 msec. Sep 17, 2010 2:03:46 PM null INFO: Running GlassFish Version: GlassFish Server Open Source Edition 3.1-b20 (build 20) [#|2010-09-17T14:03:46.773-0700|INFO|glassfish3.1|javax.enterprise.system.core.com.sun.enterprise.server.logging|_ThreadID=15;_ThreadName=Thread-1;|This message was emitted before the logging service started:Total time to parse domain.xml: 708 milliseconds|#] [#|2010-09-17T14:03:49.114-0700|INFO|glassfish3.1|com.sun.grizzly.config.GrizzlyServiceListener|_ThreadID=15;_ThreadName=Thread-1;|Perform lazy SSL initialization for the listener 'http-listener-2'|#] [#|2010-09-17T14:03:49.339-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Grizzly Framework 1.9.19 started in: 38ms - bound to [0.0.0.0:24849]|#] [#|2010-09-17T14:03:49.339-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Grizzly Framework 1.9.19 started in: 666ms - bound to [0.0.0.0:28081]|#] [#|2010-09-17T14:03:49.339-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Grizzly Framework 1.9.19 started in: 88ms - bound to [0.0.0.0:28182]|#] [#|2010-09-17T14:03:49.853-0700|INFO|glassfish3.1|org.hibernate.validator.util.Version|_ThreadID=15;_ThreadName=Thread-1;|Hibernate Validator null|#] [#|2010-09-17T14:03:49.895-0700|INFO|glassfish3.1|org.hibernate.validator.engine.resolver.DefaultTraversableResolver|_ThreadID=15;_ThreadName=Thread-1;|Instantiated an instance of org.hibernate.validator.engine.resolver.JPATraversableResolver.|#] [#|2010-09-17T14:03:51.236-0700|INFO|glassfish3.1|org.glassfish.ha.store.spi.BackingStoreFactoryRegistry|_ThreadID=15;_ThreadName=Thread-1;|Registered org.glassfish.ha.store.adapter.cache.ShoalBackingStoreProxy for persistence-type = replicated in BackingStoreFactoryRegistry|#] [#|2010-09-17T14:03:51.244-0700|INFO|glassfish3.1|org.glassfish.ha.store.adapter.cache.ShoalBackingStoreProxy|_ThreadID=15;_ThreadName=Thread-1;|Registered SHOAL BackingStore Proxy with persistence-type = replicated|#] [#|2010-09-17T14:03:51.376-0700|CONFIG|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=15;_ThreadName=Thread-1;|clusterName=st-cluster clusterConfig=GlassFishConfigBean.com.sun.enterprise.config.serverbeans.Config|#] [#|2010-09-17T14:03:51.467-0700|CONFIG|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=15;_ThreadName=Thread-1;|processing cluster property name=GMS_LISTENER_PORT value= ${GMS_LISTENER_PORT-st-cluster}|#] [#|2010-09-17T14:03:51.467-0700|CONFIG|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=15;_ThreadName=Thread-1;|skipping cluster property name=GMS_LISTENER_PORT since value is unresolved symbolic token=${GMS_LISTENER_PORT-st-cluster}|#] [#|2010-09-17T14:03:51.468-0700|CONFIG|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=15;_ThreadName=Thread-1;|Printing all GMS properties: |#] [#|2010-09-17T14:03:52.075-0700|INFO|glassfish3.1|ShoalLogger|_ThreadID=15;_ThreadName=Thread-1;|GMS1095: Member instance102 is joining group st-cluster ...|#] [#|2010-09-17T14:03:52.361-0700|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=15;_ThreadName=Thread-1;|instantiated following NetworkManager implementation:com.sun.enterprise.mgmt.transport.grizzly.GrizzlyNetworkManager|#] [#|2010-09-17T14:03:52.371-0700|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=15;_ThreadName=Thread-1;|GMS MAX_MESSAGE_LENGTH=4196352|#] [#|2010-09-17T14:03:52.391-0700|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=15;_ThreadName=Thread-1;| GrizzlyNetworkManager Configuration BIND_INTERFACE_ADDRESS:null NetworkInterfaceName:null TCPSTARTPORT..TCPENDPORT:9090..9120 tcpPort:9091 MULTICAST_ADDRESS:MULTICAST_PORT:228.9.195.157:2496 MULTICAST_PACKET_SIZE:65536 MULTICAST_TIME_TO_LIVE: default FAILURE_DETECT_TCP_RETRANSMIT_TIMEOUT(ms):10000 ThreadPool CORE_POOLSIZE:20 MAX_POOLSIZE:50 POOL_QUEUE_SIZE:4096 KEEP_ALIVE_TIME(ms):60000 HIGH_WATER_MARK:1024 NUMBER_TO_RECLAIM:10 MAX_PARALLEL:1 START_TIMEOUT(ms):15000 WRITE_TIMEOUT(ms):10000 MAX_WRITE_SELECTOR_POOL_SIZE:30 VIRTUAL_MULTICAST_URI_LIST:null |#] [#|2010-09-17T14:03:52.570-0700|INFO|glassfish3.1|com.sun.grizzly.config.GrizzlyServiceListener|_ThreadID=15;_ThreadName=Thread-1;|GRIZZLY0001: Starting Grizzly Framework 1.9.19 - 9/17/10 2:03 PM|#] [#|2010-09-17T14:03:52.576-0700|SEVERE|glassfish3.1|grizzly|_ThreadID=15;_ThreadName=Thread-1;|doSelect IOException java.net.BindException: No free port within range: 9091=com.sun.grizzly.ReusableTCPSelectorHandler@40a47f at com.sun.grizzly.TCPSelectorHandler.initSelector(TCPSelectorHandler.java:430) at com.sun.grizzly.TCPSelectorHandler.preSelect(TCPSelectorHandler.java:376) at com.sun.grizzly.SelectorHandlerRunner.doSelect(SelectorHandlerRunner.java:186) at com.sun.grizzly.SelectorHandlerRunner.run(SelectorHandlerRunner.java:130) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908) at java.lang.Thread.run(Thread.java:619) |#] [#|2010-09-17T14:03:52.579-0700|SEVERE|glassfish3.1|ShoalLogger|_ThreadID=15;_ThreadName=Thread-1;|Exception during starting the controller java.net.BindException: No free port within range: 9091=com.sun.grizzly.ReusableTCPSelectorHandler@40a47f at com.sun.grizzly.TCPSelectorHandler.initSelector(TCPSelectorHandler.java:430) at com.sun.grizzly.TCPSelectorHandler.preSelect(TCPSelectorHandler.java:376) at com.sun.grizzly.SelectorHandlerRunner.doSelect(SelectorHandlerRunner.java:186) at com.sun.grizzly.SelectorHandlerRunner.run(SelectorHandlerRunner.java:130) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908) at java.lang.Thread.run(Thread.java:619) |#] [#|2010-09-17T14:03:52.581-0700|WARNING|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=15;_ThreadName=Thread-1;|GMSAD1008: GMSException occurred : failed to join group st-cluster|#] [#|2010-09-17T14:03:52.582-0700|INFO|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=15;_ThreadName=Thread-1;|GMSAD1004: Started GMS for instance instance102 in group st-cluster|#] [#|2010-09-17T14:03:52.591-0700|INFO|glassfish3.1|org.glassfish.ha.store.spi.BackingStoreFactoryRegistry|_ThreadID=15;_ThreadName=Thread-1;|Registered org.glassfish.ha.store.adapter.cache.ReplicationStoreProxy2 for persistence-type = replication in BackingStoreFactoryRegistry|#] [#|2010-09-17T14:03:52.592-0700|INFO|glassfish3.1|org.glassfish.ha.store.adapter.cache.ReplicationStoreProxy2|_ThreadID=15;_ThreadName=Thread-1;|Registered ReplicationStoreProxy with persistence-type = replication|#] [#|2010-09-17T14:03:53.843-0700|INFO|glassfish3.1|javax.enterprise.resource.jta.com.sun.enterprise.transaction|_ThreadID=15;_ThreadName=Thread-1;|DTX5019: Using [com.sun.enterprise.transaction.jts.JavaEETransactionManagerJTSDelegate] as the delegate|#] [#|2010-09-17T14:03:54.539-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Cannot read logging.properties file. |#] [#|2010-09-17T14:03:54.808-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|WEB0169: Created HTTP listener [http-listener-1] on host/port [0.0.0.0:28081]|#] [#|2010-09-17T14:03:54.849-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|WEB0169: Created HTTP listener [http-listener-2] on host/port [0.0.0.0:28182]|#] [#|2010-09-17T14:03:54.914-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|WEB0169: Created HTTP listener [admin-listener] on host/port [0.0.0.0:24849]|#] [#|2010-09-17T14:03:55.117-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|WEB0171: Created virtual server [server]|#] [#|2010-09-17T14:03:55.117-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|WEB0171: Created virtual server [server]|#] [#|2010-09-17T14:03:55.134-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|WEB0171: Created virtual server [__asadmin]|#] [#|2010-09-17T14:03:55.134-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|WEB0171: Created virtual server [__asadmin]|#] [#|2010-09-17T14:03:55.134-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|WEB0171: Created virtual server [__asadmin]|#] [#|2010-09-17T14:03:58.354-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|PersistenceStrategyBuilderFactory>>createPersistenceStrategyBuilder: CandidateBuilderClassName = class com.sun.enterprise.web.MemoryStrategyBuilder|#] [#|2010-09-17T14:03:58.354-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|PersistenceStrategyBuilderFactory>>createPersistenceStrategyBuilder: CandidateBuilderClassName = class com.sun.enterprise.web.MemoryStrategyBuilder|#] [#|2010-09-17T14:03:58.354-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|PersistenceStrategyBuilderFactory>>createPersistenceStrategyBuilder: CandidateBuilderClassName = class com.sun.enterprise.web.MemoryStrategyBuilder|#] [#|2010-09-17T14:03:58.458-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|WEB0172: Virtual server [server] loaded default web module []|#] [#|2010-09-17T14:03:58.458-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|WEB0172: Virtual server [server] loaded default web module []|#] [#|2010-09-17T14:03:58.458-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|WEB0172: Virtual server [server] loaded default web module []|#] [#|2010-09-17T14:04:02.006-0700|INFO|glassfish3.1|javax.enterprise.system.core.com.sun.enterprise.v3.services.impl|_ThreadID=15;_ThreadName=Thread-1;|core.start_container_done|#] [#|2010-09-17T14:04:05.845-0700|INFO|glassfish3.1|javax.enterprise.system.core.security.com.sun.enterprise.security|_ThreadID=15;_ThreadName=Thread-1;|SEC1002: Security Manager is OFF.|#] [#|2010-09-17T14:04:06.041-0700|INFO|glassfish3.1|javax.enterprise.system.core.security.com.sun.enterprise.security|_ThreadID=15;_ThreadName=Thread-1;|SEC1010: Entering Security Startup Service|#] [#|2010-09-17T14:04:06.062-0700|INFO|glassfish3.1|javax.enterprise.system.core.security.com.sun.enterprise.security|_ThreadID=15;_ThreadName=Thread-1;|SEC1143: Loading policy provider com.sun.enterprise.security.provider.PolicyWrapper.|#] [#|2010-09-17T14:04:06.729-0700|INFO|glassfish3.1|javax.enterprise.system.core.security.com.sun.enterprise.security.auth.realm|_ThreadID=15;_ThreadName=Thread-1;|SEC1115: Realm [admin-realm] of classtype [com.sun.enterprise.security.auth.realm.file.FileRealm] successfully created.|#] [#|2010-09-17T14:04:06.734-0700|INFO|glassfish3.1|javax.enterprise.system.core.security.com.sun.enterprise.security.auth.realm|_ThreadID=15;_ThreadName=Thread-1;|SEC1115: Realm [file] of classtype [com.sun.enterprise.security.auth.realm.file.FileRealm] successfully created.|#] [#|2010-09-17T14:04:06.952-0700|INFO|glassfish3.1|javax.enterprise.system.core.security.com.sun.enterprise.security.auth.realm|_ThreadID=15;_ThreadName=Thread-1;|SEC1115: Realm [certificate] of classtype [com.sun.enterprise.security.auth.realm.certificate.CertificateRealm] successfully created.|#] [#|2010-09-17T14:04:07.177-0700|INFO|glassfish3.1|javax.enterprise.system.core.security.com.sun.enterprise.security|_ThreadID=15;_ThreadName=Thread-1;|SEC1011: Security Service(s) Started Successfully|#] [#|2010-09-17T14:04:07.704-0700|WARNING|glassfish3.1|javax.enterprise.system.container.web|_ThreadID=15;_ThreadName=Thread-1;|Can not find resource bundle for this logger. class name that failed: org.glassfish.web.ha.session.management.ReplicationWebEventPersistentManager|#] [#|2010-09-17T14:04:07.631-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.org.glassfish.web.ha.session.management|_ThreadID=15;_ThreadName=Thread-1;|ReplicationWebEventPersistentManager created|#] [#|2010-09-17T14:04:07.719-0700|WARNING|glassfish3.1|javax.enterprise.system.container.web|_ThreadID=15;_ThreadName=Thread-1;|Can not find resource bundle for this logger. class name that failed: org.glassfish.web.ha.session.management.ReplicationWebEventPersistentManager|#] [#|2010-09-17T14:04:07.741-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|PersistenceStrategyBuilderFactory>>createPersistenceStrategyBuilder: CandidateBuilderClassName = class org.glassfish.web.ha.strategy.builder.ReplicatedWebMethodSessionStrategyBuilder|#] [#|2010-09-17T14:04:07.741-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|PersistenceStrategyBuilderFactory>>createPersistenceStrategyBuilder: CandidateBuilderClassName = class org.glassfish.web.ha.strategy.builder.ReplicatedWebMethodSessionStrategyBuilder|#] [#|2010-09-17T14:04:07.741-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|PersistenceStrategyBuilderFactory>>createPersistenceStrategyBuilder: CandidateBuilderClassName = class org.glassfish.web.ha.strategy.builder.ReplicatedWebMethodSessionStrategyBuilder|#] [#|2010-09-17T14:04:07.764-0700|WARNING|glassfish3.1|javax.enterprise.system.container.web|_ThreadID=15;_ThreadName=Thread-1;|Can not find resource bundle for this logger. class name that failed: org.glassfish.web.ha.session.management.ReplicationWebEventPersistentManager|#] [#|2010-09-17T14:04:07.762-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.org.glassfish.web.ha.session.management|_ThreadID=15;_ThreadName=Thread-1;|Create backing store invoked with persistence type replicated and store name /clusterjsp|#] [#|2010-09-17T14:04:07.766-0700|WARNING|glassfish3.1|javax.enterprise.system.container.web|_ThreadID=15;_ThreadName=Thread-1;|Can not find resource bundle for this logger. class name that failed: org.glassfish.web.ha.session.management.ReplicationWebEventPersistentManager|#] [#|2010-09-17T14:04:07.770-0700|WARNING|glassfish3.1|javax.enterprise.system.container.web|_ThreadID=15;_ThreadName=Thread-1;|Can not find resource bundle for this logger. class name that failed: org.glassfish.web.ha.session.management.ReplicationWebEventPersistentManager|#] [#|2010-09-17T14:04:07.768-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.org.glassfish.web.ha.session.management|_ThreadID=15;_ThreadName=Thread-1;|About to create backing store BackingStoreConfiguration{clusterName='st-cluster', instanceName='instance102', storeName='/clusterjsp', shortUniqueName='null', storeType='replicated', maxIdleTimeInSeconds=-1, relaxVersionCheck='null', maxLoadWaitTimeInSeconds=0, baseDirectoryName='null', keyClazz=class java.lang.String, valueClazz=class org.glassfish.web.ha.session.management.SimpleMetadata, synchronousSave=false, typicalPayloadSizeInKiloBytes=0, vendorSpecificSettings={async.replication=true}}|#] [#|2010-09-17T14:04:07.773-0700|WARNING|glassfish3.1|javax.enterprise.system.container.web|_ThreadID=15;_ThreadName=Thread-1;|Can not find resource bundle for this logger. class name that failed: org.glassfish.web.ha.session.management.ReplicationWebEventPersistentManager|#] [#|2010-09-17T14:04:08.051-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Entered GlassFish2ShoalBackingStoreFactory.createBackingStore...|#] [#|2010-09-17T14:04:08.061-0700|INFO|glassfish3.1|org.shoal.ha.cache.mapper|_ThreadID=15;_ThreadName=Thread-1;|DefaultKeyMapper created for: myName: instance102; groupName: st-cluster|#] [#|2010-09-17T14:04:08.113-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|** SET ASYNC REPLICATUION: true|#] [#|2010-09-17T14:04:08.144-0700|INFO|glassfish3.1|ShoalLogger|_ThreadID=15;_ThreadName=Thread-1;|**GroupServiceProvider:: GMS module for group st-cluster should have been started by now GMS: com.sun.enterprise.ee.cms.impl.common.GroupManagementServiceImpl@98ab04|#] [#|2010-09-17T14:04:08.146-0700|INFO|glassfish3.1|ShoalLogger|_ThreadID=15;_ThreadName=Thread-1;|**GroupServiceProvider:: REGISTERED member event listeners for => |#] [#|2010-09-17T14:04:08.148-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|**GroupServiceProvider:checkAndNotifyAboutCurrentAndPreviousMembers: previous viewID: -100; current viewID: 0; null|#] [#|2010-09-17T14:04:08.150-0700|INFO|glassfish3.1|org.shoal.ha.cache.mapper|_ThreadID=15;_ThreadName=Thread-1;|DefaultKeyMapper[instance102].onViewChange (isJoin: true) currentView: ; previousView |#] [#|2010-09-17T14:04:08.150-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|**VIEW: prevViewId: -100; curViewID: 0; signal: null [current: ] [previous: ]|#] [#|2010-09-17T14:04:08.151-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|**********************************************************************|#] [#|2010-09-17T14:04:08.185-0700|INFO|glassfish3.1|org.shoal.ha.cache.config|_ThreadID=15;_ThreadName=Thread-1;|ASync replication enabled...|#] [#|2010-09-17T14:04:08.186-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|**GroupServiceProvider:checkAndNotifyAboutCurrentAndPreviousMembers: previous viewID: 0; current viewID: 0; null|#] [#|2010-09-17T14:04:08.188-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|**GroupServiceProvider:checkAndNotifyAboutCurrentAndPreviousMembers. Entered ELSE 2|#] [#|2010-09-17T14:04:08.188-0700|INFO|glassfish3.1|org.shoal.ha.cache.mapper|_ThreadID=15;_ThreadName=Thread-1;|DefaultKeyMapper[instance102].onViewChange (isJoin: true) currentView: ; previousView |#] [#|2010-09-17T14:04:08.189-0700|INFO|glassfish3.1|org.shoal.ha.cache.mapper|_ThreadID=15;_ThreadName=Thread-1;|DefaultKeyMapper[instance102].onViewChange (isJoin: true) currentView: ; previousView |#] [#|2010-09-17T14:04:08.189-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|**VIEW: prevViewId: 0; curViewID: 0; signal: null [current: ] [previous: ]|#] [#|2010-09-17T14:04:08.190-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|**********************************************************************|#] [#|2010-09-17T14:04:08.193-0700|INFO|glassfish3.1|org.shoal.ha.cache.config|_ThreadID=15;_ThreadName=Thread-1;|Created ReplicatedDataStore with config: DataStoreConfigurator{instanceName='instance102', groupName='st-cluster', storeName='/clusterjsp', keyClazz=class java.lang.String, valueClazz=class org.glassfish.web.ha.session.management.SimpleMetadata, keyMapper=org.shoal.ha.store.GlassFishKeyMapper@1c7d1, dataStoreKeyHelper=org.shoal.ha.cache.api.ObjectKeyHelper@e5707f, startGMS=false, cacheLocally= false, clazzLoader=211.0, dataStoreEntryHelper=org.shoal.ha.cache.impl.util.DefaultDataStoreEntryHelper@13cc73c, doASyncReplication=true, objectInputOutputStreamFactory=org.shoal.ha.cache.api.DefaultObjectInputOutputStreamFactory@13c5cc8}|#] [#|2010-09-17T14:04:08.195-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|GlassFish2ShoalBackingStoreFactory:: CREATED an instance of: org.shoal.adapter.store.ReplicatedBackingStore|#] [#|2010-09-17T14:04:08.196-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|ReplicatedManager.keymapper is org.shoal.ha.store.GlassFishKeyMapper@1c7d1|#] [#|2010-09-17T14:04:10.670-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|WEB0671: Loading application [clusterjsp#clusterjsp.war] at [/clusterjsp]|#] [#|2010-09-17T14:04:10.670-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=15;_ThreadName=Thread-1;|WEB0671: Loading application [clusterjsp#clusterjsp.war] at [/clusterjsp]|#] [#|2010-09-17T14:04:10.670-0700|INFO|glassfish3.1|javax.enterprise.system.container.web.com.sun.enterprise.web|_ThreadID=1;_ThreadName=main;|WEB0671: Loading application [clusterjsp#clusterjsp.war] at [/clusterjsp]|#] [#|2010-09-17T14:04:10.675-0700|INFO|glassfish3.1|javax.enterprise.system.core.com.sun.enterprise.v3.server|_ThreadID=15;_ThreadName=Thread-1;|CORE10010: Loading application clusterjsp done in 8,481 ms|#] [#|2010-09-17T14:04:10.681-0700|INFO|glassfish3.1|javax.enterprise.system.core.com.sun.enterprise.v3.server|_ThreadID=15;_ThreadName=Thread-1;|GlassFish Server Open Source Edition 3.1-b20 (20) startup time : Felix(16340ms) startup services(28154ms) total(44494ms)|#] [#|2010-09-17T14:04:10.992-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|/export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102/autodeploy/bundles does not exist, please create it.|#] [#|2010-09-17T14:04:11.295-0700|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=15;_ThreadName=Thread-1;|ExtenderManager starting|#] [#|2010-09-17T14:04:11.311-0700|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=15;_ThreadName=Thread-1;|Starting extender called org.glassfish.osgijavaeebase.JavaEEExtender@15b2f17|#] [#|2010-09-17T14:04:11.328-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Started bundle: file:/export/jmscvs/glassfishv3/glassfish/modules/autostart/osgi-javaee-base.jar|#] [#|2010-09-17T14:04:11.363-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|DEBUG: EventAdmin: org.apache.felix.eventadmin.CacheSize=30|#] [#|2010-09-17T14:04:11.364-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|DEBUG: EventAdmin: org.apache.felix.eventadmin.ThreadPoolSize=20|#] [#|2010-09-17T14:04:11.364-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|DEBUG: EventAdmin: org.apache.felix.eventadmin.Timeout=5000|#] [#|2010-09-17T14:04:11.365-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|DEBUG: EventAdmin: org.apache.felix.eventadmin.RequireTopic=true|#] [#|2010-09-17T14:04:11.472-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Started bundle: file:/export/jmscvs/glassfishv3/glassfish/modules/autostart/org.apache.felix.eventadmin.jar|#] [#|2010-09-17T14:04:11.478-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|DEBUG: EventAdmin: org.apache.felix.eventadmin.CacheSize=30|#] [#|2010-09-17T14:04:11.479-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|DEBUG: EventAdmin: org.apache.felix.eventadmin.ThreadPoolSize=20|#] [#|2010-09-17T14:04:11.480-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|DEBUG: EventAdmin: org.apache.felix.eventadmin.Timeout=5000|#] [#|2010-09-17T14:04:11.481-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|DEBUG: EventAdmin: org.apache.felix.eventadmin.RequireTopic=true|#] [#|2010-09-17T14:04:11.586-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Started bundle: file:/export/jmscvs/glassfishv3/glassfish/modules/autostart/org.apache.felix.scr.jar|#] [#|2010-09-17T14:04:11.881-0700|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=15;_ThreadName=Thread-1;|Starting extender called org.glassfish.osgiweb.WebExtender@6f5bef|#] [#|2010-09-17T14:04:11.931-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Started bundle: file:/export/jmscvs/glassfishv3/glassfish/modules/autostart/osgi-web-container.jar|#] [#|2010-09-17T14:04:14.694-0700|INFO|glassfish3.1|javax.enterprise.resource.jms.com.sun.enterprise.connectors.jms.system|_ThreadID=15;_ThreadName=Thread-1;|ADDRESSLIST in setJmsServiceProvider mq://hat2k1:27677/,mq://hat2k1:27677/,mq://hat2k1:27678/|#] [#|2010-09-17T14:04:14.762-0700|INFO|glassfish3.1|javax.enterprise.resource.jms.com.sun.enterprise.connectors.jms.system|_ThreadID=15;_ThreadName=Thread-1;|JMS Service Connection URL is :mq://hat2k1:27677/,mq://hat2k1:27677/,mq://hat2k1:27678/|#] [#|2010-09-17T14:04:15.677-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Started bundle: file:/export/jmscvs/glassfishv3/glassfish/modules/autostart/org.apache.felix.bundlerepository.jar|#] [#|2010-09-17T14:04:16.163-0700|INFO|glassfish3.1|org.hibernate.validator.engine.resolver.DefaultTraversableResolver|_ThreadID=15;_ThreadName=Thread-1;|Instantiated an instance of org.hibernate.validator.engine.resolver.JPATraversableResolver.|#] [#|2010-09-17T14:04:16.894-0700|INFO|glassfish3.1|javax.resourceadapter.mqjmsra.lifecycle|_ThreadID=15;_ThreadName=Thread-1;|MQJMSRA_RA1101: SJSMQ JMS Resource Adapter starting: broker is LOCAL, connection mode is TCP|#] [#|2010-09-17T14:04:17.234-0700|INFO|glassfish3.1|javax.resourceadapter.mqjmsra.lifecycle|_ThreadID=15;_ThreadName=Thread-1;|MQJMSRA_LB1101: Looking for Broker Running at:localhost:27677|#] [#|2010-09-17T14:04:17.777-0700|WARNING|glassfish3.1|javax.jms|_ThreadID=15;_ThreadName=Thread-1;|[C4003]: Error occurred on connection creation [localhost:27677]. - cause: java.net.ConnectException: Connection refused|#] [#|2010-09-17T14:04:18.982-0700|WARNING|glassfish3.1|javax.jms|_ThreadID=15;_ThreadName=Thread-1;|[C4003]: Error occurred on connection creation [localhost:27677]. - cause: java.net.ConnectException: Connection refused|#] [#|2010-09-17T14:04:19.992-0700|WARNING|glassfish3.1|javax.jms|_ThreadID=15;_ThreadName=Thread-1;|[C4003]: Error occurred on connection creation [localhost:27677]. - cause: java.net.ConnectException: Connection refused|#] [#|2010-09-17T14:04:20.729-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Installed /export/jmscvs/glassfishv3/glassfish/modules/autostart/org.apache.felix.webconsole.internal.servlet.OsgiManager.cfg|#] [#|2010-09-17T14:04:20.757-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|Installed /export/jmscvs/glassfishv3/glassfish/modules/autostart/org.apache.felix.fileinstall-autodeploy-bundles.cfg|#] [#|2010-09-17T14:04:20.761-0700|INFO|glassfish3.1|null|_ThreadID=15;_ThreadName=Thread-1;|/export/jmscvs/glassfishv3/glassfish/nodes/agent1/instance102/autodeploy/bundles does not exist, please create it.|#] [#|2010-09-17T14:04:21.002-0700|WARNING|glassfish3.1|javax.jms|_ThreadID=15;_ThreadName=Thread-1;|[C4003]: Error occurred on connection creation [localhost:27677]. - cause: java.net.ConnectException: Connection refused|#] [#|2010-09-17T14:04:25.012-0700|INFO|glassfish3.1|javax.resourceadapter.mqjmsra.lifecycle|_ThreadID=15;_ThreadName=Thread-1;|MQJMSRA_RA1101: SJSMQ JMSRA Started:LOCAL|#] [#|2010-09-17T14:04:25.612-0700|INFO|glassfish3.1|javax.enterprise.system.tools.admin.org.glassfish.server|_ThreadID=15;_ThreadName=Thread-1;|Binding RMI port to *:28687|#] [#|2010-09-17T14:04:25.994-0700|INFO|glassfish3.1|javax.enterprise.resource.resourceadapter.com.sun.enterprise.connectors.inbound|_ThreadID=15;_ThreadName=Thread-1;|Recovery of Inbound Transactions started.|#] [#|2010-09-17T14:04:26.094-0700|INFO|glassfish3.1|javax.enterprise.system.core.transaction.com.sun.jts.CosTransactions|_ThreadID=15;_ThreadName=Thread-1;|JTS5014: Recoverable JTS instance, serverId = [100]|#] [#|2010-09-17T14:04:27.476-0700|INFO|glassfish3.1|javax.enterprise.system.core.com.sun.enterprise.v3.server|_ThreadID=15;_ThreadName=Thread-1;|[Thread[GlassFish Kernel Main Thread,5,main]] started|#] [#|2010-09-17T14:04:27.621-0700|INFO|glassfish3.1|javax.enterprise.system.tools.admin.org.glassfish.server|_ThreadID=15;_ThreadName=Thread-1;|JMXStartupService: Started JMXConnector, JMXService URL = service:jmx:rmi://hat2k1:28687/jndi/rmi://hat2k1:28687/jmxrmi|#]