-->
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.  [ 5 posts ] 
Author Message
 Post subject: Hibernate Spring JPA org.hibernate.type - parameter logging
PostPosted: Thu Feb 08, 2007 7:17 am 
Newbie

Joined: Thu Feb 08, 2007 6:17 am
Posts: 2
I am using Hibernate with Spring and JPA. My problem is that log4j does not log the query parameters. Here is my log4j.xml:

Code:
<?xml version="1.0" encoding="UTF-8" ?>
<!DOCTYPE log4j:configuration SYSTEM "log4j.dtd">

<log4j:configuration debug="true" xmlns:log4j="http://jakarta.apache.org/log4j/">
 
  <appender name="STDOUT" class="org.apache.log4j.ConsoleAppender">
    <param name="threshold" value="DEBUG"/>
    <layout class="org.apache.log4j.PatternLayout">
      <param name="ConversionPattern" value="%d %p [%c] - %m%n"/>
    </layout>
  </appender>
 
  <!-- spring -->
  <logger name="org.springframework">
    <level value="info"/>
  </logger>

  <!-- hibernate -->
  <!--
  <logger name="org.hibernate">
    <level value="info"/>
  </logger>
  -->
 
  <!-- log SQL statements (same as show_sql=true) -->
  <logger name="org.hibernate.SQL">
    <level value="debug"/>
  </logger>
 
  <!-- log HQL parse trees -->
  <logger name="org.hibernate.hql">
     <level value="debug"/>
  </logger>
 
  <!-- log JDBC resource acquisition -->
  <logger name="org.hibernate.jdbc">
     <level value="debug"/>
  </logger>
 
  <!-- log cache activity -->
  <logger name="org.hibernate.cache">
     <level value="debug"/>
  </logger>
 
  <!-- log JDBC bind parameters -->
  <logger name="org.hibernate.type">
    <level value="debug"/>
  </logger>
 
  <!-- log ddl statements -->
  <logger name="org.hibernate.tool.hbm2ddl">
    <level value="debug"/>
  </logger>
 
  <!-- log transaction activity -->
  <logger name="org.hibernate.transaction">
     <level value="debug"/>
  </logger>
 
  <logger name="org.apache">
     <level value="warn"/>
  </logger>
   
  <!--
    Alle Logmeldungen werden an den Appender STDOUT geschickt.
    Es gibt ein zusaetzliches Threshold im Appender STDOUT
  -->
  <root>
    <appender-ref ref="STDOUT"/>
  </root>
 
</log4j:configuration>


I think org.hibernate.type should log the parameters - but they are missing. Here a sample log output:

Code:
[...]
2007-02-08 11:14:03,964 DEBUG [org.hibernate.transaction.JDBCTransaction] - begin
2007-02-08 11:14:03,964 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection
2007-02-08 11:14:03,964 DEBUG [org.hibernate.transaction.JDBCTransaction] - current autocommit status: true
2007-02-08 11:14:03,964 DEBUG [org.hibernate.transaction.JDBCTransaction] - disabling autocommit
2007-02-08 11:14:03,980 INFO [myblog.tests.jpa.UserJPATest] - Began transaction (1): transaction manager [org.springframework.orm.jpa.JpaTransactionManager@bd09e8]; default rollback = true
2007-02-08 11:14:04,042 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] - executing identity-insert immediately
2007-02-08 11:14:04,042 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-02-08 11:14:04,042 DEBUG [org.hibernate.SQL] - insert into User (id, name) values (null, ?)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.SQL] - call identity()
2007-02-08 11:14:04,058 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] - Natively generated identity: 1
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] - executing identity-insert immediately
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.SQL] - insert into Email (id, value, index) values (null, ?, ?)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.SQL] - call identity()
2007-02-08 11:14:04,058 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] - Natively generated identity: 1
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] - executing identity-insert immediately
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.SQL] - insert into Email (id, value, index) values (null, ?, ?)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-02-08 11:14:04,058 DEBUG [org.hibernate.SQL] - call identity()
2007-02-08 11:14:04,058 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] - Natively generated identity: 2
2007-02-08 11:14:04,058 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-02-08 11:14:04,074 DEBUG [org.hibernate.transaction.JDBCTransaction] - rollback
2007-02-08 11:14:04,074 DEBUG [org.hibernate.transaction.JDBCTransaction] - re-enabling autocommit
2007-02-08 11:14:04,074 DEBUG [org.hibernate.transaction.JDBCTransaction] - rolled back JDBC Connection
2007-02-08 11:14:04,074 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection
2007-02-08 11:14:04,074 DEBUG [org.hibernate.jdbc.ConnectionManager] - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
2007-02-08 11:14:04,074 INFO [myblog.tests.jpa.UserJPATest] - Rolled back transaction after test execution


Top
 Profile  
 
 Post subject:
PostPosted: Fri Feb 09, 2007 3:39 pm 
Hibernate Team
Hibernate Team

Joined: Sun Sep 14, 2003 3:54 am
Posts: 7256
Location: Paris, France
your log4j file is probably not taken into account

_________________
Emmanuel


Top
 Profile  
 
 Post subject:
PostPosted: Sat Feb 10, 2007 5:50 pm 
Newbie

Joined: Thu Feb 08, 2007 6:17 am
Posts: 2
emmanuel wrote:
your log4j file is probably not taken into account

I think my log4j file will be used. Here is my log4j output:
Code:
log4j: Threshold ="null".
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.springframework] additivity to [true].
log4j: Level value for org.springframework is  [info].
log4j: org.springframework level set to INFO
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.hibernate.SQL] additivity to [true].
log4j: Level value for org.hibernate.SQL is  [debug].
log4j: org.hibernate.SQL level set to DEBUG
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.hibernate.hql] additivity to [true].
log4j: Level value for org.hibernate.hql is  [debug].
log4j: org.hibernate.hql level set to DEBUG
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.hibernate.jdbc] additivity to [true].
log4j: Level value for org.hibernate.jdbc is  [debug].
log4j: org.hibernate.jdbc level set to DEBUG
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.hibernate.cache] additivity to [true].
log4j: Level value for org.hibernate.cache is  [debug].
log4j: org.hibernate.cache level set to DEBUG
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.hibernate.type] additivity to [true].
log4j: Level value for org.hibernate.type is  [debug].
log4j: org.hibernate.type level set to DEBUG
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.hibernate.tool.hbm2ddl] additivity to [true].
log4j: Level value for org.hibernate.tool.hbm2ddl is  [debug].
log4j: org.hibernate.tool.hbm2ddl level set to DEBUG
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.hibernate.transaction] additivity to [true].
log4j: Level value for org.hibernate.transaction is  [debug].
log4j: org.hibernate.transaction level set to DEBUG
log4j: Retreiving an instance of org.apache.log4j.Logger.
log4j: Setting [org.apache] additivity to [true].
log4j: Level value for org.apache is  [warn].
log4j: org.apache level set to WARN
log4j: Class name: [org.apache.log4j.ConsoleAppender]
log4j: Setting property [threshold] to [DEBUG].
log4j: Parsing layout of class: "org.apache.log4j.PatternLayout"
log4j: Setting property [conversionPattern] to [%d %p [%c] - %m%n].
log4j: Adding appender named [STDOUT] to category [root].


Top
 Profile  
 
 Post subject:
PostPosted: Tue Feb 13, 2007 12:08 pm 
Newbie

Joined: Mon Feb 12, 2007 3:42 pm
Posts: 1
Hi,


try with

Code:
    <category name="org.hibernate.type">
        <priority value="TRACE" class="org.jboss.logging.XLevel"/>
    </category>

    <category name="org.hibernate.SQL">
        <priority value="TRACE" class="org.jboss.logging.XLevel"/>
    </category>


and no threshold on the STDOUT appender.


Top
 Profile  
 
 Post subject:
PostPosted: Thu Feb 15, 2007 6:33 pm 
Hibernate Team
Hibernate Team

Joined: Sun Sep 14, 2003 3:54 am
Posts: 7256
Location: Paris, France
year TRACE should make it

_________________
Emmanuel


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

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.