-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'exportDatesAsFormattedString' in the pooling flow
=== 2015-02-09 13:22:57,142 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'exportAs'
=== 2015-02-09 13:22:57,142 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'exportAs' but null was returned
=== 2015-02-09 13:22:57,142 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'exportAs' in the pooling flow
=== 2015-02-09 13:22:57,143 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'exportFilename'
=== 2015-02-09 13:22:57,143 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'exportFilename' but null was returned
=== 2015-02-09 13:22:57,143 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'exportFilename' in the pooling flow
=== 2015-02-09 13:22:57,143 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'lineBreakStyle'
=== 2015-02-09 13:22:57,143 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'lineBreakStyle' but null was returned
=== 2015-02-09 13:22:57,143 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'lineBreakStyle' in the pooling flow
=== 2015-02-09 13:22:57,144 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'useForCacheSync'
=== 2015-02-09 13:22:57,144 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'useForCacheSync' but null was returned
=== 2015-02-09 13:22:57,144 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useForCacheSync' in the pooling flow
=== 2015-02-09 13:22:57,144 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'canSyncCache'
=== 2015-02-09 13:22:57,144 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'canSyncCache' but null was returned
=== 2015-02-09 13:22:57,144 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canSyncCache' in the pooling flow
=== 2015-02-09 13:22:57,145 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'allowMultiUpdate'
=== 2015-02-09 13:22:57,145 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'allowMultiUpdate' but null was returned
=== 2015-02-09 13:22:57,145 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'allowMultiUpdate' in the pooling flow
=== 2015-02-09 13:22:57,145 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'providesMissingKeys'
=== 2015-02-09 13:22:57,145 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'providesMissingKeys' but null was returned
=== 2015-02-09 13:22:57,145 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'providesMissingKeys' in the pooling flow
=== 2015-02-09 13:22:57,146 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'requiresAuthentication'
=== 2015-02-09 13:22:57,146 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'requiresAuthentication' but null was returned
=== 2015-02-09 13:22:57,146 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'requiresAuthentication' in the pooling flow
=== 2015-02-09 13:22:57,146 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'requiresRole'
=== 2015-02-09 13:22:57,147 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'requiresRole' but null was returned
=== 2015-02-09 13:22:57,147 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'requiresRole' in the pooling flow
=== 2015-02-09 13:22:57,147 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'requires'
=== 2015-02-09 13:22:57,147 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'requires' but null was returned
=== 2015-02-09 13:22:57,147 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'requires' in the pooling flow
=== 2015-02-09 13:22:57,148 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'ownerIdField'
=== 2015-02-09 13:22:57,148 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'ownerIdField' but null was returned
=== 2015-02-09 13:22:57,148 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'ownerIdField' in the pooling flow
=== 2015-02-09 13:22:57,148 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'guestUserId'
=== 2015-02-09 13:22:57,148 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'guestUserId' but null was returned
=== 2015-02-09 13:22:57,149 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'guestUserId' in the pooling flow
=== 2015-02-09 13:22:57,149 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'mail'
=== 2015-02-09 13:22:57,149 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'mail' but null was returned
=== 2015-02-09 13:22:57,149 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'mail' in the pooling flow
=== 2015-02-09 13:22:57,150 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'beanClassName'
=== 2015-02-09 13:22:57,150 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'beanClassName' but null was returned
=== 2015-02-09 13:22:57,150 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'beanClassName' in the pooling flow
=== 2015-02-09 13:22:57,150 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'sqlType'
=== 2015-02-09 13:22:57,150 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'sqlType' but null was returned
=== 2015-02-09 13:22:57,151 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sqlType' in the pooling flow
=== 2015-02-09 13:22:57,151 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'outputs'
=== 2015-02-09 13:22:57,151 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'outputs' but null was returned
=== 2015-02-09 13:22:57,151 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'outputs' in the pooling flow
=== 2015-02-09 13:22:57,151 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoJoinTransactions'
=== 2015-02-09 13:22:57,152 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'autoJoinTransactions' but null was returned
=== 2015-02-09 13:22:57,152 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoJoinTransactions' in the pooling flow
=== 2015-02-09 13:22:57,152 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'useSpringTransaction'
=== 2015-02-09 13:22:57,152 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'useSpringTransaction' but null was returned
=== 2015-02-09 13:22:57,152 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useSpringTransaction' in the pooling flow
=== 2015-02-09 13:22:57,152 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'progressiveLoading'
=== 2015-02-09 13:22:57,153 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'progressiveLoading' but null was returned
=== 2015-02-09 13:22:57,153 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'progressiveLoading' in the pooling flow
=== 2015-02-09 13:22:57,153 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'allowAdvancedCriteria'
=== 2015-02-09 13:22:57,153 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'allowAdvancedCriteria' but null was returned
=== 2015-02-09 13:22:57,153 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'allowAdvancedCriteria' in the pooling flow
=== 2015-02-09 13:22:57,154 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'scriptImport'
=== 2015-02-09 13:22:57,154 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'scriptImport' but null was returned
=== 2015-02-09 13:22:57,154 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'scriptImport' in the pooling flow
=== 2015-02-09 13:22:57,154 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'script'
=== 2015-02-09 13:22:57,154 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'script' but null was returned
=== 2015-02-09 13:22:57,154 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'script' in the pooling flow
=== 2015-02-09 13:22:57,155 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'summaryFunctions'
=== 2015-02-09 13:22:57,155 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'summaryFunctions' but null was returned
=== 2015-02-09 13:22:57,155 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'summaryFunctions' in the pooling flow
=== 2015-02-09 13:22:57,155 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'groupBy'
=== 2015-02-09 13:22:57,156 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'groupBy' but null was returned
=== 2015-02-09 13:22:57,156 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'groupBy' in the pooling flow
=== 2015-02-09 13:22:57,156 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'allowClientRequestedSummaries'
=== 2015-02-09 13:22:57,156 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'allowClientRequestedSummaries' but null was returned
=== 2015-02-09 13:22:57,156 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'allowClientRequestedSummaries' in the pooling flow
=== 2015-02-09 13:22:57,156 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'skipRowCount'
=== 2015-02-09 13:22:57,157 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'skipRowCount' but null was returned
=== 2015-02-09 13:22:57,157 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'skipRowCount' in the pooling flow
=== 2015-02-09 13:22:57,157 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'language'
=== 2015-02-09 13:22:57,157 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'language' but null was returned
=== 2015-02-09 13:22:57,157 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'language' in the pooling flow
=== 2015-02-09 13:22:57,158 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'values'
=== 2015-02-09 13:22:57,158 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'values' but null was returned
=== 2015-02-09 13:22:57,158 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'values' in the pooling flow
=== 2015-02-09 13:22:57,158 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'criteria'
=== 2015-02-09 13:22:57,158 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'criteria' but null was returned
=== 2015-02-09 13:22:57,158 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'criteria' in the pooling flow
=== 2015-02-09 13:22:57,159 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'cacheSyncOperation'
=== 2015-02-09 13:22:57,159 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'cacheSyncOperation' but null was returned
=== 2015-02-09 13:22:57,159 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'cacheSyncOperation' in the pooling flow
=== 2015-02-09 13:22:57,159 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'relaxSecurityForCacheSync'
=== 2015-02-09 13:22:57,159 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'relaxSecurityForCacheSync' but null was returned
=== 2015-02-09 13:22:57,159 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'relaxSecurityForCacheSync' in the pooling flow
=== 2015-02-09 13:22:57,160 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'customCriteriaFields'
=== 2015-02-09 13:22:57,160 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'customCriteriaFields' but null was returned
=== 2015-02-09 13:22:57,160 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'customCriteriaFields' in the pooling flow
=== 2015-02-09 13:22:57,160 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'excludeCriteriaFields'
=== 2015-02-09 13:22:57,161 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'excludeCriteriaFields' but null was returned
=== 2015-02-09 13:22:57,161 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'excludeCriteriaFields' in the pooling flow
=== 2015-02-09 13:22:57,161 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'customValueFields'
=== 2015-02-09 13:22:57,161 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'customValueFields' but null was returned
=== 2015-02-09 13:22:57,161 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'customValueFields' in the pooling flow
=== 2015-02-09 13:22:57,161 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'creatorOverrides'
=== 2015-02-09 13:22:57,162 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'creatorOverrides' but null was returned
=== 2015-02-09 13:22:57,162 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'creatorOverrides' in the pooling flow
=== 2015-02-09 13:22:57,162 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'qualifyColumnNames'
=== 2015-02-09 13:22:57,162 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'qualifyColumnNames' but null was returned
=== 2015-02-09 13:22:57,162 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'qualifyColumnNames' in the pooling flow
=== 2015-02-09 13:22:57,163 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'customFields'
=== 2015-02-09 13:22:57,163 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'customFields' but null was returned
=== 2015-02-09 13:22:57,163 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'customFields' in the pooling flow
=== 2015-02-09 13:22:57,164 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'type'
=== 2015-02-09 13:22:57,164 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'type' but null was returned
=== 2015-02-09 13:22:57,164 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'type' in the pooling flow
=== 2015-02-09 13:22:57,164 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'types'
=== 2015-02-09 13:22:57,164 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'types' but null was returned
=== 2015-02-09 13:22:57,164 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'types' in the pooling flow
=== 2015-02-09 13:22:57,166 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 7 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,166 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 7 of type 'OperationBinding' in the pooling flow
=== 2015-02-09 13:22:57,167 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 7 of type 'OperationBinding'
=== 2015-02-09 13:22:57,202 [ec-2] INFO  SQLDataSource - Deriving dataSource Administrator from table: Administrator
=== 2015-02-09 13:22:57,264 [ec-2] INFO  PoolManager - SmartClient pooling started for 'Mysql' objects
=== 2015-02-09 13:22:57,270 [ec-2] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'Mysql' from system config - using DriverManager:  com.mysql.jdbc.Driver
=== 2015-02-09 13:22:57,275 [ec-2] DEBUG PoolableSQLConnectionFactory - com.mysql.jdbc.Driver lookup successful
=== 2015-02-09 13:22:57,276 [ec-2] DEBUG PoolableSQLConnectionFactory - DriverManager fetching connection for Mysql via jdbc url jdbc:mysql://mysql1.fcm.net/fermat?user=fermatcapital&password=fermatwandq&zeroDateTimeBehavior=convertToNull
=== 2015-02-09 13:22:57,276 [ec-2] DEBUG PoolableSQLConnectionFactory - Passing JDBC URL only to getConnection
=== 2015-02-09 13:22:57,454 [ec-2] DEBUG PoolableSQLConnectionFactory - makeObject() created a pooled Connection '603988365'
=== 2015-02-09 13:22:57,459 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,462 [ec-2] DEBUG SQLConnectionManager - Borrowed connection '603988365'
=== 2015-02-09 13:22:57,464 [ec-2] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='1653705780' with passed Connection object hashCode='603988365'
=== 2015-02-09 13:22:57,464 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for table: Administrator
=== 2015-02-09 13:22:57,464 [ec-2] INFO  SQLDSGenerator - =============Using catalog: fermat
=== 2015-02-09 13:22:57,480 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for Administrator complete
=== 2015-02-09 13:22:57,485 [ec-2] DEBUG SQLConnectionManager - About to close  with hashcode "603988365"
=== 2015-02-09 13:22:57,485 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,486 [ec-2] DEBUG SQLDataSource - DataSource 8 acquired SQLDriver instance 1457398981 during initialization
=== 2015-02-09 13:22:57,487 [ec-2] DEBUG SQLDataSource - DataSource 9 acquired SQLDriver instance 306195985 during initialization
=== 2015-02-09 13:22:57,487 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 9 of type 'Administrator' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,487 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 9 of type 'Administrator' in the pooling flow
=== 2015-02-09 13:22:57,487 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 9 of type 'Administrator'
=== 2015-02-09 13:22:57,487 [ec-2] DEBUG DataSourceLoader - For DataSource 'Administrator', got instanceId 9
=== 2015-02-09 13:22:57,501 [ec-2] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 9
=== 2015-02-09 13:22:57,501 [ec-2] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 9
=== 2015-02-09 13:22:57,501 [ec-2] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 9 of type 'Administrator'
=== 2015-02-09 13:22:57,502 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'AMBest'
=== 2015-02-09 13:22:57,503 [ec-2] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/AMBest.ds.xml: 1ms
=== 2015-02-09 13:22:57,504 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource'
=== 2015-02-09 13:22:57,506 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 10 of type 'DataSource' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,506 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 10 of type 'DataSource' in the pooling flow
=== 2015-02-09 13:22:57,506 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 10 of type 'DataSource'
=== 2015-02-09 13:22:57,507 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField'
=== 2015-02-09 13:22:57,509 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 11 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,509 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 11 of type 'DataSourceField' in the pooling flow
=== 2015-02-09 13:22:57,509 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 11 of type 'DataSourceField'
=== 2015-02-09 13:22:57,509 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'field'
=== 2015-02-09 13:22:57,509 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'field' but null was returned
=== 2015-02-09 13:22:57,509 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow
=== 2015-02-09 13:22:57,511 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding'
=== 2015-02-09 13:22:57,511 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'operationBinding' but null was returned
=== 2015-02-09 13:22:57,511 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow
=== 2015-02-09 13:22:57,511 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding'
=== 2015-02-09 13:22:57,512 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 12 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,512 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 12 of type 'OperationBinding' in the pooling flow
=== 2015-02-09 13:22:57,513 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 12 of type 'OperationBinding'
=== 2015-02-09 13:22:57,513 [ec-2] INFO  SQLDataSource - Deriving dataSource AMBest from table: AMBest
=== 2015-02-09 13:22:57,514 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,514 [ec-2] DEBUG SQLConnectionManager - Borrowed connection '603988365'
=== 2015-02-09 13:22:57,515 [ec-2] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='284206056' with passed Connection object hashCode='603988365'
=== 2015-02-09 13:22:57,515 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for table: AMBest
=== 2015-02-09 13:22:57,515 [ec-2] INFO  SQLDSGenerator - =============Using catalog: fermat
=== 2015-02-09 13:22:57,523 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for AMBest complete
=== 2015-02-09 13:22:57,525 [ec-2] DEBUG SQLConnectionManager - About to close  with hashcode "603988365"
=== 2015-02-09 13:22:57,525 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,527 [ec-2] DEBUG SQLDataSource - DataSource 13 acquired SQLDriver instance 387848211 during initialization
=== 2015-02-09 13:22:57,527 [ec-2] DEBUG SQLDataSource - DataSource 14 acquired SQLDriver instance 952013632 during initialization
=== 2015-02-09 13:22:57,527 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 14 of type 'AMBest' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,528 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 14 of type 'AMBest' in the pooling flow
=== 2015-02-09 13:22:57,528 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 14 of type 'AMBest'
=== 2015-02-09 13:22:57,528 [ec-2] DEBUG DataSourceLoader - For DataSource 'AMBest', got instanceId 14
=== 2015-02-09 13:22:57,531 [ec-2] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 14
=== 2015-02-09 13:22:57,531 [ec-2] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 14
=== 2015-02-09 13:22:57,531 [ec-2] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 14 of type 'AMBest'
=== 2015-02-09 13:22:57,531 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'auditor'
=== 2015-02-09 13:22:57,533 [ec-2] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/auditor.ds.xml: 2ms
=== 2015-02-09 13:22:57,533 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource'
=== 2015-02-09 13:22:57,535 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 15 of type 'DataSource' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,535 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 15 of type 'DataSource' in the pooling flow
=== 2015-02-09 13:22:57,535 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 15 of type 'DataSource'
=== 2015-02-09 13:22:57,536 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField'
=== 2015-02-09 13:22:57,538 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 16 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,538 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 16 of type 'DataSourceField' in the pooling flow
=== 2015-02-09 13:22:57,538 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 16 of type 'DataSourceField'
=== 2015-02-09 13:22:57,538 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'field'
=== 2015-02-09 13:22:57,538 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'field' but null was returned
=== 2015-02-09 13:22:57,538 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow
=== 2015-02-09 13:22:57,539 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding'
=== 2015-02-09 13:22:57,540 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'operationBinding' but null was returned
=== 2015-02-09 13:22:57,540 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow
=== 2015-02-09 13:22:57,540 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding'
=== 2015-02-09 13:22:57,541 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 17 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,541 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 17 of type 'OperationBinding' in the pooling flow
=== 2015-02-09 13:22:57,541 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 17 of type 'OperationBinding'
=== 2015-02-09 13:22:57,542 [ec-2] INFO  SQLDataSource - Deriving dataSource auditor from table: auditor
=== 2015-02-09 13:22:57,542 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,543 [ec-2] DEBUG SQLConnectionManager - Borrowed connection '603988365'
=== 2015-02-09 13:22:57,543 [ec-2] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='2036671403' with passed Connection object hashCode='603988365'
=== 2015-02-09 13:22:57,543 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for table: auditor
=== 2015-02-09 13:22:57,543 [ec-2] INFO  SQLDSGenerator - =============Using catalog: fermat
=== 2015-02-09 13:22:57,548 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for auditor complete
=== 2015-02-09 13:22:57,551 [ec-2] DEBUG SQLConnectionManager - About to close  with hashcode "603988365"
=== 2015-02-09 13:22:57,551 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,552 [ec-2] DEBUG SQLDataSource - DataSource 18 acquired SQLDriver instance 667979297 during initialization
=== 2015-02-09 13:22:57,553 [ec-2] DEBUG SQLDataSource - DataSource 19 acquired SQLDriver instance 1831021810 during initialization
=== 2015-02-09 13:22:57,553 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 19 of type 'auditor' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,553 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 19 of type 'auditor' in the pooling flow
=== 2015-02-09 13:22:57,553 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 19 of type 'auditor'
=== 2015-02-09 13:22:57,553 [ec-2] DEBUG DataSourceLoader - For DataSource 'auditor', got instanceId 19
=== 2015-02-09 13:22:57,556 [ec-2] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 19
=== 2015-02-09 13:22:57,556 [ec-2] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 19
=== 2015-02-09 13:22:57,556 [ec-2] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 19 of type 'auditor'
=== 2015-02-09 13:22:57,556 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'author'
=== 2015-02-09 13:22:57,558 [ec-2] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/author.ds.xml: 1ms
=== 2015-02-09 13:22:57,559 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource'
=== 2015-02-09 13:22:57,561 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 20 of type 'DataSource' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,561 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 20 of type 'DataSource' in the pooling flow
=== 2015-02-09 13:22:57,561 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 20 of type 'DataSource'
=== 2015-02-09 13:22:57,561 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField'
=== 2015-02-09 13:22:57,564 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 21 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,564 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 21 of type 'DataSourceField' in the pooling flow
=== 2015-02-09 13:22:57,564 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 21 of type 'DataSourceField'
=== 2015-02-09 13:22:57,564 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'field'
=== 2015-02-09 13:22:57,564 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'field' but null was returned
=== 2015-02-09 13:22:57,564 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow
=== 2015-02-09 13:22:57,566 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding'
=== 2015-02-09 13:22:57,566 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'operationBinding' but null was returned
=== 2015-02-09 13:22:57,566 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow
=== 2015-02-09 13:22:57,566 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding'
=== 2015-02-09 13:22:57,567 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 22 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,567 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 22 of type 'OperationBinding' in the pooling flow
=== 2015-02-09 13:22:57,567 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 22 of type 'OperationBinding'
=== 2015-02-09 13:22:57,568 [ec-2] INFO  SQLDataSource - Deriving dataSource author from table: author
=== 2015-02-09 13:22:57,568 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,569 [ec-2] DEBUG SQLConnectionManager - Borrowed connection '603988365'
=== 2015-02-09 13:22:57,569 [ec-2] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='845061684' with passed Connection object hashCode='603988365'
=== 2015-02-09 13:22:57,569 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for table: author
=== 2015-02-09 13:22:57,570 [ec-2] INFO  SQLDSGenerator - =============Using catalog: fermat
=== 2015-02-09 13:22:57,574 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for author complete
=== 2015-02-09 13:22:57,577 [ec-2] DEBUG SQLConnectionManager - About to close  with hashcode "603988365"
=== 2015-02-09 13:22:57,577 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,578 [ec-2] DEBUG SQLDataSource - DataSource 23 acquired SQLDriver instance 165176382 during initialization
=== 2015-02-09 13:22:57,579 [ec-2] DEBUG SQLDataSource - DataSource 24 acquired SQLDriver instance 1570580350 during initialization
=== 2015-02-09 13:22:57,579 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 24 of type 'author' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,579 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 24 of type 'author' in the pooling flow
=== 2015-02-09 13:22:57,579 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 24 of type 'author'
=== 2015-02-09 13:22:57,579 [ec-2] DEBUG DataSourceLoader - For DataSource 'author', got instanceId 24
=== 2015-02-09 13:22:57,582 [ec-2] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 24
=== 2015-02-09 13:22:57,582 [ec-2] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 24
=== 2015-02-09 13:22:57,582 [ec-2] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 24 of type 'author'
=== 2015-02-09 13:22:57,582 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'basket'
=== 2015-02-09 13:22:57,584 [ec-2] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/basket.ds.xml: 2ms
=== 2015-02-09 13:22:57,584 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource'
=== 2015-02-09 13:22:57,586 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 25 of type 'DataSource' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,586 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 25 of type 'DataSource' in the pooling flow
=== 2015-02-09 13:22:57,586 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 25 of type 'DataSource'
=== 2015-02-09 13:22:57,586 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'field'
=== 2015-02-09 13:22:57,586 [ec-2] DEBUG PoolableDataSourceFactory - Tried to create DataSource  of type 'field' but null was returned
=== 2015-02-09 13:22:57,586 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow
=== 2015-02-09 13:22:57,587 [ec-2] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField'
=== 2015-02-09 13:22:57,588 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 26 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-2
=== 2015-02-09 13:22:57,588 [ec-2] DEBUG PoolableDataSourceFactory - Created DataSource 26 of type 'DataSourceField' in the pooling flow
=== 2015-02-09 13:22:57,588 [ec-2] DEBUG PoolableDataSourceFactory - Activated DataSource 26 of type 'DataSourceField'
=== 2015-02-09 13:22:57,589 [ec-2] INFO  SQLDataSource - Deriving dataSource basket from table: basket
=== 2015-02-09 13:22:57,589 [ec-2] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 603988365
=== 2015-02-09 13:22:57,590 [ec-2] DEBUG SQLConnectionManager - Borrowed connection '603988365'
=== 2015-02-09 13:22:57,590 [ec-2] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='1071352435' with passed Connection object hashCode='603988365'
=== 2015-02-09 13:22:57,590 [ec-2] INFO  SQLDSGenerator - Fetching column metadata for table: basket
=== 2015-02-09 13:22:57,591 [ec-2] INFO  SQLDSGenerator - =============Using catalog: fermat
=== 2015-02-09 13:22:57,596 [ec-2] INFO  SQLDSGenerator - Fetchin