[ https://issues.apache.org/jira/browse/OPENJPA-1812?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12913976#action_12913976 ]
Willis Blackburn commented on OPENJPA-1812: ------------------------------------------- Log from the run: /System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/bin/java -javaagent:/Users/wboyce/.m2/repository/org/apache/openjpa/openjpa/2.0.1/openjpa-2.0.1.jar -Dfile.encoding=MacRoman -classpath /System/Library/Frameworks/JavaVM.framework/Versions/A/Resources/Deploy.bundle/Contents/Resources/Java/deploy.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/dt.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/javaws.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/jce.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/management-agent.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/plugin.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/sa-jdi.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/alt-rt.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/charsets.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/classes.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/jconsole.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/jsse.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/ui.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/ext/apple_provider.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/ext/dnsns.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/ext/localedata.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/ext/sunjce_provider.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/ext/sunpkcs11.jar:/Users/wboyce/git/openjpatest/target/classes:/Users/wboyce/.m2/repository/org/apache/openjpa/openjpa/2.0.1/openjpa-2.0.1.jar:/Users/wboyce/.m2/repository/commons-lang/commons-lang/2.1/commons-lang-2.1.jar:/Users/wboyce/.m2/repository/commons-collections/commons-collections/3.2.1/commons-collections-3.2.1.jar:/Users/wboyce/.m2/repository/net/sourceforge/serp/serp/1.13.1/serp-1.13.1.jar:/Users/wboyce/.m2/repository/junit/junit/3.8.1/junit-3.8.1.jar:/Users/wboyce/.m2/repository/org/apache/geronimo/specs/geronimo-jms_1.1_spec/1.1.1/geronimo-jms_1.1_spec-1.1.1.jar:/Users/wboyce/.m2/repository/org/apache/geronimo/specs/geronimo-jta_1.1_spec/1.1.1/geronimo-jta_1.1_spec-1.1.1.jar:/Users/wboyce/.m2/repository/commons-pool/commons-pool/1.5.3/commons-pool-1.5.3.jar:/Users/wboyce/.m2/repository/org/apache/geronimo/specs/geronimo-jpa_2.0_spec/1.1/geronimo-jpa_2.0_spec-1.1.jar:/Users/wboyce/.m2/repository/com/h2database/h2/1.2.143/h2-1.2.143.jar openjpatest.Main 6 db TRACE [main] openjpa.Runtime - Setting the following properties from "file:/Users/wboyce/git/openjpatest/target/classes/META-INF/persistence.xml" into configuration: {openjpa.jdbc.SynchronizeMappings=buildSchema(foreignKeys=true), openjpa.ConnectionDriverName=org.h2.Driver, javax.persistence.provider=org.apache.openjpa.persistence.PersistenceProviderImpl, openjpa.MetaDataFactory=jpa(Types=openjpatest.AddressBook;openjpatest.EmailAddress;openjpatest.Group;openjpatest.HostName;openjpatest.Organization), openjpa.Log=DefaultLevel=TRACE, PersistenceVersion=2.0, openjpa.ConnectionURL=jdbc:h2:mem:test, openjpa.Id=db} 83 db TRACE [main] openjpa.Runtime - No cache marshaller found for id org.apache.openjpa.conf.MetaDataCacheMaintenance. 136 db TRACE [main] openjpa.Runtime - No cache marshaller found for id org.apache.openjpa.conf.MetaDataCacheMaintenance. 144 db TRACE [main] openjpa.MetaData - Scanning resource "META-INF/orm.xml" for persistent types. 145 db TRACE [main] openjpa.MetaData - The persistent unit root url is "null" 146 db TRACE [main] openjpa.MetaData - parsePersistentTypeNames() found [openjpatest.Group, openjpatest.Organization, openjpatest.EmailAddress, openjpatest.HostName, openjpatest.AddressBook]. 146 db TRACE [main] openjpa.MetaData - Found 5 classes with metadata in 9 milliseconds. 148 db TRACE [main] openjpa.MetaData - Clearing metadata repository "org.apache.openjpa.meta.metadatareposit...@403ef810". 0 db TRACE [main] openjpa.Runtime - Setting the following properties from "file:/Users/wboyce/git/openjpatest/target/classes/META-INF/persistence.xml" into configuration: {openjpa.BrokerFactory=jdbc, openjpa.jdbc.SynchronizeMappings=buildSchema(foreignKeys=true), openjpa.ConnectionDriverName=org.h2.Driver, javax.persistence.provider=org.apache.openjpa.persistence.PersistenceProviderImpl, openjpa.MetaDataFactory=jpa(Types=openjpatest.AddressBook;openjpatest.EmailAddress;openjpatest.Group;openjpatest.HostName;openjpatest.Organization), openjpa.Log=DefaultLevel=TRACE, PersistenceVersion=2.0, openjpa.ConnectionURL=jdbc:h2:mem:test, openjpa.Id=db} 35 db TRACE [main] openjpa.Runtime - Trying to load javax.validation APIs based on the ValidationMode=AUTO 39 db TRACE [main] openjpa.Runtime - Could not create the optional validation provider. Reason returned: "No available javax.validation APIs" 77 db INFO [main] openjpa.Runtime - Starting OpenJPA 2.0.1 79 db TRACE [main] openjpa.Runtime - Properties: javax.persistence.lock.timeout: 0 javax.persistence.query.timeout: 0 javax.persistence.sharedCache.mode: UNSPECIFIED javax.persistence.validation.group.pre-persist: javax.validation.groups.Default javax.persistence.validation.group.pre-update: javax.validation.groups.Default openjpa.AutoClear: 0 openjpa.AutoDetach: [Ljava.lang.String;@73da669c openjpa.BrokerFactory: jdbc openjpa.BrokerImpl: default openjpa.CacheDistributionPolicy: default openjpa.Callbacks: default openjpa.ClassResolver: default openjpa.Compatibility: default openjpa.ConnectionDriverName: org.h2.Driver openjpa.ConnectionFactoryMode: false openjpa.ConnectionRetainMode: 0 openjpa.ConnectionURL: jdbc:h2:mem:test openjpa.DataCache: false openjpa.DataCacheManager: default openjpa.DataCacheTimeout: -1 openjpa.DetachState: loaded openjpa.DynamicDataStructs: false openjpa.DynamicEnhancementAgent: true openjpa.EntityManagerFactory: default openjpa.FetchBatchSize: -1 openjpa.FetchGroups: [Ljava.lang.String;@786c730 openjpa.FlushBeforeQueries: 0 openjpa.Id: db openjpa.IgnoreChanges: false openjpa.InitializeEagerly: false openjpa.InverseManager: false openjpa.LifecycleEventManager: default openjpa.LockManager: mixed openjpa.Log: true(DefaultLevel=TRACE) openjpa.ManagedRuntime: auto openjpa.MaxFetchDepth: -1 openjpa.MetaDataFactory: jpa(Types=openjpatest.AddressBook;openjpatest.EmailAddress;openjpatest.Group;openjpatest.HostName;openjpatest.Organization) openjpa.MetaDataRepository: default openjpa.Multithreaded: false openjpa.NontransactionalRead: true openjpa.NontransactionalWrite: true openjpa.Optimistic: true openjpa.OrphanedKeyAction: log openjpa.ProxyManager: default openjpa.QueryCache: false openjpa.QueryCompilationCache: true openjpa.ReadLockLevel: 10 openjpa.RefreshFromDataCache: false openjpa.RestoreState: 1 openjpa.RetainState: true openjpa.RetryClassRegistration: false openjpa.RuntimeUnenhancedClasses: 1 openjpa.SavepointManager: in-mem openjpa.Sequence: table openjpa.TransactionMode: false openjpa.WriteLockLevel: 20 openjpa.jdbc.DriverDataSource: simple openjpa.jdbc.EagerFetchMode: 2 openjpa.jdbc.FetchDirection: 1000 openjpa.jdbc.FinderCache: true openjpa.jdbc.IdentifierUtil: default openjpa.jdbc.LRSSize: 2 openjpa.jdbc.MappingDefaults: jpa openjpa.jdbc.QuerySQLCache: true openjpa.jdbc.ResultSetType: 1003 openjpa.jdbc.SQLFactory: default openjpa.jdbc.SchemaFactory: dynamic openjpa.jdbc.Schemas: [Ljava.lang.String;@73da669c openjpa.jdbc.SubclassFetchMode: 1 openjpa.jdbc.SynchronizeMappings: buildSchema(foreignKeys=true) openjpa.jdbc.TransactionIsolation: -1 openjpa.jdbc.UpdateManager: default 80 db TRACE [main] openjpa.Runtime - No cache marshaller found for id org.apache.openjpa.conf.MetaDataCacheMaintenance. 113 db TRACE [main] openjpa.MetaData - Using metadata factory "org.apache.openjpa.persistence.jdbc.persistencemappingfact...@1d766806". 141 db INFO [main] openjpa.jdbc.JDBC - Using dictionary class "org.apache.openjpa.jdbc.sql.H2Dictionary". 220 db TRACE [main] openjpa.jdbc.JDBC - createConnectionFactory: datasource=org.apache.openjpa.jdbc.schema.simpledriverdatasour...@26659db7 268 db TRACE [main] openjpa.jdbc.JDBC - DataSource connection setAutoCommit to "true" 472 db TRACE [main] openjpa.jdbc.JDBC - catalogSeparator: . catalogTerm: catalog databaseProductName: H2 databaseProductVersion: 1.2.143 (2010-09-18) driverName: H2 JDBC Driver driverVersion: 1.2.143 (2010-09-18) extraNameCharacters: identifierQuoteString: " numericFunctions: ABS,ACOS,ASIN,ATAN,COS,COT,SIN,TAN,ATAN2,BITAND,BITOR,BITXOR,MOD,CEILING,DEGREES,EXP,FLOOR,LOG,LOG10,RADIANS,SQRT,PI,POWER,RAND,RANDOM_UUID,ROUND,ROUNDMAGIC,SECURE_RAND,SIGN,ENCRYPT,DECRYPT,HASH,TRUNCATE,COMPRESS,EXPAND,ZERO procedureTerm: procedure schemaTerm: schema searchStringEscape: \ sqlKeywords: LIMIT,MINUS,ROWNUM,SYSDATE,SYSTIME,SYSTIMESTAMP,TODAY stringFunctions: ASCII,BIT_LENGTH,LENGTH,OCTET_LENGTH,CHAR,CONCAT,DIFFERENCE,HEXTORAW,RAWTOHEX,INSTR,INSERT,LOWER,UPPER,LEFT,RIGHT,LOCATE,POSITION,LPAD,RPAD,LTRIM,RTRIM,TRIM,REGEXP_REPLACE,REPEAT,REPLACE,SOUNDEX,SPACE,STRINGDECODE,STRINGENCODE,STRINGTOUTF8,SUBSTRING,UTF8TOSTRING,XMLATTR,XMLNODE,XMLCOMMENT,XMLCDATA,XMLSTARTDOC,XMLTEXT systemFunctions: ARRAY_GET,ARRAY_LENGTH,AUTOCOMMIT,CANCEL_SESSION,CASEWHEN,CAST,COALESCE,CONVERT,CURRVAL,CSVREAD,CSVWRITE,DATABASE,DATABASE_PATH,FILE_READ,GREATEST,IDENTITY,IFNULL,LEAST,LOCK_MODE,LOCK_TIMEOUT,LINK_SCHEMA,MEMORY_FREE,MEMORY_USED,NEXTVAL,NULLIF,READONLY,ROWNUM,SCHEMA,SCOPE_IDENTITY,SESSION_ID,SET,TABLE,TRANSACTION_ID,USER timeDateFunctions: CURRENT_DATE,CURRENT_TIME,CURRENT_TIMESTAMP,DATEADD,DATEDIFF,DAYNAME,DAY_OF_MONTH,DAY_OF_WEEK,DAY_OF_YEAR,EXTRACT,FORMATDATETIME,HOUR,MINUTE,MONTH,MONTHNAME,PARSEDATETIME,QUARTER,SECOND,WEEK,YEAR url: jdbc:h2:mem:test userName: defaultTransactionIsolation: 2 driverMajorVersion: 1 driverMinorVersion: 2 maxBinaryLiteralLength: 0 maxCatalogNameLength: 0 maxCharLiteralLength: 0 maxColumnNameLength: 0 maxColumnsInGroupBy: 0 maxColumnsInIndex: 0 maxColumnsInOrderBy: 0 maxColumnsInSelect: 0 maxColumnsInTable: 0 maxConnections: 0 maxCursorNameLength: 0 maxIndexLength: 0 maxProcedureNameLength: 0 maxRowSize: 0 maxSchemaNameLength: 0 maxStatementLength: 0 maxStatements: 0 maxTableNameLength: 0 maxTablesInSelect: 0 maxUserNameLength: 0 isCatalogAtStart: true isReadOnly: false nullPlusNonNullIsNull: true nullsAreSortedAtEnd: false nullsAreSortedAtStart: false nullsAreSortedHigh: false nullsAreSortedLow: true storesLowerCaseIdentifiers: false storesLowerCaseQuotedIdentifiers: false storesMixedCaseIdentifiers: false storesMixedCaseQuotedIdentifiers: true storesUpperCaseIdentifiers: true storesUpperCaseQuotedIdentifiers: false supportsAlterTableWithAddColumn: true supportsAlterTableWithDropColumn: true supportsANSI92EntryLevelSQL: true supportsANSI92FullSQL: false supportsANSI92IntermediateSQL: false supportsCatalogsInDataManipulation: true supportsCatalogsInIndexDefinitions: true supportsCatalogsInPrivilegeDefinitions: true supportsCatalogsInProcedureCalls: false supportsCatalogsInTableDefinitions: true supportsColumnAliasing: true supportsConvert: true supportsCoreSQLGrammar: true supportsCorrelatedSubqueries: true supportsDataDefinitionAndDataManipulationTransactions: false supportsDataManipulationTransactionsOnly: true supportsDifferentTableCorrelationNames: false supportsExpressionsInOrderBy: true supportsExtendedSQLGrammar: false supportsFullOuterJoins: false supportsGroupBy: true supportsGroupByBeyondSelect: true supportsGroupByUnrelated: true supportsIntegrityEnhancementFacility: true supportsLikeEscapeClause: true supportsLimitedOuterJoins: true supportsMinimumSQLGrammar: true supportsMixedCaseIdentifiers: false supportsMixedCaseQuotedIdentifiers: true supportsMultipleResultSets: false supportsMultipleTransactions: true supportsNonNullableColumns: true supportsOpenCursorsAcrossCommit: false supportsOpenCursorsAcrossRollback: false supportsOpenStatementsAcrossCommit: true supportsOpenStatementsAcrossRollback: true supportsOrderByUnrelated: true supportsOuterJoins: true supportsPositionedDelete: true supportsPositionedUpdate: true supportsSchemasInDataManipulation: true supportsSchemasInIndexDefinitions: true supportsSchemasInPrivilegeDefinitions: true supportsSchemasInProcedureCalls: true supportsSchemasInTableDefinitions: true supportsSelectForUpdate: true supportsStoredProcedures: false supportsSubqueriesInComparisons: true supportsSubqueriesInExists: true supportsSubqueriesInIns: true supportsSubqueriesInQuantifieds: true supportsTableCorrelationNames: true supportsTransactions: true supportsUnion: true supportsUnionAll: true usesLocalFilePerTable: false usesLocalFiles: true allProceduresAreCallable: true allTablesAreSelectable: true dataDefinitionCausesTransactionCommit: true dataDefinitionIgnoredInTransactions: false doesMaxRowSizeIncludeBlobs: false supportsBatchUpdates: true 475 db TRACE [main] openjpa.jdbc.JDBC - Initial connection autoCommit: true, holdability: 1, TransactionIsolation: 2 477 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 601903402> [1 ms] close 503 db TRACE [main] openjpa.MetaData - Scanning resource "META-INF/orm.xml" for persistent types. 503 db TRACE [main] openjpa.MetaData - The persistent unit root url is "null" 503 db TRACE [main] openjpa.MetaData - parsePersistentTypeNames() found [openjpatest.Group, openjpatest.Organization, openjpatest.EmailAddress, openjpatest.HostName, openjpatest.AddressBook]. 503 db TRACE [main] openjpa.MetaData - Found 5 classes with metadata in 0 milliseconds. 737 db TRACE [main] openjpa.Enhance - "openjpatest/Group" requires runtime enhancement: true 765 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.Group" under mode "[META][QUERY]". 779 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.Group". 779 db TRACE [main] openjpa.MetaData - Parsing package "openjpatest.Group". 808 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.Group". 808 db TRACE [main] openjpa.MetaData - Using reflection for metadata generation. 841 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.Group" to "null". 842 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.gr...@1573788650". 842 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@1573788650.id". 848 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@1573788650.name". 848 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@1573788650.organization". 848 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.Organization" under mode "[META][QUERY]". 848 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.Organization". 848 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.Organization". 849 db TRACE [main] openjpa.MetaData - Using reflection for metadata generation. 856 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.HostName". 856 db TRACE [main] openjpa.MetaData - Using reflection for metadata generation. 856 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.Organization" to "null". 856 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@1573788650.version". 857 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.organizat...@925668695". 857 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@925668695.addressbook". 857 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.AddressBook" under mode "[META][QUERY]". 857 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.AddressBook". 858 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.AddressBook". 858 db TRACE [main] openjpa.MetaData - Using reflection for metadata generation. 861 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.EmailAddress". 861 db TRACE [main] openjpa.MetaData - Using reflection for metadata generation. 861 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.AddressBook" to "null". 861 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@925668695.hostnames". 861 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.HostName" under mode "[META][QUERY]". 861 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.HostName". 861 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.HostName". 861 db TRACE [main] openjpa.MetaData - Using reflection for metadata generation. 862 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.HostName" to "null". 862 db TRACE [main] openjpa.MetaData - Resolving embedded metadata for "openjpatest.hostn...@846275759". 862 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.HostName" to "null". 862 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.hostn...@572487432". 862 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.hostn...@572487432.name". 862 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.hostn...@846275759.name". 862 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@925668695.id". 862 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@925668695.name". 862 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@925668695.version". 862 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.addressb...@1069531064". 862 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.addressb...@1069531064.id". 862 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.addressb...@1069531064.primaryemailaddress". 862 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.EmailAddress" under mode "[META][QUERY]". 863 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.EmailAddress". 863 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.EmailAddress". 863 db TRACE [main] openjpa.MetaData - Using reflection for metadata generation. 863 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.EmailAddress" to "null". 863 db TRACE [main] openjpa.MetaData - Resolving embedded metadata for "openjpatest.emailaddr...@1170467258". 863 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.EmailAddress" to "null". 863 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.emailaddr...@1092998686". 863 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.emailaddr...@1092998686.email". 864 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.emailaddr...@1170467258.email". 864 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.Group". 864 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.Organization". 864 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.AddressBook". 864 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.EmailAddress". 864 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.HostName". 864 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.gr...@1573788650". 865 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.organizat...@925668695". 865 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.addressb...@1069531064". 865 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.emailaddr...@1092998686". 865 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.hostn...@572487432". 865 db TRACE [main] openjpa.Enhance - Enhancing type "class openjpatest.Group" loaded by org.apache.openjpa.lib.util.temporaryclassloa...@20f8395f. 893 db TRACE [main] openjpa.Enhance - "openjpatest/Organization" requires runtime enhancement: true 896 db TRACE [main] openjpa.Enhance - Enhancing type "class openjpatest.Organization" loaded by org.apache.openjpa.lib.util.temporaryclassloa...@20f8395f. 916 db TRACE [main] openjpa.Enhance - "openjpatest/AddressBook" requires runtime enhancement: true 917 db TRACE [main] openjpa.Enhance - Enhancing type "class openjpatest.AddressBook" loaded by org.apache.openjpa.lib.util.temporaryclassloa...@20f8395f. 932 db TRACE [main] openjpa.Enhance - "openjpatest/EmailAddress" requires runtime enhancement: true 934 db TRACE [main] openjpa.Enhance - Enhancing type "class openjpatest.EmailAddress" loaded by org.apache.openjpa.lib.util.temporaryclassloa...@20f8395f. 1043 db TRACE [main] openjpa.Enhance - "openjpatest/HostName" requires runtime enhancement: true 1044 db TRACE [main] openjpa.Enhance - Enhancing type "class openjpatest.HostName" loaded by org.apache.openjpa.lib.util.temporaryclassloa...@20f8395f. 834 db TRACE [main] openjpa.Runtime - No cache marshaller found for id org.apache.openjpa.conf.MetaDataCacheMaintenance. 834 db TRACE [main] openjpa.MetaData - Using metadata factory "org.apache.openjpa.persistence.jdbc.persistencemappingfact...@739abd2b". 835 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.Group" under mode "[META][QUERY]". 835 db TRACE [main] openjpa.MetaData - Scanning resource "META-INF/orm.xml" for persistent types. 835 db TRACE [main] openjpa.MetaData - The persistent unit root url is "null" 835 db TRACE [main] openjpa.MetaData - parsePersistentTypeNames() found [openjpatest.Group, openjpatest.Organization, openjpatest.EmailAddress, openjpatest.HostName, openjpatest.AddressBook]. 835 db TRACE [main] openjpa.MetaData - Found 5 classes with metadata in 0 milliseconds. 862 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.Group". 862 db TRACE [main] openjpa.MetaData - Parsing package "openjpatest.Group". 872 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.Group". 886 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.Group" to "null". 886 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.gr...@989279323". 886 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@989279323.id". 886 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@989279323.name". 886 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@989279323.organization". 886 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.Organization" under mode "[META][QUERY]". 886 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.Organization". 886 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.Organization". 889 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.HostName". 890 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.Organization" to "null". 890 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@989279323.version". 890 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.organizat...@999186587". 890 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.addressbook". 890 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.AddressBook" under mode "[META][QUERY]". 890 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.AddressBook". 890 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.AddressBook". 893 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.EmailAddress". 893 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.AddressBook" to "null". 893 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.hostnames". 893 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.HostName" under mode "[META][QUERY]". 894 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.HostName". 894 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.HostName". 895 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.HostName" to "null". 895 db TRACE [main] openjpa.MetaData - Resolving embedded metadata for "openjpatest.hostn...@6848169". 895 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.HostName" to "null". 895 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.hostn...@1280543092". 895 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.hostn...@1280543092.name". 895 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.hostn...@6848169.name". 895 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.id". 895 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.name". 895 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.version". 896 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.addressb...@6637010". 896 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.addressb...@6637010.id". 896 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.addressb...@6637010.primaryemailaddress". 896 db TRACE [main] openjpa.MetaData - Loading metadata for "class openjpatest.EmailAddress" under mode "[META][QUERY]". 896 db TRACE [main] openjpa.MetaData - Parsing class "openjpatest.EmailAddress". 896 db TRACE [main] openjpa.MetaData - Generating default metadata for type "openjpatest.EmailAddress". 897 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.EmailAddress" to "null". 897 db TRACE [main] openjpa.MetaData - Resolving embedded metadata for "openjpatest.emailaddr...@2026561073". 897 db TRACE [main] openjpa.MetaData - Set persistence-capable superclass of "openjpatest.EmailAddress" to "null". 897 db TRACE [main] openjpa.MetaData - Resolving metadata for "openjpatest.emailaddr...@1321312491". 897 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.emailaddr...@1321312491.email". 897 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.emailaddr...@2026561073.email". 897 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.Group". 900 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@989279323.id". 905 db TRACE [main] openjpa.MetaData - "id" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 906 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@989279323.name". 906 db TRACE [main] openjpa.MetaData - "name" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 906 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@989279323.version". 906 db TRACE [main] openjpa.MetaData - "version" has mapping strategy "none". 909 db TRACE [main] openjpa.MetaData - "openjpatest.Group<discriminator>" has mapping strategy "value-map". 911 db TRACE [main] openjpa.MetaData - "openjpatest.Group<version>" has mapping strategy "version-number". 911 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.Organization". 911 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.id". 911 db TRACE [main] openjpa.MetaData - "id" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 911 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.name". 911 db TRACE [main] openjpa.MetaData - "name" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 911 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.version". 912 db TRACE [main] openjpa.MetaData - "version" has mapping strategy "none". 912 db TRACE [main] openjpa.MetaData - "openjpatest.Organization<discriminator>" has mapping strategy "value-map". 912 db TRACE [main] openjpa.MetaData - "openjpatest.Organization<version>" has mapping strategy "version-number". 912 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.AddressBook". 912 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.addressb...@6637010.id". 912 db TRACE [main] openjpa.MetaData - "id" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 913 db TRACE [main] openjpa.MetaData - "openjpatest.AddressBook<discriminator>" has mapping strategy "value-map". 913 db TRACE [main] openjpa.MetaData - "openjpatest.AddressBook<version>" has mapping strategy "none". 913 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.EmailAddress". 913 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.emailaddr...@1321312491.email". 913 db TRACE [main] openjpa.MetaData - "email" has mapping strategy "none". 913 db TRACE [main] openjpa.MetaData - "openjpatest.EmailAddress<discriminator>" has mapping strategy "none". 914 db TRACE [main] openjpa.MetaData - "openjpatest.EmailAddress<version>" has mapping strategy "none". 914 db TRACE [main] openjpa.MetaData - Preparing mapping for "openjpatest.HostName". 914 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.hostn...@1280543092.name". 914 db TRACE [main] openjpa.MetaData - "name" has mapping strategy "none". 914 db TRACE [main] openjpa.MetaData - "openjpatest.HostName<discriminator>" has mapping strategy "none". 914 db TRACE [main] openjpa.MetaData - "openjpatest.HostName<version>" has mapping strategy "none". 914 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.gr...@989279323". 914 db TRACE [main] openjpa.MetaData - "openjpatest.Group" has mapping strategy "full". 914 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.gr...@989279323.organization". 920 db TRACE [main] openjpa.MetaData - "organization" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.RelationFieldStrategy". 920 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.organizat...@999186587". 920 db TRACE [main] openjpa.MetaData - "openjpatest.Organization" has mapping strategy "full". 920 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.addressbook". 921 db TRACE [main] openjpa.MetaData - "addressBook" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.RelationFieldStrategy". 921 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.organizat...@999186587.hostnames". 932 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.hostn...@6848169". 932 db TRACE [main] openjpa.MetaData - "openjpatest.HostName" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.EmbeddedClassStrategy". 932 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.hostn...@6848169.name". 933 db TRACE [main] openjpa.MetaData - "name" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 933 db TRACE [main] openjpa.MetaData - "openjpatest.HostName<discriminator>" has mapping strategy "none". 933 db TRACE [main] openjpa.MetaData - "openjpatest.HostName<version>" has mapping strategy "none". 933 db TRACE [main] openjpa.MetaData - "hostNames" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.HandlerCollectionTableFieldStrategy". 933 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.addressb...@6637010". 933 db TRACE [main] openjpa.MetaData - "openjpatest.AddressBook" has mapping strategy "full". 933 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.addressb...@6637010.primaryemailaddress". 935 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.emailaddr...@2026561073". 935 db TRACE [main] openjpa.MetaData - "openjpatest.EmailAddress" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.EmbeddedClassStrategy". 935 db TRACE [main] openjpa.MetaData - Resolving field "openjpatest.emailaddr...@2026561073.email". 936 db TRACE [main] openjpa.MetaData - "email" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.StringFieldStrategy". 936 db TRACE [main] openjpa.MetaData - "openjpatest.EmailAddress<discriminator>" has mapping strategy "none". 936 db TRACE [main] openjpa.MetaData - "openjpatest.EmailAddress<version>" has mapping strategy "none". 936 db TRACE [main] openjpa.MetaData - "primaryEmailAddress" has mapping strategy "org.apache.openjpa.jdbc.meta.strats.EmbedFieldStrategy". 936 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.emailaddr...@1321312491". 936 db TRACE [main] openjpa.MetaData - "openjpatest.EmailAddress" has mapping strategy "none". 936 db TRACE [main] openjpa.MetaData - Resolving mapping for "openjpatest.hostn...@1280543092". 936 db TRACE [main] openjpa.MetaData - "openjpatest.HostName" has mapping strategy "none". 939 db TRACE [main] openjpa.Runtime - Found datasource 2: null from config. StoreContext: null 939 db TRACE [main] openjpa.Runtime - Trying datasource1 940 db TRACE [main] openjpa.Runtime - Found datasource1: datasource 644193719 from configuration. StoreContext: null 942 db TRACE [main] openjpa.Runtime - Found datasource 2: null from config. StoreContext: null 942 db TRACE [main] openjpa.Runtime - Trying datasource1 942 db TRACE [main] openjpa.Runtime - Found datasource1: datasource 644193719 from configuration. StoreContext: null 943 db TRACE [main] openjpa.jdbc.Schema - Reading table information for schema name "null", table name "organization_table". 944 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1068685279> getColumns: TEST, null, ORGANIZATION_TABLE, null 949 db TRACE [main] openjpa.jdbc.Schema - Reading sequence information for schema "null", sequence name "null". 952 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1068685279> executing prepstmnt 1727921240 SELECT SEQUENCE_SCHEMA, SEQUENCE_NAME FROM INFORMATION_SCHEMA.SEQUENCES 952 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1068685279> [0 ms] spent 953 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1068685279> [0 ms] commit 953 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1068685279> [0 ms] close 954 db TRACE [main] openjpa.jdbc.Schema - Reading table information for schema name "null", table name "OPENJPA_SEQUENCE_TABLE". 954 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1075051425> getColumns: TEST, null, OPENJPA_SEQUENCE_TABLE, null 958 db TRACE [main] openjpa.jdbc.Schema - Reading sequence information for schema "null", sequence name "null". 958 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1075051425> executing prepstmnt 1609377764 SELECT SEQUENCE_SCHEMA, SEQUENCE_NAME FROM INFORMATION_SCHEMA.SEQUENCES 958 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1075051425> [0 ms] spent 958 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1075051425> [0 ms] commit 958 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1075051425> [0 ms] close 959 db TRACE [main] openjpa.jdbc.Schema - Reading table information for schema name "null", table name "address_book_table". 959 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 780298059> getColumns: TEST, null, ADDRESS_BOOK_TABLE, null 962 db TRACE [main] openjpa.jdbc.Schema - Reading sequence information for schema "null", sequence name "null". 962 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 780298059> executing prepstmnt 1934329031 SELECT SEQUENCE_SCHEMA, SEQUENCE_NAME FROM INFORMATION_SCHEMA.SEQUENCES 963 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 780298059> [1 ms] spent 963 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 780298059> [0 ms] commit 963 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 780298059> [0 ms] close 963 db TRACE [main] openjpa.jdbc.Schema - Reading table information for schema name "null", table name "group_table". 963 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 598834505> getColumns: TEST, null, GROUP_TABLE, null 966 db TRACE [main] openjpa.jdbc.Schema - Reading sequence information for schema "null", sequence name "null". 967 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 598834505> executing prepstmnt 1503155693 SELECT SEQUENCE_SCHEMA, SEQUENCE_NAME FROM INFORMATION_SCHEMA.SEQUENCES 967 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 598834505> [0 ms] spent 967 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 598834505> [0 ms] commit 967 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 598834505> [0 ms] close 967 db TRACE [main] openjpa.jdbc.Schema - Reading table information for schema name "null", table name "Organization_hostNames". 968 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 197629132> getColumns: TEST, null, ORGANIZATION_HOSTNAMES, null 970 db TRACE [main] openjpa.jdbc.Schema - Reading sequence information for schema "null", sequence name "null". 971 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 197629132> executing prepstmnt 1924003262 SELECT SEQUENCE_SCHEMA, SEQUENCE_NAME FROM INFORMATION_SCHEMA.SEQUENCES 971 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 197629132> [0 ms] spent 971 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 197629132> [0 ms] commit 971 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 197629132> [0 ms] close 972 db TRACE [main] openjpa.jdbc.Schema - Reading foreign keys for schema name "null", table name "organization_table". 972 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1477049838> [0 ms] commit 972 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1477049838> [0 ms] close 973 db TRACE [main] openjpa.jdbc.Schema - Reading foreign keys for schema name "null", table name "OPENJPA_SEQUENCE_TABLE". 973 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1589377628> [0 ms] commit 973 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1589377628> [0 ms] close 973 db TRACE [main] openjpa.jdbc.Schema - Reading foreign keys for schema name "null", table name "address_book_table". 974 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1527616973> [1 ms] commit 974 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1527616973> [0 ms] close 974 db TRACE [main] openjpa.jdbc.Schema - Reading foreign keys for schema name "null", table name "group_table". 974 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1628606298> [0 ms] commit 974 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1628606298> [0 ms] close 975 db TRACE [main] openjpa.jdbc.Schema - Reading foreign keys for schema name "null", table name "Organization_hostNames". 975 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 418652512> [0 ms] commit 975 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 418652512> [0 ms] close 976 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 921400113> [0 ms] rollback 978 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 921400113> executing stmnt 819761253 CREATE TABLE address_book_table (id VARCHAR(255) NOT NULL, clazz VARCHAR(31), email VARCHAR(255), PRIMARY KEY (id)) 984 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 921400113> [6 ms] spent 984 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 921400113> [0 ms] commit 984 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 921400113> [0 ms] close 985 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1148670241> [0 ms] rollback 985 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1148670241> executing stmnt 1970237604 CREATE TABLE group_table (id VARCHAR(255) NOT NULL, name VARCHAR(255), clazz VARCHAR(31), version INTEGER, organization_id VARCHAR(255), PRIMARY KEY (id)) 986 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1148670241> [1 ms] spent 986 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1148670241> [0 ms] commit 986 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1148670241> [0 ms] close 987 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1226621799> [0 ms] rollback 987 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1226621799> executing stmnt 2137048240 CREATE TABLE OPENJPA_SEQUENCE_TABLE (ID TINYINT NOT NULL, SEQUENCE_VALUE BIGINT, PRIMARY KEY (ID)) 987 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1226621799> [0 ms] spent 987 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1226621799> [0 ms] commit 987 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1226621799> [0 ms] close 988 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 2000442639> [0 ms] rollback 988 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 2000442639> executing stmnt 435456241 CREATE TABLE Organization_hostNames (ORGANIZATION_ID VARCHAR(255), name VARCHAR(255)) 988 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 2000442639> [0 ms] spent 989 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 2000442639> [0 ms] commit 989 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 2000442639> [0 ms] close 991 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1580650567> [0 ms] rollback 991 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1580650567> executing stmnt 1621366179 CREATE TABLE organization_table (id VARCHAR(255) NOT NULL, name VARCHAR(255), clazz VARCHAR(31), version INTEGER, address_book_id VARCHAR(255), PRIMARY KEY (id)) 991 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 1580650567> [0 ms] spent 991 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1580650567> [0 ms] commit 992 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 1580650567> [0 ms] close 993 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 170563709> [0 ms] rollback 993 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 170563709> executing stmnt 1921072065 CREATE INDEX I_DDRSTBL_DTYPE ON address_book_table (clazz) 998 db TRACE [main] openjpa.jdbc.SQL - <t 1839586123, conn 170563709> [5 ms] spent 998 db TRACE [main] openjpa.jdbc.JDBC - <t 1839586123, conn 170563709> [0 ms] close Exception in thread "main" <openjpa-2.0.1-r422266:989424 nonfatal general error> org.apache.openjpa.persistence.PersistenceException: Table "ADDRESS_BOOK_TABLE" not found; SQL statement: CREATE INDEX I_DDRSTBL_DTYPE ON address_book_table (clazz) [42102-143] {stmnt 1921072065 CREATE INDEX I_DDRSTBL_DTYPE ON address_book_table (clazz)} [code=42102, state=42S02] at org.apache.openjpa.jdbc.meta.MappingTool.record(MappingTool.java:556) at org.apache.openjpa.jdbc.meta.MappingTool.record(MappingTool.java:456) at org.apache.openjpa.jdbc.kernel.JDBCBrokerFactory.synchronizeMappings(JDBCBrokerFactory.java:155) at org.apache.openjpa.jdbc.kernel.JDBCBrokerFactory.synchronizeMappings(JDBCBrokerFactory.java:159) at org.apache.openjpa.jdbc.kernel.JDBCBrokerFactory.newBrokerImpl(JDBCBrokerFactory.java:117) at org.apache.openjpa.kernel.AbstractBrokerFactory.newBroker(AbstractBrokerFactory.java:212) at org.apache.openjpa.kernel.DelegatingBrokerFactory.newBroker(DelegatingBrokerFactory.java:156) at org.apache.openjpa.persistence.EntityManagerFactoryImpl.createEntityManager(EntityManagerFactoryImpl.java:227) at org.apache.openjpa.persistence.EntityManagerFactoryImpl.createEntityManager(EntityManagerFactoryImpl.java:154) at org.apache.openjpa.persistence.EntityManagerFactoryImpl.createEntityManager(EntityManagerFactoryImpl.java:60) at openjpatest.Main.main(Main.java:17) Caused by: org.apache.openjpa.lib.jdbc.ReportingSQLException: Table "ADDRESS_BOOK_TABLE" not found; SQL statement: CREATE INDEX I_DDRSTBL_DTYPE ON address_book_table (clazz) [42102-143] {stmnt 1921072065 CREATE INDEX I_DDRSTBL_DTYPE ON address_book_table (clazz)} [code=42102, state=42S02] at org.apache.openjpa.lib.jdbc.LoggingConnectionDecorator.wrap(LoggingConnectionDecorator.java:273) at org.apache.openjpa.lib.jdbc.LoggingConnectionDecorator.wrap(LoggingConnectionDecorator.java:257) at org.apache.openjpa.lib.jdbc.LoggingConnectionDecorator.access$700(LoggingConnectionDecorator.java:70) at org.apache.openjpa.lib.jdbc.LoggingConnectionDecorator$LoggingConnection$LoggingStatement.executeUpdate(LoggingConnectionDecorator.java:967) at org.apache.openjpa.lib.jdbc.DelegatingStatement.executeUpdate(DelegatingStatement.java:136) at org.apache.openjpa.jdbc.schema.SchemaTool.executeSQL(SchemaTool.java:1200) at org.apache.openjpa.jdbc.schema.SchemaTool.createIndex(SchemaTool.java:1013) at org.apache.openjpa.jdbc.schema.SchemaTool.add(SchemaTool.java:561) at org.apache.openjpa.jdbc.schema.SchemaTool.add(SchemaTool.java:348) at org.apache.openjpa.jdbc.schema.SchemaTool.run(SchemaTool.java:325) at org.apache.openjpa.jdbc.meta.MappingTool.record(MappingTool.java:504) ... 10 more Process finished with exit code 1 > Schema synchronizer fails to build tables and indexes when running with H2 > in-memory database > --------------------------------------------------------------------------------------------- > > Key: OPENJPA-1812 > URL: https://issues.apache.org/jira/browse/OPENJPA-1812 > Project: OpenJPA > Issue Type: Bug > Affects Versions: 2.0.1 > Reporter: Willis Blackburn > Priority: Minor > > Using the example from OPENJPA-1804 I added HostName and EmailAddress to the > class list, updated the JVM launcher command to use the Java agent enhancer, > and added: > <property name="openjpa.jdbc.SynchronizeMappings" > value="buildSchema(foreignKeys=true)"/> > Note also: > <property name="openjpa.ConnectionURL" value="jdbc:h2:mem:test"/> > When I tried to run the example, it failed when attempting to create an > index, saying that address_book_table (which it created a few milliseconds > earlier) did not exist. > Changing H2 to use a database on disk fixed the problem: > <property name="openjpa.ConnectionURL" > value="jdbc:h2:~/openjpatestdb"/> > But why is OpenJPA sensitive to whether I'm using an in-memory or disk H2 > database? > I tried opening the same in-memory database URL using my IDE's JDBC console. > Of course I got a different database, since the IDE is running in its own > JVM. But I was able to execute the "create table" from the OpenJPA log > followed by the "create index" without any trouble. -- This message is automatically generated by JIRA. - You can reply to this email to add a comment to the issue online.