I anticipated such a request ;-). Here is the server-side console trace: Apache OpenEJB 3.1.4 build: 20101112-03:32 http://openejb.apache.org/ FOO moduleName = C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar 0 cmp TRACE [main] openjpa.Runtime - Setting the following properties from "?" into configuration: {openjpa.jdbc.DBDictionary=mysql, openjpa.jdbc.SynchronizeMappings=buildSchema(ForeignKeys=true), openjpa.ConnectionFactory=org.apache.openejb.resource.jdbc.BasicManagedDataSource@1286b10, openjpa.ConnectionFactory2=org.apache.openejb.resource.jdbc.BasicDataSource@8d2280, openjpa.Log=DefaultLevel=TRACE, openjpa.MetaDataFactory=jpa(Files=/C:/Program Files/Apache/openejb-3.1.4/apps/oejb5370303094264292163/EJB_example.jar), javax.persistence.provider=org.apache.openjpa.persistence.PersistenceProviderImpl, openjpa.ConnectionFactoryMode=managed, openjpa.jdbc.TransactionIsolation=read-uncommitted, openjpa.TransactionMode=managed, openjpa.Id=cmp, openjpa.ClassResolver=org.apache.openjpa.persistence.PersistenceUnitInfoImpl$ClassResolverImpl@1f7abae} 16 cmp TRACE [main] openjpa.Runtime - No cache marshaller found for id org.apache.openjpa.conf.MetaDataCacheMaintenance. 78 cmp TRACE [main] openjpa.MetaData - Scanning jar "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" for persistent types. 94 cmp TRACE [main] openjpa.MetaData - Skipping persistent type location association for location "ejb/bo/Book.class" since it is a class, and will not need to be re-parsed later. 94 cmp TRACE [main] openjpa.MetaData - Scan of "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" found persistent types [ejb.bo.Book]. 94 cmp TRACE [main] openjpa.MetaData - Skipping persistent type location association for location "ejb/bo/Library.class" since it is a class, and will not need to be re-parsed later. 94 cmp TRACE [main] openjpa.MetaData - Scan of "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" found persistent types [ejb.bo.Library]. 94 cmp TRACE [main] openjpa.MetaData - Scanning resource "META-INF/orm.xml" for persistent types. 94 cmp TRACE [main] openjpa.MetaData - parsePersistentTypeNames() found [ejb.bo.Library, ejb.bo.Book]. 94 cmp TRACE [main] openjpa.MetaData - Found 2 classes with metadata in 16 milliseconds. 0 cmp TRACE [main] openjpa.Runtime - Setting the following properties from "?" into configuration: {openjpa.jdbc.DBDictionary=mysql, openjpa.BrokerFactory=jdbc, openjpa.ConnectionFactory2=org.apache.openejb.resource.jdbc.BasicDataSource@8d2280, openjpa.ConnectionFactory=org.apache.openejb.resource.jdbc.BasicManagedDataSource@1286b10, openjpa.MetaDataFactory=jpa(Files=/C:/Program Files/Apache/openejb-3.1.4/apps/oejb5370303094264292163/EJB_example.jar), javax.persistence.provider=org.apache.openjpa.persistence.PersistenceProviderImpl, openjpa.ConnectionFactoryMode=managed, openjpa.TransactionMode=managed, openjpa.Id=cmp, openjpa.ClassResolver=org.apache.openjpa.persistence.PersistenceUnitInfoImpl$ClassResolverImpl@1f7abae, openjpa.jdbc.SynchronizeMappings=buildSchema(ForeignKeys=true), openjpa.BrokerImpl=non-finalizing, openjpa.Log=DefaultLevel=TRACE, openjpa.jdbc.TransactionIsolation=read-uncommitted} 297 cmp TRACE [main] openjpa.Enhance - "ejb.bo.Library" requires runtime enhancement: true 375 cmp TRACE [main] openjpa.MetaData - Loading metadata for "class ejb.bo.Library" under mode "[META][QUERY]". 407 cmp TRACE [main] openjpa.MetaData - Parsing class "ejb.bo.Library". 407 cmp TRACE [main] openjpa.MetaData - Parsing package "ejb.bo.Library". 422 cmp TRACE [main] openjpa.MetaData - Generating default metadata for type "ejb.bo.Library". 422 cmp TRACE [main] openjpa.MetaData - Using reflection for metadata generation. 438 cmp TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "ejb.bo.Library" to "null". 438 cmp TRACE [main] openjpa.MetaData - Resolving metadata for "ejb.bo.Library@10131947". 438 cmp TRACE [main] openjpa.MetaData - Resolving field "[email protected]". 453 cmp TRACE [main] openjpa.MetaData - Resolving field "[email protected]". 453 cmp TRACE [main] openjpa.Enhance - Enhancing type "class ejb.bo.Library". 469 cmp WARN [main] openjpa.Enhance - The type "ejb.bo.Library" must have a no-args constructor. Adding a public no-args constructor. [init] OpenEJB Remote Server ** Starting Services ** NAME IP PORT ejbd 127.0.0.1 4203 httpejbd 127.0.0.1 4204 telnet 127.0.0.1 4202 ejbd 127.0.0.1 4201 hsql 127.0.0.1 9001 admin thread 127.0.0.1 4200 ------- Ready! 20016 cmp INFO [ejbd 0] openjpa.Runtime - Starting OpenJPA 1.2.1 20016 cmp TRACE [ejbd 0] openjpa.Runtime - Properties: openjpa.EntityManagerFactory: default openjpa.DataCache: false openjpa.MetaDataFactory: jpa(Files=/C:/Program Files/Apache/openejb-3.1.4/apps/oejb5370303094264292163/EJB_example.jar) openjpa.InverseManager: false openjpa.ReadLockLevel: read openjpa.jdbc.SubclassFetchMode: join openjpa.DataCacheManager: default openjpa.RefreshFromDataCache: false openjpa.jdbc.UpdateManager: default openjpa.jdbc.SynchronizeMappings: buildSchema(ForeignKeys=true) openjpa.NontransactionalRead: true openjpa.QueryCompilationCache: true openjpa.MaxFetchDepth: -1 openjpa.RetainState: true openjpa.jdbc.QuerySQLCache: true openjpa.DynamicDataStructs: false openjpa.BrokerFactory: jdbc openjpa.WriteLockLevel: write openjpa.ManagedRuntime: auto openjpa.jdbc.EagerFetchMode: parallel openjpa.RestoreState: immutable openjpa.jdbc.SchemaFactory: dynamic openjpa.LockManager: version openjpa.BrokerImpl: non-finalizing openjpa.NontransactionalWrite: true openjpa.MetaDataRepository: default openjpa.Log: true(DefaultLevel=TRACE) openjpa.jdbc.ResultSetType: forward-only openjpa.AutoDetach: openjpa.ConnectionRetainMode: on-demand openjpa.RuntimeUnenhancedClasses: supported openjpa.SavepointManager: in-mem openjpa.jdbc.DBDictionary: mysql openjpa.Optimistic: true openjpa.ConnectionFactoryMode: managed openjpa.Sequence: table openjpa.FetchGroups: default openjpa.jdbc.Schemas: openjpa.Id: cmp openjpa.OrphanedKeyAction: log openjpa.FlushBeforeQueries: true openjpa.AutoClear: datastore openjpa.Compatibility: default openjpa.jdbc.LRSSize: query openjpa.DetachState: loaded openjpa.Multithreaded: false openjpa.FetchBatchSize: -1 openjpa.jdbc.SQLFactory: default openjpa.IgnoreChanges: false openjpa.jdbc.MappingDefaults: jpa openjpa.TransactionMode: managed openjpa.RetryClassRegistration: false openjpa.jdbc.FetchDirection: forward openjpa.ClassResolver: org.apache.openjpa.persistence.PersistenceUnitInfoImpl$ClassResolverImpl openjpa.LockTimeout: -1 openjpa.DataCacheTimeout: -1 openjpa.QueryCache: true openjpa.jdbc.DriverDataSource: simple openjpa.jdbc.TransactionIsolation: read-uncommitted openjpa.ProxyManager: default 20031 cmp TRACE [ejbd 0] openjpa.Runtime - No cache marshaller found for id org.apache.openjpa.conf.MetaDataCacheMaintenance. 20078 cmp TRACE [ejbd 0] openjpa.MetaData - Using metadata factory "org.apache.openjpa.persistence.jdbc.PersistenceMappingFactory@1d1695e". 20109 cmp INFO [ejbd 0] openjpa.jdbc.JDBC - Using dictionary class "org.apache.openjpa.jdbc.sql.MySQLDictionary". 20594 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - catalogSeparator: . catalogTerm: database databaseProductName: MySQL databaseProductVersion: 5.1.20-beta-community-nt-debug driverName: MySQL-AB JDBC Driver driverVersion: mysql-connector-java-5.0.4 ( $Date: 2006-10-19 17:47:48 +0200 (Thu, 19 Oct 2006) $, $Revision: 5908 $ ) extraNameCharacters: #@ identifierQuoteString: ` numericFunctions: ABS,ACOS,ASIN,ATAN,ATAN2,BIT_COUNT,CEILING,COS,COT,DEGREES,EXP,FLOOR,LOG,LOG10,MAX,MIN,MOD,PI,POW,POWER,RADIANS,RAND,ROUND,SIN,SQRT,TAN,TRUNCATE procedureTerm: PROCEDURE schemaTerm: searchStringEscape: \ sqlKeywords: AUTO_INCREMENT,BINARY,BLOB,ENUM,INFILE,LOAD,MEDIUMINT,OPTION,OUTFILE,REPLACE,SET,TEXT,UNSIGNED,ZEROFILL stringFunctions: ASCII,BIN,BIT_LENGTH,CHAR,CHARACTER_LENGTH,CHAR_LENGTH,CONCAT,CONCAT_WS,CONV,ELT,EXPORT_SET,FIELD,FIND_IN_SET,HEX,INSERT,INSTR,LCASE,LEFT,LENGTH,LOAD_FILE,LOCATE,LOCATE,LOWER,LPAD,LTRIM,MAKE_SET,MATCH,MID,OCT,OCTET_LENGTH,ORD,POSITION,QUOTE,REPEAT,REPLACE,REVERSE,RIGHT,RPAD,RTRIM,SOUNDEX,SPACE,STRCMP,SUBSTRING,SUBSTRING,SUBSTRING,SUBSTRING,SUBSTRING_INDEX,TRIM,UCASE,UPPER systemFunctions: DATABASE,USER,SYSTEM_USER,SESSION_USER,PASSWORD,ENCRYPT,LAST_INSERT_ID,VERSION timeDateFunctions: DAYOFWEEK,WEEKDAY,DAYOFMONTH,DAYOFYEAR,MONTH,DAYNAME,MONTHNAME,QUARTER,WEEK,YEAR,HOUR,MINUTE,SECOND,PERIOD_ADD,PERIOD_DIFF,TO_DAYS,FROM_DAYS,DATE_FORMAT,TIME_FORMAT,CURDATE,CURRENT_DATE,CURTIME,CURRENT_TIME,NOW,SYSDATE,CURRENT_TIMESTAMP,UNIX_TIMESTAMP,FROM_UNIXTIME,SEC_TO_TIME,TIME_TO_SEC url: jdbc:mysql://localhost:3306/ejb userName: ejb@localhost defaultTransactionIsolation: 2 driverMajorVersion: 5 driverMinorVersion: 0 maxBinaryLiteralLength: 16777208 maxCatalogNameLength: 32 maxCharLiteralLength: 16777208 maxColumnNameLength: 64 maxColumnsInGroupBy: 64 maxColumnsInIndex: 16 maxColumnsInOrderBy: 64 maxColumnsInSelect: 256 maxColumnsInTable: 512 maxConnections: 0 maxCursorNameLength: 64 maxIndexLength: 256 maxProcedureNameLength: 0 maxRowSize: 2147483639 maxSchemaNameLength: 0 maxStatementLength: 65531 maxStatements: 0 maxTableNameLength: 64 maxTablesInSelect: 256 maxUserNameLength: 16 isCatalogAtStart: true isReadOnly: false nullPlusNonNullIsNull: true nullsAreSortedAtEnd: false nullsAreSortedAtStart: false nullsAreSortedHigh: false nullsAreSortedLow: true storesLowerCaseIdentifiers: true storesLowerCaseQuotedIdentifiers: true storesMixedCaseIdentifiers: false storesMixedCaseQuotedIdentifiers: false storesUpperCaseIdentifiers: false storesUpperCaseQuotedIdentifiers: true supportsAlterTableWithAddColumn: true supportsAlterTableWithDropColumn: true supportsANSI92EntryLevelSQL: true supportsANSI92FullSQL: false supportsANSI92IntermediateSQL: false supportsCatalogsInDataManipulation: true supportsCatalogsInIndexDefinitions: true supportsCatalogsInPrivilegeDefinitions: true supportsCatalogsInProcedureCalls: true supportsCatalogsInTableDefinitions: true supportsColumnAliasing: true supportsConvert: false supportsCoreSQLGrammar: true supportsCorrelatedSubqueries: true supportsDataDefinitionAndDataManipulationTransactions: false supportsDataManipulationTransactionsOnly: false supportsDifferentTableCorrelationNames: true supportsExpressionsInOrderBy: true supportsExtendedSQLGrammar: false supportsFullOuterJoins: false supportsGroupBy: true supportsGroupByBeyondSelect: true supportsGroupByUnrelated: true supportsIntegrityEnhancementFacility: false supportsLikeEscapeClause: true supportsLimitedOuterJoins: true supportsMinimumSQLGrammar: true supportsMixedCaseIdentifiers: false supportsMixedCaseQuotedIdentifiers: false supportsMultipleResultSets: false supportsMultipleTransactions: true supportsNonNullableColumns: true supportsOpenCursorsAcrossCommit: false supportsOpenCursorsAcrossRollback: false supportsOpenStatementsAcrossCommit: false supportsOpenStatementsAcrossRollback: false supportsOrderByUnrelated: false supportsOuterJoins: true supportsPositionedDelete: false supportsPositionedUpdate: false supportsSchemasInDataManipulation: false supportsSchemasInIndexDefinitions: false supportsSchemasInPrivilegeDefinitions: false supportsSchemasInProcedureCalls: false supportsSchemasInTableDefinitions: false supportsSelectForUpdate: true supportsStoredProcedures: true supportsSubqueriesInComparisons: true supportsSubqueriesInExists: true supportsSubqueriesInIns: true supportsSubqueriesInQuantifieds: true supportsTableCorrelationNames: true supportsTransactions: true supportsUnion: true supportsUnionAll: true usesLocalFilePerTable: false usesLocalFiles: false allProceduresAreCallable: false allTablesAreSelectable: false dataDefinitionCausesTransactionCommit: true dataDefinitionIgnoredInTransactions: false doesMaxRowSizeIncludeBlobs: true supportsBatchUpdates: true 20625 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - Initial connection autoCommit: false, holdability: 2, TransactionIsolation: 1 20625 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 0> [0 ms] close 20625 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - DataSource connection setAutoCommit to "false" 20781 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 0> [0 ms] close 20828 cmp TRACE [ejbd 0] openjpa.MetaData - Scanning jar "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" for persistent types. 20828 cmp TRACE [ejbd 0] openjpa.MetaData - Skipping persistent type location association for location "ejb/bo/Book.class" since it is a class, and will not need to be re-parsed later. 20828 cmp TRACE [ejbd 0] openjpa.MetaData - Scan of "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" found persistent types [ejb.bo.Book]. 20828 cmp TRACE [ejbd 0] openjpa.MetaData - Skipping persistent type location association for location "ejb/bo/Library.class" since it is a class, and will not need to be re-parsed later. 20828 cmp TRACE [ejbd 0] openjpa.MetaData - Scan of "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" found persistent types [ejb.bo.Library]. 20828 cmp TRACE [ejbd 0] openjpa.MetaData - Scanning resource "META-INF/orm.xml" for persistent types. 20828 cmp TRACE [ejbd 0] openjpa.MetaData - parsePersistentTypeNames() found [ejb.bo.Library, ejb.bo.Book]. 20828 cmp TRACE [ejbd 0] openjpa.MetaData - Found 2 classes with metadata in 0 milliseconds. 21016 cmp TRACE [ejbd 0] openjpa.Enhance - "ejb.bo.Book" requires runtime enhancement: true 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Loading metadata for "class ejb.bo.Book" under mode "[META][QUERY]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Parsing class "ejb.bo.Book". 21032 cmp TRACE [ejbd 0] openjpa.MetaData - Generating default metadata for type "ejb.bo.Book". 21032 cmp TRACE [ejbd 0] openjpa.MetaData - Using reflection for metadata generation. 21032 cmp TRACE [ejbd 0] openjpa.MetaData - Set persistence-capable superclass of "ejb.bo.Book" to "null". 21032 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving metadata for "ejb.bo.Book@22963857". 21032 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21032 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21032 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21032 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21032 cmp TRACE [ejbd 0] openjpa.Enhance - Enhancing type "class ejb.bo.Book". 20891 cmp TRACE [ejbd 0] openjpa.Runtime - No cache marshaller found for id org.apache.openjpa.conf.MetaDataCacheMaintenance. 20891 cmp TRACE [ejbd 0] openjpa.MetaData - Using metadata factory "org.apache.openjpa.persistence.jdbc.PersistenceMappingFactory@9c15d2". 20891 cmp TRACE [ejbd 0] openjpa.MetaData - Loading metadata for "class ejb.bo.Library" under mode "[META][QUERY]". 20891 cmp TRACE [ejbd 0] openjpa.MetaData - Scanning jar "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" for persistent types. 20906 cmp TRACE [ejbd 0] openjpa.MetaData - Skipping persistent type location association for location "ejb/bo/Book.class" since it is a class, and will not need to be re-parsed later. 20906 cmp TRACE [ejbd 0] openjpa.MetaData - Scan of "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" found persistent types [ejb.bo.Book]. 20906 cmp TRACE [ejbd 0] openjpa.MetaData - Skipping persistent type location association for location "ejb/bo/Library.class" since it is a class, and will not need to be re-parsed later. 20906 cmp TRACE [ejbd 0] openjpa.MetaData - Scan of "C:\Program Files\Apache\openejb-3.1.4\apps\oejb5370303094264292163\EJB_example.jar" found persistent types [ejb.bo.Library]. 20906 cmp TRACE [ejbd 0] openjpa.MetaData - Scanning resource "META-INF/orm.xml" for persistent types. 20906 cmp TRACE [ejbd 0] openjpa.MetaData - parsePersistentTypeNames() found [ejb.bo.Library, ejb.bo.Book]. 20906 cmp TRACE [ejbd 0] openjpa.MetaData - Found 2 classes with metadata in 15 milliseconds. 20938 cmp TRACE [ejbd 0] openjpa.MetaData - Parsing class "ejb.bo.Library". 20938 cmp TRACE [ejbd 0] openjpa.MetaData - Parsing package "ejb.bo.Library". 20953 cmp TRACE [ejbd 0] openjpa.MetaData - Generating default metadata for type "ejb.bo.Library". 20969 cmp TRACE [ejbd 0] openjpa.MetaData - Set persistence-capable superclass of "ejb.bo.Library" to "null". 20969 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving metadata for "ejb.bo.Library@19151089". 20969 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 20984 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 20984 cmp TRACE [ejbd 0] openjpa.MetaData - Preparing mapping for "ejb.bo.Library". 20984 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21000 cmp TRACE [ejbd 0] openjpa.MetaData - "id" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.PrimitiveFieldStrategy". 21000 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21000 cmp TRACE [ejbd 0] openjpa.MetaData - "name" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 21000 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Library<discriminator>" has mapping strategy "none". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Library<version>" has mapping strategy "none". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving mapping for "ejb.bo.Library@19151089". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Library" has mapping strategy "full". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Loading metadata for "class ejb.bo.Book" under mode "[META][QUERY]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Parsing class "ejb.bo.Book". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Generating default metadata for type "ejb.bo.Book". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Set persistence-capable superclass of "ejb.bo.Book" to "null". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving metadata for "ejb.bo.Book@14673041". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Preparing mapping for "ejb.bo.Book". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "id" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.PrimitiveFieldStrategy". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "isbn" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "libraryId" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.PrimitiveFieldStrategy". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "title" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Book<discriminator>" has mapping strategy "none". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Book<version>" has mapping strategy "none". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving mapping for "ejb.bo.Book@14673041". 21016 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Book" has mapping strategy "full". 21031 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Reading table information for schema name "null", table name "book". 21031 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 7237927> getColumns: ejb, null, book, null 21094 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Reading column information for table "book". 21094 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Found existing column "id" on table "book". 21094 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Found existing column "library_id" on table "book". 21094 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Found existing column "isbn" on table "book". 21094 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Found existing column "title" on table "book". 21094 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Found existing column "libraryId" on table "book". 21094 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Reading table information for schema name "null", table name "library". 21094 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 7237927> getColumns: ejb, null, library, null 21125 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Reading column information for table "library". 21125 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Found existing column "id" on table "library". 21125 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Found existing column "name" on table "library". 21125 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Reading sequence information for schema "null", sequence name "null". 21125 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 7237927> [0 ms] commit 21125 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 0> [0 ms] close 21125 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Reading foreign keys for schema name "null", table name "book". 21125 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 7237927> getImportedKeys: ejb, null, book 21125 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Found existing foreign key "FK_books_1" on table "book (library_id)" linking to table "library (id)". Sequence: "1". 21125 cmp TRACE [ejbd 0] openjpa.jdbc.Schema - Reading foreign keys for schema name "null", table name "library". 21125 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 7237927> getImportedKeys: ejb, null, library 21125 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 7237927> [0 ms] commit 21125 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 0> [0 ms] close 21125 cmp WARN [ejbd 0] openjpa.jdbc.Schema - Existing column "isbn" on table "book" is incompatible with the same column in the given schema definition. Existing column: Full Name: book.isbn Type: varchar Size: 32 Default: null Not Null: true Given column: Full Name: book.isbn Type: varchar Size: 255 Default: null Not Null: false
21141 cmp WARN [ejbd 0] openjpa.jdbc.Schema - Existing column "title" on table "book" is incompatible with the same column in the given schema definition. Existing column: Full Name: book.title Type: varchar Size: 128 Default: null Not Null: true Given column: Full Name: book.title Type: varchar Size: 255 Default: null Not Null: false 21141 cmp WARN [ejbd 0] openjpa.jdbc.Schema - Existing column "name" on table "library" is incompatible with the same column in the given schema definition. Existing column: Full Name: library.name Type: varchar Size: 64 Default: null Not Null: true Given column: Full Name: library.name Type: varchar Size: 255 Default: null Not Null: false 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Loading metadata for "class ejb.bo.Library" under mode "[META][QUERY]". 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Parsing class "ejb.bo.Library". 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Parsing package "ejb.bo.Library". 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Generating default metadata for type "ejb.bo.Library". 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Set persistence-capable superclass of "ejb.bo.Library" to "null". 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving metadata for "ejb.bo.Library@10330589". 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21203 cmp TRACE [ejbd 0] openjpa.MetaData - Preparing mapping for "ejb.bo.Library". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - Processing registered persistence-capable class "class ejb.bo.Book". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - Processing registered persistence-capable class "class ejb.bo.Library". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - "id" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.PrimitiveFieldStrategy". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - "name" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Library<discriminator>" has mapping strategy "none". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Library<version>" has mapping strategy "none". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving mapping for "ejb.bo.Library@10330589". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - "ejb.bo.Library" has mapping strategy "full". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - Initializing mapping for "ejb.bo.Library@10330589". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21219 cmp TRACE [ejbd 0] openjpa.MetaData - Resolving field "[email protected]". 21266 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - The batch limit is set to 0. 21297 cmp TRACE [ejbd 0] openjpa.jdbc.SQL - <t 28277251, conn 0> executing prepstmnt 23970790 INSERT INTO library (name) VALUES (?) [params=(String) Best Library In Town] 21297 cmp TRACE [ejbd 0] openjpa.jdbc.SQL - <t 28277251, conn 0> [0 ms] spent 21313 cmp TRACE [ejbd 0] openjpa.jdbc.SQL - <t 28277251, conn 0> executing prepstmnt 12224239 SELECT LAST_INSERT_ID() 21313 cmp TRACE [ejbd 0] openjpa.jdbc.SQL - <t 28277251, conn 0> [0 ms] spent 21313 cmp TRACE [ejbd 0] openjpa.Runtime - An exception occurred while ending the transaction. This exception will be re-thrown. <openjpa-1.2.1-r752877:753278 nonfatal store error> org.apache.openjpa.util.OptimisticException: Optimistic locking errors were detected when flushing to the data store. The following objects may have been concurrently modified in another transaction: [ejb.bo.Library@2d150f] at org.apache.openjpa.kernel.BrokerImpl.newFlushException(BrokerImpl.java:2160) at org.apache.openjpa.kernel.BrokerImpl.flush(BrokerImpl.java:2010) at org.apache.openjpa.kernel.BrokerImpl.flushSafe(BrokerImpl.java:1908) at org.apache.openjpa.kernel.BrokerImpl.beforeCompletion(BrokerImpl.java:1826) at org.apache.geronimo.transaction.manager.TransactionImpl.beforeCompletion(TransactionImpl.java:514) at org.apache.geronimo.transaction.manager.TransactionImpl.beforeCompletion(TransactionImpl.java:499) at org.apache.geronimo.transaction.manager.TransactionImpl.beforePrepare(TransactionImpl.java:400) at org.apache.geronimo.transaction.manager.TransactionImpl.commit(TransactionImpl.java:257) at org.apache.geronimo.transaction.manager.TransactionManagerImpl.commit(TransactionManagerImpl.java:245) at org.apache.openejb.core.transaction.JtaTransactionPolicy.completeTransaction(JtaTransactionPolicy.java:291) at org.apache.openejb.core.transaction.TxRequired.commit(TxRequired.java:75) at org.apache.openejb.core.transaction.EjbTransactionUtil.afterInvoke(EjbTransactionUtil.java:74) at org.apache.openejb.core.stateless.StatelessContainer._invoke(StatelessContainer.java:241) at org.apache.openejb.core.stateless.StatelessContainer.invoke(StatelessContainer.java:174) at org.apache.openejb.core.stateless.StatelessContainer.invoke(StatelessContainer.java:136) at org.apache.openejb.server.ejbd.EjbRequestHandler.doEjbObject_BUSINESS_METHOD(EjbRequestHandler.java:238) at org.apache.openejb.server.ejbd.EjbRequestHandler.processRequest(EjbRequestHandler.java:129) at org.apache.openejb.server.ejbd.EjbDaemon.processEjbRequest(EjbDaemon.java:196) at org.apache.openejb.server.ejbd.EjbDaemon.service(EjbDaemon.java:149) at org.apache.openejb.server.ejbd.EjbServer.service(EjbServer.java:71) at org.apache.openejb.server.ejbd.KeepAliveServer$Session.service(KeepAliveServer.java:213) at org.apache.openejb.server.ejbd.KeepAliveServer.service(KeepAliveServer.java:233) at org.apache.openejb.server.ejbd.EjbServer.service(EjbServer.java:66) at org.apache.openejb.server.ServicePool$2.run(ServicePool.java:91) at org.apache.openejb.server.ServicePool$3.run(ServicePool.java:120) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675) at java.lang.Thread.run(Thread.java:595) Caused by: <openjpa-1.2.1-r752877:753278 nonfatal store error> org.apache.openjpa.util.OptimisticException: An optimistic lock violation was detected when flushing object instance "ejb.bo.Library@2d150f" to the data store. This indicates that the object was concurrently modified in another transaction. FailedObject: ejb.bo.Library@2d150f at org.apache.openjpa.jdbc.kernel.PreparedStatementManagerImpl.flushAndUpdate(PreparedStatementManagerImpl.java:124) at org.apache.openjpa.jdbc.kernel.BatchingPreparedStatementManagerImpl.flushAndUpdate(BatchingPreparedStatementManagerImpl.java:82) at org.apache.openjpa.jdbc.kernel.PreparedStatementManagerImpl.flushInternal(PreparedStatementManagerImpl.java:89) at org.apache.openjpa.jdbc.kernel.PreparedStatementManagerImpl.flush(PreparedStatementManagerImpl.java:72) at org.apache.openjpa.jdbc.kernel.ConstraintUpdateManager.flush(ConstraintUpdateManager.java:543) at org.apache.openjpa.jdbc.kernel.ConstraintUpdateManager.flush(ConstraintUpdateManager.java:105) at org.apache.openjpa.jdbc.kernel.BatchingConstraintUpdateManager.flush(BatchingConstraintUpdateManager.java:59) at org.apache.openjpa.jdbc.kernel.AbstractUpdateManager.flush(AbstractUpdateManager.java:89) at org.apache.openjpa.jdbc.kernel.AbstractUpdateManager.flush(AbstractUpdateManager.java:72) at org.apache.openjpa.jdbc.kernel.JDBCStoreManager.flush(JDBCStoreManager.java:717) at org.apache.openjpa.kernel.DelegatingStoreManager.flush(DelegatingStoreManager.java:130) ... 27 more 21609 cmp TRACE [ejbd 0] openjpa.jdbc.JDBC - <t 28277251, conn 0> [0 ms] close -- View this message in context: http://openejb.979440.n4.nabble.com/Newbie-troubles-attempting-CMP-entity-insert-tp3297911p3298049.html Sent from the OpenEJB Dev mailing list archive at Nabble.com.
