Announcement

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

    GWT Development Mode Crash: Bug?

    I have run into a crash when I try and run in GWT Development Mode. This crash does not occur if I run the identical code in production mode. I have narrowed the crash down to a single method invocation on the following line:

    Code:
    DataSource.get("jobControl").getField("COMMENTS").getLength();
    The invocation of getLength() causes a crash in dev mode as follows:

    Code:
    onModuleLoad() threw an exception
    
    Exception while loading module com.clp.dear.client.Dear. See Development Mode for details.
    java.lang.reflect.InvocationTargetException at 
    sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at 
    sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at 
    sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at 
    java.lang.reflect.Method.invoke(Method.java:597) at 
    com.google.gwt.dev.shell.ModuleSpace.onLoad(ModuleSpace.java:396) at 
    com.google.gwt.dev.shell.OophmSessionHandler.loadModule(OophmSessionHandler.java:183) at 
    com.google.gwt.dev.shell.BrowserChannelServer.processConnection(BrowserChannelServer.java:510) at 
    com.google.gwt.dev.shell.BrowserChannelServer.run(BrowserChannelServer.java:352) at
     java.lang.Thread.run(Thread.java:619) 
    
    Caused by: 
    com.google.gwt.dev.shell.HostedModeException: invoke arguments: JS value of type string, expected int at 
    com.google.gwt.dev.shell.JsValueGlue.getIntRange(JsValueGlue.java:266) at 
    com.google.gwt.dev.shell.JsValueGlue.get(JsValueGlue.java:144) at 
    com.google.gwt.dev.shell.MethodDispatch.invoke(MethodDispatch.java:65) at 
    com.google.gwt.dev.shell.OophmSessionHandler.invoke(OophmSessionHandler.java:157) at 
    com.google.gwt.dev.shell.BrowserChannelServer.reactToMessagesWhileWaitingForReturn(BrowserChannelServer.java:326) at 
    com.google.gwt.dev.shell.BrowserChannelServer.invokeJavascript(BrowserChannelServer.java:207) at 
    com.google.gwt.dev.shell.ModuleSpaceOOPHM.doInvoke(ModuleSpaceOOPHM.java:126) at 
    com.google.gwt.dev.shell.ModuleSpace.invokeNative(ModuleSpace.java:561) at 
    com.google.gwt.dev.shell.ModuleSpace.invokeNativeObject(ModuleSpace.java:269) at 
    com.google.gwt.dev.shell.JavaScriptHost.invokeNativeObject(JavaScriptHost.java:91) at 
    com.smartgwt.client.util.JSOHelper.getAttributeAsInt(JSOHelper.java) at 
    com.smartgwt.client.core.DataClass.getAttributeAsInt(DataClass.java:67) at 
    com.smartgwt.client.data.DataSourceField.getLength(DataSourceField.java:715) at 
    com.clp.dear.client.SectionReportSelection.(SectionReportSelection.java:288) at 
    com.clp.dear.client.Dear.onModuleLoad(Dear.java:165)
     ... 9 more
    If I simply remove the getLength call and have the following:

    Code:
    DataSource.get("jobControl").getField("COMMENTS");
    all is well.

    The code that works with no problem in production is:

    Code:
    textItemComment.setLength(DataSource.get("jobControl").getField("COMMENTS").getLength());
    This code works in dev mode if I use:

    Code:
    textItemComment.setLength(4000);
    This seems like a bug to me. Can anyone confirm this?

    I'm running 06Dec2010 ee nightly on FireFox 3.6.13.

    From the jobControl.ds.xml datasource descriptor:
    Code:
    <DataSource ID="jobControl" serverType="sql" tableName="DEAR.AUDIT_JOB_QUEUE">
        <fields>
            <field name="JOB_ROW_ID" type="sequence" sequenceName="SEQ_AUDIT_JOB_QUEUE" />
            <field name="JOB_ID" type="text" length="50" primaryKey="true"/>
            ...
            <field name="COMMENTS" type="text" length="4000"/>
            ...
        </fields>
        <title>Job Control</title>
        <titleField>JOB_ID</titleField>
    </DataSource>
    -=> Gregg <=-
    Last edited by gsl1; 3 Jan 2011, 07:03.

    #2
    In what browsers does it occur in GWT Development Mode? If it's Chrome only, it's probably another manifestation of core GWT Chrome-specific bugs mentioned in the FAQ.

    If it's all browsers, it's probably an IDE/project misconfiguration issue - it suggests that schema files such as DataSourceField.ds.xml are not being loaded in Dev Mode. To confirm, please capture the HTTP response from the DataSourceLoader servlet in Dev Mode vs Production Mode (you can use Firebug, for example), and post them here.

    Comment


      #3
      As I mentioned previously, I am using FireFox 3.6.13.

      I also went and tried this in Chrome 9.0.597.19 (Official Build 68937) beta and in IE 6.0.2900.5512.xpsp_sp3_gdr.090206-1234 with identical development mode crash results. I believe that the following is the information that you have requested, but if not please let me know and I will endeavor to provide it:

      Code:
      GET DataSourceLoader?dataSource=jobControl,jobControlDetail,protocol,subject,studyDate,auditReportAnnotations,auditReportCalibrations,auditReportImages
      http://localhost:8090/dear/dear/sc/DataSourceLoader?dataSource=jobControl,jobControlDetail,protocol,subject,studyDate,auditReportAnnotations,auditReportCalibrations,auditReportImages
      	
      200 OK
      	
      localhost:8090
      	
      13.9 KB
      	
       
      31ms
      	
      ParamsHeadersPostPutResponseCacheHTML
      Response Headerspretty print
      
      HTTP/1.1 200 OK
      Server: Apache-Coyote/1.1
      X-Included-Test2: true
      X-Included-Test: true
      Transfer-Encoding: chunked
      Date: Mon, 03 Jan 2011 18:01:50 GMT
      
      
      Request Headersview source
      Host	localhost:8090
      User-Agent	Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)
      Accept	*/*
      Accept-Language	en-us,en;q=0.5
      Accept-Encoding	gzip,deflate
      Accept-Charset	ISO-8859-1,utf-8;q=0.7,*;q=0.7
      Keep-Alive	115
      Connection	keep-alive
      Referer	http://localhost:8090/dear/report.html?gwt.codesvr=127.0.0.1:9997
      Cookie	JSESSIONID=C3F061BEC03942FF51D15EE28FDD7826; GLog=%7B%0D%20%20%20%20left%3A166%2C%20%0D%20%20%20%20top%3A25%2C%20%0D%20%20%20%20width%3A1272%2C%20%0D%20%20%20%20height%3A811%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%2C%20%0D%20%20%20%20%20%20%20%20layout%3A3%2C%20%0D%20%20%20%20%20%20%20%20RPCManager%3A5%2C%20%0D%20%20%20%20%20%20%20%20RPCManagerResponse%3A5%2C%20%0D%20%20%20%20%20%20%20%20xmlComm%3A5%2C%20%0D%20%20%20%20%20%20%20%20sizing%3A3%2C%20%0D%20%20%20%20%20%20%20%20scrolling%3A3%2C%20%0D%20%20%20%20%20%20%20%20animation%3A3%2C%20%0D%20%20%20%20%20%20%20%20dragDrop%3A3%2C%20%0D%20%20%20%20%20%20%20%20loadTime%3A3%2C%20%0D%20%20%20%20%20%20%20%20redraws%3A3%2C%20%0D%20%20%20%20%20%20%20%20redrawTrace%3A3%2C%20%0D%20%20%20%20%20%20%20%20draws%3A3%2C%20%0D%20%20%20%20%20%20%20%20resize%3A3%2C%20%0D%20%20%20%20%20%20%20%20ResultSet%3A5%2C%20%0D%20%20%20%20%20%20%20%20fetchTrace%3A5%2C%20%0D%20%20%20%20%20%20%20%20ResultTree%3A5%2C%20%0D%20%20%20%20%20%20%20%20xmlToJS%3A5%2C%20%0D%20%20%20%20%20%20%20%20xmlBinding%3A5%2C%20%0D%20%20%20%20%20%20%20%20xmlSelect%3A5%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A5%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D; isc_cState=ready

      Comment


        #4
        No, we need the actual response text (not just headers) in both Development and Compiled mode.

        We'll also need the server startup logs (for each mode).

        Comment


          #5
          Sorry, I didn't know where to look within Firebug to obtain the response text beyond the headers; however, I think I found what you are asking for. I have included the output for the jobControl datasource, since it is the one where the problem appears to occur. If the text below is what you are looking for, please let me know and I will be happy to provide all of the requested info:

          Dev mode with crash:
          Code:
          isc.DataSource.create({
              title:"Job Control",
              titleField:"JOB_ID",
              tableName:"DEAR.AUDIT_JOB_QUEUE",
              ID:"jobControl",
              fields:[
                  {
                      name:"JOB_ROW_ID",
                      sequenceName:"SEQ_AUDIT_JOB_QUEUE",
                      type:"sequence"
                  },
                  {
                      length:"50",
                      name:"JOB_ID",
                      primaryKey:true,
                      type:"text"
                  },
                  {
                      length:"100",
                      name:"CVS_PROTOCOL_NAME",
                      type:"text"
                  },
                  {
                      length:"100",
                      name:"CVS_SUBJECT",
                      type:"text"
                  },
                  {
                      length:"10",
                      name:"FILE_TYPE",
                      type:"text"
                  },
                  {
                      length:"100",
                      name:"JOB_STATUS",
                      type:"text"
                  },
                  {
                      name:"JOB_START_DATE",
                      type:"datetime"
                  },
                  {
                      name:"JOB_COMPLETED_DATE",
                      type:"datetime"
                  },
                  {
                      length:"100",
                      name:"JOB_PERCENT_COMPLETE",
                      type:"text"
                  },
                  {
                      length:"1",
                      name:"REQUEST_FOR_TERMINATE",
                      type:"text"
                  },
                  {
                      length:"100",
                      name:"REQUEST_FOR_TERMINATE_BY",
                      type:"text"
                  },
                  {
                      name:"REQUEST_FOR_TERMINATE_DATE",
                      type:"datetime"
                  },
                  {
                      length:"4000",
                      name:"JOB_EXCEPTION_MESSAGE",
                      type:"text"
                  },
                  {
                      length:"100",
                      name:"JOB_EXCEPTION_USER",
                      type:"text"
                  },
                  {
                      name:"JOB_EXCEPTION_DATE",
                      type:"datetime"
                  },
                  {
                      length:"100",
                      name:"CREATED_BY",
                      type:"text"
                  },
                  {
                      name:"CREATED_DATE",
                      type:"datetime"
                  },
                  {
                      length:"100",
                      name:"UPDATED_BY",
                      type:"text"
                  },
                  {
                      name:"UPDATED_DATE",
                      type:"datetime"
                  },
                  {
                      length:"4000",
                      name:"COMMENTS",
                      type:"text"
                  },
                  {
                      name:"DB_JOB_START_DATE",
                      type:"datetime"
                  },
                  {
                      name:"DB_JOB_COMPLETED_DATE",
                      type:"datetime"
                  }
              ],
              serverType:"sql"
          })
          -=> Gregg <=-

          Comment


            #6
            That's the right information, and it's available in Firebug's NET panel by opening any resource line and clicking in the "Response" tab. But we still need it for both Dev Mode and Compiled Mode, and the server startup logs for each.

            Comment


              #7
              Thanks, I can't believe I missed the tab. I did it a different way, by right clicking on the link in the histogram display and selecting "Open in New Tab", but both methods achieve identical results.

              For development mode I have:

              Tomcat startup log:

              Code:
              Jan 3, 2011 2:20:28 PM org.apache.catalina.core.AprLifecycleListener init
              INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: C:\DevApps\eclipse\MyEclipse\Common\binary\com.sun.java.jdk.win32.x86_1.6.0.013\bin;C:\DevApps\tomcat\apache-tomcat-6.0.20\bin
              Jan 3, 2011 2:20:28 PM org.apache.coyote.http11.Http11Protocol init
              INFO: Initializing Coyote HTTP/1.1 on http-8090
              Jan 3, 2011 2:20:28 PM org.apache.catalina.startup.Catalina load
              INFO: Initialization processed in 653 ms
              Jan 3, 2011 2:20:28 PM org.apache.catalina.core.StandardService start
              INFO: Starting service Catalina
              Jan 3, 2011 2:20:28 PM org.apache.catalina.core.StandardEngine start
              INFO: Starting Servlet Engine: Apache Tomcat/6.0.20
              Jan 3, 2011 2:20:28 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
              INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\WEB-INF\lib\gwt-dev.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
              Jan 3, 2011 2:20:28 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
              INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\WEB-INF\lib\gwt-user.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
              Jan 3, 2011 2:20:29 PM org.apache.catalina.core.ApplicationContext log
              INFO: Initializing Spring root WebApplicationContext
              INFO  ContextLoader                   - Root WebApplicationContext: initialization started
              INFO  XmlWebApplicationContext        - Refreshing Root WebApplicationContext: startup date [Mon Jan 03 14:20:30 EST 2011]; root of context hierarchy
              INFO  XmlBeanDefinitionReader         - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-security.xml]
              INFO  tpSecurityBeanDefinitionParser  - Checking sorted filter chain: [<concurrencyFilter>, order = 200, Root bean: class [org.springframework.security.web.context.SecurityContextPersistenceFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 300, <formLoginFilter>, order = 800, Root bean: class [org.springframework.security.web.savedrequest.RequestCacheAwareFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1300, Root bean: class [org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1400, Root bean: class [org.springframework.security.web.session.SessionManagementFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1700, Root bean: class [org.springframework.security.web.access.ExceptionTranslationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1800, <org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0>, order = 1900]
              INFO  DefaultListableBeanFactory      - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@b8fba5: defining beans [org.springframework.security.web.PortMapperImpl#0,org.springframework.security.web.context.HttpSessionSecurityContextRepository#0,org.springframework.security.authentication.ProviderManager#0,org.springframework.security.access.vote.AffirmativeBased#0,org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0,org.springframework.security.web.access.DefaultWebInvocationPrivilegeEvaluator#0,org.springframework.security.web.savedrequest.HttpSessionRequestCache#0,org.springframework.security.config.http.UserDetailsServiceInjectionBeanPostProcessor#0,org.springframework.security.filterChainProxy,org.springframework.security.core.userdetails.memory.InMemoryDaoImpl#0,org.springframework.security.authentication.dao.DaoAuthenticationProvider#0,org.springframework.security.authentication.DefaultAuthenticationEventPublisher#0,org.springframework.security.authenticationManager,formLoginFilter,authenticationEntryPoint,accessDeniedHandler,concurrencyFilter,sessionAuthenticationStrategy,sessionRegistry]; root of factory hierarchy
              INFO  FilterSecurityInterceptor       - Validated configuration attributes
              INFO  ContextLoader                   - Root WebApplicationContext: initialization completed in 3515 ms
              [Server@14cbc58]: [Thread[main,5,main]]: checkRunning(false) entered
              [Server@14cbc58]: [Thread[main,5,main]]: checkRunning(false) exited
              [Server@14cbc58]: Startup sequence initiated from main() method
              [Server@14cbc58]: Loaded properties from [C:\DevApps\tomcat\apache-tomcat-6.0.20\bin\server.properties]
              [Server@14cbc58]: Initiating startup sequence...
              [Server@14cbc58]: Server socket opened successfully in 0 ms.
              [Server@14cbc58]: Database [index=0, id=0, db=file:C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\WEB-INF\db\hsqldb\isomorphic, alias=isomorphic] opened sucessfully in 906 ms.
              [Server@14cbc58]: Startup sequence completed in 922 ms.
              [Server@14cbc58]: 2011-01-03 14:20:34.461 HSQLDB server 1.8.0 is online
              [Server@14cbc58]: To close normally, connect and execute SHUTDOWN SQL
              [Server@14cbc58]: From command line, use [Ctrl]+[C] to abort abruptly
              ISC: Configuring log4j from: file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/BuiltInDS/WEB-INF/classes/log4j.isc.config.xml
              === 2011-01-03 14:20:34,758 [main] INFO  ISCInit - Isomorphic SmartClient Framework - Initializing
              === 2011-01-03 14:20:34,789 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
              === 2011-01-03 14:20:35,023 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/BuiltInDS/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties
              === 2011-01-03 14:20:35,023 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
              === 2011-01-03 14:20:35,023 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
              === 2011-01-03 14:20:35,023 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/BuiltInDS/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties
              === 2011-01-03 14:20:35,023 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
              === 2011-01-03 14:20:35,039 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/BuiltInDS/WEB-INF/classes/server.properties
              === 2011-01-03 14:20:35,070 [main] INFO  Logger - Logging system started.
              === 2011-01-03 14:20:35,070 [main] INFO  ISCInit - Isomorphic SmartClient Framework (SC_SNAPSHOT-2010-10-20/EVAL Deployment 2010-10-20) - Initialization Complete
              === 2011-01-03 14:20:35,070 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS
              === 2011-01-03 14:20:35,242 [main] INFO  PreCache - Isomorphic PreCache servlet loading
              === 2011-01-03 14:20:35,320 [main] INFO  PoolManager - SmartClient pooling disabled for 'DataSource' objects
              === 2011-01-03 14:20:35,492 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DataSource.ds.xml: 15ms
              === 2011-01-03 14:20:35,508 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\builtinTypes.xml: 16ms
              === 2011-01-03 14:20:35,648 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DataSourceField.ds.xml: 0ms
              === 2011-01-03 14:20:35,680 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Validator.ds.xml: 0ms
              === 2011-01-03 14:20:35,711 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\ValueMap.ds.xml: 0ms
              === 2011-01-03 14:20:35,727 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\InstantDataApp.ds.xml: 0ms
              === 2011-01-03 14:20:35,945 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Application.ds.xml: 0ms
              === 2011-01-03 14:20:35,961 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\IDAPage.ds.xml: 0ms
              === 2011-01-03 14:20:35,977 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\IDAUserType.ds.xml: 0ms
              === 2011-01-03 14:20:36,008 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\IDAOperation.ds.xml: 0ms
              === 2011-01-03 14:20:36,055 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Canvas.ds.xml: 16ms
              === 2011-01-03 14:20:36,164 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\MethodDeclaration.ds.xml: 0ms
              === 2011-01-03 14:20:36,180 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Img.ds.xml: 0ms
              === 2011-01-03 14:20:36,195 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\StatefulCanvas.ds.xml: 0ms
              === 2011-01-03 14:20:36,242 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Button.ds.xml: 0ms
              === 2011-01-03 14:20:36,273 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\ListViewer.ds.xml: 0ms
              === 2011-01-03 14:20:36,289 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\ListGrid.ds.xml: 0ms
              === 2011-01-03 14:20:36,367 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DynamicForm.ds.xml: 0ms
              === 2011-01-03 14:20:36,414 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\FormItem.ds.xml: 0ms
              === 2011-01-03 14:20:36,445 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DetailViewer.ds.xml: 0ms
              === 2011-01-03 14:20:36,477 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DetailViewerField.ds.xml: 0ms
              === 2011-01-03 14:20:36,492 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\isomorphicXML.ds.xml: 0ms
              === 2011-01-03 14:20:36,508 [main] INFO  PreCache - Isomorphic PreCache complete (1266ms)
              Jan 3, 2011 2:20:36 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
              INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\WEB-INF\lib\gwt-dev.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
              Jan 3, 2011 2:20:36 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
              INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\WEB-INF\lib\gwt-user.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
              Jan 3, 2011 2:20:38 PM org.apache.catalina.core.ApplicationContext log
              INFO: Initializing Spring root WebApplicationContext
              INFO  ContextLoader                   - Root WebApplicationContext: initialization started
              INFO  XmlWebApplicationContext        - Refreshing Root WebApplicationContext: startup date [Mon Jan 03 14:20:38 EST 2011]; root of context hierarchy
              INFO  XmlBeanDefinitionReader         - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext.xml]
              INFO  PropertyPlaceholderConfigurer   - Loading properties file from ServletContext resource [/WEB-INF/listServerClient.properties]
              INFO  DefaultListableBeanFactory      - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@1387985: defining beans [propertyConfigurer,listServerSettings,listServerDAOprotocolFactory,listServerDAOprotocol,listServerDAOsubjectFactory,listServerDAOsubject,listServerDAOstudyDateFactory,listServerDAOstudyDate,ListServerProtocolsDMI,ListServerSubjectsDMI,ListServerStudyDatesDMI]; root of factory hierarchy
              INFO  ContextLoader                   - Root WebApplicationContext: initialization completed in 2359 ms
              ISC: Configuring log4j from: file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/WEB-INF/classes/log4j.isc.config.xml
              === 2011-01-03 14:20:41,133 [main] INFO  ISCInit - Isomorphic SmartClient Framework - Initializing
              === 2011-01-03 14:20:41,164 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
              === 2011-01-03 14:20:41,414 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties
              === 2011-01-03 14:20:41,414 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
              === 2011-01-03 14:20:41,414 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
              === 2011-01-03 14:20:41,430 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties
              === 2011-01-03 14:20:41,430 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
              === 2011-01-03 14:20:41,430 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/WEB-INF/classes/server.properties
              === 2011-01-03 14:20:41,477 [main] INFO  Logger - Logging system started.
              === 2011-01-03 14:20:41,477 [main] INFO  ISCInit - Isomorphic SmartClient Framework (SC_SNAPSHOT-2010-12-06/EVAL Deployment 2010-12-06) - Initialization Complete
              === 2011-01-03 14:20:41,477 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear
              === 2011-01-03 14:20:41,633 [main] INFO  PreCache - Isomorphic PreCache servlet loading
              === 2011-01-03 14:20:41,727 [main] INFO  PoolManager - SmartClient pooling disabled for 'DataSource' objects
              === 2011-01-03 14:20:41,930 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DataSource.ds.xml: 16ms
              === 2011-01-03 14:20:41,945 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\builtinTypes.xml: 0ms
              === 2011-01-03 14:20:42,070 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DataSourceField.ds.xml: 0ms
              === 2011-01-03 14:20:42,102 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Validator.ds.xml: 0ms
              === 2011-01-03 14:20:42,133 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\ValueMap.ds.xml: 0ms
              === 2011-01-03 14:20:42,164 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\InstantDataApp.ds.xml: 16ms
              === 2011-01-03 14:20:42,398 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Application.ds.xml: 0ms
              === 2011-01-03 14:20:42,430 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\IDAPage.ds.xml: 16ms
              === 2011-01-03 14:20:42,445 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\IDAUserType.ds.xml: 15ms
              === 2011-01-03 14:20:42,461 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\IDAOperation.ds.xml: 0ms
              === 2011-01-03 14:20:42,508 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Canvas.ds.xml: 0ms
              === 2011-01-03 14:20:42,617 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\MethodDeclaration.ds.xml: 15ms
              === 2011-01-03 14:20:42,633 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Img.ds.xml: 0ms
              === 2011-01-03 14:20:42,648 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\StatefulCanvas.ds.xml: 0ms
              === 2011-01-03 14:20:42,695 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Button.ds.xml: 0ms
              === 2011-01-03 14:20:42,727 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\ListViewer.ds.xml: 0ms
              === 2011-01-03 14:20:42,742 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\ListGrid.ds.xml: 15ms
              === 2011-01-03 14:20:42,820 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DynamicForm.ds.xml: 0ms
              === 2011-01-03 14:20:42,867 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\FormItem.ds.xml: 0ms
              === 2011-01-03 14:20:42,898 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DetailViewer.ds.xml: 0ms
              === 2011-01-03 14:20:42,930 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DetailViewerField.ds.xml: 0ms
              === 2011-01-03 14:20:42,945 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\isomorphicXML.ds.xml: 0ms
              === 2011-01-03 14:20:42,961 [main] INFO  PreCache - Isomorphic PreCache complete (1328ms)
              Jan 3, 2011 2:20:43 PM org.apache.catalina.core.ApplicationContext log
              INFO: ContextListener: contextInitialized()
              Jan 3, 2011 2:20:43 PM org.apache.catalina.core.ApplicationContext log
              INFO: SessionListener: contextInitialized()
              Jan 3, 2011 2:20:43 PM org.apache.coyote.http11.Http11Protocol start
              INFO: Starting Coyote HTTP/1.1 on http-8090
              Jan 3, 2011 2:20:43 PM org.apache.jk.common.ChannelSocket init
              INFO: JK: ajp13 listening on /0.0.0.0:8009
              Jan 3, 2011 2:20:43 PM org.apache.jk.server.JkMain start
              INFO: Jk running ID=0 time=0/78  config=null
              Jan 3, 2011 2:20:43 PM org.apache.catalina.startup.Catalina start
              INFO: Server startup in 15417 ms
              After entering dev mode I get from tomcat:

              Code:
              === 2011-01-03 14:23:41,209 [90-1] INFO  RequestContext - URL: '/dear/report.html', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,240 [90-1] INFO  Compression - /dear/report.html: 2706 -> 1225 bytes
              === 2011-01-03 14:23:41,287 [90-1] INFO  RequestContext - URL: '/dear/Dear.css', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,287 [90-1] INFO  Compression - /dear/Dear.css: 1869 -> 803 bytes
              === 2011-01-03 14:23:41,302 [90-2] INFO  RequestContext - URL: '/dear/images/ctAbdAnimation.gif', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,380 [90-1] INFO  RequestContext - URL: '/dear/dear/dear.nocache.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,380 [90-1] INFO  Compression - /dear/dear/dear.nocache.js: 6099 -> 2291 bytes
              === 2011-01-03 14:23:41,474 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,490 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/initsc.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,505 [90-1] INFO  Compression - /dear/dear/sc/initsc.js: 47 -> 72 bytes
              === 2011-01-03 14:23:41,505 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\jobControl.ds.xml: 15ms
              === 2011-01-03 14:23:41,537 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Core.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,771 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Grids.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,802 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Foundation.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,802 [90-1] INFO  Compression - /dear/dear/sc/modules/ISC_Core.js: 665612 -> 172884 bytes
              === 2011-01-03 14:23:41,771 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Forms.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:41,771 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Containers.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:42,052 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\jobControlDetail.ds.xml: 0ms
              === 2011-01-03 14:23:42,005 [90-5] INFO  Compression - /dear/dear/sc/modules/ISC_Grids.js: 660431 -> 167339 bytes
              === 2011-01-03 14:23:41,943 [90-3] INFO  Compression - /dear/dear/sc/modules/ISC_Foundation.js: 219230 -> 52149 bytes
              === 2011-01-03 14:23:42,255 [90-6] INFO  Compression - /dear/dear/sc/modules/ISC_Forms.js: 550423 -> 133919 bytes
              === 2011-01-03 14:23:42,224 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\protocol.ds.xml: 47ms
              === 2011-01-03 14:23:42,177 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_RichTextEditor.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:42,177 [90-4] INFO  Compression - /dear/dear/sc/modules/ISC_Containers.js: 110119 -> 27228 bytes
              === 2011-01-03 14:23:42,287 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\ServerObject.ds.xml: 16ms
              === 2011-01-03 14:23:42,271 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Calendar.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:42,318 [90-3] INFO  Compression - /dear/dear/sc/modules/ISC_Calendar.js: 102519 -> 24581 bytes
              === 2011-01-03 14:23:42,349 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/load_skin.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:42,318 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\subject.ds.xml: 16ms
              === 2011-01-03 14:23:42,287 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_DataBinding.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:42,287 [90-1] INFO  Compression - /dear/dear/sc/modules/ISC_RichTextEditor.js: 38915 -> 10929 bytes
              === 2011-01-03 14:23:42,396 [90-3] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/load_skin.js
              === 2011-01-03 14:23:42,412 [90-3] INFO  Compression - /dear/dear/sc/skins/EnterpriseBlue/load_skin.js: 29216 -> 6175 bytes
              === 2011-01-03 14:23:42,459 [90-4] INFO  Compression - /dear/dear/sc/modules/ISC_DataBinding.js: 496136 -> 123906 bytes
              === 2011-01-03 14:23:42,459 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\studyDate.ds.xml: 47ms
              === 2011-01-03 14:23:42,474 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\auditReportAnnotations.ds.xml: 0ms
              === 2011-01-03 14:23:42,505 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\auditReportCalibrations.ds.xml: 0ms
              === 2011-01-03 14:23:42,521 [90-2] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\auditReportImages.ds.xml: 0ms
              === 2011-01-03 14:23:44,849 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/skin_styles.css', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:44,849 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/skin_styles.css
              === 2011-01-03 14:23:44,849 [90-1] INFO  Compression - /dear/dear/sc/skins/EnterpriseBlue/skin_styles.css: 60884 -> 7955 bytes
              === 2011-01-03 14:23:46,334 [90-3] INFO  RequestContext - URL: '/dear/dear/hosted.html', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:46,334 [90-3] INFO  Compression - /dear/dear/hosted.html: 11289 -> 4037 bytes
              === 2011-01-03 14:23:46,334 [90-2] INFO  RequestContext - URL: '/dear/dear/gwt/standard/standard.css', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
              === 2011-01-03 14:23:46,334 [90-2] INFO  Compression - /dear/dear/gwt/standard/standard.css: 26804 -> 3832 bytes

              I see the following errors:

              Code:
              INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\WEB-INF\lib\gwt-dev.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
              Jan 3, 2011 2:20:36 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
              INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\WEB-INF\lib\gwt-user.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
              If this is where my problem is, how can I get these jars to be loaded during runtime within Eclipse? Currently, they are in my build path, but they are not within my WEB-INF/lib directory.

              I do of course have gwt-servlet.jar in WEB-INF/lib.


              I get the crash stacktrace in the browser and in the dev mode console:

              Code:
              onModuleLoad() threw an exception
              
              Exception while loading module com.clp.dear.client.Dear. See Development Mode for details.
              java.lang.reflect.InvocationTargetException at 
              sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at 
              sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at 
              sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at 
              java.lang.reflect.Method.invoke(Method.java:597) at 
              com.google.gwt.dev.shell.ModuleSpace.onLoad(ModuleSpace.java:396) at 
              com.google.gwt.dev.shell.OophmSessionHandler.loadModule(OophmSessionHandler.java:183) at 
              com.google.gwt.dev.shell.BrowserChannelServer.processConnection(BrowserChannelServer.java:510) at 
              com.google.gwt.dev.shell.BrowserChannelServer.run(BrowserChannelServer.java:352) at
               java.lang.Thread.run(Thread.java:619) 
              
              Caused by: 
              com.google.gwt.dev.shell.HostedModeException: invoke arguments: JS value of type string, expected int at 
              com.google.gwt.dev.shell.JsValueGlue.getIntRange(JsValueGlue.java:266) at 
              com.google.gwt.dev.shell.JsValueGlue.get(JsValueGlue.java:144) at 
              com.google.gwt.dev.shell.MethodDispatch.invoke(MethodDispatch.java:65) at 
              com.google.gwt.dev.shell.OophmSessionHandler.invoke(OophmSessionHandler.java:157) at 
              com.google.gwt.dev.shell.BrowserChannelServer.reactToMessagesWhileWaitingForReturn(BrowserChannelServer.java:326) at 
              com.google.gwt.dev.shell.BrowserChannelServer.invokeJavascript(BrowserChannelServer.java:207) at 
              com.google.gwt.dev.shell.ModuleSpaceOOPHM.doInvoke(ModuleSpaceOOPHM.java:126) at 
              com.google.gwt.dev.shell.ModuleSpace.invokeNative(ModuleSpace.java:561) at 
              com.google.gwt.dev.shell.ModuleSpace.invokeNativeObject(ModuleSpace.java:269) at 
              com.google.gwt.dev.shell.JavaScriptHost.invokeNativeObject(JavaScriptHost.java:91) at 
              com.smartgwt.client.util.JSOHelper.getAttributeAsInt(JSOHelper.java) at 
              com.smartgwt.client.core.DataClass.getAttributeAsInt(DataClass.java:67) at 
              com.smartgwt.client.data.DataSourceField.getLength(DataSourceField.java:715) at 
              com.clp.dear.client.SectionReportSelection.(SectionReportSelection.java:288) at 
              com.clp.dear.client.Dear.onModuleLoad(Dear.java:165)
               ... 9 more
              Here is the response text for the job control datasource load:

              Code:
              isc.DataSource.create({
                  title:"Job Control",
                  titleField:"JOB_ID",
                  tableName:"DEAR.AUDIT_JOB_QUEUE",
                  ID:"jobControl",
                  fields:[
                      {
                          name:"JOB_ROW_ID",
                          sequenceName:"SEQ_AUDIT_JOB_QUEUE",
                          type:"sequence"
                      },
                      {
                          length:"50",
                          name:"JOB_ID",
                          primaryKey:true,
                          type:"text"
                      },
                      {
                          length:"100",
                          name:"CVS_PROTOCOL_NAME",
                          type:"text"
                      },
                      {
                          length:"100",
                          name:"CVS_SUBJECT",
                          type:"text"
                      },
                      {
                          length:"10",
                          name:"FILE_TYPE",
                          type:"text"
                      },
                      {
                          length:"100",
                          name:"JOB_STATUS",
                          type:"text"
                      },
                      {
                          name:"JOB_START_DATE",
                          type:"datetime"
                      },
                      {
                          name:"JOB_COMPLETED_DATE",
                          type:"datetime"
                      },
                      {
                          length:"100",
                          name:"JOB_PERCENT_COMPLETE",
                          type:"text"
                      },
                      {
                          length:"1",
                          name:"REQUEST_FOR_TERMINATE",
                          type:"text"
                      },
                      {
                          length:"100",
                          name:"REQUEST_FOR_TERMINATE_BY",
                          type:"text"
                      },
                      {
                          name:"REQUEST_FOR_TERMINATE_DATE",
                          type:"datetime"
                      },
                      {
                          length:"4000",
                          name:"JOB_EXCEPTION_MESSAGE",
                          type:"text"
                      },
                      {
                          length:"100",
                          name:"JOB_EXCEPTION_USER",
                          type:"text"
                      },
                      {
                          name:"JOB_EXCEPTION_DATE",
                          type:"datetime"
                      },
                      {
                          length:"100",
                          name:"CREATED_BY",
                          type:"text"
                      },
                      {
                          name:"CREATED_DATE",
                          type:"datetime"
                      },
                      {
                          length:"100",
                          name:"UPDATED_BY",
                          type:"text"
                      },
                      {
                          name:"UPDATED_DATE",
                          type:"datetime"
                      },
                      {
                          length:"4000",
                          name:"COMMENTS",
                          type:"text"
                      },
                      {
                          name:"DB_JOB_START_DATE",
                          type:"datetime"
                      },
                      {
                          name:"DB_JOB_COMPLETED_DATE",
                          type:"datetime"
                      }
                  ],
                  serverType:"sql"
              })
              Post is too large to put in one reply, so I have split it up. Compiled production output to follow in a second post.

              -=> Gregg <=-
              Last edited by gsl1; 3 Jan 2011, 11:57.

              Comment


                #8
                Compiled production mode:

                Tomcat startup log:

                Code:
                Jan 3, 2011 2:42:00 PM org.apache.catalina.core.AprLifecycleListener init
                INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: C:\DevApps\eclipse\MyEclipse\Common\binary\com.sun.java.jdk.win32.x86_1.6.0.013\bin;C:\DevApps\tomcat\apache-tomcat-6.0.20\bin
                Jan 3, 2011 2:42:00 PM org.apache.coyote.http11.Http11Protocol init
                INFO: Initializing Coyote HTTP/1.1 on http-8090
                Jan 3, 2011 2:42:00 PM org.apache.catalina.startup.Catalina load
                INFO: Initialization processed in 762 ms
                Jan 3, 2011 2:42:00 PM org.apache.catalina.core.StandardService start
                INFO: Starting service Catalina
                Jan 3, 2011 2:42:00 PM org.apache.catalina.core.StandardEngine start
                INFO: Starting Servlet Engine: Apache Tomcat/6.0.20
                Jan 3, 2011 2:42:01 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
                INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\WEB-INF\lib\gwt-dev.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
                Jan 3, 2011 2:42:01 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
                INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\WEB-INF\lib\gwt-user.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
                Jan 3, 2011 2:42:02 PM org.apache.catalina.core.ApplicationContext log
                INFO: Initializing Spring root WebApplicationContext
                INFO  ContextLoader                   - Root WebApplicationContext: initialization started
                INFO  XmlWebApplicationContext        - Refreshing Root WebApplicationContext: startup date [Mon Jan 03 14:42:02 EST 2011]; root of context hierarchy
                INFO  XmlBeanDefinitionReader         - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-security.xml]
                INFO  tpSecurityBeanDefinitionParser  - Checking sorted filter chain: [<concurrencyFilter>, order = 200, Root bean: class [org.springframework.security.web.context.SecurityContextPersistenceFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 300, <formLoginFilter>, order = 800, Root bean: class [org.springframework.security.web.savedrequest.RequestCacheAwareFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1300, Root bean: class [org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1400, Root bean: class [org.springframework.security.web.session.SessionManagementFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1700, Root bean: class [org.springframework.security.web.access.ExceptionTranslationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1800, <org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0>, order = 1900]
                INFO  DefaultListableBeanFactory      - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@1f4ba51: defining beans [org.springframework.security.web.PortMapperImpl#0,org.springframework.security.web.context.HttpSessionSecurityContextRepository#0,org.springframework.security.authentication.ProviderManager#0,org.springframework.security.access.vote.AffirmativeBased#0,org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0,org.springframework.security.web.access.DefaultWebInvocationPrivilegeEvaluator#0,org.springframework.security.web.savedrequest.HttpSessionRequestCache#0,org.springframework.security.config.http.UserDetailsServiceInjectionBeanPostProcessor#0,org.springframework.security.filterChainProxy,org.springframework.security.core.userdetails.memory.InMemoryDaoImpl#0,org.springframework.security.authentication.dao.DaoAuthenticationProvider#0,org.springframework.security.authentication.DefaultAuthenticationEventPublisher#0,org.springframework.security.authenticationManager,formLoginFilter,authenticationEntryPoint,accessDeniedHandler,concurrencyFilter,sessionAuthenticationStrategy,sessionRegistry]; root of factory hierarchy
                INFO  FilterSecurityInterceptor       - Validated configuration attributes
                INFO  ContextLoader                   - Root WebApplicationContext: initialization completed in 3546 ms
                [Server@74187a]: [Thread[main,5,main]]: checkRunning(false) entered
                [Server@74187a]: [Thread[main,5,main]]: checkRunning(false) exited
                [Server@74187a]: Startup sequence initiated from main() method
                [Server@74187a]: Loaded properties from [C:\DevApps\tomcat\apache-tomcat-6.0.20\bin\server.properties]
                [Server@74187a]: Initiating startup sequence...
                [Server@74187a]: Server socket opened successfully in 0 ms.
                [Server@74187a]: Database [index=0, id=0, db=file:C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\WEB-INF\db\hsqldb\isomorphic, alias=isomorphic] opened sucessfully in 875 ms.
                [Server@74187a]: Startup sequence completed in 891 ms.
                [Server@74187a]: 2011-01-03 14:42:06.882 HSQLDB server 1.8.0 is online
                [Server@74187a]: To close normally, connect and execute SHUTDOWN SQL
                [Server@74187a]: From command line, use [Ctrl]+[C] to abort abruptly
                ISC: Configuring log4j from: file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/BuiltInDS/WEB-INF/classes/log4j.isc.config.xml
                === 2011-01-03 14:42:07,101 [main] INFO  ISCInit - Isomorphic SmartClient Framework - Initializing
                === 2011-01-03 14:42:07,132 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
                === 2011-01-03 14:42:07,351 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/BuiltInDS/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties
                === 2011-01-03 14:42:07,351 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
                === 2011-01-03 14:42:07,351 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
                === 2011-01-03 14:42:07,366 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/BuiltInDS/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties
                === 2011-01-03 14:42:07,366 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
                === 2011-01-03 14:42:07,366 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/BuiltInDS/WEB-INF/classes/server.properties
                === 2011-01-03 14:42:07,398 [main] INFO  Logger - Logging system started.
                === 2011-01-03 14:42:07,398 [main] INFO  ISCInit - Isomorphic SmartClient Framework (SC_SNAPSHOT-2010-10-20/EVAL Deployment 2010-10-20) - Initialization Complete
                === 2011-01-03 14:42:07,413 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS
                === 2011-01-03 14:42:07,585 [main] INFO  PreCache - Isomorphic PreCache servlet loading
                === 2011-01-03 14:42:07,663 [main] INFO  PoolManager - SmartClient pooling disabled for 'DataSource' objects
                === 2011-01-03 14:42:07,835 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DataSource.ds.xml: 16ms
                === 2011-01-03 14:42:07,851 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\builtinTypes.xml: 16ms
                === 2011-01-03 14:42:07,991 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DataSourceField.ds.xml: 0ms
                === 2011-01-03 14:42:08,038 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Validator.ds.xml: 15ms
                === 2011-01-03 14:42:08,054 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\ValueMap.ds.xml: 0ms
                === 2011-01-03 14:42:08,069 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\InstantDataApp.ds.xml: 0ms
                === 2011-01-03 14:42:08,288 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Application.ds.xml: 15ms
                === 2011-01-03 14:42:08,304 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\IDAPage.ds.xml: 16ms
                === 2011-01-03 14:42:08,319 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\IDAUserType.ds.xml: 15ms
                === 2011-01-03 14:42:08,335 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\IDAOperation.ds.xml: 0ms
                === 2011-01-03 14:42:08,398 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Canvas.ds.xml: 16ms
                === 2011-01-03 14:42:08,507 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\MethodDeclaration.ds.xml: 16ms
                === 2011-01-03 14:42:08,523 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Img.ds.xml: 16ms
                === 2011-01-03 14:42:08,538 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\StatefulCanvas.ds.xml: 0ms
                === 2011-01-03 14:42:08,585 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\Button.ds.xml: 0ms
                === 2011-01-03 14:42:08,616 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\ListViewer.ds.xml: 15ms
                === 2011-01-03 14:42:08,616 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\ListGrid.ds.xml: 0ms
                === 2011-01-03 14:42:08,710 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DynamicForm.ds.xml: 0ms
                === 2011-01-03 14:42:08,741 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\FormItem.ds.xml: 0ms
                === 2011-01-03 14:42:08,788 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DetailViewer.ds.xml: 0ms
                === 2011-01-03 14:42:08,819 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\DetailViewerField.ds.xml: 0ms
                === 2011-01-03 14:42:08,835 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\BuiltInDS\builtinds\sc\system\schema\isomorphicXML.ds.xml: 0ms
                === 2011-01-03 14:42:08,851 [main] INFO  PreCache - Isomorphic PreCache complete (1266ms)
                Jan 3, 2011 2:42:09 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
                INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\WEB-INF\lib\gwt-dev.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
                Jan 3, 2011 2:42:09 PM org.apache.catalina.loader.WebappClassLoader validateJarFile
                INFO: validateJarFile(C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\WEB-INF\lib\gwt-user.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
                Jan 3, 2011 2:42:10 PM org.apache.catalina.core.ApplicationContext log
                INFO: Initializing Spring root WebApplicationContext
                INFO  ContextLoader                   - Root WebApplicationContext: initialization started
                INFO  XmlWebApplicationContext        - Refreshing Root WebApplicationContext: startup date [Mon Jan 03 14:42:11 EST 2011]; root of context hierarchy
                INFO  XmlBeanDefinitionReader         - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext.xml]
                INFO  PropertyPlaceholderConfigurer   - Loading properties file from ServletContext resource [/WEB-INF/listServerClient.properties]
                INFO  DefaultListableBeanFactory      - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@437ff0: defining beans [propertyConfigurer,listServerSettings,listServerDAOprotocolFactory,listServerDAOprotocol,listServerDAOsubjectFactory,listServerDAOsubject,listServerDAOstudyDateFactory,listServerDAOstudyDate,ListServerProtocolsDMI,ListServerSubjectsDMI,ListServerStudyDatesDMI]; root of factory hierarchy
                INFO  ContextLoader                   - Root WebApplicationContext: initialization completed in 2234 ms
                ISC: Configuring log4j from: file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/WEB-INF/classes/log4j.isc.config.xml
                === 2011-01-03 14:42:13,226 [main] INFO  ISCInit - Isomorphic SmartClient Framework - Initializing
                === 2011-01-03 14:42:13,257 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
                === 2011-01-03 14:42:13,491 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties
                === 2011-01-03 14:42:13,491 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
                === 2011-01-03 14:42:13,491 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
                === 2011-01-03 14:42:13,507 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties
                === 2011-01-03 14:42:13,507 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
                === 2011-01-03 14:42:13,507 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/WEB-INF/classes/server.properties
                === 2011-01-03 14:42:13,554 [main] INFO  Logger - Logging system started.
                === 2011-01-03 14:42:13,554 [main] INFO  ISCInit - Isomorphic SmartClient Framework (SC_SNAPSHOT-2010-12-06/EVAL Deployment 2010-12-06) - Initialization Complete
                === 2011-01-03 14:42:13,554 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear
                === 2011-01-03 14:42:13,694 [main] INFO  PreCache - Isomorphic PreCache servlet loading
                === 2011-01-03 14:42:13,804 [main] INFO  PoolManager - SmartClient pooling disabled for 'DataSource' objects
                === 2011-01-03 14:42:13,991 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DataSource.ds.xml: 15ms
                === 2011-01-03 14:42:14,007 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\builtinTypes.xml: 16ms
                === 2011-01-03 14:42:14,132 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DataSourceField.ds.xml: 0ms
                === 2011-01-03 14:42:14,163 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Validator.ds.xml: 0ms
                === 2011-01-03 14:42:14,194 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\ValueMap.ds.xml: 0ms
                === 2011-01-03 14:42:14,210 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\InstantDataApp.ds.xml: 16ms
                === 2011-01-03 14:42:14,444 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Application.ds.xml: 15ms
                === 2011-01-03 14:42:14,460 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\IDAPage.ds.xml: 0ms
                === 2011-01-03 14:42:14,476 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\IDAUserType.ds.xml: 0ms
                === 2011-01-03 14:42:14,507 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\IDAOperation.ds.xml: 0ms
                === 2011-01-03 14:42:14,554 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Canvas.ds.xml: 16ms
                === 2011-01-03 14:42:14,647 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\MethodDeclaration.ds.xml: 0ms
                === 2011-01-03 14:42:14,663 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Img.ds.xml: 0ms
                === 2011-01-03 14:42:14,679 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\StatefulCanvas.ds.xml: 0ms
                === 2011-01-03 14:42:14,726 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\Button.ds.xml: 0ms
                === 2011-01-03 14:42:14,757 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\ListViewer.ds.xml: 16ms
                === 2011-01-03 14:42:14,772 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\ListGrid.ds.xml: 15ms
                === 2011-01-03 14:42:14,851 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DynamicForm.ds.xml: 0ms
                === 2011-01-03 14:42:14,897 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\FormItem.ds.xml: 15ms
                === 2011-01-03 14:42:14,929 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DetailViewer.ds.xml: 0ms
                === 2011-01-03 14:42:14,960 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\DetailViewerField.ds.xml: 0ms
                === 2011-01-03 14:42:14,976 [main] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\isomorphicXML.ds.xml: 0ms
                === 2011-01-03 14:42:14,991 [main] INFO  PreCache - Isomorphic PreCache complete (1297ms)
                Jan 3, 2011 2:42:15 PM org.apache.catalina.core.ApplicationContext log
                INFO: ContextListener: contextInitialized()
                Jan 3, 2011 2:42:15 PM org.apache.catalina.core.ApplicationContext log
                INFO: SessionListener: contextInitialized()
                Jan 3, 2011 2:42:15 PM org.apache.coyote.http11.Http11Protocol start
                INFO: Starting Coyote HTTP/1.1 on http-8090
                Jan 3, 2011 2:42:15 PM org.apache.jk.common.ChannelSocket init
                INFO: JK: ajp13 listening on /0.0.0.0:8009
                Jan 3, 2011 2:42:15 PM org.apache.jk.server.JkMain start
                INFO: Jk running ID=0 time=0/63  config=null
                Jan 3, 2011 2:42:15 PM org.apache.catalina.startup.Catalina start
                INFO: Server startup in 15104 ms
                A third posting will be necessary.

                -=> Gregg <=-

                Comment


                  #9
                  Compiled production mode:

                  Tomcat log after loading app in FireFox:

                  Code:
                  === 2011-01-03 14:44:02,396 [90-6] INFO  RequestContext - URL: '/dear/report.html', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,427 [90-6] INFO  Compression - /dear/report.html: 2706 -> 1225 bytes
                  === 2011-01-03 14:44:02,474 [90-2] INFO  RequestContext - URL: '/dear/images/ctAbdAnimation.gif', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,490 [90-5] INFO  RequestContext - URL: '/dear/Dear.css', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,490 [90-5] INFO  Compression - /dear/Dear.css: 1869 -> 803 bytes
                  === 2011-01-03 14:44:02,584 [90-3] INFO  RequestContext - URL: '/dear/dear/dear.nocache.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,584 [90-3] INFO  Compression - /dear/dear/dear.nocache.js: 6099 -> 2290 bytes
                  === 2011-01-03 14:44:02,630 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,662 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/initsc.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,662 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\jobControl.ds.xml: 16ms
                  === 2011-01-03 14:44:02,677 [90-1] INFO  Compression - /dear/dear/sc/initsc.js: 47 -> 72 bytes
                  === 2011-01-03 14:44:02,818 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Foundation.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,849 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Core.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,849 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Containers.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,849 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Forms.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:02,849 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Grids.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:03,115 [90-5] INFO  Compression - /dear/dear/sc/modules/ISC_Containers.js: 110119 -> 27228 bytes
                  === 2011-01-03 14:44:03,099 [90-6] INFO  Compression - /dear/dear/sc/modules/ISC_Core.js: 665612 -> 172884 bytes
                  === 2011-01-03 14:44:03,084 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\jobControlDetail.ds.xml: 0ms
                  === 2011-01-03 14:44:03,037 [90-2] INFO  Compression - /dear/dear/sc/modules/ISC_Foundation.js: 219230 -> 52149 bytes
                  === 2011-01-03 14:44:03,146 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_RichTextEditor.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:03,396 [90-3] INFO  Compression - /dear/dear/sc/modules/ISC_Grids.js: 660431 -> 167339 bytes
                  === 2011-01-03 14:44:03,334 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\protocol.ds.xml: 16ms
                  === 2011-01-03 14:44:03,412 [90-5] INFO  Compression - /dear/dear/sc/modules/ISC_RichTextEditor.js: 38915 -> 10929 bytes
                  === 2011-01-03 14:44:03,412 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/load_skin.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:03,334 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_DataBinding.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:03,302 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/modules/ISC_Calendar.js', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:03,287 [90-1] INFO  Compression - /dear/dear/sc/modules/ISC_Forms.js: 550423 -> 133919 bytes
                  === 2011-01-03 14:44:03,505 [90-2] INFO  Compression - /dear/dear/sc/modules/ISC_DataBinding.js: 496136 -> 123906 bytes
                  === 2011-01-03 14:44:03,443 [90-5] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/load_skin.js
                  === 2011-01-03 14:44:03,427 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\ServerObject.ds.xml: 0ms
                  === 2011-01-03 14:44:03,505 [90-6] INFO  Compression - /dear/dear/sc/modules/ISC_Calendar.js: 102519 -> 24581 bytes
                  === 2011-01-03 14:44:03,505 [90-5] INFO  Compression - /dear/dear/sc/skins/EnterpriseBlue/load_skin.js: 29216 -> 6175 bytes
                  === 2011-01-03 14:44:03,537 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\subject.ds.xml: 0ms
                  === 2011-01-03 14:44:03,568 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\studyDate.ds.xml: 0ms
                  === 2011-01-03 14:44:03,584 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\auditReportAnnotations.ds.xml: 0ms
                  === 2011-01-03 14:44:03,615 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\auditReportCalibrations.ds.xml: 16ms
                  === 2011-01-03 14:44:03,630 [90-4] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\ds\auditReportImages.ds.xml: 0ms
                  === 2011-01-03 14:44:06,318 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/skin_styles.css', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:06,318 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/skin_styles.css
                  === 2011-01-03 14:44:06,318 [90-6] INFO  Compression - /dear/dear/sc/skins/EnterpriseBlue/skin_styles.css: 60884 -> 7955 bytes
                  === 2011-01-03 14:44:06,646 [90-5] INFO  RequestContext - URL: '/dear/dear/6FFE9436273AC309AD579D94FE91C968.cache.html', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:06,646 [90-4] INFO  RequestContext - URL: '/dear/dear/gwt/standard/standard.css', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:06,646 [90-4] INFO  Compression - /dear/dear/gwt/standard/standard.css: 26804 -> 3832 bytes
                  === 2011-01-03 14:44:06,662 [90-5] INFO  Compression - /dear/dear/6FFE9436273AC309AD579D94FE91C968.cache.html: 174076 -> 47498 bytes
                  === 2011-01-03 14:44:07,209 [90-3] INFO  RequestContext - URL: '/dear/images/clpLogoAbout.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,224 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_start.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,224 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_stretch.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,224 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_start.png
                  === 2011-01-03 14:44:07,224 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_stretch.png
                  === 2011-01-03 14:44:07,240 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_end.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,240 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_end.png
                  === 2011-01-03 14:44:07,255 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Selected_start.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,271 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Selected_start.png
                  === 2011-01-03 14:44:07,271 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Selected_stretch.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,271 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Selected_end.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,271 [90-5] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Selected_stretch.png
                  === 2011-01-03 14:44:07,287 [90-3] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Selected_end.png
                  === 2011-01-03 14:44:07,302 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/ListGrid/header.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,318 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/ListGrid/header.png
                  === 2011-01-03 14:44:07,349 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/blank.gif', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,365 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/blank.gif
                  === 2011-01-03 14:44:07,365 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/loadingSmall.gif', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,365 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/loadingSmall.gif
                  === 2011-01-03 14:44:07,396 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/RecordEditor/filter.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,396 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/RecordEditor/filter.png
                  === 2011-01-03 14:44:07,474 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/DynamicForm/unchecked.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:07,490 [90-5] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/DynamicForm/unchecked.png
                  === 2011-01-03 14:44:08,287 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Disabled_start.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:08,287 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Disabled_stretch.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:08,287 [90-3] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Disabled_start.png
                  === 2011-01-03 14:44:08,302 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Disabled_stretch.png
                  === 2011-01-03 14:44:08,302 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Disabled_end.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:08,302 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/button/button_Disabled_end.png
                  === 2011-01-03 14:44:08,771 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/DynamicForm/date_control.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:08,771 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/DynamicForm/date_control.png
                  === 2011-01-03 14:44:08,865 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/pickers/comboBoxPicker.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:08,880 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/pickers/comboBoxPicker.png
                  === 2011-01-03 14:44:09,505 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/SectionHeader/opener_opened.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:09,505 [90-5] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/SectionHeader/opener_opened.png
                  === 2011-01-03 14:44:09,521 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/SectionHeader/header_opened_start.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:09,521 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/SectionHeader/header_opened_stretch.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:09,521 [90-3] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/SectionHeader/header_opened_start.png
                  === 2011-01-03 14:44:09,521 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/SectionHeader/header_opened_stretch.png
                  === 2011-01-03 14:44:09,521 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/SectionHeader/header_opened_end.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:09,537 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/SectionHeader/header_opened_end.png
                  === 2011-01-03 14:44:11,005 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_TL.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,005 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_T.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,005 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_TL.png
                  === 2011-01-03 14:44:11,005 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_T.png
                  === 2011-01-03 14:44:11,005 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_TR.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,021 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_L.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,021 [90-5] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_TR.png
                  === 2011-01-03 14:44:11,021 [90-3] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_L.png
                  === 2011-01-03 14:44:11,021 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_R.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,037 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_BL.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,037 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_R.png
                  === 2011-01-03 14:44:11,037 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_BL.png
                  === 2011-01-03 14:44:11,037 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_B.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,037 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_B.png
                  === 2011-01-03 14:44:11,037 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_BR.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,052 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Window/window_BR.png
                  === 2011-01-03 14:44:11,099 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hscroll_start.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,099 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hscroll_track.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,099 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hscroll_start.png
                  === 2011-01-03 14:44:11,115 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hscroll_track.png
                  === 2011-01-03 14:44:11,130 [90-5] INFO  RequestContext - URL: '/dear/dear/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,130 [90-3] INFO  RequestContext - URL: '/dear/dear/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,208 [90-3] DEBUG XML - Parsed XML from (in memory stream): 0ms
                  === 2011-01-03 14:44:11,208 [90-3] DEBUG XML - Parsed XML from C:\DevApps\tomcat\apache-tomcat-6.0.20\webapps\dear\dear\sc\system\schema\List.ds.xml: 0ms
                  === 2011-01-03 14:44:11,115 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hthumb_grip.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,115 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hscroll_end.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,240 [90-3] DEBUG RPCManager - Processing 1 requests.
                  === 2011-01-03 14:44:11,193 [90-5] DEBUG XML - Parsed XML from (in memory stream): 0ms
                  === 2011-01-03 14:44:11,130 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hthumb_stretch.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,130 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hthumb_start.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,287 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hscroll_end.png
                  === 2011-01-03 14:44:11,287 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vscroll_track.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,287 [90-3] DEBUG RPCManager - Request #1 (DSRequest) payload: {
                      criteria:{
                      },
                      operationConfig:{
                          dataSource:"jobControl",
                          operationType:"fetch",
                          textMatchStyle:"substring"
                      },
                      startRow:0,
                      endRow:75,
                      componentId:"isc_ListGrid_3",
                      appID:"builtinApplication",
                      operation:"jobControl_fetch",
                      oldValues:{
                      }
                  }
                  === 2011-01-03 14:44:11,255 [90-5] DEBUG RPCManager - Processing 1 requests.
                  === 2011-01-03 14:44:11,255 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hthumb_grip.png
                  === 2011-01-03 14:44:11,302 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vscroll_start.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,255 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hthumb_stretch.png
                  === 2011-01-03 14:44:11,318 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hthumb_end.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,318 [90-3] INFO  IDACall - Performing 1 operation(s)
                  === 2011-01-03 14:44:11,302 [90-5] DEBUG RPCManager - Request #1 (DSRequest) payload: {
                      criteria:{
                      },
                      operationConfig:{
                          dataSource:"protocol",
                          operationType:"fetch",
                          textMatchStyle:"substring"
                      },
                      startRow:0,
                      endRow:75,
                      componentId:"isc_ListGrid_2",
                      appID:"builtinApplication",
                      operation:"protocol_fetch",
                      oldValues:{
                      }
                  }
                  === 2011-01-03 14:44:11,287 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vscroll_track.png
                  === 2011-01-03 14:44:11,287 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hthumb_start.png
                  === 2011-01-03 14:44:11,396 [90-3] DEBUG AppBase - [builtinApplication.jobControl_fetch] No userTypes defined, allowing anyone access to all operations for this application
                  === 2011-01-03 14:44:11,396 [90-3] DEBUG AppBase - [builtinApplication.jobControl_fetch] No public zero-argument method named '_jobControl_fetch' found, performing generic datasource operation
                  === 2011-01-03 14:44:11,396 [90-3] INFO  SQLDataSource - [builtinApplication.jobControl_fetch] Performing fetch operation with
                  	criteria: {}	values: {}
                  === 2011-01-03 14:44:11,349 [90-5] INFO  IDACall - Performing 1 operation(s)
                  === 2011-01-03 14:44:11,333 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vscroll_start.png
                  === 2011-01-03 14:44:11,333 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/hthumb_end.png
                  === 2011-01-03 14:44:11,443 [90-5] INFO  ServerObject - DMI on Spring bean: ListServerProtocolsDMI
                  === 2011-01-03 14:44:11,443 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vthumb_grip.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,427 [90-3] INFO  SQLWhereClause - [builtinApplication.jobControl_fetch] empty condition
                  === 2011-01-03 14:44:11,427 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vthumb_start.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,396 [90-6] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vscroll_corner.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,396 [90-1] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vscroll_end.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,474 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vthumb_start.png
                  === 2011-01-03 14:44:11,490 [90-4] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vthumb_end.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:11,474 [90-3] INFO  SQLDataSource - [builtinApplication.jobControl_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
                  === 2011-01-03 14:44:11,474 [90-5] INFO  DSResponse - DSResponse: List with 115 items
                  === 2011-01-03 14:44:11,505 [90-5] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
                  === 2011-01-03 14:44:11,443 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vthumb_grip.png
                  === 2011-01-03 14:44:12,412 [90-3] DEBUG SQLDataSource - [builtinApplication.jobControl_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
                  === 2011-01-03 14:44:12,412 [90-3] DEBUG SQLDataSource - [builtinApplication.jobControl_fetch] Eval'd row count query: SELECT COUNT(*) FROM DEAR.AUDIT_JOB_QUEUE WHERE ('1'='1')
                  === 2011-01-03 14:44:11,521 [90-4] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vthumb_end.png
                  === 2011-01-03 14:44:11,505 [90-5] DEBUG RPCManager - DMI response, dropExtraFields: true
                  === 2011-01-03 14:44:11,490 [90-1] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vscroll_end.png
                  === 2011-01-03 14:44:11,490 [90-6] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vscroll_corner.png
                  === 2011-01-03 14:44:12,677 [90-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.jobControl_fetch] Initializing SQL config for 'Oracle' from system config - using DataSource:  oracle.jdbc.pool.OracleDataSource
                  === 2011-01-03 14:44:12,412 [90-2] INFO  RequestContext - URL: '/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vthumb_stretch.png', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.2.13) Gecko/20101203 Firefox/3.6.13 ( .NET CLR 3.5.30729)': Moz (Gecko) with Accept-Encoding header
                  === 2011-01-03 14:44:12,724 [90-5] INFO  Compression - /dear/dear/sc/IDACall: 3764 -> 868 bytes
                  === 2011-01-03 14:44:12,787 [90-2] INFO  Download - done streaming: C:/DevApps/tomcat/apache-tomcat-6.0.20/webapps/dear/dear/sc/skins/EnterpriseBlue/images/Scrollbar/vthumb_stretch.png
                  === 2011-01-03 14:44:15,083 [90-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.jobControl_fetch] Returning pooled Connection
                  === 2011-01-03 14:44:15,521 [90-3] INFO  SQLDriver - [builtinApplication.jobControl_fetch] Executing SQL query on 'Oracle': SELECT COUNT(*) FROM DEAR.AUDIT_JOB_QUEUE WHERE ('1'='1')
                  === 2011-01-03 14:44:15,724 [90-3] WARN  SQLDataSource - [builtinApplication.jobControl_fetch] DataSource 'jobControl': sqlPaging was explicitly specified as 'sqlLimit', but the underlying database (oracle) does not support SQL limit queries.  Falling back to 'jdbcScroll'
                  === 2011-01-03 14:44:15,724 [90-3] DEBUG SQLDataSource - [builtinApplication.jobControl_fetch] JDBC driver windowed select rows 0->75, result size 75. Query: SELECT DEAR.AUDIT_JOB_QUEUE.JOB_PERCENT_COMPLETE, DEAR.AUDIT_JOB_QUEUE.JOB_STATUS, DEAR.AUDIT_JOB_QUEUE.COMMENTS, DEAR.AUDIT_JOB_QUEUE.REQUEST_FOR_TERMINATE_DATE, DEAR.AUDIT_JOB_QUEUE.REQUEST_FOR_TERMINATE, DEAR.AUDIT_JOB_QUEUE.JOB_EXCEPTION_MESSAGE, DEAR.AUDIT_JOB_QUEUE.UPDATED_DATE, DEAR.AUDIT_JOB_QUEUE.JOB_EXCEPTION_DATE, DEAR.AUDIT_JOB_QUEUE.JOB_ID, DEAR.AUDIT_JOB_QUEUE.CVS_PROTOCOL_NAME, DEAR.AUDIT_JOB_QUEUE.CREATED_DATE, DEAR.AUDIT_JOB_QUEUE.CREATED_BY, DEAR.AUDIT_JOB_QUEUE.JOB_ROW_ID, DEAR.AUDIT_JOB_QUEUE.JOB_EXCEPTION_USER, DEAR.AUDIT_JOB_QUEUE.FILE_TYPE, DEAR.AUDIT_JOB_QUEUE.DB_JOB_START_DATE, DEAR.AUDIT_JOB_QUEUE.UPDATED_BY, DEAR.AUDIT_JOB_QUEUE.JOB_COMPLETED_DATE, DEAR.AUDIT_JOB_QUEUE.JOB_START_DATE, DEAR.AUDIT_JOB_QUEUE.DB_JOB_COMPLETED_DATE, DEAR.AUDIT_JOB_QUEUE.CVS_SUBJECT, DEAR.AUDIT_JOB_QUEUE.REQUEST_FOR_TERMINATE_BY FROM DEAR.AUDIT_JOB_QUEUE WHERE ('1'='1')
                  === 2011-01-03 14:44:15,818 [90-3] INFO  DSResponse - [builtinApplication.jobControl_fetch] DSResponse: List with 31 items
                  === 2011-01-03 14:44:15,818 [90-3] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
                  === 2011-01-03 14:44:15,818 [90-3] DEBUG RPCManager - non-DMI response, dropExtraFields: false
                  === 2011-01-03 14:44:15,833 [90-3] INFO  Compression - /dear/dear/sc/IDACall: 9304 -> 1700 bytes
                  Repsonse text:

                  Code:
                  isc.DataSource.create({
                      title:"Job Control",
                      titleField:"JOB_ID",
                      tableName:"DEAR.AUDIT_JOB_QUEUE",
                      ID:"jobControl",
                      fields:[
                          {
                              name:"JOB_ROW_ID",
                              sequenceName:"SEQ_AUDIT_JOB_QUEUE",
                              type:"sequence"
                          },
                          {
                              length:"50",
                              name:"JOB_ID",
                              primaryKey:true,
                              type:"text"
                          },
                          {
                              length:"100",
                              name:"CVS_PROTOCOL_NAME",
                              type:"text"
                          },
                          {
                              length:"100",
                              name:"CVS_SUBJECT",
                              type:"text"
                          },
                          {
                              length:"10",
                              name:"FILE_TYPE",
                              type:"text"
                          },
                          {
                              length:"100",
                              name:"JOB_STATUS",
                              type:"text"
                          },
                          {
                              name:"JOB_START_DATE",
                              type:"datetime"
                          },
                          {
                              name:"JOB_COMPLETED_DATE",
                              type:"datetime"
                          },
                          {
                              length:"100",
                              name:"JOB_PERCENT_COMPLETE",
                              type:"text"
                          },
                          {
                              length:"1",
                              name:"REQUEST_FOR_TERMINATE",
                              type:"text"
                          },
                          {
                              length:"100",
                              name:"REQUEST_FOR_TERMINATE_BY",
                              type:"text"
                          },
                          {
                              name:"REQUEST_FOR_TERMINATE_DATE",
                              type:"datetime"
                          },
                          {
                              length:"4000",
                              name:"JOB_EXCEPTION_MESSAGE",
                              type:"text"
                          },
                          {
                              length:"100",
                              name:"JOB_EXCEPTION_USER",
                              type:"text"
                          },
                          {
                              name:"JOB_EXCEPTION_DATE",
                              type:"datetime"
                          },
                          {
                              length:"100",
                              name:"CREATED_BY",
                              type:"text"
                          },
                          {
                              name:"CREATED_DATE",
                              type:"datetime"
                          },
                          {
                              length:"100",
                              name:"UPDATED_BY",
                              type:"text"
                          },
                          {
                              name:"UPDATED_DATE",
                              type:"datetime"
                          },
                          {
                              length:"4000",
                              name:"COMMENTS",
                              type:"text"
                          },
                          {
                              name:"DB_JOB_START_DATE",
                              type:"datetime"
                          },
                          {
                              name:"DB_JOB_COMPLETED_DATE",
                              type:"datetime"
                          }
                      ],
                      serverType:"sql"
                  })

                  Comment


                    #10
                    In addition, I went and got the 2.4 ee nightly build from today 03Jan2011 and placed its jars in my WEB-INF/lib, cleaned everything, rebuilt everything and redeployed everything both in dev and compiled modes and compiled still works, but dev still fails with the same crash and stack trace.

                    Comment


                      #11
                      Based on what was requested, I believe that I have provided the correct information. Do you need something additional or are you still investigating this issue?

                      Comment


                        #12
                        We've fixed a bug where the length attribute could end up String-valued, and that will be present in the next nightly build. However the difference you're experiencing between Dev Mode and Compiled Mode could not be reproduced. Regardless, since the value will always be an integer from now on, the fix should correct the problem for you.

                        Comment


                          #13
                          Thank you. I'll give the next build a try.

                          -=> Gregg <=-

                          Comment


                            #14
                            The SmartGWTee nightly from 04Jan2011 has fixed the problem that I was experiencing.

                            Thank you!

                            -=> Gregg <=-

                            Comment

                            Working...
                            X