-->
These old forums are deprecated now and set to read-only. We are waiting for you on our new forums!
More modern, Discourse-based and with GitHub/Google/Twitter authentication built-in.

All times are UTC - 5 hours [ DST ]



Forum locked This topic is locked, you cannot edit posts or make further replies.  [ 1 post ] 
Author Message
 Post subject: EJB3-QL case sensitive bug in identification variables
PostPosted: Wed Jun 21, 2006 6:34 am 
Newbie

Joined: Wed Jun 21, 2006 5:46 am
Posts: 10
Location: Finland
Seems like there is a case sensitive/insensitive bug in Hibernate EJB3-QL identification variable processing. EJB3 Java Persistence API Final Release states in 4.4.2 Identification Variables that identification variables are case insensitive. Hibernate treats them as case sensitive, because it converts all the EJB3-QL queries to HQL queries where all the identification variables (aliases) are case sensitive.

Used Hibernate EntityManager Version: 3.2.0 CR1

Here is an example. Following Log messages are from simple JUnit test which uses Spring Frameworks managed transactions. Build/run tool is Maven 1.0.2.

Not working query (notice uppercase X): SELECT x FROM Keyword as X WHERE x.id IN ( 1,2 ) ORDER BY x.id
Code:
DEBUG jdbc.JDBCContext:203 [afterTransactionBegin] (2006-06-21 13:23:19,296) after transaction begin
DEBUG query.QueryPlanCache:69 [getHQLQueryPlan] (2006-06-21 13:23:19,312) unable to locate HQL query plan in cache; generating (SELECT x FROM Keyword as X WHERE x.id IN ( 1,2 ) ORDER BY x.id)
DEBUG ast.QueryTranslatorImpl:245 [parse] (2006-06-21 13:23:19,437) parse() - HQL: SELECT x FROM aeonstore.domain.Keyword as X WHERE x.id IN ( 1,2 ) ORDER BY x.id
DEBUG ast.QueryTranslatorImpl:261 [showHqlAst] (2006-06-21 13:23:19,453) --- HQL AST ---
\-[QUERY] 'query'
    +-[SELECT_FROM] 'SELECT_FROM'
    |  +-[FROM] 'FROM'
    |  |  \-[RANGE] 'RANGE'
    |  |     +-[DOT] '.'
    |  |     |  +-[DOT] '.'
    |  |     |  |  +-[IDENT] 'aeonstore'
    |  |     |  |  \-[IDENT] 'domain'
    |  |     |  \-[IDENT] 'Keyword'
    |  |     \-[ALIAS] 'X'
    |  \-[SELECT] 'SELECT'
    |     \-[IDENT] 'x'
    +-[WHERE] 'WHERE'
    |  \-[IN] 'in'
    |     +-[DOT] '.'
    |     |  +-[IDENT] 'x'
    |     |  \-[IDENT] 'id'
    |     \-[IN_LIST] 'inList'
    |        +-[NUM_INT] '1'
    |        \-[NUM_INT] '2'
    \-[ORDER] 'ORDER'
       \-[DOT] '.'
          +-[IDENT] 'x'
          \-[IDENT] 'id'

DEBUG ast.ErrorCounter:68 [throwQueryException] (2006-06-21 13:23:19,468) throwQueryException() : no errors
DEBUG antlr.HqlSqlBaseWalker:111 [beforeStatement] (2006-06-21 13:23:19,609) select << begin [level=1, statement=select]
DEBUG tree.FromElement:105 [doInitialize] (2006-06-21 13:23:19,656) FromClause{level=1} :  aeonstore.domain.Keyword (X) -> keyword0_
DEBUG ast.HqlSqlWalker:484 [isNonQualifiedPropertyRef] (2006-06-21 13:23:19,656) attempting to resolve property [x] as a non-qualified ref
DEBUG ast.HqlSqlWalker:484 [isNonQualifiedPropertyRef] (2006-06-21 13:23:19,687) attempting to resolve property [x] as a non-qualified ref
ERROR ast.ErrorCounter:33 [reportError] (2006-06-21 13:23:19,734)  Invalid path: 'x.id'
DEBUG ast.ErrorCounter:28 [reportError] (2006-06-21 13:23:19,734)  Invalid path: 'x.id'
Invalid path: 'x.id'
   at org.hibernate.hql.ast.util.LiteralProcessor.lookupConstant(LiteralProcessor.java:111)
   at org.hibernate.hql.ast.tree.DotNode.resolve(DotNode.java:178)
   at org.hibernate.hql.ast.tree.FromReferenceNode.resolve(FromReferenceNode.java:94)
   at org.hibernate.hql.ast.tree.FromReferenceNode.resolve(FromReferenceNode.java:90)
   at org.hibernate.hql.ast.HqlSqlWalker.resolve(HqlSqlWalker.java:737)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.expr(HqlSqlBaseWalker.java:1215)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.exprOrSubquery(HqlSqlBaseWalker.java:4032)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.comparisonExpr(HqlSqlBaseWalker.java:3832)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.logicalExpr(HqlSqlBaseWalker.java:1758)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.whereClause(HqlSqlBaseWalker.java:776)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.query(HqlSqlBaseWalker.java:577)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.selectStatement(HqlSqlBaseWalker.java:281)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.statement(HqlSqlBaseWalker.java:229)
   at org.hibernate.hql.ast.QueryTranslatorImpl.analyze(QueryTranslatorImpl.java:227)
   at org.hibernate.hql.ast.QueryTranslatorImpl.doCompile(QueryTranslatorImpl.java:159)
   at org.hibernate.hql.ast.QueryTranslatorImpl.compile(QueryTranslatorImpl.java:110)
   at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:77)
   at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:56)
   at org.hibernate.engine.query.QueryPlanCache.getHQLQueryPlan(QueryPlanCache.java:71)
   at org.hibernate.impl.AbstractSessionImpl.getHQLQueryPlan(AbstractSessionImpl.java:133)
   at org.hibernate.impl.AbstractSessionImpl.createQuery(AbstractSessionImpl.java:112)
   at org.hibernate.impl.SessionImpl.createQuery(SessionImpl.java:1612)
   at org.hibernate.ejb.AbstractEntityManagerImpl.createQuery(AbstractEntityManagerImpl.java:76)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.springframework.orm.jpa.ExtendedEntityManagerCreator$ExtendedEntityManagerInvocationHandler.invoke(ExtendedEntityManagerCreator.java:210)
   at $Proxy19.createQuery(Unknown Source)
   at aeonstore.jpa.JPADatabase.findIdentifiables(JPADatabase.java:128)
   at aeonstore.service.impl.BasicServiceImpl.findIdentifiables(BasicServiceImpl.java:127)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:266)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:181)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:148)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:100)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:170)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:176)
   at $Proxy18.findIdentifiables(Unknown Source)
   at aeonstore.service.BasicServiceFindTest.testFindKeywords(BasicServiceFindTest.java:111)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at junit.framework.TestCase.runTest(TestCase.java:164)
   at junit.framework.TestCase.runBare(TestCase.java:130)
   at junit.framework.TestResult$1.protect(TestResult.java:106)
   at junit.framework.TestResult.runProtected(TestResult.java:124)
   at junit.framework.TestResult.run(TestResult.java:109)
   at junit.framework.TestCase.run(TestCase.java:120)
   at junit.framework.TestSuite.runTest(TestSuite.java:230)
   at junit.framework.TestSuite.run(TestSuite.java:225)
   at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24)
   at junit.extensions.TestSetup$1.protect(TestSetup.java:21)
   at junit.framework.TestResult.runProtected(TestResult.java:124)
   at junit.extensions.TestSetup.run(TestSetup.java:25)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:325)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.executeInVM(JUnitTask.java:848)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.execute(JUnitTask.java:556)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.execute(JUnitTask.java:532)
   at org.apache.tools.ant.Task.perform(Task.java:341)
   at org.apache.commons.jelly.tags.ant.AntTag.doTag(AntTag.java:185)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.OtherwiseTag.doTag(OtherwiseTag.java:87)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:84)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.IfTag.doTag(IfTag.java:88)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.maven.jelly.tags.werkz.MavenGoalTag.runBodyTag(MavenGoalTag.java:79)
   at org.apache.maven.jelly.tags.werkz.MavenGoalTag$MavenGoalAction.performAction(MavenGoalTag.java:110)
   at com.werken.werkz.Goal.fire(Goal.java:639)
   at com.werken.werkz.Goal.attain(Goal.java:575)
   at org.apache.maven.plugin.PluginManager.attainGoals(PluginManager.java:671)
   at org.apache.maven.MavenSession.attainGoals(MavenSession.java:263)
   at org.apache.maven.cli.App.doMain(App.java:488)
   at org.apache.maven.cli.App.main(App.java:1239)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at com.werken.forehead.Forehead.run(Forehead.java:551)
   at com.werken.forehead.Forehead.main(Forehead.java:581)
ERROR ast.ErrorCounter:33 [reportError] (2006-06-21 13:23:19,750) <AST>: expecting IN_LIST, found '<empty tree>'
DEBUG ast.ErrorCounter:28 [reportError] (2006-06-21 13:23:19,750) <AST>: expecting IN_LIST, found '<empty tree>'
<AST>: expecting IN_LIST, found '<empty tree>'
   at antlr.TreeParser.match(TreeParser.java:68)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.inRhs(HqlSqlBaseWalker.java:4143)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.comparisonExpr(HqlSqlBaseWalker.java:3835)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.logicalExpr(HqlSqlBaseWalker.java:1758)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.whereClause(HqlSqlBaseWalker.java:776)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.query(HqlSqlBaseWalker.java:577)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.selectStatement(HqlSqlBaseWalker.java:281)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.statement(HqlSqlBaseWalker.java:229)
   at org.hibernate.hql.ast.QueryTranslatorImpl.analyze(QueryTranslatorImpl.java:227)
   at org.hibernate.hql.ast.QueryTranslatorImpl.doCompile(QueryTranslatorImpl.java:159)
   at org.hibernate.hql.ast.QueryTranslatorImpl.compile(QueryTranslatorImpl.java:110)
   at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:77)
   at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:56)
   at org.hibernate.engine.query.QueryPlanCache.getHQLQueryPlan(QueryPlanCache.java:71)
   at org.hibernate.impl.AbstractSessionImpl.getHQLQueryPlan(AbstractSessionImpl.java:133)
   at org.hibernate.impl.AbstractSessionImpl.createQuery(AbstractSessionImpl.java:112)
   at org.hibernate.impl.SessionImpl.createQuery(SessionImpl.java:1612)
   at org.hibernate.ejb.AbstractEntityManagerImpl.createQuery(AbstractEntityManagerImpl.java:76)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.springframework.orm.jpa.ExtendedEntityManagerCreator$ExtendedEntityManagerInvocationHandler.invoke(ExtendedEntityManagerCreator.java:210)
   at $Proxy19.createQuery(Unknown Source)
   at aeonstore.jpa.JPADatabase.findIdentifiables(JPADatabase.java:128)
   at aeonstore.service.impl.BasicServiceImpl.findIdentifiables(BasicServiceImpl.java:127)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:266)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:181)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:148)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:100)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:170)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:176)
   at $Proxy18.findIdentifiables(Unknown Source)
   at aeonstore.service.BasicServiceFindTest.testFindKeywords(BasicServiceFindTest.java:111)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at junit.framework.TestCase.runTest(TestCase.java:164)
   at junit.framework.TestCase.runBare(TestCase.java:130)
   at junit.framework.TestResult$1.protect(TestResult.java:106)
   at junit.framework.TestResult.runProtected(TestResult.java:124)
   at junit.framework.TestResult.run(TestResult.java:109)
   at junit.framework.TestCase.run(TestCase.java:120)
   at junit.framework.TestSuite.runTest(TestSuite.java:230)
   at junit.framework.TestSuite.run(TestSuite.java:225)
   at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24)
   at junit.extensions.TestSetup$1.protect(TestSetup.java:21)
   at junit.framework.TestResult.runProtected(TestResult.java:124)
   at junit.extensions.TestSetup.run(TestSetup.java:25)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:325)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.executeInVM(JUnitTask.java:848)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.execute(JUnitTask.java:556)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.execute(JUnitTask.java:532)
   at org.apache.tools.ant.Task.perform(Task.java:341)
   at org.apache.commons.jelly.tags.ant.AntTag.doTag(AntTag.java:185)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.OtherwiseTag.doTag(OtherwiseTag.java:87)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:84)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.IfTag.doTag(IfTag.java:88)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.maven.jelly.tags.werkz.MavenGoalTag.runBodyTag(MavenGoalTag.java:79)
   at org.apache.maven.jelly.tags.werkz.MavenGoalTag$MavenGoalAction.performAction(MavenGoalTag.java:110)
   at com.werken.werkz.Goal.fire(Goal.java:639)
   at com.werken.werkz.Goal.attain(Goal.java:575)
   at org.apache.maven.plugin.PluginManager.attainGoals(PluginManager.java:671)
   at org.apache.maven.MavenSession.attainGoals(MavenSession.java:263)
   at org.apache.maven.cli.App.doMain(App.java:488)
   at org.apache.maven.cli.App.main(App.java:1239)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at com.werken.forehead.Forehead.run(Forehead.java:551)
   at com.werken.forehead.Forehead.main(Forehead.java:581)
ERROR ast.ErrorCounter:33 [reportError] (2006-06-21 13:23:19,750)  left-hand operand of in operator was null
DEBUG ast.ErrorCounter:28 [reportError] (2006-06-21 13:23:19,750)  left-hand operand of in operator was null
left-hand operand of in operator was null
   at org.hibernate.hql.ast.tree.InLogicOperatorNode.initialize(InLogicOperatorNode.java:19)
   at org.hibernate.hql.ast.HqlSqlWalker.prepareLogicOperator(HqlSqlWalker.java:1015)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.comparisonExpr(HqlSqlBaseWalker.java:3984)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.logicalExpr(HqlSqlBaseWalker.java:1758)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.whereClause(HqlSqlBaseWalker.java:776)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.query(HqlSqlBaseWalker.java:577)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.selectStatement(HqlSqlBaseWalker.java:281)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.statement(HqlSqlBaseWalker.java:229)
   at org.hibernate.hql.ast.QueryTranslatorImpl.analyze(QueryTranslatorImpl.java:227)
   at org.hibernate.hql.ast.QueryTranslatorImpl.doCompile(QueryTranslatorImpl.java:159)
   at org.hibernate.hql.ast.QueryTranslatorImpl.compile(QueryTranslatorImpl.java:110)
   at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:77)
   at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:56)
   at org.hibernate.engine.query.QueryPlanCache.getHQLQueryPlan(QueryPlanCache.java:71)
   at org.hibernate.impl.AbstractSessionImpl.getHQLQueryPlan(AbstractSessionImpl.java:133)
   at org.hibernate.impl.AbstractSessionImpl.createQuery(AbstractSessionImpl.java:112)
   at org.hibernate.impl.SessionImpl.createQuery(SessionImpl.java:1612)
   at org.hibernate.ejb.AbstractEntityManagerImpl.createQuery(AbstractEntityManagerImpl.java:76)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.springframework.orm.jpa.ExtendedEntityManagerCreator$ExtendedEntityManagerInvocationHandler.invoke(ExtendedEntityManagerCreator.java:210)
   at $Proxy19.createQuery(Unknown Source)
   at aeonstore.jpa.JPADatabase.findIdentifiables(JPADatabase.java:128)
   at aeonstore.service.impl.BasicServiceImpl.findIdentifiables(BasicServiceImpl.java:127)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:266)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:181)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:148)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:100)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:170)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:176)
   at $Proxy18.findIdentifiables(Unknown Source)
   at aeonstore.service.BasicServiceFindTest.testFindKeywords(BasicServiceFindTest.java:111)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at junit.framework.TestCase.runTest(TestCase.java:164)
   at junit.framework.TestCase.runBare(TestCase.java:130)
   at junit.framework.TestResult$1.protect(TestResult.java:106)
   at junit.framework.TestResult.runProtected(TestResult.java:124)
   at junit.framework.TestResult.run(TestResult.java:109)
   at junit.framework.TestCase.run(TestCase.java:120)
   at junit.framework.TestSuite.runTest(TestSuite.java:230)
   at junit.framework.TestSuite.run(TestSuite.java:225)
   at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24)
   at junit.extensions.TestSetup$1.protect(TestSetup.java:21)
   at junit.framework.TestResult.runProtected(TestResult.java:124)
   at junit.extensions.TestSetup.run(TestSetup.java:25)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:325)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.executeInVM(JUnitTask.java:848)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.execute(JUnitTask.java:556)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.execute(JUnitTask.java:532)
   at org.apache.tools.ant.Task.perform(Task.java:341)
   at org.apache.commons.jelly.tags.ant.AntTag.doTag(AntTag.java:185)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.OtherwiseTag.doTag(OtherwiseTag.java:87)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:84)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.IfTag.doTag(IfTag.java:88)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.maven.jelly.tags.werkz.MavenGoalTag.runBodyTag(MavenGoalTag.java:79)
   at org.apache.maven.jelly.tags.werkz.MavenGoalTag$MavenGoalAction.performAction(MavenGoalTag.java:110)
   at com.werken.werkz.Goal.fire(Goal.java:639)
   at com.werken.werkz.Goal.attain(Goal.java:575)
   at org.apache.maven.plugin.PluginManager.attainGoals(PluginManager.java:671)
   at org.apache.maven.MavenSession.attainGoals(MavenSession.java:263)
   at org.apache.maven.cli.App.doMain(App.java:488)
   at org.apache.maven.cli.App.main(App.java:1239)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at com.werken.forehead.Forehead.run(Forehead.java:551)
   at com.werken.forehead.Forehead.main(Forehead.java:581)
DEBUG ast.HqlSqlWalker:484 [isNonQualifiedPropertyRef] (2006-06-21 13:23:19,765) attempting to resolve property [x] as a non-qualified ref
ERROR ast.ErrorCounter:33 [reportError] (2006-06-21 13:23:19,796)  Invalid path: 'x.id'
DEBUG ast.ErrorCounter:28 [reportError] (2006-06-21 13:23:19,796)  Invalid path: 'x.id'
Invalid path: 'x.id'
   at org.hibernate.hql.ast.util.LiteralProcessor.lookupConstant(LiteralProcessor.java:111)
   at org.hibernate.hql.ast.tree.DotNode.resolve(DotNode.java:178)
   at org.hibernate.hql.ast.tree.FromReferenceNode.resolve(FromReferenceNode.java:94)
   at org.hibernate.hql.ast.tree.FromReferenceNode.resolve(FromReferenceNode.java:90)
   at org.hibernate.hql.ast.HqlSqlWalker.resolve(HqlSqlWalker.java:737)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.expr(HqlSqlBaseWalker.java:1215)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.orderExprs(HqlSqlBaseWalker.java:1543)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.orderClause(HqlSqlBaseWalker.java:1519)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.query(HqlSqlBaseWalker.java:622)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.selectStatement(HqlSqlBaseWalker.java:281)
   at org.hibernate.hql.antlr.HqlSqlBaseWalker.statement(HqlSqlBaseWalker.java:229)
   at org.hibernate.hql.ast.QueryTranslatorImpl.analyze(QueryTranslatorImpl.java:227)
   at org.hibernate.hql.ast.QueryTranslatorImpl.doCompile(QueryTranslatorImpl.java:159)
   at org.hibernate.hql.ast.QueryTranslatorImpl.compile(QueryTranslatorImpl.java:110)
   at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:77)
   at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:56)
   at org.hibernate.engine.query.QueryPlanCache.getHQLQueryPlan(QueryPlanCache.java:71)
   at org.hibernate.impl.AbstractSessionImpl.getHQLQueryPlan(AbstractSessionImpl.java:133)
   at org.hibernate.impl.AbstractSessionImpl.createQuery(AbstractSessionImpl.java:112)
   at org.hibernate.impl.SessionImpl.createQuery(SessionImpl.java:1612)
   at org.hibernate.ejb.AbstractEntityManagerImpl.createQuery(AbstractEntityManagerImpl.java:76)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.springframework.orm.jpa.ExtendedEntityManagerCreator$ExtendedEntityManagerInvocationHandler.invoke(ExtendedEntityManagerCreator.java:210)
   at $Proxy19.createQuery(Unknown Source)
   at aeonstore.jpa.JPADatabase.findIdentifiables(JPADatabase.java:128)
   at aeonstore.service.impl.BasicServiceImpl.findIdentifiables(BasicServiceImpl.java:127)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:266)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:181)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:148)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:100)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:170)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:176)
   at $Proxy18.findIdentifiables(Unknown Source)
   at aeonstore.service.BasicServiceFindTest.testFindKeywords(BasicServiceFindTest.java:111)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at junit.framework.TestCase.runTest(TestCase.java:164)
   at junit.framework.TestCase.runBare(TestCase.java:130)
   at junit.framework.TestResult$1.protect(TestResult.java:106)
   at junit.framework.TestResult.runProtected(TestResult.java:124)
   at junit.framework.TestResult.run(TestResult.java:109)
   at junit.framework.TestCase.run(TestCase.java:120)
   at junit.framework.TestSuite.runTest(TestSuite.java:230)
   at junit.framework.TestSuite.run(TestSuite.java:225)
   at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24)
   at junit.extensions.TestSetup$1.protect(TestSetup.java:21)
   at junit.framework.TestResult.runProtected(TestResult.java:124)
   at junit.extensions.TestSetup.run(TestSetup.java:25)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:325)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.executeInVM(JUnitTask.java:848)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.execute(JUnitTask.java:556)
   at org.apache.tools.ant.taskdefs.optional.junit.JUnitTask.execute(JUnitTask.java:532)
   at org.apache.tools.ant.Task.perform(Task.java:341)
   at org.apache.commons.jelly.tags.ant.AntTag.doTag(AntTag.java:185)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.OtherwiseTag.doTag(OtherwiseTag.java:87)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:84)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:233)
   at org.apache.commons.jelly.tags.core.IfTag.doTag(IfTag.java:88)
   at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:279)
   at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:135)
   at org.apache.maven.jelly.tags.werkz.MavenGoalTag.runBodyTag(MavenGoalTag.java:79)
   at org.apache.maven.jelly.tags.werkz.MavenGoalTag$MavenGoalAction.performAction(MavenGoalTag.java:110)
   at com.werken.werkz.Goal.fire(Goal.java:639)
   at com.werken.werkz.Goal.attain(Goal.java:575)
   at org.apache.maven.plugin.PluginManager.attainGoals(PluginManager.java:671)
   at org.apache.maven.MavenSession.attainGoals(MavenSession.java:263)
   at org.apache.maven.cli.App.doMain(App.java:488)
   at org.apache.maven.cli.App.main(App.java:1239)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at com.werken.forehead.Forehead.run(Forehead.java:551)
   at com.werken.forehead.Forehead.main(Forehead.java:581)
DEBUG antlr.HqlSqlBaseWalker:117 [beforeStatementCompletion] (2006-06-21 13:23:19,796) select : finishing up [level=1, statement=select]
DEBUG ast.HqlSqlWalker:518 [processQuery] (2006-06-21 13:23:19,796) processQuery() :  ( SELECT ( {select clause} x ) ( FromClause{level=1} KEYWORD keyword0_ ) ( WHERE in ) ORDER )
DEBUG transaction.JDBCTransaction:152 [rollback] (2006-06-21 13:23:19,812) rollback


Working query (all lowercase): SELECT x FROM Keyword as x WHERE x.id IN ( 1,2 ) ORDER BY x.id
Code:
DEBUG jdbc.JDBCContext:203 [afterTransactionBegin] (2006-06-21 13:28:50,453) after transaction begin
DEBUG query.QueryPlanCache:69 [getHQLQueryPlan] (2006-06-21 13:28:50,468) unable to locate HQL query plan in cache; generating (SELECT x FROM Keyword as x WHERE x.id IN ( 1,2 ) ORDER BY x.id)
DEBUG ast.QueryTranslatorImpl:245 [parse] (2006-06-21 13:28:50,609) parse() - HQL: SELECT x FROM aeonstore.domain.Keyword as x WHERE x.id IN ( 1,2 ) ORDER BY x.id
DEBUG ast.QueryTranslatorImpl:261 [showHqlAst] (2006-06-21 13:28:50,625) --- HQL AST ---
\-[QUERY] 'query'
    +-[SELECT_FROM] 'SELECT_FROM'
    |  +-[FROM] 'FROM'
    |  |  \-[RANGE] 'RANGE'
    |  |     +-[DOT] '.'
    |  |     |  +-[DOT] '.'
    |  |     |  |  +-[IDENT] 'aeonstore'
    |  |     |  |  \-[IDENT] 'domain'
    |  |     |  \-[IDENT] 'Keyword'
    |  |     \-[ALIAS] 'x'
    |  \-[SELECT] 'SELECT'
    |     \-[IDENT] 'x'
    +-[WHERE] 'WHERE'
    |  \-[IN] 'in'
    |     +-[DOT] '.'
    |     |  +-[IDENT] 'x'
    |     |  \-[IDENT] 'id'
    |     \-[IN_LIST] 'inList'
    |        +-[NUM_INT] '1'
    |        \-[NUM_INT] '2'
    \-[ORDER] 'ORDER'
       \-[DOT] '.'
          +-[IDENT] 'x'
          \-[IDENT] 'id'

DEBUG ast.ErrorCounter:68 [throwQueryException] (2006-06-21 13:28:50,625) throwQueryException() : no errors
DEBUG antlr.HqlSqlBaseWalker:111 [beforeStatement] (2006-06-21 13:28:50,734) select << begin [level=1, statement=select]
DEBUG tree.FromElement:105 [doInitialize] (2006-06-21 13:28:50,781) FromClause{level=1} :  aeonstore.domain.Keyword (x) -> keyword0_
DEBUG tree.FromReferenceNode:51 [setResolved] (2006-06-21 13:28:50,796) Resolved :  x -> keyword0_.KEYWORD_ID
DEBUG tree.FromReferenceNode:51 [setResolved] (2006-06-21 13:28:50,812) Resolved :  x -> keyword0_.KEYWORD_ID
DEBUG tree.DotNode:541 [getDataType] (2006-06-21 13:28:50,812) getDataType() : id -> org.hibernate.type.LongType@645fd
DEBUG tree.FromReferenceNode:51 [setResolved] (2006-06-21 13:28:50,812) Resolved :  x.id -> keyword0_.KEYWORD_ID
DEBUG tree.FromReferenceNode:51 [setResolved] (2006-06-21 13:28:50,812) Resolved :  x -> keyword0_.KEYWORD_ID
DEBUG tree.DotNode:541 [getDataType] (2006-06-21 13:28:50,828) getDataType() : id -> org.hibernate.type.LongType@645fd
DEBUG tree.FromReferenceNode:51 [setResolved] (2006-06-21 13:28:50,828) Resolved :  x.id -> keyword0_.KEYWORD_ID
DEBUG antlr.HqlSqlBaseWalker:117 [beforeStatementCompletion] (2006-06-21 13:28:50,828) select : finishing up [level=1, statement=select]
DEBUG ast.HqlSqlWalker:518 [processQuery] (2006-06-21 13:28:50,828) processQuery() :  ( SELECT ( {select clause} keyword0_.KEYWORD_ID ) ( FromClause{level=1} KEYWORD keyword0_ ) ( WHERE ( in ( keyword0_.KEYWORD_ID keyword0_.KEYWORD_ID id ) ( inList 1 2 ) ) ) ( ORDER ( keyword0_.KEYWORD_ID keyword0_.KEYWORD_ID id ) ) )
DEBUG util.JoinProcessor:129 [addJoinNodes] (2006-06-21 13:28:50,843) Using FROM fragment [KEYWORD keyword0_]
DEBUG antlr.HqlSqlBaseWalker:123 [afterStatementCompletion] (2006-06-21 13:28:50,843) select >> end [level=1, statement=select]
DEBUG ast.QueryTranslatorImpl:231 [analyze] (2006-06-21 13:28:50,859) --- SQL AST ---
\-[SELECT] QueryNode: 'SELECT'  querySpaces (KEYWORD)
    +-[SELECT_CLAUSE] SelectClause: '{select clause}'
    |  +-[ALIAS_REF] IdentNode: 'keyword0_.KEYWORD_ID as KEYWORD1_3_' {alias=x, className=aeonstore.domain.Keyword, tableAlias=keyword0_}
    |  \-[SQL_TOKEN] SqlFragment: 'keyword0_.WORD as WORD3_, keyword0_.KEYWORD_TYPE as KEYWORD3_3_'
    +-[FROM] FromClause: 'FROM' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClassAlias=[x], fromElementByTableAlias=[keyword0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElements=[]}
    |  \-[FROM_FRAGMENT] FromElement: 'KEYWORD keyword0_' FromElement{explicit,not a collection join,not a fetch join,fetch non-lazy properties,classAlias=x,role=null,tableName=KEYWORD,tableAlias=keyword0_,origin=null,colums={,className=aeonstore.domain.Keyword}}
    +-[WHERE] SqlNode: 'WHERE'
    |  \-[IN] InLogicOperatorNode: 'in'
    |     +-[DOT] DotNode: 'keyword0_.KEYWORD_ID' {propertyName=id,dereferenceType=4,propertyPath=id,path=x.id,tableAlias=keyword0_,className=aeonstore.domain.Keyword,classAlias=x}
    |     |  +-[ALIAS_REF] IdentNode: 'keyword0_.KEYWORD_ID' {alias=x, className=aeonstore.domain.Keyword, tableAlias=keyword0_}
    |     |  \-[IDENT] IdentNode: 'id' {originalText=id}
    |     \-[IN_LIST] SqlNode: 'inList'
    |        +-[NUM_INT] LiteralNode: '1'
    |        \-[NUM_INT] LiteralNode: '2'
    \-[ORDER] OrderByClause: 'ORDER'
       \-[DOT] DotNode: 'keyword0_.KEYWORD_ID' {propertyName=id,dereferenceType=4,propertyPath=id,path=x.id,tableAlias=keyword0_,className=aeonstore.domain.Keyword,classAlias=x}
          +-[ALIAS_REF] IdentNode: 'keyword0_.KEYWORD_ID' {alias=x, className=aeonstore.domain.Keyword, tableAlias=keyword0_}
          \-[IDENT] IdentNode: 'id' {originalText=id}

DEBUG ast.ErrorCounter:68 [throwQueryException] (2006-06-21 13:28:50,859) throwQueryException() : no errors
DEBUG ast.QueryTranslatorImpl:215 [generate] (2006-06-21 13:28:50,921) HQL: SELECT x FROM aeonstore.domain.Keyword as x WHERE x.id IN ( 1,2 ) ORDER BY x.id
DEBUG ast.QueryTranslatorImpl:216 [generate] (2006-06-21 13:28:50,921) SQL: select keyword0_.KEYWORD_ID as KEYWORD1_3_, keyword0_.WORD as WORD3_, keyword0_.KEYWORD_TYPE as KEYWORD3_3_ from KEYWORD keyword0_ where keyword0_.KEYWORD_ID in (1 , 2) order by keyword0_.KEYWORD_ID
DEBUG ast.ErrorCounter:68 [throwQueryException] (2006-06-21 13:28:50,921) throwQueryException() : no errors
DEBUG query.HQLQueryPlan:269 [buildParameterMetadata] (2006-06-21 13:28:50,953) HQL param location recognition took 0 mills (SELECT x FROM Keyword as x WHERE x.id IN ( 1,2 ) ORDER BY x.id)
DEBUG query.QueryPlanCache:75 [getHQLQueryPlan] (2006-06-21 13:28:50,968) located HQL query plan in cache (SELECT x FROM Keyword as x WHERE x.id IN ( 1,2 ) ORDER BY x.id)
DEBUG query.HQLQueryPlan:150 [performList] (2006-06-21 13:28:50,968) find: SELECT x FROM Keyword as x WHERE x.id IN ( 1,2 ) ORDER BY x.id
DEBUG engine.QueryParameters:277 [traceParameters] (2006-06-21 13:28:50,984) named parameters: {}
DEBUG jdbc.AbstractBatcher:358 [logOpenPreparedStatement] (2006-06-21 13:28:51,000) about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
DEBUG jdbc.AbstractBatcher:393 [log] (2006-06-21 13:28:51,000) select keyword0_.KEYWORD_ID as KEYWORD1_3_, keyword0_.WORD as WORD3_, keyword0_.KEYWORD_TYPE as KEYWORD3_3_ from KEYWORD keyword0_ where keyword0_.KEYWORD_ID in (1 , 2) order by keyword0_.KEYWORD_ID
DEBUG jdbc.AbstractBatcher:476 [getPreparedStatement] (2006-06-21 13:28:51,000) preparing statement
DEBUG jdbc.AbstractBatcher:374 [logOpenResults] (2006-06-21 13:28:51,046) about to open ResultSet (open ResultSets: 0, globally: 0)
DEBUG loader.Loader:682 [doQuery] (2006-06-21 13:28:51,046) processing result set
DEBUG loader.Loader:687 [doQuery] (2006-06-21 13:28:51,046) result set row: 0
DEBUG type.NullableType:122 [nullSafeGet] (2006-06-21 13:28:51,046) returning '1' as column: KEYWORD1_3_
DEBUG loader.Loader:1164 [getRow] (2006-06-21 13:28:51,046) result row: EntityKey[aeonstore.domain.Keyword#1]
DEBUG loader.Loader:1347 [loadFromResultSet] (2006-06-21 13:28:51,046) Initializing object from ResultSet: [aeonstore.domain.Keyword#1]
DEBUG entity.AbstractEntityPersister:1944 [hydrate] (2006-06-21 13:28:51,062) Hydrating entity: [aeonstore.domain.Keyword#1]
DEBUG type.NullableType:122 [nullSafeGet] (2006-06-21 13:28:51,062) returning 'War' as column: WORD3_
DEBUG type.NullableType:122 [nullSafeGet] (2006-06-21 13:28:51,062) returning '3' as column: KEYWORD3_3_
DEBUG type.NullableType:122 [nullSafeGet] (2006-06-21 13:28:51,062) returning '3' as column: KEYWORD3_3_
DEBUG loader.Loader:687 [doQuery] (2006-06-21 13:28:51,078) result set row: 1
DEBUG type.NullableType:122 [nullSafeGet] (2006-06-21 13:28:51,078) returning '2' as column: KEYWORD1_3_
DEBUG loader.Loader:1164 [getRow] (2006-06-21 13:28:51,078) result row: EntityKey[aeonstore.domain.Keyword#2]
DEBUG loader.Loader:1347 [loadFromResultSet] (2006-06-21 13:28:51,078) Initializing object from ResultSet: [aeonstore.domain.Keyword#2]
DEBUG entity.AbstractEntityPersister:1944 [hydrate] (2006-06-21 13:28:51,078) Hydrating entity: [aeonstore.domain.Keyword#2]
DEBUG type.NullableType:122 [nullSafeGet] (2006-06-21 13:28:51,078) returning 'Animal' as column: WORD3_
DEBUG type.NullableType:122 [nullSafeGet] (2006-06-21 13:28:51,078) returning '3' as column: KEYWORD3_3_
DEBUG type.NullableType:122 [nullSafeGet] (2006-06-21 13:28:51,078) returning '3' as column: KEYWORD3_3_
DEBUG loader.Loader:709 [doQuery] (2006-06-21 13:28:51,078) done processing result set (2 rows)
DEBUG jdbc.AbstractBatcher:381 [logCloseResults] (2006-06-21 13:28:51,078) about to close ResultSet (open ResultSets: 1, globally: 1)
DEBUG jdbc.AbstractBatcher:366 [logClosePreparedStatement] (2006-06-21 13:28:51,078) about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
DEBUG jdbc.AbstractBatcher:525 [closePreparedStatement] (2006-06-21 13:28:51,078) closing statement


Top
 Profile  
 
Display posts from previous:  Sort by  
Forum locked This topic is locked, you cannot edit posts or make further replies.  [ 1 post ] 

All times are UTC - 5 hours [ DST ]


You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum

Search for:
© Copyright 2014, Red Hat Inc. All rights reserved. JBoss and Hibernate are registered trademarks and servicemarks of Red Hat, Inc.