glassfish
  1. glassfish
  2. GLASSFISH-9133

Manual Recover-Transactions after this server instance crash is not supported

    Details

    • Type: Improvement Improvement
    • Status: Open
    • Priority: Major Major
    • Resolution: Unresolved
    • Affects Version/s: v2.1.1
    • Fix Version/s: future release
    • Component/s: jts
    • Labels:
      None
    • Environment:

      Operating System: Solaris
      Platform: Sun

    • Issuezilla Id:
      9,133

      Description

      I have a setup of DAS server connected to two databases (Java DB). I have
      deployed an application which connects to both the databases to update tables in
      a user transaction. I have used FailureInducer to induce a wait of 60 seconds in
      my application during the commit phase. When the transaction waits in the commit
      phase (ie, Prepared State), i bring down the appserver using "kill -9" unix
      command. Then i start the application server with automatic-recovery configured
      as false. But from the log i can observe that during the application server
      start-up it is invoking RecoveryManager.recover method.

      The transaction recovery does not happen after the application server is
      started. Then i executed the command asadmin recover-transactions command. The
      command output is given below

      ./asadmin recover-transactions server
      Command recover-transactions executed successfully.

      Though it says the command has executed successfully, the transaction recovery
      does not happen. The tables are still locked in the database after the execution
      of the command. When i do a select query on the table in any one of the two
      databases, i am getting the following error message

      Error code -1, SQL state 40XL1: A lock could not be obtained within the time
      requested
      Line 1, column 1

      Execution finished after 0 s, 1 error(s) occurred.

      I have provided the server log at Finest level for transaction as shown below

      [#|2009-08-14T14:54:05.271-0700|INFO|sun-appserver2.1|javax.enterprise.system.core|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;transactionapp;|CORE5022:
      All ejb(s) of [transactionapp] were unloaded successfully!|#]

      [#|2009-08-14T14:54:05.311-0700|INFO|sun-appserver2.1|javax.enterprise.system.tools.admin|_ThreadID=17;_ThreadName=httpWorkerThread-4848-1;/var/tmp/s1astempdomain1server416256446/transactionapp.ear;|ADM1064:The
      upload file at [/var/tmp/s1astempdomain1server416256446/transactionapp.ear]
      exists and will be overwritten.|#]

      [#|2009-08-14T14:54:05.312-0700|INFO|sun-appserver2.1|javax.enterprise.system.tools.admin|_ThreadID=17;_ThreadName=httpWorkerThread-4848-1;/var/tmp/s1astempdomain1server416256446/transactionapp.ear;|ADM1006:Uploading
      the file to:[/var/tmp/s1astempdomain1server416256446/transactionapp.ear]|#]

      [#|2009-08-14T14:54:05.975-0700|INFO|sun-appserver2.1|javax.enterprise.system.tools.deployment|_ThreadID=20;_ThreadName=Thread-3484;|deployed
      with moduleid = transactionapp|#]

      [#|2009-08-14T14:54:06.180-0700|INFO|sun-appserver2.1|javax.enterprise.system.core.classloading|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;transactionapp;|LDR5010:
      All ejb(s) of [transactionapp] loaded successfully!|#]

      [#|2009-08-14T14:54:06.572-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Creating tables|#]

      [#|2009-08-14T14:54:06.576-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      tx866128|#]

      [#|2009-08-14T14:54:06.577-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Executing create table using query :create table tx866128 (Account VARCHAR
      (50),bal INTEGER )|#]

      [#|2009-08-14T14:54:06.614-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|

      • Executed create Table |#]

      [#|2009-08-14T14:54:06.619-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Executing create table using query :create table tx866128 (name VARCHAR (50),bal
      INTEGER )|#]

      [#|2009-08-14T14:54:06.677-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|

      • Executed create Table |#]

      [#|2009-08-14T14:54:06.677-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Creating TxBean for Commit...|#]

      [#|2009-08-14T14:54:06.711-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Getting the User Transaction|#]

      [#|2009-08-14T14:54:06.712-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Beginning the Tx|#]

      [#|2009-08-14T14:54:06.712-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      tx begin...|#]

      [#|2009-08-14T14:54:06.712-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Inserting the data|#]

      [#|2009-08-14T14:54:06.712-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      insert in TxBean|#]

      [#|2009-08-14T14:54:06.712-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=CurrentImpl;MethodName=begin();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Before
      invoking create() on TxFactory|#]

      [#|2009-08-14T14:54:06.713-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TransactionFactoryImpl;MethodName=localCreate();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Control
      object :com.sun.jts.CosTransactions.ControlImpl@1d344e7 corresponding to this
      transaction has been createdGTID is :
      0300000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:06.713-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=CurrentImpl;MethodName=begin();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Before
      invoking CurrentTransaction.setCurrent(control,true)|#]

      [#|2009-08-14T14:54:06.713-0700|FINER|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TopCoordinator;MethodName=register_synchronization();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|SynchronizationImpl
      :com.sun.jts.jta.SynchronizationImpl@150a3dc has been registeredwith
      TopCoordinator :GTID is :
      0300000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:06.713-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TopCoordinator;MethodName=register_resource();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|OTSResource
      OTSResource : XAResource com.sun.gjc.spi.XAResourceImpl@135ca6c XID

      {XID: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)}

      has been registeredGTID
      is:0300000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:06.714-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Got DB Connection Successfully...|#]

      [#|2009-08-14T14:54:06.715-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TopCoordinator;MethodName=register_resource();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|OTSResource
      OTSResource : XAResource com.sun.gjc.spi.XAResourceImpl@4ee7c0 XID

      {XID: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)}

      has been registeredGTID
      is:0300000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:06.719-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Got DB Connection Successfully...|#]

      [#|2009-08-14T14:54:06.763-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      Account added Successfully...|#]

      [#|2009-08-14T14:54:06.763-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      before committing the tx sleeping for 20 Secs...|#]

      [#|2009-08-14T14:54:06.764-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=com.sun.jts.pi.InterceptorImpl;MethodName=send_request;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|
      sending_request[42] : _is_a, ThreadName :
      Thread[httpSSLWorkerThread-8080-1,10,Grizzly]|#]

      [#|2009-08-14T14:54:06.765-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=com.sun.jts.pi.InterceptorImpl;MethodName=receive_request_service_contexts;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|
      received_request[42] : _is_a, ThreadName :
      Thread[httpSSLWorkerThread-8080-1,10,Grizzly]|#]

      [#|2009-08-14T14:54:06.767-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=com.sun.jts.pi.InterceptorImpl;MethodName=send_request;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|
      sending_request[43] : getGlobalTID, ThreadName :
      Thread[httpSSLWorkerThread-8080-1,10,Grizzly]|#]

      [#|2009-08-14T14:54:06.768-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=com.sun.jts.pi.InterceptorImpl;MethodName=receive_request_service_contexts;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|
      received_request[43] : getGlobalTID, ThreadName :
      Thread[httpSSLWorkerThread-8080-1,10,Grizzly]|#]

      [#|2009-08-14T14:54:06.771-0700|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;|
      before commit ...|#]

      [#|2009-08-14T14:54:06.771-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=RegisterdSyncs;MethodName=distributeBefore();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Before
      invoking before_completion() on synchronization object
      com.sun.jts.jta.SynchronizationImpl@150a3dc|#]

      [#|2009-08-14T14:54:06.775-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=RegisterdSyncs;MethodName=distributeBefore();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|After
      invoking before_completion() on synchronization object
      com.sun.jts.jta.SynchronizationImpl@150a3dc|#]

      [#|2009-08-14T14:54:06.775-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TransactionState;MethodName=setState();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Acquiring
      read lock on freeze : state PREPARING|#]

      [#|2009-08-14T14:54:06.775-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TransactionState;MethodName=setState();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Acquired
      read lock on freeze : state PREPARING|#]

      [#|2009-08-14T14:54:06.775-0700|WARNING|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;0;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|JTS5057:
      FailPoint : [0]|#]

      [#|2009-08-14T14:54:06.775-0700|WARNING|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|JTS5057:
      FailPoint : [null]|#]

      [#|2009-08-14T14:54:06.776-0700|FINER|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=RegisteredResources;MethodName=prepare();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Before
      invoking prepare() on resource:OTSResource : XAResource
      com.sun.gjc.spi.XAResourceImpl@135ca6c XID

      {XID: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)}

      |#]

      [#|2009-08-14T14:54:06.780-0700|FINER|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=RegisteredResources;MethodName=prepare();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|After
      invoking prepare() on resource:OTSResource : XAResource
      com.sun.gjc.spi.XAResourceImpl@135ca6c XID

      {XID: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)}

      ;This resource voted :
      org.omg.CosTransactions.Vote@17750ef|#]

      [#|2009-08-14T14:54:06.780-0700|FINER|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=RegisteredResources;MethodName=prepare();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Before
      invoking prepare() on resource:OTSResource : XAResource
      com.sun.gjc.spi.XAResourceImpl@4ee7c0 XID

      {XID: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)}

      |#]

      [#|2009-08-14T14:54:06.788-0700|FINER|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=RegisteredResources;MethodName=prepare();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|After
      invoking prepare() on resource:OTSResource : XAResource
      com.sun.gjc.spi.XAResourceImpl@4ee7c0 XID

      {XID: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)}

      ;This resource voted :
      org.omg.CosTransactions.Vote@17750ef|#]

      [#|2009-08-14T14:54:06.788-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TransactionState;MethodName=setState();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Releasing
      read lock on freeze : state Illegal state |#]

      [#|2009-08-14T14:54:06.788-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TransactionState;MethodName=setState();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Released
      read lock on freeze|#]

      [#|2009-08-14T14:54:06.788-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TransactionState;MethodName=setState();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Released
      read lock on freeze : state Illegal state |#]

      [#|2009-08-14T14:54:06.789-0700|WARNING|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;1;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|JTS5057:
      FailPoint : [1]|#]

      [#|2009-08-14T14:54:06.797-0700|WARNING|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|JTS5057:
      FailPoint : [null]|#]

      [#|2009-08-14T14:54:06.797-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TopCoordinator;MethodName=commit();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Within
      TopCoordinator.commit()GTID is
      :0300000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:06.797-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TransactionState;MethodName=setState();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Acquiring
      read lock on freeze : state COMMITTING|#]

      [#|2009-08-14T14:54:06.797-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;ClassName=TransactionState;MethodName=setState();_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|Acquired
      read lock on freeze : state COMMITTING|#]

      [#|2009-08-14T14:54:06.797-0700|WARNING|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=21;_ThreadName=httpSSLWorkerThread-8080-1;2;_RequestID=bec4fc9e-9613-46ee-a65c-aa67c0ca4a41;|JTS5057:
      FailPoint : [2]|#]

      Aug 14, 2009 2:54:31 PM com.sun.enterprise.admin.servermgmt.launch.ASLauncher
      buildCommand
      INFO:
      /usr/jdk/instances/jdk1.5.0/jre/../bin/java
      -Dcom.sun.aas.instanceRoot=/export/nachi/V2/Appserver/glassfish/domains/domain1
      -Dcom.sun.aas.ClassPathPrefix=
      -Dcom.sun.aas.ClassPathSuffix=
      -Dcom.sun.aas.ServerClassPath=
      -Dcom.sun.aas.classloader.appserverChainJars.ee=
      -Dcom.sun.aas.classloader.appserverChainJars=admin-cli.jar,admin-cli-ee.jar,j2ee-svc.jar
      -Dcom.sun.aas.classloader.excludesList=admin-cli.jar,appserv-upgrade.jar,sun-appserv-ant.jar
      -Dcom.sun.aas.classloader.optionalOverrideableChain.ee=
      -Dcom.sun.aas.classloader.optionalOverrideableChain=webservices-rt.jar,webservices-tools.jar
      -Dcom.sun.aas.classloader.serverClassPath.ee=/lib/hadbjdbc4.jar,/export/nachi/V2/Appserver/glassfish/lib/SUNWjdmk/5.1/lib/jdmkrt.jar,/lib/dbstate.jar,/lib/hadbm.jar,/lib/hadbmgt.jar,/opt/SUNWmfwk/lib/mfwk_instrum_tk.jar
      -Dcom.sun.aas.classloader.serverClassPath=/export/nachi/V2/Appserver/glassfish/lib/install/applications/jmsra/imqjmsra.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/jaxm-api.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/fscontext.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/imqbroker.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/imqjmx.jar,/export/nachi/V2/Appserver/glassfish/lib/ant/lib/ant.jar,/export/nachi/V2/Appserver/glassfish/lib/SUNWjdmk/5.1/lib/jdmkrt.jar
      -Dcom.sun.aas.classloader.sharedChainJars.ee=appserv-se.jar,appserv-ee.jar,jesmf-plugin.jar,/lib/dbstate.jar,/lib/hadbjdbc4.jar,jgroups-all.jar,/opt/SUNWmfwk/lib/mfwk_instrum_tk.jar
      -Dcom.sun.aas.classloader.sharedChainJars=javaee.jar,/usr/jdk/instances/jdk1.5.0/jre/../lib/tools.jar,install/applications/jmsra/imqjmsra.jar,com-sun-commons-launcher.jar,com-sun-commons-logging.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/jaxm-api.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/fscontext.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/imqbroker.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/imqjmx.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/imqxm.jar,webservices-rt.jar,webservices-tools.jar,mail.jar,appserv-jstl.jar,jmxremote_optional.jar,/export/nachi/V2/Appserver/glassfish/lib/SUNWjdmk/5.1/lib/jdmkrt.jar,activation.jar,appserv-rt.jar,appserv-admin.jar,appserv-cmp.jar,/export/nachi/V2/Appserver/glassfish/updatecenter/lib/updatecenter.jar,/export/nachi/V2/Appserver/glassfish/jbi/lib/jbi.jar,/export/nachi/V2/Appserver/glassfish/imq/lib/imqjmx.jar,/export/nachi/V2/Appserver/glassfish/lib/ant/lib/ant.jar,dbschema.jar
      -Dcom.sun.aas.configName=server-config
      -Dcom.sun.aas.configRoot=/export/nachi/V2/Appserver/glassfish/config
      -Dcom.sun.aas.defaultLogFile=/export/nachi/V2/Appserver/glassfish/domains/domain1/logs/server.log
      -Dcom.sun.aas.domainName=domain1
      -Dcom.sun.aas.installRoot=/export/nachi/V2/Appserver/glassfish
      -Dcom.sun.aas.instanceName=server
      -Dcom.sun.aas.processLauncher=SE
      -Dcom.sun.aas.promptForIdentity=true
      -Dcom.sun.appserv.pluggable.features=com.sun.enterprise.ee.server.pluggable.EEPluggableFeatureImpl
      -Dcom.sun.enterprise.config.config_environment_factory_class=com.sun.enterprise.config.serverbeans.AppserverConfigEnvironmentFactory
      -Dcom.sun.enterprise.overrideablejavaxpackages=javax.help,javax.portlet
      -Dcom.sun.enterprise.taglibs=appserv-jstl.jar,jsf-impl.jar
      -Dcom.sun.enterprise.taglisteners=jsf-impl.jar
      -Dcom.sun.updatecenter.home=/export/nachi/V2/Appserver/glassfish/updatecenter
      -Ddomain.name=domain1
      -Djava.endorsed.dirs=/export/nachi/V2/Appserver/glassfish/lib/endorsed
      -Djava.ext.dirs=/usr/jdk/instances/jdk1.5.0/jre/../lib/ext:/usr/jdk/instances/jdk1.5.0/jre/../jre/lib/ext:/export/nachi/V2/Appserver/glassfish/domains/domain1/lib/ext:/export/nachi/V2/Appserver/glassfish/javadb/lib:/export/nachi/V2/Appserver/glassfish/lib/jdbcdrivers
      -Djava.library.path=/export/nachi/V2/Appserver/glassfish/lib:/export/nachi/V2/Appserver/glassfish/lib:/export/nachi/V2/Appserver/glassfish/lib
      -Djava.security.auth.login.config=/export/nachi/V2/Appserver/glassfish/domains/domain1/config/login.conf
      -Djava.security.policy=/export/nachi/V2/Appserver/glassfish/domains/domain1/config/server.policy
      -Djava.util.logging.manager=com.sun.enterprise.server.logging.ServerLogManager
      -Djavax.management.builder.initial=com.sun.enterprise.ee.admin.AppServerMBeanServerBuilder
      -Djavax.net.ssl.keyStore=/export/nachi/V2/Appserver/glassfish/domains/domain1/config/keystore.jks
      -Djavax.net.ssl.trustStore=/export/nachi/V2/Appserver/glassfish/domains/domain1/config/cacerts.jks
      -Djdbc.drivers=org.apache.derby.jdbc.ClientDriver
      -Djmx.invoke.getters=true
      -Dsun.rmi.dgc.client.gcInterval=3600000
      -Dsun.rmi.dgc.server.gcInterval=3600000
      -client
      -XX:+UnlockDiagnosticVMOptions
      -XX:MaxPermSize=192m
      -Xmx512m
      -XX:NewRatio=2
      -XX:+LogVMOutput
      -XX:LogFile=/export/nachi/V2/Appserver/glassfish/domains/domain1/logs/jvm.log
      -cp
      /export/nachi/V2/Appserver/glassfish/lib/jhall.jar:/export/nachi/V2/Appserver/glassfish/lib/appserv-launch.jar
      com.sun.enterprise.server.PELaunch
      start
      [#|2009-08-14T14:54:33.527-0700|INFO|sun-appserver2.1|javax.enterprise.system.core|_ThreadID=10;_ThreadName=main;Java
      HotSpot(TM) Client VM;1.5.0_12;Sun Microsystems Inc.;|CORE5076: Using [Java
      HotSpot(TM) Client VM, Version 1.5.0_12] from [Sun Microsystems Inc.]|#]

      [#|2009-08-14T14:54:33.593-0700|INFO|sun-appserver2.1|javax.enterprise.resource.jms|_ThreadID=11;_ThreadName=pool-1-thread-7;|Using
      MQ RA for Broker lifecycle control|#]

      [#|2009-08-14T14:54:33.635-0700|INFO|sun-appserver2.1|javax.enterprise.system.core.security|_ThreadID=12;_ThreadName=pool-1-thread-4;|SEC1002:
      Security Manager is OFF.|#]

      [#|2009-08-14T14:54:35.671-0700|INFO|sun-appserver2.1|javax.enterprise.system.core.security|_ThreadID=10;_ThreadName=main;com.sun.enterprise.security.provider.PolicyWrapper;|SEC1143:
      Loading policy provider com.sun.enterprise.security.provider.PolicyWrapper.|#]

      [#|2009-08-14T14:54:36.301-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.web|_ThreadID=10;_ThreadName=main;server;|WEB0114:
      SSO is disabled in virtual server [server]|#]

      [#|2009-08-14T14:54:36.313-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.web|ThreadID=10;_ThreadName=main;_asadmin;|WEB0114:
      SSO is disabled in virtual server [__asadmin]|#]

      [#|2009-08-14T14:54:36.318-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.web|_ThreadID=10;_ThreadName=main;com.ericsson.ssa.config.ConvergedContextConfig;|REgistering
      Custom ContextConfig|#]

      [#|2009-08-14T14:54:36.318-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.web|_ThreadID=10;_ThreadName=main;com.ericsson.ssa.config.ConvergedContextImpl;|REgistering
      Custom Context|#]

      [#|2009-08-14T14:54:36.724-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=10;_ThreadName=main;ClassName=Configuration;MethodName=setProperties();_RequestID=8c02f4b9-e82b-476c-b71e-4c6b77e3ef57;|
      Properties set are :

      { [ com.sun.jts.heuristicDirection->rollback ] [ com.sun.jts.logDirectory->/export/nachi/V2/Appserver/glassfish/domains/domain1/logs/server/tx ] [ com.sun.jts.commitRetry->600 ] [ com.sun.jts.keypointCount->65536 ] [ com.sun.jts.persistentServerId->3700 ] [ com.sun.jts.instancename->server ] }|#]

      [#|2009-08-14T14:54:37.407-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=10;_ThreadName=main;ClassName=com.sun.jts.pi.InterceptorImpl;MethodName=<init>;_RequestID=8c02f4b9-e82b-476c-b71e-4c6b77e3ef57;|Transaction
      INTEROP Mode: true|#]

      [#|2009-08-14T14:54:38.463-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=10;_ThreadName=main;ClassName=Configuration;MethodName=setProperties();_RequestID=8c02f4b9-e82b-476c-b71e-4c6b77e3ef57;|
      Properties set are :{ [ com.sun.jts.heuristicDirection->rollback ] [com.sun.jts.logDirectory->/export/nachi/V2/Appserver/glassfish/domains/domain1/logs/server/tx] [ com.sun.jts.commitRetry->600 ] [ com.sun.jts.keypointCount->65536 ] [com.sun.jts.persistentServerId->3700 ] [ com.sun.jts.instancename->server ] }

      |#]

      [#|2009-08-14T14:54:38.464-0700|INFO|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=10;_ThreadName=main;3700;|JTS5014:
      Recoverable JTS instance, serverId = [3700]|#]

      [#|2009-08-14T14:54:38.464-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=10;_ThreadName=main;ClassName=com.sun.jts.CosTransactions.Configuration;MethodName=getPropertyValue;_RequestID=8c02f4b9-e82b-476c-b71e-4c6b77e3ef57;|Property
      :com.sun.jts.instancename has the value : server|#]

      [#|2009-08-14T14:54:38.475-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=10;_ThreadName=main;ClassName=Configuration;MethodName=getDirectory();_RequestID=8c02f4b9-e82b-476c-b71e-4c6b77e3ef57;|Using
      directory = /export/nachi/V2/Appserver/glassfish/domains/domain1/logs/server/tx
      : provided in configuration|#]

      [#|2009-08-14T14:54:38.479-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=10;_ThreadName=main;ClassName=Configuration;MethodName=setServerName();_RequestID=8c02f4b9-e82b-476c-b71e-4c6b77e3ef57;|
      serverName = glassfish-x86-1,server,P3700; isRecoverable = true|#]

      [#|2009-08-14T14:54:38.506-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=10;_ThreadName=main;ClassName=RecoveryManager;MethodName=initialise();_RequestID=8c02f4b9-e82b-476c-b71e-4c6b77e3ef57;|Before
      starting ResyncThread |#]

      [#|2009-08-14T14:54:38.507-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=ResyncThread;MethodName=run();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Before
      invoking RecoveryManager.recover()|#]

      [#|2009-08-14T14:54:38.513-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=com.sun.jts.CosTransactions.Configuration;MethodName=getPropertyValue;_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Property
      :com.sun.jts.keypointCount has the value : 65536|#]

      [#|2009-08-14T14:54:38.515-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=Configuration;MethodName=getDirectory();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Using
      directory = /export/nachi/V2/Appserver/glassfish/domains/domain1/logs/server/tx
      : provided in configuration|#]

      [#|2009-08-14T14:54:38.549-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=RecoveryManager;MethodName=recover();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Before
      invoking proceedWithXARecovery()|#]

      [#|2009-08-14T14:54:38.549-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=com.sun.jts.CosTransactions.Configuration;MethodName=getPropertyValue;_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Property
      :com.sun.jts.ManualRecovery has the value : null|#]

      [#|2009-08-14T14:54:38.550-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=RecoveryManager;MethodName=resync();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Before
      invoking commit on the reconstructed coordinatorGTID is:
      0300000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:38.550-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TopCoordinator;MethodName=commit();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Within
      TopCoordinator.commit()GTID is
      :0300000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:38.551-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Acquiring
      read lock on freeze : state COMMITTING|#]

      [#|2009-08-14T14:54:38.551-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Acquired
      read lock on freeze : state COMMITTING|#]

      [#|2009-08-14T14:54:38.556-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Releasing
      read lock on freeze : state Illegal state |#]

      [#|2009-08-14T14:54:38.556-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Released
      read lock on freeze|#]

      [#|2009-08-14T14:54:38.556-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Released
      read lock on freeze : state Illegal state |#]

      [#|2009-08-14T14:54:38.566-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=RecoveryManager;MethodName=resync();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Before
      invoking commit on the reconstructed coordinatorGTID is:
      0200000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:38.566-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TopCoordinator;MethodName=commit();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Within
      TopCoordinator.commit()GTID is
      :0200000000DDBF1A676C617373666973682D7838362D312C7365727665722C5033373030|#]

      [#|2009-08-14T14:54:38.567-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Acquiring
      read lock on freeze : state COMMITTING|#]

      [#|2009-08-14T14:54:38.567-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Acquired
      read lock on freeze : state COMMITTING|#]

      [#|2009-08-14T14:54:38.567-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Releasing
      read lock on freeze : state Illegal state |#]

      [#|2009-08-14T14:54:38.567-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Released
      read lock on freeze|#]

      [#|2009-08-14T14:54:38.567-0700|FINEST|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=13;_ThreadName=JTS
      Resync
      Thread;ClassName=TransactionState;MethodName=setState();_RequestID=c5c179bd-9f91-4f0f-869e-4dd45fb4e903;|Released
      read lock on freeze : state Illegal state |#]

      [#|2009-08-14T14:54:38.821-0700|INFO|sun-appserver2.1|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;|ADM1079:
      Initialization of AMX MBeans started|#]

      [#|2009-08-14T14:54:39.090-0700|INFO|sun-appserver2.1|javax.enterprise.system.tools.admin|_ThreadID=14;_ThreadName=Thread-16;service:jmx:rmi:///jndi/rmi://glassfish-x86-1:8686/jmxrmi;|ADM1504:
      Here is the JMXServiceURL for the Standard JMXConnectorServer:
      [service:jmx:rmi:///jndi/rmi://glassfish-x86-1:8686/jmxrmi]. This is where the
      remote administrative clients should connect using the standard JMX connectors|#]

      [#|2009-08-14T14:54:39.090-0700|INFO|sun-appserver2.1|javax.enterprise.system.tools.admin|_ThreadID=14;_ThreadName=Thread-16;true;|ADM1506:
      Status of Standard JMX Connector: Active = [true]|#]

      [#|2009-08-14T14:54:39.762-0700|INFO|sun-appserver2.1|javax.enterprise.resource.resourceadapter|_ThreadID=10;_ThreadName=main;|JMS
      Service Connection URL is :mq://glassfish-x86-1:7676/|#]

      [#|2009-08-14T14:54:39.784-0700|INFO|sun-appserver2.1|javax.resourceadapter.mqjmsra.lifecycle|_ThreadID=10;_ThreadName=main;|MQJMSRA_RA1101:
      SJSMQ JMS Resource Adapter starting...|#]

      [#|2009-08-14T14:54:40.758-0700|INFO|sun-appserver2.1|javax.resourceadapter.mqjmsra.lifecycle|_ThreadID=10;_ThreadName=main;|MQJMSRA_EB1101:
      EMBEDDED broker started with code =0|#]

      [#|2009-08-14T14:54:40.760-0700|INFO|sun-appserver2.1|javax.resourceadapter.mqjmsra.lifecycle|_ThreadID=10;_ThreadName=main;|MQJMSRA_RA1101:
      SJSMQ JMSRA Started:DIRECT|#]

      [#|2009-08-14T14:54:41.929-0700|INFO|sun-appserver2.1|javax.enterprise.system.core.classloading|_ThreadID=10;_ThreadName=main;MEjbApp;|LDR5010:
      All ejb(s) of [MEjbApp] loaded successfully!|#]

      [#|2009-08-14T14:54:42.822-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.ejb|ThreadID=10;_ThreadName=main;jdbc/_TimerPool;|EJB5109:EJB
      Timer Service started successfully for datasource [jdbc/__TimerPool]|#]

      [#|2009-08-14T14:54:42.822-0700|INFO|sun-appserver2.1|javax.enterprise.system.core.classloading|ThreadID=10;_ThreadName=main;_ejb_container_timer_app;|LDR5010:
      All ejb(s) of [__ejb_container_timer_app] loaded successfully!|#]

      [#|2009-08-14T14:54:43.127-0700|INFO|sun-appserver2.1|com.sun.jbi.framework|_ThreadID=15;_ThreadName=pool-1-thread-3;|JBIFW0010:
      JBI framework ready to accept requests.|#]

      [#|2009-08-14T14:54:43.251-0700|INFO|sun-appserver2.1|javax.enterprise.system.core.classloading|_ThreadID=10;_ThreadName=main;transactionapp;|LDR5010:
      All ejb(s) of [transactionapp] loaded successfully!|#]

      [#|2009-08-14T14:54:43.261-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.web|_ThreadID=10;_ThreadName=main;|WEB0302:
      Starting Sun-Java-System/Application-Server.|#]

      [#|2009-08-14T14:54:43.585-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.web|_ThreadID=10;_ThreadName=main;8080;|WEB0712:
      Starting Sun-Java-System/Application-Server HTTP/1.1 on 8080|#]

      [#|2009-08-14T14:54:43.651-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.web|_ThreadID=10;_ThreadName=main;8181;|WEB0712:
      Starting Sun-Java-System/Application-Server HTTP/1.1 on 8181|#]

      [#|2009-08-14T14:54:43.663-0700|INFO|sun-appserver2.1|javax.enterprise.system.container.web|_ThreadID=10;_ThreadName=main;4848;|WEB0712:
      Starting Sun-Java-System/Application-Server HTTP/1.1 on 4848|#]

      [#|2009-08-14T14:54:44.200-0700|INFO|sun-appserver2.1|javax.enterprise.system.core.selfmanagement|_ThreadID=10;_ThreadName=main;|SMGT0007:
      Self Management Rules service is enabled|#]

      [#|2009-08-14T14:54:44.654-0700|WARNING|sun-appserver2.1|javax.enterprise.system.container.ejb|_ThreadID=10;_ThreadName=main;_RequestID=8c02f4b9-e82b-476c-b71e-4c6b77e3ef57;|EJBLifeCycle:
      Automatic timer migration component not enabled for DAS instance|#]

      [#|2009-08-14T14:54:44.674-0700|INFO|sun-appserver2.1|javax.enterprise.system.core|_ThreadID=10;_ThreadName=main;|Application
      server startup complete.|#]

      [#|2009-08-14T14:57:49.290-0700|WARNING|sun-appserver2.1|javax.enterprise.resource.resourceadapter|ThreadID=16;_ThreadName=httpWorkerThread-4848-0;_CallFlowPool;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|RAR5005:Error
      in accessing XA resource with JNDI name [__CallFlowPool] for recovery|#]

      [#|2009-08-14T14:57:49.294-0700|WARNING|sun-appserver2.1|javax.enterprise.resource.resourceadapter|ThreadID=16;_ThreadName=httpWorkerThread-4848-0;_TimerPool;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|RAR5005:Error
      in accessing XA resource with JNDI name [__TimerPool] for recovery|#]

      [#|2009-08-14T14:57:49.295-0700|INFO|sun-appserver2.1|javax.enterprise.resource.resourceadapter|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;|Recovery
      of Inbound Transactions started.|#]

      [#|2009-08-14T14:57:49.296-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=getInDoubtXids();_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|Before
      receiving inDoubtXids from xaresource = com.sun.gjc.spi.XAResourceImpl@1601539|#]

      [#|2009-08-14T14:57:49.298-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=getInDoubtXid();_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|InDoubtXids
      returned from xaresource = com.sun.gjc.spi.XAResourceImpl@1601539are: Xid class
      name is org.apache.derby.client.ClientXid Number of Xids are 4 [

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 9D753F1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)} {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(02000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)} {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(04000000 0EEDF919 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)} {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)}

      ]|#]

      [#|2009-08-14T14:57:49.299-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=recoverIncompleteTx;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|
      This xid is UNIQUE

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 9D753F1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)}

      |#]

      [#|2009-08-14T14:57:49.305-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=recoverIncompleteTx;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|
      This xid is UNIQUE

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(02000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)}

      |#]

      [#|2009-08-14T14:57:49.305-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=recoverIncompleteTx;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|
      This xid is UNIQUE

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(04000000 0EEDF919 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)}

      |#]

      [#|2009-08-14T14:57:49.305-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=recoverIncompleteTx;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|
      This xid is UNIQUE

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C01)}

      |#]

      [#|2009-08-14T14:57:49.306-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=getInDoubtXids();_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|Before
      receiving inDoubtXids from xaresource = com.sun.gjc.spi.XAResourceImpl@11d3f0b|#]

      [#|2009-08-14T14:57:49.306-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=getInDoubtXid();_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|InDoubtXids
      returned from xaresource = com.sun.gjc.spi.XAResourceImpl@11d3f0bare: Xid class
      name is org.apache.derby.client.ClientXid Number of Xids are 3 [

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 9D753F1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)} {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(04000000 0EEDF919 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)} {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)}

      ]|#]

      [#|2009-08-14T14:57:49.306-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=recoverIncompleteTx;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|
      This xid is UNIQUE

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 9D753F1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)}

      |#]

      [#|2009-08-14T14:57:49.307-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=recoverIncompleteTx;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|
      This xid is UNIQUE

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(04000000 0EEDF919 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)}

      |#]

      [#|2009-08-14T14:57:49.307-0700|FINE|sun-appserver2.1|javax.enterprise.system.core.transaction|_ThreadID=16;_ThreadName=httpWorkerThread-4848-0;ClassName=RecoveryManager;MethodName=recoverIncompleteTx;_RequestID=302b7b14-105d-429a-96bd-f952d6676e99;|
      This xid is UNIQUE

      {ClientXid: formatID(4871251), gtrid_length(36), bqual_length(30), data(03000000 00DDBF1A 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 676C6173 73666973 682D7838 362D312C 73657276 65722C50 33373030 2C00)}

      |#]

        Activity

        Hide
        marina vatkina added a comment -

        Can it be the same problem as CR 6673688? The recovery skips resources that are
        not up by the time the revovery is happening?

        Show
        marina vatkina added a comment - Can it be the same problem as CR 6673688? The recovery skips resources that are not up by the time the revovery is happening?
        Hide
        nachi_glassfish added a comment -

        This is a different scenario. In this case, the application server is brought
        down and started again. The resources are always are up and running.

        Show
        nachi_glassfish added a comment - This is a different scenario. In this case, the application server is brought down and started again. The resources are always are up and running.
        Hide
        marina vatkina added a comment -

        It might still be an error in Derby with the lock handling

        Show
        marina vatkina added a comment - It might still be an error in Derby with the lock handling
        Hide
        marina vatkina added a comment -

        not a blocker

        Show
        marina vatkina added a comment - not a blocker
        Hide
        marina vatkina added a comment -

        Unfortunately the scenario described in this bug - server crash and automatic
        recovery not enabled - is not a supported option.

        Manual recovery is supported only for a resource recovery on a live server, that
        is when one of the resource manager dies and comes and you want to perform recovery.

        I'll file a separate doc bug to document this limitation, but I'm changing this
        issue to be an RFE for the next release

        Show
        marina vatkina added a comment - Unfortunately the scenario described in this bug - server crash and automatic recovery not enabled - is not a supported option. Manual recovery is supported only for a resource recovery on a live server, that is when one of the resource manager dies and comes and you want to perform recovery. I'll file a separate doc bug to document this limitation, but I'm changing this issue to be an RFE for the next release
        Hide
        marina vatkina added a comment -

        The problem applies to non-delegated recovery only

        Show
        marina vatkina added a comment - The problem applies to non-delegated recovery only

          People

          • Assignee:
            marina vatkina
            Reporter:
            nachi_glassfish
          • Votes:
            0 Vote for this issue
            Watchers:
            0 Start watching this issue

            Dates

            • Created:
              Updated: