Problem with BuiltInDS-sample and DevMode

[Blama]

Hi Isomorphic,

I just wanted to use BuiltInDS to create a testcase, but can't get it running anymore. Most likely this is not related to SmartGWT, but perhaps you can help anyway. I tested with the 4.1d nightlies of Jan 28th, Feb 2nd and Feb 3rd (SNAPSHOT_v9.1d_2014-02-03/EVAL Deployment 2014-02-03).
The only other difference in my system is that I changed from a manually downloaded version of GWT 2.6.0 to the updated version from Eclipse updater. But the directory structure (C:\eclipse\plugins\com.google.gwt.eclipse.sdkbundle_2.6.0\gwt-2.6.0) is the same and for my project the setup works (DevMode and compiling).

Here is my stack trace and server log:

Server log:

[WARN] Server class 'org.eclipse.jetty.servlet.listener.ELContextCleaner' could not be found in the web app, but was found on the system classpath
   [WARN] Adding classpath entry 'file:/C:/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.6.0/gwt-2.6.0/gwt-dev.jar' to the web app classpath for this session
   For additional info see: file:/C:/eclipse/plugins/com.google.gwt.eclipse.sdkbundle_2.6.0/gwt-2.6.0/doc/helpInfo/webAppClassPath.html
[Server@60c7945f]: [Thread[main,5,main]]: checkRunning(false) entered
[Server@60c7945f]: [Thread[main,5,main]]: checkRunning(false) exited
[Server@60c7945f]: Startup sequence initiated from main() method
[Server@60c7945f]: Could not load properties from file
[Server@60c7945f]: Using cli/default properties only
[Server@60c7945f]: Initiating startup sequence...
[Server@60c7945f]: Server socket opened successfully in 1 ms.
log4j:WARN No appenders could be found for logger (hsqldb.db.HSQLDB42471D50F3.ENGINE).
log4j:WARN Please initialize the log4j system properly.
[Server@60c7945f]: Database [index=0, id=0, db=file:C:\Users\userone\workspace\lib\smartgwtee-4.1d\samples\built-in-ds\war\WEB-INF\db\hsqldb\isomorphic, alias=isomorphic] opened sucessfully in 2382 ms.
[Server@60c7945f]: Startup sequence completed in 2385 ms.
[Server@60c7945f]: 2014-02-03 23:08:05.625 HSQLDB server 2.2.9 is online on port 9001
[Server@60c7945f]: To close normally, connect and execute SHUTDOWN SQL
[Server@60c7945f]: From command line, use [Ctrl]+[C] to abort abruptly
ISC: Configuring log4j from: file:/C:/Users/userone/workspace/lib/smartgwtee-4.1d/samples/built-in-ds/war/WEB-INF/classes/log4j.isc.config.xml
=== 2014-02-03 23:08:05,793 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework - Initializing
=== 2014-02-03 23:08:05,804 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
=== 2014-02-03 23:08:06,040 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/Users/userone/workspace/lib/smartgwtee-4.1d/samples/built-in-ds/war/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties
=== 2014-02-03 23:08:06,040 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
=== 2014-02-03 23:08:06,041 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
=== 2014-02-03 23:08:06,051 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/Users/userone/workspace/lib/smartgwtee-4.1d/samples/built-in-ds/war/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties
=== 2014-02-03 23:08:06,051 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
=== 2014-02-03 23:08:06,056 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/Users/userone/workspace/lib/smartgwtee-4.1d/samples/built-in-ds/war/WEB-INF/classes/server.properties
=== 2014-02-03 23:08:06,070 [main] INFO  Logger - Logging system started.
=== 2014-02-03 23:08:06,076 [main] ERROR ISCInit - Can't find marker file for webRoot: C:/Users/userone/workspace/lib/smartgwtee-4.1d/samples/built-in-ds/war/builtinds/sc for configured/autodetected webRoot - if you moved the 'isomorphic' directory, please set isomorphicPathRootRelative in server.properties to the new location and restart the servlet engine.
=== 2014-02-03 23:08:06,076 [main] INFO  ISCInit - WebRoot auto-detection failed - using container IO
=== 2014-02-03 23:08:06,079 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework (SNAPSHOT_v9.1d_2014-02-03/EVAL Deployment 2014-02-03) - Initialization Complete
log4j:WARN No appenders could be found for logger (org.apache.jasper.compiler.JspRuntimeContext).
log4j:WARN Please initialize the log4j system properly.
=== 2014-02-03 23:08:30,303 [7-31] INFO  Compression - /BuiltInDS.html: 0 -> 20 bytes
=== 2014-02-03 23:08:30,308 [7-31] ERROR Compression - Caught exception in doFilter() - for URI: /BuiltInDS.html
java.lang.IllegalStateException: NO CONTENT
	at org.eclipse.jetty.http.HttpGenerator.addContent(HttpGenerator.java:176)
	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:155)
	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:107)
	at java.io.ByteArrayOutputStream.writeTo(Unknown Source)
	at com.isomorphic.compression.ServletCompression.compressAndSend(ServletCompression.java:159)
	at com.isomorphic.servlet.CompressionFilter.doFilter(CompressionFilter.java:387)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1474)
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:428)
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
	at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:68)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
	at org.eclipse.jetty.server.Server.handle(Server.java:370)
	at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
	at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:949)
	at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1011)
	at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:644)
	at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
	at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
	at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:668)
	at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
	at java.lang.Thread.run(Unknown Source)

=== 2014-02-03 23:08:30,407 [7-30] INFO  RequestContext - URL: '/builtinds/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.2; WOW64; rv:26.0) Gecko/20100101 Firefox/26.0': Moz (Gecko) with Accept-Encoding header
=== 2014-02-03 23:08:30,581 [7-33] INFO  Compression - /builtinds/sc/modules/ISC_Core.js: 908468 -> 238463 bytes
=== 2014-02-03 23:08:30,608 [7-30] DEBUG XML - Parsed XML from __USE_CONTAINER__/builtinds/sc/system/schema/builtinTypes.xml: 28ms
=== 2014-02-03 23:08:30,674 [7-30] INFO  PoolManager - SmartClient pooling started for 'simpleTypes' objects
=== 2014-02-03 23:08:31,013 [7-30] DEBUG XML - Parsed XML from __USE_CONTAINER__/ds/supplyItem.ds.xml: 7ms
=== 2014-02-03 23:08:31,030 [7-30] DEBUG XML - Parsed XML from __USE_CONTAINER__/builtinds/sc/system/schema/DataSource.ds.xml: 13ms
=== 2014-02-03 23:08:31,275 [7-30] DEBUG XML - Parsed XML from __USE_CONTAINER__/builtinds/sc/system/schema/DataSourceField.ds.xml: 12ms
=== 2014-02-03 23:08:31,432 [7-30] DEBUG XML - Parsed XML from __USE_CONTAINER__/builtinds/sc/system/schema/ValueMap.ds.xml: 4ms
=== 2014-02-03 23:08:31,455 [7-30] DEBUG XML - Parsed XML from __USE_CONTAINER__/builtinds/sc/system/schema/Validator.ds.xml: 10ms
=== 2014-02-03 23:08:31,616 [7-30] DEBUG DataSourceLoader - For DataSource 'supplyItem', got instanceId 10
=== 2014-02-03 23:08:31,665 [7-30] DEBUG XML - Parsed XML from __USE_CONTAINER__/ds/animals.ds.xml: 6ms
=== 2014-02-03 23:08:31,703 [7-30] DEBUG DataSourceLoader - For DataSource 'animals', got instanceId 14
=== 2014-02-03 23:08:31,723 [7-30] DEBUG XML - Parsed XML from __USE_CONTAINER__/ds/employees.ds.xml: 8ms
=== 2014-02-03 23:08:31,772 [7-30] DEBUG DataSourceLoader - For DataSource 'employees', got instanceId 18
=== 2014-02-03 23:08:31,857 [7-32] INFO  Compression - /builtinds/hosted.html: 0 -> 20 bytes
=== 2014-02-03 23:08:31,858 [7-32] ERROR Compression - Caught exception in doFilter() - for URI: /builtinds/hosted.html
java.lang.IllegalStateException: NO CONTENT
	at org.eclipse.jetty.http.HttpGenerator.addContent(HttpGenerator.java:176)
	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:155)
	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:107)
	at java.io.ByteArrayOutputStream.writeTo(Unknown Source)
	at com.isomorphic.compression.ServletCompression.compressAndSend(ServletCompression.java:159)
	at com.isomorphic.servlet.CompressionFilter.doFilter(CompressionFilter.java:387)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1474)
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:428)
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
	at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:68)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
	at org.eclipse.jetty.server.Server.handle(Server.java:370)
	at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
	at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:949)
	at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1011)
	at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:644)
	at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
	at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
	at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:668)
	at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
	at java.lang.Thread.run(Unknown Source)

Stack trace:

23:09:24.447 [ERROR] [builtinds] Unable to load module entry point class com.smartgwt.sample.client.BuiltInDS (see associated exception for details)
com.google.gwt.core.client.JavaScriptException: (TypeError) @com.smartgwt.client.widgets.BaseWidget::draw()([]): _29 is undefined
    at com.google.gwt.dev.shell.BrowserChannelServer.invokeJavascript(BrowserChannelServer.java:249)
    at com.google.gwt.dev.shell.ModuleSpaceOOPHM.doInvoke(ModuleSpaceOOPHM.java:136)
    at com.google.gwt.dev.shell.ModuleSpace.invokeNative(ModuleSpace.java:576)
    at com.google.gwt.dev.shell.ModuleSpace.invokeNativeVoid(ModuleSpace.java:304)
    at com.google.gwt.dev.shell.JavaScriptHost.invokeNativeVoid(JavaScriptHost.java:107)
    at com.smartgwt.client.widgets.BaseWidget.draw(BaseWidget.java)
    at com.smartgwt.sample.client.BuiltInDS.onModuleLoad(BuiltInDS.java:169)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
    at java.lang.reflect.Method.invoke(Unknown Source)
    at com.google.gwt.dev.shell.ModuleSpace.onLoad(ModuleSpace.java:411)
    at com.google.gwt.dev.shell.OophmSessionHandler.loadModule(OophmSessionHandler.java:200)
    at com.google.gwt.dev.shell.BrowserChannelServer.processConnection(BrowserChannelServer.java:526)
    at com.google.gwt.dev.shell.BrowserChannelServer.run(BrowserChannelServer.java:364)
    at java.lang.Thread.run(Unknown Source)

It takes quite a long time for the stack trace to appear. During that time the browser (FF26) is blocked. In the server log I can already see the error while the browser waits.

Additional info:
I remember seeing this "NO CONTENT" message from the server log before, but it worked anyway. I also got it now while testing for other files (e.g ISC_DataBinding.js. But all the files are there, when I call them manually (with http://127.0.0.1:8888/builtinds/hosted.html or http://127.0.0.1:8888/builtinds/sc/m...DataBinding.js).

Also: When I clear my log and call http://127.0.0.1:8888/builtinds/sc/m...DataBinding.js manually, I can see the JS file in the browser, but the server log says:

=== 2014-02-03 23:18:34,022 [7-43] INFO  Compression - /builtinds/sc/modules/ISC_DataBinding.js: 0 -> 36 bytes
=== 2014-02-03 23:18:34,023 [7-43] ERROR Compression - Caught exception in doFilter() - for URI: /builtinds/sc/modules/ISC_DataBinding.js
java.lang.IllegalStateException: NO CONTENT
	at org.eclipse.jetty.http.HttpGenerator.addContent(HttpGenerator.java:176)
	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:155)
	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:107)
	at java.io.ByteArrayOutputStream.writeTo(Unknown Source)
	at com.isomorphic.compression.ServletCompression.compressAndSend(ServletCompression.java:159)
	at com.isomorphic.servlet.CompressionFilter.doFilter(CompressionFilter.java:387)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1474)
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:428)
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
	at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:68)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
	at org.eclipse.jetty.server.Server.handle(Server.java:370)
	at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
	at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:949)
	at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1011)
	at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:644)
	at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
	at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
	at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:668)
	at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
	at java.lang.Thread.run(Unknown Source

Do you have an idea whats happening here?

Thank you and best regards,
Blama

[Blama]

Update:

I did a file-compare between the jars from the Eclipse-internal DL and my previous DL from http://code.google.com/p/google-web-...downloads/list. They are the same. I really have no idea what's happening here.
I'm pretty sure that the Jan 28th (SNAPSHOT_v9.1d_2014-01-28/EVAL Deployment 2014-01-28) nightly worked for me before.

Best regards,
Blama

[Blama]

Update:
I did a clean and also cleaned my browser cache - no change.
I can build & war & deploy the BuiltInDS sample and call it, so it must be something related to DevMode.

Please see also this thread from yesterday, where another user is also getting a similar error with "draw()([]): _29 is undefined" on top of the stack trace.

Best regards,
Blama

[Isomorphic]

Thanks for the notification. This was a temporary regression, now fixed. Please try the next nightly build (Feb 5 or above)

[Blama]

Hi Isomorphic,

its fixed for me with SNAPSHOT_v9.1d_2014-02-05/EVAL Deployment, thanks.

Best regards,
Blama