2015-05-08 09:32:53.903 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.internal.ast.QueryTranslatorImpl : parse() - HQL: select count(c) from pl.comic.domain.model.Comic c where c.updated is not null and (:categories_0_, :categories_1_) MEMBER OF c.categories
2015-05-08 09:32:53.906 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.internal.ast.QueryTranslatorImpl : --- HQL AST ---
\-[QUERY] Node: 'query'
+-[SELECT_FROM] Node: 'SELECT_FROM'
| +-[FROM] Node: 'from'
| | \-[RANGE] Node: 'RANGE'
| | +-[DOT] Node: '.'
| | | +-[DOT] Node: '.'
| | | | +-[DOT] Node: '.'
| | | | | +-[DOT] Node: '.'
| | | | | | +-[IDENT] Node: 'pl'
| | | | | | \-[IDENT] Node: 'comic'
| | | | | \-[IDENT] Node: 'domain'
| | | | \-[IDENT] Node: 'model'
| | | \-[IDENT] Node: 'Comic'
| | \-[ALIAS] Node: 'c'
| \-[SELECT] Node: 'select'
| \-[COUNT] Node: 'count'
| \-[IDENT] Node: 'c'
\-[WHERE] Node: 'where'
\-[AND] Node: 'and'
+-[IS_NOT_NULL] Node: 'is not null'
| \-[DOT] Node: '.'
| +-[IDENT] Node: 'c'
| \-[IDENT] Node: 'updated'
\-[IN] Node: 'in'
+-[VECTOR_EXPR] Node: '{vector}'
| +-[COLON] Node: ':'
| | \-[IDENT] Node: 'categories_0_'
| \-[COLON] Node: ':'
| \-[IDENT] Node: 'categories_1_'
\-[IN_LIST] Node: 'inList'
\-[ELEMENTS] Node: 'elements'
\-[DOT] Node: '.'
+-[IDENT] Node: 'c'
\-[IDENT] Node: 'categories'
2015-05-08 09:32:53.906 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.ErrorCounter : throwQueryException() : no errors
2015-05-08 09:32:53.906 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.antlr.HqlSqlBaseWalker : select << begin [level=1, statement=select]
2015-05-08 09:32:53.906 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.tree.FromElement : FromClause{level=1} : pl.comic.domain.model.Comic (c) -> comic0_
2015-05-08 09:32:53.906 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.i.ast.tree.FromReferenceNode : Resolved : c -> comic0_.id
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.i.ast.tree.FromReferenceNode : Resolved : c -> comic0_.id
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.tree.DotNode : getDataType() : updated -> org.hibernate.type.DateType@151a5428
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.i.ast.tree.FromReferenceNode : Resolved : c.updated -> comic0_.updated
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.i.ast.tree.FromReferenceNode : Resolved : c -> comic0_.id
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.tree.DotNode : getDataType() : categories -> org.hibernate.type.SetType(pl.comic.domain.model.Comic.categories)
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.tree.FromElement : FromClause{level=1} : null (<no alias>) -> categories1_
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.tree.FromClause : addCollectionJoinFromElementByPath() : c.categories -> comic_categories
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.tree.DotNode : dereferenceCollection() : Created new FROM element for c.categories : comic_categories categories1_
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.tree.MethodNode : Creating elements for c.categories[].elements
2015-05-08 09:32:53.907 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.internal.ast.tree.FromElementType : toColumns(categories1_,elements) : subquery = select categories1_.category from comic_categories categories1_ where comic0_.id=categories1_.comic_id
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.antlr.HqlSqlBaseWalker : select : finishing up [level=1, statement=select]
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.HqlSqlWalker : processQuery() : ( SELECT ( {select clause} ( count comic0_.id ) ) ( FromClause{level=1} ) ( where ( and ( is not null ( comic0_.updated comic0_.id updated ) ) ( in ( {vector} ? ? ) ( inList ( select categories1_.category from comic_categories categories1_ where comic0_.id=categories1_.comic_id ( . comic0_.id categories ) ) ) ) ) ) )
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.util.JoinProcessor : Using FROM fragment [comic comic0_]
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.antlr.HqlSqlBaseWalker : select >> end [level=1, statement=select]
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.internal.ast.QueryTranslatorImpl : --- SQL AST ---
\-[SELECT] QueryNode: 'SELECT' querySpaces (comic_categories,comic)
+-[SELECT_CLAUSE] SelectClause: '{select clause}'
| +-[COUNT] CountNode: 'count'
| | \-[ALIAS_REF] IdentNode: 'comic0_.id' {alias=c, className=pl.comic.domain.model.Comic, tableAlias=comic0_}
| \-[SELECT_COLUMNS] SqlNode: ' as col_0_0_'
+-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=2, fromElementByClassAlias=[c], fromElementByTableAlias=[categories1_, comic0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[c.categories], impliedElements=[]}
| +-[FROM_FRAGMENT] FromElement: 'comic comic0_' FromElement{explicit,collection join,not a fetch join,fetch non-lazy properties,classAlias=c,role=null,tableName=comic,tableAlias=comic0_,origin=null,columns={,className=pl.comic.domain.model.Comic}}
| \-[FROM_FRAGMENT] ImpliedFromElement: '' ImpliedFromElement{implied,collection join,not a fetch join,fetch non-lazy properties,classAlias=null,role=pl.comic.domain.model.Comic.categories,tableName={none},tableAlias=categories1_,origin=comic comic0_,columns={,className=null}}
\-[WHERE] SqlNode: 'where'
\-[AND] SqlNode: 'and'
+-[IS_NOT_NULL] IsNotNullLogicOperatorNode: 'is not null'
| \-[DOT] DotNode: 'comic0_.updated' {propertyName=updated,dereferenceType=PRIMITIVE,getPropertyPath=updated,path=c.updated,tableAlias=comic0_,className=pl.comic.domain.model.Comic,classAlias=c}
| +-[ALIAS_REF] IdentNode: 'comic0_.id' {alias=c, className=pl.comic.domain.model.Comic, tableAlias=comic0_}
| \-[IDENT] IdentNode: 'updated' {originalText=updated}
\-[IN] InLogicOperatorNode: 'in'
+-[VECTOR_EXPR] SqlNode: '{vector}'
| +-[NAMED_PARAM] ParameterNode: '?' {name=categories_0_, expectedType=null}
| \-[NAMED_PARAM] ParameterNode: '?' {name=categories_1_, expectedType=null}
\-[IN_LIST] SqlNode: 'inList'
\-[SQL_TOKEN] CollectionFunction: 'select categories1_.category from comic_categories categories1_ where comic0_.id=categories1_.comic_id' {method=elements,selectColumns=[select categories1_.category from comic_categories categories1_ where comic0_.id=categories1_.comic_id],fromElement=categories1_}
\-[DOT] DotNode: '.' {propertyName=categories,dereferenceType=COLLECTION,getPropertyPath=categories,path=c.categories,tableAlias=categories1_,className=null,classAlias=null}
+-[ALIAS_REF] IdentNode: 'comic0_.id' {alias=c, className=pl.comic.domain.model.Comic, tableAlias=comic0_}
\-[IDENT] IdentNode: 'categories' {originalText=categories}
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.ErrorCounter : throwQueryException() : no errors
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.internal.ast.QueryTranslatorImpl : HQL: select count(c) from pl.comic.domain.model.Comic c where c.updated is not null and (:categories_0_, :categories_1_) MEMBER OF c.categories
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.h.internal.ast.QueryTranslatorImpl : SQL: select count(comic0_.id) as col_0_0_ from comic comic0_ where (comic0_.updated is not null) and ((? , ?) in (select categories1_.category from comic_categories categories1_ where comic0_.id=categories1_.comic_id))
2015-05-08 09:32:53.908 DEBUG 3755 --- [nio-8080-exec-1] o.h.hql.internal.ast.ErrorCounter : throwQueryException() : no errors
2015-05-08 09:32:53.914 DEBUG 3755 --- [nio-8080-exec-1] org.hibernate.SQL : select count(comic0_.id) as col_0_0_ from comic comic0_ where (comic0_.updated is not null) and ((? , ?) in (select categories1_.category from comic_categories categories1_ where comic0_.id=categories1_.comic_id))
Hibernate: select count(comic0_.id) as col_0_0_ from comic comic0_ where (comic0_.updated is not null) and ((? , ?) in (select categories1_.category from comic_categories categories1_ where comic0_.id=categories1_.comic_id))
2015-05-08 09:32:53.915 DEBUG 3755 --- [nio-8080-exec-1] o.h.e.j.internal.LogicalConnectionImpl : Obtaining JDBC connection
2015-05-08 09:32:53.915 DEBUG 3755 --- [nio-8080-exec-1] o.h.e.j.internal.LogicalConnectionImpl : Obtained JDBC connection
2015-05-08 09:32:53.930 DEBUG 3755 --- [nio-8080-exec-1] o.h.engine.jdbc.spi.SqlExceptionHelper : could not extract ResultSet [n/a]
java.sql.SQLException: Operand should contain 2 column(s)