=== 2012-07-18 16:58:24,982 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war
[WARN] Server class 'com.isomorphic.compression.ServletCompression' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/isomorphic_compression.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
log4j:WARN No appenders could be found for logger (org.apache.jasper.compiler.JspRuntimeContext).
log4j:WARN Please initialize the log4j system properly.
[WARN] Server class 'org.apache.commons.fileupload.FileItemFactory' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/commons-fileupload-1.2.1.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:45,600 [l0-0] INFO  RequestContext - URL: '/BuiltInDS.html', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:58:45,610 [l0-0] INFO  Compression - /BuiltInDS.html: 1998 -> 896 bytes
=== 2012-07-18 16:58:45,656 [l0-0] INFO  RequestContext - URL: '/builtinds/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
[WARN] Server class 'org.apache.commons.pool.impl.GenericKeyedObjectPool' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/commons-pool-1.4.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:45,688 [l0-0] INFO  PoolManager - SmartClient pooling disabled for 'productCharacteristicsSQL' objects
[WARN] Server class 'org.apache.commons.jxpath.AbstractFactory' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/commons-jxpath-1.3.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:45,723 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\builtinds\sc\system\schema\builtinTypes.xml: 7ms
=== 2012-07-18 16:58:45,736 [l0-6] INFO  Compression - /builtinds/sc/modules/ISC_Core.js: 705501 -> 182712 bytes
=== 2012-07-18 16:58:45,779 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\productCharacteristicsSQL.ds.xml: 2ms
=== 2012-07-18 16:58:45,785 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\builtinds\sc\system\schema\DataSource.ds.xml: 5ms
[WARN] Server class 'org.apache.velocity.context.Context' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/velocity-1.6.1.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:45,874 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\builtinds\sc\system\schema\DataSourceField.ds.xml: 4ms
[WARN] Server class 'com.isomorphic.sql.SQLDataSource' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/isomorphic_sql.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:45,917 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\characteristicSQL.ds.xml: 1ms
=== 2012-07-18 16:58:45,929 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\productSQL.ds.xml: 1ms
=== 2012-07-18 16:58:45,947 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\animals.ds.xml: 1ms
=== 2012-07-18 16:58:45,960 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\builtinds\sc\system\schema\ValueMap.ds.xml: 2ms
=== 2012-07-18 16:58:45,969 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\employees.ds.xml: 2ms
=== 2012-07-18 16:58:45,982 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\employeesSQL.ds.xml: 3ms
=== 2012-07-18 16:58:45,996 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\contactSQL.ds.xml: 2ms
=== 2012-07-18 16:58:46,008 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\productTypeSQL.ds.xml: 2ms
=== 2012-07-18 16:58:46,018 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\ds\approveBySQL.ds.xml: 3ms
=== 2012-07-18 16:58:46,031 [l0-0] INFO  Compression - /builtinds/sc/DataSourceLoader: 12181 -> 1568 bytes
=== 2012-07-18 16:58:50,362 [l0-0] INFO  RequestContext - URL: '/favicon.ico', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:58:53,508 [l0-0] INFO  RequestContext - URL: '/builtinds/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
[WARN] Server class 'org.apache.commons.codec.net.URLCodec' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/commons-codec-1.3.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:53,531 [l0-0] DEBUG XML - Parsed XML from (in memory stream): 2ms
=== 2012-07-18 16:58:53,533 [l0-0] DEBUG XML - Parsed XML from C:\smartGwt\smartgwtee-3.0\samples\built-in-ds\war\builtinds\sc\system\schema\List.ds.xml: 1ms
=== 2012-07-18 16:58:53,537 [l0-0] DEBUG RPCManager - Processing 1 requests.
=== 2012-07-18 16:58:53,552 [l0-0] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        __gwt_ObjectId:124
    },
    operationConfig:{
        dataSource:"productSQL",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_0",
    appID:"builtinApplication",
    operation:"productSQL_fetch",
    oldValues:{
        __gwt_ObjectId:124
    }
}
=== 2012-07-18 16:58:53,556 [l0-0] INFO  IDACall - Performing 1 operation(s)
=== 2012-07-18 16:58:53,566 [l0-0] DEBUG AppBase - [builtinApplication.productSQL_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-07-18 16:58:53,566 [l0-0] DEBUG AppBase - [builtinApplication.productSQL_fetch] No public zero-argument method named '_productSQL_fetch' found, performing generic datasource operation
=== 2012-07-18 16:58:53,566 [l0-0] INFO  SQLDataSource - [builtinApplication.productSQL_fetch] Performing fetch operation with
	criteria: {__gwt_ObjectId:124}	values: {__gwt_ObjectId:124}
=== 2012-07-18 16:58:53,577 [l0-0] INFO  SQLDataSource - [builtinApplication.productSQL_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
[WARN] Server class 'org.apache.commons.lang.StringUtils' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/commons-lang-2.4.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:53,692 [l0-0] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:53,693 [l0-0] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Eval'd row count query: SELECT COUNT(*) FROM product WHERE ('1'='1')
[WARN] Server class 'com.isomorphic.hibernate.HibernateDataSource' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/isomorphic_hibernate.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
[WARN] Server class 'org.hibernate.criterion.Conjunction' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/hibernate3.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:53,734 [l0-6] INFO  RequestContext - URL: '/builtinds/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:58:53,741 [l0-6] DEBUG XML - Parsed XML from (in memory stream): 6ms
=== 2012-07-18 16:58:53,749 [l0-6] DEBUG RPCManager - Processing 1 requests.
=== 2012-07-18 16:58:53,752 [l0-6] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        __gwt_ObjectId:216
    },
    operationConfig:{
        dataSource:"productSQL",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_0",
    appID:"builtinApplication",
    operation:"productSQL_fetch",
    oldValues:{
        __gwt_ObjectId:216
    }
}
=== 2012-07-18 16:58:53,753 [l0-6] INFO  IDACall - Performing 1 operation(s)
=== 2012-07-18 16:58:53,753 [l0-6] DEBUG AppBase - [builtinApplication.productSQL_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-07-18 16:58:53,753 [l0-6] DEBUG AppBase - [builtinApplication.productSQL_fetch] No public zero-argument method named '_productSQL_fetch' found, performing generic datasource operation
=== 2012-07-18 16:58:53,754 [l0-6] INFO  SQLDataSource - [builtinApplication.productSQL_fetch] Performing fetch operation with
	criteria: {__gwt_ObjectId:216}	values: {__gwt_ObjectId:216}
=== 2012-07-18 16:58:53,754 [l0-6] INFO  SQLDataSource - [builtinApplication.productSQL_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:53,755 [l0-6] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:53,756 [l0-6] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Eval'd row count query: SELECT COUNT(*) FROM product WHERE ('1'='1')
=== 2012-07-18 16:58:53,777 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Initializing SQL config for 'Mysql' from system config - using DataSource:  com.mysql.jdbc.jdbc2.optional.MysqlDataSource
=== 2012-07-18 16:58:54,033 [l0-4] INFO  RequestContext - URL: '/builtinds/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:58:54,033 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Returning pooled Connection
[WARN] Server class 'org.apache.commons.dbcp.PoolableConnection' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/smartGwt/smartgwtee-3.0/lib/commons-dbcp-1.2.2.jar' to the web app classpath for this session
   For additional info see: file:/D:/Program%20Files/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.4.0.v201112160242-rel-r37/gwt-2.4.0/doc/helpInfo/webAppClassPath.html
=== 2012-07-18 16:58:54,035 [l0-6] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:54,042 [l0-4] DEBUG XML - Parsed XML from (in memory stream): 8ms
=== 2012-07-18 16:58:54,045 [l0-4] DEBUG RPCManager - Processing 1 requests.
=== 2012-07-18 16:58:54,045 [l0-0] INFO  SQLDriver - [builtinApplication.productSQL_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM product WHERE ('1'='1')
=== 2012-07-18 16:58:54,045 [l0-6] INFO  SQLDriver - [builtinApplication.productSQL_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM product WHERE ('1'='1')
=== 2012-07-18 16:58:54,046 [l0-4] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        __gwt_ObjectId:276
    },
    operationConfig:{
        dataSource:"productSQL",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_0",
    appID:"builtinApplication",
    operation:"productSQL_fetch",
    oldValues:{
        __gwt_ObjectId:276
    }
}
=== 2012-07-18 16:58:54,047 [l0-4] INFO  IDACall - Performing 1 operation(s)
=== 2012-07-18 16:58:54,047 [l0-4] DEBUG AppBase - [builtinApplication.productSQL_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-07-18 16:58:54,047 [l0-4] DEBUG AppBase - [builtinApplication.productSQL_fetch] No public zero-argument method named '_productSQL_fetch' found, performing generic datasource operation
=== 2012-07-18 16:58:54,047 [l0-4] INFO  SQLDataSource - [builtinApplication.productSQL_fetch] Performing fetch operation with
	criteria: {__gwt_ObjectId:276}	values: {__gwt_ObjectId:276}
=== 2012-07-18 16:58:54,048 [l0-4] INFO  SQLDataSource - [builtinApplication.productSQL_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:54,048 [l0-4] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:54,049 [l0-4] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Eval'd row count query: SELECT COUNT(*) FROM product WHERE ('1'='1')
=== 2012-07-18 16:58:54,054 [l0-6] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Using SQL Limit query
=== 2012-07-18 16:58:54,055 [l0-6] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT product.description, product.id, product.name FROM product WHERE ('1'='1') LIMIT 0, 75
=== 2012-07-18 16:58:54,054 [l0-0] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Using SQL Limit query
=== 2012-07-18 16:58:54,055 [l0-0] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT product.description, product.id, product.name FROM product WHERE ('1'='1') LIMIT 0, 75
=== 2012-07-18 16:58:54,060 [l0-4] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:54,060 [l0-4] INFO  SQLDriver - [builtinApplication.productSQL_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM product WHERE ('1'='1')
=== 2012-07-18 16:58:54,061 [l0-4] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Using SQL Limit query
=== 2012-07-18 16:58:54,061 [l0-4] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT product.description, product.id, product.name FROM product WHERE ('1'='1') LIMIT 0, 75
=== 2012-07-18 16:58:54,065 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:54,067 [l0-6] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:54,068 [l0-0] INFO  DSResponse - [builtinApplication.productSQL_fetch] DSResponse: List with 2 items
=== 2012-07-18 16:58:54,068 [l0-6] INFO  DSResponse - [builtinApplication.productSQL_fetch] DSResponse: List with 2 items
=== 2012-07-18 16:58:54,070 [l0-6] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-07-18 16:58:54,070 [l0-0] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-07-18 16:58:54,071 [l0-0] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-07-18 16:58:54,072 [l0-6] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-07-18 16:58:54,074 [l0-6] INFO  Compression - /builtinds/sc/IDACall: 262 -> 187 bytes
=== 2012-07-18 16:58:54,074 [l0-4] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:54,075 [l0-0] INFO  Compression - /builtinds/sc/IDACall: 262 -> 187 bytes
=== 2012-07-18 16:58:54,075 [l0-4] INFO  DSResponse - [builtinApplication.productSQL_fetch] DSResponse: List with 2 items
=== 2012-07-18 16:58:54,075 [l0-4] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-07-18 16:58:54,076 [l0-4] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-07-18 16:58:54,077 [l0-4] INFO  Compression - /builtinds/sc/IDACall: 262 -> 187 bytes
=== 2012-07-18 16:58:56,491 [l0-4] INFO  RequestContext - URL: '/builtinds/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:58:56,493 [l0-4] DEBUG XML - Parsed XML from (in memory stream): 2ms
=== 2012-07-18 16:58:56,496 [l0-4] DEBUG RPCManager - Processing 1 requests.
=== 2012-07-18 16:58:56,497 [l0-4] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        __gwt_ObjectId:329
    },
    operationConfig:{
        dataSource:"productSQL",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_0",
    appID:"builtinApplication",
    operation:"productSQL_fetch",
    oldValues:{
        __gwt_ObjectId:329
    }
}
=== 2012-07-18 16:58:56,497 [l0-4] INFO  IDACall - Performing 1 operation(s)
=== 2012-07-18 16:58:56,497 [l0-4] DEBUG AppBase - [builtinApplication.productSQL_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-07-18 16:58:56,497 [l0-4] DEBUG AppBase - [builtinApplication.productSQL_fetch] No public zero-argument method named '_productSQL_fetch' found, performing generic datasource operation
=== 2012-07-18 16:58:56,498 [l0-4] INFO  SQLDataSource - [builtinApplication.productSQL_fetch] Performing fetch operation with
	criteria: {__gwt_ObjectId:329}	values: {__gwt_ObjectId:329}
=== 2012-07-18 16:58:56,498 [l0-4] INFO  SQLDataSource - [builtinApplication.productSQL_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:56,498 [l0-4] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:56,499 [l0-4] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Eval'd row count query: SELECT COUNT(*) FROM product WHERE ('1'='1')
=== 2012-07-18 16:58:56,506 [l0-4] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:56,506 [l0-4] INFO  SQLDriver - [builtinApplication.productSQL_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM product WHERE ('1'='1')
=== 2012-07-18 16:58:56,506 [l0-4] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] Using SQL Limit query
=== 2012-07-18 16:58:56,506 [l0-4] DEBUG SQLDataSource - [builtinApplication.productSQL_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT product.description, product.id, product.name FROM product WHERE ('1'='1') LIMIT 0, 75
=== 2012-07-18 16:58:56,515 [l0-4] DEBUG PoolableSQLConnectionFactory - [builtinApplication.productSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:56,516 [l0-4] INFO  DSResponse - [builtinApplication.productSQL_fetch] DSResponse: List with 2 items
=== 2012-07-18 16:58:56,517 [l0-4] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-07-18 16:58:56,517 [l0-4] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-07-18 16:58:56,518 [l0-4] INFO  Compression - /builtinds/sc/IDACall: 262 -> 187 bytes
=== 2012-07-18 16:58:59,595 [l0-4] INFO  RequestContext - URL: '/builtinds/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:58:59,600 [l0-4] DEBUG XML - Parsed XML from (in memory stream): 3ms
=== 2012-07-18 16:58:59,602 [l0-4] DEBUG RPCManager - Processing 1 requests.
=== 2012-07-18 16:58:59,603 [l0-4] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        __gwt_ObjectId:378
    },
    operationConfig:{
        dataSource:"characteristicSQL",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_1",
    appID:"builtinApplication",
    operation:"characteristicSQL_fetch",
    oldValues:{
        __gwt_ObjectId:378
    }
}
=== 2012-07-18 16:58:59,603 [l0-4] INFO  IDACall - Performing 1 operation(s)
=== 2012-07-18 16:58:59,603 [l0-4] DEBUG AppBase - [builtinApplication.characteristicSQL_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-07-18 16:58:59,603 [l0-4] DEBUG AppBase - [builtinApplication.characteristicSQL_fetch] No public zero-argument method named '_characteristicSQL_fetch' found, performing generic datasource operation
=== 2012-07-18 16:58:59,604 [l0-4] INFO  SQLDataSource - [builtinApplication.characteristicSQL_fetch] Performing fetch operation with
	criteria: {__gwt_ObjectId:378}	values: {__gwt_ObjectId:378}
=== 2012-07-18 16:58:59,604 [l0-4] INFO  SQLDataSource - [builtinApplication.characteristicSQL_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:59,604 [l0-4] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:59,604 [l0-4] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Eval'd row count query: SELECT COUNT(*) FROM characteristic WHERE ('1'='1')
=== 2012-07-18 16:58:59,612 [l0-4] DEBUG PoolableSQLConnectionFactory - [builtinApplication.characteristicSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:59,612 [l0-4] INFO  SQLDriver - [builtinApplication.characteristicSQL_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM characteristic WHERE ('1'='1')
=== 2012-07-18 16:58:59,612 [l0-4] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Using SQL Limit query
=== 2012-07-18 16:58:59,612 [l0-4] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT characteristic.description, characteristic.id, characteristic.name FROM characteristic WHERE ('1'='1') LIMIT 0, 75
=== 2012-07-18 16:58:59,620 [l0-0] INFO  RequestContext - URL: '/builtinds/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:58:59,623 [l0-0] DEBUG XML - Parsed XML from (in memory stream): 2ms
=== 2012-07-18 16:58:59,624 [l0-4] DEBUG PoolableSQLConnectionFactory - [builtinApplication.characteristicSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:59,626 [l0-0] DEBUG RPCManager - Processing 1 requests.
=== 2012-07-18 16:58:59,627 [l0-0] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        __gwt_ObjectId:385
    },
    operationConfig:{
        dataSource:"characteristicSQL",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_1",
    appID:"builtinApplication",
    operation:"characteristicSQL_fetch",
    oldValues:{
        __gwt_ObjectId:385
    }
}
=== 2012-07-18 16:58:59,627 [l0-0] INFO  IDACall - Performing 1 operation(s)
=== 2012-07-18 16:58:59,627 [l0-0] DEBUG AppBase - [builtinApplication.characteristicSQL_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-07-18 16:58:59,628 [l0-0] DEBUG AppBase - [builtinApplication.characteristicSQL_fetch] No public zero-argument method named '_characteristicSQL_fetch' found, performing generic datasource operation
=== 2012-07-18 16:58:59,628 [l0-4] INFO  DSResponse - [builtinApplication.characteristicSQL_fetch] DSResponse: List with 3 items
=== 2012-07-18 16:58:59,628 [l0-0] INFO  SQLDataSource - [builtinApplication.characteristicSQL_fetch] Performing fetch operation with
	criteria: {__gwt_ObjectId:385}	values: {__gwt_ObjectId:385}
=== 2012-07-18 16:58:59,628 [l0-0] INFO  SQLDataSource - [builtinApplication.characteristicSQL_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:59,628 [l0-4] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-07-18 16:58:59,628 [l0-4] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-07-18 16:58:59,630 [l0-4] INFO  Compression - /builtinds/sc/IDACall: 307 -> 196 bytes
=== 2012-07-18 16:58:59,630 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:59,630 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Eval'd row count query: SELECT COUNT(*) FROM characteristic WHERE ('1'='1')
=== 2012-07-18 16:58:59,636 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.characteristicSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:59,636 [l0-0] INFO  SQLDriver - [builtinApplication.characteristicSQL_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM characteristic WHERE ('1'='1')
=== 2012-07-18 16:58:59,637 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Using SQL Limit query
=== 2012-07-18 16:58:59,637 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT characteristic.description, characteristic.id, characteristic.name FROM characteristic WHERE ('1'='1') LIMIT 0, 75
=== 2012-07-18 16:58:59,643 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.characteristicSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:59,644 [l0-0] INFO  DSResponse - [builtinApplication.characteristicSQL_fetch] DSResponse: List with 3 items
=== 2012-07-18 16:58:59,645 [l0-0] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-07-18 16:58:59,645 [l0-0] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-07-18 16:58:59,647 [l0-0] INFO  Compression - /builtinds/sc/IDACall: 307 -> 196 bytes
=== 2012-07-18 16:58:59,662 [l0-0] INFO  RequestContext - URL: '/builtinds/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:58:59,664 [l0-0] DEBUG XML - Parsed XML from (in memory stream): 2ms
=== 2012-07-18 16:58:59,664 [l0-0] DEBUG RPCManager - Processing 1 requests.
=== 2012-07-18 16:58:59,665 [l0-0] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        __gwt_ObjectId:392
    },
    operationConfig:{
        dataSource:"characteristicSQL",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_1",
    appID:"builtinApplication",
    operation:"characteristicSQL_fetch",
    oldValues:{
        __gwt_ObjectId:392
    }
}
=== 2012-07-18 16:58:59,665 [l0-0] INFO  IDACall - Performing 1 operation(s)
=== 2012-07-18 16:58:59,666 [l0-0] DEBUG AppBase - [builtinApplication.characteristicSQL_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-07-18 16:58:59,666 [l0-0] DEBUG AppBase - [builtinApplication.characteristicSQL_fetch] No public zero-argument method named '_characteristicSQL_fetch' found, performing generic datasource operation
=== 2012-07-18 16:58:59,666 [l0-0] INFO  SQLDataSource - [builtinApplication.characteristicSQL_fetch] Performing fetch operation with
	criteria: {__gwt_ObjectId:392}	values: {__gwt_ObjectId:392}
=== 2012-07-18 16:58:59,666 [l0-0] INFO  SQLDataSource - [builtinApplication.characteristicSQL_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:59,667 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:58:59,667 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Eval'd row count query: SELECT COUNT(*) FROM characteristic WHERE ('1'='1')
=== 2012-07-18 16:58:59,674 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.characteristicSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:59,674 [l0-0] INFO  SQLDriver - [builtinApplication.characteristicSQL_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM characteristic WHERE ('1'='1')
=== 2012-07-18 16:58:59,674 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Using SQL Limit query
=== 2012-07-18 16:58:59,674 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT characteristic.description, characteristic.id, characteristic.name FROM characteristic WHERE ('1'='1') LIMIT 0, 75
=== 2012-07-18 16:58:59,682 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.characteristicSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:58:59,683 [l0-0] INFO  DSResponse - [builtinApplication.characteristicSQL_fetch] DSResponse: List with 3 items
=== 2012-07-18 16:58:59,683 [l0-0] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-07-18 16:58:59,684 [l0-0] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-07-18 16:58:59,687 [l0-0] INFO  Compression - /builtinds/sc/IDACall: 307 -> 196 bytes
=== 2012-07-18 16:59:00,430 [l0-0] INFO  RequestContext - URL: '/builtinds/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/536.11 (KHTML, like Gecko) Chrome/20.0.1132.57 Safari/536.11': Safari with Accept-Encoding header
=== 2012-07-18 16:59:00,432 [l0-0] DEBUG XML - Parsed XML from (in memory stream): 1ms
=== 2012-07-18 16:59:00,435 [l0-0] DEBUG RPCManager - Processing 1 requests.
=== 2012-07-18 16:59:00,436 [l0-0] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        __gwt_ObjectId:420
    },
    operationConfig:{
        dataSource:"characteristicSQL",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_1",
    appID:"builtinApplication",
    operation:"characteristicSQL_fetch",
    oldValues:{
        __gwt_ObjectId:420
    }
}
=== 2012-07-18 16:59:00,436 [l0-0] INFO  IDACall - Performing 1 operation(s)
=== 2012-07-18 16:59:00,437 [l0-0] DEBUG AppBase - [builtinApplication.characteristicSQL_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-07-18 16:59:00,437 [l0-0] DEBUG AppBase - [builtinApplication.characteristicSQL_fetch] No public zero-argument method named '_characteristicSQL_fetch' found, performing generic datasource operation
=== 2012-07-18 16:59:00,437 [l0-0] INFO  SQLDataSource - [builtinApplication.characteristicSQL_fetch] Performing fetch operation with
	criteria: {__gwt_ObjectId:420}	values: {__gwt_ObjectId:420}
=== 2012-07-18 16:59:00,437 [l0-0] INFO  SQLDataSource - [builtinApplication.characteristicSQL_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:59:00,438 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-07-18 16:59:00,439 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Eval'd row count query: SELECT COUNT(*) FROM characteristic WHERE ('1'='1')
=== 2012-07-18 16:59:00,444 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.characteristicSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:59:00,445 [l0-0] INFO  SQLDriver - [builtinApplication.characteristicSQL_fetch] Executing SQL query on 'Mysql': SELECT COUNT(*) FROM characteristic WHERE ('1'='1')
=== 2012-07-18 16:59:00,446 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] Using SQL Limit query
=== 2012-07-18 16:59:00,446 [l0-0] DEBUG SQLDataSource - [builtinApplication.characteristicSQL_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT characteristic.description, characteristic.id, characteristic.name FROM characteristic WHERE ('1'='1') LIMIT 0, 75
=== 2012-07-18 16:59:00,453 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.characteristicSQL_fetch] Returning pooled Connection
=== 2012-07-18 16:59:00,454 [l0-0] INFO  DSResponse - [builtinApplication.characteristicSQL_fetch] DSResponse: List with 3 items
=== 2012-07-18 16:59:00,455 [l0-0] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-07-18 16:59:00,456 [l0-0] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-07-18 16:59:00,457 [l0-0] INFO  Compression - /builtinds/sc/IDACall: 307 -> 196 bytes