Nov 11, 2010 9:15:48 AM com.sun.enterprise.admin.launcher.GFLauncherLogger info INFO: JVM invocation command line: /files/jdk/jdk1.6/bin/java -cp /sun/glassfishv2.1.1/glassfish3/glassfish/modules/glassfish.jar -XX:+UnlockDiagnosticVMOptions -XX:MaxPermSize=192m -XX:NewRatio=2 -XX:+LogVMOutput -XX:LogFile=/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1/logs/jvm.log -Xmx512m -client -javaagent:/sun/glassfishv2.1.1/glassfish3/glassfish/lib/monitor/btrace-agent.jar=unsafe=true,noServer=true -Dosgi.shell.telnet.maxconn=1 -Djdbc.drivers=org.apache.derby.jdbc.ClientDriver -Dfelix.fileinstall.dir=/sun/glassfishv2.1.1/glassfish3/glassfish/modules/autostart/ -Djavax.net.ssl.keyStore=/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1/config/keystore.jks -Dosgi.shell.telnet.port=6666 -Djava.security.policy=/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1/config/server.policy -Dcom.sun.appserv.pluggable.features=com.sun.enterprise.ee.server.pluggable.EEPluggableFeatureImpl -Dfelix.fileinstall.poll=5000 -Dcom.sun.aas.instanceRoot=/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1 -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=/sun/glassfishv2.1.1/glassfish3/glassfish/lib/endorsed -Dcom.sun.aas.installRoot=/sun/glassfishv2.1.1/glassfish3/glassfish -Djava.ext.dirs=/files/jdk/jdk1.6/lib/ext:/files/jdk/jdk1.6/jre/lib/ext:/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1/lib/ext:/sun/glassfishv2.1.1/glassfish3/javadb/lib:/sun/glassfishv2.1.1/glassfish3/glassfish/lib/jdbcdrivers -Dfelix.fileinstall.bundles.new.start=true -Djavax.net.ssl.trustStore=/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1/config/cacerts.jks -Djava.security.auth.login.config=/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1/config/login.conf -DANTLR_USE_DIRECT_CLASS_LOADING=true -Dfelix.fileinstall.debug=1 -Dorg.glassfish.web.rfc2109_cookie_names_enforced=false -Djava.library.path=/sun/glassfishv2.1.1/glassfish3/glassfish/lib:/files/gfut/nov9-testing/cluster:/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java com.sun.enterprise.glassfish.bootstrap.ASMain -domainname domain1 -asadmin-args --host,,,localhost,,,--port,,,4848,,,--secure=false,,,--terse=false,,,--echo=false,,,--interactive=true,,,start-domain,,,--verbose=false,,,--debug=false,,,--domaindir,,,/sun/glassfishv2.1.1/glassfish3/glassfish/domains,,,domain1 -instancename server -verbose false -debug false -asadmin-classpath /sun/glassfishv2.1.1/glassfish3/glassfish/modules/admin-cli.jar -asadmin-classname com.sun.enterprise.admin.cli.AsadminMain -upgrade false -type DAS -domaindir /sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1 -read-stdin true Nov 11, 2010 9:15:48 AM com.sun.enterprise.admin.launcher.GFLauncherLogger info INFO: Successfully launched in 85 msec. Nov 11, 2010 9:16:07 AM null INFO: Running GlassFish Version: GlassFish Server Open Source Edition 3.1-b28 (build 28) [#|2010-11-11T09:16:07.979-0500|INFO|glassfish3.1|javax.enterprise.system.core.com.sun.enterprise.server.logging|_ThreadID=19;_ThreadName=Thread-2;|This message was emitted before the logging service started:Total time to parse domain.xml: 382 milliseconds|#] [#|2010-11-11T09:16:08.506-0500|CONFIG|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=19;_ThreadName=Thread-2;|clusterName=cluster1 clusterConfig=GlassFishConfigBean.com.sun.enterprise.config.serverbeans.Config|#] [#|2010-11-11T09:16:08.768-0500|WARNING|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1117: Could not validate binding address "${GMS-BIND-INTERFACE-ADDRESS-cluster1}" due to java.net.UnknownHostException: ${GMS-BIND-INTERFACE-ADDRESS-cluster1}|#] [#|2010-11-11T09:16:08.768-0500|SEVERE|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=19;_ThreadName=Thread-2;|GMSAD1019: GMS bind interface address ${GMS-BIND-INTERFACE-ADDRESS-cluster1} is invalid. Will use default value instead.|#] [#|2010-11-11T09:16:08.774-0500|CONFIG|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=19;_ThreadName=Thread-2;|processing cluster property name=GMS_LISTENER_PORT value= ${GMS_LISTENER_PORT-cluster1}|#] [#|2010-11-11T09:16:08.775-0500|CONFIG|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=19;_ThreadName=Thread-2;|skipping cluster property name=GMS_LISTENER_PORT since value is unresolved symbolic token=${GMS_LISTENER_PORT-cluster1}|#] [#|2010-11-11T09:16:08.776-0500|CONFIG|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=19;_ThreadName=Thread-2;|Printing all GMS properties: |#] [#|2010-11-11T09:16:08.908-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1095: Member server is joining group cluster1 ...|#] [#|2010-11-11T09:16:09.023-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|instantiated following NetworkManager implementation:com.sun.enterprise.mgmt.transport.grizzly.GrizzlyNetworkManager|#] [#|2010-11-11T09:16:09.049-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS MAX_MESSAGE_LENGTH=4196352|#] [#|2010-11-11T09:16:09.050-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;| GrizzlyNetworkManager Configuration BIND_INTERFACE_ADDRESS:null NetworkInterfaceName:null TCPSTARTPORT..TCPENDPORT:9090..9120 MULTICAST_ADDRESS:MULTICAST_PORT:228.8.7.9:11922 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:15 START_TIMEOUT(ms):15000 WRITE_TIMEOUT(ms):10000 MAX_WRITE_SELECTOR_POOL_SIZE:30 VIRTUAL_MULTICAST_URI_LIST:null |#] [#|2010-11-11T09:16:09.230-0500|INFO|glassfish3.1|grizzly|_ThreadID=19;_ThreadName=Thread-2;|GRIZZLY0001: Starting Grizzly Framework 1.9.21 - 11/11/10 9:16 AM|#] [#|2010-11-11T09:16:09.301-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|Grizzly controller listening on /0.0.0.0:9096. Controller started in 78 ms|#] [#|2010-11-11T09:16:09.374-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|Set via default minimum: MulticastSocket.getTimeToLive()=4|#] [#|2010-11-11T09:16:09.375-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|MulticastSocket configuration: local socket address: 0.0.0.0/0.0.0.0:11922 network interface: name:vmnet8 (vmnet8) index: 9 addresses: /172.16.189.1; multicast address:/228.8.7.9 timeToLive=4|#] [#|2010-11-11T09:16:09.445-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|HealthMonitor: heartBeatTimeout(ms)=2000 maxMissedBeats=3 failureDetectionTCPTimeout(ms)=10000 failureDetectionTCPPort=9000|#] [#|2010-11-11T09:16:09.447-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|starting cluster cluster1 for member:server|#] [#|2010-11-11T09:16:09.447-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1061: MasterNode message listener is registered for member: server group: cluster1|#] [#|2010-11-11T09:16:09.457-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1092: GMS View Change Received for group cluster1 : Members in view for MASTER_CHANGE_EVENT(before change analysis) are : 1: MemberId: server, MemberType: SPECTATOR, Address: 172.16.189.1:9096:228.8.7.9:11922:cluster1:server |#] [#|2010-11-11T09:16:09.458-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1016: Analyzing new membership snapshot received as part of event : MASTER_CHANGE_EVENT for Member: server of Group: cluster1|#] [#|2010-11-11T09:16:09.458-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1093: adding GroupLeadershipNotification signal leaderMember: server of group: cluster1|#] [#|2010-11-11T09:16:09.501-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|MySystemAdvertisement(summary): GMSMember name: server group: cluster1 memberType: SPECTATOR startTime: Nov 11, 2010 9:16:08 AM EST ID:172.16.189.1:9096:228.8.7.9:11922:cluster1:server TCP uri(s):[tcp://172.16.189.1:4000, tcp://192.168.23.1:4000, tcp://10.152.22.229:4000, tcp://[fe80:0:0:0:66b9:e8ff:fed3:6e16%4]:4000, tcp://[fe80:0:0:0:0:0:0:1%1]:4000]|#] [#|2010-11-11T09:16:09.500-0500|INFO|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=19;_ThreadName=Thread-2;|GMSAD1005: Member server joined group cluster1|#] [#|2010-11-11T09:16:09.501-0500|INFO|glassfish3.1|javax.org.glassfish.gms.org.glassfish.gms|_ThreadID=19;_ThreadName=Thread-2;|GMSAD1004: Started GMS for instance server in group cluster1|#] [#|2010-11-11T09:16:09.501-0500|CONFIG|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|MySystemAdvertisement(dump)=PEERID[172.16.189.1:9096:228.8.7.9:11922:cluster1:server] CUSTOMTAGS[GROUP_NAME:cluster1, MEMBER_TYPE:SPECTATOR, START_TIME[9:16:08 AM EST on Nov 11, 2010]], ENDPONTADDRESSES[[tcp://172.16.189.1:4000, tcp://192.168.23.1:4000, tcp://10.152.22.229:4000, tcp://[fe80:0:0:0:66b9:e8ff:fed3:6e16%4]:4000, tcp://[fe80:0:0:0:0:0:0:1%1]:4000]], NAME:server, OSNAME:Mac OS X, OSVERSION:10.6.4, OSARCH:x86_64, HWARCH:x86_64, HWVENDOR:Apple Inc.|#] [#|2010-11-11T09:16:09.619-0500|INFO|glassfish3.1|org.glassfish.ha.store.spi.BackingStoreFactoryRegistry|_ThreadID=19;_ThreadName=Thread-2;|Registered org.glassfish.ha.store.adapter.cache.ReplicationStoreProxy2 for persistence-type = replication in BackingStoreFactoryRegistry|#] [#|2010-11-11T09:16:09.619-0500|INFO|glassfish3.1|org.glassfish.ha.store.adapter.cache.ReplicationStoreProxy2|_ThreadID=19;_ThreadName=Thread-2;|Registered ReplicationStoreProxy with persistence-type = replication|#] [#|2010-11-11T09:16:09.916-0500|INFO|glassfish3.1|com.sun.grizzly.config.GrizzlyServiceListener|_ThreadID=19;_ThreadName=Thread-2;|Perform lazy SSL initialization for the listener 'http-listener-2'|#] [#|2010-11-11T09:16:09.938-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|Grizzly Framework 1.9.21 started in: 14ms - bound to [0.0.0.0:8181]|#] [#|2010-11-11T09:16:09.938-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|Grizzly Framework 1.9.21 started in: 68ms - bound to [0.0.0.0:8080]|#] [#|2010-11-11T09:16:09.954-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|Grizzly Framework 1.9.21 started in: 5ms - bound to [0.0.0.0:4848]|#] [#|2010-11-11T09:16:10.300-0500|INFO|glassfish3.1|org.glassfish.ha.store.spi.BackingStoreFactoryRegistry|_ThreadID=19;_ThreadName=Thread-2;|Registered org.glassfish.ha.store.adapter.cache.ShoalBackingStoreProxy for persistence-type = replicated in BackingStoreFactoryRegistry|#] [#|2010-11-11T09:16:10.301-0500|INFO|glassfish3.1|org.glassfish.ha.store.adapter.cache.ShoalBackingStoreProxy|_ThreadID=19;_ThreadName=Thread-2;|Registered SHOAL BackingStore Proxy with persistence-type = replicated|#] [#|2010-11-11T09:16:10.439-0500|INFO|glassfish3.1|javax.enterprise.system.core.com.sun.enterprise.v3.server|_ThreadID=19;_ThreadName=Thread-2;|GlassFish Server Open Source Edition 3.1-b28 (28) startup time : Felix (17,464ms), startup services(3,003ms), total(20,467ms)|#] [#|2010-11-11T09:16:10.440-0500|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=19;_ThreadName=Thread-2;|Starting extender called org.glassfish.osgijavaeebase.JavaEEExtender@6041f871|#] [#|2010-11-11T09:16:10.443-0500|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=19;_ThreadName=Thread-2;|Starting extender called org.glassfish.osgiejb.EJBExtender@24d3e83f|#] [#|2010-11-11T09:16:10.453-0500|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=19;_ThreadName=Thread-2;|Starting extender called org.glassfish.osgijta.JTAExtender@489fe953|#] [#|2010-11-11T09:16:10.472-0500|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=19;_ThreadName=Thread-2;|Starting extender called org.glassfish.osgiweb.WebExtender@230cc23b|#] [#|2010-11-11T09:16:10.489-0500|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=19;_ThreadName=Thread-2;|Starting extender called org.glassfish.osgijpa.JPAExtender@79b04310|#] [#|2010-11-11T09:16:10.491-0500|INFO|glassfish3.1|org.glassfish.osgijpa|_ThreadID=19;_ThreadName=Thread-2;| JPAExtender started|#] [#|2010-11-11T09:16:10.491-0500|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=19;_ThreadName=Thread-2;|Starting extender called org.glassfish.osgi.ee.resources.ResourcesExtender@23030dda|#] [#|2010-11-11T09:16:10.569-0500|INFO|glassfish3.1|org.glassfish.osgijavaeebase|_ThreadID=19;_ThreadName=Thread-2;|Starting extender called org.glassfish.osgijdbc.JDBCExtender@544cb3a4|#] [#|2010-11-11T09:16:10.639-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1099: GMS:Reporting Joined and Ready state to group cluster1|#] [#|2010-11-11T09:16:10.792-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1/autodeploy/bundles does not exist, please create it.|#] [#|2010-11-11T09:16:10.892-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|____________________________ Welcome to Apache Felix Gogo |#] [#|2010-11-11T09:16:14.477-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1092: GMS View Change Received for group cluster1 : Members in view for MASTER_CHANGE_EVENT(before change analysis) are : 1: MemberId: server, MemberType: SPECTATOR, Address: 172.16.189.1:9096:228.8.7.9:11922:cluster1:server |#] [#|2010-11-11T09:16:14.477-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1016: Analyzing new membership snapshot received as part of event : MASTER_CHANGE_EVENT for Member: server of Group: cluster1|#] [#|2010-11-11T09:16:14.477-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1093: adding GroupLeadershipNotification signal leaderMember: server of group: cluster1|#] [#|2010-11-11T09:16:14.477-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1058: Assuming Master Node designation member:server for group:cluster1|#] [#|2010-11-11T09:16:14.479-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1057: Announcing Master Node designation for member: server of group: cluster1. Local view contains 1 entries|#] [#|2010-11-11T09:16:14.518-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1040: Calling reportMyState() with READY...|#] [#|2010-11-11T09:16:14.518-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1092: GMS View Change Received for group cluster1 : Members in view for JOINED_AND_READY_EVENT(before change analysis) are : 1: MemberId: server, MemberType: SPECTATOR, Address: 172.16.189.1:9096:228.8.7.9:11922:cluster1:server |#] [#|2010-11-11T09:16:14.518-0500|INFO|glassfish3.1|ShoalLogger|_ThreadID=19;_ThreadName=Thread-2;|GMS1016: Analyzing new membership snapshot received as part of event : JOINED_AND_READY_EVENT for Member: server of Group: cluster1|#] [#|2010-11-11T09:16:14.740-0500|INFO|glassfish3.1|javax.enterprise.resource.jta.com.sun.enterprise.transaction|_ThreadID=19;_ThreadName=Thread-2;|DTX5019: Using [com.sun.enterprise.transaction.jts.JavaEETransactionManagerJTSDelegate] as the delegate|#] [#|2010-11-11T09:16:16.194-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|/sun/glassfishv2.1.1/glassfish3/glassfish/domains/domain1/autodeploy/bundles does not exist, please create it.|#] [#|2010-11-11T09:16:18.328-0500|INFO|glassfish3.1|javax.enterprise.resource.jms.com.sun.enterprise.connectors.jms.system|_ThreadID=19;_ThreadName=Thread-2;|addresslist.setjmsservice.provider|#] [#|2010-11-11T09:16:18.371-0500|INFO|glassfish3.1|javax.enterprise.resource.jms.com.sun.enterprise.connectors.jms.system|_ThreadID=19;_ThreadName=Thread-2;|jms.connection.url|#] [#|2010-11-11T09:16:18.811-0500|INFO|glassfish3.1|org.hibernate.validator.util.Version|_ThreadID=19;_ThreadName=Thread-2;|Hibernate Validator null|#] [#|2010-11-11T09:16:18.989-0500|INFO|glassfish3.1|org.hibernate.validator.engine.resolver.DefaultTraversableResolver|_ThreadID=19;_ThreadName=Thread-2;|Instantiated an instance of org.hibernate.validator.engine.resolver.JPATraversableResolver.|#] [#|2010-11-11T09:16:19.300-0500|INFO|glassfish3.1|javax.resourceadapter.mqjmsra.lifecycle|_ThreadID=19;_ThreadName=Thread-2;|MQJMSRA_RA1101: SJSMQ JMS Resource Adapter starting: broker is EMBEDDED, connection mode is Direct|#] [#|2010-11-11T09:16:23.236-0500|INFO|glassfish3.1|javax.resourceadapter.mqjmsra.lifecycle|_ThreadID=19;_ThreadName=Thread-2;|MQJMSRA_RA1101: SJSMQ JMSRA Started:EMBEDDED|#] [#|2010-11-11T09:16:23.495-0500|INFO|glassfish3.1|javax.enterprise.system.tools.admin.org.glassfish.server|_ThreadID=19;_ThreadName=Thread-2;|Binding RMI port to *:8686|#] [#|2010-11-11T09:16:23.534-0500|INFO|glassfish3.1|javax.enterprise.system.tools.admin.org.glassfish.server|_ThreadID=19;_ThreadName=Thread-2;|JMXStartupService: Started JMXConnector, JMXService URL = service:jmx:rmi://dhcp-burlington9-3rd-a-east-10-152-22-229.usdhcp.oraclecorp.com:8686/jndi/rmi://dhcp-burlington9-3rd-a-east-10-152-22-229.usdhcp.oraclecorp.com:8686/jmxrmi|#] [#|2010-11-11T09:16:23.535-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|connection OBJ Name while creation = jmxremote:type=jmx-connector-server,protocol=rmi_jrmp,name=system|#] [#|2010-11-11T09:16:23.553-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|Registered the connector :: jmxremote:type=jmx-connector-server,protocol=rmi_jrmp,name=system|#] [#|2010-11-11T09:16:24.985-0500|INFO|glassfish3.1|javax.enterprise.system.core.com.sun.enterprise.v3.server|_ThreadID=19;_ThreadName=Thread-2;|[Thread[GlassFish Kernel Main Thread,5,main]] started|#] [#|2010-11-11T09:16:37.825-0500|INFO|glassfish3.1|null|_ThreadID=19;_ThreadName=Thread-2;|Total number of available updates : 0|#]