Eclipse Community Forums
Forum Search:

Search      Help    Register    Login    Home
Home » Eclipse Projects » EclipseLink » Database Locks after upgrading from Toplink to Eclipselink(A non-released read lock is blocking the wrting threads to acquire a write lock)
Database Locks after upgrading from Toplink to Eclipselink [message #518922] Fri, 05 March 2010 13:18 Go to next message
Ilyes Ben Hassen is currently offline Ilyes Ben Hassen
Messages: 2
Registered: March 2010
Junior Member
Since our upgrade from Toplonk 10.1.3.3.0 to Eclipselink 2.0.0 and then to 2.0.1 we are experiencing non-reproducable locks on the Database.
After a long debugging we were not able to figure out where this comes from. I added more debugging on the ConcurrencyManager to see what's happening. It seems, according to the logs, that a readLock was not released while acquiring a write lock and that caused the writing Thread to wait forever.
For more detailed information see the following logs and the Thread dump. TP-Processor9 and TP-Processor28 are the Threads waiting to acquire the write locks.
NB: The added debugging code is marked in blue, which yeilds the red marked debug messages.

-------

public synchronized void acquire(boolean forMerge) throws ConcurrencyException {
while (((this.activeThread != null) || (this.numberOfReaders > 0)) && (this.activeThread != Thread.currentThread())) {
// This must be in a while as multiple threads may be released, or another thread may rush the acquire after one is released.
if(this.ownerCacheKey != null){
AbstractSessionLog.getLog().log(SessionLog.FINER, "wait_acquire_lock " + toString(),this.ownerCacheKey.getObject(),", numberOfReaders=" + this.numberOfReaders);
}else{
AbstractSessionLog.getLog().log(SessionLog.FINER, "wait_acquire_lock " + toString() ,"numberOfReaders=" + this.numberOfReaders);
}
if(activeThread != null){
Object obj = (this.ownerCacheKey != null)? this.ownerCacheKey.getObject(): null;
AbstractSessionLog.getLog().log(SessionLog.FINER, "wait_acquire_lock_activeThread " + toString()," activeThread: " + activeThread.getName(),obj,", numberOfReaders=" + this.numberOfReaders);
Exception exp = new Exception("activeThread=" + activeThread.getName() + " numberOfReaders= " + numberOfReaders + " currentThread=" +Thread.currentThread() + " LockedObject=" + obj);
AbstractSessionLog.getLog().logThrowable(SessionLog.FINER,ex p);

}
try {
this.numberOfWritersWaiting++;
wait();
this.numberOfWritersWaiting--;
} catch (InterruptedException exception) {
throw ConcurrencyException.waitWasInterrupted(exception.getMessage ());
}
}
if (this.activeThread == null) {
this.activeThread = Thread.currentThread();
}
this.lockedByMergeManager = forMerge;
this.depth++;
}
-----------------
2010-03-05 08:10:27,883 3800321 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:10:27,883 3800321 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225) - acquire_unit_of_work_with_argument - 29938688
2010-03-05 08:10:27,883 3800321 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Account@1313e0e ID=19157222
2010-03-05 08:10:27,884 3800322 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Person@c8d62f ID=59458036
2010-03-05 08:10:27,884 3800322 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@c8d62f ID=59458036
2010-03-05 08:10:27,884 3800322 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Account@1313e0e ID=19157222
2010-03-05 08:10:27,884 3800322 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Portfolio@140c973 ID=20365378
2010-03-05 08:10:27,885 3800323 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - unregister - com.acme.model.Kfz_Daten@1611aec ID=27747240
2010-03-05 08:10:27,886 3800324 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - unregister - com.acme.model.Person@c8d62f ID=59458036
2010-03-05 08:10:27,887 3800325 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Kfz_Daten@84c1f9 ID=null
2010-03-05 08:10:27,887 3800325 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Person@b4ef2 ID=null
2010-03-05 08:10:27,887 3800325 INFO (services.persistence.ToplinkTransaction) - >>> Try to registering a not-original version of class com.acme.model.Account (an Object with primary key). The original version is registered instead.
2010-03-05 08:10:27,887 3800325 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Account@1313e0e ID=19157222
2010-03-05 08:10:27,888 3800326 INFO (services.persistence.ToplinkTransaction) - >>> Try to registering a not-original version of class com.acme.model.Portfolio (an Object with primary key). The original version is registered instead.
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Portfolio@140c973 ID=20365378
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - ClientSession(6217586) - execute_query - ReadObjectQuery(referenceClass=Account )
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - ClientSession(6217586) - client_released
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Account@1aea727 ID=0
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - ClientSession(27655250) - execute_query - ReadObjectQuery(referenceClass=Portfolio )
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - ClientSession(27655250) - client_released
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Portfolio@19c18ae ID=0
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@1db5427 ID=59448033
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@c8d62f ID=59458036
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@c8d62f ID=59458036
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Account@1313e0e ID=19157222
2010-03-05 08:10:27,888 3800326 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Portfolio@140c973 ID=20365378
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Account@1aea727 ID=0
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Portfolio@19c18ae ID=0
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@1c6cc9c ID=59448128
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@c8d62f ID=59458036
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Account@1aea727 ID=0
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Portfolio@19c18ae ID=0
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@1bb3e9a ID=59447640
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@c8d62f ID=59458036
2010-03-05 08:10:27,889 3800327 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Account@1aea727 ID=0
2010-03-05 08:10:27,890 3800328 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Portfolio@19c18ae ID=0
2010-03-05 08:10:27,890 3800328 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register_existing - com.acme.model.Person@c8d62f ID=59458036
2010-03-05 08:10:27,890 3800328 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Vorversicherung@1b6c74 ID=null
2010-03-05 08:10:27,890 3800328 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Account@1313e0e ID=19157222
2010-03-05 08:10:27,890 3800328 INFO (services.persistence.ToplinkTransaction) - >>> Try to registering a not-original version of class com.acme.model.Kfz_Daten (an Object with primary key). The original version is registered instead.
2010-03-05 08:10:27,890 3800328 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - register - com.acme.model.Kfz_Daten@84c1f9 ID=null
2010-03-05 08:10:27,890 3800328 INFO (services.persistence.ToplinkTransaction) - call to method ensureUoWisActive.
2010-03-05 08:10:27,890 3800328 INFO (services.persistence.ToplinkTransaction) - successfully finished with ensureUoWisActive() and going further with commit.
2010-03-05 08:10:27,891 3800329 DEBUG (services.persistence.ToplinkTransaction) - Committing Transaction ...
2010-03-05 08:10:27,891 3800329 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - validate_object_space
2010-03-05 08:10:27,891 3800329 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - begin_unit_of_work_commit
2010-03-05 08:10:27,891 3800329 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225) - execute_query - ValueReadQuery(sql="SELECT SEQ_Person.NEXTVAL FROM DUAL")
2010-03-05 08:10:27,891 3800329 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(4750431) - SELECT SEQ_Person.NEXTVAL FROM DUAL
2010-03-05 08:10:27,892 3800330 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - assign_sequence - 59458178 - com.acme.model.Person@6bf80b ID=null
2010-03-05 08:10:27,892 3800330 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225) - execute_query - ValueReadQuery(sql="SELECT SEQ_Vorversicherung.NEXTVAL FROM DUAL")
2010-03-05 08:10:27,892 3800330 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(4750431) - SELECT SEQ_Vorversicherung.NEXTVAL FROM DUAL
2010-03-05 08:10:27,894 3800332 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - assign_sequence - 29306749 - com.acme.model.Vorversicherung@6d65fd ID=null
2010-03-05 08:10:27,895 3800333 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225) - execute_query - ValueReadQuery(sql="SELECT SEQ_Kfz_Daten.NEXTVAL FROM DUAL")
2010-03-05 08:10:27,895 3800333 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(4750431) - SELECT SEQ_Kfz_Daten.NEXTVAL FROM DUAL
2010-03-05 08:10:27,896 3800334 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - assign_sequence - 27747300 - com.acme.model.Kfz_Daten@1dae27f ID=null
2010-03-05 08:10:27,898 3800336 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225) - execute_query - ValueReadQuery(sql="SELECT SEQ_Person_Kfz_Daten.NEXTVAL FROM DUAL")
2010-03-05 08:10:27,898 3800336 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(4750431) - SELECT SEQ_Person_Kfz_Daten.NEXTVAL FROM DUAL
2010-03-05 08:10:27,900 3800338 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - assign_sequence - 56398378 - com.acme.model.Person_Kfz_Daten@4301c9 ID=null
2010-03-05 08:10:27,900 3800338 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - begin_transaction
2010-03-05 08:10:27,900 3800338 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - UpdateObjectQuery(com.acme.model.Person@1075056)
2010-03-05 08:10:27,900 3800338 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Person@6bf80b)
2010-03-05 08:10:27,901 3800339 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Person@6bf80b)
2010-03-05 08:10:27,901 3800339 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - begin_batch_statements
2010-03-05 08:10:27,901 3800339 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - INSERT IGNORE INTO Person (ID, anrede, titel, familienname, familiennameLow, vorname, vornameLow, geburtsdatum, geschlecht, familienstand, arbeitsweise, wohnungseigentum, mitgliedBUND, accountInfo, news, datenSpeichern, datenWeitergabe, ODState, automobilclub, automobilclubSeit, automobilclubNummer, lebtImHaushalt, fsErteilung, bahncard, jahreskarteOEPV, anzahlPkwHaushalt, smoker, danger, azubi, leitendeTaetigkeit, berufFreiText, arbeitgeber, dienststelle, geburtsort, einkommensgruppe, eintragVZR, checked, currentpersonID, accountID, portfolioID, brancheID, berufID, berufsgruppeID, firmaID, wohnungversichertBeiID, address_plz, address_strasse, address_ergaenzung, address_hausnummer, address_firma, address_telefonTags, address_telefonAbends, address_handy, address_telefax, address_email, Address_staatID, Address_ortID, nationalitaetID, fsLandID) VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
2010-03-05 08:10:27,902 3800340 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - bind =>
2010-03-05 08:10:27,902 3800340 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - end_batch_statements
2010-03-05 08:10:27,935 3800373 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - begin_batch_statements
2010-03-05 08:10:27,935 3800373 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - UPDATE Person SET geburtsdatum = ?, brancheID = ?, address_email = ?, Address_staatID = ?, address_telefonTags = ?, address_plz = ?, address_hausnummer = ?, Address_ortID = ?, address_strasse = ?, berufsgruppeID = ?, wohnungversichertBeiID = ?, familienstand = ?, familiennameLow = ?, titel = ?, portfolioID = ?, firmaID = ?, familienname = ?, fsLandID = ?, currentpersonID = ?, vornameLow = ?, automobilclub = ?, nationalitaetID = ?, accountID = ?, vorname = ?, berufID = ?, accountInfo = ?, fsErteilung = ?, arbeitsweise = ?, checked = ?, bahncard = ?, anrede = ? WHERE (ID = ?)
2010-03-05 08:10:27,935 3800373 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - bind =>
2010-03-05 08:10:27,936 3800374 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - end_batch_statements
2010-03-05 08:10:27,961 3800399 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - UpdateObjectQuery(com.acme.model.Person@ec7913)
2010-03-05 08:10:27,961 3800399 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Person@6bf80b)
2010-03-05 08:10:27,961 3800399 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - UpdateObjectQuery(com.acme.model.Person@1010435)
2010-03-05 08:10:27,961 3800399 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Person@6bf80b)
2010-03-05 08:10:27,962 3800400 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - begin_batch_statements
2010-03-05 08:10:27,962 3800400 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - UPDATE Person SET currentpersonID = ? WHERE (ID = ?)
2010-03-05 08:10:27,962 3800400 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - bind =>
2010-03-05 08:10:27,962 3800400 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - bind =>
2010-03-05 08:10:27,962 3800400 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - end_batch_statements
2010-03-05 08:10:27,966 3800404 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - UpdateObjectQuery(com.acme.model.Person@1441dc0)
2010-03-05 08:10:27,966 3800404 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Person@6bf80b)
2010-03-05 08:10:27,967 3800405 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - begin_batch_statements
2010-03-05 08:10:27,967 3800405 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - UPDATE Person SET currentpersonID = ?, accountID = ?, portfolioID = ? WHERE (ID = ?)
2010-03-05 08:10:27,967 3800405 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - bind =>
2010-03-05 08:10:27,967 3800405 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - end_batch_statements
2010-03-05 08:10:27,976 3800414 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - InsertObjectQuery(com.acme.model.Vorversicherung@6d65fd)
2010-03-05 08:10:27,977 3800415 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - begin_batch_statements
2010-03-05 08:10:27,977 3800415 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - UPDATE Person SET currentpersonID = ? WHERE (ID = ?)
2010-03-05 08:10:27,977 3800415 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - bind =>
2010-03-05 08:10:27,977 3800415 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - end_batch_statements
2010-03-05 08:10:27,979 3800417 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - InsertObjectQuery(com.acme.model.Kfz_Daten@1dae27f)
2010-03-05 08:10:27,979 3800417 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Person@6bf80b)
2010-03-05 08:10:27,979 3800417 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Vorversicherung@6d65fd)
2010-03-05 08:10:27,980 3800418 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - begin_batch_statements
2010-03-05 08:10:27,980 3800418 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - INSERT IGNORE INTO Vorversicherung (ID, abschlussDatum, vertragsnummer, kuendigung, kuendigungWann, versicherungsArt, versichererID) VALUES (?, ?, ?, ?, ?, ?, ?)
2010-03-05 08:10:27,980 3800418 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - bind =>
2010-03-05 08:10:27,980 3800418 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - end_batch_statements
2010-03-05 08:10:27,989 3800427 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - InsertObjectQuery(com.acme.model.Person_Kfz_Daten@4301c9)
2010-03-05 08:10:27,989 3800427 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Person@6bf80b)
2010-03-05 08:10:27,989 3800427 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(29938688) - execute_query - WriteObjectQuery(com.acme.model.Kfz_Daten@1dae27f)
2010-03-05 08:10:27,989 3800427 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - begin_batch_statements
2010-03-05 08:10:27,990 3800428 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - INSERT IGNORE INTO Kfz_Daten (ID, Version, revision, Active, ntesFahrzeug, deckungKH, fahrgestellnr, neuwert, zeitwert, zubehoerwert, jahreskilometer, erstzulassung, zulassungDurchVN, wegfahrsperre, finanzierung, jahreswagen, airbag, alarmanlage, kmStand, halter, alterMaennlich, alterWeiblich, alterAeltesterFahrer, hatAndereNutzer, nutzung, fahrtzweck, nutzungAusland, nutzungDienstreisen, nutzungArbeitsanfahrt, hatSchaeden, stellplatz, stellplatzAbschliessbar, stellplatzOeffentlich, willSchutzbrief, versicherungswechsler, zahlweise, willBankeinzug, werkstattBindung, versicherungsbeginn, IstZweitfahrzeug, istErstfahrzeugPKW, erstfahrzeugHalterTyp, payFee, reminder_done, reminder_processingtime, sessionid, machineid, creditCrossSellingState, hidden, remindNewTariffs, rueckdatierer, versicherungsbeginnWunsch, KFZ_TypID, personID, KFZ_SFK_HaftpflichtID, KFZ_SFK_VollkaskoID, KFZ_KaskotypID, vorversicherungID, KFZ_StellplatzID, kennzeichen_nummer, kennzeichen_plz, kennzeichen_saison, kennzeichen_saisonVon, kennzeichen_saisonBis, Kennzeichen_bezirkID, KFZ_SFK_KH_ErstfahrzeugID, KFZ_SFK_VK_ErstfahrzeugID, ErstfahrzeugVorversicherungID, HalterKFZID, HalterOrtID, AccountID, anfrage_typ, anfrage_schutzbrief, anfrage_mallorcaPolice, anfrage_erhoehteDeckungKH, anfrage_rabattretterKH, anfrage_rabattretterKasko, anfrage_freieWerkstattwahl, anfrage_werkstattbindung, anfrage_marderschaeden, anfrage_wildschaeden, anfrage_grobeFahrlaessigkeit, anfrage_neuwerterstattung, anfrage_GAPDeckung) VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
2010-03-05 08:10:27,990 3800428 INFO (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - bind =>
2010-03-05 08:10:27,990 3800428 DEBUG (services.toplink.ToplinkLogging) - ClientSession(30829225), Connection(4750431) - end_batch_statements
2010-03-05 08:10:28,023 3800461 DEBUG (services.toplink.ToplinkLogging) - - wait_acquire_lock ConcurrencyManager(nest level = 0) - com.acme.model.Person@c8d62f ID=59458036 - , numberOfReaders=1
-----------------------


2010-03-05 08:07:19,730 3612168 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,730 3612168 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,730 3612168 DEBUG (services.toplink.ToplinkLogging) - ClientSession(25881841) - execute_query - ReadAllQuery(referenceClass=KFZ_ClosingError )
2010-03-05 08:07:19,731 3612169 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT ID, modified, erstellung, Beschreibung, itKlaert, erledigt, KFZ_ActionID FROM KFZ_ClosingError WHERE (KFZ_ActionID = ?)
bind =>
2010-03-05 08:07:19,734 3612172 DEBUG (services.toplink.ToplinkLogging) - ClientSession(25881841) - client_released
2010-03-05 08:07:19,734 3612172 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,734 3612172 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,734 3612172 DEBUG (services.toplink.ToplinkLogging) - ClientSession(24212276) - execute_query - ReadAllQuery(referenceClass=KFZ_Pagination )
2010-03-05 08:07:19,735 3612173 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT ID, modified, nummer, paginierzeit, eingangstag, doppel, fuellstatus, bearbeitung, done, locked, version, KFZ_ActionID, version FROM KFZ_Pagination WHERE (KFZ_ActionID = ?)
bind =>
2010-03-05 08:07:19,737 3612175 DEBUG (services.toplink.ToplinkLogging) - ClientSession(24212276) - client_released
2010-03-05 08:07:19,737 3612175 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,737 3612175 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,737 3612175 DEBUG (services.toplink.ToplinkLogging) - ClientSession(10134515) - execute_query - ReadAllQuery(referenceClass=KFZ_ClosingError )
2010-03-05 08:07:19,737 3612175 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT ID, modified, erstellung, Beschreibung, itKlaert, erledigt, KFZ_ActionID FROM KFZ_ClosingError WHERE (KFZ_ActionID = ?)
bind =>
2010-03-05 08:07:19,738 3612176 DEBUG (services.toplink.ToplinkLogging) - ClientSession(10134515) - client_released
2010-03-05 08:07:19,738 3612176 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,738 3612176 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,738 3612176 DEBUG (services.toplink.ToplinkLogging) - ClientSession(8510245) - execute_query - ReadAllQuery(referenceClass=KFZ_Pagination )
2010-03-05 08:07:19,738 3612176 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT ID, modified, nummer, paginierzeit, eingangstag, doppel, fuellstatus, bearbeitung, done, locked, version, KFZ_ActionID, version FROM KFZ_Pagination WHERE (KFZ_ActionID = ?)
bind =>
2010-03-05 08:07:19,739 3612177 DEBUG (services.toplink.ToplinkLogging) - ClientSession(8510245) - client_released
2010-03-05 08:07:19,739 3612177 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,739 3612177 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,739 3612177 DEBUG (services.toplink.ToplinkLogging) - ClientSession(33411906) - execute_query - ReadAllQuery(referenceClass=KFZ_ClosingError )
2010-03-05 08:07:19,739 3612177 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT ID, modified, erstellung, Beschreibung, itKlaert, erledigt, KFZ_ActionID FROM KFZ_ClosingError WHERE (KFZ_ActionID = ?)
bind =>
2010-03-05 08:07:19,739 3612177 DEBUG (services.toplink.ToplinkLogging) - ClientSession(33411906) - client_released
2010-03-05 08:07:19,740 3612178 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,740 3612178 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,741 3612179 DEBUG (services.toplink.ToplinkLogging) - ClientSession(7807191) - execute_query - ReadAllQuery(referenceClass=KFZ_Pagination )
2010-03-05 08:07:19,741 3612179 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT ID, modified, nummer, paginierzeit, eingangstag, doppel, fuellstatus, bearbeitung, done, locked, version, KFZ_ActionID, version FROM KFZ_Pagination WHERE (KFZ_ActionID = ?)
bind =>
2010-03-05 08:07:19,741 3612179 DEBUG (services.toplink.ToplinkLogging) - ClientSession(7807191) - client_released
2010-03-05 08:07:19,741 3612179 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - register - com.acme.model.KFZ_Journal@10d1f30 ID=null
2010-03-05 08:07:19,741 3612179 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - register - com.acme.model.Account@18c5b4f ID=19157222
2010-03-05 08:07:19,741 3612179 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - register - com.acme.model.Kfz_Daten@b8f952 ID=27747240
2010-03-05 08:07:19,742 3612180 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - register - com.acme.model.CSP_SalesPartner@1e3cabd ID=427907
2010-03-05 08:07:19,742 3612180 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - register_existing - com.acme.model.KFZ_Profile@1ffb7d4 ID=3
2010-03-05 08:07:19,742 3612180 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - register - com.acme.model.Kfz_Action@87286 ID=175727905


2010-03-05 08:07:19,742 3612180 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,742 3612180 DEBUG (services.toplink.ToplinkLogging) - ClientSession(33343401) - acquire_unit_of_work_with_argument - 21599642
2010-03-05 08:07:19,742 3612180 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,742 3612180 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,742 3612180 DEBUG (services.toplink.ToplinkLogging) - ClientSession(9985954) - execute_query - ReadAllQuery(referenceClass=KFZ_Pagination )
2010-03-05 08:07:19,743 3612181 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT ID, modified, nummer, paginierzeit, eingangstag, doppel, fuellstatus, bearbeitung, done, locked, version, KFZ_ActionID, version FROM KFZ_Pagination WHERE (KFZ_ActionID = ?)
bind =>
2010-03-05 08:07:19,743 3612181 DEBUG (services.toplink.ToplinkLogging) - ClientSession(9985954) - client_released
2010-03-05 08:07:19,743 3612181 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,743 3612181 DEBUG (services.toplink.ToplinkLogging) - ServerSession(14112795) - client_acquired
2010-03-05 08:07:19,743 3612181 DEBUG (services.toplink.ToplinkLogging) - ClientSession(28218725) - execute_query - ReadAllQuery(referenceClass=KFZ_Pagination )
2010-03-05 08:07:19,743 3612181 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT ID, modified, nummer, paginierzeit, eingangstag, doppel, fuellstatus, bearbeitung, done, locked, version, KFZ_ActionID, version FROM KFZ_Pagination WHERE (KFZ_ActionID = ?)
bind =>
2010-03-05 08:07:19,743 3612181 DEBUG (services.toplink.ToplinkLogging) - ClientSession(28218725) - client_released
2010-03-05 08:07:19,743 3612181 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(21599642) - release_unit_of_work
2010-03-05 08:07:19,744 3612182 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - register - com.acme.model.KFZ_Bestand@d25538 ID=null
2010-03-05 08:07:19,744 3612182 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - register - com.acme.model.Kfz_Action@1e13ce3 ID=175727905
2010-03-05 08:07:19,744 3612182 INFO (services.persistence.ToplinkTransaction) - call to method ensureUoWisActive.
2010-03-05 08:07:19,744 3612182 INFO (services.persistence.ToplinkTransaction) - successfully finished with ensureUoWisActive() and going further with commit.
2010-03-05 08:07:19,744 3612182 DEBUG (services.persistence.ToplinkTransaction) - Committing Transaction ...
2010-03-05 08:07:19,744 3612182 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - validate_object_space
2010-03-05 08:07:19,745 3612183 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - begin_unit_of_work_commit
2010-03-05 08:07:19,745 3612183 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936) - execute_query - ValueReadQuery(sql="SELECT SEQ_KFZ_Journal.NEXTVAL FROM DUAL")
2010-03-05 08:07:19,746 3612184 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT SEQ_KFZ_Journal.NEXTVAL FROM DUAL
2010-03-05 08:07:19,747 3612185 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - assign_sequence - 1704953 - com.acme.model.KFZ_Journal@7aacc1 ID=null
2010-03-05 08:07:19,747 3612185 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936) - execute_query - ValueReadQuery(sql="SELECT SEQ_KFZ_Bestand.NEXTVAL FROM DUAL")
2010-03-05 08:07:19,747 3612185 INFO (services.toplink.ToplinkLogging) - ServerSession(14112795), Connection(16318274) - SELECT SEQ_KFZ_Bestand.NEXTVAL FROM DUAL
2010-03-05 08:07:19,748 3612186 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - assign_sequence - 1131967 - com.acme.model.KFZ_Bestand@d8f5e8 ID=null
2010-03-05 08:07:19,750 3612188 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - begin_transaction
2010-03-05 08:07:19,751 3612189 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - execute_query - UpdateObjectQuery(com.acme.model.Kfz_Daten@b8f952)
2010-03-05 08:07:19,751 3612189 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - execute_query - UpdateObjectQuery(com.acme.model.Kfz_Action@87286)
2010-03-05 08:07:19,751 3612189 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - begin_batch_statements
2010-03-05 08:07:19,751 3612189 INFO (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - UPDATE Kfz_Daten SET fahrgestellnr = ?, kmStand = ? WHERE (ID = ?)
2010-03-05 08:07:19,751 3612189 INFO (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - bind =>
2010-03-05 08:07:19,751 3612189 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - end_batch_statements
2010-03-05 08:07:19,755 3612193 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - execute_query - InsertObjectQuery(com.acme.model.KFZ_Bestand@d8f5e8)
2010-03-05 08:07:19,755 3612193 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - begin_batch_statements
2010-03-05 08:07:19,755 3612193 INFO (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - UPDATE Kfz_Action SET closingTime = ?, state = ?, checked = ?, hasConfirmedConditions = ? WHERE (ID = ?)
2010-03-05 08:07:19,755 3612193 INFO (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - bind =>
2010-03-05 08:07:19,755 3612193 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - end_batch_statements
2010-03-05 08:07:19,763 3612201 DEBUG (services.toplink.ToplinkLogging) - UnitOfWork(10683785) - execute_query - InsertObjectQuery(com.acme.model.KFZ_Journal@7aacc1)
2010-03-05 08:07:19,763 3612201 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - begin_batch_statements
2010-03-05 08:07:19,763 3612201 INFO (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - INSERT IGNORE INTO KFZ_Bestand (ID, Willbankeinzug, Bankname, Ort, Kontonummer, Blz, Kontoinhabername, KontoinhaberVorname, KontoinhaberFamilienname, Datenverarbeitungsklausel, Time_antrag, Time_abschluss, Time_eingabe, Time_kuendigung, Preis_anfang, Preis_aktuell, Istbestand, Istportfolio, Versicherungsscheinnummer, ErstfahrzeugVsNr, Tarifbescheinigung, kennzeichenVorVU, zlsTelefon, kmstandAltesAuto, verbleibAltesAuto, datumVerbleibAltesAuto, evbCode, evbGueltigkeit, evbMobilVorwahl, evbMobilRufnummer, clientInfo, KFZ_ActionID, VersichererID, ErstfahrzeugVersichererID, KFZ_ZLS_GebuehrID) VALUES (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
2010-03-05 08:07:19,763 3612201 INFO (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - bind =>
2010-03-05 08:07:19,763 3612201 DEBUG (services.toplink.ToplinkLogging) - ClientSession(12613936), Connection(16318274) - end_batch_statements
2010-03-05 08:07:19,775 3612213 DEBUG (services.toplink.ToplinkLogging) - - wait_acquire_lock ConcurrencyManager(nest level = 0) - com.acme.model.Kfz_Daten@1611aec ID=27747240 - , numberOfReaders=1


---------------------------------------------
------------ Thread Dump -------------
----------------------------------------------

2010-03-05 08:19:32
Full thread dump Java HotSpot(TM) Server VM (16.0-b13 mixed mode):

"TP-Processor40" daemon prio=3 tid=0x08af3400 nid=0x59 in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbbaade98> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Object.wait(Object.java:485)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:662)
- locked <0xbbaade98> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor39" daemon prio=3 tid=0x0980c800 nid=0x58 in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbbaadb38> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Object.wait(Object.java:485)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:662)
- locked <0xbbaadb38> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor38" daemon prio=3 tid=0x09021800 nid=0x57 in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbbaad7d8> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Object.wait(Object.java:485)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:662)
- locked <0xbbaad7d8> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor37" daemon prio=3 tid=0x093fb000 nid=0x56 in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbbaad478> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Object.wait(Object.java:485)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:662)
- locked <0xbbaad478> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor32" daemon prio=3 tid=0x08dbec00 nid=0x51 in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbbaac210> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Object.wait(Object.java:485)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:662)
- locked <0xbbaac210> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor31" daemon prio=3 tid=0x0976f000 nid=0x50 in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbbaabeb0> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Object.wait(Object.java:485)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:662)
- locked <0xbbaabeb0> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor30" daemon prio=3 tid=0x089c5c00 nid=0x4f in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbba54cb0> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Object.wait(Object.java:485)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:662)
- locked <0xbba54cb0> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor29" daemon prio=3 tid=0x089c5800 nid=0x4e in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xdfa11cc0> (a org.eclipse.persistence.internal.helper.ConcurrencyManager)
at java.lang.Object.wait(Object.java:485)
at org.eclipse.persistence.internal.helper.WriteLockManager.acq uireLocksForClone(WriteLockManager.java:82)
- locked <0xdfa11cc0> (a org.eclipse.persistence.internal.helper.ConcurrencyManager)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.clo neAndRegisterObject(UnitOfWorkImpl.java:958)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.clo neAndRegisterObject(UnitOfWorkImpl.java:896)
at org.eclipse.persistence.internal.sessions.UnitOfWorkIdentity MapAccessor.getAndCloneCacheKeyFromParent(UnitOfWorkIdentity MapAccessor.java:171)
at org.eclipse.persistence.internal.sessions.UnitOfWorkIdentity MapAccessor.getFromIdentityMap(UnitOfWorkIdentityMapAccessor .java:110)
at org.eclipse.persistence.internal.sessions.IdentityMapAccesso r.getFromIdentityMap(IdentityMapAccessor.java:331)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.reg isterExistingObject(UnitOfWorkImpl.java:3883)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.reg isterExistingObject(UnitOfWorkImpl.java:3843)
at org.eclipse.persistence.mappings.CollectionMapping.buildElem entClone(CollectionMapping.java:240)
at org.eclipse.persistence.internal.queries.ContainerPolicy.add NextValueFromIteratorInto(ContainerPolicy.java:264)
at org.eclipse.persistence.mappings.CollectionMapping.buildClon eForPartObject(CollectionMapping.java:195)
at org.eclipse.persistence.internal.indirection.UnitOfWorkQuery ValueHolder.buildCloneFor(UnitOfWorkQueryValueHolder.java:51 )
at org.eclipse.persistence.internal.indirection.UnitOfWorkValue Holder.instantiateImpl(UnitOfWorkValueHolder.java:162)
at org.eclipse.persistence.internal.indirection.UnitOfWorkValue Holder.instantiate(UnitOfWorkValueHolder.java:230)
at org.eclipse.persistence.internal.indirection.DatabaseValueHo lder.getValue(DatabaseValueHolder.java:83)
- locked <0xc82f8c38> (a org.eclipse.persistence.internal.indirection.UnitOfWorkQuery ValueHolder)
at org.eclipse.persistence.indirection.IndirectList.buildDelega te(IndirectList.java:237)
at org.eclipse.persistence.indirection.IndirectList.getDelegate (IndirectList.java:397)
- locked <0xc82f8c70> (a org.eclipse.persistence.indirection.IndirectList)
at org.eclipse.persistence.indirection.IndirectList.size(Indire ctList.java:726)
at com.acme.application.common.businessobjects.CommonLogic.gene rateHistoryPerson(CommonLogic.java:257)
at com.acme.application.common.businessobjects.CommonLogic.clon ePerson(CommonLogic.java:355)
at com.acme.application.auto.businessobjects.AutoLogic.deepClon eKfzDaten(AutoLogic.java:1057)
at com.acme.application.auto.businessobjects.AutoLogic.reInitAf terSaving(AutoLogic.java:972)
at com.acme.application.auto.businessobjects.AutoLogic.cloneExi stingKfzDaten(AutoLogic.java:947)
at com.acme.application.auto.actions.QCRecalculate.cloneViaBean AndCrawl(QCRecalculate.java:324)
at com.acme.application.auto.actions.QCRecalculate.doBusinessLo gic(QCRecalculate.java:147)
at com.acme.gui.framework.AbstractAction.execute(AbstractAction .java:253)
at org.apache.struts.action.RequestProcessor.processActionPerfo rm(RequestProcessor.java:431)
at org.apache.struts.action.RequestProcessor.process(RequestPro cessor.java:236)
at org.apache.struts.action.ActionServlet.process(ActionServlet .java:1196)
at com.acme.gui.framework.ExtendedActionServlet.process(Extende dActionServlet.java:124)
at org.apache.struts.action.ActionServlet.doPost(ActionServlet. java:432)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:637)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFi lter(ApplicationFilterChain.java:290)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(App licationFilterChain.java:206)
at com.acme.gui.framework.maintenance.MaintenanceFilter.doFilte r(MaintenanceFilter.java:82)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFi lter(ApplicationFilterChain.java:235)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(App licationFilterChain.java:206)
at org.apache.catalina.core.StandardWrapperValve.invoke(Standar dWrapperValve.java:233)
at org.apache.catalina.core.StandardContextValve.invoke(Standar dContextValve.java:191)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHo stValve.java:128)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorRepo rtValve.java:102)
at org.apache.catalina.core.StandardEngineValve.invoke(Standard EngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAd apter.java:293)
at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler. java:190)
at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.ja va:291)
at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java :769)
at org.apache.jk.common.ChannelSocket.processConnection(Channel Socket.java:698)
at org.apache.jk.common.ChannelSocket$SocketConnection.runIt(Ch annelSocket.java:891)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:690)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor28" daemon prio=3 tid=0x0869b800 nid=0x4d in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xc1d15ad8> (a org.eclipse.persistence.internal.helper.ConcurrencyManager)
at java.lang.Object.wait(Object.java:485)
at org.eclipse.persistence.internal.helper.ConcurrencyManager.a cquire(ConcurrencyManager.java:104)
- locked <0xc1d15ad8> (a org.eclipse.persistence.internal.helper.ConcurrencyManager)
at org.eclipse.persistence.internal.helper.ConcurrencyManager.a cquireNoWait(ConcurrencyManager.java:135)
- locked <0xc1d15ad8> (a org.eclipse.persistence.internal.helper.ConcurrencyManager)
at org.eclipse.persistence.internal.identitymaps.CacheKey.acqui reNoWait(CacheKey.java:155)
at org.eclipse.persistence.internal.identitymaps.AbstractIdenti tyMap.acquireLockNoWait(AbstractIdentityMap.java:123)
at org.eclipse.persistence.internal.identitymaps.IdentityMapMan ager.acquireLockNoWait(IdentityMapManager.java:149)
at org.eclipse.persistence.internal.sessions.IdentityMapAccesso r.acquireLockNoWait(IdentityMapAccessor.java:97)
at org.eclipse.persistence.internal.helper.WriteLockManager.att emptToAcquireLock(WriteLockManager.java:403)
at org.eclipse.persistence.internal.helper.WriteLockManager.acq uireRequiredLocks(WriteLockManager.java:283)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitToDatabase(UnitOfWorkImpl.java:1428)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitToDatabaseWithChangeSet(UnitOfWorkImpl.java:1508)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitRootUnitOfWork(UnitOfWorkImpl.java:1311)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitAndResume(UnitOfWorkImpl.java:1129)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitAndResumeOnFailure(UnitOfWorkImpl.java:1207)
at com.acme.services.persistence.ToplinkTransaction.commit(Topl inkTransaction.java:237)
- locked <0xd465f9f0> (a org.eclipse.persistence.internal.sessions.UnitOfWorkImpl)
- locked <0xd465f258> (a com.acme.services.persistence.ToplinkTransaction)
at com.acme.application.auto.actions.QCRecalculate.cloneViaBean AndCrawl(QCRecalculate.java:345)
at com.acme.application.auto.actions.QCRecalculate.doBusinessLo gic(QCRecalculate.java:147)
at com.acme.gui.framework.AbstractAction.execute(AbstractAction .java:253)
at org.apache.struts.action.RequestProcessor.processActionPerfo rm(RequestProcessor.java:431)
at org.apache.struts.action.RequestProcessor.process(RequestPro cessor.java:236)
at org.apache.struts.action.ActionServlet.process(ActionServlet .java:1196)
at com.acme.gui.framework.ExtendedActionServlet.process(Extende dActionServlet.java:124)
at org.apache.struts.action.ActionServlet.doPost(ActionServlet. java:432)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:637)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFi lter(ApplicationFilterChain.java:290)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(App licationFilterChain.java:206)
at com.acme.gui.framework.maintenance.MaintenanceFilter.doFilte r(MaintenanceFilter.java:82)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFi lter(ApplicationFilterChain.java:235)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(App licationFilterChain.java:206)
at org.apache.catalina.core.StandardWrapperValve.invoke(Standar dWrapperValve.java:233)
at org.apache.catalina.core.StandardContextValve.invoke(Standar dContextValve.java:191)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHo stValve.java:128)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorRepo rtValve.java:102)
at org.apache.catalina.core.StandardEngineValve.invoke(Standard EngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAd apter.java:293)
at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler. java:190)
at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.ja va:291)
at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java :769)
at org.apache.jk.common.ChannelSocket.processConnection(Channel Socket.java:698)
at org.apache.jk.common.ChannelSocket$SocketConnection.runIt(Ch annelSocket.java:891)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:690)
at java.lang.Thread.run(Thread.java:619)


"TP-Processor9" daemon prio=3 tid=0x0922d800 nid=0x20 in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xc1d15cb8> (a org.eclipse.persistence.internal.helper.ConcurrencyManager)
at java.lang.Object.wait(Object.java:485)
at org.eclipse.persistence.internal.helper.ConcurrencyManager.a cquire(ConcurrencyManager.java:104)
- locked <0xc1d15cb8> (a org.eclipse.persistence.internal.helper.ConcurrencyManager)
at org.eclipse.persistence.internal.helper.ConcurrencyManager.a cquireNoWait(ConcurrencyManager.java:135)
- locked <0xc1d15cb8> (a org.eclipse.persistence.internal.helper.ConcurrencyManager)
at org.eclipse.persistence.internal.identitymaps.CacheKey.acqui reNoWait(CacheKey.java:155)
at org.eclipse.persistence.internal.identitymaps.AbstractIdenti tyMap.acquireLockNoWait(AbstractIdentityMap.java:123)
at org.eclipse.persistence.internal.identitymaps.IdentityMapMan ager.acquireLockNoWait(IdentityMapManager.java:149)
at org.eclipse.persistence.internal.sessions.IdentityMapAccesso r.acquireLockNoWait(IdentityMapAccessor.java:97)
at org.eclipse.persistence.internal.helper.WriteLockManager.att emptToAcquireLock(WriteLockManager.java:403)
at org.eclipse.persistence.internal.helper.WriteLockManager.acq uireRequiredLocks(WriteLockManager.java:283)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitToDatabase(UnitOfWorkImpl.java:1428)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitToDatabaseWithChangeSet(UnitOfWorkImpl.java:1508)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitRootUnitOfWork(UnitOfWorkImpl.java:1311)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitAndResume(UnitOfWorkImpl.java:1129)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.com mitAndResumeOnFailure(UnitOfWorkImpl.java:1207)
at com.acme.services.persistence.ToplinkTransaction.commit(Topl inkTransaction.java:237)
- locked <0xc9d86c78> (a org.eclipse.persistence.internal.sessions.UnitOfWorkImpl)
- locked <0xe0089918> (a com.acme.services.persistence.ToplinkTransaction)
at com.acme.application.pkw.businessobjects.AutoLogic.saveClosi ngData(AutoLogic.java:1487)
at com.acme.application.pkw.actions.closing.ProcessAutoClosing. doPkwBusinessLogic(ProcessAutoClosing.java:177)
at com.acme.application.pkw.actions.AbstractPkwAction.doBusines sLogic(AbstractPkwAction.java:30)
- locked <0xe00b4aa8> (a java.lang.Object)
at com.acme.gui.framework.AbstractAction.execute(AbstractAction .java:253)
at org.apache.struts.action.RequestProcessor.processActionPerfo rm(RequestProcessor.java:431)
at org.apache.struts.action.RequestProcessor.process(RequestPro cessor.java:236)
at org.apache.struts.action.ActionServlet.process(ActionServlet .java:1196)
at com.acme.gui.framework.ExtendedActionServlet.process(Extende dActionServlet.java:124)
at org.apache.struts.action.ActionServlet.doPost(ActionServlet. java:432)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:637)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFi lter(ApplicationFilterChain.java:290)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(App licationFilterChain.java:206)
at com.acme.gui.framework.maintenance.MaintenanceFilter.doFilte r(MaintenanceFilter.java:82)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFi lter(ApplicationFilterChain.java:235)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(App licationFilterChain.java:206)
at org.apache.catalina.core.StandardWrapperValve.invoke(Standar dWrapperValve.java:233)
at org.apache.catalina.core.StandardContextValve.invoke(Standar dContextValve.java:191)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHo stValve.java:128)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorRepo rtValve.java:102)
at org.apache.catalina.core.StandardEngineValve.invoke(Standard EngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAd apter.java:293)
at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler. java:190)
at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.ja va:291)
at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java :769)
at org.apache.jk.common.ChannelSocket.processConnection(Channel Socket.java:698)
at org.apache.jk.common.ChannelSocket$SocketConnection.runIt(Ch annelSocket.java:891)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:690)
at java.lang.Thread.run(Thread.java:619)

"TP-Processor8" daemon prio=3 tid=0x0922c000 nid=0x1f in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x3ee71080> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Object.wait(Object.java:485)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.ru n(ThreadPool.java:662)
- locked <0x3ee71080> (a org.apache.tomcat.util.threads.ThreadPool$ControlRunnable)
at java.lang.Thread.run(Thread.java:619)


"ContainerBackgroundProcessor[StandardEngine]" daemon prio=3 tid=0x08326400 nid=0x15 waiting on condition
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.catalina.core.ContainerBase$ContainerBackgroundPr ocessor.run(ContainerBase.java:1579)
at java.lang.Thread.run(Thread.java:619)


"MultiThreadedHttpConnectionManager cleanup" daemon prio=3 tid=0x0912a000 nid=0xf in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x3e8ee3a8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:118)
- locked <0x3e8ee3a8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:134)
at org.apache.commons.httpclient.MultiThreadedHttpConnectionMan ager$ReferenceQueueThread.run(MultiThreadedHttpConnectionMan

[Updated on: Fri, 05 March 2010 13:40]

Report message to a moderator

Re: Database Locks after upgrading from Toplink to Eclipselink [message #519377 is a reply to message #518922] Mon, 08 March 2010 16:29 Go to previous message
James Sutherland is currently offline James Sutherland
Messages: 1939
Registered: July 2009
Location: Ottawa, Canada
Senior Member

The issue seems to be you have two threads writing trying to get write locks waiting on a read lock, and one reading that has a read lock, and is trying to get another read lock, but the writer has it locked.

The problem could be the acquireLockNoWait is not checking for read locks, so waits instead of returning false. This seems like it should be checking for read locks.

To debug further there is a method printIdentityMapLocks on IdentityMapAccessor on the Session that may be useful.

Please log a bug for this in Bugzilla and vote for it.

Using LAZY on all of your relationships, should avoid the issue, and is strongly recommended in general.

As a workaround you could also disable the shared cache for the classes involved.

Another workaround would be to use a SessionCustomizer to the set the Session's DatabaseLogin cacheIsolationLevel to CONCURRENT_READ_WRITE.



James : Wiki : Book : Blog : Twitter
Previous Topic:Help for Entity derived from a MappedSuperclass with an EmbeddedId
Next Topic:Left outer join on a unidirectional many to one mapping
Goto Forum:
  


Current Time: Mon Oct 20 09:51:31 GMT 2014

Powered by FUDForum. Page generated in 0.01916 seconds
.:: Contact :: Home ::.

Powered by: FUDforum 3.0.2.
Copyright ©2001-2010 FUDforum Bulletin Board Software