I've got a bit of a problem with (what appears to be) a recursive query executing in Hibernate. First off, the two objects interacting are "Business" and "Discount". Business has a one-to-many bi-directional association with Discount. Here is the mapping for Business:
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 2.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd">
<hibernate-mapping>
<class name="com.sa.go.bto.Business" table="BUSINESS">
<id name="id" column="BUSINESS_ID" type="java.lang.Long" unsaved-value="null">
<generator class="sequence">
<param name="sequence">BUSINESS_ID_SEQ</param>
</generator>
</id>
<property name="name"
column="BUSINESS_NAME"
type="java.lang.String" />
<property name="nationalFlag"
column="NATIONAL_FLAG"
type="yes_no" />
<property name="jumpPageFlag"
column="PJP_FLAG"
type="yes_no" />
<set name="discounts"
inverse="true"
lazy="true">
<key column="BUSINESS_ID" />
<one-to-many
class="com.sa.go.bto.Discount" />
</set>
</class>
<!-- Returns all the businesses matching the given name in the database. -->
<!-- By default, the returned list is ordered by name. -->
<query name="com.sa.go.bto.Business.findByName"><![CDATA[
from com.sa.go.bto.Business as business
where upper(business.name) like upper(:name)
order by business.name
]]></query>
</hibernate-mapping>
And the mapping file for the Discount object:
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 2.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd">
<hibernate-mapping>
<class name="com.sa.go.bto.Discount" table="DISCOUNT">
<id name="id" column="DISCOUNT_ID" type="java.lang.Long" unsaved-value="null">
<generator class="sequence">
<param name="sequence">DISCOUNT_ID_SEQ</param>
</generator>
</id>
<property name="shortText"
column="SHORT_TEXT"
type="java.lang.String" />
<many-to-one
name="business"
class="com.sa.go.bto.Business"
column="BUSINESS_ID" />
</class>
</hibernate-mapping>
Upon *just* loading a Business object, everything is fine. I verified the Set is in fact the hibernate set that is used for lazy loads. Now, when I attempt to access an item (or size()) of the set, I end up getting this: (this is the entire debug log from a short session -- the recursive queries are at the bottom):
Aug 28, 2003 10:59:31 AM org.apache.commons.modeler.Registry loadRegistry
INFO: Loading registry information
Aug 28, 2003 10:59:31 AM org.apache.commons.modeler.Registry getRegistry
INFO: Creating new Registry instance
Aug 28, 2003 10:59:31 AM org.apache.commons.modeler.Registry getServer
INFO: Creating MBeanServer
Aug 28, 2003 10:59:32 AM org.apache.coyote.http11.Http11Protocol init
INFO: Initializing Coyote HTTP/1.1 on port 80
Starting service Tomcat-HTTP
Apache Tomcat/4.1.27
Aug 28, 2003 10:59:34 AM org.apache.struts.util.PropertyMessageResources <init>
INFO: Initializing, config='org.apache.struts.util.LocalStrings', returnNull=true
Aug 28, 2003 10:59:34 AM org.apache.struts.util.PropertyMessageResources <init>
INFO: Initializing, config='org.apache.struts.action.ActionResources', returnNull=true
Aug 28, 2003 10:59:35 AM org.apache.struts.util.PropertyMessageResources <init>
INFO: Initializing, config='org.apache.webapp.admin.ApplicationResources', returnNull=true
WebappClassLoader: validateJarFile(C:\Java\IDE\Eclipse\3.0-M2\workspace\go3\tomcat\.\.\..\site\docroot\WEB-INF\lib\servlet.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
10:59:40,374 INFO PropertyMessageResources:127 - Initializing, config='org.apache.struts.util.LocalStrings', returnNull=true
10:59:40,384 INFO PropertyMessageResources:127 - Initializing, config='org.apache.struts.action.ActionResources', returnNull=true
10:59:41,055 INFO Environment:403 - Hibernate 2.0.3
10:59:41,065 INFO Environment:432 - hibernate.properties not found
10:59:41,075 INFO Environment:452 - using CGLIB reflection optimizer
10:59:41,075 INFO Environment:462 - JVM proxy support: true
10:59:41,085 INFO Configuration:703 - Configuration resource: /hibernate.cfg.xml
10:59:41,265 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath under net/sf/hibernate/
10:59:41,265 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath
10:59:41,366 DEBUG Configuration:689 - dialect=net.sf.hibernate.dialect.OracleDialect
10:59:41,366 DEBUG Configuration:689 - show_sql=true
10:59:41,366 DEBUG Configuration:689 - use_outer_join=true
10:59:41,366 DEBUG Configuration:689 - transaction.factory_class=net.sf.hibernate.transaction.JDBCTransactionFactory
10:59:41,376 DEBUG Configuration:689 - connection.datasource=java:comp/env/stad/jdbc/go
10:59:41,376 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@1493102 [Attribute: name resource value "com/sa/go/bto/config/Business.hbm.xml"]
10:59:41,386 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/Business.hbm.xml
10:59:41,406 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:41,416 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:41,676 INFO Binder:178 - Mapping class: com.sa.go.bto.Business -> BUSINESS
10:59:41,896 DEBUG Binder:394 - Mapped property: id -> BUSINESS_ID, type: long
10:59:41,956 DEBUG Binder:394 - Mapped property: name -> BUSINESS_NAME, type: string
10:59:41,956 DEBUG Binder:394 - Mapped property: nationalFlag -> NATIONAL_FLAG, type: yes_no
10:59:41,956 DEBUG Binder:394 - Mapped property: jumpPageFlag -> PJP_FLAG, type: yes_no
10:59:42,016 DEBUG Binder:394 - Mapped property: discounts, type: java.util.Set
10:59:42,016 DEBUG Binder:1104 - Named query: com.sa.go.bto.Business.findByName ->
from com.sa.go.bto.Business as business
where upper(business.name) like upper(:name)
order by business.name
10:59:42,016 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@1342a67 [Attribute: name resource value "com/sa/go/bto/config/BusinessLocation.hbm.xml"]
10:59:42,016 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/BusinessLocation.hbm.xml
10:59:42,036 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,046 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,107 INFO Binder:178 - Mapping class: com.sa.go.bto.BusinessLocation -> STORE_LOCATION
10:59:42,107 DEBUG Binder:394 - Mapped property: id -> LOCATION_ID, type: long
10:59:42,107 DEBUG Binder:394 - Mapped property: phoneNumber -> LOCATION_PHONE, type: string
10:59:42,117 DEBUG Binder:394 - Mapped property: topPickFlag -> TOP_PICK_FLAG, type: yes_no
10:59:42,127 DEBUG Binder:394 - Mapped property: url -> SITE_URL, type: string
10:59:42,147 DEBUG Binder:394 - Mapped property: discount -> STORE_DISCOUNT_ID, type: com.sa.go.bto.Discount
10:59:42,147 DEBUG Binder:394 - Mapped property: business -> BUSINESS_ID, type: com.sa.go.bto.Business
10:59:42,227 INFO Binder:122 - Mapping subclass: com.sa.go.bto.OnlineBusinessLocation -> STORE_LOCATION
10:59:42,237 INFO Binder:122 - Mapping subclass: com.sa.go.bto.OfflineBusinessLocation -> STORE_LOCATION
10:59:42,247 DEBUG Binder:394 - Mapped property: addressOne -> ADDRESS1, type: string
10:59:42,247 DEBUG Binder:394 - Mapped property: addressTwo -> ADDRESS2, type: string
10:59:42,247 DEBUG Binder:394 - Mapped property: addressThree -> ADDRESS3, type: string
10:59:42,247 DEBUG Binder:394 - Mapped property: addressFour -> ADDRESS4, type: string
10:59:42,247 DEBUG Binder:394 - Mapped property: city -> CITY, type: string
10:59:42,247 DEBUG Binder:394 - Mapped property: stateCode -> STATE_PROVINCE_CODE, type: string
10:59:42,247 DEBUG Binder:394 - Mapped property: zipCode -> POSTAL_CODE, type: string
10:59:42,257 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@190ef12 [Attribute: name resource value "com/sa/go/bto/config/Discount.hbm.xml"]
10:59:42,257 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/Discount.hbm.xml
10:59:42,287 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,287 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,317 INFO Binder:178 - Mapping class: com.sa.go.bto.Discount -> DISCOUNT
10:59:42,327 DEBUG Binder:394 - Mapped property: id -> DISCOUNT_ID, type: long
10:59:42,327 DEBUG Binder:394 - Mapped property: shortText -> SHORT_TEXT, type: string
10:59:42,327 DEBUG Binder:394 - Mapped property: business -> BUSINESS_ID, type: com.sa.go.bto.Business
10:59:42,327 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@ce16ad [Attribute: name resource value "com/sa/go/bto/config/Member.hbm.xml"]
10:59:42,327 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/Member.hbm.xml
10:59:42,357 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,357 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,387 INFO Binder:178 - Mapping class: com.sa.go.bto.Member -> MEMBER
10:59:42,387 DEBUG Binder:394 - Mapped property: id -> MEMBER_ID, type: long
10:59:42,387 DEBUG Binder:394 - Mapped property: firstName -> FIRST_NAME, type: string
10:59:42,387 DEBUG Binder:394 - Mapped property: middleName -> MIDDLE_NAME, type: string
10:59:42,397 DEBUG Binder:394 - Mapped property: lastName -> LAST_NAME, type: string
10:59:42,397 DEBUG Binder:394 - Mapped property: birthDate -> BIRTH_DATE, type: timestamp
10:59:42,397 DEBUG Binder:394 - Mapped property: gender -> GENDER, type: string
10:59:42,397 DEBUG Binder:394 - Mapped property: graduationYear -> GRADUATION_YEAR, type: long
10:59:42,437 DEBUG Binder:394 - Mapped property: addresses, type: java.util.Set
10:59:42,437 DEBUG Binder:394 - Mapped property: memberSinceDate -> MEMBER_SINCE_DATE, type: timestamp
10:59:42,437 DEBUG Binder:394 - Mapped property: memberUntilDate -> MEMBER_UNTIL_DATE, type: timestamp
10:59:42,457 DEBUG Binder:394 - Mapped property: membershipStatus -> MEMBERSHIP_STATUS_ID, type: com.sa.go.bto.enum.MembershipStatus
10:59:42,477 DEBUG Binder:394 - Mapped property: educationStatus -> EDUCATION_TYPE_ID, type: com.sa.go.bto.enum.EducationStatus
10:59:42,487 DEBUG Binder:394 - Mapped property: secretQuestion -> SCRT_QSTN_ID, type: com.sa.go.bto.SecretQuestion
10:59:42,497 DEBUG Binder:394 - Mapped property: secretQuestionAnswer -> SCRT_ANS, type: string
10:59:42,517 DEBUG Binder:394 - Mapped property: referralMember -> REFERRAL_MEMBER_ID, type: com.sa.go.bto.Member
10:59:42,517 DEBUG Binder:394 - Mapped property: originalPromotion -> ORIGINAL_PROMO_ID, type: com.sa.go.bto.Promotion
10:59:42,527 DEBUG Binder:394 - Mapped property: originalOffer -> ORIGINAL_OFFER_ID, type: com.sa.go.bto.Offer
10:59:42,527 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@29ac [Attribute: name resource value "com/sa/go/bto/config/MemberAddress.hbm.xml"]
10:59:42,527 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/MemberAddress.hbm.xml
10:59:42,547 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,557 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,567 INFO Binder:178 - Mapping class: com.sa.go.bto.MemberAddress -> MEMBER_ADDRESS
10:59:42,577 DEBUG Binder:394 - Mapped property: id -> ADDRESS_ID, type: long
10:59:42,577 DEBUG Binder:394 - Mapped property: type -> ADDRESS_TYPE_ID, type: com.sa.go.bto.enum.MemberAddressType
10:59:42,577 DEBUG Binder:394 - Mapped property: addressOne -> ADDRESS1, type: string
10:59:42,577 DEBUG Binder:394 - Mapped property: addressTwo -> ADDRESS2, type: string
10:59:42,587 DEBUG Binder:394 - Mapped property: addressThree -> ADDRESS3, type: string
10:59:42,587 DEBUG Binder:394 - Mapped property: addressFour -> ADDRESS4, type: string
10:59:42,587 DEBUG Binder:394 - Mapped property: city -> CITY, type: string
10:59:42,597 DEBUG Binder:394 - Mapped property: state -> STATE_PROVINCE_CODE, type: string
10:59:42,597 DEBUG Binder:394 - Mapped property: zip -> POSTAL_CODE, type: string
10:59:42,597 DEBUG Binder:394 - Mapped property: member -> MEMBER_ID, type: com.sa.go.bto.Member
10:59:42,597 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@136d9d8 [Attribute: name resource value "com/sa/go/bto/config/Offer.hbm.xml"]
10:59:42,597 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/Offer.hbm.xml
10:59:42,627 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,627 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,637 INFO Binder:178 - Mapping class: com.sa.go.bto.Offer -> OFFER
10:59:42,647 DEBUG Binder:394 - Mapped property: id -> OFFER_ID, type: long
10:59:42,647 DEBUG Binder:394 - Mapped property: code -> OFFER_NAME, type: string
10:59:42,647 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@1de45e2 [Attribute: name resource value "com/sa/go/bto/config/Promotion.hbm.xml"]
10:59:42,647 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/Promotion.hbm.xml
10:59:42,677 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,677 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,697 INFO Binder:178 - Mapping class: com.sa.go.bto.Promotion -> PROMO
10:59:42,697 DEBUG Binder:394 - Mapped property: id -> PROMO_ID, type: long
10:59:42,697 DEBUG Binder:394 - Mapped property: code -> PROMO_CODE, type: string
10:59:42,697 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@159e154 [Attribute: name resource value "com/sa/go/bto/config/Province.hbm.xml"]
10:59:42,697 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/Province.hbm.xml
10:59:42,747 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,747 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,798 INFO Binder:178 - Mapping class: com.sa.go.bto.Province -> PROVINCE
10:59:42,798 DEBUG Binder:394 - Mapped property: id -> PROVINCE_ID, type: long
10:59:42,798 DEBUG Binder:394 - Mapped property: code -> PROVINCE_CODE, type: string
10:59:42,798 DEBUG Binder:394 - Mapped property: description -> PROVINCE_DESC, type: string
10:59:42,798 DEBUG Binder:394 - Mapped property: sortIndex -> SORT_INDEX, type: long
10:59:42,798 DEBUG Binder:1104 - Named query: com.sa.go.bto.Province.all ->
from com.sa.go.bto.Province as province order by province.sortIndex
10:59:42,808 DEBUG Binder:1104 - Named query: com.sa.go.bto.Province.byCode ->
from com.sa.go.bto.Province as province where province.code = :code
10:59:42,808 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@22d166 [Attribute: name resource value "com/sa/go/bto/config/Region.hbm.xml"]
10:59:42,808 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/Region.hbm.xml
10:59:42,828 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,828 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,858 INFO Binder:178 - Mapping class: com.sa.go.bto.Region -> REGION
10:59:42,858 DEBUG Binder:394 - Mapped property: id -> REGION_ID, type: long
10:59:42,868 DEBUG Binder:394 - Mapped property: name -> NAME, type: string
10:59:42,868 DEBUG Binder:394 - Mapped property: description -> DESCRIPTION, type: string
10:59:42,878 DEBUG Binder:394 - Mapped property: ordering -> ORDERING, type: long
10:59:42,888 INFO Binder:122 - Mapping subclass: com.sa.go.bto.RadiusRegion -> REGION
10:59:42,888 DEBUG Binder:394 - Mapped property: zipCode -> ZIP_CODE, type: string
10:59:42,888 DEBUG Binder:394 - Mapped property: radius -> RADIUS, type: double
10:59:42,898 INFO Binder:122 - Mapping subclass: com.sa.go.bto.StateRegion -> REGION
10:59:42,898 DEBUG Binder:394 - Mapped property: stateCode -> STATE_CODE, type: string
10:59:42,908 DEBUG Binder:1104 - Named query: com.sa.go.bto.Region.all ->
from com.sa.go.bto.Region order by ordering
10:59:42,908 DEBUG Binder:1104 - Named query: com.sa.go.bto.Region.specific ->
from com.sa.go.bto.Region as region where region.id = :id
10:59:42,908 DEBUG Binder:1104 - Named query: com.sa.go.bto.Region.maxOrdering ->
select max(region.ordering) from com.sa.go.bto.Region as region
10:59:42,908 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@578073 [Attribute: name resource value "com/sa/go/bto/config/SecretQuestion.hbm.xml"]
10:59:42,908 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/SecretQuestion.hbm.xml
10:59:42,938 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,938 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:42,948 INFO Binder:178 - Mapping class: com.sa.go.bto.SecretQuestion -> SCRT_QSTN
10:59:42,948 DEBUG Binder:394 - Mapped property: id -> SCRT_QSTN_ID, type: long
10:59:42,958 DEBUG Binder:394 - Mapped property: question -> SCRT_QSTN, type: string
10:59:42,958 DEBUG Configuration:836 - null<-org.dom4j.tree.DefaultAttribute@7e9ce2 [Attribute: name resource value "com/sa/go/bto/config/ZipCode.hbm.xml"]
10:59:42,958 INFO Configuration:270 - Mapping resource: com/sa/go/bto/config/ZipCode.hbm.xml
10:59:42,988 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
10:59:42,988 DEBUG DTDEntityResolver:29 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
10:59:43,018 INFO Binder:178 - Mapping class: com.sa.go.bto.ZipCode -> ZIP_LIST
10:59:43,018 DEBUG Binder:394 - Mapped property: id -> ZIP_LIST_ID, type: long
10:59:43,018 DEBUG Binder:394 - Mapped property: cityName -> CITY_NAME, type: string
10:59:43,018 DEBUG Binder:394 - Mapped property: stateCode -> STATE_CODE, type: string
10:59:43,018 DEBUG Binder:394 - Mapped property: zipCode -> ZIP_CODE, type: string
10:59:43,018 DEBUG Binder:394 - Mapped property: areaCode -> AREA_CODE, type: string
10:59:43,018 DEBUG Binder:394 - Mapped property: countyFips -> COUNTY_FIPS, type: string
10:59:43,018 DEBUG Binder:394 - Mapped property: countyName -> COUNTY_NAME, type: string
10:59:43,028 DEBUG Binder:394 - Mapped property: timeZone -> TIME_ZONE, type: string
10:59:43,028 DEBUG Binder:394 - Mapped property: daylightSavingsFlag -> DAYLIGHT_SAVINGS_FLAG, type: yes_no
10:59:43,028 DEBUG Binder:394 - Mapped property: latitude -> LATITUDE, type: double
10:59:43,028 DEBUG Binder:394 - Mapped property: longitude -> LONGITUDE, type: double
10:59:43,028 DEBUG Binder:394 - Mapped property: zipCodeType -> ZIP_CODE_TYPE, type: string
10:59:43,038 DEBUG Binder:1104 - Named query: com.sa.go.bto.ZipCode.all ->
from com.sa.go.bto.ZipCode
10:59:43,038 DEBUG Binder:1104 - Named query: com.sa.go.bto.ZipCode.byCode ->
from com.sa.go.bto.ZipCode as zipCode where zipCode.zipCode = :zipCode
10:59:43,038 INFO Configuration:885 - Configured SessionFactory: null
10:59:43,038 DEBUG Configuration:886 - properties: {java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, transaction.factory_class=net.sf.hibernate.transaction.JDBCTransactionFactory, sun.boot.library.path=c:\java\j2sdk\1.4.1_02\jre\bin, java.vm.version=1.4.1_02-b06, connection.datasource=java:comp/env/stad/jdbc/go, java.vm.vendor=Sun Microsystems Inc., java.vendor.url=http://java.sun.com/, path.separator=;, java.vm.name=Java HotSpot(TM) Client VM, file.encoding.pkg=sun.io, use_outer_join=true, user.country=US, sun.os.patch.level=, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\Java\IDE\Eclipse\3.0-M2\workspace\go3\tomcat, java.runtime.version=1.4.1_02-b06, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=./common/endorsed, os.arch=x86, java.io.tmpdir=./temp, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, java.naming.factory.url.pkgs=org.apache.naming, os.name=Windows XP, sun.java2d.fontpath=, hibernate.connection.datasource=java:comp/env/stad/jdbc/go, java.library.path=c:\java\j2sdk\1.4.1_02\bin;.;C:\WINDOWS\System32;C:\WINDOWS;C:\Progra~1\Oracle\Ora81\bin;C:\Program Files\Oracle\jre\1.1.7\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\Common Files\Adaptec Shared\System;C:\Program Files\Microsoft SQL Server\80\Tools\BINN;c:/java/j2sdk/1.4.1_02/bin, java.specification.name=Java Platform API Specification, java.class.version=48.0, hibernate.transaction.factory_class=net.sf.hibernate.transaction.JDBCTransactionFactory, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, os.version=5.1, user.home=C:\Documents and Settings\JFarley, user.timezone=America/New_York, catalina.useNaming=true, java.awt.printerjob=sun.awt.windows.WPrinterJob, file.encoding=Cp1252, java.specification.version=1.4, show_sql=true, catalina.home=., java.class.path=C:\Java\IDE\Eclipse\3.0-M2\workspace\go3\tomcat\bin\bootstrap.jar, user.name=JFarley, hibernate.show_sql=true, java.naming.factory.initial=org.apache.naming.java.javaURLContextFactory, java.vm.specification.version=1.0, java.home=c:\java\j2sdk\1.4.1_02\jre, sun.arch.data.model=32, hibernate.dialect=net.sf.hibernate.dialect.OracleDialect, user.language=en, java.specification.vendor=Sun Microsystems Inc., awt.toolkit=sun.awt.windows.WToolkit, hibernate.cglib.use_reflection_optimizer=true, java.vm.info=mixed mode, java.version=1.4.1_02, java.ext.dirs=c:\java\j2sdk\1.4.1_02\jre\lib\ext, sun.boot.class.path=./common/endorsed\xercesImpl.jar;./common/endorsed\xmlParserAPIs.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\rt.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\ext\dnsns.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\ext\ldapsec.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\ext\localedata.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\ext\sunjce_provider.jar;C:\Java\J2SDK\1.4.1_02\lib\tools.jar, java.vendor=Sun Microsystems Inc., catalina.base=., file.separator=\, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, sun.io.unicode.encoding=UnicodeLittle, sun.cpu.endian=little, hibernate.use_outer_join=true, dialect=net.sf.hibernate.dialect.OracleDialect, sun.cpu.isalist=pentium i486 i386}
10:59:43,038 INFO Configuration:492 - processing one-to-many association mappings
10:59:43,048 DEBUG Binder:1134 - Second pass for collection: com.sa.go.bto.Business.discounts
10:59:43,048 INFO Binder:1025 - Mapping collection: com.sa.go.bto.Business.discounts -> DISCOUNT
10:59:43,048 DEBUG Binder:1146 - Mapped collection key: BUSINESS_ID, one-to-many: com.sa.go.bto.Discount
10:59:43,048 DEBUG Binder:1134 - Second pass for collection: com.sa.go.bto.Member.addresses
10:59:43,048 INFO Binder:1025 - Mapping collection: com.sa.go.bto.Member.addresses -> MEMBER_ADDRESS
10:59:43,048 DEBUG Binder:1146 - Mapped collection key: MEMBER_ID, one-to-many: com.sa.go.bto.MemberAddress
10:59:43,048 INFO Configuration:503 - processing foreign key constraints
10:59:43,058 DEBUG Configuration:513 - resolving reference to class: com.sa.go.bto.Discount
10:59:43,058 DEBUG Configuration:513 - resolving reference to class: com.sa.go.bto.Business
10:59:43,058 DEBUG Configuration:513 - resolving reference to class: com.sa.go.bto.Offer
10:59:43,058 DEBUG Configuration:513 - resolving reference to class: com.sa.go.bto.SecretQuestion
10:59:43,058 DEBUG Configuration:513 - resolving reference to class: com.sa.go.bto.Member
10:59:43,058 DEBUG Configuration:513 - resolving reference to class: com.sa.go.bto.Promotion
10:59:43,058 DEBUG Configuration:513 - resolving reference to class: com.sa.go.bto.Member
10:59:43,068 DEBUG Configuration:513 - resolving reference to class: com.sa.go.bto.Business
10:59:43,549 INFO SessionFactoryImpl:132 - building session factory
10:59:43,559 DEBUG SessionFactoryImpl:134 - instantiating session factory with properties: {java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, transaction.factory_class=net.sf.hibernate.transaction.JDBCTransactionFactory, sun.boot.library.path=c:\java\j2sdk\1.4.1_02\jre\bin, java.vm.version=1.4.1_02-b06, connection.datasource=java:comp/env/stad/jdbc/go, java.vm.vendor=Sun Microsystems Inc., java.vendor.url=http://java.sun.com/, path.separator=;, java.vm.name=Java HotSpot(TM) Client VM, file.encoding.pkg=sun.io, user.country=US, sun.os.patch.level=, use_outer_join=true, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\Java\IDE\Eclipse\3.0-M2\workspace\go3\tomcat, java.runtime.version=1.4.1_02-b06, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=./common/endorsed, os.arch=x86, java.io.tmpdir=./temp, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, java.naming.factory.url.pkgs=org.apache.naming, os.name=Windows XP, sun.java2d.fontpath=, java.library.path=c:\java\j2sdk\1.4.1_02\bin;.;C:\WINDOWS\System32;C:\WINDOWS;C:\Progra~1\Oracle\Ora81\bin;C:\Program Files\Oracle\jre\1.1.7\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\Common Files\Adaptec Shared\System;C:\Program Files\Microsoft SQL Server\80\Tools\BINN;c:/java/j2sdk/1.4.1_02/bin, hibernate.connection.datasource=java:comp/env/stad/jdbc/go, java.specification.name=Java Platform API Specification, java.class.version=48.0, hibernate.transaction.factory_class=net.sf.hibernate.transaction.JDBCTransactionFactory, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, os.version=5.1, user.home=C:\Documents and Settings\JFarley, catalina.useNaming=true, user.timezone=America/New_York, java.awt.printerjob=sun.awt.windows.WPrinterJob, java.specification.version=1.4, file.encoding=Cp1252, catalina.home=., show_sql=true, user.name=JFarley, java.class.path=C:\Java\IDE\Eclipse\3.0-M2\workspace\go3\tomcat\bin\bootstrap.jar, java.naming.factory.initial=org.apache.naming.java.javaURLContextFactory, hibernate.show_sql=true, java.vm.specification.version=1.0, sun.arch.data.model=32, java.home=c:\java\j2sdk\1.4.1_02\jre, hibernate.dialect=net.sf.hibernate.dialect.OracleDialect, java.specification.vendor=Sun Microsystems Inc., user.language=en, awt.toolkit=sun.awt.windows.WToolkit, java.vm.info=mixed mode, hibernate.cglib.use_reflection_optimizer=true, java.version=1.4.1_02, java.ext.dirs=c:\java\j2sdk\1.4.1_02\jre\lib\ext, sun.boot.class.path=./common/endorsed\xercesImpl.jar;./common/endorsed\xmlParserAPIs.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\rt.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\ext\dnsns.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\ext\ldapsec.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\ext\localedata.jar;C:\Java\J2SDK\1.4.1_02\jre\lib\ext\sunjce_provider.jar;C:\Java\J2SDK\1.4.1_02\lib\tools.jar, java.vendor=Sun Microsystems Inc., catalina.base=., file.separator=\, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, sun.cpu.endian=little, sun.io.unicode.encoding=UnicodeLittle, hibernate.use_outer_join=true, sun.cpu.isalist=pentium i486 i386, dialect=net.sf.hibernate.dialect.OracleDialect}
10:59:43,629 INFO Dialect:83 - Using dialect: net.sf.hibernate.dialect.OracleDialect
10:59:43,659 INFO NamingHelper:26 - JNDI InitialContext properties:{}
10:59:43,699 INFO DatasourceConnectionProvider:52 - Using datasource: java:comp/env/stad/jdbc/go
10:59:43,699 INFO SessionFactoryImpl:162 - Use outer join fetching: true
10:59:44,991 INFO SessionFactoryImpl:185 - Use scrollable result sets: true
10:59:45,001 INFO SessionFactoryImpl:186 - JDBC 2 max batch size: 15
10:59:45,001 INFO SessionFactoryImpl:460 - Transaction strategy: net.sf.hibernate.transaction.JDBCTransactionFactory
10:59:45,011 INFO SessionFactoryImpl:194 - echoing all SQL to stdout
10:59:45,331 INFO ReflectHelper:328 - reflection optimizer disabled for: com.sa.go.bto.Province, IllegalArgumentException: getSortIndex
10:59:45,782 INFO ReflectHelper:328 - reflection optimizer disabled for: com.sa.go.bto.BusinessLocation, InstantiationError: com.sa.go.bto.BusinessLocation
10:59:46,092 DEBUG SessionFactoryObjectFactory:39 - initializing class SessionFactoryObjectFactory
10:59:46,102 DEBUG SessionFactoryObjectFactory:76 - registered: 8ae49417f749112700f7491133220000 (unnamed)
10:59:46,102 INFO SessionFactoryObjectFactory:82 - no JDNI name configured
10:59:46,102 INFO SessionFactoryImpl:269 - Query language substitutions: {}
10:59:46,102 DEBUG SessionFactoryImpl:281 - instantiated session factory
10:59:46,483 INFO TilesPlugin:238 - Tiles definition factory loaded for module '/newadmin'.
10:59:46,623 INFO PropertyMessageResources:127 - Initializing, config='com.sa.go.web.admin.region.ApplicationResources', returnNull=true
10:59:46,643 INFO ValidatorPlugIn:209 - Loading validation rules file from '/WEB-INF/config/validation/validator-rules.xml'
10:59:46,763 INFO ValidatorPlugIn:209 - Loading validation rules file from '/WEB-INF/config/validation/validator-rules-custom.xml'
10:59:46,783 INFO ValidatorPlugIn:209 - Loading validation rules file from '/WEB-INF/config/validation/admin-regions-validation.xml'
10:59:46,944 INFO TilesPlugin:238 - Tiles definition factory loaded for module '/newadmin/regions'.
10:59:47,014 INFO PropertyMessageResources:127 - Initializing, config='com.sa.go.web.admin.businessmanagement.ApplicationResources', returnNull=true
10:59:47,024 INFO ValidatorPlugIn:209 - Loading validation rules file from '/WEB-INF/config/validation/validator-rules.xml'
10:59:47,094 INFO ValidatorPlugIn:209 - Loading validation rules file from '/WEB-INF/config/validation/validator-rules-custom.xml'
10:59:47,124 INFO ValidatorPlugIn:209 - Loading validation rules file from '/WEB-INF/config/validation/admin-businessmanagement-validation.xml'
10:59:47,224 INFO TilesPlugin:238 - Tiles definition factory loaded for module '/newadmin/businessmanagement'.
Aug 28, 2003 10:59:47 AM org.apache.coyote.http11.Http11Protocol start
INFO: Starting Coyote HTTP/1.1 on port 80
10:59:50,178 INFO TilesRequestProcessor:139 - Tiles definition factory found for request processor '/newadmin'.
10:59:50,338 DEBUG SessionImpl:413 - opened session
10:59:50,348 DEBUG JDBCTransaction:36 - begin
10:59:50,549 INFO PropertyMessageResources:127 - Initializing, config='org.apache.struts.taglib.logic.LocalStrings', returnNull=true
10:59:50,669 DEBUG JDBCTransaction:54 - commit
10:59:50,669 DEBUG SessionImpl:2011 - flushing session
10:59:50,679 DEBUG SessionImpl:2113 - Flushing entities and processing referenced collections
10:59:50,679 DEBUG SessionImpl:2397 - Processing unreferenced collections
10:59:50,679 DEBUG SessionImpl:2408 - Scheduling collection removes/(re)creates/updates
10:59:50,679 DEBUG SessionImpl:2023 - Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
10:59:50,679 DEBUG SessionImpl:2028 - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
10:59:50,679 DEBUG SessionImpl:2058 - executing flush
10:59:50,689 DEBUG SessionImpl:2428 - post flush
10:59:50,689 DEBUG SessionImpl:447 - transaction completion
10:59:50,689 DEBUG SessionImpl:435 - closing session
10:59:50,689 DEBUG SessionImpl:2930 - disconnecting session
10:59:50,699 DEBUG SessionImpl:447 - transaction completion
10:59:55,185 INFO TilesRequestProcessor:139 - Tiles definition factory found for request processor '/newadmin/businessmanagement'.
10:59:55,185 DEBUG SessionImpl:413 - opened session
10:59:55,185 DEBUG JDBCTransaction:36 - begin
LOADING
10:59:55,326 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Business#1000410]
10:59:55,326 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Business#1000410]
10:59:55,336 DEBUG SessionImpl:1887 - object not resolved in any cache [com.sa.go.bto.Business#1000410]
10:59:55,336 DEBUG EntityPersister:394 - Materializing entity: com.sa.go.bto.Business#1000410
10:59:55,346 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:55,346 DEBUG SessionFactoryImpl:526 - prepared statement get: select business0_.BUSINESS_ID as BUSINESS_ID, business0_.BUSINESS_NAME as BUSINESS2_, business0_.NATIONAL_FLAG as NATIONAL3_, business0_.PJP_FLAG as PJP_FLAG from BUSINESS business0_ where business0_.BUSINESS_ID=?
Hibernate: select business0_.BUSINESS_ID as BUSINESS_ID, business0_.BUSINESS_NAME as BUSINESS2_, business0_.NATIONAL_FLAG as NATIONAL3_, business0_.PJP_FLAG as PJP_FLAG from BUSINESS business0_ where business0_.BUSINESS_ID=?
10:59:55,346 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:55,406 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:55,466 DEBUG Loader:148 - processing result set
10:59:55,476 DEBUG Loader:260 - result row: 1000410
10:59:55,476 DEBUG Loader:357 - Initializing object from ResultSet: 1000410
10:59:55,486 DEBUG Loader:413 - Hydrating entity: com.sa.go.bto.Business#1000410
10:59:55,486 DEBUG StringType:65 - returning 'Pizzeria Uno Chicago Grill' as column: BUSINESS2_
10:59:55,486 DEBUG YesNoType:65 - returning 'true' as column: NATIONAL3_
10:59:55,486 DEBUG YesNoType:65 - returning 'true' as column: PJP_FLAG
10:59:55,496 DEBUG Loader:182 - done processing result set (1 rows)
10:59:55,506 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:55,516 DEBUG SessionFactoryImpl:554 - closing statement
10:59:55,516 DEBUG Loader:195 - total objects hydrated: 1
10:59:55,516 DEBUG SessionImpl:1954 - resolving associations for [com.sa.go.bto.Business#1000410]
10:59:55,556 DEBUG SessionImpl:1975 - done materializing entity [com.sa.go.bto.Business#1000410]
DONE
LOOPING OVER DISCOUNTS
GOT SET: class net.sf.hibernate.collection.Set
10:59:55,566 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:55,566 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:55,566 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:55,576 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:55,576 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:55,626 DEBUG Loader:148 - processing result set
10:59:55,636 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:55,636 DEBUG Loader:260 - result row: 32113
10:59:55,636 DEBUG Loader:357 - Initializing object from ResultSet: 32113
10:59:55,646 DEBUG Loader:413 - Hydrating entity: com.sa.go.bto.Discount#32113
10:59:55,646 DEBUG StringType:65 - returning 'Save 10-15% at select locations.' as column: SHORT_TEXT
10:59:55,646 DEBUG LongType:65 - returning '1000410' as column: BUSINESS3_
10:59:55,646 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:55,646 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:55,656 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:55,656 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:55,656 DEBUG Loader:182 - done processing result set (1 rows)
10:59:55,656 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:55,656 DEBUG SessionFactoryImpl:554 - closing statement
10:59:55,666 DEBUG Loader:195 - total objects hydrated: 1
10:59:55,666 DEBUG SessionImpl:1954 - resolving associations for [com.sa.go.bto.Discount#32113]
10:59:55,666 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Business#1000410]
10:59:55,676 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Business#1000410]
10:59:55,676 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Business#1000410]
10:59:55,676 DEBUG SessionImpl:1975 - done materializing entity [com.sa.go.bto.Discount#32113]
10:59:55,686 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:55,686 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:55,686 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:55,686 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:55,696 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:55,736 DEBUG Loader:148 - processing result set
10:59:55,746 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:55,746 DEBUG Loader:260 - result row: 32113
10:59:55,746 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:55,746 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:55,756 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:55,756 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:55,756 DEBUG Loader:182 - done processing result set (1 rows)
10:59:55,756 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:55,766 DEBUG SessionFactoryImpl:554 - closing statement
10:59:55,766 DEBUG Loader:195 - total objects hydrated: 0
10:59:55,766 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:55,776 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:55,776 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:55,786 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:55,786 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:55,826 DEBUG Loader:148 - processing result set
10:59:55,836 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:55,836 DEBUG Loader:260 - result row: 32113
10:59:55,836 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:55,846 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:55,846 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:55,856 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:55,856 DEBUG Loader:182 - done processing result set (1 rows)
10:59:55,856 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:55,866 DEBUG SessionFactoryImpl:554 - closing statement
10:59:55,866 DEBUG Loader:195 - total objects hydrated: 0
10:59:55,876 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:55,876 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:55,886 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:55,886 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:55,886 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:55,926 DEBUG Loader:148 - processing result set
10:59:55,936 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:55,936 DEBUG Loader:260 - result row: 32113
10:59:55,936 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:55,956 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:55,956 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:55,956 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:55,967 DEBUG Loader:182 - done processing result set (1 rows)
10:59:55,967 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:55,967 DEBUG SessionFactoryImpl:554 - closing statement
10:59:55,977 DEBUG Loader:195 - total objects hydrated: 0
10:59:55,977 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:55,987 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:55,987 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:55,997 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:55,997 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:56,047 DEBUG Loader:148 - processing result set
10:59:56,047 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:56,057 DEBUG Loader:260 - result row: 32113
10:59:56,067 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:56,067 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:56,067 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:56,077 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:56,077 DEBUG Loader:182 - done processing result set (1 rows)
10:59:56,087 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:56,087 DEBUG SessionFactoryImpl:554 - closing statement
10:59:56,097 DEBUG Loader:195 - total objects hydrated: 0
10:59:56,097 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:56,107 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:56,107 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:56,107 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:56,117 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:56,187 DEBUG Loader:148 - processing result set
10:59:56,187 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:56,197 DEBUG Loader:260 - result row: 32113
10:59:56,197 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:56,207 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:56,207 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:56,217 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:56,217 DEBUG Loader:182 - done processing result set (1 rows)
10:59:56,227 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:56,227 DEBUG SessionFactoryImpl:554 - closing statement
10:59:56,237 DEBUG Loader:195 - total objects hydrated: 0
10:59:56,237 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:56,247 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:56,257 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:56,257 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:56,267 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:56,317 DEBUG Loader:148 - processing result set
10:59:56,317 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:56,317 DEBUG Loader:260 - result row: 32113
10:59:56,327 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:56,327 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:56,337 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:56,347 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:56,357 DEBUG Loader:182 - done processing result set (1 rows)
10:59:56,357 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:56,367 DEBUG SessionFactoryImpl:554 - closing statement
10:59:56,367 DEBUG Loader:195 - total objects hydrated: 0
10:59:56,377 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:56,377 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:56,387 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:56,387 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:56,397 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:56,437 DEBUG Loader:148 - processing result set
10:59:56,447 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:56,457 DEBUG Loader:260 - result row: 32113
10:59:56,457 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:56,467 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:56,477 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:56,477 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:56,487 DEBUG Loader:182 - done processing result set (1 rows)
10:59:56,487 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:56,497 DEBUG SessionFactoryImpl:554 - closing statement
10:59:56,497 DEBUG Loader:195 - total objects hydrated: 0
10:59:56,507 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:56,517 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:56,517 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:56,527 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:56,527 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:56,577 DEBUG Loader:148 - processing result set
10:59:56,577 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:56,587 DEBUG Loader:260 - result row: 32113
10:59:56,587 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:56,597 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:56,597 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:56,617 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:56,617 DEBUG Loader:182 - done processing result set (1 rows)
10:59:56,627 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:56,627 DEBUG SessionFactoryImpl:554 - closing statement
10:59:56,637 DEBUG Loader:195 - total objects hydrated: 0
10:59:56,637 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:56,658 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:56,658 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:56,668 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:56,678 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:56,718 DEBUG Loader:148 - processing result set
10:59:56,728 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:56,728 DEBUG Loader:260 - result row: 32113
10:59:56,738 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:56,758 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:56,758 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:56,768 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:56,768 DEBUG Loader:182 - done processing result set (1 rows)
10:59:56,778 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:56,788 DEBUG SessionFactoryImpl:554 - closing statement
10:59:56,788 DEBUG Loader:195 - total objects hydrated: 0
10:59:56,798 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:56,808 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
10:59:56,808 DEBUG SessionFactoryImpl:526 - prepared statement get: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
Hibernate: select discount0_.DISCOUNT_ID as DISCOUNT1___, discount0_.DISCOUNT_ID as DISCOUNT_ID, discount0_.SHORT_TEXT as SHORT_TEXT, discount0_.BUSINESS_ID as BUSINESS3_ from DISCOUNT discount0_ where discount0_.BUSINESS_ID=?
10:59:56,818 DEBUG SessionFactoryImpl:536 - preparing statement
10:59:56,828 DEBUG LongType:44 - binding '1000410' to parameter: 1
10:59:56,868 DEBUG Loader:148 - processing result set
10:59:56,868 DEBUG LongType:65 - returning '32113' as column: DISCOUNT_ID
10:59:56,878 DEBUG Loader:260 - result row: 32113
10:59:56,888 DEBUG LongType:65 - returning '32113' as column: DISCOUNT1___
10:59:56,888 DEBUG SessionImpl:1752 - loading [com.sa.go.bto.Discount#32113]
10:59:56,898 DEBUG SessionImpl:1843 - attempting to resolve [com.sa.go.bto.Discount#32113]
10:59:56,898 DEBUG SessionImpl:1858 - resolved object in session cache [com.sa.go.bto.Discount#32113]
10:59:56,908 DEBUG Loader:182 - done processing result set (1 rows)
10:59:56,918 DEBUG BatcherImpl:173 - done closing: 0 open PreparedStatements, 0 open ResultSets
10:59:56,918 DEBUG SessionFactoryImpl:554 - closing statement
10:59:56,938 DEBUG Loader:195 - total objects hydrated: 0
10:59:56,938 DEBUG SessionImpl:2888 - initializing collection [com.sa.go.bto.Business.discounts#1000410]
10:59:56,948 DEBUG BatcherImpl:166 - about to open: 0 open PreparedStatements, 0 open ResultSets
If I set lazy to false on the Business class, it works. If I leave lazy on and remove the bidirectional many-to-one attribute in Discount, it works. When lazy is on in Business *and* many-to-one is present in Discount, I get what you see above. This is killin' me! :-)
Anyone with ideas, I'd certainly appreciate it. You can get back to me at
jfarley@studentadvantage.com if necessary.
Thanks in advance!
James