3 [ec-4] INFO SQLDSGenerator - Fetching column metadata for bondpricipalreductionfactor complete === 2015-02-06 16:31:55,616 [ec-4] DEBUG SQLConnectionManager - About to close with hashcode "1290082656" === 2015-02-06 16:31:55,616 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:55,628 [ec-4] DEBUG SQLDataSource - DataSource 102 acquired SQLDriver instance 399182358 during initialization === 2015-02-06 16:31:55,629 [ec-4] DEBUG SQLDataSource - DataSource 103 acquired SQLDriver instance 318977678 during initialization === 2015-02-06 16:31:55,629 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 103 of type 'bondpricipalreductionfactor' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,630 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 103 of type 'bondpricipalreductionfactor' in the pooling flow === 2015-02-06 16:31:55,630 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 103 of type 'bondpricipalreductionfactor' === 2015-02-06 16:31:55,630 [ec-4] DEBUG DataSourceLoader - For DataSource 'bondpricipalreductionfactor', got instanceId 103 === 2015-02-06 16:31:55,635 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 103 === 2015-02-06 16:31:55,635 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 103 === 2015-02-06 16:31:55,635 [ec-4] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 103 of type 'bondpricipalreductionfactor' === 2015-02-06 16:31:55,635 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'BondReset' === 2015-02-06 16:31:55,638 [ec-4] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/BondReset.ds.xml: 2ms === 2015-02-06 16:31:55,638 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource' === 2015-02-06 16:31:55,639 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 104 of type 'DataSource' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,639 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 104 of type 'DataSource' in the pooling flow === 2015-02-06 16:31:55,640 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 104 of type 'DataSource' === 2015-02-06 16:31:55,640 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField' === 2015-02-06 16:31:55,641 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 105 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,641 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 105 of type 'DataSourceField' in the pooling flow === 2015-02-06 16:31:55,641 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 105 of type 'DataSourceField' === 2015-02-06 16:31:55,641 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'field' === 2015-02-06 16:31:55,641 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned === 2015-02-06 16:31:55,641 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow === 2015-02-06 16:31:55,643 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'ValueMap' === 2015-02-06 16:31:55,643 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 106 of type 'ValueMap' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,644 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 106 of type 'ValueMap' in the pooling flow === 2015-02-06 16:31:55,644 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 106 of type 'ValueMap' === 2015-02-06 16:31:55,645 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding' === 2015-02-06 16:31:55,645 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operationBinding' but null was returned === 2015-02-06 16:31:55,645 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow === 2015-02-06 16:31:55,645 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding' === 2015-02-06 16:31:55,646 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 107 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,646 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 107 of type 'OperationBinding' in the pooling flow === 2015-02-06 16:31:55,646 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 107 of type 'OperationBinding' === 2015-02-06 16:31:55,646 [ec-4] INFO SQLDataSource - Deriving dataSource BondReset from table: BondReset === 2015-02-06 16:31:55,646 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:55,657 [ec-4] DEBUG SQLConnectionManager - Borrowed connection '1290082656' === 2015-02-06 16:31:55,658 [ec-4] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='134827207' with passed Connection object hashCode='1290082656' === 2015-02-06 16:31:55,658 [ec-4] INFO SQLDSGenerator - Fetching column metadata for table: BondReset === 2015-02-06 16:31:55,658 [ec-4] INFO SQLDSGenerator - =============Using catalog: fermat === 2015-02-06 16:31:55,692 [ec-4] INFO SQLDSGenerator - Fetching column metadata for BondReset complete === 2015-02-06 16:31:55,722 [ec-4] DEBUG SQLConnectionManager - About to close with hashcode "1290082656" === 2015-02-06 16:31:55,722 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:55,734 [ec-4] DEBUG SQLDataSource - DataSource 108 acquired SQLDriver instance 1537587829 during initialization === 2015-02-06 16:31:55,735 [ec-4] DEBUG SQLDataSource - DataSource 109 acquired SQLDriver instance 1567917652 during initialization === 2015-02-06 16:31:55,735 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 109 of type 'BondReset' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,735 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 109 of type 'BondReset' in the pooling flow === 2015-02-06 16:31:55,735 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 109 of type 'BondReset' === 2015-02-06 16:31:55,736 [ec-4] DEBUG DataSourceLoader - For DataSource 'BondReset', got instanceId 109 === 2015-02-06 16:31:55,742 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 109 === 2015-02-06 16:31:55,742 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 109 === 2015-02-06 16:31:55,742 [ec-4] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 109 of type 'BondReset' === 2015-02-06 16:31:55,742 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'bonds' === 2015-02-06 16:31:55,749 [ec-4] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/bonds.ds.xml: 6ms === 2015-02-06 16:31:55,750 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource' === 2015-02-06 16:31:55,751 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 110 of type 'DataSource' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,751 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 110 of type 'DataSource' in the pooling flow === 2015-02-06 16:31:55,751 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 110 of type 'DataSource' === 2015-02-06 16:31:55,752 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField' === 2015-02-06 16:31:55,753 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 111 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,753 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 111 of type 'DataSourceField' in the pooling flow === 2015-02-06 16:31:55,753 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 111 of type 'DataSourceField' === 2015-02-06 16:31:55,753 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'field' === 2015-02-06 16:31:55,753 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned === 2015-02-06 16:31:55,753 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow === 2015-02-06 16:31:55,756 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'JS' === 2015-02-06 16:31:55,758 [ec-4] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/tables/sc/system/schema/JS.ds.xml: 2ms === 2015-02-06 16:31:55,758 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource' === 2015-02-06 16:31:55,759 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 112 of type 'DataSource' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,759 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 112 of type 'DataSource' in the pooling flow === 2015-02-06 16:31:55,759 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 112 of type 'DataSource' === 2015-02-06 16:31:55,759 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 113 of type 'JS' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,759 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 113 of type 'JS' in the pooling flow === 2015-02-06 16:31:55,759 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 113 of type 'JS' === 2015-02-06 16:31:55,760 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'ValueMap' === 2015-02-06 16:31:55,761 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 114 of type 'ValueMap' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,761 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 114 of type 'ValueMap' in the pooling flow === 2015-02-06 16:31:55,761 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 114 of type 'ValueMap' === 2015-02-06 16:31:55,777 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding' === 2015-02-06 16:31:55,777 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 115 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,777 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 115 of type 'OperationBinding' in the pooling flow === 2015-02-06 16:31:55,777 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 115 of type 'OperationBinding' === 2015-02-06 16:31:55,778 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding' === 2015-02-06 16:31:55,778 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operationBinding' but null was returned === 2015-02-06 16:31:55,778 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow === 2015-02-06 16:31:55,778 [ec-4] INFO SQLDataSource - Deriving dataSource bonds from table: bonds === 2015-02-06 16:31:55,778 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:55,790 [ec-4] DEBUG SQLConnectionManager - Borrowed connection '1290082656' === 2015-02-06 16:31:55,790 [ec-4] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='1879096508' with passed Connection object hashCode='1290082656' === 2015-02-06 16:31:55,790 [ec-4] INFO SQLDSGenerator - Fetching column metadata for table: bonds === 2015-02-06 16:31:55,790 [ec-4] INFO SQLDSGenerator - =============Using catalog: fermat === 2015-02-06 16:31:55,851 [ec-4] INFO SQLDSGenerator - Fetching column metadata for bonds complete === 2015-02-06 16:31:55,897 [ec-4] DEBUG SQLConnectionManager - About to close with hashcode "1290082656" === 2015-02-06 16:31:55,897 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:55,909 [ec-4] DEBUG SQLDataSource - DataSource 116 acquired SQLDriver instance 1252044923 during initialization === 2015-02-06 16:31:55,910 [ec-4] DEBUG SQLDataSource - DataSource 117 acquired SQLDriver instance 2074247555 during initialization === 2015-02-06 16:31:55,910 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 117 of type 'bonds' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,910 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 117 of type 'bonds' in the pooling flow === 2015-02-06 16:31:55,910 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 117 of type 'bonds' === 2015-02-06 16:31:55,910 [ec-4] DEBUG DataSourceLoader - For DataSource 'bonds', got instanceId 117 === 2015-02-06 16:31:55,945 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 117 === 2015-02-06 16:31:55,945 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 117 === 2015-02-06 16:31:55,945 [ec-4] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 117 of type 'bonds' === 2015-02-06 16:31:55,945 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'BondsImpaired' === 2015-02-06 16:31:55,947 [ec-4] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/BondsImpaired.ds.xml: 2ms === 2015-02-06 16:31:55,947 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource' === 2015-02-06 16:31:55,948 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 118 of type 'DataSource' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,948 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 118 of type 'DataSource' in the pooling flow === 2015-02-06 16:31:55,948 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 118 of type 'DataSource' === 2015-02-06 16:31:55,949 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField' === 2015-02-06 16:31:55,949 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 119 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,950 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 119 of type 'DataSourceField' in the pooling flow === 2015-02-06 16:31:55,950 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 119 of type 'DataSourceField' === 2015-02-06 16:31:55,950 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'field' === 2015-02-06 16:31:55,950 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned === 2015-02-06 16:31:55,950 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow === 2015-02-06 16:31:55,951 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding' === 2015-02-06 16:31:55,951 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operationBinding' but null was returned === 2015-02-06 16:31:55,951 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow === 2015-02-06 16:31:55,951 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding' === 2015-02-06 16:31:55,952 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 120 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:55,952 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 120 of type 'OperationBinding' in the pooling flow === 2015-02-06 16:31:55,952 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 120 of type 'OperationBinding' === 2015-02-06 16:31:55,952 [ec-4] INFO SQLDataSource - Deriving dataSource BondsImpaired from table: BondsImpaired === 2015-02-06 16:31:55,953 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:55,963 [ec-4] DEBUG SQLConnectionManager - Borrowed connection '1290082656' === 2015-02-06 16:31:55,964 [ec-4] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='300385377' with passed Connection object hashCode='1290082656' === 2015-02-06 16:31:55,964 [ec-4] INFO SQLDSGenerator - Fetching column metadata for table: BondsImpaired === 2015-02-06 16:31:55,964 [ec-4] INFO SQLDSGenerator - =============Using catalog: fermat === 2015-02-06 16:31:55,998 [ec-4] INFO SQLDSGenerator - Fetching column metadata for BondsImpaired complete === 2015-02-06 16:31:56,028 [ec-4] DEBUG SQLConnectionManager - About to close with hashcode "1290082656" === 2015-02-06 16:31:56,028 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:56,040 [ec-4] DEBUG SQLDataSource - DataSource 121 acquired SQLDriver instance 1596879151 during initialization === 2015-02-06 16:31:56,041 [ec-4] DEBUG SQLDataSource - DataSource 122 acquired SQLDriver instance 1644754298 during initialization === 2015-02-06 16:31:56,041 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 122 of type 'BondsImpaired' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,042 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 122 of type 'BondsImpaired' in the pooling flow === 2015-02-06 16:31:56,042 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 122 of type 'BondsImpaired' === 2015-02-06 16:31:56,042 [ec-4] DEBUG DataSourceLoader - For DataSource 'BondsImpaired', got instanceId 122 === 2015-02-06 16:31:56,047 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 122 === 2015-02-06 16:31:56,047 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 122 === 2015-02-06 16:31:56,047 [ec-4] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 122 of type 'BondsImpaired' === 2015-02-06 16:31:56,047 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'BondStatus' === 2015-02-06 16:31:56,049 [ec-4] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/BondStatus.ds.xml: 2ms === 2015-02-06 16:31:56,049 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource' === 2015-02-06 16:31:56,050 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 123 of type 'DataSource' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,050 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 123 of type 'DataSource' in the pooling flow === 2015-02-06 16:31:56,050 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 123 of type 'DataSource' === 2015-02-06 16:31:56,050 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField' === 2015-02-06 16:31:56,051 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 124 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,051 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 124 of type 'DataSourceField' in the pooling flow === 2015-02-06 16:31:56,051 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 124 of type 'DataSourceField' === 2015-02-06 16:31:56,051 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'field' === 2015-02-06 16:31:56,051 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned === 2015-02-06 16:31:56,051 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow === 2015-02-06 16:31:56,052 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding' === 2015-02-06 16:31:56,052 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operationBinding' but null was returned === 2015-02-06 16:31:56,052 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow === 2015-02-06 16:31:56,052 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding' === 2015-02-06 16:31:56,052 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 125 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,052 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 125 of type 'OperationBinding' in the pooling flow === 2015-02-06 16:31:56,052 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 125 of type 'OperationBinding' === 2015-02-06 16:31:56,053 [ec-4] INFO SQLDataSource - Deriving dataSource BondStatus from table: BondStatus === 2015-02-06 16:31:56,053 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:56,063 [ec-4] DEBUG SQLConnectionManager - Borrowed connection '1290082656' === 2015-02-06 16:31:56,064 [ec-4] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='1781811624' with passed Connection object hashCode='1290082656' === 2015-02-06 16:31:56,064 [ec-4] INFO SQLDSGenerator - Fetching column metadata for table: BondStatus === 2015-02-06 16:31:56,064 [ec-4] INFO SQLDSGenerator - =============Using catalog: fermat === 2015-02-06 16:31:56,092 [ec-4] INFO SQLDSGenerator - Fetching column metadata for BondStatus complete === 2015-02-06 16:31:56,118 [ec-4] DEBUG SQLConnectionManager - About to close with hashcode "1290082656" === 2015-02-06 16:31:56,118 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:56,129 [ec-4] DEBUG SQLDataSource - DataSource 126 acquired SQLDriver instance 1812897344 during initialization === 2015-02-06 16:31:56,129 [ec-4] DEBUG SQLDataSource - DataSource 127 acquired SQLDriver instance 867676972 during initialization === 2015-02-06 16:31:56,129 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 127 of type 'BondStatus' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,129 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 127 of type 'BondStatus' in the pooling flow === 2015-02-06 16:31:56,129 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 127 of type 'BondStatus' === 2015-02-06 16:31:56,130 [ec-4] DEBUG DataSourceLoader - For DataSource 'BondStatus', got instanceId 127 === 2015-02-06 16:31:56,132 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 127 === 2015-02-06 16:31:56,132 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 127 === 2015-02-06 16:31:56,132 [ec-4] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 127 of type 'BondStatus' === 2015-02-06 16:31:56,132 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'BondTriggerData' === 2015-02-06 16:31:56,134 [ec-4] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/BondTriggerData.ds.xml: 2ms === 2015-02-06 16:31:56,134 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource' === 2015-02-06 16:31:56,135 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 128 of type 'DataSource' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,135 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 128 of type 'DataSource' in the pooling flow === 2015-02-06 16:31:56,135 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 128 of type 'DataSource' === 2015-02-06 16:31:56,135 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField' === 2015-02-06 16:31:56,136 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 129 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,136 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 129 of type 'DataSourceField' in the pooling flow === 2015-02-06 16:31:56,136 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 129 of type 'DataSourceField' === 2015-02-06 16:31:56,136 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'field' === 2015-02-06 16:31:56,136 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned === 2015-02-06 16:31:56,136 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow === 2015-02-06 16:31:56,138 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'ValueMap' === 2015-02-06 16:31:56,138 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 130 of type 'ValueMap' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,138 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 130 of type 'ValueMap' in the pooling flow === 2015-02-06 16:31:56,138 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 130 of type 'ValueMap' === 2015-02-06 16:31:56,139 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding' === 2015-02-06 16:31:56,139 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operationBinding' but null was returned === 2015-02-06 16:31:56,139 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow === 2015-02-06 16:31:56,139 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding' === 2015-02-06 16:31:56,139 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 131 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,139 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 131 of type 'OperationBinding' in the pooling flow === 2015-02-06 16:31:56,139 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 131 of type 'OperationBinding' === 2015-02-06 16:31:56,140 [ec-4] INFO SQLDataSource - Deriving dataSource BondTriggerData from table: bondtriggerdata === 2015-02-06 16:31:56,140 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:56,152 [ec-4] DEBUG SQLConnectionManager - Borrowed connection '1290082656' === 2015-02-06 16:31:56,152 [ec-4] DEBUG SQLMetaData - Created SQLMetaData instnace with hashCode='1088333500' with passed Connection object hashCode='1290082656' === 2015-02-06 16:31:56,152 [ec-4] INFO SQLDSGenerator - Fetching column metadata for table: bondtriggerdata === 2015-02-06 16:31:56,152 [ec-4] INFO SQLDSGenerator - =============Using catalog: fermat === 2015-02-06 16:31:56,181 [ec-4] INFO SQLDSGenerator - Fetching column metadata for bondtriggerdata complete === 2015-02-06 16:31:56,206 [ec-4] DEBUG SQLConnectionManager - About to close with hashcode "1290082656" === 2015-02-06 16:31:56,206 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:56,217 [ec-4] DEBUG SQLDataSource - DataSource 132 acquired SQLDriver instance 365113514 during initialization === 2015-02-06 16:31:56,217 [ec-4] DEBUG SQLDataSource - DataSource 133 acquired SQLDriver instance 1102050319 during initialization === 2015-02-06 16:31:56,218 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 133 of type 'BondTriggerData' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,218 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 133 of type 'BondTriggerData' in the pooling flow === 2015-02-06 16:31:56,218 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 133 of type 'BondTriggerData' === 2015-02-06 16:31:56,218 [ec-4] DEBUG DataSourceLoader - For DataSource 'BondTriggerData', got instanceId 133 === 2015-02-06 16:31:56,223 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 133 === 2015-02-06 16:31:56,223 [ec-4] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 133 === 2015-02-06 16:31:56,223 [ec-4] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 133 of type 'BondTriggerData' === 2015-02-06 16:31:56,223 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'borrow' === 2015-02-06 16:31:56,225 [ec-4] DEBUG XML - Parsed XML from /Users/mike/Library/Tomcat/apache-tomcat-7.0.27/webapps/Tables/ds/borrow.ds.xml: 2ms === 2015-02-06 16:31:56,225 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource' === 2015-02-06 16:31:56,226 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 134 of type 'DataSource' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,226 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 134 of type 'DataSource' in the pooling flow === 2015-02-06 16:31:56,226 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 134 of type 'DataSource' === 2015-02-06 16:31:56,227 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField' === 2015-02-06 16:31:56,227 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 135 of type 'DataSourceField' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,227 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 135 of type 'DataSourceField' in the pooling flow === 2015-02-06 16:31:56,227 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 135 of type 'DataSourceField' === 2015-02-06 16:31:56,227 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'field' === 2015-02-06 16:31:56,227 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned === 2015-02-06 16:31:56,227 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow === 2015-02-06 16:31:56,229 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding' === 2015-02-06 16:31:56,229 [ec-4] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operationBinding' but null was returned === 2015-02-06 16:31:56,229 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow === 2015-02-06 16:31:56,229 [ec-4] DEBUG ISCKeyedObjectPool - Borrowing object for 'OperationBinding' === 2015-02-06 16:31:56,229 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 136 of type 'OperationBinding' and assigned it to thread http-bio-8080-exec-4 === 2015-02-06 16:31:56,229 [ec-4] DEBUG PoolableDataSourceFactory - Created DataSource 136 of type 'OperationBinding' in the pooling flow === 2015-02-06 16:31:56,229 [ec-4] DEBUG PoolableDataSourceFactory - Activated DataSource 136 of type 'OperationBinding' === 2015-02-06 16:31:56,230 [ec-4] INFO SQLDataSource - Deriving dataSource borrow from table: borrow === 2015-02-06 16:31:56,230 [ec-4] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1290082656 === 2015-02-06 16:31:56,242 [ec-4] DEBUG SQLConnectionManager - Borrowed connection '12900826