Skip to main content

developerWorks >  WebSphere  >  Forums  >  WebSphere Extended Deployment (XD)  >  developerWorks

Strange delay in objectgrid server    Point your RSS reader here for a feed of the latest messages in this thread


     

 
 

My developerWorks
 Welcome, Guest
Sign in or register
This question is not answered.

Permlink Replies: 1 - Pages: 1 - Last Post: Nov 11, 2009 11:50 AM Last Post By: jhanders Threads: [ Previous | Next ]
locklema

Posts: 24
Registered: Jun 06, 2008 11:18:20 AM
Strange delay in objectgrid server
Posted: Nov 11, 2009 07:47:05 AM
 
Click to report abuse...   Click to reply to this thread Reply
I have attached an object grid server transaction as an example of an issue that is puzzling me.

When seem to have a consistant 80-90ms delay on orders whenever we commit them to object-grid. This is regardless of whether we run in client or server mode.

Below is the log snippet in question.
[11/11/09 07:08:10:475 EST]    dae7c BaseMap       < applyPMap
                                 102
[11/11/09 07:08:10:555 EST]    dae7c BaseMap       > afterCompletion for: E324CDDB-0124-4000-E000-15CC97BF6A87 map=Order


Now as far as I can tell this is all internal to the object grid server, but no logs are being generated. Can you provide some insight into what is happening since this is badly effecting the performance of our application.

Thanks

Matt

I have attached a fuller trace from object grid server which was gather with trace set to *=debug=enabled
jhanders

Posts: 53
Registered: Jun 09, 2006 01:17:44 PM
Re: Strange delay in objectgrid server
Posted: Nov 11, 2009 11:50:29 AM   in response to: locklema in response to: locklema's post
 
Click to report abuse...   Click to reply to this thread Reply
We took a look at the log that was provided. Not knowing your configuration we had to make some assumptions. With additional information some things may be more clear. Here is what to look at:

Do you have replication enabled? If you have replication enabled, it is one of the operations that happens during the time between when the map being updated on the primary and afterCompletion being called. From looking at the trace it appears that replication is not enabled, but I could be mistaken.

The other major operation called during this time is TransactionCallback.commit(). I assume that you are using a TransactionCallback since you are using the write behind logic. From looking at the trace it appears you are calling find or get on one entry and updating it. According to the trace the get is a cache hit so the Loader should never be invoked. The TransactionCallback.begin will be called when the transaction is started, but it should not create a database connection at that time. Only if a Loader is invoked should it lazily create a database connection. When the TransactionCallback.commit is called it should look to see if a connection exists in the slot on the TxID that is reserved for connections and if it doesn't it should no-op otherwise it should close the connection and commit the database transaction. I am assuming the problem is that TransactionCallback.begin() is always creating a database connection and TransactionCallback.commit() is closing it. We had a similar issue with another customer where this type of issue was seen where cache hits were taking as long as cache misses and this was the issue.

If this is not the issue please let us know.

Jared Anderson
 Tags
Help

Use the search field to find all types of content in My developerWorks with that tag.

Use the slider bar to see more or fewer tags.

Popular tags shows the top tags for this particular type of content or application that you're viewing.

My tags shows your tags for this particular type of content or application that you're viewing.

 

MoreLess 


Point your RSS reader here for a feed of the latest messages in all forums