I have a strange behavior when executing two successive fetchData(Criteria) queries with different criteria on the same tableView connected to a sql datasource. I use BASIC fetch mode.
Looking at the log I understand that for one fetch a count rows query is first calculated then a windowed query with all fields is executed with row limited to the result of the count query (or less if paged I suppose). The problem comes when a second fetch is executed with a different criteria hence with a different number of rows returned. It seems that the window size (number of row to limit the second query) is not updated properly. The limit remains the same as for the first fetch.
Proof: When you look at the following log, there are two fetch operations. One with the criteria person_samCode = 'cdr' and the second with person_samCode = 'ygo'. The first fetch is supposed to return 14 rows - and this is indeed the result of the first count query - and the second query gets windowed properly to 0-14. The second fetch is supposed to return 50 rows, the count query is properly formed (i.e. with the right new criteria 'ygo') but the select query is still windowed to 0-14, as in the first fetch, while the result of the count query in this second case is not 14 but 50 (this is not shown in the log but if I execute the count query in my DB I got 50 rows).
In the following log, the two queries are reversed, the 50 rows is executed first ('ygo' one) and the 14 rows second ('cdr' one). Here we see that both get windowed to 50 (result of first count). This shows that the window is not really updated after the first fetch.
Looking at the log I understand that for one fetch a count rows query is first calculated then a windowed query with all fields is executed with row limited to the result of the count query (or less if paged I suppose). The problem comes when a second fetch is executed with a different criteria hence with a different number of rows returned. It seems that the window size (number of row to limit the second query) is not updated properly. The limit remains the same as for the first fetch.
Proof: When you look at the following log, there are two fetch operations. One with the criteria person_samCode = 'cdr' and the second with person_samCode = 'ygo'. The first fetch is supposed to return 14 rows - and this is indeed the result of the first count query - and the second query gets windowed properly to 0-14. The second fetch is supposed to return 50 rows, the count query is properly formed (i.e. with the right new criteria 'ygo') but the select query is still windowed to 0-14, as in the first fetch, while the result of the count query in this second case is not 14 but 50 (this is not shown in the log but if I execute the count query in my DB I got 50 rows).
Code:
=== 2012-12-27 00:43:44,525 [l0-7] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Performing fetch operation with
criteria: {criteria:[{fieldName:"person_samCode",operator:"equals",value:"cdr"},{fieldName:"statusIs_final",operator:"equals",value:"false"}],operator:"and",_constructor:"AdvancedCriteria"} values: {criteria:[{fieldName:"person_samCode",operator:"equals",value:"cdr"},{fieldName:"statusIs_final",operator:"equals",value:"false"}],operator:"and",_constructor:"AdvancedCriteria"}
=== 2012-12-27 00:43:44,525 [l0-7] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-12-27 00:43:44,526 [l0-7] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Executing SQL query on 'Mysql': SELECT ui_grid_prospects._warnings, ui_grid_prospects.companyName_short, ui_grid_prospects.countryCode, ui_grid_prospects.id, ui_grid_prospects.mobileIcon, ui_grid_prospects.mobileIconDebug, ui_grid_prospects.name_short, ui_grid_prospects.person_samCode, ui_grid_prospects.sectorName, ui_grid_prospects.statusBudget_total, ui_grid_prospects.statusCurrency, ui_grid_prospects.statusDate_close, ui_grid_prospects.statusIs_final, ui_grid_prospects.statusLikelihood, ui_grid_prospects.statusName FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'cdr' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL))
=== 2012-12-27 00:43:44,526 [l0-7] DEBUG PoolableSQLConnectionFactory - [builtinApplication.mb_grid_prospects_fetch] Executing pingTest 'select 1 from dual' on connection 859802444
=== 2012-12-27 00:43:44,526 [l0-7] DEBUG SQLConnectionManager - [builtinApplication.mb_grid_prospects_fetch] Returning borrowed connection '859802444'
=== 2012-12-27 00:43:44,526 [l0-7] DEBUG SQLDriver - [builtinApplication.mb_grid_prospects_fetch] About to execute SQL query in 'Mysql' using connection '859802444'
=== 2012-12-27 00:43:44,526 [l0-7] INFO SQLDriver - [builtinApplication.mb_grid_prospects_fetch] Executing SQL query on 'Mysql': SELECT ui_grid_prospects._warnings, ui_grid_prospects.companyName_short, ui_grid_prospects.countryCode, ui_grid_prospects.id, ui_grid_prospects.mobileIcon, ui_grid_prospects.mobileIconDebug, ui_grid_prospects.name_short, ui_grid_prospects.person_samCode, ui_grid_prospects.sectorName, ui_grid_prospects.statusBudget_total, ui_grid_prospects.statusCurrency, ui_grid_prospects.statusDate_close, ui_grid_prospects.statusIs_final, ui_grid_prospects.statusLikelihood, ui_grid_prospects.statusName FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'cdr' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL))
=== 2012-12-27 00:43:44,567 [l0-7] INFO DSResponse - [builtinApplication.mb_grid_prospects_fetch] DSResponse: List with 14 items
=== 2012-12-27 00:43:44,567 [l0-7] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "859802444"
=== 2012-12-27 00:43:44,567 [l0-7] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 859802444
=== 2012-12-27 00:43:44,568 [l0-7] DEBUG RPCManager - Content type for RPC transaction: text/html; charset=UTF-8
=== 2012-12-27 00:43:44,569 [l0-7] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-12-27 00:44:18,850 [l0-6] INFO RequestContext - URL: '/isomorphic/RESTHandler', User-Agent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_7_5) AppleWebKit/537.11 (KHTML, like Gecko) Chrome/23.0.1271.101 Safari/537.11': Safari with Accept-Encoding header
=== 2012-12-27 00:44:18,851 [l0-6] DEBUG RestRequestParser - Parsing json object: '{"endRow":14,"transactionNum":3,"dataSource":"mb_grid_prospects","sortBy":null,"operationType":"fetch","requestId":"3","startRow":0,"showPrompt":null,"data":{"_constructor":"AdvancedCriteria","operator":"and","criteria":[{"fieldName":"person_samCode","operator":"equals","value":"ygo"},{"fieldName":"statusIs_final","operator":"equals","value":false}]}}'
=== 2012-12-27 00:44:18,860 [l0-6] DEBUG RestRequestParser - Parameter:'isc_dataFormat'. Value:'json'.
=== 2012-12-27 00:44:18,862 [l0-6] INFO RESTHandler - Performing 1 operation(s)
=== 2012-12-27 00:44:18,862 [l0-6] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2012-12-27 00:44:18,863 [l0-6] DEBUG DeclarativeSecurity - DataSource mb_grid_prospects is not in the pre-checked list, processing...
=== 2012-12-27 00:44:18,863 [l0-6] DEBUG AppBase - [builtinApplication.mb_grid_prospects_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-12-27 00:44:18,863 [l0-6] DEBUG AppBase - [builtinApplication.mb_grid_prospects_fetch] No public zero-argument method named '_mb_grid_prospects_fetch' found, performing generic datasource operation
=== 2012-12-27 00:44:18,863 [l0-6] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Performing fetch operation with
criteria: {criteria:[{fieldName:"person_samCode",operator:"equals",value:"ygo"},{fieldName:"statusIs_final",operator:"equals",value:"false"}],operator:"and",_constructor:"AdvancedCriteria"} values: {criteria:[{fieldName:"person_samCode",operator:"equals",value:"ygo"},{fieldName:"statusIs_final",operator:"equals",value:"false"}],operator:"and",_constructor:"AdvancedCriteria"}
=== 2012-12-27 00:44:18,864 [l0-6] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-12-27 00:44:18,864 [l0-6] DEBUG SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-12-27 00:44:18,864 [l0-6] DEBUG SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Eval'd row count query: SELECT COUNT(*) FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'ygo' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL))
=== 2012-12-27 00:44:18,865 [l0-6] DEBUG PoolableSQLConnectionFactory - [builtinApplication.mb_grid_prospects_fetch] Executing pingTest 'select 1 from dual' on connection 859802444
=== 2012-12-27 00:44:18,865 [l0-6] DEBUG SQLConnectionManager - [builtinApplication.mb_grid_prospects_fetch] Returning borrowed connection '859802444'
=== 2012-12-27 00:44:18,865 [l0-6] DEBUG SQLDriver - [builtinApplication.mb_grid_prospects_fetch] About to execute SQL query in 'Mysql' using connection '859802444'
=== 2012-12-27 00:44:18,865 [l0-6] INFO SQLDriver - [builtinApplication.mb_grid_prospects_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'ygo' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL))
=== 2012-12-27 00:44:18,897 [l0-6] DEBUG SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Using SQL Limit query
=== 2012-12-27 00:44:18,897 [l0-6] DEBUG SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] SQL windowed select rows 0->14, result size 14. Query: SELECT ui_grid_prospects._warnings, ui_grid_prospects.companyName_short, ui_grid_prospects.countryCode, ui_grid_prospects.id, ui_grid_prospects.mobileIcon, ui_grid_prospects.mobileIconDebug, ui_grid_prospects.name_short, ui_grid_prospects.person_samCode, ui_grid_prospects.sectorName, ui_grid_prospects.statusBudget_total, ui_grid_prospects.statusCurrency, ui_grid_prospects.statusDate_close, ui_grid_prospects.statusIs_final, ui_grid_prospects.statusLikelihood, ui_grid_prospects.statusName FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'ygo' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL)) LIMIT 0, 14
=== 2012-12-27 00:44:18,897 [l0-6] DEBUG PoolableSQLConnectionFactory - [builtinApplication.mb_grid_prospects_fetch] Executing pingTest 'select 1 from dual' on connection 1551980018
=== 2012-12-27 00:44:18,897 [l0-6] DEBUG SQLConnectionManager - [builtinApplication.mb_grid_prospects_fetch] Returning borrowed connection '1551980018'
=== 2012-12-27 00:44:18,940 [l0-6] INFO DSResponse - [builtinApplication.mb_grid_prospects_fetch] DSResponse: List with 14 items
=== 2012-12-27 00:44:18,941 [l0-6] DEBUG SQLConnectionManager - [builtinApplication.mb_grid_prospects_fetch] About to close PoolableConnection with hashcode "1551980018"
=== 2012-12-27 00:44:18,941 [l0-6] DEBUG PoolableSQLConnectionFactory - [builtinApplication.mb_grid_prospects_fetch] Executing pingTest 'select 1 from dual' on connection 1551980018
=== 2012-12-27 00:44:18,941 [l0-6] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "859802444"
=== 2012-12-27 00:44:18,941 [l0-6] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 859802444
=== 2012-12-27 00:44:18,942 [l0-6] DEBUG RPCManager - Content type for RPC transaction: text/html; charset=UTF-8
=== 2012-12-27 00:44:18,943 [l0-6] DEBUG RPCManager - non-DMI response, dropExtraFields: false
Code:
=== 2012-12-27 01:04:49,626 [l0-8] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Performing fetch operation with
criteria: {criteria:[{fieldName:"person_samCode",operator:"equals",value:"ygo"},{fieldName:"statusIs_final",operator:"equals",value:"false"}],operator:"and",_constructor:"AdvancedCriteria"} values: {criteria:[{fieldName:"person_samCode",operator:"equals",value:"ygo"},{fieldName:"statusIs_final",operator:"equals",value:"false"}],operator:"and",_constructor:"AdvancedCriteria"}
=== 2012-12-27 01:04:49,627 [l0-8] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-12-27 01:04:49,627 [l0-8] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Executing SQL query on 'Mysql': SELECT ui_grid_prospects._warnings, ui_grid_prospects.companyName_short, ui_grid_prospects.countryCode, ui_grid_prospects.id, ui_grid_prospects.mobileIcon, ui_grid_prospects.mobileIconDebug, ui_grid_prospects.name_short, ui_grid_prospects.person_samCode, ui_grid_prospects.sectorName, ui_grid_prospects.statusBudget_total, ui_grid_prospects.statusCurrency, ui_grid_prospects.statusDate_close, ui_grid_prospects.statusIs_final, ui_grid_prospects.statusLikelihood, ui_grid_prospects.statusName FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'ygo' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL))
=== 2012-12-27 01:04:49,627 [l0-8] DEBUG PoolableSQLConnectionFactory - [builtinApplication.mb_grid_prospects_fetch] Executing pingTest 'select 1 from dual' on connection 859802444
=== 2012-12-27 01:04:49,628 [l0-8] DEBUG SQLConnectionManager - [builtinApplication.mb_grid_prospects_fetch] Returning borrowed connection '859802444'
=== 2012-12-27 01:04:49,628 [l0-8] DEBUG SQLDriver - [builtinApplication.mb_grid_prospects_fetch] About to execute SQL query in 'Mysql' using connection '859802444'
=== 2012-12-27 01:04:49,628 [l0-8] INFO SQLDriver - [builtinApplication.mb_grid_prospects_fetch] Executing SQL query on 'Mysql': SELECT ui_grid_prospects._warnings, ui_grid_prospects.companyName_short, ui_grid_prospects.countryCode, ui_grid_prospects.id, ui_grid_prospects.mobileIcon, ui_grid_prospects.mobileIconDebug, ui_grid_prospects.name_short, ui_grid_prospects.person_samCode, ui_grid_prospects.sectorName, ui_grid_prospects.statusBudget_total, ui_grid_prospects.statusCurrency, ui_grid_prospects.statusDate_close, ui_grid_prospects.statusIs_final, ui_grid_prospects.statusLikelihood, ui_grid_prospects.statusName FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'ygo' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL))
=== 2012-12-27 01:04:49,675 [l0-8] INFO DSResponse - [builtinApplication.mb_grid_prospects_fetch] DSResponse: List with 50 items
=== 2012-12-27 01:04:49,675 [l0-8] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "859802444"
=== 2012-12-27 01:04:49,675 [l0-8] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 859802444
=== 2012-12-27 01:04:49,676 [l0-8] DEBUG RPCManager - Content type for RPC transaction: text/html; charset=UTF-8
=== 2012-12-27 01:04:49,676 [l0-8] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-12-27 01:05:27,496 [l0-5] INFO RequestContext - URL: '/isomorphic/RESTHandler', User-Agent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_7_5) AppleWebKit/537.11 (KHTML, like Gecko) Chrome/23.0.1271.101 Safari/537.11': Safari with Accept-Encoding header
=== 2012-12-27 01:05:27,497 [l0-5] DEBUG RestRequestParser - Parsing json object: '{"endRow":50,"transactionNum":3,"dataSource":"mb_grid_prospects","sortBy":null,"operationType":"fetch","requestId":"3","startRow":0,"showPrompt":null,"data":{"_constructor":"AdvancedCriteria","operator":"and","criteria":[{"fieldName":"person_samCode","operator":"equals","value":"cdr"},{"fieldName":"statusIs_final","operator":"equals","value":false}]}}'
=== 2012-12-27 01:05:27,506 [l0-5] DEBUG RestRequestParser - Parameter:'isc_dataFormat'. Value:'json'.
=== 2012-12-27 01:05:27,507 [l0-5] INFO RESTHandler - Performing 1 operation(s)
=== 2012-12-27 01:05:27,507 [l0-5] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2012-12-27 01:05:27,507 [l0-5] DEBUG DeclarativeSecurity - DataSource mb_grid_prospects is not in the pre-checked list, processing...
=== 2012-12-27 01:05:27,508 [l0-5] DEBUG AppBase - [builtinApplication.mb_grid_prospects_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-12-27 01:05:27,508 [l0-5] DEBUG AppBase - [builtinApplication.mb_grid_prospects_fetch] No public zero-argument method named '_mb_grid_prospects_fetch' found, performing generic datasource operation
=== 2012-12-27 01:05:27,508 [l0-5] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Performing fetch operation with
criteria: {criteria:[{fieldName:"person_samCode",operator:"equals",value:"cdr"},{fieldName:"statusIs_final",operator:"equals",value:"false"}],operator:"and",_constructor:"AdvancedCriteria"} values: {criteria:[{fieldName:"person_samCode",operator:"equals",value:"cdr"},{fieldName:"statusIs_final",operator:"equals",value:"false"}],operator:"and",_constructor:"AdvancedCriteria"}
=== 2012-12-27 01:05:27,508 [l0-5] INFO SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-12-27 01:05:27,509 [l0-5] DEBUG SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-12-27 01:05:27,509 [l0-5] DEBUG SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Eval'd row count query: SELECT COUNT(*) FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'cdr' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL))
=== 2012-12-27 01:05:27,509 [l0-5] DEBUG PoolableSQLConnectionFactory - [builtinApplication.mb_grid_prospects_fetch] Executing pingTest 'select 1 from dual' on connection 859802444
=== 2012-12-27 01:05:27,510 [l0-5] DEBUG SQLConnectionManager - [builtinApplication.mb_grid_prospects_fetch] Returning borrowed connection '859802444'
=== 2012-12-27 01:05:27,510 [l0-5] DEBUG SQLDriver - [builtinApplication.mb_grid_prospects_fetch] About to execute SQL query in 'Mysql' using connection '859802444'
=== 2012-12-27 01:05:27,510 [l0-5] INFO SQLDriver - [builtinApplication.mb_grid_prospects_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'cdr' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL))
=== 2012-12-27 01:05:27,542 [l0-5] DEBUG SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] Using SQL Limit query
=== 2012-12-27 01:05:27,542 [l0-5] DEBUG SQLDataSource - [builtinApplication.mb_grid_prospects_fetch] SQL windowed select rows 0->50, result size 50. Query: SELECT ui_grid_prospects._warnings, ui_grid_prospects.companyName_short, ui_grid_prospects.countryCode, ui_grid_prospects.id, ui_grid_prospects.mobileIcon, ui_grid_prospects.mobileIconDebug, ui_grid_prospects.name_short, ui_grid_prospects.person_samCode, ui_grid_prospects.sectorName, ui_grid_prospects.statusBudget_total, ui_grid_prospects.statusCurrency, ui_grid_prospects.statusDate_close, ui_grid_prospects.statusIs_final, ui_grid_prospects.statusLikelihood, ui_grid_prospects.statusName FROM ui_grid_prospects WHERE ((ui_grid_prospects.person_samCode = 'cdr' AND ui_grid_prospects.person_samCode IS NOT NULL) AND (ui_grid_prospects.statusIs_final = 0 AND ui_grid_prospects.statusIs_final IS NOT NULL)) LIMIT 0, 50
=== 2012-12-27 01:05:27,543 [l0-5] DEBUG PoolableSQLConnectionFactory - [builtinApplication.mb_grid_prospects_fetch] Executing pingTest 'select 1 from dual' on connection 1551980018
=== 2012-12-27 01:05:27,543 [l0-5] DEBUG SQLConnectionManager - [builtinApplication.mb_grid_prospects_fetch] Returning borrowed connection '1551980018'
=== 2012-12-27 01:05:27,577 [l0-5] INFO DSResponse - [builtinApplication.mb_grid_prospects_fetch] DSResponse: List with 14 items
=== 2012-12-27 01:05:27,577 [l0-5] DEBUG SQLConnectionManager - [builtinApplication.mb_grid_prospects_fetch] About to close PoolableConnection with hashcode "1551980018"
=== 2012-12-27 01:05:27,577 [l0-5] DEBUG PoolableSQLConnectionFactory - [builtinApplication.mb_grid_prospects_fetch] Executing pingTest 'select 1 from dual' on connection 1551980018
=== 2012-12-27 01:05:27,577 [l0-5] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "859802444"
=== 2012-12-27 01:05:27,577 [l0-5] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 859802444
=== 2012-12-27 01:05:27,578 [l0-5] DEBUG RPCManager - Content type for RPC transaction: text/html; charset=UTF-8
=== 2012-12-27 01:05:27,579 [l0-5] DEBUG RPCManager - non-DMI response, dropExtraFields: false
Comment