2006-03-14 16:26:19,703 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Opened new session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=[] updates=[] deletions=[] collectionCreations=[] collectionRemovals=[] collectionUpdates=[]])] for Hibernate transaction 2006-03-14 16:26:19,703 DEBUG [org.hibernate.jdbc.JDBCContext] - opening user JDBC connection, application must close it 2006-03-14 16:26:19,703 DEBUG [org.springframework.jdbc.datasource.DriverManagerDataSource] - Creating new JDBC connection to [jdbc:mysql://localhost:3306/aiweb?useUnicode=true&characterEncoding=UTF-8] 2006-03-14 16:26:19,734 DEBUG [org.hibernate.transaction.JDBCTransaction] - begin 2006-03-14 16:26:19,734 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection 2006-03-14 16:26:19,734 DEBUG [org.springframework.jdbc.datasource.DriverManagerDataSource] - Creating new JDBC connection to [jdbc:mysql://localhost:3306/aiweb?useUnicode=true&characterEncoding=UTF-8] 2006-03-14 16:26:19,781 DEBUG [org.hibernate.transaction.JDBCTransaction] - current autocommit status: true 2006-03-14 16:26:19,781 DEBUG [org.hibernate.transaction.JDBCTransaction] - disabling autocommit 2006-03-14 16:26:19,781 DEBUG [org.hibernate.jdbc.JDBCContext] - after transaction begin 2006-03-14 16:26:19,781 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Exposing Hibernate transaction as JDBC transaction [com.mysql.jdbc.Connection@1b06041] 2006-03-14 16:26:19,781 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Bound value [org.springframework.jdbc.datasource.ConnectionHolder@7f5580] for key [org.springframework.jdbc.datasource.DriverManagerDataSource@1f82982] to thread [main] 2006-03-14 16:26:19,781 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Bound value [org.springframework.orm.hibernate3.SessionHolder@84cc09] for key [org.hibernate.impl.SessionFactoryImpl@1c6572b] to thread [main] 2006-03-14 16:26:19,781 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Initializing transaction synchronization 2006-03-14 16:26:19,781 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@84cc09] for key [org.hibernate.impl.SessionFactoryImpl@1c6572b] bound to thread [main] 2006-03-14 16:26:19,781 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@84cc09] for key [org.hibernate.impl.SessionFactoryImpl@1c6572b] bound to thread [main] 2006-03-14 16:26:19,921 DEBUG [org.hibernate.engine.VersionValue] - version unsaved-value strategy UNDEFINED 2006-03-14 16:26:19,921 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] - transient instance of: org.feynixs.aiweb.model.User 2006-03-14 16:26:19,921 DEBUG [org.hibernate.event.def.DefaultSaveOrUpdateEventListener] - saving transient instance 2006-03-14 16:26:19,921 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] - generated identifier: cr8@gmail.com, using strategy: org.hibernate.id.Assigned 2006-03-14 16:26:19,921 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] - saving [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:19,937 DEBUG [org.hibernate.engine.Versioning] - Seeding: 0 2006-03-14 16:26:19,953 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@84cc09] for key [org.hibernate.impl.SessionFactoryImpl@1c6572b] bound to thread [main] 2006-03-14 16:26:19,953 DEBUG [org.springframework.transaction.interceptor.TransactionInterceptor] - Invoking commit for transaction on org.feynixs.aiweb.service.UserManager.saveUser 2006-03-14 16:26:19,953 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Triggering beforeCommit synchronization 2006-03-14 16:26:19,953 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Triggering beforeCompletion synchronization 2006-03-14 16:26:19,953 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Initiating transaction commit 2006-03-14 16:26:19,953 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Committing Hibernate transaction on session [SessionImpl(PersistenceContext[entityKeys=[EntityKey[org.feynixs.aiweb.model.Usercr8@gmail.com]],collectionKeys=[]];ActionQueue[insertions=[EntityInsertAction[org.feynixs.aiweb.model.Usercr8@gmail.com]] updates=[] deletions=[] collectionCreations=[] collectionRemovals=[] collectionUpdates=[]])] 2006-03-14 16:26:19,953 DEBUG [org.hibernate.transaction.JDBCTransaction] - commit 2006-03-14 16:26:19,953 DEBUG [org.hibernate.impl.SessionImpl] - automatically flushing session 2006-03-14 16:26:19,953 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - flushing session 2006-03-14 16:26:19,953 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - processing flush-time cascades 2006-03-14 16:26:19,953 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - dirty checking collections 2006-03-14 16:26:19,953 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - Flushing entities and processing referenced collections 2006-03-14 16:26:19,953 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - Processing unreferenced collections 2006-03-14 16:26:19,953 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - Scheduling collection removes/(re)creates/updates 2006-03-14 16:26:19,953 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - Flushed: 1 insertions, 0 updates, 0 deletions to 1 objects 2006-03-14 16:26:19,953 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections 2006-03-14 16:26:19,968 DEBUG [org.hibernate.pretty.Printer] - listing entities: 2006-03-14 16:26:19,968 DEBUG [org.hibernate.pretty.Printer] - org.feynixs.aiweb.model.User{password=test, country=中国, applicationId=null, province=广东, role=user, email=cr8@gmail.com, city=广州, firstName=刘, lastName=荣, version=0} 2006-03-14 16:26:19,968 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - executing flush 2006-03-14 16:26:19,968 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] - Inserting entity: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:19,968 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] - Version: 0 2006-03-14 16:26:19,968 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0) 2006-03-14 16:26:19,968 DEBUG [org.hibernate.SQL] - insert into user (version, first_name, last_name, city, province, country, password, applicaiton_id, role, email) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2006-03-14 16:26:19,968 DEBUG [org.hibernate.jdbc.AbstractBatcher] - preparing statement 2006-03-14 16:26:20,000 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] - Dehydrating entity: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.IntegerType] - binding '0' to parameter: 1 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.StringType] - binding '刘' to parameter: 2 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.StringType] - binding '荣' to parameter: 3 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.StringType] - binding '广州' to parameter: 4 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.StringType] - binding '广东' to parameter: 5 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.StringType] - binding '中国' to parameter: 6 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.StringType] - binding 'test' to parameter: 7 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.LongType] - binding null to parameter: 8 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.StringType] - binding 'user' to parameter: 9 2006-03-14 16:26:20,000 DEBUG [org.hibernate.type.StringType] - binding 'cr8@gmail.com' to parameter: 10 2006-03-14 16:26:20,000 DEBUG [org.hibernate.jdbc.AbstractBatcher] - Adding to batch 2006-03-14 16:26:20,000 DEBUG [org.hibernate.jdbc.AbstractBatcher] - Executing batch size: 1 2006-03-14 16:26:20,015 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1) 2006-03-14 16:26:20,015 DEBUG [org.hibernate.jdbc.AbstractBatcher] - closing statement 2006-03-14 16:26:20,015 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] - post flush 2006-03-14 16:26:20,015 DEBUG [org.hibernate.jdbc.JDBCContext] - before transaction completion 2006-03-14 16:26:20,015 DEBUG [org.hibernate.impl.SessionImpl] - before transaction completion 2006-03-14 16:26:20,093 DEBUG [org.hibernate.transaction.JDBCTransaction] - re-enabling autocommit 2006-03-14 16:26:20,093 DEBUG [org.hibernate.transaction.JDBCTransaction] - committed JDBC Connection 2006-03-14 16:26:20,093 DEBUG [org.hibernate.jdbc.JDBCContext] - after transaction completion 2006-03-14 16:26:20,093 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection 2006-03-14 16:26:20,093 DEBUG [org.hibernate.jdbc.ConnectionManager] - closing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)] 2006-03-14 16:26:20,093 DEBUG [org.hibernate.impl.SessionImpl] - after transaction completion 2006-03-14 16:26:20,093 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Triggering afterCompletion synchronization 2006-03-14 16:26:20,093 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Clearing transaction synchronization 2006-03-14 16:26:20,109 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Removed value [org.springframework.orm.hibernate3.SessionHolder@84cc09] for key [org.hibernate.impl.SessionFactoryImpl@1c6572b] from thread [main] 2006-03-14 16:26:20,109 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Removed value [org.springframework.jdbc.datasource.ConnectionHolder@7f5580] for key [org.springframework.jdbc.datasource.DriverManagerDataSource@1f82982] from thread [main] 2006-03-14 16:26:20,109 DEBUG [org.hibernate.jdbc.JDBCContext] - opening user JDBC connection, application must close it 2006-03-14 16:26:20,109 DEBUG [org.springframework.jdbc.datasource.DriverManagerDataSource] - Creating new JDBC connection to [jdbc:mysql://localhost:3306/aiweb?useUnicode=true&characterEncoding=UTF-8] 2006-03-14 16:26:20,125 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Closing Hibernate session [SessionImpl(PersistenceContext[entityKeys=[EntityKey[org.feynixs.aiweb.model.Usercr8@gmail.com]],collectionKeys=[]];ActionQueue[insertions=[] updates=[] deletions=[] collectionCreations=[] collectionRemovals=[] collectionUpdates=[]])] after transaction 2006-03-14 16:26:20,125 DEBUG [org.springframework.orm.hibernate3.SessionFactoryUtils] - Closing Hibernate session 2006-03-14 16:26:20,125 DEBUG [org.hibernate.impl.SessionImpl] - closing session 2006-03-14 16:26:20,125 DEBUG [org.hibernate.jdbc.ConnectionManager] - connection already null in cleanup : no action 2006-03-14 16:26:20,125 DEBUG [org.springframework.transaction.interceptor.TransactionInterceptor] - Getting transaction for org.feynixs.aiweb.service.UserManager.getUser 2006-03-14 16:26:20,125 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Using transaction object [org.springframework.orm.hibernate3.HibernateTransactionManager$HibernateTransactionObject@15575e0] 2006-03-14 16:26:20,125 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Creating new transaction 2006-03-14 16:26:20,125 DEBUG [org.springframework.orm.hibernate3.SessionFactoryUtils] - Opening Hibernate session 2006-03-14 16:26:20,125 DEBUG [org.hibernate.impl.SessionImpl] - opened session at timestamp: 4678962299392000 2006-03-14 16:26:20,125 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Opened new session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=[] updates=[] deletions=[] collectionCreations=[] collectionRemovals=[] collectionUpdates=[]])] for Hibernate transaction 2006-03-14 16:26:20,125 DEBUG [org.hibernate.jdbc.JDBCContext] - opening user JDBC connection, application must close it 2006-03-14 16:26:20,125 DEBUG [org.springframework.jdbc.datasource.DriverManagerDataSource] - Creating new JDBC connection to [jdbc:mysql://localhost:3306/aiweb?useUnicode=true&characterEncoding=UTF-8] 2006-03-14 16:26:20,125 DEBUG [org.springframework.jdbc.datasource.DataSourceUtils] - Setting JDBC connection [com.mysql.jdbc.Connection@81b1fb] read-only 2006-03-14 16:26:20,125 DEBUG [org.hibernate.impl.SessionImpl] - setting flush mode to: NEVER 2006-03-14 16:26:20,125 DEBUG [org.hibernate.transaction.JDBCTransaction] - begin 2006-03-14 16:26:20,125 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection 2006-03-14 16:26:20,125 DEBUG [org.springframework.jdbc.datasource.DriverManagerDataSource] - Creating new JDBC connection to [jdbc:mysql://localhost:3306/aiweb?useUnicode=true&characterEncoding=UTF-8] 2006-03-14 16:26:20,156 DEBUG [org.hibernate.transaction.JDBCTransaction] - current autocommit status: true 2006-03-14 16:26:20,156 DEBUG [org.hibernate.transaction.JDBCTransaction] - disabling autocommit 2006-03-14 16:26:20,156 DEBUG [org.hibernate.jdbc.JDBCContext] - after transaction begin 2006-03-14 16:26:20,156 DEBUG [org.springframework.orm.hibernate3.HibernateTransactionManager] - Exposing Hibernate transaction as JDBC transaction [com.mysql.jdbc.Connection@81b1fb] 2006-03-14 16:26:20,156 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Bound value [org.springframework.jdbc.datasource.ConnectionHolder@1e1dadb] for key [org.springframework.jdbc.datasource.DriverManagerDataSource@1f82982] to thread [main] 2006-03-14 16:26:20,156 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Bound value [org.springframework.orm.hibernate3.SessionHolder@e79839] for key [org.hibernate.impl.SessionFactoryImpl@1c6572b] to thread [main] 2006-03-14 16:26:20,156 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Initializing transaction synchronization 2006-03-14 16:26:20,156 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@e79839] for key [org.hibernate.impl.SessionFactoryImpl@1c6572b] bound to thread [main] 2006-03-14 16:26:20,156 DEBUG [org.springframework.transaction.support.TransactionSynchronizationManager] - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@e79839] for key [org.hibernate.impl.SessionFactoryImpl@1c6572b] bound to thread [main] 2006-03-14 16:26:20,156 DEBUG [org.hibernate.event.def.DefaultLoadEventListener] - loading entity: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,156 DEBUG [org.hibernate.event.def.DefaultLoadEventListener] - attempting to resolve: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,156 DEBUG [org.hibernate.event.def.DefaultLoadEventListener] - object not resolved in any cache: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,156 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] - Fetching entity: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,156 DEBUG [org.hibernate.loader.Loader] - loading entity: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,156 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0) 2006-03-14 16:26:20,156 DEBUG [org.hibernate.SQL] - select user0_.email as email0_0_, user0_.version as version0_0_, user0_.first_name as first3_0_0_, user0_.last_name as last4_0_0_, user0_.city as city0_0_, user0_.province as province0_0_, user0_.country as country0_0_, user0_.password as password0_0_, user0_.applicaiton_id as applicai9_0_0_, user0_.role as role0_0_ from user user0_ where user0_.email=? 2006-03-14 16:26:20,156 DEBUG [org.hibernate.jdbc.AbstractBatcher] - preparing statement 2006-03-14 16:26:20,203 DEBUG [org.hibernate.type.StringType] - binding 'cr8@gmail.com' to parameter: 1 2006-03-14 16:26:20,218 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open ResultSet (open ResultSets: 0, globally: 0) 2006-03-14 16:26:20,218 DEBUG [org.hibernate.loader.Loader] - processing result set 2006-03-14 16:26:20,218 DEBUG [org.hibernate.loader.Loader] - result set row: 0 2006-03-14 16:26:20,218 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,218 DEBUG [org.hibernate.loader.Loader] - Initializing object from ResultSet: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,218 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] - Hydrating entity: [org.feynixs.aiweb.model.Usercr8@gmail.com] 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.IntegerType] - returning '0' as column: version0_0_ 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.StringType] - returning '?' as column: first3_0_0_ 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.StringType] - returning '?' as column: last4_0_0_ 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.StringType] - returning '??' as column: city0_0_ 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.StringType] - returning '??' as column: province0_0_ 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.StringType] - returning '??' as column: country0_0_ 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.StringType] - returning 'test' as column: password0_0_ 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.LongType] - returning null as column: applicai9_0_0_ 2006-03-14 16:26:20,218 DEBUG [org.hibernate.type.StringType] - returning 'user' as column: role0_0_
|