=== 2013-04-02 11:58:22,496 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
=== 2013-04-02 11:58:22,652 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/Users/usus/workspace/SmartgwtOLAPDynamic/war/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties
=== 2013-04-02 11:58:22,652 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
=== 2013-04-02 11:58:22,652 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
=== 2013-04-02 11:58:22,652 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/Users/usus/workspace/SmartgwtOLAPDynamic/war/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties
=== 2013-04-02 11:58:22,652 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
=== 2013-04-02 11:58:22,652 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/Users/usus/workspace/SmartgwtOLAPDynamic/war/WEB-INF/classes/server.properties
=== 2013-04-02 11:58:22,668 [main] INFO  Logger - Logging system started.
=== 2013-04-02 11:58:22,668 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework (v8.3p_2013-03-10/PowerEdition Deployment 2013-03-10) - Initialization Complete
=== 2013-04-02 11:58:22,668 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\Users\usus\workspace\SmartgwtOLAPDynamic\war
=== 2013-04-02 11:58:22,668 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework initialization called from com.isomorphic.base.Base
=== 2013-04-02 11:58:22,668 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework is already initialized
=== 2013-04-02 11:58:22,699 [main] INFO  PreCache - Isomorphic PreCache servlet loading
=== 2013-04-02 11:58:22,715 [main] INFO  PoolManager - SmartClient pooling disabled for 'DataSource' objects
=== 2013-04-02 11:58:22,746 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\builtinTypes.xml: 0ms
=== 2013-04-02 11:58:22,824 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\DataSource.ds.xml: 0ms
=== 2013-04-02 11:58:23,011 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\DataSourceField.ds.xml: 156ms
=== 2013-04-02 11:58:23,042 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\Validator.ds.xml: 15ms
=== 2013-04-02 11:58:23,042 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\ValueMap.ds.xml: 0ms
=== 2013-04-02 11:58:23,058 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\InstantDataApp.ds.xml: 0ms
=== 2013-04-02 11:58:23,120 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\Application.ds.xml: 0ms
=== 2013-04-02 11:58:23,136 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\IDAPage.ds.xml: 0ms
=== 2013-04-02 11:58:23,152 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\IDAUserType.ds.xml: 0ms
=== 2013-04-02 11:58:23,167 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\IDAOperation.ds.xml: 0ms
=== 2013-04-02 11:58:23,198 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\Canvas.ds.xml: 15ms
=== 2013-04-02 11:58:23,230 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\MethodDeclaration.ds.xml: 0ms
=== 2013-04-02 11:58:23,245 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\Img.ds.xml: 0ms
=== 2013-04-02 11:58:23,277 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\StatefulCanvas.ds.xml: 15ms
=== 2013-04-02 11:58:23,293 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\Button.ds.xml: 0ms
=== 2013-04-02 11:58:23,340 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\ListViewer.ds.xml: 0ms
=== 2013-04-02 11:58:23,355 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\ListGrid.ds.xml: 15ms
=== 2013-04-02 11:58:23,387 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\DynamicForm.ds.xml: 16ms
=== 2013-04-02 11:58:23,402 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\FormItem.ds.xml: 0ms
=== 2013-04-02 11:58:23,433 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\DetailViewer.ds.xml: 15ms
=== 2013-04-02 11:58:23,433 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\DetailViewerField.ds.xml: 0ms
=== 2013-04-02 11:58:23,808 [main] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\isomorphicXML.ds.xml: 0ms
=== 2013-04-02 11:58:23,808 [main] INFO  PreCache - Isomorphic PreCache complete (1109ms)
=== 2013-04-02 11:58:28,628 [l0-1] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\ds\listData.ds.xml: 0ms
=== 2013-04-02 11:58:28,659 [l0-1] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\ds\listCubes.ds.xml: 0ms
=== 2013-04-02 11:58:28,691 [l0-1] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\ds\listDimensions.ds.xml: 16ms
=== 2013-04-02 11:58:29,986 [l0-1] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\ds\listMembers.ds.xml: 0ms
=== 2013-04-02 11:58:42,982 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:8888
=== 2013-04-02 11:58:42,982 [l0-2] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0
=== 2013-04-02 11:58:42,982 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2013-04-02 11:58:42,982 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:8888/SmartgwtOLAP.html?gwt.codesvr=127.0.0.1:9997
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - Header Name:Value pair: Cookie:JSESSIONID=1vgnie62evsft; GLog=%7B%0D%20%20%20%20left%3A0%2C%20%0D%20%20%20%20top%3A0%2C%20%0D%20%20%20%20width%3A1592%2C%20%0D%20%20%20%20height%3A803%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:1019
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - session exists: null
=== 2013-04-02 11:58:42,998 [l0-2] DEBUG IDACall - remote user: null
=== 2013-04-02 11:58:42,998 [l0-2] INFO  RequestContext - URL: '/smartgwtolap/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header
=== 2013-04-02 11:58:43,013 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms
=== 2013-04-02 11:58:43,030 [l0-2] DEBUG XML - Parsed XML from C:\Users\usus\workspace\SmartgwtOLAPDynamic\war\smartgwtolap\sc\system\schema\List.ds.xml: 17ms
=== 2013-04-02 11:58:43,030 [l0-2] DEBUG RPCManager - Processing 1 requests.
=== 2013-04-02 11:58:43,046 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
    },
    operationConfig:{
        dataSource:"listCubes",
        operationType:"fetch",
        textMatchStyle:"startsWith"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_PickListMenu_0",
    appID:"builtinApplication",
    operation:"listCubes_fetch",
    oldValues:{
    }
}
=== 2013-04-02 11:58:43,046 [l0-2] INFO  IDACall - Performing 1 operation(s)
=== 2013-04-02 11:58:43,046 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2013-04-02 11:58:43,046 [l0-2] DEBUG DeclarativeSecurity - DataSource listCubes is not in the pre-checked list, processing...
=== 2013-04-02 11:58:43,046 [l0-2] DEBUG AppBase - [builtinApplication.listCubes_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2013-04-02 11:58:43,046 [l0-2] DEBUG AppBase - [builtinApplication.listCubes_fetch] No public zero-argument method named '_listCubes_fetch' found, performing generic datasource operation
=== 2013-04-02 11:58:43,841 [l0-2] INFO  DSResponse - [builtinApplication.listCubes_fetch] DSResponse: List with 7 items
=== 2013-04-02 11:58:43,841 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2013-04-02 11:58:43,841 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:8888
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:8888/SmartgwtOLAP.html?gwt.codesvr=127.0.0.1:9997
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Cookie:JSESSIONID=aca8hijgupls; GLog=%7B%0D%20%20%20%20left%3A0%2C%20%0D%20%20%20%20top%3A0%2C%20%0D%20%20%20%20width%3A1592%2C%20%0D%20%20%20%20height%3A803%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:1092
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - session exists: aca8hijgupls
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG IDACall - remote user: null
=== 2013-04-02 11:59:19,863 [l0-2] INFO  RequestContext - URL: '/smartgwtolap/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms
=== 2013-04-02 11:59:19,863 [l0-2] DEBUG RPCManager - Processing 1 requests.
=== 2013-04-02 11:59:19,878 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        nameCube:"Sales"
    },
    operationConfig:{
        dataSource:"listDimensions",
        operationType:"fetch",
        textMatchStyle:"exact"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_ListGrid_0",
    appID:"builtinApplication",
    operation:"listDimensions_fetch",
    oldValues:{
        nameCube:"Sales"
    }
}
=== 2013-04-02 11:59:19,878 [l0-2] INFO  IDACall - Performing 1 operation(s)
=== 2013-04-02 11:59:19,878 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2013-04-02 11:59:19,878 [l0-2] DEBUG DeclarativeSecurity - DataSource listDimensions is not in the pre-checked list, processing...
=== 2013-04-02 11:59:19,878 [l0-2] DEBUG AppBase - [builtinApplication.listDimensions_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2013-04-02 11:59:19,878 [l0-2] DEBUG AppBase - [builtinApplication.listDimensions_fetch] No public zero-argument method named '_listDimensions_fetch' found, performing generic datasource operation
=== 2013-04-02 11:59:20,643 [l0-2] INFO  DSResponse - [builtinApplication.listDimensions_fetch] DSResponse: List with 13 items
=== 2013-04-02 11:59:20,643 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2013-04-02 11:59:20,643 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:8888
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:8888/SmartgwtOLAP.html?gwt.codesvr=127.0.0.1:9997
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Cookie:JSESSIONID=aca8hijgupls; GLog=%7B%0D%20%20%20%20left%3A0%2C%20%0D%20%20%20%20top%3A0%2C%20%0D%20%20%20%20width%3A1592%2C%20%0D%20%20%20%20height%3A803%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:900
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - session exists: aca8hijgupls
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG IDACall - remote user: null
=== 2013-04-02 11:59:26,759 [l0-2] INFO  RequestContext - URL: '/smartgwtolap/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header
=== 2013-04-02 11:59:26,759 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms
=== 2013-04-02 11:59:26,775 [l0-2] DEBUG RPCManager - Processing 1 requests.
=== 2013-04-02 11:59:26,775 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        idDimension:"EducationLevel"
    },
    operationConfig:{
        dataSource:"listDimensions",
        operationType:"remove"
    },
    appID:"builtinApplication",
    operation:"listDimensions_remove",
    oldValues:{
        idDimension:"EducationLevel"
    }
}
=== 2013-04-02 11:59:26,775 [l0-2] INFO  IDACall - Performing 1 operation(s)
=== 2013-04-02 11:59:26,775 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2013-04-02 11:59:26,775 [l0-2] DEBUG DeclarativeSecurity - DataSource listDimensions is not in the pre-checked list, processing...
=== 2013-04-02 11:59:26,775 [l0-2] DEBUG AppBase - [builtinApplication.listDimensions_remove] No userTypes defined, allowing anyone access to all operations for this application
=== 2013-04-02 11:59:26,775 [l0-2] DEBUG AppBase - [builtinApplication.listDimensions_remove] No public zero-argument method named '_listDimensions_remove' found, performing generic datasource operation
=== 2013-04-02 11:59:26,775 [l0-2] INFO  DSResponse - [builtinApplication.listDimensions_remove] DSResponse: Map with 1 keys
=== 2013-04-02 11:59:26,775 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2013-04-02 11:59:26,775 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:8888
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:8888/SmartgwtOLAP.html?gwt.codesvr=127.0.0.1:9997
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Cookie:JSESSIONID=aca8hijgupls; GLog=%7B%0D%20%20%20%20left%3A0%2C%20%0D%20%20%20%20top%3A0%2C%20%0D%20%20%20%20width%3A1592%2C%20%0D%20%20%20%20height%3A803%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:884
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - session exists: aca8hijgupls
=== 2013-04-02 11:59:29,194 [l0-2] DEBUG IDACall - remote user: null
=== 2013-04-02 11:59:29,194 [l0-2] INFO  RequestContext - URL: '/smartgwtolap/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 31ms
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG RPCManager - Processing 1 requests.
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        idDimension:"Gender"
    },
    operationConfig:{
        dataSource:"listDimensions",
        operationType:"remove"
    },
    appID:"builtinApplication",
    operation:"listDimensions_remove",
    oldValues:{
        idDimension:"Gender"
    }
}
=== 2013-04-02 11:59:29,225 [l0-2] INFO  IDACall - Performing 1 operation(s)
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG DeclarativeSecurity - DataSource listDimensions is not in the pre-checked list, processing...
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG AppBase - [builtinApplication.listDimensions_remove] No userTypes defined, allowing anyone access to all operations for this application
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG AppBase - [builtinApplication.listDimensions_remove] No public zero-argument method named '_listDimensions_remove' found, performing generic datasource operation
=== 2013-04-02 11:59:29,225 [l0-2] INFO  DSResponse - [builtinApplication.listDimensions_remove] DSResponse: Map with 1 keys
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2013-04-02 11:59:29,225 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:8888
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:8888/SmartgwtOLAP.html?gwt.codesvr=127.0.0.1:9997
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Cookie:JSESSIONID=aca8hijgupls; GLog=%7B%0D%20%20%20%20left%3A0%2C%20%0D%20%20%20%20top%3A0%2C%20%0D%20%20%20%20width%3A1592%2C%20%0D%20%20%20%20height%3A803%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:1288
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - session exists: aca8hijgupls
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG IDACall - remote user: null
=== 2013-04-02 11:59:30,583 [l0-2] INFO  RequestContext - URL: '/smartgwtolap/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG RPCManager - Processing 1 requests.
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        nameCube:"Sales",
        rowFacets:"Gender,",
        columnFacets:"Education Level,"
    },
    operationConfig:{
        dataSource:"listMembers",
        operationType:"fetch",
        textMatchStyle:"exact"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_ListGrid_3",
    appID:"builtinApplication",
    operation:"listMembers_fetch",
    oldValues:{
        nameCube:"Sales",
        rowFacets:"Gender,",
        columnFacets:"Education Level,"
    }
}
=== 2013-04-02 11:59:30,583 [l0-2] INFO  IDACall - Performing 1 operation(s)
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG DeclarativeSecurity - DataSource listMembers is not in the pre-checked list, processing...
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG AppBase - [builtinApplication.listMembers_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2013-04-02 11:59:30,583 [l0-2] DEBUG AppBase - [builtinApplication.listMembers_fetch] No public zero-argument method named '_listMembers_fetch' found, performing generic datasource operation
=== 2013-04-02 11:59:31,423 [l0-2] INFO  DSResponse - [builtinApplication.listMembers_fetch] DSResponse: List with 7 items
=== 2013-04-02 11:59:31,423 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2013-04-02 11:59:31,423 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:8888
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:8888/SmartgwtOLAP.html?gwt.codesvr=127.0.0.1:9997
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Cookie:JSESSIONID=aca8hijgupls; GLog=%7B%0D%20%20%20%20left%3A0%2C%20%0D%20%20%20%20top%3A0%2C%20%0D%20%20%20%20width%3A1592%2C%20%0D%20%20%20%20height%3A803%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:2274
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - session exists: aca8hijgupls
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG IDACall - remote user: null
=== 2013-04-02 11:59:32,905 [l0-2] INFO  RequestContext - URL: '/smartgwtolap/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG RPCManager - Processing 1 requests.
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        rowFacets:"Gender,",
        columnFacets:"Education Level,",
        Scenarios:"Sales",
        Gender:[
            "[Gender].[F]",
            "[Gender].[M]"
        ],
        EducationLevel:[
            "[Education Level].[Bachelors Degree]",
            "[Education Level].[Graduate Degree]",
            "[Education Level].[High School Degree]",
            "[Education Level].[Partial College]",
            "[Education Level].[Partial High School]"
        ]
    },
    operationConfig:{
        dataSource:"listData",
        operationType:"fetch",
        textMatchStyle:"exact"
    },
    appID:"builtinApplication",
    operation:"listData_fetch",
    oldValues:{
        rowFacets:"Gender,",
        columnFacets:"Education Level,",
        Scenarios:"Sales",
        Gender:[
            "[Gender].[F]",
            "[Gender].[M]"
        ],
        EducationLevel:[
            "[Education Level].[Bachelors Degree]",
            "[Education Level].[Graduate Degree]",
            "[Education Level].[High School Degree]",
            "[Education Level].[Partial College]",
            "[Education Level].[Partial High School]"
        ]
    }
}
=== 2013-04-02 11:59:32,905 [l0-2] INFO  IDACall - Performing 1 operation(s)
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG DeclarativeSecurity - DataSource listData is not in the pre-checked list, processing...
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG AppBase - [builtinApplication.listData_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2013-04-02 11:59:32,905 [l0-2] DEBUG AppBase - [builtinApplication.listData_fetch] No public zero-argument method named '_listData_fetch' found, performing generic datasource operation
=== 2013-04-02 11:59:33,468 [l0-2] INFO  DSResponse - [builtinApplication.listData_fetch] DSResponse: List with 10 items
=== 2013-04-02 11:59:33,468 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2013-04-02 11:59:33,468 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:8888
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:8888/SmartgwtOLAP.html?gwt.codesvr=127.0.0.1:9997
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Cookie:JSESSIONID=aca8hijgupls; GLog=%7B%0D%20%20%20%20left%3A0%2C%20%0D%20%20%20%20top%3A0%2C%20%0D%20%20%20%20width%3A1592%2C%20%0D%20%20%20%20height%3A803%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:860
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - session exists: aca8hijgupls
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG IDACall - remote user: null
=== 2013-04-02 11:59:42,975 [l0-2] INFO  RequestContext - URL: '/smartgwtolap/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG RPCManager - Processing 1 requests.
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        Scenarios:"Sales"
    },
    operationConfig:{
        dataSource:"listData",
        operationType:"fetch"
    },
    appID:"builtinApplication",
    operation:"listData_fetch",
    oldValues:{
        Scenarios:"Sales"
    }
}
=== 2013-04-02 11:59:42,975 [l0-2] INFO  IDACall - Performing 1 operation(s)
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG DeclarativeSecurity - DataSource listData is not in the pre-checked list, processing...
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG AppBase - [builtinApplication.listData_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG AppBase - [builtinApplication.listData_fetch] No public zero-argument method named '_listData_fetch' found, performing generic datasource operation
=== 2013-04-02 11:59:42,975 [l0-2] WARN  RequestContext - dsRequest.execute() failed: 
java.lang.NullPointerException
	at com.smartgwt.sample.server.OLAPDataSource.fetchRecordsAll(OLAPDataSource.java:31)
	at com.smartgwt.sample.server.OLAPDataSource.executeFetch(OLAPDataSource.java:22)
	at com.isomorphic.datasource.DataSource.execute(DataSource.java:1367)
	at com.isomorphic.application.AppBase.executeDefaultDSOperation(AppBase.java:726)
	at com.isomorphic.application.AppBase.executeAppOperation(AppBase.java:658)
	at com.isomorphic.application.AppBase.execute(AppBase.java:491)
	at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:2030)
	at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:216)
	at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:173)
	at com.isomorphic.servlet.IDACall.processRequest(IDACall.java:138)
	at com.isomorphic.servlet.IDACall.doPost(IDACall.java:74)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:637)
	at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:152)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:362)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:729)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.RequestLogHandler.handle(RequestLogHandler.java:49)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:324)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:843)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:647)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:395)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:488)
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2013-04-02 11:59:42,975 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false
Uncaught JavaScript exception [TypeError: _1 is undefined] in http://127.0.0.1:8888/smartgwtolap/sc/modules/ISC_Charts.js, line 393