Re: Finding why two UPDATES are send
Re: Finding why two UPDATES are send
- Subject: Re: Finding why two UPDATES are send
- From: Chuck Hill <email@hidden>
- Date: Thu, 22 Apr 2010 12:50:07 -0700
On Apr 22, 2010, at 12:41 PM, Pascal Robert wrote:
Setting
er.extensions.ERXAdaptorChannelDelegate.enabled=true
er.extensions.ERXAdaptorChannelDelegate.trace.milliSeconds.info=1
er.extensions.ERXAdaptorChannelDelegate.trace.entityMatchPattern
= .*
Should give you a stack trace of where the second update
originates.
Based on the delay, I'd guess a refresh of some sort from the
browser. Check your Ajax usage. Also override dispatchRequest()
in Application and log out the request.uri() so that you can see
the traffic coming in.
Ah yes, the SQL Server calls does happen in a WOLongResponsePage.
So I will check that out.
The two updates runs in the same request (eg, the URI didn't
change) :-/ In fact, they are running in the same transaction.
So, it's part of the same transaction, and it's timed only one time :
2010-04-22 15:36:37,811 [ERXNSLogLog4jBridge.java:46] DEBUG - ===
Begin Internal Transaction
2010-04-22 15:36:37,812 [ERXNSLogLog4jBridge.java:46] DEBUG -
evaluateExpression:
<com.webobjects.jdbcadaptor.MicrosoftSQLServerPlugIn
$MicrosoftSQLServerExpression: "UPDATE dbo.CommandesEcom SET
CommandeComplet = ? WHERE NoCommandeOracle = ?" withBindings:
1:true(commandeComplet), 2:6091(noCommandeOracle)>
The gap between log messages here is 0.5 seconds and note the missing
log message
"2010-04-22 15:36:38,324 [ERXEOAccessUtilities.java:1213] INFO -
"CommandesEcom"@8796244 expression took X ms: "
Or did you delete that by accident?
2010-04-22 15:36:38,319 [ERXNSLogLog4jBridge.java:46] DEBUG -
evaluateExpression:
<com.webobjects.jdbcadaptor.MicrosoftSQLServerPlugIn
$MicrosoftSQLServerExpression: "UPDATE dbo.CommandesEcom SET
CommandeComplet = ? WHERE NoCommandeOracle = ?" withBindings:
1:true(commandeComplet), 2:6091(noCommandeOracle)>
2010-04-22 15:36:38,324 [ERXEOAccessUtilities.java:1213] INFO -
"CommandesEcom"@8796244 expression took 5 ms: UPDATE
dbo.CommandesEcom SET CommandeComplet = ? WHERE NoCommandeOracle = ?
withBindings: 1:NULL[commandeComplet], 2:6091[noCommandeOracle]
That one was 0.005 ms not 0.5 like the first. Are you hitting a
timeout of some sort? Database returning an error and EOF retrying?
Is inheritance involved?
2010-04-22 15:36:38,335 [ERXNSLogLog4jBridge.java:46] DEBUG - ===
Commit Internal Transaction
--
Chuck Hill Senior Consultant / VP Development
Practical WebObjects - for developers who want to increase their
overall knowledge of WebObjects or who are trying to solve specific
problems.
http://www.global-village.net/products/practical_webobjects
_______________________________________________
Do not post admin requests to the list. They will be ignored.
Webobjects-dev mailing list (email@hidden)
Help/Unsubscribe/Update your Subscription:
This email sent to email@hidden