Re: Weblogic 7.1 ..

Madhav Inamti <[email protected]> Wed, 26 Mar 2003 13:18:50 -0800
Newsgroups gmane.comp.java.sun.connector
Message-ID <75C025AE395F374B81F6416B1D4BDEFB0108D045@mtv-corpmail.microfocus.com>
Deb,



Here's the trace. This happens only with RA's that have local transaction/
XA transaction capability.



Thanks,



Madhav



-----Original Message-----
From: Deb June [mailto:[email protected]]
Sent: Wednesday, March 26, 2003 11:47 AM
To: [email protected]
Subject: Re: Weblogic 7.1 ..



Madhav,

We usually call matchManagedConnection with each connection request to give
the RAR an opportunity to validate that we are using an appropriate MC to
satisfy the connection request.

If you could send me a log, I can take a closer look.

Feel free to contact me offline about this.
Deb






I have a question on the way Weblogic works with regard to connector and
stateful session beans.



I would appreciate any answer/s to this.



I have the connection pool size set to 10. Weblogic obtains 10 managed
connections initially. When the EJB method is invoked which invokes the
connector to perform a method call on the EIS, Weblogic invokes
ManagedConnectionFactory::matchManagedConnection and goes through the list
of 10 Managed Connections and does not find anything.



Weblogic then destroys the first ManagedConnection in the pool and allocates
a new one, say MC1. So, the connection handle instance in the EJB is linked
to ManagedConnection MC1 by a call to ManagedConnection::getConnection.



After the EJB method call is over, Weblogic calls ManagedConnection::cleanup
to return the ManagedConnection to the pool.



The next time an EJB method is called, it does not seem to call
ManagedConnectionFactory::matchManagedConnection to find the matches in the
pool.



Websphere does call ManagedConnectionFactory::matchManagedConnection and
ManagedConnection::associateConnection

to associate the ManagedConnection with the connection handle



Is Weblogic performing some optimization here ? Should it not call
ManagedConnectionFactory::matchManagedConnection and
ManagedConnection::associateConnection ?



Thanks in advance,

Madhav
wl.log (application/octet-stream, 15 KB)
[(26 Mar 2003 13:17:47,859)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:47,921)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for 2efcb32c-d2c7-f305-ae49-fee0cc64a63e
[(26 Mar 2003 13:17:47,921)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is 2efcb32c-d2c7-f305-ae49-fee0cc64a63e
[(26 Mar 2003 13:17:47,921)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 1
[(26 Mar 2003 13:17:47,953)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:47,953)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for acd3335f-e695-a671-aba3-f74d4944da0d
[(26 Mar 2003 13:17:47,953)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is acd3335f-e695-a671-aba3-f74d4944da0d
[(26 Mar 2003 13:17:47,953)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 2
[(26 Mar 2003 13:17:47,953)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:47,953)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for 7abd8fe7-2b18-7c7c-c55e-1f29ab055d1c
[(26 Mar 2003 13:17:47,953)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is 7abd8fe7-2b18-7c7c-c55e-1f29ab055d1c
[(26 Mar 2003 13:17:47,953)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 3
[(26 Mar 2003 13:17:47,968)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:47,968)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for 7edd7e66-0393-4a78-5422-c304ba95730f
[(26 Mar 2003 13:17:47,968)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is 7edd7e66-0393-4a78-5422-c304ba95730f
[(26 Mar 2003 13:17:47,968)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 4
[(26 Mar 2003 13:17:47,968)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:47,968)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for cb3cd656-faef-6a3d-180c-27565d9bf62a
[(26 Mar 2003 13:17:47,968)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is cb3cd656-faef-6a3d-180c-27565d9bf62a
[(26 Mar 2003 13:17:47,968)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 5
[(26 Mar 2003 13:17:47,984)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:47,984)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for 4129cd5b-3701-ef65-ad7f-d07cf5f6caae
[(26 Mar 2003 13:17:47,984)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is 4129cd5b-3701-ef65-ad7f-d07cf5f6caae
[(26 Mar 2003 13:17:47,984)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 6
[(26 Mar 2003 13:17:47,984)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:47,984)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for 43a4f498-44f3-0040-a6b4-4d701acae78c
[(26 Mar 2003 13:17:47,984)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is 43a4f498-44f3-0040-a6b4-4d701acae78c
[(26 Mar 2003 13:17:47,984)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 7
[(26 Mar 2003 13:17:48,000)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:48,000)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for 76a15f71-c14e-aac7-752b-765604ee06d5
[(26 Mar 2003 13:17:48,000)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is 76a15f71-c14e-aac7-752b-765604ee06d5
[(26 Mar 2003 13:17:48,000)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 8
[(26 Mar 2003 13:17:48,000)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:48,000)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for 43efceaa-4591-d5dd-7f79-23172ae5700e
[(26 Mar 2003 13:17:48,000)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is 43efceaa-4591-d5dd-7f79-23172ae5700e
[(26 Mar 2003 13:17:48,000)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 9
[(26 Mar 2003 13:17:48,015)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:17:48,015)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for e2413324-27a5-1f94-16d8-4e034bdeae18
[(26 Mar 2003 13:17:48,015)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is e2413324-27a5-1f94-16d8-4e034bdeae18
[(26 Mar 2003 13:17:48,015)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 10
[(26 Mar 2003 13:19:00,171)com.microfocus.cobol.connector.spi.CobolConnectionRequestInfo(DEBUG)] 
Created a connection request info instance -USERPWD
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
Match managed Connections
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID to  match = 
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
Size of connection set is 10
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is 4129cd5b-3701-ef65-ad7f-d07cf5f6caae
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is 43a4f498-44f3-0040-a6b4-4d701acae78c
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is 2efcb32c-d2c7-f305-ae49-fee0cc64a63e
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is 7abd8fe7-2b18-7c7c-c55e-1f29ab055d1c
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is 43efceaa-4591-d5dd-7f79-23172ae5700e
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is acd3335f-e695-a671-aba3-f74d4944da0d
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is cb3cd656-faef-6a3d-180c-27565d9bf62a
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)]
GUID in connection set is 76a15f71-c14e-aac7-752b-765604ee06d5
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is 7edd7e66-0393-4a78-5422-c304ba95730f
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
GUID in connection set is e2413324-27a5-1f94-16d8-4e034bdeae18
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
No match found
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Removed a connection listener for 4129cd5b-3701-ef65-ad7f-d07cf5f6caae
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
destroy called
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
cleanup called
[(26 Mar 2003 13:19:00,187)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Disposing Cobol Connection4129cd5b-3701-ef65-ad7f-d07cf5f6caae
[(26 Mar 2003 13:19:00,203)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Closing the physical pipe to EIS
[(26 Mar 2003 13:19:00,203)com.microfocus.cobol.connector.ti.CobolSystemConnection(DEBUG)] 
START DISCONNECT - 8d39d37c-7f50-bcd7-ab11-78596981503c
[(26 Mar 2003 13:19:00,203)com.microfocus.cobol.connector.ti.CobolSystemConnection(DEBUG)] 
END DISCONNECT - 8d39d37c-7f50-bcd7-ab11-78596981503c
[(26 Mar 2003 13:19:00,203)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
url = TraceBean://CobolBean://localhost:9003
[(26 Mar 2003 13:19:00,203)com.microfocus.cobol.connector.spi.CobolLocalTxManagedConnectionFactory(DEBUG)] 
Returning a CobolManagedConnection to AppServr -USERPWD
[(26 Mar 2003 13:19:00,203)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Created a Connection event listener for 2316d123-a8fc-5703-4769-4d3df5f499ca
[(26 Mar 2003 13:19:00,203)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
Connection GUID is 2316d123-a8fc-5703-4769-4d3df5f499ca
[(26 Mar 2003 13:19:00,203)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
The number of cobol managed connections is 10
[(26 Mar 2003 13:19:00,218)com.microfocus.cobol.connector.spi.CobolManagedConnection(DEBUG)] 
CobolManagedConnection::getConnection called
[(26 Mar 2003 13:19:00,218)com.microfocus.cobol.connector.spi.CobolConnectionEventListener(DEBUG)] 
Added a connection listener for 2316d123-a8fc-5703-4769-4d3df5f499ca
[(26 Mar 2003 13:19:00,218)com.microfocus.cobol.connector.spi.CobolManagedConnection$aCobolCon(DEBUG)] 
creating a Cobol Interaction
[(26 Mar 2003 13:19:00,234)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Function Name = initialize
[(26 Mar 2003 13:19:00,234)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Created a new instance for output record
[(26 Mar 2003 13:19:00,234)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Calling initialize on - 2316d123-a8fc-5703-4769-4d3df5f499ca
[(26 Mar 2003 13:19:00,234)com.microfocus.cobol.connector.cci.CobolInteractionSpec(DEBUG)] 
Setting return code to 0
[(26 Mar 2003 13:19:00,234)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Returning output record
[(26 Mar 2003 13:19:00,234)com.microfocus.cobol.connector.spi.CobolManagedConnection$aCobolCon(DEBUG)] 
creating a Cobol Interaction
[(26 Mar 2003 13:19:00,234)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Calling Prepare for Cobcall
[(26 Mar 2003 13:19:00,250)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
In prepareForCobCall
[(26 Mar 2003 13:19:00,250)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Prepare for cobcall done
[(26 Mar 2003 13:19:00,250)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Calling cobcall on - 2316d123-a8fc-5703-4769-4d3df5f499ca
[(26 Mar 2003 13:19:01,015)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Back from cobcall
[(26 Mar 2003 13:19:01,015)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
In prepareFromCobCall
[(26 Mar 2003 13:19:01,015)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Length of outList = 1
[(26 Mar 2003 13:19:01,015)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Back from cobcall. Type is Indexed Record
[(26 Mar 2003 13:19:01,015)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
output is an instance of Indexed Record
[(26 Mar 2003 13:19:01,015)com.microfocus.cobol.connector.cci.CobolInteractionSpec(DEBUG)] 
Setting return code to 0
[(26 Mar 2003 13:19:02,531)com.microfocus.cobol.connector.spi.CobolManagedConnection$aCobolCon(DEBUG)] 
creating a Cobol Interaction
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Calling Prepare for Cobcall
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
In prepareForCobCall
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Prepare for cobcall done
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Calling cobcall on - 2316d123-a8fc-5703-4769-4d3df5f499ca
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Back from cobcall
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
In prepareFromCobCall
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Length of outList = 1
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Back from cobcall. Type is Indexed Record
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
output is an instance of Indexed Record
[(26 Mar 2003 13:19:02,546)com.microfocus.cobol.connector.cci.CobolInteractionSpec(DEBUG)] 
Setting return code to 0
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.spi.CobolManagedConnection$aCobolCon(DEBUG)] 
creating a Cobol Interaction
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Calling Prepare for Cobcall
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
In prepareForCobCall
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Prepare for cobcall done
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Calling cobcall on - 2316d123-a8fc-5703-4769-4d3df5f499ca
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Back from cobcall
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
In prepareFromCobCall
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Length of outList = 1
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
Back from cobcall. Type is Indexed Record
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteraction(DEBUG)] 
output is an instance of Indexed Record
[(26 Mar 2003 13:19:04,296)com.microfocus.cobol.connector.cci.CobolInteractionSpec(DEBUG)] 
Setting return code to 0