Hibernate Community • View topic - Hibernate RANDOMLY gives back old or new results on select

View unanswered posts | View active topics

Board index » Hibernate & Java Persistence » Hibernate Users

All times are UTC - 5 hours [ DST ]

Hibernate RANDOMLY gives back old or new results on select

Page 1 of 1

[ 9 posts ]

Previous topic | Next topic

Author

Message

cagara

Post subject: Hibernate RANDOMLY gives back old or new results on select

Posted: Sat Jul 01, 2006 12:28 pm

Newbie

Joined: Fri Nov 04, 2005 5:40 pm
Posts: 16

This is what i did:

session.Update(Object)

alright, now i do 1000 identical selects sometimes it gives me back the new updated result, but SOMETIMES it gives me back the old ones!

What is going on there...how come hibernate givbes me randomely back the old or the new results????

Other funny thing, if i do 3 changes, it gives me back randomely one of the 3 variations!

Is this a problem with the cache? Can i turn this sh*t off? Or is the problem a BUG or am I just totally stupid???

btw: this is my updating function

Code:

   private static final void updateHibernate(Object updatingObject,
         SaveOrUpdateTypes updateType) {
      /* Set-Up Hibernate Session/Transaction */
      Session session = getSession();
      Transaction tx = session.beginTransaction();

      switch (updateType) {

      case SAVEONLY:
         session.save(updatingObject);
         break;
      case UPDATEONLY:
         session.update(updatingObject);
         break;
      case SAVEORUPDATE:
         session.saveOrUpdate(updatingObject);
         break;

      }

      /* Zu guter letzt, ein Commitment */
      tx.commit();
   }

the query is just a simple one.

ps: im using hibernate 3

Top

david

Post subject:

Posted: Sat Jul 01, 2006 8:09 pm

Hibernate Team

Joined: Tue Aug 26, 2003 7:19 pm
Posts: 2364
Location: Brisbane, Australia

It will be your code. Having said that you have not showed the query or how you performing your looping test or even session management. There just not enough information here to help you.

Top

cagara

Post subject:

Posted: Sun Jul 02, 2006 4:26 am

Newbie

Joined: Fri Nov 04, 2005 5:40 pm
Posts: 16

Hello David, thank you very much for your response.

Here are more informations:

This is how I get the Session:

Code:

public class HibernateSessionFactory {
 private static String CONFIG_FILE_LOCATION = "/hibernate.cfg.xml";
    /** Holds a single instance of Session */
   private static final ThreadLocal threadLocal = new ThreadLocal();

    /** The single instance of hibernate configuration */
    private static final Configuration cfg = new Configuration();

    /** The single instance of hibernate SessionFactory */
    private static org.hibernate.SessionFactory sessionFactory;

    public static Session currentSession() throws HibernateException {
        Session session = (Session) threadLocal.get();

      if (session == null || !session.isOpen()) {
         if (sessionFactory == null) {
            try {
               cfg.configure(CONFIG_FILE_LOCATION);
               sessionFactory = cfg.buildSessionFactory();
            } catch (Exception e) {
               System.err
                     .println("%%%% Error Creating SessionFactory %%%%");
               e.printStackTrace();
            }
         }
         session = (sessionFactory != null) ? sessionFactory.openSession()
               : null;
         threadLocal.set(session);
      }

        return session;
    }
    public static void closeSession() throws HibernateException {
        Session session = (Session) threadLocal.get();
        threadLocal.set(null);

        if (session != null) {
            session.close();
        }
    }
    private HibernateSessionFactory() {
    }
}

This is how I update an Object:

Code:

private static final void updateHibernate(Object updatingObject,
         SaveOrUpdateTypes updateType) {
      /* Set-Up Hibernate Session/Transaction */
      Session session = getSession();
      Transaction tx = session.beginTransaction();

      switch (updateType) {

      case SAVEONLY:
         session.save(updatingObject);
         break;
      case UPDATEONLY:
         session.update(updatingObject);
         break;
      case SAVEORUPDATE:
         session.saveOrUpdate(updatingObject);
         break;

      }

      /* Zu guter letzt, ein Commitment */
      tx.commit();
   }

and this is how I query the Database, basically its a MULTIFUNCTIONAL FUNCTION, basically what it does is get a Session (getSession() calls the HibernateSessionFactory you can see above), adds some Parameters, and returns the Query.:

Code:

private static final Object queryHibernate(String hql,
         ResultTypes resultType, Map<String, Object> parameters) {
      /* Set-Up Hibernate Session/Transaction */
      Session session = getSession();
      Transaction tx = session.beginTransaction();

      /* Now we are retreiving, what this Function is meant to */
      Query query = session.createQuery(hql);

      if (parameters != null) {
         /* Wir setzen die Parameter ein, die man uns Uebergeben hat */
         Iterator parametersIter = parameters.entrySet().iterator();

         while (parametersIter.hasNext()) {
            Entry entry = (Entry) parametersIter.next();
            if (entry.getKey().equals("setFirstResult")
                  || entry.getKey().equals("setMaxResults")) {
               if (entry.getKey().equals("setFirstResult")){
                  query.setFirstResult(((Integer) entry.getValue())
                        .intValue());
               logger.info("Limiting Resultset: lowerindex=" + entry.getValue().toString());
               }
               if (entry.getKey().equals("setMaxResults")){
                  query.setFetchSize(((Integer) entry.getValue())
                        .intValue());
                  logger.info("Limiting Resultset: size=" + entry.getValue().toString());
               }
            } else {
               logger.info("Setting Parameter " + (String)entry.getKey() + " to " + entry.getValue() + " (type: " + entry.getValue().getClass().toString() + ")");
               query.setParameter((String) entry.getKey(), entry
                     .getValue());
            }
         }
      }
      /* So jetzt gibt es verschiedene Rueckgabe Methoden */
      Object returning = null; /* Wir wissen nicht was zurueck kommt */

      /* Logging */
      logger.info("New Query: " + query.getQueryString() + " - RSType: " + resultType);
      
      
      switch (resultType) {
      case UNIQUE_RESULT:
         returning = query.uniqueResult(); /* Single Object */
         logger.info("Queried for UNIQUE_RESULT: returned " + returning.toString());
         break;

      case LIST:
         returning = query.list(); /* Viele Results, List<Irgendeintyp> */
         logger.info("Queried for LIST: returned " + returning.toString());
         break;

      case ITERATOR:
         returning = query.iterate(); /* Iterator kommt zurueck */
         logger.info("Queried for ITERATOR: returned " + returning.toString());
         break;

      case ROWCOUNT:
         returning = (Integer) query.iterate().next();
         logger.info("Queried for ROWCOUNT: returned " + returning.toString());
         break;

      }

      /* Zu guter letzt, ein Commitment */
      tx.commit();
      
      /* Rueckgabe erfolgt jetzt */
      return returning;
   }

Maybe it's important to say that the Session is always open and is stored in threadLocal (correct me if i'm wrong).

I hope you can help me, because i really don't know what to do!

Thank you very much in advance!

BY THE WAY, here a debug printout, the coloured lines are my debug printout what comes back from hibernate. Im querying the User "STATE" field withouth changing it inbetween. ote: I changed it 10 minutes ago from Nevada to Hawaii. Here we go.

Quote:

(...)
10:33:01,265 INFO [DriverManagerConnectionProvider] connection properties: {user=root, password=jcw8dpm7wc}
10:33:02,109 INFO [SettingsFactory] RDBMS: MySQL, version: 5.0.22-community-nt
10:33:02,109 INFO [SettingsFactory] JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-3.1.12 ( $Date: 2005-11-17 15:53:48 +0100 (Thu, 17 Nov 2005) $, $Revision$ )
10:33:02,171 INFO [Dialect] Using dialect: org.hibernate.dialect.MySQLInnoDBDialect
10:33:02,187 INFO [TransactionFactoryFactory] Using default transaction strategy (direct JDBC transactions)
10:33:02,187 INFO [TransactionManagerLookupFactory] No TransactionManagerLookup configured (in JTA environment, use of read-write or transactional second-level cache is not recommended)
10:33:02,187 INFO [SettingsFactory] Automatic flush during beforeCompletion(): disabled
10:33:02,187 INFO [SettingsFactory] Automatic session close at end of transaction: disabled
10:33:02,187 INFO [SettingsFactory] JDBC batch size: 15
10:33:02,187 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled
10:33:02,187 INFO [SettingsFactory] Scrollable result sets: enabled
10:33:02,203 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): enabled
10:33:02,203 INFO [SettingsFactory] Connection release mode: null
10:33:02,203 INFO [SettingsFactory] Maximum outer join fetch depth: 2
10:33:02,203 INFO [SettingsFactory] Default batch fetch size: 1
10:33:02,203 INFO [SettingsFactory] Generate SQL with comments: disabled
10:33:02,203 INFO [SettingsFactory] Order SQL updates by primary key: disabled
10:33:02,203 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
10:33:02,203 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
10:33:02,203 INFO [SettingsFactory] Query language substitutions: {}
10:33:02,203 INFO [SettingsFactory] Second-level cache: enabled
10:33:02,203 INFO [SettingsFactory] Query cache: disabled
10:33:02,203 INFO [SettingsFactory] Cache provider: org.hibernate.cache.NoCacheProvider
10:33:02,218 INFO [SettingsFactory] Optimize cache for minimal puts: disabled
10:33:02,218 INFO [SettingsFactory] Structured second-level cache entries: disabled
10:33:02,234 INFO [SettingsFactory] Echoing all SQL to stdout
10:33:02,234 INFO [SettingsFactory] Statistics: disabled
10:33:02,234 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
10:33:02,234 INFO [SettingsFactory] Default entity-mode: pojo
10:33:02,500 INFO [SessionFactoryImpl] building session factory
10:33:05,640 INFO [SessionFactoryObjectFactory] Not binding factory to JNDI, no JNDI name configured
10:33:05,640 INFO [SessionFactoryImpl] Checking 0 named queries
10:33:05,750 INFO [root] Setting Parameter password to admina (type: class java.lang.String)
10:33:05,750 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:05,750 INFO [root] New Query: select count(*) from Users where username = :username and password = :password - RSType: ROWCOUNT
10:33:06,281 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.users users0_ where users0_.username=? and users0_.password=?
10:33:06,390 INFO [root] Queried for ROWCOUNT: returned 1
10:33:06,390 INFO [root] checkUser() - Testvalue = 1 => Rueckgabe muss sein = true
10:33:09,515 INFO [root] EXPIRED REQUEST: (lastAction=1151829189515) inactive=0, possible=300
10:33:09,515 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:09,515 INFO [root] EXPIRED REQUEST: (lastAction=1151829189515) inactive=0, possible=300
10:33:09,531 INFO [root] Requesting Session
10:33:09,531 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:09,531 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:09,546 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:09,687 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@19bb4bb
10:33:09,687 INFO [root] Requesting Session
10:33:09,687 INFO [root] New Query: from Countries - RSType: LIST
10:33:09,750 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:10,234 INFO [root] Requesting Session
10:33:10,234 INFO [root] New Query: from Currencies - RSType: LIST
10:33:10,390 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:10,453 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:10,453 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> NV
10:33:10,468 INFO [STDOUT] Hibernate: select addressfor0_.id as id0_, addressfor0_.address_format as address2_13_0_, addressfor0_.address_summary as address3_13_0_ from gameservice.address_formats addressfor0_ where addressfor0_.id=?
10:33:10,562 INFO [root] Requesting Session
10:33:10,562 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:10,562 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:10,687 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:11,406 INFO [root] Requesting Session
10:33:11,406 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:11,406 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:11,531 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:11,546 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@19bb4bb
10:33:11,562 INFO [root] Requesting Session
10:33:11,562 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:11,562 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:11,687 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:11,734 INFO [root] Queried for ROWCOUNT: returned 0
10:33:14,578 INFO [root] EXPIRED REQUEST: (lastAction=1151829194578) inactive=0, possible=300
10:33:14,578 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:14,578 INFO [root] EXPIRED REQUEST: (lastAction=1151829194578) inactive=0, possible=300
10:33:14,578 INFO [root] Requesting Session
10:33:14,578 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:14,578 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:14,703 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:14,703 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@19bb4bb
10:33:14,703 INFO [root] Requesting Session
10:33:14,703 INFO [root] New Query: from Countries - RSType: LIST
10:33:14,781 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:14,843 INFO [root] Requesting Session
10:33:14,843 INFO [root] New Query: from Currencies - RSType: LIST
10:33:14,890 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:14,890 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:14,890 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> NV
10:33:14,890 INFO [root] Requesting Session
10:33:14,890 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:14,890 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:14,937 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:14,984 INFO [root] Requesting Session
10:33:14,984 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:14,984 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:15,000 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:15,015 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@19bb4bb
10:33:15,015 INFO [root] Requesting Session
10:33:15,015 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:15,015 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:15,046 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:15,046 INFO [root] Queried for ROWCOUNT: returned 0
10:33:17,859 INFO [root] EXPIRED REQUEST: (lastAction=1151829197859) inactive=0, possible=300
10:33:17,859 INFO [root] Requesting Session
10:33:17,859 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:17,859 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:17,906 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:17,921 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@760f48
10:33:17,921 INFO [root] Requesting Session
10:33:17,921 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:17,921 INFO [root] New Query: from Countries c where c.iso2kuerzel = :iso - RSType: UNIQUE_RESULT
10:33:17,937 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_ where countries0_.iso2kuerzel=?
10:33:17,953 INFO [root] Queried for UNIQUE_RESULT: returned US
10:33:17,953 INFO [STDOUT] Hibernate: select addressfor0_.id as id0_, addressfor0_.address_format as address2_13_0_, addressfor0_.address_summary as address3_13_0_ from gameservice.address_formats addressfor0_ where addressfor0_.id=?
10:33:17,953 INFO [root] Requesting Session
10:33:17,953 INFO [root] New Query: from Countries - RSType: LIST
10:33:17,968 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:18,390 INFO [root] Requesting Session
10:33:18,390 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:18,390 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:18,484 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:18,562 INFO [root] Requesting Session
10:33:18,562 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:18,562 INFO [root] New Query: from Countries c where c.iso2kuerzel = :iso - RSType: UNIQUE_RESULT
10:33:18,625 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_ where countries0_.iso2kuerzel=?
10:33:18,625 INFO [root] Queried for UNIQUE_RESULT: returned US
10:33:18,671 INFO [root] Requesting Session
[size=16]10:33:18,781 INFO [STDOUT] Hibernate: update gameservice.users set countries_fk=?, currencies_fk=?, languages_fk=?, username=?, password=?, vorname=?, nachname=?, strasse=?, state=?, plz=?, ort=?, email=?, avatar=?, winner=?, balance=? where id=? (HERE THE STATE IS SET TO HI (HAWAII)[/size]
10:33:18,859 INFO [root] Requesting Session
10:33:18,859 INFO [root] New Query: from Countries - RSType: LIST
10:33:18,953 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:19,046 INFO [root] Requesting Session
10:33:19,046 INFO [root] New Query: from Currencies - RSType: LIST
10:33:19,109 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:19,125 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:19,125 INFO [root] Requesting Session
10:33:19,125 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:19,125 INFO [root] New Query: from Countries c where c.iso2kuerzel = :iso - RSType: UNIQUE_RESULT
10:33:19,187 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_ where countries0_.iso2kuerzel=?
10:33:19,187 INFO [root] Queried for UNIQUE_RESULT: returned US
10:33:19,187 INFO [root] Requesting Session
10:33:19,187 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:19,187 INFO [root] New Query: from Countries c where c.iso2kuerzel = :iso - RSType: UNIQUE_RESULT
10:33:19,250 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_ where countries0_.iso2kuerzel=?
10:33:19,250 INFO [root] Queried for UNIQUE_RESULT: returned US
10:33:19,250 INFO [root] Requesting Session
10:33:19,250 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:19,250 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:19,328 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:19,421 INFO [root] Requesting Session
10:33:19,421 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:19,421 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:19,468 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:19,484 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@760f48
10:33:19,484 INFO [root] Requesting Session
10:33:19,484 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:19,484 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:19,531 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:19,531 INFO [root] Queried for ROWCOUNT: returned 0
10:33:19,734 INFO [root] EXPIRED REQUEST: (lastAction=1151829199734) inactive=0, possible=300
10:33:19,734 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:19,734 INFO [root] EXPIRED REQUEST: (lastAction=1151829199734) inactive=0, possible=300
10:33:19,734 INFO [root] Requesting Session
10:33:19,734 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:19,734 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:19,781 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:19,781 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@760f48
10:33:19,781 INFO [root] Requesting Session
10:33:19,781 INFO [root] New Query: from Countries - RSType: LIST
10:33:19,828 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:19,890 INFO [root] Requesting Session
10:33:19,890 INFO [root] New Query: from Currencies - RSType: LIST
10:33:19,921 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:19,921 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:19,921 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> HI
10:33:19,921 INFO [root] Requesting Session
10:33:19,921 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:19,921 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:19,953 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:19,968 INFO [root] Requesting Session
10:33:19,968 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:19,968 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:20,000 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:20,000 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@760f48
10:33:20,000 INFO [root] Requesting Session
10:33:20,000 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:20,000 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:20,046 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:20,046 INFO [root] Queried for ROWCOUNT: returned 0
10:33:21,484 INFO [root] EXPIRED REQUEST: (lastAction=1151829201484) inactive=0, possible=300
10:33:21,484 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:21,484 INFO [root] EXPIRED REQUEST: (lastAction=1151829201484) inactive=0, possible=300
10:33:21,484 INFO [root] Requesting Session
10:33:21,484 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:21,484 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:21,515 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:21,531 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@a0e9d7
10:33:21,531 INFO [root] Requesting Session
10:33:21,531 INFO [root] New Query: from Countries - RSType: LIST
10:33:21,531 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:21,906 INFO [root] Requesting Session
10:33:21,906 INFO [root] New Query: from Currencies - RSType: LIST
10:33:21,953 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:21,953 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:21,953 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> HI
10:33:21,953 INFO [STDOUT] Hibernate: select addressfor0_.id as id0_, addressfor0_.address_format as address2_13_0_, addressfor0_.address_summary as address3_13_0_ from gameservice.address_formats addressfor0_ where addressfor0_.id=?
10:33:21,968 INFO [root] Requesting Session
10:33:21,968 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:21,968 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:22,015 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:22,078 INFO [root] Requesting Session
10:33:22,093 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:22,093 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:22,140 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:22,140 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@a0e9d7
10:33:22,140 INFO [root] Requesting Session
10:33:22,156 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:22,156 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:22,203 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:22,203 INFO [root] Queried for ROWCOUNT: returned 0
10:33:22,343 INFO [root] EXPIRED REQUEST: (lastAction=1151829202343) inactive=0, possible=300
10:33:22,343 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:22,343 INFO [root] EXPIRED REQUEST: (lastAction=1151829202343) inactive=0, possible=300
10:33:22,343 INFO [root] Requesting Session
10:33:22,343 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:22,343 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:22,406 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:22,406 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@a0e9d7
10:33:22,406 INFO [root] Requesting Session
10:33:22,406 INFO [root] New Query: from Countries - RSType: LIST
10:33:22,453 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:22,515 INFO [root] Requesting Session
10:33:22,515 INFO [root] New Query: from Currencies - RSType: LIST
10:33:22,562 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:22,578 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:22,578 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> HI
10:33:22,578 INFO [root] Requesting Session
10:33:22,578 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:22,578 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:22,625 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?

10:33:22,640 INFO [root] Requesting Session
10:33:22,640 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:22,640 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:22,687 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:22,687 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@a0e9d7
10:33:22,687 INFO [root] Requesting Session
10:33:22,687 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:22,687 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:22,750 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:22,750 INFO [root] Queried for ROWCOUNT: returned 0
10:33:23,796 INFO [root] EXPIRED REQUEST: (lastAction=1151829203796) inactive=0, possible=300
10:33:23,796 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:23,796 INFO [root] EXPIRED REQUEST: (lastAction=1151829203796) inactive=0, possible=300
10:33:23,796 INFO [root] Requesting Session
10:33:23,796 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:23,796 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:23,875 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:23,890 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@760f48
10:33:23,890 INFO [root] Requesting Session
10:33:23,890 INFO [root] New Query: from Countries - RSType: LIST
10:33:23,968 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_

10:33:24,031 INFO [root] Requesting Session
10:33:24,031 INFO [root] New Query: from Currencies - RSType: LIST
10:33:24,093 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:24,109 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:24,109 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> HI
10:33:24,109 INFO [root] Requesting Session
10:33:24,109 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:24,109 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:24,156 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:24,234 INFO [root] Requesting Session
10:33:24,234 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:24,234 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:24,296 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:24,312 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@760f48
10:33:24,312 INFO [root] Requesting Session
10:33:24,312 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:24,312 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:24,359 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:24,359 INFO [root] Queried for ROWCOUNT: returned 0
10:33:24,500 INFO [root] EXPIRED REQUEST: (lastAction=1151829204500) inactive=0, possible=300
10:33:24,500 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:24,500 INFO [root] EXPIRED REQUEST: (lastAction=1151829204500) inactive=0, possible=300
10:33:24,500 INFO [root] Requesting Session
10:33:24,500 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:24,500 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:24,531 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:24,546 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@760f48
10:33:24,546 INFO [root] Requesting Session
10:33:24,546 INFO [root] New Query: from Countries - RSType: LIST
10:33:24,609 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:24,656 INFO [root] Requesting Session
10:33:24,656 INFO [root] New Query: from Currencies - RSType: LIST
10:33:24,687 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:24,687 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:24,687 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> HI
10:33:24,687 INFO [root] Requesting Session
10:33:24,687 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:24,687 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:24,718 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:24,734 INFO [root] Requesting Session
10:33:24,734 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:24,734 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:24,765 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:24,765 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@760f48
10:33:24,765 INFO [root] Requesting Session
10:33:24,765 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:24,765 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:24,796 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:24,796 INFO [root] Queried for ROWCOUNT: returned 0
10:33:25,312 INFO [root] EXPIRED REQUEST: (lastAction=1151829205296) inactive=0, possible=300
10:33:25,312 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:25,312 INFO [root] EXPIRED REQUEST: (lastAction=1151829205312) inactive=0, possible=300
10:33:25,312 INFO [root] Requesting Session
10:33:25,312 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:25,312 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:25,343 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:25,359 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@a0e9d7
10:33:25,359 INFO [root] Requesting Session
10:33:25,359 INFO [root] New Query: from Countries - RSType: LIST
10:33:25,437 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:25,500 INFO [root] Requesting Session
10:33:25,500 INFO [root] New Query: from Currencies - RSType: LIST
10:33:25,562 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:25,562 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:25,562 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> HI[/size]
10:33:25,562 INFO [root] Requesting Session
10:33:25,562 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:25,562 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:25,640 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:25,656 INFO [root] Queried for LIST: returned [AL, AK, AS, AZ, AR, AF, AA, AC, AE, AM, AP, CA, CO, CT, DE, DC, FM, FL, GA, GU, HI, ID, IL, IN, IA, KS, KY, LA, ME, MH, MD, MA, MI, MN, MS, MO, MT, NE, NV, NH, NJ, NM, NY, NC, ND, MP, OH, OK, OR, PW, PA, PR, RI, SC, SD, TN, TX, UT, VT, VI, VA, WA, WV, WI, WY]
10:33:25,656 INFO [root] Requesting Session
10:33:25,656 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:25,656 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:25,734 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:25,734 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@a0e9d7
10:33:25,734 INFO [root] Requesting Session
10:33:25,734 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:25,734 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:25,796 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:25,796 INFO [root] Queried for ROWCOUNT: returned 0
10:33:25,906 INFO [root] EXPIRED REQUEST: (lastAction=1151829205906) inactive=0, possible=300
10:33:25,921 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:25,921 INFO [root] EXPIRED REQUEST: (lastAction=1151829205921) inactive=0, possible=300
10:33:25,921 INFO [root] Requesting Session
10:33:25,921 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:25,921 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:25,968 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:25,984 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@a0e9d7
10:33:25,984 INFO [root] Requesting Session
10:33:25,984 INFO [root] New Query: from Countries - RSType: LIST
10:33:26,031 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:26,078 INFO [root] not intresting, GN, GW, GY, HT, HM, HN, HK,
10:33:26,078 INFO [root] Requesting Session
10:33:26,078 INFO [root] New Query: from Currencies - RSType: LIST
10:33:26,109 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:26,109 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:26,109 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> HI[/size]
10:33:26,109 INFO [root] Requesting Session
10:33:26,109 INFO [root] Setting Parameter iso to US (type: class java.lang.String)
10:33:26,109 INFO [root] New Query: select c.regionses from Countries c where c.iso2kuerzel = :iso - RSType: LIST
10:33:26,140 INFO [STDOUT] Hibernate: select regionses1_.id as id, regionses1_.countries_fk as countries2_3_, regionses1_.regionkuerzel as regionku3_3_, regionses1_.beschreibung as beschrei4_3_ from gameservice.countries countries0_ inner join gameservice.regions regionses1_ on countries0_.id=regionses1_.countries_fk where countries0_.iso2kuerzel=?
10:33:26,156 INFO [root] Requesting Session
10:33:26,156 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:26,156 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:26,187 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:26,187 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@a0e9d7
10:33:26,187 INFO [root] Requesting Session
10:33:26,187 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:26,187 INFO [root] New Query: select count(*) from Messages m where m.usersBySUsersFk.username = :username and m.read=0 - RSType: ROWCOUNT
10:33:26,234 INFO [STDOUT] Hibernate: select count(*) as col_0_0_ from gameservice.messages messages0_, gameservice.users users1_ where messages0_.s_users_fk=users1_.id and users1_.username=? and messages0_.read=0
10:33:26,234 INFO [root] Queried for ROWCOUNT: returned 0
10:33:26,625 INFO [root] EXPIRED REQUEST: (lastAction=1151829206625) inactive=0, possible=300
10:33:26,625 INFO [root] DatenAction - loggedn=true, Expired=false
10:33:26,625 INFO [root] EXPIRED REQUEST: (lastAction=1151829206625) inactive=0, possible=300
10:33:26,625 INFO [root] Requesting Session
10:33:26,625 INFO [root] Setting Parameter username to cagara (type: class java.lang.String)
10:33:26,625 INFO [root] New Query: from Users where username = :username - RSType: UNIQUE_RESULT
10:33:26,656 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:26,656 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@19bb4bb
10:33:26,656 INFO [root] Requesting Session
10:33:26,656 INFO [root] New Query: from Countries - RSType: LIST
10:33:26,687 INFO [STDOUT] Hibernate: select countries0_.id as id, countries0_.address_formats_fk as address2_10_, countries0_.iso3kuerzel as iso3_10_, countries0_.iso2kuerzel as iso4_10_, countries0_.beschreibung as beschrei5_10_ from gameservice.countries countries0_
10:33:26,765 INFO [root] not intresting,
10:33:26,765 INFO [root] Requesting Session
10:33:26,765 INFO [root] New Query: from Currencies - RSType: LIST
10:33:26,828 INFO [STDOUT] Hibernate: select currencies0_.id as id, currencies0_.title as title0_, currencies0_.currencyFormatLocale as currency3_0_, currencies0_.value as value0_, currencies0_.last_updated as last5_0_ from gameservice.currencies currencies0_
10:33:26,843 INFO [root] Queried for LIST: returned [en_US, de_DE, en_GB]
10:33:26,843 INFO [root] $$$$$$$$$$$$$$$$$$$$ -> NV[/size] WTF NEVADA?????? LOOK ABOVE IT HAS BEEN CHANGED TO HAWAII AND IT WAS WORINKG, WHY DOES IT GIVE BACK NEVADA

Top

cagara

Post subject:

Posted: Sun Jul 02, 2006 4:53 am

Newbie

Joined: Fri Nov 04, 2005 5:40 pm
Posts: 16

I just saw that the request what gives back an OLD Object

Quote:

10:33:26,656 INFO [STDOUT] Hibernate: select users0_.id as id, users0_.countries_fk as countries2_4_, users0_.currencies_fk as currencies3_4_, users0_.languages_fk as languages4_4_, users0_.username as username4_, users0_.password as password4_, users0_.vorname as vorname4_, users0_.nachname as nachname4_, users0_.strasse as strasse4_, users0_.state as state4_, users0_.plz as plz4_, users0_.ort as ort4_, users0_.email as email4_, users0_.avatar as avatar4_, users0_.winner as winner4_, users0_.balance as balance4_ from gameservice.users users0_ where users0_.username=?
10:33:26,656 INFO [root] Queried for UNIQUE_RESULT: returned de.gameservice.library.Users@19bb4bb

...actually returns an old reference. The reference 19bb4bb is the reference to a previously fetched Resultset BEFORE the change, scroll up the long log, you will find 19bb4bb on the very first request.

So its a Problem with Hibernate ?????

Top

Henning Malzahn

Post subject:

Posted: Sun Jul 02, 2006 6:51 am

Beginner

Joined: Fri Jun 30, 2006 6:54 am
Posts: 20
Location: Germany

Hello cagara,

is it possible that you use the built in connetion pool?

I had a similar problem and it went away after switching to the
c3p0 connection pool.

see:
http://forum.hibernate.org/viewtopic.php?t=961471

I had:

Code:

<!-- JDBC connection pool (use the built-in) -->
<!--  <property name="connection.pool_size">2</property> -->

and changed it to in my hibernate.cfg.xml:

Code:

<!-- c3p0 connection Pool settings -->     
<property name="hibernate.c3p0.min_size">4</property>
<property name="hibernate.c3p0.max_size">50</property>
<property name="hibernate.c3p0.acquire_increment">2</property>
<property name="hibernate.c3p0.validate">true</property>

hth

Henning Malzahn

Top

david

Post subject:

Posted: Sun Jul 02, 2006 9:22 pm

Hibernate Team

Joined: Tue Aug 26, 2003 7:19 pm
Posts: 2364
Location: Brisbane, Australia

It appears to me that you are never ever closing the session after your transaction is complete. This could be leaving the session cache in an inconsistent state (more care is required). Close your session after each unit of work where a unit of work reqpresent the length of the transaction (at least to start with). Read more about transactions and sessions etc on the wiki.

Top

Henning Malzahn

Post subject:

Posted: Mon Jul 03, 2006 1:45 am

Beginner

Joined: Fri Jun 30, 2006 6:54 am
Posts: 20
Location: Germany

Hello david,

but in my case I can definitively reproduce the behaviour of returning outdated data when switching back to the built in or the dbcp connection pool.

And as you can see in my post referenced above I do close my sessions after every unit of work.

I even tried a session.clear() before closing it but it only works with the c3p0 connection pool. But because I'am also very new to Hibernate (and I can't believe that there is something wrong with the dbcp connection pool) I would greatly appreciate some more hints for correctly using sessions - but what is more to do than clear it and close it?

Henning Malzahn

Top

david

Post subject:

Posted: Mon Jul 03, 2006 9:20 pm

Hibernate Team

Joined: Tue Aug 26, 2003 7:19 pm
Posts: 2364
Location: Brisbane, Australia

You are not using your utility class closeSession() method which not only closes the hibernate session but it clears the Treadlocal. If you don't clear your thread local it will return the old session. For the moment, your goal will be to get a fresh (new) session for each transaction.

Top

Henning Malzahn

Post subject:

Posted: Tue Jul 04, 2006 4:05 pm

Beginner

Joined: Fri Jun 30, 2006 6:54 am
Posts: 20
Location: Germany

Hello David,

thank you for the tipp. I changed all of my code to use the HibernateUtil class
provided in CaveatEmptor example - but I'am still retreiving outdated data
when making concurrent changes and when I use dbcp or the built in connection pool.
It only works with c3p0.

I put a lot of debug statements into my HibernateUtil class telling me that
the thread in question is definitely receiving a new session and I
even verified that the changes made by the second instance are commited properly.

Any furhter ideas?

Thanks in advance.

Henning Malzahn

Top

Page 1 of 1

[ 9 posts ]

Board index » Hibernate & Java Persistence » Hibernate Users

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