Home » Eclipse Projects » EclipseLink » Very strange "primary key [null]" validation exception("primary key [null]" exception appear where it should not)
Very strange "primary key [null]" validation exception [message #893590] |
Wed, 04 July 2012 17:48 |
Rodion Missing name Messages: 8 Registered: September 2009 |
Junior Member |
|
|
I'm using eclipselink v 2.3.2 (supplied with glassfish v.3.2)
I've got this stack while trying to merge object graph into database:
Exception [EclipseLink-7197] (Eclipse Persistence Services - 2.3.1.v20111018-r10243): org.eclipse.persistence.exceptions.ValidationException
Exception Description: Null or zero primary key encountered in unit of work clone [com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@75c191a7], primary key [null]. Set descriptors IdValidation or the "eclipselink.id-validation" property.
at org.eclipse.persistence.exceptions.ValidationException.nullPrimaryKeyInUnitOfWorkClone(ValidationException.java:1439)
at org.eclipse.persistence.descriptors.changetracking.DeferredChangeDetectionPolicy.calculateChanges(DeferredChangeDetectionPolicy.java:107)
at org.eclipse.persistence.descriptors.changetracking.DeferredChangeDetectionPolicy.calculateChangesForExistingObject(DeferredChangeDetectionPolicy.java:54)
My entities model looks like these:
@Entity
public class PhoneContactInfo {
@Id
@GeneratedValue(strategy = GenerationType.SEQUENCE, generator = "SEQ_PROFILE_ENTITES")
private Integer id;
...
}
@Entity
public class PersonContactableProfile extends ContactableProfile{
@Id
@GeneratedValue(strategy = GenerationType.SEQUENCE, generator = "SEQ_PROFILE_ENTITES")
private Integer id;
@OneToOne(cascade = {CascadeType.ALL}, orphanRemoval = true, optional = true)
private PhoneContactInfo phoneInfo;
@OneToOne(optional = false, cascade = CascadeType.ALL)
private Person person;
...
}
@Entity
public class UserContact {
@Id
@GeneratedValue(strategy = GenerationType.SEQUENCE, generator = "SEQ_PROFILE_ENTITES")
private Integer id;
@OneToOne(optional = false, orphanRemoval = false, fetch = FetchType.EAGER)
private ContactableProfile contactable;
@ManyToOne(optional = false, fetch = FetchType.EAGER)
private Person personOwner;
...
}
@Entity
public class PersonToPersonLink {
@Id
@GeneratedValue(strategy = GenerationType.SEQUENCE, generator = "SEQ_PROFILE_ENTITES")
private Integer id;
@ManyToOne(fetch = javax.persistence.FetchType.LAZY, cascade = {CascadeType.PERSIST, CascadeType.MERGE, CascadeType.REFRESH})
private Person relative;
@ManyToOne(fetch = javax.persistence.FetchType.LAZY)
private Person user;
...
}
@Entity
public class Person {
@Id
@GeneratedValue(strategy = GenerationType.SEQUENCE, generator = "SEQ_PROFILE_ENTITES")
private Integer id;
@OneToMany(mappedBy = "personOwner", fetch = FetchType.LAZY, cascade = CascadeType.ALL, orphanRemoval = true)
private Set<UsersContact> contacts;
@OneToMany(cascade = CascadeType.ALL, mappedBy = "user", orphanRemoval = true, fetch = FetchType.LAZY)
private Set<UserRelativeLink> relativeLinks;
@OneToOne(optional = false, cascade = {CascadeType.ALL}, mappedBy = "person", fetch = FetchType.LAZY)
private PersonContactableProfile personContactableProfile;
...
}
Every Person may have PersonContactable which is basically set of "ways to contact person" (e.g. phone number) - there is other types of contactable profiles in system, but this does not matter now. Every person can also may have collection of contacts and collection of relatives. UserContact entity, essentially, is record in one's contacts list. PersonToPersonLink keep link between two persons (e.g. relative). I have two Person instances, lets say Person1 and Person2. Person2 is already in Persons1's relstiveLinks collection (all data in database already). Then I take Person1, add new UserContact that points to Person2 PersonContactableProfile and also add new PhoneContactInfo to PersonContactableProfile of Person2 - I've got exception described above while saving Person1 graph (entityManager.merge(Person2)).
While investigating that issue i've found out why it happening - PhoneContactInfo instance added to cloneMapping collection of UnitOfWorkImpl twice!
First time during mapping traversal through contacts collection and second time during mapping traversal through relativeLinks collection. I do not understand if it's a bug? I also find out that line in MergeManager source code (trunk):
...
Object registeredObject = unitOfWork.internalRegisterObject(clone, descriptor);//should use cloneAndRegisterNewObject to avoid the exist check
...
Addition of second copy of PhoneContactInfo to cloneMapping collection happening exactly during existence check.
Can someone tell me how I can fix this behaviour?
|
|
| |
Re: Very strange "primary key [null]" validation exception [message #893830 is a reply to message #893755] |
Thu, 05 July 2012 15:34 |
Rodion Missing name Messages: 8 Registered: September 2009 |
Junior Member |
|
|
Hello, thank for response
Quote:
How are you adding the new PhoneContactInfo to the existing PersonContactableProfile? And how is Person2 read in?
My example model is little bit oversiplified but basically I do like that:
/* ----------- server code (java): -------- */
... this method invoked by client to get person data
public Person getPersonById(Integer id){
Person person = entityManager.findById(id, Person.class);
// here come some operations to force loading lazy collections from db
return person; // graniteds serialization
}
... this method is invoked to save graph
public void savePerson(Person person1) {
/* person1 is came from client request deserialization - i.e. it is detached from persistence layer
all object instances in passed graph contains all added by weawing fields and their values */
entityManager.merge(person1); // exception happens not here, but on transaction commit which will call "calculateChanges", but PhoneContactInfo added twice here
}
/* ------- client code (actionscript): --------- */
var person1:Person = personService.getPersonById(1); // simplified, because service call is really async
var person2:Person = person1.relativeLinks[0].relative; // simplified, just assume we have only one relative in collection and it will be our "person2";
/* adding contact */
var userContact:UserContact = new UserContact();
userContact.personOwner = person1;
userContact.contactable= person2.personContactableProfile;
person1.contacts.add(userContact); // assume that collection is not null which is not true for real life
/* adding phone */
var phone:PhoneContactInfo = new PhoneContactInfo();
phone.value = '123123123'; // all contactinfos has value, forgot to add superclass definition in previous example
person2.personContactableProfile.phoneInfo = phone;
/* at this moment object graph that have person1 as "root" contains new userContact
person2 (which is also part of this object graph) have brand new phone number
time to submit all that stuff to server
*/
personService.savePerson(person1);
Quote:
Can you set logging to Finest or ALL and post the log showing when merge is called?
Log for FINEST level is hidden under spoiler. As i said model example is oversimplified, so you would not find exact matching in log.
Log excerpt
[notag]
[EL Fine]: 2012-07-05 17:32:43.45--ServerSession(586343931)--Connection(1121500394)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, dateofbirth, language, name, nationality, personnumber, surname FROM PUBLIC.person WHERE (ID = ?)
bind => [93]
[EL Fine]: 2012-07-05 17:32:43.452--ServerSession(586343931)--Connection(1181602860)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.institution_id, t1.employeetype_id FROM PUBLIC.roleinfo t0, PUBLIC.employeeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [93, EMPLOYEE]
Jul 05, 2012 5:32:43 PM com.hospitality.hp.osloproject.security.graniteDS.SpringSecurity3ServiceHP userCanAccessService
INFO: Allowed access to tom in role employee
Jul 05, 2012 5:32:43 PM com.hospitality.hp.baseclient.profile.ProfileServiceBean savePerson
INFO: Attempting to save Person asdfasdf asdfasdf (93)
[EL Fine]: 2012-07-05 17:32:43.454--ServerSession(586343931)--Connection(1582422157)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.addressci_id, t1.emailci_id, t1.intsipcontactinfo_id, t1.mobilephoneci_id, t1.person_id, t1.phonenumberci_id, t1.servicephone_id, t1.sipcontactinfo_id, t1.voicephone_id FROM PUBLIC.contactableprofile t0, PUBLIC.personcontprofile t1 WHERE ((t1.person_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [93, PERSON]
[EL Fine]: 2012-07-05 17:32:43.456--ServerSession(586343931)--Connection(143106549)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID FROM PUBLIC.roleinfo t0, PUBLIC.relativeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [93, RELATIVE]
[EL Fine]: 2012-07-05 17:32:43.457--ServerSession(586343931)--Connection(140368787)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.description, t1.sensorserveruserid, t1.terminalid, t1.institution_id FROM PUBLIC.roleinfo t0, PUBLIC.userroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [93, USER]
[EL Fine]: 2012-07-05 17:32:43.458--ServerSession(586343931)--Connection(1450592032)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.dtype, t0.NAME, t0.regservicepin, t1.ID FROM PUBLIC.ORGANIZATION t0, PUBLIC.institution t1 WHERE ((t0.ID = ?) AND ((t1.ID = t0.ID) AND (t0.dtype = ?)))
bind => [1, INSTITUTION]
[EL Fine]: 2012-07-05 17:32:43.46--ServerSession(586343931)--Connection(1075341637)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.organization_id FROM PUBLIC.contactableprofile t0, PUBLIC.orgcontprofile t1 WHERE ((t1.organization_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [1, ORGANIZATION]
[EL Fine]: 2012-07-05 17:32:43.461--ServerSession(586343931)--Connection(1444886945)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.organization_id FROM PUBLIC.contactableprofile t0, PUBLIC.orgcontprofile t1 WHERE ((t1.organization_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [1, ORGANIZATIONEMPLOYEES]
[EL Fine]: 2012-07-05 17:32:43.463--ServerSession(586343931)--Connection(2015885021)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, TOKEN FROM PUBLIC.RFIDTOKEN WHERE (organization_id = ?)
bind => [1]
[EL Fine]: 2012-07-05 17:32:43.464--ServerSession(586343931)--Connection(1746505997)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, "number", prefix_id, userrole_id FROM PUBLIC.sms_subnumber WHERE (userrole_id = ?)
bind => [92]
[EL Fine]: 2012-07-05 17:32:43.465--ServerSession(586343931)--Connection(1242840559)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, mobilephonenumber, CLIENTPASSWORD, CLIENTUSERNAME, sipstring, address_id, phonenumber, internal_phonenumber, sipcontactinfo_id, email FROM PUBLIC.contactinfo WHERE (contactableprofile_id = ?)
bind => [87]
[EL Fine]: 2012-07-05 17:32:43.467--ServerSession(586343931)--Connection(741232880)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, contactgroup, contactnickname, usercomments, userrole_id, contactableprofile_id FROM PUBLIC.userrole_contacts WHERE (userrole_id = ?)
bind => [92]
[EL Fine]: 2012-07-05 17:32:43.469--ServerSession(586343931)--Connection(461040337)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID FROM PUBLIC.contactableprofile t0, PUBLIC.personcontprofile t1 WHERE (((t0.ID = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?))) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [88, PERSON, PERSON]
[EL Fine]: 2012-07-05 17:32:43.471--ServerSession(586343931)--Connection(1867882230)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--CALL NEXT VALUE FOR PUBLIC.SEQ_PROFILE_ENTITES
[EL Fine]: 2012-07-05 17:32:43.472--ServerSession(586343931)--Connection(99052511)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, relativeinfo_id, userinfo_id FROM PUBLIC.USERRELATIVELINK WHERE (userinfo_id = ?)
bind => [92]
[EL Fine]: 2012-07-05 17:32:43.475--ServerSession(586343931)--Connection(1793387320)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--CALL NEXT VALUE FOR PUBLIC.SEQ_PROFILE_ENTITES
[EL Fine]: 2012-07-05 17:32:43.487--ServerSession(586343931)--Connection(415164034)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, reminder_type, ACKNOWLEDGEBEFORE, ACKNOWLEDGETIMEUNIT, ACKNOWLEDGEBLE, ALERTAHEADMINUTES, DETAILS, ENDDATE, STARTDATE, ownerroleinfo_id, schedulepattern_id, cause_id, VISITTYPE, VISITORNAME, visiting_contactable_id, HTTPLINK, initiatorphone, VIDEOURL, VIDEO_ID, CUSTOMSUBTYPE, CUSTOMTYPE FROM PUBLIC.REMINDER WHERE (ownerroleinfo_id = ?)
bind => [92]
[EL Fine]: 2012-07-05 17:32:43.491--ServerSession(586343931)--Connection(1448176491)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT USERNAME, CHANGEPASSWORD, CREATEDDATE, ENABLED, ENDDATE, ROLE, STARTDATE, person_id, OWNERTYPE FROM PUBLIC.security_account WHERE (USERNAME = ?)
bind => [tom]
[EL Fine]: 2012-07-05 17:32:43.497--ServerSession(586343931)--Connection(71463161)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, dateofbirth, language, name, nationality, personnumber, surname FROM PUBLIC.person WHERE (ID = ?)
bind => [55]
[EL Fine]: 2012-07-05 17:32:43.499--ServerSession(586343931)--Connection(1701838985)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.institution_id, t1.employeetype_id FROM PUBLIC.roleinfo t0, PUBLIC.employeeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [55, EMPLOYEE]
[EL Fine]: 2012-07-05 17:32:43.502--ServerSession(586343931)--Connection(2110373052)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, NAME, channel_id, role_id FROM PUBLIC.employee_type WHERE (ID = ?)
bind => [2]
[EL Fine]: 2012-07-05 17:32:43.505--ServerSession(586343931)--Connection(1950292273)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.addressci_id, t1.emailci_id, t1.intsipcontactinfo_id, t1.mobilephoneci_id, t1.person_id, t1.phonenumberci_id, t1.servicephone_id, t1.sipcontactinfo_id, t1.voicephone_id FROM PUBLIC.contactableprofile t0, PUBLIC.personcontprofile t1 WHERE ((t1.person_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [55, PERSON]
[EL Fine]: 2012-07-05 17:32:43.508--ServerSession(586343931)--Connection(645820858)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, address_id FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [49, ADDRESS]
[EL Fine]: 2012-07-05 17:32:43.51--ServerSession(586343931)--Connection(1050898615)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, CITY, COUNTRY, LATITUDE, LONGITUDE, POSTALCODE, STREET, STREET2 FROM PUBLIC.address WHERE (ID = ?)
bind => [6]
[EL Fine]: 2012-07-05 17:32:43.511--ServerSession(586343931)--Connection(1248523753)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, email FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [50, EMAIL]
[EL Fine]: 2012-07-05 17:32:43.513--ServerSession(586343931)--Connection(1403846745)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, mobilephonenumber FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [51, MOBILEPHONE]
[EL Fine]: 2012-07-05 17:32:43.514--ServerSession(586343931)--Connection(146401801)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, phonenumber FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [52, PHONE]
[EL Fine]: 2012-07-05 17:32:43.516--ServerSession(586343931)--Connection(31220413)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, CLIENTPASSWORD, CLIENTUSERNAME, sipstring FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [53, SEEVIASIP]
[EL Fine]: 2012-07-05 17:32:43.519--ServerSession(586343931)--Connection(480879579)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID FROM PUBLIC.roleinfo t0, PUBLIC.relativeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [55, RELATIVE]
[EL Fine]: 2012-07-05 17:32:43.521--ServerSession(586343931)--Connection(488137924)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.description, t1.sensorserveruserid, t1.terminalid, t1.institution_id FROM PUBLIC.roleinfo t0, PUBLIC.userroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [55, USER]
[EL Warning]: 2012-07-05 17:32:43.527--UnitOfWork(1209071627)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--Exception [EclipseLink-7197] (Eclipse Persistence Services - 2.3.1.v20111018-r10243): org.eclipse.persistence.exceptions.ValidationException
Exception Description: Null or zero primary key encountered in unit of work clone [[email]com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@6bd3162f[/email]], primary key [null]. Set descriptors IdValidation or the "eclipselink.id-validation" property.
[EL Warning]: 2012-07-05 17:32:43.527--UnitOfWork(1209071627)--Thread(Thread[http-thread-pool-8080(3),5,grizzly-kernel])--Exception [EclipseLink-7197] (Eclipse Persistence Services - 2.3.1.v20111018-r10243): org.eclipse.persistence.exceptions.ValidationException
Exception Description: Null or zero primary key encountered in unit of work clone [[email]com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@6bd3162f[/email]], primary key [null]. Set descriptors IdValidation or the "eclipselink.id-validation" property.
Jul 05, 2012 5:32:43 PM com.sun.enterprise.transaction.JavaEETransactionImpl commit
WARNING: DTX5014: Caught exception in beforeCompletion() callback:
Local Exception Stack:
Exception [EclipseLink-7197] (Eclipse Persistence Services - 2.3.1.v20111018-r10243): org.eclipse.persistence.exceptions.ValidationException
Exception Description: Null or zero primary key encountered in unit of work clone [[email]com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@6bd3162f[/email]], primary key [null]. Set descriptors IdValidation or the "eclipselink.id-validation" property.
at org.eclipse.persistence.exceptions.ValidationException.nullPrimaryKeyInUnitOfWorkClone(ValidationException.java:1439)
at org.eclipse.persistence.descriptors.changetracking.DeferredChangeDetectionPolicy.calculateChanges(DeferredChangeDetectionPolicy.java:107)
at org.eclipse.persistence.descriptors.changetracking.DeferredChangeDetectionPolicy.calculateChangesForExistingObject(DeferredChangeDetectionPolicy.java:54)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.calculateChanges(UnitOfWorkImpl.java:643)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.commitToDatabaseWithChangeSet(UnitOfWorkImpl.java:1490)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.issueSQLbeforeCompletion(UnitOfWorkImpl.java:3143)
at org.eclipse.persistence.internal.sessions.RepeatableWriteUnitOfWork.issueSQLbeforeCompletion(RepeatableWriteUnitOfWork.java:346)
at org.eclipse.persistence.transaction.AbstractSynchronizationListener.beforeCompletion(AbstractSynchronizationListener.java:157)
at org.eclipse.persistence.transaction.JTASynchronizationListener.beforeCompletion(JTASynchronizationListener.java:68)
at com.sun.enterprise.transaction.JavaEETransactionImpl.commit(JavaEETransactionImpl.java:435)
at com.sun.enterprise.transaction.JavaEETransactionManagerSimplified.commit(JavaEETransactionManagerSimplified.java:852)
at com.sun.ejb.containers.BaseContainer.completeNewTx(BaseContainer.java:5114)
at com.sun.ejb.containers.BaseContainer.postInvokeTx(BaseContainer.java:4879)
at com.sun.ejb.containers.BaseContainer.postInvoke(BaseContainer.java:2039)
at com.sun.ejb.containers.BaseContainer.postInvoke(BaseContainer.java:1990)
at com.sun.ejb.containers.EJBLocalObjectInvocationHandler.invoke(EJBLocalObjectInvocationHandler.java:222)
at com.sun.ejb.containers.EJBLocalObjectInvocationHandlerDelegate.invoke(EJBLocalObjectInvocationHandlerDelegate.java:88)
at $Proxy256.savePerson(Unknown Source)
at com.hospitality.hp.baseclient.profile.__EJB31_Generated__ProfileServiceBean__Intf____Bean__.savePerson(Unknown Source)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:601)
at org.granite.messaging.service.ServiceInvocationContext.invoke(ServiceInvocationContext.java:71)
at org.granite.messaging.service.security.AbstractSecurityService.endAuthorization(AbstractSecurityService.java:67)
at com.hospitality.hp.osloproject.security.graniteDS.SpringSecurity3ServiceHP.authorize(SpringSecurity3ServiceHP.java:283)
at org.granite.messaging.service.ServiceInvoker.invoke(ServiceInvoker.java:214)
at org.granite.messaging.amf.process.AMF3MessageProcessor.processRemotingMessage(AMF3MessageProcessor.java:136)
at org.granite.messaging.amf.process.AMF3MessageProcessor.process(AMF3MessageProcessor.java:59)
at org.granite.messaging.amf.process.AMF0MessageProcessor.process(AMF0MessageProcessor.java:78)
at org.granite.messaging.webapp.AMFMessageServlet.doPost(AMFMessageServlet.java:59)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
at org.apache.catalina.core.StandardWrapper.service(StandardWrapper.java:1539)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:343)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:217)
at org.granite.messaging.webapp.AMFMessageFilter.doFilter(AMFMessageFilter.java:117)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:256)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:217)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:279)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:175)
at org.apache.catalina.core.StandardPipeline.doInvoke(StandardPipeline.java:655)
at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:595)
at com.sun.enterprise.web.WebPipeline.invoke(WebPipeline.java:98)
at com.sun.enterprise.web.PESessionLockingStandardPipeline.invoke(PESessionLockingStandardPipeline.java:91)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:162)
at org.apache.catalina.connector.CoyoteAdapter.doService(CoyoteAdapter.java:330)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:231)
at com.sun.enterprise.v3.services.impl.ContainerMapper.service(ContainerMapper.java:174)
at com.sun.grizzly.http.ProcessorTask.invokeAdapter(ProcessorTask.java:828)
at com.sun.grizzly.http.ProcessorTask.doProcess(ProcessorTask.java:725)
at com.sun.grizzly.http.ProcessorTask.process(ProcessorTask.java:1019)
at com.sun.grizzly.http.DefaultProtocolFilter.execute(DefaultProtocolFilter.java:225)
at com.sun.grizzly.DefaultProtocolChain.executeProtocolFilter(DefaultProtocolChain.java:137)
at com.sun.grizzly.DefaultProtocolChain.execute(DefaultProtocolChain.java:104)
at com.sun.grizzly.DefaultProtocolChain.execute(DefaultProtocolChain.java:90)
at com.sun.grizzly.http.HttpProtocolChain.execute(HttpProtocolChain.java:79)
at com.sun.grizzly.ProtocolChainContextTask.doCall(ProtocolChainContextTask.java:54)
at com.sun.grizzly.SelectionKeyContextTask.call(SelectionKeyContextTask.java:59)
at com.sun.grizzly.ContextTask.run(ContextTask.java:71)
at com.sun.grizzly.util.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:532)
at com.sun.grizzly.util.AbstractThreadPool$Worker.run(AbstractThreadPool.java:513)
at java.lang.Thread.run(Thread.java:722)
Jul 05, 2012 5:32:43 PM com.sun.ejb.containers.BaseContainer postInvoke
WARNING: A system exception occurred during an invocation on EJB ProfileServiceBean method public com.hospitality.hp.osloproject.vo.OperationResultVO com.hospitality.hp.baseclient.profile.ProfileServiceBean.savePerson(com.hospitality.hp.osloproject.entities.Person,byte[],com.hospitality.hp.osloproject.entities.Credentials[])
javax.ejb.EJBException: Transaction aborted
at com.sun.ejb.containers.BaseContainer.completeNewTx(BaseContainer.java:5120)
at com.sun.ejb.containers.BaseContainer.postInvokeTx(BaseContainer.java:4879)
at com.sun.ejb.containers.BaseContainer.postInvoke(BaseContainer.java:2039)
at com.sun.ejb.containers.BaseContainer.postInvoke(BaseContainer.java:1990)
at com.sun.ejb.containers.EJBLocalObjectInvocationHandler.invoke(EJBLocalObjectInvocationHandler.java:222)
at com.sun.ejb.containers.EJBLocalObjectInvocationHandlerDelegate.invoke(EJBLocalObjectInvocationHandlerDelegate.java:88)
at $Proxy256.savePerson(Unknown Source)
at com.hospitality.hp.baseclient.profile.__EJB31_Generated__ProfileServiceBean__Intf____Bean__.savePerson(Unknown Source)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:601)
at org.granite.messaging.service.ServiceInvocationContext.invoke(ServiceInvocationContext.java:71)
at org.granite.messaging.service.security.AbstractSecurityService.endAuthorization(AbstractSecurityService.java:67)
at com.hospitality.hp.osloproject.security.graniteDS.SpringSecurity3ServiceHP.authorize(SpringSecurity3ServiceHP.java:283)
at org.granite.messaging.service.ServiceInvoker.invoke(ServiceInvoker.java:214)
at org.granite.messaging.amf.process.AMF3MessageProcessor.processRemotingMessage(AMF3MessageProcessor.java:136)
at org.granite.messaging.amf.process.AMF3MessageProcessor.process(AMF3MessageProcessor.java:59)
at org.granite.messaging.amf.process.AMF0MessageProcessor.process(AMF0MessageProcessor.java:78)
at org.granite.messaging.webapp.AMFMessageServlet.doPost(AMFMessageServlet.java:59)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
at org.apache.catalina.core.StandardWrapper.service(StandardWrapper.java:1539)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:343)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:217)
at org.granite.messaging.webapp.AMFMessageFilter.doFilter(AMFMessageFilter.java:117)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:256)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:217)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:279)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:175)
at org.apache.catalina.core.StandardPipeline.doInvoke(StandardPipeline.java:655)
at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:595)
at com.sun.enterprise.web.WebPipeline.invoke(WebPipeline.java:98)
at com.sun.enterprise.web.PESessionLockingStandardPipeline.invoke(PESessionLockingStandardPipeline.java:91)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:162)
at org.apache.catalina.connector.CoyoteAdapter.doService(CoyoteAdapter.java:330)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:231)
at com.sun.enterprise.v3.services.impl.ContainerMapper.service(ContainerMapper.java:174)
at com.sun.grizzly.http.ProcessorTask.invokeAdapter(ProcessorTask.java:828)
at com.sun.grizzly.http.ProcessorTask.doProcess(ProcessorTask.java:725)
at com.sun.grizzly.http.ProcessorTask.process(ProcessorTask.java:1019)
at com.sun.grizzly.http.DefaultProtocolFilter.execute(DefaultProtocolFilter.java:225)
at com.sun.grizzly.DefaultProtocolChain.executeProtocolFilter(DefaultProtocolChain.java:137)
at com.sun.grizzly.DefaultProtocolChain.execute(DefaultProtocolChain.java:104)
at com.sun.grizzly.DefaultProtocolChain.execute(DefaultProtocolChain.java:90)
at com.sun.grizzly.http.HttpProtocolChain.execute(HttpProtocolChain.java:79)
at com.sun.grizzly.ProtocolChainContextTask.doCall(ProtocolChainContextTask.java:54)
at com.sun.grizzly.SelectionKeyContextTask.call(SelectionKeyContextTask.java:59)
at com.sun.grizzly.ContextTask.run(ContextTask.java:71)
at com.sun.grizzly.util.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:532)
at com.sun.grizzly.util.AbstractThreadPool$Worker.run(AbstractThreadPool.java:513)
at java.lang.Thread.run(Thread.java:722)
Caused by: javax.transaction.RollbackException: Transaction marked for rollback.
at com.sun.enterprise.transaction.JavaEETransactionImpl.commit(JavaEETransactionImpl.java:473)
at com.sun.enterprise.transaction.JavaEETransactionManagerSimplified.commit(JavaEETransactionManagerSimplified.java:852)
at com.sun.ejb.containers.BaseContainer.completeNewTx(BaseContainer.java:5114)
... 51 more
Caused by: Exception [EclipseLink-7197] (Eclipse Persistence Services - 2.3.1.v20111018-r10243): org.eclipse.persistence.exceptions.ValidationException
Exception Description: Null or zero primary key encountered in unit of work clone [[email]com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@6bd3162f[/email]], primary key [null]. Set descriptors IdValidation or the "eclipselink.id-validation" property.
at org.eclipse.persistence.exceptions.ValidationException.nullPrimaryKeyInUnitOfWorkClone(ValidationException.java:1439)
at org.eclipse.persistence.descriptors.changetracking.DeferredChangeDetectionPolicy.calculateChanges(DeferredChangeDetectionPolicy.java:107)
at org.eclipse.persistence.descriptors.changetracking.DeferredChangeDetectionPolicy.calculateChangesForExistingObject(DeferredChangeDetectionPolicy.java:54)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.calculateChanges(UnitOfWorkImpl.java:643)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.commitToDatabaseWithChangeSet(UnitOfWorkImpl.java:1490)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.issueSQLbeforeCompletion(UnitOfWorkImpl.java:3143)
at org.eclipse.persistence.internal.sessions.RepeatableWriteUnitOfWork.issueSQLbeforeCompletion(RepeatableWriteUnitOfWork.java:346)
at org.eclipse.persistence.transaction.AbstractSynchronizationListener.beforeCompletion(AbstractSynchronizationListener.java:157)
at org.eclipse.persistence.transaction.JTASynchronizationListener.beforeCompletion(JTASynchronizationListener.java:68)
at com.sun.enterprise.transaction.JavaEETransactionImpl.commit(JavaEETransactionImpl.java:435)
... 53 more
[/notag]
[Updated on: Thu, 05 July 2012 15:43] Report message to a moderator
|
|
| |
Re: Very strange "primary key [null]" validation exception [message #894814 is a reply to message #894772] |
Tue, 10 July 2012 15:56 |
Rodion Missing name Messages: 8 Registered: September 2009 |
Junior Member |
|
|
Quote:
Can you set the log level to finest.
Here is my log. Previous wasn't really with FINEST level because I miss one place where log level is actually was set.
Toggle Spoiler
Jul 10, 2012 5:48:21 PM com.hospitality.hp.osloproject.security.graniteDS.SpringSecurity3ServiceHP userCanAccessService
INFO: Allowed access to tom in role employee
Jul 10, 2012 5:48:21 PM com.hospitality.hp.baseclient.profile.ProfileServiceBean savePerson
INFO: Attempting to save Person asdfasdf asdfasdf (93)
[EL Finer]: 2012-07-10 17:48:21.231--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--client acquired: 360461022
[EL Finer]: 2012-07-10 17:48:21.231--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--TX binding to tx mgr, status=STATUS_ACTIVE
[EL Finer]: 2012-07-10 17:48:21.231--ClientSession(360461022)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--acquire unit of work: 217028567
[EL Finest]: 2012-07-10 17:48:21.231--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Merge clone with references asdfasdf asdfasdf (93)
[EL Finest]: 2012-07-10 17:48:21.232--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(referenceClass=Person )
[EL Finest]: 2012-07-10 17:48:21.232--ServerSession(1153560764)--Connection(1432502504)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.232--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.232--ServerSession(1153560764)--Connection(630418211)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, dateofbirth, language, name, nationality, personnumber, surname FROM PUBLIC.person WHERE (ID = ?)
bind => [93]
[EL Finest]: 2012-07-10 17:48:21.235--ServerSession(1153560764)--Connection(1432502504)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.235--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=EmployeeRoleInfo sql="SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.institution_id, t1.employeetype_id FROM PUBLIC.roleinfo t0, PUBLIC.employeeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.235--ServerSession(1153560764)--Connection(945475718)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.235--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.236--ServerSession(1153560764)--Connection(1378888273)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.institution_id, t1.employeetype_id FROM PUBLIC.roleinfo t0, PUBLIC.employeeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [93, EMPLOYEE]
[EL Finest]: 2012-07-10 17:48:21.238--ServerSession(1153560764)--Connection(945475718)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.238--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=PersonContactableProfile sql="SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.addressci_id, t1.emailci_id, t1.intsipcontactinfo_id, t1.mobilephoneci_id, t1.person_id, t1.phonenumberci_id, t1.servicephone_id, t1.sipcontactinfo_id, t1.voicephone_id FROM PUBLIC.contactableprofile t0, PUBLIC.personcontprofile t1 WHERE ((t1.person_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.238--ServerSession(1153560764)--Connection(1698912830)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.238--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.238--ServerSession(1153560764)--Connection(685363298)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.addressci_id, t1.emailci_id, t1.intsipcontactinfo_id, t1.mobilephoneci_id, t1.person_id, t1.phonenumberci_id, t1.servicephone_id, t1.sipcontactinfo_id, t1.voicephone_id FROM PUBLIC.contactableprofile t0, PUBLIC.personcontprofile t1 WHERE ((t1.person_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [93, PERSON]
[EL Finest]: 2012-07-10 17:48:21.241--ServerSession(1153560764)--Connection(1698912830)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.241--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Person )
[EL Finest]: 2012-07-10 17:48:21.242--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=RelativeRoleInfo sql="SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID FROM PUBLIC.roleinfo t0, PUBLIC.relativeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.242--ServerSession(1153560764)--Connection(92750435)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.242--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.242--ServerSession(1153560764)--Connection(1930916970)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID FROM PUBLIC.roleinfo t0, PUBLIC.relativeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [93, RELATIVE]
[EL Finest]: 2012-07-10 17:48:21.244--ServerSession(1153560764)--Connection(92750435)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.244--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=UserRoleInfo sql="SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.description, t1.sensorserveruserid, t1.terminalid, t1.institution_id FROM PUBLIC.roleinfo t0, PUBLIC.userroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.244--ServerSession(1153560764)--Connection(534094877)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.245--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.245--ServerSession(1153560764)--Connection(50953279)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.description, t1.sensorserveruserid, t1.terminalid, t1.institution_id FROM PUBLIC.roleinfo t0, PUBLIC.userroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [93, USER]
[EL Finest]: 2012-07-10 17:48:21.247--ServerSession(1153560764)--Connection(534094877)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.247--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Institution )
[EL Finest]: 2012-07-10 17:48:21.248--ServerSession(1153560764)--Connection(290516566)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.248--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.248--ServerSession(1153560764)--Connection(1481595131)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.dtype, t0.NAME, t0.regservicepin, t1.ID FROM PUBLIC.ORGANIZATION t0, PUBLIC.institution t1 WHERE ((t0.ID = ?) AND ((t1.ID = t0.ID) AND (t0.dtype = ?)))
bind => [1, INSTITUTION]
[EL Finest]: 2012-07-10 17:48:21.25--ServerSession(1153560764)--Connection(290516566)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.25--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=OrganizationContactableProfile sql="SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.organization_id FROM PUBLIC.contactableprofile t0, PUBLIC.orgcontprofile t1 WHERE ((t1.organization_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.25--ServerSession(1153560764)--Connection(623393304)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.25--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.251--ServerSession(1153560764)--Connection(1946030262)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.organization_id FROM PUBLIC.contactableprofile t0, PUBLIC.orgcontprofile t1 WHERE ((t1.organization_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [1, ORGANIZATION]
[EL Finest]: 2012-07-10 17:48:21.252--ServerSession(1153560764)--Connection(623393304)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.252--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Organization )
[EL Finest]: 2012-07-10 17:48:21.253--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=OrgEmployeesPhonesContactableProfile sql="SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.organization_id FROM PUBLIC.contactableprofile t0, PUBLIC.orgcontprofile t1 WHERE ((t1.organization_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.253--ServerSession(1153560764)--Connection(844658104)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.255--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.255--ServerSession(1153560764)--Connection(1301847258)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.organization_id FROM PUBLIC.contactableprofile t0, PUBLIC.orgcontprofile t1 WHERE ((t1.organization_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [1, ORGANIZATIONEMPLOYEES]
[EL Finest]: 2012-07-10 17:48:21.257--ServerSession(1153560764)--Connection(844658104)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.257--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Organization )
[EL Finest]: 2012-07-10 17:48:21.257--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadAllQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=RFIDToken sql="SELECT ID, TOKEN FROM PUBLIC.RFIDTOKEN WHERE (organization_id = ?)")
[EL Finest]: 2012-07-10 17:48:21.257--ServerSession(1153560764)--Connection(1344068612)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.258--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.258--ServerSession(1153560764)--Connection(380679091)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, TOKEN FROM PUBLIC.RFIDTOKEN WHERE (organization_id = ?)
bind => [1]
[EL Finest]: 2012-07-10 17:48:21.262--ServerSession(1153560764)--Connection(1344068612)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.262--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Person )
[EL Finest]: 2012-07-10 17:48:21.262--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Subnumber sql="SELECT ID, "number", prefix_id, userrole_id FROM PUBLIC.sms_subnumber WHERE (userrole_id = ?)")
[EL Finest]: 2012-07-10 17:48:21.262--ServerSession(1153560764)--Connection(1336789464)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.262--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.263--ServerSession(1153560764)--Connection(446606534)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, "number", prefix_id, userrole_id FROM PUBLIC.sms_subnumber WHERE (userrole_id = ?)
bind => [92]
[EL Finest]: 2012-07-10 17:48:21.264--ServerSession(1153560764)--Connection(1336789464)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.264--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadAllQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=ContactInfo sql="SELECT ID, DTYPE, contactableprofile_id, mobilephonenumber, CLIENTPASSWORD, CLIENTUSERNAME, sipstring, phonenumber, address_id, email, internal_phonenumber, sipcontactinfo_id FROM PUBLIC.contactinfo WHERE (contactableprofile_id = ?)")
[EL Finest]: 2012-07-10 17:48:21.265--ServerSession(1153560764)--Connection(37531704)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.265--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.265--ServerSession(1153560764)--Connection(1582640557)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, mobilephonenumber, CLIENTPASSWORD, CLIENTUSERNAME, sipstring, phonenumber, address_id, email, internal_phonenumber, sipcontactinfo_id FROM PUBLIC.contactinfo WHERE (contactableprofile_id = ?)
bind => [87]
[EL Finest]: 2012-07-10 17:48:21.266--ServerSession(1153560764)--Connection(37531704)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.267--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadAllQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=UsersContact sql="SELECT ID, contactgroup, contactnickname, usercomments, userrole_id, contactableprofile_id FROM PUBLIC.userrole_contacts WHERE (userrole_id = ?)")
[EL Finest]: 2012-07-10 17:48:21.267--ServerSession(1153560764)--Connection(1308989109)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.267--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.268--ServerSession(1153560764)--Connection(1357475095)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, contactgroup, contactnickname, usercomments, userrole_id, contactableprofile_id FROM PUBLIC.userrole_contacts WHERE (userrole_id = ?)
bind => [92]
[EL Finest]: 2012-07-10 17:48:21.269--ServerSession(1153560764)--Connection(1308989109)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.27--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the object [email]com.hospitality.hp.osloproject.entities.UserRoleInfo@4e26b060[/email]
[EL Finest]: 2012-07-10 17:48:21.27--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the object [email]com.hospitality.hp.osloproject.entities.contacts.profiles.PersonContactableProfile@33c830f9[/email]
[EL Finest]: 2012-07-10 17:48:21.27--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query DoesExistQuery(referenceClass=PersonContactableProfile )
[EL Finest]: 2012-07-10 17:48:21.271--ServerSession(1153560764)--Connection(49326348)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.271--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.271--ServerSession(1153560764)--Connection(99243094)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID FROM PUBLIC.contactableprofile t0, PUBLIC.personcontprofile t1 WHERE (((t0.ID = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?))) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [88, PERSON, PERSON]
[EL Finest]: 2012-07-10 17:48:21.272--ServerSession(1153560764)--Connection(49326348)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.272--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object ddddd ddddddd (89)
[EL Finest]: 2012-07-10 17:48:21.273--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object [email]com.hospitality.hp.osloproject.entities.contacts.profiles.PersonContactableProfile@33c830f9[/email]
[EL Finest]: 2012-07-10 17:48:21.273--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object [email]com.hospitality.hp.osloproject.entities.RelativeRoleInfo@e32b2bb[/email]
[EL Finest]: 2012-07-10 17:48:21.273--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object ddddd ddddddd (89)
[EL Finest]: 2012-07-10 17:48:21.274--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object [email]com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@c2b8997[/email]
[EL Finest]: 2012-07-10 17:48:21.274--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object [email]com.hospitality.hp.osloproject.entities.contacts.profiles.PersonContactableProfile@33c830f9[/email]
[EL Finest]: 2012-07-10 17:48:21.274--ClientSession(360461022)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ValueReadQuery(sql="CALL NEXT VALUE FOR PUBLIC.SEQ_PROFILE_ENTITES")
[EL Finest]: 2012-07-10 17:48:21.274--ServerSession(1153560764)--Connection(1800190421)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.274--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.275--ServerSession(1153560764)--Connection(2050786811)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--CALL NEXT VALUE FOR PUBLIC.SEQ_PROFILE_ENTITES
[EL Finest]: 2012-07-10 17:48:21.275--ServerSession(1153560764)--Connection(1800190421)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.276--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--assign sequence to the object (98 -> [email]com.hospitality.hp.osloproject.entities.contacts.UsersContact@43bd194d[/email])
[EL Finest]: 2012-07-10 17:48:21.276--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadAllQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=UserRelativeLink sql="SELECT ID, relativeinfo_id, userinfo_id FROM PUBLIC.USERRELATIVELINK WHERE (userinfo_id = ?)")
[EL Finest]: 2012-07-10 17:48:21.276--ServerSession(1153560764)--Connection(154871172)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.276--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.276--ServerSession(1153560764)--Connection(169607640)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, relativeinfo_id, userinfo_id FROM PUBLIC.USERRELATIVELINK WHERE (userinfo_id = ?)
bind => [92]
[EL Finest]: 2012-07-10 17:48:21.278--ServerSession(1153560764)--Connection(154871172)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.278--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=RelativeRoleInfo )
[EL Finest]: 2012-07-10 17:48:21.278--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=UserRoleInfo )
[EL Finest]: 2012-07-10 17:48:21.279--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object [email]com.hospitality.hp.osloproject.entities.UserRelativeLink@674525e1[/email]
[EL Finest]: 2012-07-10 17:48:21.279--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the object [email]com.hospitality.hp.osloproject.entities.contacts.profiles.PersonContactableProfile@33c830f9[/email]
[EL Finest]: 2012-07-10 17:48:21.279--ClientSession(360461022)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ValueReadQuery(sql="CALL NEXT VALUE FOR PUBLIC.SEQ_PROFILE_ENTITES")
[EL Finest]: 2012-07-10 17:48:21.279--ServerSession(1153560764)--Connection(1089426546)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.279--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.279--ServerSession(1153560764)--Connection(546384300)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--CALL NEXT VALUE FOR PUBLIC.SEQ_PROFILE_ENTITES
[EL Finest]: 2012-07-10 17:48:21.28--ServerSession(1153560764)--Connection(1089426546)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.28--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--assign sequence to the object (99 -> [email]com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@2a591eb6[/email])
[EL Finest]: 2012-07-10 17:48:21.281--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object [email]com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@c2b8997[/email]
[EL Finest]: 2012-07-10 17:48:21.281--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Register the existing object [email]com.hospitality.hp.osloproject.entities.UserRelativeLink@7e561ebe[/email]
[EL Finest]: 2012-07-10 17:48:21.281--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadAllQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Reminder sql="SELECT ID, reminder_type, ACKNOWLEDGEBEFORE, ACKNOWLEDGETIMEUNIT, ACKNOWLEDGEBLE, ALERTAHEADMINUTES, DETAILS, ENDDATE, STARTDATE, ownerroleinfo_id, schedulepattern_id, cause_id, VISITTYPE, VISITORNAME, visiting_contactable_id, initiatorphone, CUSTOMSUBTYPE, CUSTOMTYPE, VIDEOURL, VIDEO_ID, HTTPLINK FROM PUBLIC.REMINDER WHERE (ownerroleinfo_id = ?)")
[EL Finest]: 2012-07-10 17:48:21.282--ServerSession(1153560764)--Connection(1611564533)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.282--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.283--ServerSession(1153560764)--Connection(1501350167)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, reminder_type, ACKNOWLEDGEBEFORE, ACKNOWLEDGETIMEUNIT, ACKNOWLEDGEBLE, ALERTAHEADMINUTES, DETAILS, ENDDATE, STARTDATE, ownerroleinfo_id, schedulepattern_id, cause_id, VISITTYPE, VISITORNAME, visiting_contactable_id, initiatorphone, CUSTOMSUBTYPE, CUSTOMTYPE, VIDEOURL, VIDEO_ID, HTTPLINK FROM PUBLIC.REMINDER WHERE (ownerroleinfo_id = ?)
bind => [92]
[EL Finest]: 2012-07-10 17:48:21.284--ServerSession(1153560764)--Connection(1611564533)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finer]: 2012-07-10 17:48:21.285--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--TX beforeCompletion callback, status=STATUS_ACTIVE
[EL Finer]: 2012-07-10 17:48:21.285--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--begin unit of work commit
[EL Finest]: 2012-07-10 17:48:21.285--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="readObject" referenceClass=UserAccount sql="SELECT USERNAME, CHANGEPASSWORD, CREATEDDATE, ENABLED, ENDDATE, ROLE, STARTDATE, person_id, OWNERTYPE FROM PUBLIC.security_account WHERE (USERNAME = ?)")
[EL Finest]: 2012-07-10 17:48:21.285--ServerSession(1153560764)--Connection(1425074319)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.285--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.286--ServerSession(1153560764)--Connection(338964442)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT USERNAME, CHANGEPASSWORD, CREATEDDATE, ENABLED, ENDDATE, ROLE, STARTDATE, person_id, OWNERTYPE FROM PUBLIC.security_account WHERE (USERNAME = ?)
bind => [tom]
[EL Finest]: 2012-07-10 17:48:21.287--ServerSession(1153560764)--Connection(1425074319)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.287--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Person )
[EL Finest]: 2012-07-10 17:48:21.287--ServerSession(1153560764)--Connection(880617874)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.287--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.288--ServerSession(1153560764)--Connection(87313194)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, dateofbirth, language, name, nationality, personnumber, surname FROM PUBLIC.person WHERE (ID = ?)
bind => [55]
[EL Finest]: 2012-07-10 17:48:21.289--ServerSession(1153560764)--Connection(880617874)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.289--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=EmployeeRoleInfo sql="SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.institution_id, t1.employeetype_id FROM PUBLIC.roleinfo t0, PUBLIC.employeeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.289--ServerSession(1153560764)--Connection(180920004)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.289--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.289--ServerSession(1153560764)--Connection(2033146723)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.institution_id, t1.employeetype_id FROM PUBLIC.roleinfo t0, PUBLIC.employeeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [55, EMPLOYEE]
[EL Finest]: 2012-07-10 17:48:21.291--ServerSession(1153560764)--Connection(180920004)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.291--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Institution )
[EL Finest]: 2012-07-10 17:48:21.291--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=EmployeeType )
[EL Finest]: 2012-07-10 17:48:21.291--ServerSession(1153560764)--Connection(1554087970)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.291--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.291--ServerSession(1153560764)--Connection(1860396976)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, NAME, channel_id, role_id FROM PUBLIC.employee_type WHERE (ID = ?)
bind => [2]
[EL Finest]: 2012-07-10 17:48:21.293--ServerSession(1153560764)--Connection(1554087970)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.293--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Institution )
[EL Finest]: 2012-07-10 17:48:21.293--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Person )
[EL Finest]: 2012-07-10 17:48:21.293--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=PersonContactableProfile sql="SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.addressci_id, t1.emailci_id, t1.intsipcontactinfo_id, t1.mobilephoneci_id, t1.person_id, t1.phonenumberci_id, t1.servicephone_id, t1.sipcontactinfo_id, t1.voicephone_id FROM PUBLIC.contactableprofile t0, PUBLIC.personcontprofile t1 WHERE ((t1.person_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.293--ServerSession(1153560764)--Connection(990302416)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.293--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.293--ServerSession(1153560764)--Connection(1014441462)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.smssubscriber, t1.ID, t1.addressci_id, t1.emailci_id, t1.intsipcontactinfo_id, t1.mobilephoneci_id, t1.person_id, t1.phonenumberci_id, t1.servicephone_id, t1.sipcontactinfo_id, t1.voicephone_id FROM PUBLIC.contactableprofile t0, PUBLIC.personcontprofile t1 WHERE ((t1.person_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [55, PERSON]
[EL Finest]: 2012-07-10 17:48:21.295--ServerSession(1153560764)--Connection(990302416)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.295--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=AddressContactInfo )
[EL Finest]: 2012-07-10 17:48:21.295--ServerSession(1153560764)--Connection(805127626)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.295--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.296--ServerSession(1153560764)--Connection(485550435)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, address_id FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [49, ADDRESS]
[EL Finest]: 2012-07-10 17:48:21.297--ServerSession(1153560764)--Connection(805127626)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.297--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Address )
[EL Finest]: 2012-07-10 17:48:21.298--ServerSession(1153560764)--Connection(1890029431)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.298--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.298--ServerSession(1153560764)--Connection(146540393)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, CITY, COUNTRY, LATITUDE, LONGITUDE, POSTALCODE, STREET, STREET2 FROM PUBLIC.address WHERE (ID = ?)
bind => [6]
[EL Finest]: 2012-07-10 17:48:21.299--ServerSession(1153560764)--Connection(1890029431)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.3--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=ContactableProfile )
[EL Finest]: 2012-07-10 17:48:21.3--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=EmailContactInfo )
[EL Finest]: 2012-07-10 17:48:21.3--ServerSession(1153560764)--Connection(1862623789)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.3--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.3--ServerSession(1153560764)--Connection(1248899404)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, email FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [50, EMAIL]
[EL Finest]: 2012-07-10 17:48:21.302--ServerSession(1153560764)--Connection(1862623789)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.302--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=ContactableProfile )
[EL Finest]: 2012-07-10 17:48:21.302--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=MobilePhoneContactInfo )
[EL Finest]: 2012-07-10 17:48:21.302--ServerSession(1153560764)--Connection(1178120200)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.302--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.302--ServerSession(1153560764)--Connection(866976060)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, mobilephonenumber FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [51, MOBILEPHONE]
[EL Finest]: 2012-07-10 17:48:21.303--ServerSession(1153560764)--Connection(1178120200)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.304--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=ContactableProfile )
[EL Finest]: 2012-07-10 17:48:21.304--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=Person )
[EL Finest]: 2012-07-10 17:48:21.304--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=PhoneContactInfo )
[EL Finest]: 2012-07-10 17:48:21.304--ServerSession(1153560764)--Connection(325731305)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.304--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.305--ServerSession(1153560764)--Connection(630226932)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, phonenumber FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [52, PHONE]
[EL Finest]: 2012-07-10 17:48:21.306--ServerSession(1153560764)--Connection(325731305)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.306--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=ContactableProfile )
[EL Finest]: 2012-07-10 17:48:21.307--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=SeeViaContactInfo )
[EL Finest]: 2012-07-10 17:48:21.307--ServerSession(1153560764)--Connection(21146908)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.307--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.307--ServerSession(1153560764)--Connection(1081281001)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT ID, DTYPE, contactableprofile_id, CLIENTPASSWORD, CLIENTUSERNAME, sipstring FROM PUBLIC.contactinfo WHERE ((ID = ?) AND (DTYPE = ?))
bind => [53, SEEVIASIP]
[EL Finest]: 2012-07-10 17:48:21.309--ServerSession(1153560764)--Connection(21146908)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.309--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=ContactableProfile )
[EL Finest]: 2012-07-10 17:48:21.309--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=RelativeRoleInfo sql="SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID FROM PUBLIC.roleinfo t0, PUBLIC.relativeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.309--ServerSession(1153560764)--Connection(309179760)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.309--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.309--ServerSession(1153560764)--Connection(1621284227)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID FROM PUBLIC.roleinfo t0, PUBLIC.relativeroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [55, RELATIVE]
[EL Finest]: 2012-07-10 17:48:21.311--ServerSession(1153560764)--Connection(309179760)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.311--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Execute query ReadObjectQuery(name="file:/C:/Work/Projects/HospitalityIT/trunk/osloproject/osloproject-backend/osloproject-war-baseclient/target/glassfish/gfembed7851547338133471156tmp/applications/baseclientBackend/WEB-INF/classes/_osloproject-entities" referenceClass=UserRoleInfo sql="SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.description, t1.sensorserveruserid, t1.terminalid, t1.institution_id FROM PUBLIC.roleinfo t0, PUBLIC.userroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))")
[EL Finest]: 2012-07-10 17:48:21.311--ServerSession(1153560764)--Connection(1529138041)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection acquired from connection pool [read].
[EL Finest]: 2012-07-10 17:48:21.311--ServerSession(1153560764)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--reconnecting to external connection pool
[EL Fine]: 2012-07-10 17:48:21.311--ServerSession(1153560764)--Connection(1286251438)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--SELECT t0.ID, t0.DTYPE, t0.owner_id, t1.ID, t1.description, t1.sensorserveruserid, t1.terminalid, t1.institution_id FROM PUBLIC.roleinfo t0, PUBLIC.userroleinfo t1 WHERE ((t0.owner_id = ?) AND ((t1.ID = t0.ID) AND (t0.DTYPE = ?)))
bind => [55, USER]
[EL Finest]: 2012-07-10 17:48:21.312--ServerSession(1153560764)--Connection(1529138041)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Connection released to connection pool [read].
[EL Warning]: 2012-07-10 17:48:21.314--UnitOfWork(217028567)--Thread(Thread[http-thread-pool-8080(4),5,grizzly-kernel])--Local Exception Stack:
Exception [EclipseLink-7197] (Eclipse Persistence Services - 2.3.1.v20111018-r10243): org.eclipse.persistence.exceptions.ValidationException
Exception Description: Null or zero primary key encountered in unit of work clone [[email]com.hospitality.hp.osloproject.entities.contacts.info.PhoneContactInfo@5cdde2ac[/email]], primary key [null]. Set descriptors IdValidation or the "eclipselink.id-validation" property.
at org.eclipse.persistence.exceptions.ValidationException.nullPrimaryKeyInUnitOfWorkClone(ValidationException.java:1439)
at org.eclipse.persistence.descriptors.changetracking.DeferredChangeDetectionPolicy.calculateChanges(DeferredChangeDetectionPolicy.java:107)
at org.eclipse.persistence.descriptors.changetracking.DeferredChangeDetectionPolicy.calculateChangesForExistingObject(DeferredChangeDetectionPolicy.java:54)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.calculateChanges(UnitOfWorkImpl.java:643)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.commitToDatabaseWithChangeSet(UnitOfWorkImpl.java:1490)
at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.issueSQLbeforeCompletion(UnitOfWorkImpl.java:3143)
at org.eclipse.persistence.internal.sessions.RepeatableWriteUnitOfWork.issueSQLbeforeCompletion(RepeatableWriteUnitOfWork.java:346)
at org.eclipse.persistence.transaction.AbstractSynchronizationListener.beforeCompletion(AbstractSynchronizationListener.java:157)
at org.eclipse.persistence.transaction.JTASynchronizationListener.beforeCompletion(JTASynchronizationListener.java:68)
at com.sun.enterprise.transaction.JavaEETransactionImpl.commit(JavaEETransactionImpl.java:435)
at com.sun.enterprise.transaction.JavaEETransactionManagerSimplified.commit(JavaEETransactionManagerSimplified.java:852)
at com.sun.ejb.containers.BaseContainer.completeNewTx(BaseContainer.java:5114)
at com.sun.ejb.containers.BaseContainer.postInvokeTx(BaseContainer.java:4879)
at com.sun.ejb.containers.BaseContainer.postInvoke(BaseContainer.java:2039)
at com.sun.ejb.containers.BaseContainer.postInvoke(BaseContainer.java:1990)
at com.sun.ejb.containers.EJBLocalObjectInvocationHandler.invoke(EJBLocalObjectInvocationHandler.java:222)
at com.sun.ejb.containers.EJBLocalObjectInvocationHandlerDelegate.invoke(EJBLocalObjectInvocationHandlerDelegate.java:88)
at $Proxy264.savePerson(Unknown Source)
at com.hospitality.hp.baseclient.profile.__EJB31_Generated__ProfileServiceBean__Intf____Bean__.savePerson(Unknown Source)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:601)
at org.granite.messaging.service.ServiceInvocationContext.invoke(ServiceInvocationContext.java:71)
at org.granite.messaging.service.security.AbstractSecurityService.endAuthorization(AbstractSecurityService.java:67)
at com.hospitality.hp.osloproject.security.graniteDS.SpringSecurity3ServiceHP.authorize(SpringSecurity3ServiceHP.java:283)
at org.granite.messaging.service.ServiceInvoker.invoke(ServiceInvoker.java:214)
at org.granite.messaging.amf.process.AMF3MessageProcessor.processRemotingMessage(AMF3MessageProcessor.java:136)
at org.granite.messaging.amf.process.AMF3MessageProcessor.process(AMF3MessageProcessor.java:59)
at org.granite.messaging.amf.process.AMF0MessageProcessor.process(AMF0MessageProcessor.java:78)
at org.granite.messaging.webapp.AMFMessageServlet.doPost(AMFMessageServlet.java:59)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
at org.apache.catalina.core.StandardWrapper.service(StandardWrapper.java:1539)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:343)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:217)
at org.granite.messaging.webapp.AMFMessageFilter.doFilter(AMFMessageFilter.java:117)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:256)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:217)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:279)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:175)
at org.apache.catalina.core.StandardPipeline.doInvoke(StandardPipeline.java:655)
at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:595)
at com.sun.enterprise.web.WebPipeline.invoke(WebPipeline.java:98)
at com.sun.enterprise.web.PESessionLockingStandardPipeline.invoke(PESessionLockingStandardPipeline.java:91)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:162)
at org.apache.catalina.connector.CoyoteAdapter.doService(CoyoteAdapter.java:330)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:231)
at com.sun.enterprise.v3.services.impl.ContainerMapper.service(ContainerMapper.java:174)
at com.sun.grizzly.http.ProcessorTask.invokeAdapter(ProcessorTask.java:828)
at com.sun.grizzly.http.ProcessorTask.doProcess(ProcessorTask.java:725)
at com.sun.grizzly.http.ProcessorTask.process(ProcessorTask.java:1019)
at com.sun.grizzly.http.DefaultProtocolFilter.execute(DefaultProtocolFilter.java:225)
at com.sun.grizzly.DefaultProtocolChain.executeProtocolFilter(DefaultProtocolChain.java:137)
at com.sun.grizzly.DefaultProtocolChain.execute(DefaultProtocolChain.java:104)
at com.sun.grizzly.DefaultProtocolChain.execute(DefaultProtocolChain.java:90)
at com.sun.grizzly.http.HttpProtocolChain.execute(HttpProtocolChain.java:79)
at com.sun.grizzly.ProtocolChainContextTask.doCall(ProtocolChainContextTask.java:54)
at com.sun.grizzly.SelectionKeyContextTask.call(SelectionKeyContextTask.java:59)
at com.sun.grizzly.ContextTask.run(ContextTask.java:71)
at com.sun.grizzly.util.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:532)
at com.sun.grizzly.util.AbstractThreadPool$Worker.run(AbstractThreadPool.java:513)
at java.lang.Thread.run(Thread.java:722)
Quote:
Also try removing the creation of the UserContact from the code to see if it is affecting the merge. It may be some cyclic issue.
If I don't create UserContact along with PhoneContactInfo it work like a charm - i.e. only UserContact and only PhoneContactInfo both works perfectly. This is some cyclic issue indeed, not like exactly "cyclic" but more like existence of several pathes through graph to same entity.
[Updated on: Tue, 10 July 2012 16:02] Report message to a moderator
|
|
| | |
Goto Forum:
Current Time: Fri Sep 20 16:30:11 GMT 2024
Powered by FUDForum. Page generated in 0.03309 seconds
|