Uploaded image for project: 'MidPoint'
  1. MidPoint
  2. MID-1520

Performance Tuning

    XMLWordPrintable

Details

    • Improvement
    • Status: Closed
    • Major
    • Resolution: Fixed
    • 2.2 (Crius)
    • 2.2 (Crius)
    • Model, Repository
    • None
    • H2, MySQL, PostgreSQL, Oracle DB, MS SQL server, ...

    Description

      Performance measuring has shown some problems:

      • In general, import feature is slower than in previous version, mostly because auditing (for more specifix details, see logs in attachment),
      • problem occured during using midpoint with about 100k users in repository when clicking on users page in GUI. This takes up to 10-12 seconds using MySQL repository using decent HW and very fast SSD. The problem is in Hibernate:

      First phase, internalSize() count

      2013-07-31 09:34:02,286 [] [http-apr-8080-exec-6] TRACE (com.evolveum.midpoint.web.component.data.ObjectDataProvider): begin::internalSize()
      2013-07-31 09:34:02,287 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): SET TRANSACTION READ ONLY
      2013-07-31 09:34:02,288 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select count(*) as y0_ from m_user this_ inner join m_focus this_1_ on this_.id=this_1_.id and this_.oid=this_1_.oid inner join m_object this_2_ on this_.id=this_2_.id and this_.oid=this_2_.oid inner join m_container this_3_ on this_.id=this_3_.id and this_.oid=this_3_.oid
      2013-07-31 09:34:02,835 [] [http-apr-8080-exec-6] TRACE (com.evolveum.midpoint.web.component.data.ObjectDataProvider): end::internalSize()
      

      The problem is second phase, listing of 10 users, when midPoint creates about hundred of DB queries:

      2013-07-31 09:34:02,836 [] [http-apr-8080-exec-6] TRACE (com.evolveum.midpoint.web.component.data.ObjectDataProvider): begin::iterator() from 0 count 10.
      2013-07-31 09:34:02,836 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): SET TRANSACTION READ ONLY
      2013-07-31 09:34:02,837 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select this_.id as id6_3_, this_.oid as oid6_3_, this_2_.description as descript1_7_3_, this_2_.extId as extId7_3_, this_2_.extOid as extOid7_3_, this_2_.extType as extType7_3_, this_2_.version as version7_3_, this_1_.administrativeStatus as administ1_8_3_, this_1_.archiveTimestamp as archiveT2_8_3_, this_1_.disableTimestamp as disableT3_8_3_, this_1_.effectiveStatus as effectiv4_8_3_, this_1_.enableTimestamp as enableTi5_8_3_, this_1_.validFrom as validFrom8_3_, this_1_.validTo as validTo8_3_, this_1_.validityChangeTimestamp as validity8_8_3_, this_1_.validityStatus as validity9_8_3_, this_.additionalName_norm as addition1_34_3_, this_.additionalName_orig as addition2_34_3_, this_.costCenter as costCenter34_3_, this_.allowedIdmAdminGuiAccess as allowedI4_34_3_, this_.passwordXml as password5_34_3_, this_.emailAddress as emailAdd6_34_3_, this_.employeeNumber as employee7_34_3_, this_.familyName_norm as familyName8_34_3_, this_.familyName_orig as familyName9_34_3_, this_.fullName_norm as fullName10_34_3_, this_.fullName_orig as fullName11_34_3_, this_.givenName_norm as givenName12_34_3_, this_.givenName_orig as givenName13_34_3_, this_.honorificPrefix_norm as honorif14_34_3_, this_.honorificPrefix_orig as honorif15_34_3_, this_.honorificSuffix_norm as honorif16_34_3_, this_.honorificSuffix_orig as honorif17_34_3_, this_.locale as locale34_3_, this_.locality_norm as locality19_34_3_, this_.locality_orig as locality20_34_3_, this_.name_norm as name21_34_3_, this_.name_orig as name22_34_3_, this_.nickName_norm as nickName23_34_3_, this_.nickName_orig as nickName24_34_3_, this_.preferredLanguage as preferr25_34_3_, this_.telephoneNumber as telepho26_34_3_, this_.timezone as timezone34_3_, this_.title_norm as title28_34_3_, this_.title_orig as title29_34_3_, ranycontai2_.owner_id as owner1_12_0_, ranycontai2_.owner_oid as owner2_12_0_, ranycontai2_.owner_type as owner3_12_0_, rmetadata3_.owner_id as owner1_19_1_, rmetadata3_.owner_oid as owner2_19_1_, rmetadata3_.createChannel as createCh3_19_1_, rmetadata3_.createTimestamp as createTi4_19_1_, rmetadata3_.creatorRef_description as creatorRef5_19_1_, rmetadata3_.creatorRef_filter as creatorRef6_19_1_, rmetadata3_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata3_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata3_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata3_.creatorRef_type as creatorRef10_19_1_, rmetadata3_.modifierRef_description as modifie11_19_1_, rmetadata3_.modifierRef_filter as modifie12_19_1_, rmetadata3_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata3_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata3_.modifierRef_targetOid as modifie15_19_1_, rmetadata3_.modifierRef_type as modifie16_19_1_, rmetadata3_.modifyChannel as modifyC17_19_1_, rmetadata3_.modifyTimestamp as modifyT18_19_1_, roperation4_.owner_oid as owner1_23_2_, roperation4_.owner_id as owner2_23_2_, roperation4_.details as details23_2_, roperation4_.localizedMessage as localize4_23_2_, roperation4_.message as message23_2_, roperation4_.messageCode as messageC6_23_2_, roperation4_.operation as operation23_2_, roperation4_.params as params23_2_, roperation4_.partialResults as partialR9_23_2_, roperation4_.status as status23_2_, roperation4_.token as token23_2_ from m_user this_ inner join m_focus this_1_ on this_.id=this_1_.id and this_.oid=this_1_.oid inner join m_object this_2_ on this_.id=this_2_.id and this_.oid=this_2_.oid inner join m_container this_3_ on this_.id=this_3_.id and this_.oid=this_3_.oid left outer join m_any ranycontai2_ on this_2_.extId=ranycontai2_.owner_id and this_2_.extOid=ranycontai2_.owner_oid and this_2_.extType=ranycontai2_.owner_type left outer join m_metadata rmetadata3_ on this_.id=rmetadata3_.owner_id and this_.oid=rmetadata3_.owner_oid left outer join m_operation_result roperation4_ on this_.id=roperation4_.owner_id and this_.oid=roperation4_.owner_oid order by this_.name_orig asc limit ?
      2013-07-31 09:34:09,335 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): SET TRANSACTION READ ONLY
      2013-07-31 09:34:09,335 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select rsystemcon0_.id as id6_2_, rsystemcon0_.oid as oid6_2_, rsystemcon0_1_.description as descript1_7_2_, rsystemcon0_1_.extId as extId7_2_, rsystemcon0_1_.extOid as extOid7_2_, rsystemcon0_1_.extType as extType7_2_, rsystemcon0_1_.version as version7_2_, rsystemcon0_.cleanupPolicy as cleanupP1_31_2_, rsystemcon0_.connectorFramework as connecto2_31_2_, rsystemcon0_.d22_description as d3_31_2_, rsystemcon0_.defaultUserTemplateRef_filter as defaultU4_31_2_, rsystemcon0_.d22_relationLocalPart as d5_31_2_, rsystemcon0_.d22_relationNamespace as d6_31_2_, rsystemcon0_.d22_targetOid as d7_31_2_, rsystemcon0_.defaultUserTemplateRef_type as defaultU8_31_2_, rsystemcon0_.g36 as g9_31_2_, rsystemcon0_.g23_description as g10_31_2_, rsystemcon0_.globalPasswordPolicyRef_filter as globalP11_31_2_, rsystemcon0_.g23_relationLocalPart as g12_31_2_, rsystemcon0_.g23_relationNamespace as g13_31_2_, rsystemcon0_.g23_targetOid as g14_31_2_, rsystemcon0_.globalPasswordPolicyRef_type as globalP15_31_2_, rsystemcon0_.logging as logging31_2_, rsystemcon0_.modelHooks as modelHooks31_2_, rsystemcon0_.name_norm as name18_31_2_, rsystemcon0_.name_orig as name19_31_2_, rsystemcon0_.notificationConfiguration as notific20_31_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_system_configuration rsystemcon0_ inner join m_object rsystemcon0_1_ on rsystemcon0_.id=rsystemcon0_1_.id and rsystemcon0_.oid=rsystemcon0_1_.oid inner join m_container rsystemcon0_2_ on rsystemcon0_.id=rsystemcon0_2_.id and rsystemcon0_.oid=rsystemcon0_2_.oid left outer join m_any ranycontai1_ on rsystemcon0_1_.extId=ranycontai1_.owner_id and rsystemcon0_1_.extOid=ranycontai1_.owner_oid and rsystemcon0_1_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on rsystemcon0_.id=rmetadata2_.owner_id and rsystemcon0_.oid=rmetadata2_.owner_oid where rsystemcon0_.id=? and rsystemcon0_.oid=?
      2013-07-31 09:34:09,338 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:09,338 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:09,339 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select createappr0_.owner_id as owner2_19_1_, createappr0_.owner_oid as owner3_19_1_, createappr0_.owner_id as owner2_21_1_, createappr0_.owner_oid as owner3_21_1_, createappr0_.relLocalPart as relLocal4_21_1_, createappr0_.relNamespace as relNames5_21_1_, createappr0_.targetOid as targetOid21_1_, createappr0_.owner_id as owner2_21_0_, createappr0_.owner_oid as owner3_21_0_, createappr0_.relLocalPart as relLocal4_21_0_, createappr0_.relNamespace as relNames5_21_0_, createappr0_.targetOid as targetOid21_0_, createappr0_.description as descript7_21_0_, createappr0_.filter as filter21_0_, createappr0_.containerType as containe9_21_0_, createappr0_.reference_type as reference1_21_0_ from m_reference createappr0_ where  ( createappr0_.reference_type=5)  and createappr0_.owner_id=? and createappr0_.owner_oid=?
      2013-07-31 09:34:09,339 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select modifyappr0_.owner_id as owner2_19_1_, modifyappr0_.owner_oid as owner3_19_1_, modifyappr0_.owner_id as owner2_21_1_, modifyappr0_.owner_oid as owner3_21_1_, modifyappr0_.relLocalPart as relLocal4_21_1_, modifyappr0_.relNamespace as relNames5_21_1_, modifyappr0_.targetOid as targetOid21_1_, modifyappr0_.owner_id as owner2_21_0_, modifyappr0_.owner_oid as owner3_21_0_, modifyappr0_.relLocalPart as relLocal4_21_0_, modifyappr0_.relNamespace as relNames5_21_0_, modifyappr0_.targetOid as targetOid21_0_, modifyappr0_.description as descript7_21_0_, modifyappr0_.filter as filter21_0_, modifyappr0_.containerType as containe9_21_0_, modifyappr0_.reference_type as reference1_21_0_ from m_reference modifyappr0_ where  ( modifyappr0_.reference_type=6)  and modifyappr0_.owner_id=? and modifyappr0_.owner_oid=?
      2013-07-31 09:34:09,343 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): SET TRANSACTION READ ONLY
      2013-07-31 09:34:09,343 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select rnode0_.id as id6_2_, rnode0_.oid as oid6_2_, rnode0_1_.description as descript1_7_2_, rnode0_1_.extId as extId7_2_, rnode0_1_.extOid as extOid7_2_, rnode0_1_.extType as extType7_2_, rnode0_1_.version as version7_2_, rnode0_.clusteredNode as clustere1_20_2_, rnode0_.hostname as hostname20_2_, rnode0_.internalNodeIdentifier as internal3_20_2_, rnode0_.jmxPort as jmxPort20_2_, rnode0_.lastCheckInTime as lastChec5_20_2_, rnode0_.name_norm as name6_20_2_, rnode0_.name_orig as name7_20_2_, rnode0_.nodeIdentifier as nodeIden8_20_2_, rnode0_.running as running20_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_node rnode0_ inner join m_object rnode0_1_ on rnode0_.id=rnode0_1_.id and rnode0_.oid=rnode0_1_.oid inner join m_container rnode0_2_ on rnode0_.id=rnode0_2_.id and rnode0_.oid=rnode0_2_.oid left outer join m_any ranycontai1_ on rnode0_1_.extId=ranycontai1_.owner_id and rnode0_1_.extOid=ranycontai1_.owner_oid and rnode0_1_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on rnode0_.id=rmetadata2_.owner_id and rnode0_.oid=rmetadata2_.owner_oid where rnode0_.id=? and rnode0_.oid=?
      2013-07-31 09:34:09,345 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:09,346 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:09,347 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): SET TRANSACTION READ ONLY
      2013-07-31 09:34:09,348 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select this_.id as id6_2_, this_.oid as oid6_2_, this_1_.description as descript1_7_2_, this_1_.extId as extId7_2_, this_1_.extOid as extOid7_2_, this_1_.extType as extType7_2_, this_1_.version as version7_2_, this_.clusteredNode as clustere1_20_2_, this_.hostname as hostname20_2_, this_.internalNodeIdentifier as internal3_20_2_, this_.jmxPort as jmxPort20_2_, this_.lastCheckInTime as lastChec5_20_2_, this_.name_norm as name6_20_2_, this_.name_orig as name7_20_2_, this_.nodeIdentifier as nodeIden8_20_2_, this_.running as running20_2_, ranycontai2_.owner_id as owner1_12_0_, ranycontai2_.owner_oid as owner2_12_0_, ranycontai2_.owner_type as owner3_12_0_, rmetadata3_.owner_id as owner1_19_1_, rmetadata3_.owner_oid as owner2_19_1_, rmetadata3_.createChannel as createCh3_19_1_, rmetadata3_.createTimestamp as createTi4_19_1_, rmetadata3_.creatorRef_description as creatorRef5_19_1_, rmetadata3_.creatorRef_filter as creatorRef6_19_1_, rmetadata3_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata3_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata3_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata3_.creatorRef_type as creatorRef10_19_1_, rmetadata3_.modifierRef_description as modifie11_19_1_, rmetadata3_.modifierRef_filter as modifie12_19_1_, rmetadata3_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata3_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata3_.modifierRef_targetOid as modifie15_19_1_, rmetadata3_.modifierRef_type as modifie16_19_1_, rmetadata3_.modifyChannel as modifyC17_19_1_, rmetadata3_.modifyTimestamp as modifyT18_19_1_ from m_node this_ inner join m_object this_1_ on this_.id=this_1_.id and this_.oid=this_1_.oid inner join m_container this_2_ on this_.id=this_2_.id and this_.oid=this_2_.oid left outer join m_any ranycontai2_ on this_1_.extId=ranycontai2_.owner_id and this_1_.extOid=ranycontai2_.owner_oid and this_1_.extType=ranycontai2_.owner_type left outer join m_metadata rmetadata3_ on this_.id=rmetadata3_.owner_id and this_.oid=rmetadata3_.owner_oid
      2013-07-31 09:34:09,350 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:09,351 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:09,353 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select rnode0_.id as id6_2_, rnode0_.oid as oid6_2_, rnode0_1_.description as descript1_7_2_, rnode0_1_.extId as extId7_2_, rnode0_1_.extOid as extOid7_2_, rnode0_1_.extType as extType7_2_, rnode0_1_.version as version7_2_, rnode0_.clusteredNode as clustere1_20_2_, rnode0_.hostname as hostname20_2_, rnode0_.internalNodeIdentifier as internal3_20_2_, rnode0_.jmxPort as jmxPort20_2_, rnode0_.lastCheckInTime as lastChec5_20_2_, rnode0_.name_norm as name6_20_2_, rnode0_.name_orig as name7_20_2_, rnode0_.nodeIdentifier as nodeIden8_20_2_, rnode0_.running as running20_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_node rnode0_ inner join m_object rnode0_1_ on rnode0_.id=rnode0_1_.id and rnode0_.oid=rnode0_1_.oid inner join m_container rnode0_2_ on rnode0_.id=rnode0_2_.id and rnode0_.oid=rnode0_2_.oid left outer join m_any ranycontai1_ on rnode0_1_.extId=ranycontai1_.owner_id and rnode0_1_.extOid=ranycontai1_.owner_oid and rnode0_1_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on rnode0_.id=rmetadata2_.owner_id and rnode0_.oid=rmetadata2_.owner_oid where rnode0_.id=? and rnode0_.oid=?
      2013-07-31 09:34:09,355 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:09,356 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:09,358 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): update m_object set description=?, extId=?, extOid=?, extType=?, version=? where id=? and oid=?
      2013-07-31 09:34:09,359 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): update m_node set clusteredNode=?, hostname=?, internalNodeIdentifier=?, jmxPort=?, lastCheckInTime=?, name_norm=?, name_orig=?, nodeIdentifier=?, running=? where id=? and oid=?
      2013-07-31 09:34:09,362 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): SET TRANSACTION READ ONLY
      2013-07-31 09:34:09,363 [] [ClusterManagerThread] DEBUG (org.hibernate.SQL): select this_.id as id6_3_, this_.oid as oid6_3_, this_1_.description as descript1_7_3_, this_1_.extId as extId7_3_, this_1_.extOid as extOid7_3_, this_1_.extType as extType7_3_, this_1_.version as version7_3_, this_.binding as binding32_3_, this_.canRunOnNode as canRunOn2_32_3_, this_.category as category32_3_, this_.completionTimestamp as completi4_32_3_, this_.executionStatus as executio5_32_3_, this_.handlerUri as handlerUri32_3_, this_.lastRunFinishTimestamp as lastRunF7_32_3_, this_.lastRunStartTimestamp as lastRunS8_32_3_, this_.name_norm as name9_32_3_, this_.name_orig as name10_32_3_, this_.node as node32_3_, this_.objectRef_description as objectRef12_32_3_, this_.objectRef_filter as objectRef13_32_3_, this_.objectRef_relationLocalPart as objectRef14_32_3_, this_.objectRef_relationNamespace as objectRef15_32_3_, this_.objectRef_targetOid as objectRef16_32_3_, this_.objectRef_type as objectRef17_32_3_, this_.otherHandlersUriStack as otherHa18_32_3_, this_.ownerRef_description as ownerRef19_32_3_, this_.ownerRef_filter as ownerRef20_32_3_, this_.ownerRef_relationLocalPart as ownerRef21_32_3_, this_.ownerRef_relationNamespace as ownerRef22_32_3_, this_.ownerRef_targetOid as ownerRef23_32_3_, this_.ownerRef_type as ownerRef24_32_3_, this_.parent as parent32_3_, this_.progress as progress32_3_, this_.recurrence as recurrence32_3_, this_.resultStatus as resultS28_32_3_, this_.schedule as schedule32_3_, this_.taskIdentifier as taskIde30_32_3_, this_.threadStopAction as threadS31_32_3_, this_.waitingReason as waiting32_32_3_, ranycontai2_.owner_id as owner1_12_0_, ranycontai2_.owner_oid as owner2_12_0_, ranycontai2_.owner_type as owner3_12_0_, rmetadata3_.owner_id as owner1_19_1_, rmetadata3_.owner_oid as owner2_19_1_, rmetadata3_.createChannel as createCh3_19_1_, rmetadata3_.createTimestamp as createTi4_19_1_, rmetadata3_.creatorRef_description as creatorRef5_19_1_, rmetadata3_.creatorRef_filter as creatorRef6_19_1_, rmetadata3_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata3_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata3_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata3_.creatorRef_type as creatorRef10_19_1_, rmetadata3_.modifierRef_description as modifie11_19_1_, rmetadata3_.modifierRef_filter as modifie12_19_1_, rmetadata3_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata3_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata3_.modifierRef_targetOid as modifie15_19_1_, rmetadata3_.modifierRef_type as modifie16_19_1_, rmetadata3_.modifyChannel as modifyC17_19_1_, rmetadata3_.modifyTimestamp as modifyT18_19_1_, roperation4_.owner_oid as owner1_23_2_, roperation4_.owner_id as owner2_23_2_, roperation4_.details as details23_2_, roperation4_.localizedMessage as localize4_23_2_, roperation4_.message as message23_2_, roperation4_.messageCode as messageC6_23_2_, roperation4_.operation as operation23_2_, roperation4_.params as params23_2_, roperation4_.partialResults as partialR9_23_2_, roperation4_.status as status23_2_, roperation4_.token as token23_2_ from m_task this_ inner join m_object this_1_ on this_.id=this_1_.id and this_.oid=this_1_.oid inner join m_container this_2_ on this_.id=this_2_.id and this_.oid=this_2_.oid left outer join m_any ranycontai2_ on this_1_.extId=ranycontai2_.owner_id and this_1_.extOid=ranycontai2_.owner_oid and this_1_.extType=ranycontai2_.owner_type left outer join m_metadata rmetadata3_ on this_.id=rmetadata3_.owner_id and this_.oid=rmetadata3_.owner_oid left outer join m_operation_result roperation4_ on this_.id=roperation4_.owner_id and this_.oid=roperation4_.owner_oid where (this_.executionStatus=? and this_.waitingReason=?)
      2013-07-31 09:34:10,367 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,368 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,369 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select createappr0_.owner_id as owner2_19_1_, createappr0_.owner_oid as owner3_19_1_, createappr0_.owner_id as owner2_21_1_, createappr0_.owner_oid as owner3_21_1_, createappr0_.relLocalPart as relLocal4_21_1_, createappr0_.relNamespace as relNames5_21_1_, createappr0_.targetOid as targetOid21_1_, createappr0_.owner_id as owner2_21_0_, createappr0_.owner_oid as owner3_21_0_, createappr0_.relLocalPart as relLocal4_21_0_, createappr0_.relNamespace as relNames5_21_0_, createappr0_.targetOid as targetOid21_0_, createappr0_.description as descript7_21_0_, createappr0_.filter as filter21_0_, createappr0_.containerType as containe9_21_0_, createappr0_.reference_type as reference1_21_0_ from m_reference createappr0_ where  ( createappr0_.reference_type=5)  and createappr0_.owner_id=? and createappr0_.owner_oid=?
      2013-07-31 09:34:10,369 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select modifyappr0_.owner_id as owner2_19_1_, modifyappr0_.owner_oid as owner3_19_1_, modifyappr0_.owner_id as owner2_21_1_, modifyappr0_.owner_oid as owner3_21_1_, modifyappr0_.relLocalPart as relLocal4_21_1_, modifyappr0_.relNamespace as relNames5_21_1_, modifyappr0_.targetOid as targetOid21_1_, modifyappr0_.owner_id as owner2_21_0_, modifyappr0_.owner_oid as owner3_21_0_, modifyappr0_.relLocalPart as relLocal4_21_0_, modifyappr0_.relNamespace as relNames5_21_0_, modifyappr0_.targetOid as targetOid21_0_, modifyappr0_.description as descript7_21_0_, modifyappr0_.filter as filter21_0_, modifyappr0_.containerType as containe9_21_0_, modifyappr0_.reference_type as reference1_21_0_ from m_reference modifyappr0_ where  ( modifyappr0_.reference_type=6)  and modifyappr0_.owner_id=? and modifyappr0_.owner_oid=?
      2013-07-31 09:34:10,370 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,370 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,374 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,375 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,375 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,376 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,376 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,377 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,377 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,380 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,380 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,381 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,381 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,381 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,382 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,382 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,385 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,385 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,386 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,386 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,386 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,387 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,387 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,389 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,390 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,390 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,391 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,391 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,392 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,392 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,394 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,395 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,395 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,395 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,396 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,396 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,397 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,399 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,399 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,400 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,400 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,401 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,401 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,402 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,404 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,404 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,405 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,405 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,406 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,406 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,407 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,410 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,411 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,411 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,412 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,412 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,413 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,413 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,416 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,417 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,417 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,418 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select parentorgr0_.owner_id as owner2_6_1_, parentorgr0_.owner_oid as owner3_6_1_, parentorgr0_.owner_id as owner2_21_1_, parentorgr0_.owner_oid as owner3_21_1_, parentorgr0_.relLocalPart as relLocal4_21_1_, parentorgr0_.relNamespace as relNames5_21_1_, parentorgr0_.targetOid as targetOid21_1_, parentorgr0_.owner_id as owner2_21_0_, parentorgr0_.owner_oid as owner3_21_0_, parentorgr0_.relLocalPart as relLocal4_21_0_, parentorgr0_.relNamespace as relNames5_21_0_, parentorgr0_.targetOid as targetOid21_0_, parentorgr0_.description as descript7_21_0_, parentorgr0_.filter as filter21_0_, parentorgr0_.containerType as containe9_21_0_, parentorgr0_.reference_type as reference1_21_0_ from m_reference parentorgr0_ where  ( parentorgr0_.reference_type=0)  and parentorgr0_.owner_id=? and parentorgr0_.owner_oid=?
      2013-07-31 09:34:10,418 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select trigger0_.owner_id as owner2_6_1_, trigger0_.owner_oid as owner3_6_1_, trigger0_.id as id33_1_, trigger0_.oid as oid33_1_, trigger0_.id as id6_0_, trigger0_.oid as oid6_0_, trigger0_.handlerUri as handlerUri33_0_, trigger0_.owner_id as owner2_33_0_, trigger0_.owner_oid as owner3_33_0_, trigger0_.timestampValue as timestam4_33_0_ from m_trigger trigger0_ inner join m_container trigger0_1_ on trigger0_.id=trigger0_1_.id and trigger0_.oid=trigger0_1_.oid where trigger0_.owner_id=? and trigger0_.owner_oid=?
      2013-07-31 09:34:10,419 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select linkref0_.owner_id as owner2_6_1_, linkref0_.owner_oid as owner3_6_1_, linkref0_.owner_id as owner2_21_1_, linkref0_.owner_oid as owner3_21_1_, linkref0_.relLocalPart as relLocal4_21_1_, linkref0_.relNamespace as relNames5_21_1_, linkref0_.targetOid as targetOid21_1_, linkref0_.owner_id as owner2_21_0_, linkref0_.owner_oid as owner3_21_0_, linkref0_.relLocalPart as relLocal4_21_0_, linkref0_.relNamespace as relNames5_21_0_, linkref0_.targetOid as targetOid21_0_, linkref0_.description as descript7_21_0_, linkref0_.filter as filter21_0_, linkref0_.containerType as containe9_21_0_, linkref0_.reference_type as reference1_21_0_ from m_reference linkref0_ where  ( linkref0_.reference_type=1)  and linkref0_.owner_id=? and linkref0_.owner_oid=?
      2013-07-31 09:34:10,419 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select assignment0_.owner_id as owner14_6_3_, assignment0_.owner_oid as owner15_6_3_, assignment0_.id as id13_3_, assignment0_.oid as oid13_3_, assignment0_.id as id6_2_, assignment0_.oid as oid6_2_, assignment0_.accountConstruction as accountC1_13_2_, assignment0_.administrativeStatus as administ2_13_2_, assignment0_.archiveTimestamp as archiveT3_13_2_, assignment0_.disableTimestamp as disableT4_13_2_, assignment0_.effectiveStatus as effectiv5_13_2_, assignment0_.enableTimestamp as enableTi6_13_2_, assignment0_.validFrom as validFrom13_2_, assignment0_.validTo as validTo13_2_, assignment0_.validityChangeTimestamp as validity9_13_2_, assignment0_.validityStatus as validit10_13_2_, assignment0_.assignmentOwner as assignm11_13_2_, assignment0_.construction as constru12_13_2_, assignment0_.description as descrip13_13_2_, assignment0_.extId as extId13_2_, assignment0_.extOid as extOid13_2_, assignment0_.extType as extType13_2_, assignment0_.owner_id as owner14_13_2_, assignment0_.owner_oid as owner15_13_2_, assignment0_.targetRef_description as targetRef16_13_2_, assignment0_.targetRef_filter as targetRef17_13_2_, assignment0_.targetRef_relationLocalPart as targetRef18_13_2_, assignment0_.targetRef_relationNamespace as targetRef19_13_2_, assignment0_.targetRef_targetOid as targetRef20_13_2_, assignment0_.targetRef_type as targetRef21_13_2_, ranycontai1_.owner_id as owner1_12_0_, ranycontai1_.owner_oid as owner2_12_0_, ranycontai1_.owner_type as owner3_12_0_, rmetadata2_.owner_id as owner1_19_1_, rmetadata2_.owner_oid as owner2_19_1_, rmetadata2_.createChannel as createCh3_19_1_, rmetadata2_.createTimestamp as createTi4_19_1_, rmetadata2_.creatorRef_description as creatorRef5_19_1_, rmetadata2_.creatorRef_filter as creatorRef6_19_1_, rmetadata2_.creatorRef_relationLocalPart as creatorRef7_19_1_, rmetadata2_.creatorRef_relationNamespace as creatorRef8_19_1_, rmetadata2_.creatorRef_targetOid as creatorRef9_19_1_, rmetadata2_.creatorRef_type as creatorRef10_19_1_, rmetadata2_.modifierRef_description as modifie11_19_1_, rmetadata2_.modifierRef_filter as modifie12_19_1_, rmetadata2_.modifierRef_relationLocalPart as modifie13_19_1_, rmetadata2_.modifierRef_relationNamespace as modifie14_19_1_, rmetadata2_.modifierRef_targetOid as modifie15_19_1_, rmetadata2_.modifierRef_type as modifie16_19_1_, rmetadata2_.modifyChannel as modifyC17_19_1_, rmetadata2_.modifyTimestamp as modifyT18_19_1_ from m_assignment assignment0_ inner join m_container assignment0_1_ on assignment0_.id=assignment0_1_.id and assignment0_.oid=assignment0_1_.oid left outer join m_any ranycontai1_ on assignment0_.extId=ranycontai1_.owner_id and assignment0_.extOid=ranycontai1_.owner_oid and assignment0_.extType=ranycontai1_.owner_type left outer join m_metadata rmetadata2_ on assignment0_.id=rmetadata2_.owner_id and assignment0_.oid=rmetadata2_.owner_oid where assignment0_.owner_id=? and assignment0_.owner_oid=?
      2013-07-31 09:34:10,422 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select employeety0_.user_id as user1_6_0_, employeety0_.user_oid as user2_6_0_, employeety0_.employeeType as employee3_39_0_ from m_user_employee_type employeety0_ where employeety0_.user_id=? and employeety0_.user_oid=?
      2013-07-31 09:34:10,422 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm37_0_, organizati0_.orig as orig37_0_ from m_user_organizational_unit organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,423 [] [http-apr-8080-exec-6] DEBUG (org.hibernate.SQL): select organizati0_.user_id as user1_6_0_, organizati0_.user_oid as user2_6_0_, organizati0_.norm as norm38_0_, organizati0_.orig as orig38_0_ from m_user_organization organizati0_ where organizati0_.user_id=? and organizati0_.user_oid=?
      2013-07-31 09:34:10,430 [] [http-apr-8080-exec-6] TRACE (com.evolveum.midpoint.web.component.data.ObjectDataProvider): end::iterator()
      

      What may be helpfull?

      • hibernate mapping (joins vs more selects)
      • improve db data model
      • db tuning may help tremendously

      Another improvements:

      • audit subsystem perf improvements would be helpfull as well

      Attachments

        1. 2.2_Performance_Log_H2_new.pdf
          494 kB
        2. 2.2_Performance_Log_MSSQL.pdf
          351 kB
        3. 2.2_Performance_Log_MySQL.pdf
          439 kB
        4. 2.2_Performance_Log_PSQL.pdf
          382 kB
        5. 2.2_Performance_Log_Summary.pdf
          515 kB
        6. 2.2_Performance_Log_Oracle.pdf
          321 kB
        7. 2.2_Performance_Log_RESOURCES.pdf
          299 kB
        8. 2.2_MySQL_done.pdf
          308 kB
        9. final_DB_comparison.pdf
          201 kB
        10. final_H2.pdf
          233 kB
        11. final_MSSQL.pdf
          217 kB
        12. final_MySQL.pdf
          274 kB
        13. final_PSQL.pdf
          274 kB

        Activity

          People

            semancik Radovan Semancik
            erik Erik Suta
            Votes:
            0 Vote for this issue
            Watchers:
            2 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: