=== 2011-06-03 22:34:24,647 [l0-0] DEBUG XML - Parsed XML from /Users/joel/Library/Caches/IntelliJIdea10/gwt/smartgwttest.smartgwttest40feb8d6/smartgwttest.40feb873/run/www/ds/publisher_DataSource.ds.xml: 2ms === 2011-06-03 22:34:24,647 [l0-3] DEBUG XML - Parsed XML from /Users/joel/Library/Caches/IntelliJIdea10/gwt/smartgwttest.smartgwttest40feb8d6/smartgwttest.40feb873/run/www/ds/authdef_DataSource.ds.xml: 2ms === 2011-06-03 22:34:24,647 [l0-2] DEBUG XML - Parsed XML from /Users/joel/Library/Caches/IntelliJIdea10/gwt/smartgwttest.smartgwttest40feb8d6/smartgwttest.40feb873/run/www/ds/dright_DataSource.ds.xml: 2ms === 2011-06-03 22:34:40,209 [l0-3] INFO RequestContext - URL: '/gwtapp/sc/IDACall', User-Agent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_6_7) AppleWebKit/534.24 (KHTML, like Gecko) Chrome/11.0.696.71 Safari/534.24': Safari with Accept-Encoding header === 2011-06-03 22:34:40,223 [l0-3] DEBUG XML - Parsed XML from (in memory stream): 1ms === 2011-06-03 22:34:40,225 [l0-3] DEBUG XML - Parsed XML from /Users/joel/Library/Caches/IntelliJIdea10/gwt/smartgwttest.smartgwttest40feb8d6/smartgwttest.40feb873/run/www/gwtapp/sc/system/schema/List.ds.xml: 1ms === 2011-06-03 22:34:40,229 [l0-3] DEBUG RPCManager - Processing 1 requests. === 2011-06-03 22:34:40,237 [l0-3] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ __gwt_ObjectId:13, publisher_pkid:549 }, operationConfig:{ dataSource:"authdef_DataSource", operationType:"fetch", textMatchStyle:"substring" }, appID:"builtinApplication", operation:"authdef_DataSource_fetch", oldValues:{ __gwt_ObjectId:13, publisher_pkid:549 } } === 2011-06-03 22:34:40,240 [l0-3] INFO IDACall - Performing 1 operation(s) === 2011-06-03 22:34:40,249 [l0-3] DEBUG AppBase - [builtinApplication.authdef_DataSource_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2011-06-03 22:34:40,249 [l0-3] DEBUG AppBase - [builtinApplication.authdef_DataSource_fetch] No public zero-argument method named '_authdef_DataSource_fetch' found, performing generic datasource operation === 2011-06-03 22:34:40,249 [l0-3] INFO SQLDataSource - [builtinApplication.authdef_DataSource_fetch] Performing fetch operation with criteria: {__gwt_ObjectId:13,publisher_pkid:549} values: {__gwt_ObjectId:13,publisher_pkid:549} === 2011-06-03 22:34:40,258 [l0-3] INFO SQLDataSource - [builtinApplication.authdef_DataSource_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2011-06-03 22:34:40,387 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Initializing SQL config for 'DB2' from system config - using DriverManager: com.ibm.db2.jcc.DB2Driver === 2011-06-03 22:34:40,403 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] com.ibm.db2.jcc.DB2Driver lookup successful === 2011-06-03 22:34:40,403 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] DriverManager fetching connection for DB2 via jdbc url jdbc:db2://localhost:50001/edendb === 2011-06-03 22:34:40,403 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Passing credentials getConnection separately from JDBC URL === 2011-06-03 22:34:40,591 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Returning pooled Connection === 2011-06-03 22:34:40,595 [l0-3] INFO SQLDriver - [builtinApplication.authdef_DataSource_fetch] Executing SQL query on 'DB2': SELECT edenmodel.AuthorizationDef.publisher_pkid, edenmodel.AuthorizationDef.name, edenmodel.AuthorizationDef.pkid, edenmodel.AuthorizationDef.publisherstring FROM edenmodel.AuthorizationDef WHERE (edenmodel.AuthorizationDef.publisher_pkid='549') === 2011-06-03 22:34:40,606 [l0-3] INFO SQLDriver - [builtinApplication.authdef_DataSource_fetch] Execute of select: SELECT edenmodel.AuthorizationDef.publisher_pkid, edenmodel.AuthorizationDef.name, edenmodel.AuthorizationDef.pkid, edenmodel.AuthorizationDef.publisherstring FROM edenmodel.AuthorizationDef WHERE (edenmodel.AuthorizationDef.publisher_pkid='549') on db: DB2 threw exception: com.ibm.db2.jcc.a.rn: DB2 SQL Error: SQLCODE=-401, SQLSTATE=42818, SQLERRMC==, DRIVER=4.2.73 - assuming stale connection and retrying query. === 2011-06-03 22:34:40,607 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] DriverManager fetching connection for DB2 via jdbc url jdbc:db2://localhost:50001/edendb === 2011-06-03 22:34:40,607 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Passing credentials getConnection separately from JDBC URL === 2011-06-03 22:34:40,611 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Returning pooled Connection === 2011-06-03 22:34:40,613 [l0-3] WARN RequestContext - dsRequest.execute() failed: com.ibm.db2.jcc.a.rn: DB2 SQL Error: SQLCODE=-401, SQLSTATE=42818, SQLERRMC==, DRIVER=4.2.73 at com.ibm.db2.jcc.a.cd.a(cd.java:666) at com.ibm.db2.jcc.a.cd.a(cd.java:60) at com.ibm.db2.jcc.a.cd.a(cd.java:127) at com.ibm.db2.jcc.a.ul.c(ul.java:2434) at com.ibm.db2.jcc.a.ul.d(ul.java:2411) at com.ibm.db2.jcc.a.ul.a(ul.java:1912) at com.ibm.db2.jcc.t4.db.g(db.java:138) at com.ibm.db2.jcc.t4.db.a(db.java:38) at com.ibm.db2.jcc.t4.t.a(t.java:32) at com.ibm.db2.jcc.t4.sb.h(sb.java:141) at com.ibm.db2.jcc.a.ul.ab(ul.java:1883) at com.ibm.db2.jcc.a.ul.a(ul.java:2756) at com.ibm.db2.jcc.a.ul.a(ul.java:598) at com.ibm.db2.jcc.a.ul.executeQuery(ul.java:582) at org.apache.commons.dbcp.DelegatingStatement.executeQuery(DelegatingStatement.java:208) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:323) at com.isomorphic.sql.SQLDriver.executeQuery(SQLDriver.java:551) at com.isomorphic.sql.SQLDataSource.executeNativeQuery(SQLDataSource.java:376) at com.isomorphic.sql.SQLDataSource.executeNativeQuery(SQLDataSource.java:371) at com.isomorphic.sql.SQLDataSource.SQLExecute(SQLDataSource.java:1289) at com.isomorphic.sql.SQLDataSource.processRequest(SQLDataSource.java:280) at com.isomorphic.sql.SQLDataSource.executeFetch(SQLDataSource.java:224) at com.isomorphic.datasource.DataSource.execute(DataSource.java:1077) at com.isomorphic.application.AppBase.executeDefaultDSOperation(AppBase.java:721) at com.isomorphic.application.AppBase.executeAppOperation(AppBase.java:658) at com.isomorphic.application.AppBase.execute(AppBase.java:491) at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:1620) at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:173) at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:130) at com.isomorphic.servlet.IDACall.processRequest(IDACall.java:95) at com.isomorphic.servlet.IDACall.doPost(IDACall.java:54) at javax.servlet.http.HttpServlet.service(HttpServlet.java:637) at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:152) at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487) at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:362) at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216) at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181) at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:729) at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.handler.RequestLogHandler.handle(RequestLogHandler.java:49) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.Server.handle(Server.java:324) at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505) at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:843) at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:647) at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211) at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380) at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:395) at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:488) === 2011-06-03 22:34:40,616 [l0-3] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2011-06-03 22:34:40,617 [l0-3] DEBUG RPCManager - non-DMI response, dropExtraFields: true === 2011-06-03 22:34:41,158 [l0-3] INFO RequestContext - URL: '/gwtapp/sc/IDACall', User-Agent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_6_7) AppleWebKit/534.24 (KHTML, like Gecko) Chrome/11.0.696.71 Safari/534.24': Safari with Accept-Encoding header === 2011-06-03 22:34:41,161 [l0-3] DEBUG XML - Parsed XML from (in memory stream): 1ms === 2011-06-03 22:34:41,164 [l0-3] DEBUG RPCManager - Processing 1 requests. === 2011-06-03 22:34:41,166 [l0-3] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ __gwt_ObjectId:13, publisher_pkid:549 }, operationConfig:{ dataSource:"authdef_DataSource", operationType:"fetch", textMatchStyle:"substring" }, startRow:0, endRow:75, componentId:"isc_ListGrid_0", appID:"builtinApplication", operation:"authdef_DataSource_fetch", oldValues:{ __gwt_ObjectId:13, publisher_pkid:549 } } === 2011-06-03 22:34:41,166 [l0-3] INFO IDACall - Performing 1 operation(s) === 2011-06-03 22:34:41,166 [l0-3] DEBUG AppBase - [builtinApplication.authdef_DataSource_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2011-06-03 22:34:41,166 [l0-3] DEBUG AppBase - [builtinApplication.authdef_DataSource_fetch] No public zero-argument method named '_authdef_DataSource_fetch' found, performing generic datasource operation === 2011-06-03 22:34:41,166 [l0-3] INFO SQLDataSource - [builtinApplication.authdef_DataSource_fetch] Performing fetch operation with criteria: {__gwt_ObjectId:13,publisher_pkid:549} values: {__gwt_ObjectId:13,publisher_pkid:549} === 2011-06-03 22:34:41,167 [l0-3] INFO SQLDataSource - [builtinApplication.authdef_DataSource_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2011-06-03 22:34:41,167 [l0-3] DEBUG SQLDataSource - [builtinApplication.authdef_DataSource_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause === 2011-06-03 22:34:41,168 [l0-3] DEBUG SQLDataSource - [builtinApplication.authdef_DataSource_fetch] Eval'd row count query: SELECT COUNT(*) FROM edenmodel.AuthorizationDef WHERE (edenmodel.AuthorizationDef.publisher_pkid='549') === 2011-06-03 22:34:41,168 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] DriverManager fetching connection for DB2 via jdbc url jdbc:db2://localhost:50001/edendb === 2011-06-03 22:34:41,168 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Passing credentials getConnection separately from JDBC URL === 2011-06-03 22:34:41,173 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Returning pooled Connection === 2011-06-03 22:34:41,173 [l0-3] INFO SQLDriver - [builtinApplication.authdef_DataSource_fetch] Executing SQL query on 'DB2': SELECT COUNT(*) FROM edenmodel.AuthorizationDef WHERE (edenmodel.AuthorizationDef.publisher_pkid='549') === 2011-06-03 22:34:41,174 [l0-3] INFO SQLDriver - [builtinApplication.authdef_DataSource_fetch] Execute of select: SELECT COUNT(*) FROM edenmodel.AuthorizationDef WHERE (edenmodel.AuthorizationDef.publisher_pkid='549') on db: DB2 threw exception: com.ibm.db2.jcc.a.rn: DB2 SQL Error: SQLCODE=-401, SQLSTATE=42818, SQLERRMC==, DRIVER=4.2.73 - assuming stale connection and retrying query. === 2011-06-03 22:34:41,174 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] DriverManager fetching connection for DB2 via jdbc url jdbc:db2://localhost:50001/edendb === 2011-06-03 22:34:41,174 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Passing credentials getConnection separately from JDBC URL === 2011-06-03 22:34:41,179 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.authdef_DataSource_fetch] Returning pooled Connection === 2011-06-03 22:34:41,180 [l0-3] WARN RequestContext - dsRequest.execute() failed: com.ibm.db2.jcc.a.rn: DB2 SQL Error: SQLCODE=-401, SQLSTATE=42818, SQLERRMC==, DRIVER=4.2.73 at com.ibm.db2.jcc.a.cd.a(cd.java:666) at com.ibm.db2.jcc.a.cd.a(cd.java:60) at com.ibm.db2.jcc.a.cd.a(cd.java:127) at com.ibm.db2.jcc.a.ul.c(ul.java:2434) at com.ibm.db2.jcc.a.ul.d(ul.java:2411) at com.ibm.db2.jcc.a.ul.a(ul.java:1912) at com.ibm.db2.jcc.t4.db.g(db.java:138) at com.ibm.db2.jcc.t4.db.a(db.java:38) at com.ibm.db2.jcc.t4.t.a(t.java:32) at com.ibm.db2.jcc.t4.sb.h(sb.java:141) at com.ibm.db2.jcc.a.ul.ab(ul.java:1883) at com.ibm.db2.jcc.a.ul.a(ul.java:2756) at com.ibm.db2.jcc.a.ul.a(ul.java:598) at com.ibm.db2.jcc.a.ul.executeQuery(ul.java:582) at org.apache.commons.dbcp.DelegatingStatement.executeQuery(DelegatingStatement.java:208) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:323) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:266) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:260) at com.isomorphic.sql.SQLDriver.getScalarResult(SQLDriver.java:353) at com.isomorphic.sql.SQLDriver.executeScalar(SQLDriver.java:558) at com.isomorphic.sql.SQLDataSource.executeWindowedSelect(SQLDataSource.java:1475) at com.isomorphic.sql.SQLDataSource.SQLExecute(SQLDataSource.java:1285) at com.isomorphic.sql.SQLDataSource.processRequest(SQLDataSource.java:280) at com.isomorphic.sql.SQLDataSource.executeFetch(SQLDataSource.java:224) at com.isomorphic.datasource.DataSource.execute(DataSource.java:1077) at com.isomorphic.application.AppBase.executeDefaultDSOperation(AppBase.java:721) at com.isomorphic.application.AppBase.executeAppOperation(AppBase.java:658) at com.isomorphic.application.AppBase.execute(AppBase.java:491) at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:1620) at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:173) at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:130) at com.isomorphic.servlet.IDACall.processRequest(IDACall.java:95) at com.isomorphic.servlet.IDACall.doPost(IDACall.java:54) at javax.servlet.http.HttpServlet.service(HttpServlet.java:637) at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:152) at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487) at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:362) at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216) at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181) at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:729) at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.handler.RequestLogHandler.handle(RequestLogHandler.java:49) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.Server.handle(Server.java:324) at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505) at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:843) at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:647) at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211) at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380) at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:395) at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:488) === 2011-06-03 22:34:41,182 [l0-3] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2011-06-03 22:34:41,185 [l0-3] DEBUG RPCManager - non-DMI response, dropExtraFields: true