Hey All,
I just spent a couple of hours tracking down a problem where I had a non-existant .hbm.xml file specified in my hibernate.cfg.xml file and it caused a MappingException to be reported for a completely different class/collection.
ie: I had the entry:
<mapping resource="edu/academyart/model/Image.hbm.xml"/>
in the .cfg.xml file and it was giving me:
Code:
net.sf.hibernate.MappingException: Association references unmapped class: edu.academyart.model.ExamEnrollment
at net.sf.hibernate.cfg.Binder.bindCollectionSecondPass(Binder.java:1162)
at net.sf.hibernate.cfg.Binder$CollectionSecondPass.secondPass(Binder.java:1366)
at net.sf.hibernate.cfg.Binder$SecondPass.doSecondPass(Binder.java:1342)
at net.sf.hibernate.cfg.Configuration.secondPassCompile(Configuration.java:618)
at net.sf.hibernate.cfg.Configuration.buildSessionFactory(Configuration.java:761)
at edu.academyart.model.ModelLoader.buildFactory(ModelLoader.java:63)
at edu.academyart.model.ModelLoader.getFactory(ModelLoader.java:123)
Here is the full hibernate debug dump (kinda huge) in case that helps:
Code:
15:36:24,137 INFO Environment:462 - Hibernate 2.1.4
15:36:24,137 INFO Environment:491 - hibernate.properties not found
15:36:24,147 INFO Configuration:872 - configuring from resource: /discussion-hibernate.cfg.xml
15:36:24,157 INFO Configuration:844 - Configuration resource: /discussion-hibernate.cfg.xml
15:36:24,217 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-configuration-2.0.dtd in classpath under net/sf/hibernate/
15:36:24,227 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-configuration-2.0.dtd in classpath
15:36:24,268 DEBUG Configuration:830 - connection.datasource=java:comp/env/jdbc/DISCUSSION
15:36:24,268 DEBUG Configuration:830 - dialect=net.sf.hibernate.dialect.SybaseDialect
15:36:24,268 DEBUG Configuration:830 - show_sql=false
15:36:24,268 DEBUG Configuration:830 - use_outer_join=true
15:36:24,278 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@510e39 [Attribute: name resource value "edu/academyart/model/Assignment.hbm.xml"]
15:36:24,278 INFO Configuration:328 - Mapping resource: edu/academyart/model/Assignment.hbm.xml
15:36:24,388 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:24,398 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:24,518 INFO Binder:229 - Mapping class: edu.academyart.model.Assignment -> assignment
15:36:24,608 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:24,768 DEBUG Binder:475 - Mapped property: course -> courseid, type: edu.academyart.model.Course
15:36:24,828 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:24,828 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:24,838 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:24,838 DEBUG Binder:475 - Mapped property: location -> location, type: string
15:36:24,838 DEBUG Binder:475 - Mapped property: contentType -> contentType, type: string
15:36:24,868 DEBUG Binder:475 - Mapped property: content -> dbFileId, type: edu.academyart.model.DBFile
15:36:24,878 DEBUG Binder:475 - Mapped property: isPublic -> ispublic, type: boolean
15:36:24,888 DEBUG Binder:475 - Mapped property: uploadDate -> uploaddate, type: timestamp
15:36:24,898 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@17e4dee [Attribute: name resource value "edu/academyart/model/Attachment.hbm.xml"]
15:36:24,898 INFO Configuration:328 - Mapping resource: edu/academyart/model/Attachment.hbm.xml
15:36:24,948 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:24,948 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:24,999 INFO Binder:229 - Mapping class: edu.academyart.model.Attachment -> attachment
15:36:24,999 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:24,999 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:24,999 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:24,999 DEBUG Binder:475 - Mapped property: location -> location, type: string
15:36:24,999 DEBUG Binder:475 - Mapped property: contentType -> contentType, type: string
15:36:25,009 DEBUG Binder:475 - Mapped property: content -> dbFileId, type: edu.academyart.model.DBFile
15:36:25,009 DEBUG Binder:475 - Mapped property: parentId -> parentid, type: long
15:36:25,009 DEBUG Binder:475 - Mapped property: type -> type, type: long
15:36:25,009 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@bc5596 [Attribute: name resource value "edu/academyart/model/Course.hbm.xml"]
15:36:25,009 INFO Configuration:328 - Mapping resource: edu/academyart/model/Course.hbm.xml
15:36:25,019 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,019 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,029 INFO Binder:229 - Mapping class: edu.academyart.model.Course -> course
15:36:25,029 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,029 DEBUG Binder:475 - Mapped property: semester -> semesterid, type: edu.academyart.model.Semester
15:36:25,029 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,039 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:25,039 DEBUG Binder:475 - Mapped property: startDate -> startdate, type: timestamp
15:36:25,039 DEBUG Binder:475 - Mapped property: endDate -> enddate, type: timestamp
15:36:25,039 DEBUG Binder:475 - Mapped property: inTopclass -> topclass, type: boolean
15:36:25,039 DEBUG Binder:475 - Mapped property: topclassId -> topclassid, type: long
15:36:25,039 DEBUG Binder:475 - Mapped property: assignmentUploadActive -> assignmentUploadActive, type: boolean
15:36:25,039 DEBUG Binder:475 - Mapped property: active -> active, type: boolean
15:36:25,039 DEBUG Binder:475 - Mapped property: ftpActive -> ftpActive, type: boolean
15:36:25,059 DEBUG Binder:475 - Mapped property: enrollments, type: java.util.Set
15:36:25,059 DEBUG Binder:475 - Mapped property: topics, type: java.util.Set
15:36:25,059 DEBUG Binder:475 - Mapped property: permissions, type: java.util.Set
15:36:25,109 DEBUG Binder:475 - Mapped property: grades, type: java.util.Set
15:36:25,109 DEBUG Binder:475 - Mapped property: gradeTypes, type: java.util.Set
15:36:25,119 DEBUG Binder:475 - Mapped property: assignments, type: java.util.Set
15:36:25,119 INFO Binder:560 - Mapping collection: edu.academyart.model.Course.exams -> course_to_exam
15:36:25,129 DEBUG Binder:475 - Mapped property: exams, type: java.util.Set
15:36:25,129 INFO Binder:560 - Mapping collection: edu.academyart.model.Course.examEnrollments -> exam_enrollments
15:36:25,129 DEBUG Binder:475 - Mapped property: examEnrollments, type: java.util.Set
15:36:25,129 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@4c6320 [Attribute: name resource value "edu/academyart/model/CoursePermissions.hbm.xml"]
15:36:25,129 INFO Configuration:328 - Mapping resource: edu/academyart/model/CoursePermissions.hbm.xml
15:36:25,139 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,139 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,149 INFO Binder:229 - Mapping class: edu.academyart.model.CoursePermissions -> rights
15:36:25,149 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,149 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:25,159 DEBUG Binder:475 - Mapped property: course -> courseId, type: edu.academyart.model.Course
15:36:25,159 DEBUG Binder:475 - Mapped property: student -> student, type: boolean
15:36:25,159 DEBUG Binder:475 - Mapped property: teacher -> teacher, type: boolean
15:36:25,159 DEBUG Binder:475 - Mapped property: admin -> admin, type: boolean
15:36:25,159 DEBUG Binder:475 - Mapped property: canPost -> can_post, type: boolean
15:36:25,159 DEBUG Binder:475 - Mapped property: canView -> can_view, type: boolean
15:36:25,159 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@1000bcf [Attribute: name resource value "edu/academyart/model/Department.hbm.xml"]
15:36:25,159 INFO Configuration:328 - Mapping resource: edu/academyart/model/Department.hbm.xml
15:36:25,169 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,169 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,209 INFO Binder:229 - Mapping class: edu.academyart.model.Department -> department
15:36:25,209 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,209 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,209 DEBUG Binder:475 - Mapped property: value -> value, type: string
15:36:25,209 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@1bb9696 [Attribute: name resource value "edu/academyart/model/DBFile.hbm.xml"]
15:36:25,209 INFO Configuration:328 - Mapping resource: edu/academyart/model/DBFile.hbm.xml
15:36:25,219 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,219 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,229 INFO Binder:229 - Mapping class: edu.academyart.model.DBFile -> dbFile
15:36:25,229 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,229 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,239 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:25,239 DEBUG Binder:475 - Mapped property: contentType -> contentType, type: string
15:36:25,239 DEBUG Binder:475 - Mapped property: content -> content, type: blob
15:36:25,239 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@1474e45 [Attribute: name resource value "edu/academyart/model/Enrollment.hbm.xml"]
15:36:25,239 INFO Configuration:328 - Mapping resource: edu/academyart/model/Enrollment.hbm.xml
15:36:25,259 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,259 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,269 INFO Binder:229 - Mapping class: edu.academyart.model.Enrollment -> enrolled
15:36:25,269 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,269 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:25,269 DEBUG Binder:475 - Mapped property: course -> courseid, type: edu.academyart.model.Course
15:36:25,279 DEBUG Binder:475 - Mapped property: enrolled -> enrolled, type: boolean
15:36:25,279 DEBUG Binder:475 - Mapped property: overriden -> override, type: boolean
15:36:25,279 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@719f1f [Attribute: name resource value "edu/academyart/model/HelpDeskEmail.hbm.xml"]
15:36:25,279 INFO Configuration:328 - Mapping resource: edu/academyart/model/HelpDeskEmail.hbm.xml
15:36:25,419 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,419 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,429 INFO Binder:229 - Mapping class: edu.academyart.model.HelpDeskEmail -> hd_email_message
15:36:25,429 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,429 DEBUG Binder:475 - Mapped property: title -> title, type: string
15:36:25,429 DEBUG Binder:475 - Mapped property: recipient -> recipient, type: string
15:36:25,429 DEBUG Binder:475 - Mapped property: subject -> subject, type: string
15:36:25,429 DEBUG Binder:475 - Mapped property: body -> body, type: string
15:36:25,439 INFO Binder:560 - Mapping collection: edu.academyart.model.HelpDeskEmail.attachments -> email_to_attachments
15:36:25,439 DEBUG Binder:475 - Mapped property: attachments, type: java.util.Set
15:36:25,439 DEBUG Binder:475 - Mapped property: template -> template, type: boolean
15:36:25,439 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@3a6e5c [Attribute: name resource value "edu/academyart/model/History.hbm.xml"]
15:36:25,439 INFO Configuration:328 - Mapping resource: edu/academyart/model/History.hbm.xml
15:36:25,459 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,459 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,489 INFO Binder:229 - Mapping class: edu.academyart.model.History -> history
15:36:25,489 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,489 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:25,489 DEBUG Binder:475 - Mapped property: topic -> topicid, type: edu.academyart.model.Topic
15:36:25,499 DEBUG Binder:475 - Mapped property: postsMade -> posts_made, type: long
15:36:25,499 DEBUG Binder:475 - Mapped property: postsViewed -> posts_viewed, type: long
15:36:25,499 DEBUG Configuration:989 - null<-org.dom4j.tree.DefaultAttribute@1d9e2c7 [Attribute: name resource value "edu/academyart/model/Image.hbm.xml"]
15:36:25,499 INFO Configuration:328 - Mapping resource: edu/academyart/model/Image.hbm.xml
15:36:25,509 INFO Configuration:347 - Mapping resource: edu/academyart/model/Assignment.hbm.xml
15:36:25,509 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,519 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,519 INFO Binder:229 - Mapping class: edu.academyart.model.Assignment -> assignment
15:36:25,519 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,519 DEBUG Binder:475 - Mapped property: course -> courseid, type: edu.academyart.model.Course
15:36:25,519 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:25,529 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,529 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:25,529 DEBUG Binder:475 - Mapped property: location -> location, type: string
15:36:25,529 DEBUG Binder:475 - Mapped property: contentType -> contentType, type: string
15:36:25,529 DEBUG Binder:475 - Mapped property: content -> dbFileId, type: edu.academyart.model.DBFile
15:36:25,529 DEBUG Binder:475 - Mapped property: isPublic -> ispublic, type: boolean
15:36:25,529 DEBUG Binder:475 - Mapped property: uploadDate -> uploaddate, type: timestamp
15:36:25,539 INFO Configuration:347 - Mapping resource: edu/academyart/model/Attachment.hbm.xml
15:36:25,539 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,539 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,549 INFO Binder:229 - Mapping class: edu.academyart.model.Attachment -> attachment
15:36:25,549 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,549 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,549 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:25,549 DEBUG Binder:475 - Mapped property: location -> location, type: string
15:36:25,549 DEBUG Binder:475 - Mapped property: contentType -> contentType, type: string
15:36:25,549 DEBUG Binder:475 - Mapped property: content -> dbFileId, type: edu.academyart.model.DBFile
15:36:25,559 DEBUG Binder:475 - Mapped property: parentId -> parentid, type: long
15:36:25,559 DEBUG Binder:475 - Mapped property: type -> type, type: long
15:36:25,559 INFO Configuration:347 - Mapping resource: edu/academyart/model/Course.hbm.xml
15:36:25,559 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,569 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,579 INFO Binder:229 - Mapping class: edu.academyart.model.Course -> course
15:36:25,579 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,579 DEBUG Binder:475 - Mapped property: semester -> semesterid, type: edu.academyart.model.Semester
15:36:25,579 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,579 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:25,579 DEBUG Binder:475 - Mapped property: startDate -> startdate, type: timestamp
15:36:25,579 DEBUG Binder:475 - Mapped property: endDate -> enddate, type: timestamp
15:36:25,589 DEBUG Binder:475 - Mapped property: inTopclass -> topclass, type: boolean
15:36:25,589 DEBUG Binder:475 - Mapped property: topclassId -> topclassid, type: long
15:36:25,589 DEBUG Binder:475 - Mapped property: assignmentUploadActive -> assignmentUploadActive, type: boolean
15:36:25,589 DEBUG Binder:475 - Mapped property: active -> active, type: boolean
15:36:25,589 DEBUG Binder:475 - Mapped property: ftpActive -> ftpActive, type: boolean
15:36:25,589 DEBUG Binder:475 - Mapped property: enrollments, type: java.util.Set
15:36:25,599 DEBUG Binder:475 - Mapped property: topics, type: java.util.Set
15:36:25,599 DEBUG Binder:475 - Mapped property: permissions, type: java.util.Set
15:36:25,599 DEBUG Binder:475 - Mapped property: grades, type: java.util.Set
15:36:25,599 DEBUG Binder:475 - Mapped property: gradeTypes, type: java.util.Set
15:36:25,599 DEBUG Binder:475 - Mapped property: assignments, type: java.util.Set
15:36:25,599 INFO Binder:560 - Mapping collection: edu.academyart.model.Course.exams -> course_to_exam
15:36:25,599 DEBUG Binder:475 - Mapped property: exams, type: java.util.Set
15:36:25,599 INFO Binder:560 - Mapping collection: edu.academyart.model.Course.examEnrollments -> exam_enrollments
15:36:25,599 DEBUG Binder:475 - Mapped property: examEnrollments, type: java.util.Set
15:36:25,599 INFO Configuration:347 - Mapping resource: edu/academyart/model/CoursePermissions.hbm.xml
15:36:25,609 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,609 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,619 INFO Binder:229 - Mapping class: edu.academyart.model.CoursePermissions -> rights
15:36:25,619 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,619 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:25,619 DEBUG Binder:475 - Mapped property: course -> courseId, type: edu.academyart.model.Course
15:36:25,619 DEBUG Binder:475 - Mapped property: student -> student, type: boolean
15:36:25,619 DEBUG Binder:475 - Mapped property: teacher -> teacher, type: boolean
15:36:25,619 DEBUG Binder:475 - Mapped property: admin -> admin, type: boolean
15:36:25,619 DEBUG Binder:475 - Mapped property: canPost -> can_post, type: boolean
15:36:25,629 DEBUG Binder:475 - Mapped property: canView -> can_view, type: boolean
15:36:25,629 INFO Configuration:347 - Mapping resource: edu/academyart/model/Department.hbm.xml
15:36:25,629 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,629 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,639 INFO Binder:229 - Mapping class: edu.academyart.model.Department -> department
15:36:25,639 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,649 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,649 DEBUG Binder:475 - Mapped property: value -> value, type: string
15:36:25,649 INFO Configuration:347 - Mapping resource: edu/academyart/model/Enrollment.hbm.xml
15:36:25,649 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,660 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,660 INFO Binder:229 - Mapping class: edu.academyart.model.Enrollment -> enrolled
15:36:25,660 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,670 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:25,670 DEBUG Binder:475 - Mapped property: course -> courseid, type: edu.academyart.model.Course
15:36:25,670 DEBUG Binder:475 - Mapped property: enrolled -> enrolled, type: boolean
15:36:25,670 DEBUG Binder:475 - Mapped property: overriden -> override, type: boolean
15:36:25,670 INFO Configuration:347 - Mapping resource: edu/academyart/model/History.hbm.xml
15:36:25,680 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,680 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,680 INFO Binder:229 - Mapping class: edu.academyart.model.History -> history
15:36:25,690 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,690 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:25,690 DEBUG Binder:475 - Mapped property: topic -> topicid, type: edu.academyart.model.Topic
15:36:25,690 DEBUG Binder:475 - Mapped property: postsMade -> posts_made, type: long
15:36:25,690 DEBUG Binder:475 - Mapped property: postsViewed -> posts_viewed, type: long
15:36:25,690 INFO Configuration:347 - Mapping resource: edu/academyart/model/Post.hbm.xml
15:36:25,740 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,740 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,750 INFO Binder:229 - Mapping class: edu.academyart.model.Post -> post
15:36:25,750 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,750 DEBUG Binder:475 - Mapped property: topic -> topicid, type: edu.academyart.model.Topic
15:36:25,750 DEBUG Binder:475 - Mapped property: parentPost -> referenceid, type: edu.academyart.model.Post
15:36:25,750 DEBUG Binder:475 - Mapped property: subject -> subject, type: string
15:36:25,750 DEBUG Binder:475 - Mapped property: message -> message, type: string
15:36:25,750 DEBUG Binder:475 - Mapped property: creator -> createdby, type: edu.academyart.model.User
15:36:25,750 DEBUG Binder:475 - Mapped property: createdDate -> createdon, type: timestamp
15:36:25,750 DEBUG Binder:475 - Mapped property: editDate -> changedon, type: timestamp
15:36:25,760 INFO Binder:560 - Mapping collection: edu.academyart.model.Post.attachments -> post_to_attachment
15:36:25,760 DEBUG Binder:475 - Mapped property: attachments, type: java.util.Set
15:36:25,780 INFO Configuration:347 - Mapping resource: edu/academyart/model/Profanity.hbm.xml
15:36:25,810 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,810 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,820 INFO Binder:229 - Mapping class: edu.academyart.model.Profanity -> profanity
15:36:25,830 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,830 DEBUG Binder:475 - Mapped property: word -> word, type: string
15:36:25,850 INFO Configuration:347 - Mapping resource: edu/academyart/model/Semester.hbm.xml
15:36:25,890 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,890 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,900 INFO Binder:229 - Mapping class: edu.academyart.model.Semester -> semester
15:36:25,900 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,900 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,900 DEBUG Binder:475 - Mapped property: archived -> archived, type: boolean
15:36:25,910 DEBUG Binder:475 - Mapped property: startDate -> startdate, type: timestamp
15:36:25,910 DEBUG Binder:475 - Mapped property: endDate -> enddate, type: timestamp
15:36:25,910 DEBUG Binder:475 - Mapped property: courses, type: java.util.Set
15:36:25,930 DEBUG Binder:475 - Mapped property: gradeDeadlines, type: java.util.Set
15:36:25,950 INFO Configuration:347 - Mapping resource: edu/academyart/model/StudentEvaluation.hbm.xml
15:36:25,970 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:25,970 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:25,980 INFO Binder:229 - Mapping class: edu.academyart.model.StudentEvaluation -> studentevaluation
15:36:25,980 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:25,980 DEBUG Binder:475 - Mapped property: course -> courseid, type: edu.academyart.model.Course
15:36:25,980 DEBUG Binder:475 - Mapped property: user -> userid, type: edu.academyart.model.User
15:36:25,980 DEBUG Binder:475 - Mapped property: isComplete -> completed, type: boolean
15:36:25,980 DEBUG Binder:475 - Mapped property: completeDate -> completedon, type: timestamp
15:36:25,980 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:25,980 DEBUG Binder:475 - Mapped property: question1 -> question1, type: long
15:36:25,980 DEBUG Binder:475 - Mapped property: question2 -> question2, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question3 -> question3, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question4 -> question4, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question5 -> question5, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question6 -> question6, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question7 -> question7, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question8 -> question8, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question9 -> question9, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question10 -> question10, type: long
15:36:25,990 DEBUG Binder:475 - Mapped property: question11 -> question11, type: string
15:36:26,000 DEBUG Binder:475 - Mapped property: question12 -> question12, type: string
15:36:26,000 DEBUG Binder:475 - Mapped property: question13 -> question13, type: string
15:36:26,000 DEBUG Binder:475 - Mapped property: question14 -> question14, type: string
15:36:26,000 INFO Configuration:347 - Mapping resource: edu/academyart/model/Topic.hbm.xml
15:36:26,020 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:26,020 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:26,050 INFO Binder:229 - Mapping class: edu.academyart.model.Topic -> topic
15:36:26,050 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:26,050 DEBUG Binder:475 - Mapped property: course -> courseid, type: edu.academyart.model.Course
15:36:26,060 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:26,060 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:26,060 DEBUG Binder:475 - Mapped property: creator -> createdby, type: edu.academyart.model.User
15:36:26,060 DEBUG Binder:475 - Mapped property: createDate -> createdon, type: timestamp
15:36:26,060 DEBUG Binder:475 - Mapped property: endDate -> endson, type: timestamp
15:36:26,060 DEBUG Binder:475 - Mapped property: archived -> archived, type: boolean
15:36:26,060 DEBUG Binder:475 - Mapped property: order -> orderNumber, type: integer
15:36:26,070 DEBUG Binder:475 - Mapped property: posts, type: java.util.Set
15:36:26,070 DEBUG Binder:475 - Mapped property: topicHistories, type: java.util.Set
15:36:26,070 INFO Binder:560 - Mapping collection: edu.academyart.model.Topic.attachments -> topic_to_attachment
15:36:26,070 DEBUG Binder:475 - Mapped property: attachments, type: java.util.Set
15:36:26,090 INFO Configuration:347 - Mapping resource: edu/academyart/model/User.hbm.xml
15:36:26,090 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:26,100 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:26,100 INFO Binder:229 - Mapping class: edu.academyart.model.User -> users
15:36:26,110 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:26,110 DEBUG Binder:475 - Mapped property: studentId -> studentId, type: string
15:36:26,140 DEBUG Binder:475 - Mapped property: profile -> profileId, type: edu.academyart.model.Profile
15:36:26,140 DEBUG Binder:475 - Mapped property: firstName -> firstname, type: string
15:36:26,140 DEBUG Binder:475 - Mapped property: middleName -> middlename, type: string
15:36:26,140 DEBUG Binder:475 - Mapped property: lastName -> lastname, type: string
15:36:26,140 DEBUG Binder:475 - Mapped property: email -> email, type: string
15:36:26,150 DEBUG Binder:475 - Mapped property: phone -> phone, type: string
15:36:26,150 DEBUG Binder:475 - Mapped property: altPhone -> altPhone, type: string
15:36:26,150 DEBUG Binder:475 - Mapped property: username -> username, type: string
15:36:26,150 DEBUG Binder:475 - Mapped property: password -> password, type: string
15:36:26,150 DEBUG Binder:475 - Mapped property: inTopclass -> topclass, type: boolean
15:36:26,150 DEBUG Binder:475 - Mapped property: topclassId -> topclassid, type: long
15:36:26,150 DEBUG Binder:475 - Mapped property: active -> active, type: boolean
15:36:26,150 DEBUG Binder:475 - Mapped property: enrollments, type: java.util.Set
15:36:26,160 DEBUG Binder:475 - Mapped property: coursePermissions, type: java.util.Set
15:36:26,160 DEBUG Binder:475 - Mapped property: topicHistories, type: java.util.Set
15:36:26,170 DEBUG Binder:475 - Mapped property: examEnrollments, type: java.util.Set
15:36:26,170 INFO Configuration:347 - Mapping resource: edu/academyart/model/GradeDeadline.hbm.xml
15:36:26,200 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:26,200 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:26,210 INFO Binder:229 - Mapping class: edu.academyart.model.GradeDeadline -> gradeDeadline
15:36:26,210 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:26,220 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:26,220 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:26,220 DEBUG Binder:475 - Mapped property: startDate -> startdate, type: timestamp
15:36:26,220 DEBUG Binder:475 - Mapped property: endDate -> enddate, type: timestamp
15:36:26,220 DEBUG Binder:475 - Mapped property: semester -> semesterId, type: edu.academyart.model.Semester
15:36:26,220 DEBUG Binder:475 - Mapped property: gradeType -> gradeTypeId, type: edu.academyart.model.GradeType
15:36:26,220 INFO Configuration:347 - Mapping resource: edu/academyart/model/GradeType.hbm.xml
15:36:26,240 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:26,240 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:26,250 INFO Binder:229 - Mapping class: edu.academyart.model.GradeType -> gradeType
15:36:26,250 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:26,250 DEBUG Binder:475 - Mapped property: date -> date, type: timestamp
15:36:26,250 DEBUG Binder:475 - Mapped property: name -> name, type: string
15:36:26,250 DEBUG Binder:475 - Mapped property: description -> description, type: string
15:36:26,250 DEBUG Binder:475 - Mapped property: weight -> weight, type: integer
15:36:26,250 DEBUG Binder:475 - Mapped property: course -> courseId, type: edu.academyart.model.Course
15:36:26,250 INFO Configuration:347 - Mapping resource: edu/academyart/model/Grade.hbm.xml
15:36:26,260 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
15:36:26,260 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
15:36:26,270 INFO Binder:229 - Mapping class: edu.academyart.model.Grade -> grade
15:36:26,270 DEBUG Binder:475 - Mapped property: id -> id, type: long
15:36:26,270 DEBUG Binder:475 - Mapped property: gradeType -> gradeTypeId, type: edu.academyart.model.GradeType
15:36:26,270 DEBUG Binder:475 - Mapped property: percentage -> percentage, type: integer
15:36:26,280 DEBUG Binder:475 - Mapped property: comments -> comments, type: string
15:36:26,280 DEBUG Binder:475 - Mapped property: referral -> referral, type: edu.academyart.model.HelpDeskEmail
15:36:26,280 DEBUG Binder:475 - Mapped property: date -> entryDate, type: timestamp
15:36:26,280 DEBUG Binder:475 - Mapped property: user -> userId, type: edu.academyart.model.User
15:36:26,280 DEBUG Binder:475 - Mapped property: course -> courseId, type: edu.academyart.model.Course
15:36:26,280 INFO Configuration:613 - processing one-to-many association mappings
15:36:26,280 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Course.enrollments
15:36:26,280 INFO Binder:1168 - Mapping collection: edu.academyart.model.Course.enrollments -> enrolled
15:36:26,290 DEBUG Binder:1355 - Mapped collection key: courseid, one-to-many: edu.academyart.model.Enrollment
15:36:26,290 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Course.topics
15:36:26,290 INFO Binder:1168 - Mapping collection: edu.academyart.model.Course.topics -> topic
15:36:26,290 DEBUG Binder:1355 - Mapped collection key: courseid, one-to-many: edu.academyart.model.Topic
15:36:26,290 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Course.permissions
15:36:26,290 INFO Binder:1168 - Mapping collection: edu.academyart.model.Course.permissions -> rights
15:36:26,290 DEBUG Binder:1355 - Mapped collection key: courseid, one-to-many: edu.academyart.model.CoursePermissions
15:36:26,290 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Course.grades
15:36:26,290 INFO Binder:1168 - Mapping collection: edu.academyart.model.Course.grades -> grade
15:36:26,300 DEBUG Binder:1355 - Mapped collection key: courseid, one-to-many: edu.academyart.model.Grade
15:36:26,300 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Course.gradeTypes
15:36:26,300 INFO Binder:1168 - Mapping collection: edu.academyart.model.Course.gradeTypes -> gradeType
15:36:26,300 DEBUG Binder:1355 - Mapped collection key: courseid, one-to-many: edu.academyart.model.GradeType
15:36:26,300 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Course.assignments
15:36:26,300 INFO Binder:1168 - Mapping collection: edu.academyart.model.Course.assignments -> assignment
15:36:26,300 DEBUG Binder:1355 - Mapped collection key: courseid, one-to-many: edu.academyart.model.Assignment
15:36:26,300 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Course.exams
15:36:26,300 DEBUG Binder:1355 - Mapped collection key: course_id, element: exam_id, type: edu.academyart.model.Exam
15:36:26,300 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Course.examEnrollments
15:36:26,310 DEBUG Binder:1355 - Mapped collection key: course_id, element: id, type: edu.academyart.model.ExamEnrollment
15:36:26,310 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Post.attachments
15:36:26,310 DEBUG Binder:1355 - Mapped collection key: postId, element: attachmentId, type: edu.academyart.model.Attachment
15:36:26,310 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Semester.courses
15:36:26,310 INFO Binder:1168 - Mapping collection: edu.academyart.model.Semester.courses -> course
15:36:26,310 DEBUG Binder:1355 - Mapped collection key: semesterid, one-to-many: edu.academyart.model.Course
15:36:26,310 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Semester.gradeDeadlines
15:36:26,310 INFO Binder:1168 - Mapping collection: edu.academyart.model.Semester.gradeDeadlines -> gradeDeadline
15:36:26,320 DEBUG Binder:1355 - Mapped collection key: semesterid, one-to-many: edu.academyart.model.GradeDeadline
15:36:26,320 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Topic.posts
15:36:26,320 INFO Binder:1168 - Mapping collection: edu.academyart.model.Topic.posts -> post
15:36:26,320 DEBUG Binder:1355 - Mapped collection key: topicId, one-to-many: edu.academyart.model.Post
15:36:26,320 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Topic.topicHistories
15:36:26,320 INFO Binder:1168 - Mapping collection: edu.academyart.model.Topic.topicHistories -> history
15:36:26,320 DEBUG Binder:1355 - Mapped collection key: topicid, one-to-many: edu.academyart.model.History
15:36:26,320 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.Topic.attachments
15:36:26,320 DEBUG Binder:1355 - Mapped collection key: topicId, element: attachmentId, type: edu.academyart.model.Attachment
15:36:26,320 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.User.enrollments
15:36:26,320 INFO Binder:1168 - Mapping collection: edu.academyart.model.User.enrollments -> enrolled
15:36:26,320 DEBUG Binder:1355 - Mapped collection key: userid, one-to-many: edu.academyart.model.Enrollment
15:36:26,330 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.User.coursePermissions
15:36:26,330 INFO Binder:1168 - Mapping collection: edu.academyart.model.User.coursePermissions -> rights
15:36:26,330 DEBUG Binder:1355 - Mapped collection key: userid, one-to-many: edu.academyart.model.CoursePermissions
15:36:26,330 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.User.topicHistories
15:36:26,330 INFO Binder:1168 - Mapping collection: edu.academyart.model.User.topicHistories -> history
15:36:26,330 DEBUG Binder:1355 - Mapped collection key: userid, one-to-many: edu.academyart.model.History
15:36:26,330 DEBUG Binder:1340 - Second pass for collection: edu.academyart.model.User.examEnrollments