Announcement

Collapse
No announcement yet.
X
  • Filter
  • Time
Clear All
new posts

    Dynamic DataSource on Server: Error: Can't find dataSource

    In our system, we have been using dynamic datasources. The way we use them is that we generate them on the server side using DataSource.fromXML(xmlString), and then we use the toJS() method of a JSTranslater instance to translate the DataSource instance into a javascript string and send the string over to the client side. The client (by setting setEvalResult() to true for an RPCRequest instance) would eval the returned javascript string to instance the client-side DataSource instance, bound it to a visual component (e.g. ListGrid instance) and then performs a data operation such as fetchData().

    So far so good.

    Now we want to use the generated DataSource on the server side instead.

    So we have some code like this

    Code:
    DataSource ds = DataSource.fromXML(xmlString);
    List list = ds.fetch(null);
    But then we got the error of

    Code:
    Can't find dataSource: dynDs314784014 - please make sure that you have a dynDs314784014.ds.xml file for it in
    More details of our environment are listed below:

    1. SmartClient Version: v8.3p_2013-01-15/PowerEdition Deployment (built 2013-01-15)

    2. Browser: Firefox

    3. Server log:

    Code:
    [WARN] Server class 'org.springframework.web.context.ContextLoaderListener' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/springframework/spring-web/3.1.4.RELEASE/spring-web-3.1.4.RELEASE.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.springframework.context.ApplicationContextException' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/springframework/spring-context/3.1.4.RELEASE/spring-context-3.1.4.RELEASE.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.springframework.beans.FatalBeanException' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/springframework/spring-beans/3.1.4.RELEASE/spring-beans-3.1.4.RELEASE.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.springframework.core.NestedRuntimeException' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/springframework/spring-core/3.1.4.RELEASE/spring-core-3.1.4.RELEASE.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'com.isomorphic.base.InitListener' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/com/isomorphic/smartgwt/isomorphic-core-rpc/3.1/isomorphic-core-rpc-3.1.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server resource 'log4j.properties' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/target/classes/' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.springframework.asm.ClassVisitor' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/springframework/spring-asm/3.1.4.RELEASE/spring-asm-3.1.4.RELEASE.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.springframework.expression.PropertyAccessor' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/springframework/spring-expression/3.1.4.RELEASE/spring-expression-3.1.4.RELEASE.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    ISC: Configuring log4j from: file:/C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/target/classes/log4j.isc.config.xml
    [WARN] Server class 'org.apache.commons.collections.map.LinkedMap' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/gwt-dev.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:56:25,577 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework initialization called from com.isomorphic.base.InitListener
    === 2013-06-14 10:56:25,577 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework - Initializing
    === 2013-06-14 10:56:25,581 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
    [WARN] Server class 'isc.org.apache.oro.text.perl.Perl5Util' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/com/isomorphic/smartgwt/isc-jakarta-oro/3.1/isc-jakarta-oro-3.1.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:56:25,684 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/Users/leecy/.m2/repository/com/isomorphic/smartgwt/isomorphic-core-rpc/3.1/isomorphic-core-rpc-3.1.jar!/framework.properties
    === 2013-06-14 10:56:25,684 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
    === 2013-06-14 10:56:25,684 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
    === 2013-06-14 10:56:25,707 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/Users/leecy/.m2/repository/com/isomorphic/smartgwt/isomorphic-core-rpc/3.1/isomorphic-core-rpc-3.1.jar!/isc_interfaces.properties
    === 2013-06-14 10:56:25,707 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
    === 2013-06-14 10:56:25,715 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/target/classes/server.properties
    === 2013-06-14 10:56:25,722 [main] INFO  Logger - Logging system started.
    === 2013-06-14 10:56:25,723 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework (v8.3p_2013-05-01/EVAL Deployment 2013-05-01) - Initialization Complete
    === 2013-06-14 10:56:25,726 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war
    === 2013-06-14 10:56:25,801 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework initialization called from com.isomorphic.base.Base
    === 2013-06-14 10:56:25,801 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework is already initialized
    [WARN] Server class 'org.hibernate.proxy.HibernateProxy' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/hibernate/hibernate-core/4.2.1.Final/hibernate-core-4.2.1.Final.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'net.sf.cglib.transform.impl.InterceptFieldEnabled' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/cglib/cglib/2.2.2/cglib-2.2.2.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [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:/Users/leecy/.m2/repository/com/isomorphic/smartgwt/isomorphic-compression/3.1/isomorphic-compression-3.1.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'com.google.gwt.user.client.rpc.RemoteService' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/gwt-user.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:56:25,866 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework initialization called from com.isomorphic.base.Init
    === 2013-06-14 10:56:25,867 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework is already initialized
    [WARN] Server class 'org.apache.cxf.transport.servlet.CXFServlet' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/apache/cxf/cxf-bundle-jaxrs/2.2.12/cxf-bundle-jaxrs-2.2.12.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'com.ctc.wstx.sax.WstxSAXParserFactory' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/codehaus/woodstox/wstx-asl/3.2.9/wstx-asl-3.2.9.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    Jun 14, 2013 10:56:25 AM org.apache.cxf.transport.servlet.CXFServlet updateContext
    INFO: Load the bus with application context
    [WARN] Server class 'javax.wsdl.xml.WSDLLocator' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/wsdl4j/wsdl4j/1.6.2/wsdl4j-1.6.2.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.apache.neethi.PolicyComponent' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/apache/neethi/neethi/2.0.4/neethi-2.0.4.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.springframework.aop.support.AopUtils' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/springframework/spring-aop/3.1.4.RELEASE/spring-aop-3.1.4.RELEASE.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.springframework.web.servlet.DispatcherServlet' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/springframework/spring-webmvc/3.1.4.RELEASE/spring-webmvc-3.1.4.RELEASE.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    Jun 14, 2013 10:56:26 AM org.apache.cxf.transport.servlet.AbstractCXFServlet replaceDestinationFactory
    INFO: Replaced the http destination factory with servlet transport factory
    Jun 14, 2013 10:56:26 AM org.apache.cxf.transport.servlet.CXFServlet updateContext
    INFO: Load the bus with application context
    Jun 14, 2013 10:56:26 AM org.apache.cxf.transport.servlet.AbstractCXFServlet replaceDestinationFactory
    INFO: Replaced the http destination factory with servlet transport factory
    [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:/Users/leecy/.m2/repository/commons-fileupload/commons-fileupload/1.2.2/commons-fileupload-1.2.2.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:56:33,470 [l0-1] INFO  RequestContext - URL: '/Nara.html', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:33,481 [l0-1] INFO  Compression - /Nara.html: 3976 -> 1554 bytes
    === 2013-06-14 10:56:33,753 [l0-1] INFO  RequestContext - URL: '/Nara.css', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:33,755 [l0-1] INFO  Compression - /Nara.css: 1440 -> 661 bytes
    === 2013-06-14 10:56:33,756 [l0-2] INFO  RequestContext - URL: '/nara/nara.nocache.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:33,758 [l0-2] INFO  Compression - /nara/nara.nocache.js: 7522 -> 2838 bytes
    === 2013-06-14 10:56:33,762 [l0-2] INFO  RequestContext - URL: '/nara/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:33,764 [l0-1] INFO  RequestContext - URL: '/nara/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:33,772 [l0-4] INFO  RequestContext - URL: '/nara/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:33,774 [l0-5] INFO  RequestContext - URL: '/nara/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:33,781 [l0-6] INFO  RequestContext - URL: '/nara/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:33,783 [l0-3] INFO  RequestContext - URL: '/nara/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) 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:/Users/leecy/.m2/repository/commons-pool/commons-pool/1.5.4/commons-pool-1.5.4.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:56:33,805 [l0-2] INFO  PoolManager - SmartClient pooling disabled for 'applicationDS' 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:/Users/leecy/.m2/repository/commons-jxpath/commons-jxpath/1.3/commons-jxpath-1.3.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:56:33,908 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\builtinTypes.xml: 6ms
    === 2013-06-14 10:56:33,971 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\applicationDS.ds.xml: 3ms
    === 2013-06-14 10:56:33,987 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\DataSource.ds.xml: 15ms
    [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:/Users/leecy/.m2/repository/org/apache/velocity/velocity/1.7/velocity-1.7.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:56:34,035 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\DataSourceField.ds.xml: 5ms
    === 2013-06-14 10:56:34,039 [l0-5] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\appAttriContentType.ds.xml: 8ms
    === 2013-06-14 10:56:34,046 [l0-3] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\mobileOsCategoryDS.ds.xml: 15ms
    === 2013-06-14 10:56:34,049 [l0-5] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\DataSourceField.ds.xml: 4ms
    === 2013-06-14 10:56:34,051 [l0-3] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\DataSourceField.ds.xml: 3ms
    === 2013-06-14 10:56:34,067 [l0-6] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\modelAttriHotSpot.ds.xml: 30ms
    === 2013-06-14 10:56:34,069 [l0-4] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\sigErrorDS.ds.xml: 32ms
    === 2013-06-14 10:56:34,078 [l0-5] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\OperationBinding.ds.xml: 5ms
    === 2013-06-14 10:56:34,073 [l0-1] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\rncDS.ds.xml: 34ms
    === 2013-06-14 10:56:34,099 [l0-4] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\OperationBinding.ds.xml: 3ms
    === 2013-06-14 10:56:34,104 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\OperationBinding.ds.xml: 24ms
    [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:/Users/leecy/.m2/repository/com/isomorphic/smartgwt/isomorphic-sql/3.1/isomorphic-sql-3.1.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:56:34,177 [l0-6] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\modelAttriManufacturer.ds.xml: 2ms
    === 2013-06-14 10:56:34,214 [l0-6] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\modelAttriModel.ds.xml: 2ms
    === 2013-06-14 10:56:34,178 [l0-3] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\mobileOsDS.ds.xml: 1ms
    === 2013-06-14 10:56:34,200 [l0-4] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\sigResponseDS.ds.xml: 1ms
    === 2013-06-14 10:56:34,225 [l0-3] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\techTypeDS.ds.xml: 1ms
    === 2013-06-14 10:56:34,235 [l0-3] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\techFamilyDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,252 [l0-3] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\faDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,264 [l0-4] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\sigMessageTypeDS.ds.xml: 9ms
    === 2013-06-14 10:56:34,305 [l0-4] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\sigInterfaceDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,198 [l0-1] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\ValueMap.ds.xml: 1ms
    === 2013-06-14 10:56:34,329 [l0-1] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\rncWithFaDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,337 [l0-1] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\rncWithGroupDS.ds.xml: 1ms
    === 2013-06-14 10:56:34,345 [l0-3] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\haDS.ds.xml: 36ms
    === 2013-06-14 10:56:34,351 [l0-1] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\rncGroupDS.ds.xml: 6ms
    === 2013-06-14 10:56:34,360 [l0-3] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\ipvDS.ds.xml: 3ms
    === 2013-06-14 10:56:34,192 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\appCatDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,358 [l0-4] INFO  RequestContext - URL: '/nara/sc/modules/ISC_Core.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,371 [l0-1] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\cellGroupDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,381 [l0-1] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\suberGroupDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,356 [l0-6] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\modelAttriOsCategory.ds.xml: 2ms
    === 2013-06-14 10:56:34,399 [l0-6] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\modelAttriCategory.ds.xml: 2ms
    === 2013-06-14 10:56:34,267 [l0-5] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\appAttriFunction.ds.xml: 3ms
    === 2013-06-14 10:56:34,456 [l0-5] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\appAttriProvider.ds.xml: 2ms
    === 2013-06-14 10:56:34,459 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\appGroupDS.ds.xml: 9ms
    === 2013-06-14 10:56:34,421 [l0-3] INFO  RequestContext - URL: '/nara/sc/modules/ISC_Containers.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,475 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\modelDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,407 [l0-1] INFO  RequestContext - URL: '/nara/sc/modules/ISC_Foundation.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,565 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\modelGroupDS.ds.xml: 4ms
    === 2013-06-14 10:56:34,572 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\realmDS.ds.xml: 1ms
    === 2013-06-14 10:56:34,619 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\realmGroupDS.ds.xml: 2ms
    === 2013-06-14 10:56:34,626 [l0-2] INFO  RequestContext - URL: '/nara/sc/modules/ISC_Forms.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,672 [l0-2] INFO  Compression - /nara/sc/modules/ISC_Forms.js: 699977 -> 170064 bytes
    === 2013-06-14 10:56:34,411 [l0-6] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\modelAttriGeneration.ds.xml: 2ms
    === 2013-06-14 10:56:34,679 [l0-6] INFO  RequestContext - URL: '/nara/sc/modules/ISC_RichTextEditor.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,706 [l0-6] INFO  Compression - /nara/sc/modules/ISC_RichTextEditor.js: 40327 -> 11327 bytes
    === 2013-06-14 10:56:34,708 [l0-6] INFO  RequestContext - URL: '/nara/sc/modules/ISC_Calendar.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,819 [l0-6] INFO  Compression - /nara/sc/modules/ISC_Calendar.js: 118511 -> 29158 bytes
    === 2013-06-14 10:56:34,826 [l0-6] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/load_skin.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,831 [l0-6] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/load_skin.js
    === 2013-06-14 10:56:34,834 [l0-6] INFO  Compression - /nara/sc/skins/Enterprise/load_skin.js: 55685 -> 9553 bytes
    === 2013-06-14 10:56:34,607 [l0-3] INFO  Compression - /nara/sc/modules/ISC_Containers.js: 135398 -> 32186 bytes
    === 2013-06-14 10:56:34,604 [l0-1] INFO  Compression - /nara/sc/modules/ISC_Foundation.js: 245829 -> 58389 bytes
    === 2013-06-14 10:56:34,599 [l0-4] INFO  Compression - /nara/sc/modules/ISC_Core.js: 784902 -> 205640 bytes
    === 2013-06-14 10:56:34,466 [l0-5] INFO  RequestContext - URL: '/nara/sc/modules/ISC_Grids.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,914 [l0-5] INFO  Compression - /nara/sc/modules/ISC_Grids.js: 856514 -> 215221 bytes
    === 2013-06-14 10:56:34,718 [l0-2] INFO  RequestContext - URL: '/nara/sc/modules/ISC_DataBinding.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,981 [l0-2] INFO  Compression - /nara/sc/modules/ISC_DataBinding.js: 631400 -> 155685 bytes
    === 2013-06-14 10:56:34,991 [l0-4] INFO  RequestContext - URL: '/nara/sc/initsc.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:34,993 [l0-4] INFO  Compression - /nara/sc/initsc.js: 47 -> 72 bytes
    === 2013-06-14 10:56:34,994 [l0-2] INFO  RequestContext - URL: '/nara/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:35,025 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\naraDfReportsDS.ds.xml: 30ms
    === 2013-06-14 10:56:35,033 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\dimProtocolDS.ds.xml: 2ms
    === 2013-06-14 10:56:35,039 [l0-2] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\ds\fileUploadDS.ds.xml: 2ms
    === 2013-06-14 10:56:35,102 [l0-5] INFO  RequestContext - URL: '/images/aware/logo.jpg', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:36,189 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/skin_styles.css', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:36,190 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/skin_styles.css
    === 2013-06-14 10:56:36,195 [l0-5] INFO  Compression - /nara/sc/skins/Enterprise/skin_styles.css: 213204 -> 17104 bytes
    === 2013-06-14 10:56:36,311 [l0-2] INFO  RequestContext - URL: '/nara/hosted.html', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:36,312 [l0-5] INFO  RequestContext - URL: '/images/aware/icon_bg_grad2.gif', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:56:36,320 [l0-2] INFO  Compression - /nara/hosted.html: 11781 -> 4171 bytes
    === 2013-06-14 10:57:02,176 [l0-5] INFO  RequestContext - URL: '/nara/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:02,179 [l0-2] INFO  RequestContext - URL: '/nara/metaData', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:02,181 [l0-4] INFO  RequestContext - URL: '/nara/dbService', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:02,182 [l0-1] INFO  RequestContext - URL: '/favicon.ico', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:02,184 [l0-3] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/blank.gif', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:02,186 [l0-3] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/blank.gif
    [WARN] Server class 'com.smartgwt.client.util.LogicalDate' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/com/isomorphic/smartgwt/smartgwtpower/3.1/smartgwtpower-3.1.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:57:02,419 [l0-5] WARN  RPCManager - client/server version mismatch.  Client is version: v8.3p_2013-01-15, server is version: v8.3p_2013-05-01 - mixing different client/server versions is generally not supported.  If you've installed a more recent client version, try clearing the browser cache and reloading the page.
    [WARN] Server class 'javax.validation.ConstraintDeclarationException' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/validation-api-1.0.0.GA.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:57:02,427 [l0-5] DEBUG XML - Parsed XML from (in memory stream): 6ms
    === 2013-06-14 10:57:02,434 [l0-5] DEBUG XML - Parsed XML from C:\Users\leecy\Documents\proj\AWARE\aware\trunk\nara\war\nara\sc\system\schema\List.ds.xml: 6ms
    === 2013-06-14 10:57:02,436 [l0-5] DEBUG RPCManager - Processing 1 requests.
    [WARN] Server class 'org.dom4j.DocumentException' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/dom4j/dom4j/1.6.1/dom4j-1.6.1.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.hibernate.annotations.common.reflection.MetadataProvider' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/hibernate/common/hibernate-commons-annotations/4.0.1.Final/hibernate-commons-annotations-4.0.1.Final.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'org.jboss.logging.BasicLogger' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/jboss/logging/jboss-logging/3.1.0.GA/jboss-logging-3.1.0.GA.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'javax.transaction.SystemException' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/jboss/spec/javax/transaction/jboss-transaction-api_1.1_spec/1.0.1.Final/jboss-transaction-api_1.1_spec-1.0.1.Final.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:57:02,477 [l0-5] DEBUG RPCManager - Request #1 (DSRequest) payload: {
        criteria:{
        },
        operationConfig:{
            dataSource:"dimProtocolDS",
            operationType:"fetch"
        },
        appID:"builtinApplication",
        operation:"dimProtocolDS_fetch",
        oldValues:{
        }
    }
    === 2013-06-14 10:57:02,481 [l0-5] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
    === 2013-06-14 10:57:02,481 [l0-5] DEBUG DeclarativeSecurity - DataSource dimProtocolDS is not in the pre-checked list, processing...
    === 2013-06-14 10:57:02,487 [l0-5] DEBUG AppBase - [builtinApplication.dimProtocolDS_fetch] No userTypes defined, allowing anyone access to all operations for this application
    === 2013-06-14 10:57:02,487 [l0-5] DEBUG AppBase - [builtinApplication.dimProtocolDS_fetch] No public zero-argument method named '_dimProtocolDS_fetch' found, performing generic datasource operation
    === 2013-06-14 10:57:02,487 [l0-5] INFO  SQLDataSource - [builtinApplication.dimProtocolDS_fetch] Performing fetch operation with
    	criteria: {}	values: {}
    === 2013-06-14 10:57:02,499 [l0-5] INFO  SQLWhereClause - [builtinApplication.dimProtocolDS_fetch] empty condition
    === 2013-06-14 10:57:02,500 [l0-5] INFO  SQLDataSource - [builtinApplication.dimProtocolDS_fetch] derived query: SELECT 
          protocol_code,protocol_String
                 FROM 
           DIM_protocol
                 WHERE $defaultWhereClause ORDER BY 
                    protocol_String
                
    === 2013-06-14 10:57:02,857 [l0-5] INFO  SQLDataSource - [builtinApplication.dimProtocolDS_fetch] Executing SQL query on 'central_aware_db_4100': SELECT 
          protocol_code,protocol_String
                 FROM 
           DIM_protocol
                 WHERE ('1'='1') ORDER BY 
                    protocol_String
                
    [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:/Users/leecy/.m2/repository/com/isomorphic/smartgwt/isomorphic-hibernate/3.1/isomorphic-hibernate-3.1.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:57:03,080 [l0-5] INFO  PoolManager - [builtinApplication.dimProtocolDS_fetch] SmartClient pooling started for 'central_aware_db_4100' objects
    === 2013-06-14 10:57:03,081 [l0-5] DEBUG PoolableSQLConnectionFactory - [builtinApplication.dimProtocolDS_fetch] Initializing SQL config for 'central_aware_db_4100' from system config - using DataSource:  com.mysql.jdbc.jdbc2.optional.MysqlDataSource
    [WARN] Server class 'com.mysql.jdbc.jdbc2.optional.MysqlDataSource' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/mysql/mysql-connector-java/5.1.24/mysql-connector-java-5.1.24.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    [WARN] Server class 'javax.persistence.EntityListeners' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/hibernate/javax/persistence/hibernate-jpa-2.0-api/1.0.1.Final/hibernate-jpa-2.0-api-1.0.1.Final.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:57:03,346 [l0-5] INFO  DataTools - [builtinApplication.dimProtocolDS_fetch] setProperties: couldn't set:
    {
        context:"No such property",
        networkProtocol:"No such property"
    }
    === 2013-06-14 10:57:03,881 [l0-5] DEBUG PoolableSQLConnectionFactory - [builtinApplication.dimProtocolDS_fetch] makeObject() created a pooled Connection '144741380'
    [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:/Users/leecy/.m2/repository/commons-dbcp/commons-dbcp/1.4/commons-dbcp-1.4.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:57:03,887 [l0-5] DEBUG PoolableSQLConnectionFactory - [builtinApplication.dimProtocolDS_fetch] Executing pingTest 'select 1 from dual' on connection 144741380
    === 2013-06-14 10:57:03,891 [l0-5] DEBUG SQLConnectionManager - [builtinApplication.dimProtocolDS_fetch] Returning borrowed connection '144741380'
    === 2013-06-14 10:57:03,892 [l0-5] DEBUG SQLTransaction - [builtinApplication.dimProtocolDS_fetch] Started new central_aware_db_4100 transaction "144741380"
    === 2013-06-14 10:57:03,893 [l0-5] DEBUG SQLDriver - [builtinApplication.dimProtocolDS_fetch] About to execute SQL query in 'central_aware_db_4100' using connection '144741380'
    === 2013-06-14 10:57:03,893 [l0-5] INFO  SQLDriver - [builtinApplication.dimProtocolDS_fetch] Executing SQL query on 'central_aware_db_4100': SELECT 
          protocol_code,protocol_String
                 FROM 
           DIM_protocol
                 WHERE ('1'='1') ORDER BY 
                    protocol_String
                
    === 2013-06-14 10:57:03,917 [l0-5] INFO  DSResponse - [builtinApplication.dimProtocolDS_fetch] DSResponse: List with 10 items
    === 2013-06-14 10:57:03,918 [l0-5] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
    === 2013-06-14 10:57:03,918 [l0-5] DEBUG SQLTransaction - Committing central_aware_db_4100 transaction "144741380"
    === 2013-06-14 10:57:04,024 [l0-5] DEBUG RPCManager - non-DMI response, dropExtraFields: false
    === 2013-06-14 10:57:04,065 [l0-5] DEBUG SQLTransaction - Returning transactional connection for central_aware_db_4100 with hashcode "144741380"
    === 2013-06-14 10:57:04,065 [l0-5] DEBUG SQLTransaction - Ending central_aware_db_4100 transaction "144741380"
    [WARN] Server class 'javassist.util.proxy.MethodFilter' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/org/javassist/javassist/3.15.0-GA/javassist-3.15.0-GA.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:57:04,161 [l0-5] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "144741380"
    === 2013-06-14 10:57:04,163 [l0-5] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 144741380
    === 2013-06-14 10:57:04,290 [l0-5] INFO  Compression - /nara/sc/IDACall: 603 -> 238 bytes
    Hibernate: SELECT
     @@system_time_zone as dbTimeZone,
     cast(TIMESTAMPDIFF(MINUTE, now(),convert_tz(now(),@@session.time_zone,'+00:00')) as char)  as timeDiffInMinute,
     cast(TIMEDIFF(now(),convert_tz(now(),@@session.time_zone,'+00:00')) as char) as timeDiff,
     @@hostname as hostname
    [WARN] Server class 'junit.framework.AssertionFailedError' could not be found in the web app, but was found on the system classpath
       [WARN] Adding classpath entry 'file:/C:/Users/leecy/.m2/repository/junit/junit/4.7/junit-4.7.jar' to the web app classpath for this session
       For additional info see: file:/C:/Program%20Files/eclipse-jee-indigo-win32-x86_64/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.5.1/gwt-2.5.1/doc/helpInfo/webAppClassPath.html
    === 2013-06-14 10:57:10,267 [l0-2] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/headerIcons/minimize.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,269 [l0-2] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/headerIcons/minimize.png
    === 2013-06-14 10:57:10,270 [l0-2] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/edges/edge_T.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,272 [l0-2] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/edges/edge_T.png
    === 2013-06-14 10:57:10,301 [l0-2] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/edges/edge_TR.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,302 [l0-2] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/edges/edge_TR.png
    === 2013-06-14 10:57:10,304 [l0-2] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/edges/edge_L.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,305 [l0-2] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/edges/edge_L.png
    === 2013-06-14 10:57:10,308 [l0-2] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/edges/edge_R.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,309 [l0-2] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/edges/edge_R.png
    === 2013-06-14 10:57:10,310 [l0-2] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/edges/edge_BL.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,330 [l0-2] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/edges/edge_BL.png
    === 2013-06-14 10:57:10,331 [l0-2] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/edges/edge_B.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,332 [l0-2] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/edges/edge_B.png
    === 2013-06-14 10:57:10,332 [l0-2] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/edges/edge_BR.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,333 [l0-2] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/edges/edge_BR.png
    === 2013-06-14 10:57:10,334 [l0-2] INFO  RequestContext - URL: '/images/dimImages/application.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,338 [l0-2] INFO  RequestContext - URL: '/images/dimImages/appGroup.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,340 [l0-2] INFO  RequestContext - URL: '/images/dimImages/realm.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,341 [l0-2] INFO  RequestContext - URL: '/images/dimImages/techType.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,346 [l0-2] INFO  RequestContext - URL: '/images/dimImages/ipv.jpg', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,347 [l0-2] INFO  RequestContext - URL: '/images/dimImages/suber.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,349 [l0-2] INFO  RequestContext - URL: '/images/dimImages/ha.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,350 [l0-2] INFO  RequestContext - URL: '/images/dimImages/fa.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,352 [l0-2] INFO  RequestContext - URL: '/images/dimImages/rnc.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,354 [l0-2] INFO  RequestContext - URL: '/images/dimImages/cell.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,287 [l0-3] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/TransferIcons/left_all.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,361 [l0-3] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/TransferIcons/left_all.png
    === 2013-06-14 10:57:10,361 [l0-3] INFO  RequestContext - URL: '/images/dimImages/mobileOsCat.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,363 [l0-3] INFO  RequestContext - URL: '/images/dimImages/techUsed.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,365 [l0-3] INFO  RequestContext - URL: '/images/dimImages/model.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,366 [l0-3] INFO  RequestContext - URL: '/images/dimImages/mobileId.jpg', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,277 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/TransferIcons/right.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,368 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/TransferIcons/right.png
    === 2013-06-14 10:57:10,369 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/DynamicForm/unchecked.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,371 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/DynamicForm/unchecked.png
    === 2013-06-14 10:57:10,372 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/DynamicForm/checked.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,373 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/DynamicForm/checked.png
    === 2013-06-14 10:57:10,373 [l0-5] INFO  RequestContext - URL: '/images/aware/16/status_red.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,376 [l0-5] INFO  RequestContext - URL: '/images/aware/16/next_Disabled.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,376 [l0-2] INFO  RequestContext - URL: '/images/dimImages/mobileOs.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    [WARN] 404 - GET /images/aware/16/next_Disabled.png (127.0.0.1) 1419 bytes
       Request headers
          Host: 127.0.0.1:52596
          User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0
          Accept: image/png,image/*;q=0.8,*/*;q=0.5
          Accept-Language: fr
          Accept-Encoding: gzip, deflate
          Cookie: GLog=%7B%0D%20%20%20%20left%3A4%2C%20%0D%20%20%20%20top%3A34%2C%20%0D%20%20%20%20width%3A640%2C%20%0D%20%20%20%20height%3A743%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; isc_cState=ready; JSESSIONID=1iq8qq2fa9uhw
          Connection: keep-alive
          Referer: http://127.0.0.1:52596/Nara.html?gwt.codesvr=127.0.0.1:52592
       Response headers
          X-Included-Test2: true
          X-Included-Test: true
          Content-Type: text/html; charset=iso-8859-1
          Content-Length: 1419
    === 2013-06-14 10:57:10,379 [l0-5] INFO  RequestContext - URL: '/images/aware/16/filter.jpg', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,380 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/hscroll_Disabled_start.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,383 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/hscroll_Disabled_start.png
    === 2013-06-14 10:57:10,384 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/hscroll_Disabled_track.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,384 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/hscroll_Disabled_track.png
    === 2013-06-14 10:57:10,385 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/hscroll_Disabled_end.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,386 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/hscroll_Disabled_end.png
    === 2013-06-14 10:57:10,387 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/hthumb_grip.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,388 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/hthumb_grip.png
    === 2013-06-14 10:57:10,388 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/vscroll_Disabled_start.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,389 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/vscroll_Disabled_start.png
    === 2013-06-14 10:57:10,390 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/vscroll_Disabled_track.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,391 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/vscroll_Disabled_track.png
    === 2013-06-14 10:57:10,391 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/vscroll_Disabled_end.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,393 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/vscroll_Disabled_end.png
    === 2013-06-14 10:57:10,394 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/vthumb_grip.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,395 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/vthumb_grip.png
    === 2013-06-14 10:57:10,395 [l0-5] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Menu/menu_button.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,397 [l0-5] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Menu/menu_button.png
    === 2013-06-14 10:57:10,397 [l0-5] INFO  RequestContext - URL: '/images/other/panelClose.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,343 [l0-4] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/TransferIcons/left.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,432 [l0-4] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/TransferIcons/left.png
    === 2013-06-14 10:57:10,343 [l0-1] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/edges/edge_TL.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,433 [l0-1] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/edges/edge_TL.png
    === 2013-06-14 10:57:10,342 [l0-6] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/headerIcons/close.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,437 [l0-6] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/headerIcons/close.png
    === 2013-06-14 10:57:10,392 [l0-3] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/Scrollbar/vscroll_Disabled_corner.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:10,440 [l0-3] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/Scrollbar/vscroll_Disabled_corner.png
    === 2013-06-14 10:57:17,662 [l0-3] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/TransferIcons/left_Over.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:17,663 [l0-3] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/TransferIcons/left_Over.png
    === 2013-06-14 10:57:27,726 [l0-3] INFO  RequestContext - URL: '/nara/exportServlet', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:27,727 [l0-3] INFO  ProxyHttpServletResponse - content-disposition set to: attachment;filename="null" - unwrapping response output stream (CompressionFilter)
    === 2013-06-14 10:57:27,730 [l0-3] DEBUG XML - Parsed XML from (in memory stream): 2ms
    === 2013-06-14 10:57:27,735 [l0-3] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
    === 2013-06-14 10:57:27,736 [l0-3] DEBUG AppBase - [builtinApplication.null] No userTypes defined, allowing anyone access to all operations for this application
    === 2013-06-14 10:57:27,748 [l0-3] DEBUG AppBase - [builtinApplication.null] No public zero-argument method named '_null' found, performing generic datasource operation
    java.lang.Exception: Can't find dataSource: dynDs314784014 - please make sure that you have a dynDs314784014.ds.xml file for it in [webRoot]/shared/ds
    	at com.isomorphic.application.AppBase.executeDefaultDSOperation(AppBase.java:672)
    	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:2033)
    	at com.isomorphic.datasource.DataSource.fetch(DataSource.java:2597)
    	at com.alcatel_lucent.aware.nara.server.ExportServlet.doGet(ExportServlet.java:65)
    	at javax.servlet.http.HttpServlet.service(HttpServlet.java:617)
    	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$CachedChain.doFilter(ServletHandler.java:1097)
    	at com.isomorphic.servlet.CompressionFilter.doFilter(CompressionFilter.java:259)
    	at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088)
    	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360)
    	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.headerComplete(HttpConnection.java:829)
    	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:513)
    	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-06-14 10:57:32,642 [l0-3] INFO  RequestContext - URL: '/nara/sc/skins/Enterprise/images/TransferIcons/right_Over.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header
    === 2013-06-14 10:57:32,644 [l0-3] INFO  Download - done streaming: C:/Users/leecy/Documents/proj/AWARE/aware/trunk/nara/war/nara/sc/skins/Enterprise/images/TransferIcons/right_Over.png
    4. The actual server response as shown in the RPC tab in the Developer Console: N/A

    5. if there is a JavaScript error, the stack trace logged in the Developer Console (see FAQ): N/A

    6. sample code if applicable: see above

    #2
    I have two strange observations.

    1. If I saved the dynamically generated XML string into a file under war/ds/, and then use DataSourceManager to load it, I could get the DataSource instance working (responding to fetch() operation correctly).

    Code:
    String dynDsHandle = "dynDs314784014";
    // first store the dynamically generated XML string
    // into a *.ds.xml file, and then
    DataSource ds = DataSourceManager.get(dynDsHandle)
    List list = ds.fetch(null); // okay
    2. Furthermore, and this is really strange, even if I just copied the generated DataSource instance (via the fromXML()) IN MEMORY (not file I/O), I could also get the instance working.

    Code:
    Map<String, DataSource> map = new HashMap<String, DataSource>();
    String dynDsHandle = "dynDs314784014";
    
    DataSource ds = DataSource.fromXML(xmlString);
    
    map.put(dynDsHandle, ds); // these two lines are line dummy, but they actually changed the result !
    DataSource ds2 = map.get(dynDsHandle);
    
    ds2.fetch(); // Also okay! Very strange

    Comment


      #3
      Take a look at the QuickStart, Server Framework chapter - the correct approach for server-side dynamic DataSources is to use DynamicDSGenerator, and not the approach you've attempted here. Details of usage are in the server-side JavaDoc.

      Comment


        #4
        Hi,

        I am following the suggestion by "Isomorphic" (probably one of your colleagues) from this post:

        http://forums.smartclient.com/showpost.php?p=61795&postcount=8

        Anyway, I have got my problem solved by writing the XML string to a file (*.ds.xml) first and then load it using DataSourceManager.

        I don't understand why I need to do that but it works. (Could it be a bug with the DataSource.fromXML() method?)

        Comment


          #5
          That's an obsolete approach which only works for limited features, which is why we've given the correct approach prominent placement (right in the QuickStart Guide).

          You should switch over to the correct approach soon, so that you aren't relying on a hack of writing new files (doesn't work in a variety of environments).

          Comment


            #6
            We are using the DynamicDSGenerator and have been successfully for some time. But after installing SmartClient Version: v8.3p_2013-06-16/PowerEdition Deployment (built 2013-06-16) we are seeing this message too.

            In our case it is intermittent and the datasource name is auto-generated. For example, one time the message might say "Can't find dataSource: isc_DataSource_610 - please make sure that you have a isc_DataSource_610.ds.xml file for it in [webRoot]/shared/ds" but the next time it might say "Can't find dataSource: isc_DataSource_614 ..."

            Comment


              #7
              To help us focus in, can you let us know what release you were using before 2013-06-16?

              Comment


                #8
                We took the 6/13 update a few days prior but not sure if it started showing up before we took the 6.16 build. Before that we were running the 3/13 build.

                Comment


                  #9
                  We see no changes since March 13th that would obviously have an effect on Dynamic DataSources. We're going to need a repro case or at least some more information around the circumstances of these failures to get any further.

                  That message is badly-worded, by the way - it has been around since before the introduction of DynamicDSGenerator, when the only explanation for a DataSource not being loadable was, there was no .ds.xml file. In your case, it probably means that your DynamicDSGenerator is returning null, and there is no file called isc_DataSource_610.ds.xml.

                  Finally, those names look like they have been auto-generated by client-side code - is that the case? If so, it implies that the names are meaningless in themselves, in which case how does your DynamicDSGenerator know what DS to generate?

                  Comment


                    #10
                    The auto-generated name is confusing us too. We have a few places in the app where we create a new DataSource() client side, but it is only used client side.

                    Since it is intermittent we haven't been able to tell exactly where the problem is, but given the point at which it occurs, it could be related to some initial demo screens that we created a few years ago and haven't touched since.

                    Does anything look wrong here?
                    Code:
                    DataSource newsDataSource = new DataSource();
                    newsDataSource
                    		.setDataURL("http://risnews.edgl.com/rss/RssLatestRetailNews");
                    newsDataSource.setRecordXPath("//item");
                    DataSourceTextField newsTitleField = new DataSourceTextField("title",
                    		"Title");
                    DataSourceLinkField newsLinkField = new DataSourceLinkField("link", "Link");
                    newsDataSource.setFields(newsTitleField, newsLinkField);
                    ListGrid newsGrid = new ListGrid();
                    newsGrid.setAutoFetchData(true);
                    newsGrid.setShowHeader(false);
                    newsGrid.setDataSource(newsDataSource);
                    newsGrid.setFields(new ListGridField("link"));
                    newsGrid.setLinkTextProperty("title");
                    
                    // Sample company calendar
                    DataSource eventDS = new DataSource();
                    DataSourceSequenceField eventIdField = new DataSourceSequenceField(
                    		"eventId");
                    eventIdField.setPrimaryKey(true);
                    DataSourceTextField nameField = new DataSourceTextField("name");
                    DataSourceTextField descField = new DataSourceTextField("description");
                    DataSourceDateTimeField startDateField = new DataSourceDateTimeField(
                    		"startDate");
                    DataSourceDateTimeField endDateField = new DataSourceDateTimeField(
                    		"endDate");
                    eventDS.setFields(eventIdField, nameField, descField, startDateField,
                    		endDateField);
                    eventDS.setClientOnly(true);
                    eventDS.setTestData(CalendarData.getRecords());
                    Calendar calendar = new Calendar();
                    calendar.setDataSource(eventDS);
                    calendar.setShowAddEventButton(true);
                    calendar.setAutoFetchData(true);
                    calendar.setCurrentViewName(ViewName.MONTH);
                    calendar.setHeight100();
                    calendar.setWidth100();
                    calendar.setTitle("Company Calendar");

                    Comment


                      #11
                      We've discovered the pattern that causes the problem. In our app, we first present a login screen and then load all of our datasources using information from the login screen in our DynamicDSGenerator.

                      If the user logs out and back in without closing the browser window, when the datasources are loaded again we see a message for each in the SC dev console. Here are a couple of examples.
                      Code:
                      10:45:37.542:XRP4:WARN:Log:Specified ID: DailyOrderActivity collides with the ID for an existing SmartGWT component or object. The existing object will be destroyed and the ID bound to the new object.
                      10:45:37.543:XRP4:WARN:Log:Specified ID: OrdersInProcess collides with the ID for an existing SmartGWT component or object. The existing object will be destroyed and the ID bound to the new object.
                      We've seen those messages for a long time and it makes sense that the old ds objects are destroyed and this has never been a problem.

                      But now, after those messages show up in the console we see these messages.
                      Code:
                      10:45:37.976:XRP7:WARN:RPCManager:Can't find dataSource: isc_DataSource_614 - please make sure that you have a isc_DataSource_614.ds.xml file for it in [webRoot]/shared/dsundefined - response: {operationId: "custom",
                      clientContext: undef,
                      context: Obj,
                      transactionNum: 59,
                      httpResponseCode: 200,
                      httpResponseText: "//isc_RPCResponseStart-->[{data:"Can't f..."[258],
                      xmlHttpRequest: [object XMLHttpRequest],
                      transport: "xmlHttpRequest",
                      status: -1,
                      clientOnly: undef,
                      httpHeaders: Obj,
                      isStructured: true,
                      callbackArgs: null,
                      results: Obj,
                      data: "Can't find dataSource: isc_DataSource_61..."[137],
                      invalidateCache: false,
                      isDSResponse: true,
                      queueStatus: -1}
                      10:45:37.995:XRP9:WARN:RPCManager:Can't find dataSource: isc_DataSource_614 - please make sure that you have a isc_DataSource_614.ds.xml file for it in [webRoot]/shared/dsundefined - response: {operationId: "custom",
                      clientContext: undef,
                      context: Obj,
                      transactionNum: 60,
                      httpResponseCode: 200,
                      httpResponseText: "//isc_RPCResponseStart-->[{data:"Can't f..."[258],
                      xmlHttpRequest: [object XMLHttpRequest],
                      transport: "xmlHttpRequest",
                      status: -1,
                      clientOnly: undef,
                      httpHeaders: Obj,
                      isStructured: true,
                      callbackArgs: null,
                      results: Obj,
                      data: "Can't find dataSource: isc_DataSource_61..."[137],
                      invalidateCache: false,
                      isDSResponse: true,
                      queueStatus: -1}
                      10:45:38.090:XRP3:WARN:RPCManager:Can't find dataSource: isc_DataSource_614 - please make sure that you have a isc_DataSource_614.ds.xml file for it in [webRoot]/shared/dsundefined - response: {operationId: "custom",
                      clientContext: undef,
                      context: Obj,
                      transactionNum: 61,
                      httpResponseCode: 200,
                      httpResponseText: "//isc_RPCResponseStart-->[{data:"Can't f..."[258],
                      xmlHttpRequest: [object XMLHttpRequest],
                      transport: "xmlHttpRequest",
                      status: -1,
                      clientOnly: undef,
                      httpHeaders: Obj,
                      isStructured: true,
                      callbackArgs: null,
                      results: Obj,
                      data: "Can't find dataSource: isc_DataSource_61..."[137],
                      invalidateCache: false,
                      isDSResponse: true,
                      queueStatus: -1}
                      10:45:38.107:XRP6:WARN:RPCManager:Can't find dataSource: isc_DataSource_614 - please make sure that you have a isc_DataSource_614.ds.xml file for it in [webRoot]/shared/dsundefined - response: {operationId: "custom",
                      clientContext: undef,
                      context: Obj,
                      transactionNum: 62,
                      httpResponseCode: 200,
                      httpResponseText: "//isc_RPCResponseStart-->[{data:"Can't f..."[258],
                      xmlHttpRequest: [object XMLHttpRequest],
                      transport: "xmlHttpRequest",
                      status: -1,
                      clientOnly: undef,
                      httpHeaders: Obj,
                      isStructured: true,
                      callbackArgs: null,
                      results: Obj,
                      data: "Can't find dataSource: isc_DataSource_61..."[137],
                      invalidateCache: false,
                      isDSResponse: true,
                      queueStatus: -1}
                      10:45:38.312:XRP2:WARN:RPCManager:Can't find dataSource: isc_DataSource_614 - please make sure that you have a isc_DataSource_614.ds.xml file for it in [webRoot]/shared/dsundefined - response: {operationId: "custom",
                      clientContext: undef,
                      context: Obj,
                      transactionNum: 71,
                      httpResponseCode: 200,
                      httpResponseText: "//isc_RPCResponseStart-->[{data:"Can't f..."[258],
                      xmlHttpRequest: [object XMLHttpRequest],
                      transport: "xmlHttpRequest",
                      status: -1,
                      clientOnly: undef,
                      httpHeaders: Obj,
                      isStructured: true,
                      callbackArgs: null,
                      results: Obj,
                      data: "Can't find dataSource: isc_DataSource_61..."[137],
                      invalidateCache: false,
                      isDSResponse: true,
                      queueStatus: -1}
                      On the server side console we get this stack trace.
                      Code:
                      java.lang.Exception: Can't find dataSource: isc_DataSource_614 - please make sure that you have a isc_DataSource_614.ds.xml file for it in [webRoot]/shared/ds
                      	at com.isomorphic.application.AppBase.executeDefaultDSOperation(AppBase.java:672)
                      	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:2033)
                      	at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:216)
                      	at com.islandpacific.gui.server.customDataSource.IpIDACall.handleDSRequest(IpIDACall.java:83)
                      	at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:173)
                      	at com.islandpacific.gui.server.customDataSource.IpIDACall.processRPCTransaction(IpIDACall.java:54)
                      	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$CachedChain.doFilter(ServletHandler.java:1097)
                      	at com.islandpacific.gui.server.GWTCacheControlFilter.doFilter(GWTCacheControlFilter.java:44)
                      	at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:343)
                      	at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:109)
                      	at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:83)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:97)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:100)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:35)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:188)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:105)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:79)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at com.islandpacific.gui.security.IpConcurrentSessionFilter.doFilter(IpConcurrentSessionFilter.java:55)
                      	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:355)
                      	at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:149)
                      	at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:237)
                      	at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:167)
                      	at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088)
                      	at com.isomorphic.servlet.CompressionFilter.doFilter(CompressionFilter.java:259)
                      	at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088)
                      	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360)
                      	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)

                      Comment


                        #12
                        OK, we have a suspicion about a possible cause for this, but it's pretty deep so a way to reproduce it ourselves would be helpful. Can you post the code that re-loads the DataSources?

                        Comment


                          #13
                          I've narrowed it down to a fetch to a particular datasource that is done after the datasources have been loaded. Now that I can recreate it I stopped in debug after the datasources are evalulated. The next thing that happens is a series of fetches to this datasource.
                          Code:
                          <DataSource ID="AS400Command" dataFormat="iscServer"
                          	webServiceOperations="fetch" dbName="as400"
                          	serverConstructor="com.islandpacific.gui.server.customDataSource.AS400CommandDS">
                          	<!-- An interface for the client to request the execution of an AS400 command. -->
                          	<fields>
                          		<field name="Command" title="Command" type="text" primaryKey="true"/>
                          		<field name="Success" title="Completed successfully" type="boolean"/>
                          	</fields>
                          </DataSource>
                          The fetch request is made in this method.
                          Code:
                          	/**
                          	 * Call an AS/400 command.
                          	 * @param commandText
                          	 * @param callback IpBooleanCallback When complete, calls onTrue if the command completed successfully or onFalse if the Command failed
                          	 */
                          	public static void executeAS400Command(String commandText, final IpBooleanCallback callback) {
                          		DSRequest request = new DSRequest();
                          		Criteria criteria = new Criteria("Command", commandText);
                          		myAs400CommandDS.fetchData(criteria, new DSCallback() {
                          			@Override
                          			public void execute(DSResponse response, Object rawData,
                          					DSRequest request) {
                          				Record values = (Record) response.getData()[0];
                          				boolean commandSuccessful = values.getAttributeAsBoolean("Success");
                          				if (commandSuccessful) {
                          					callback.onTrue();
                          				}
                          				else {
                          					callback.onFalse();
                          				}
                          			}
                          		}, request);
                          	}
                          This is the serverConstructor class that satisfies the fetch request using a utility class to execute a server command string passed in the Command field as critieria.
                          Code:
                          package com.islandpacific.gui.server.customDataSource;
                          
                          import java.util.HashMap;
                          import java.util.Map;
                          
                          import com.isomorphic.datasource.BasicDataSource;
                          import com.isomorphic.datasource.DSRequest;
                          import com.isomorphic.datasource.DSResponse;
                          
                          public class AS400CommandDS extends BasicDataSource {
                          
                          	
                          	@SuppressWarnings("unchecked")
                          	@Override
                          	public DSResponse execute(DSRequest req) throws Exception {
                          		
                          		DSResponse response = new DSResponse();
                          
                          		if (req.getOperationType().equals("fetch")
                          				|| req.getOperationType().equals("custom")) {
                          			Map criteria = req.getCriteria();
                          			if (criteria == null) {
                          				response.setData("Criteria not set for AS400 Command.");
                          				response.setFailure();
                          				return response;
                          			}
                          			if (!criteria.containsKey("Command")) {
                          				response.setData("Criteria not complete for AS400 Command.");
                          				response.setFailure();
                          				return response;
                          			}
                          			String command = (String)criteria.get("Command");
                          			
                          			Map responseData = new HashMap();
                          			responseData.put("Command", command);
                          			boolean success = AS400Utilities.executeAS400Command(command);
                          			responseData.put("Success", success);
                          			response.setData(responseData);
                          			return response;
                          		}
                          
                          		response.setData("Invalid request type for AS400Command");
                          		response.setFailure();
                          		return response;
                          
                          	}
                          }

                          Comment


                            #14
                            It looks like there are some missing pieces to your sample code. The execute() function in AS400CommandDS calls a single-argument function AS400Utilities.executeAS400Command() which expects a boolean return value. However, the snippet of AS400Utilities that you included instead defines a two-argument executeAS400Command() function with a void return value. In addition, you've nowhere defined IpBooleanCallback.

                            Can you provide a complete reproducing sample, ideally as a set of attached files rather than various snippets of things?

                            Comment


                              #15
                              Thank you for your responses so far. Jay is out of pocket this week and has asked me to pick up where he left off with you.

                              That being the case, it will take a little time to prepare the test case for which you asked, so in the meantime I thought I'd post the following snippet which shows the server-side definition for executeAS400Command(). The prior snippet that you correctly stated was mismatched with the remainder of the supplied code is actually the client-side implementation.

                              We will be working on putting together a test case until and unless you are able to discern the issue by examining this latest snippet.

                              Thanks again.

                              Code:
                              	/**
                              	 * Execute a command on the AS400
                              	 * @return true if the command succeeds
                              	 */
                              	public static boolean executeAS400Command(String commandText) {
                              		AS400 as400 = getAS400();
                              		if (as400 == null) {
                              			return false;
                              		}
                              		CommandCall command = new CommandCall(as400);
                              		log.info("Executing AS/400 command: " + commandText);
                              		boolean response = false;
                              		try {
                              			response = command.run(commandText);
                              		} catch (Exception e) {
                              			response = false;
                              		}
                              		log.info("AS/400 command completion: " + response);
                              		AS400Utilities.returnAS400(as400);
                              		return response;
                              	}

                              Comment

                              Working...
                              X