=== 2013-03-14 14:52:53,590 [l0-1] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ }, operationConfig:{ dataSource:"UserCubesEvaluation", operationType:"fetch" }, componentId:"(cacheAllData fetch)", appID:"builtinApplication", operation:"UserCubesEvaluation_fetch", oldValues:null } === 2013-03-14 14:52:53,594 [l0-1] INFO IDACall - Performing 1 operation(s) === 2013-03-14 14:52:53,595 [l0-1] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2013-03-14 14:52:53,595 [l0-1] DEBUG DeclarativeSecurity - DataSource UserCubesEvaluation is not in the pre-checked list, processing... === 2013-03-14 14:52:53,604 [l0-1] DEBUG AppBase - [builtinApplication.UserCubesEvaluation_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2013-03-14 14:52:53,605 [l0-1] DEBUG AppBase - [builtinApplication.UserCubesEvaluation_fetch] No public zero-argument method named '_UserCubesEvaluation_fetch' found, performing generic datasource operation === 2013-03-14 14:52:53,605 [l0-1] INFO SQLDataSource - [builtinApplication.UserCubesEvaluation_fetch] Performing fetch operation with criteria: {} values: {} === 2013-03-14 14:52:53,615 [l0-1] INFO SQLWhereClause - [builtinApplication.UserCubesEvaluation_fetch] empty condition === 2013-03-14 14:52:53,617 [l0-1] INFO SQLDataSource - [builtinApplication.UserCubesEvaluation_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2013-03-14 14:52:53,764 [l0-1] INFO SQLDataSource - [builtinApplication.UserCubesEvaluation_fetch] Executing SQL query on 'SQLServer': SELECT UserCubesEvaluation.item1, UserCubesEvaluation.item2, UserCubesEvaluation.value1 FROM UserCubesEvaluation WHERE ('1'='1') === 2013-03-14 14:52:53,833 [l0-1] INFO PoolManager - [builtinApplication.UserCubesEvaluation_fetch] SmartClient pooling started for 'SQLServer' objects === 2013-03-14 14:52:53,834 [l0-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.UserCubesEvaluation_fetch] Initializing SQL config for 'SQLServer' from system config - using DriverManager: com.microsoft.sqlserver.jdbc.SQLServerDriver === 2013-03-14 14:52:53,910 [l0-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.UserCubesEvaluation_fetch] com.microsoft.sqlserver.jdbc.SQLServerDriver lookup successful === 2013-03-14 14:52:53,910 [l0-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.UserCubesEvaluation_fetch] DriverManager fetching connection for SQLServer via jdbc url jdbc:sqlserver://192.168.1.156:1433;DatabaseName=Almaty;User=sa;Password=sasa === 2013-03-14 14:52:53,910 [l0-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.UserCubesEvaluation_fetch] Passing JDBC URL only to getConnection === 2013-03-14 14:52:54,273 [l0-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.UserCubesEvaluation_fetch] makeObject() created a pooled Connection '767201565' === 2013-03-14 14:52:54,280 [l0-1] DEBUG SQLConnectionManager - [builtinApplication.UserCubesEvaluation_fetch] Returning borrowed connection '767201565' === 2013-03-14 14:52:54,280 [l0-1] DEBUG SQLDriver - [builtinApplication.UserCubesEvaluation_fetch] About to execute SQL query in 'SQLServer' using connection '767201565' === 2013-03-14 14:52:54,280 [l0-1] INFO SQLDriver - [builtinApplication.UserCubesEvaluation_fetch] Executing SQL query on 'SQLServer': SELECT UserCubesEvaluation.item1, UserCubesEvaluation.item2, UserCubesEvaluation.value1 FROM UserCubesEvaluation WHERE ('1'='1') === 2013-03-14 14:52:54,293 [l0-1] INFO SQLDriver - [builtinApplication.UserCubesEvaluation_fetch] Execute of select: SELECT UserCubesEvaluation.item1, UserCubesEvaluation.item2, UserCubesEvaluation.value1 FROM UserCubesEvaluation WHERE ('1'='1') on db: SQLServer threw exception: com.microsoft.sqlserver.jdbc.SQLServerException: Недопустимое имя столбца "item1". - assuming stale connection and retrying query. === 2013-03-14 14:52:54,294 [l0-1] DEBUG SQLConnectionManager - [builtinApplication.UserCubesEvaluation_fetch] About to close PoolableConnection with hashcode "767201565" === 2013-03-14 14:52:54,294 [l0-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.UserCubesEvaluation_fetch] DriverManager fetching connection for SQLServer via jdbc url jdbc:sqlserver://192.168.1.156:1433;DatabaseName=Almaty;User=sa;Password=sasa === 2013-03-14 14:52:54,294 [l0-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.UserCubesEvaluation_fetch] Passing JDBC URL only to getConnection === 2013-03-14 14:52:54,305 [l0-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.UserCubesEvaluation_fetch] makeObject() created a pooled Connection '654228311' === 2013-03-14 14:52:54,307 [l0-1] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "654228311" === 2013-03-14 14:52:54,308 [l0-1] WARN RequestContext - dsRequest.execute() failed: com.microsoft.sqlserver.jdbc.SQLServerException: Недопустимое имя столбца "item1". at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDatabaseError(SQLServerException.java:216) at com.microsoft.sqlserver.jdbc.SQLServerStatement.getNextResult(SQLServerStatement.java:1515) at com.microsoft.sqlserver.jdbc.SQLServerStatement.doExecuteStatement(SQLServerStatement.java:792) at com.microsoft.sqlserver.jdbc.SQLServerStatement$StmtExecCmd.doExecute(SQLServerStatement.java:689) at com.microsoft.sqlserver.jdbc.TDSCommand.execute(IOBuffer.java:5696) at com.microsoft.sqlserver.jdbc.SQLServerConnection.executeCommand(SQLServerConnection.java:1715) at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeCommand(SQLServerStatement.java:180) at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeStatement(SQLServerStatement.java:155) at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeQuery(SQLServerStatement.java:616) at org.apache.commons.dbcp.DelegatingStatement.executeQuery(DelegatingStatement.java:208) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:592) at com.isomorphic.sql.SQLDriver.executeQuery(SQLDriver.java:848) at com.isomorphic.sql.SQLDataSource.executeNativeQuery(SQLDataSource.java:407) at com.isomorphic.sql.SQLDataSource.executeNativeQuery(SQLDataSource.java:401) at com.isomorphic.sql.SQLDataSource.SQLExecute(SQLDataSource.java:1394) at com.isomorphic.sql.SQLDataSource.processRequest(SQLDataSource.java:306) at com.isomorphic.sql.SQLDataSource.executeFetch(SQLDataSource.java:250) at com.isomorphic.datasource.DataSource.execute(DataSource.java:1368) at com.isomorphic.application.AppBase.executeDefaultDSOperation(AppBase.java:726) at com.isomorphic.application.AppBase.executeAppOperation(AppBase.java:658) at com.isomorphic.application.AppBase.execute(AppBase.java:491) at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:2027) at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:216) at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:173) at com.isomorphic.servlet.IDACall.processRequest(IDACall.java:138) at com.isomorphic.servlet.IDACall.doPost(IDACall.java:74) at javax.servlet.http.HttpServlet.service(HttpServlet.java:637) at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:152) at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487) at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1097) at com.isomorphic.servlet.CompressionFilter.doFilter(CompressionFilter.java:259) at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088) at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360) at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216) at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181) at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:729) at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.handler.RequestLogHandler.handle(RequestLogHandler.java:49) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.Server.handle(Server.java:324) at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505) at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:843) at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:647) at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211) at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380) at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:395) at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:488) === 2013-03-14 14:52:54,310 [l0-1] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2013-03-14 14:52:54,312 [l0-1] DEBUG RPCManager - non-DMI response, dropExtraFields: false === 2013-03-14 14:52:54,314 [l0-1] INFO Compression - /cubegrid/sc/IDACall: 178 -> 166 bytes === 2013-03-14 14:53:02,308 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/system/helpers/Log.html', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,325 [l0-1] INFO Compression - /cubegrid/sc/system/helpers/Log.html: 2866 -> 843 bytes === 2013-03-14 14:53:02,440 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_FileLoader.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,452 [l0-2] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_Core.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,456 [l0-2] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_Core.js === 2013-03-14 14:53:02,462 [l0-3] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_Foundation.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,472 [l0-5] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_Grids.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,481 [l0-6] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_Forms.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,483 [l0-1] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_FileLoader.js === 2013-03-14 14:53:02,486 [l0-4] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_Containers.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,487 [l0-1] INFO Compression - /cubegrid/sc/system/development/ISC_FileLoader.js: 30525 -> 8830 bytes === 2013-03-14 14:53:02,510 [l0-2] INFO Compression - /cubegrid/sc/system/development/ISC_Core.js: 788592 -> 206351 bytes === 2013-03-14 14:53:02,512 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_DataBinding.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,527 [l0-2] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_Tools.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,609 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_Containers.js === 2013-03-14 14:53:02,642 [l0-4] INFO Compression - /cubegrid/sc/system/development/ISC_Containers.js: 135810 -> 32259 bytes === 2013-03-14 14:53:02,644 [l0-4] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/load_skin.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,704 [l0-3] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_Foundation.js === 2013-03-14 14:53:02,717 [l0-3] INFO Compression - /cubegrid/sc/system/development/ISC_Foundation.js: 246671 -> 58532 bytes === 2013-03-14 14:53:02,720 [l0-3] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_DeveloperConsole.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:02,736 [l0-2] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_Tools.js === 2013-03-14 14:53:02,740 [l0-2] INFO Compression - /cubegrid/sc/system/development/ISC_Tools.js: 87203 -> 22938 bytes === 2013-03-14 14:53:02,768 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/load_skin.js === 2013-03-14 14:53:02,770 [l0-4] INFO Compression - /cubegrid/sc/skins/Enterprise/load_skin.js: 55685 -> 9553 bytes === 2013-03-14 14:53:02,819 [l0-3] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_DeveloperConsole.js === 2013-03-14 14:53:02,836 [l0-3] INFO Compression - /cubegrid/sc/system/development/ISC_DeveloperConsole.js: 71448 -> 20596 bytes === 2013-03-14 14:53:02,864 [l0-1] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_DataBinding.js === 2013-03-14 14:53:02,889 [l0-5] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_Grids.js === 2013-03-14 14:53:02,900 [l0-1] INFO Compression - /cubegrid/sc/system/development/ISC_DataBinding.js: 630590 -> 155425 bytes === 2013-03-14 14:53:02,903 [l0-6] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_Forms.js === 2013-03-14 14:53:02,948 [l0-6] INFO Compression - /cubegrid/sc/system/development/ISC_Forms.js: 726150 -> 176141 bytes === 2013-03-14 14:53:02,972 [l0-5] INFO Compression - /cubegrid/sc/system/development/ISC_Grids.js: 858632 -> 215577 bytes === 2013-03-14 14:53:03,779 [l0-5] INFO RequestContext - URL: '/cubegrid/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:03,779 [l0-5] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:8888 === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0 === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8 === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5 === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:8888/cubegrid/sc/system/helpers/Log.html === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Cookie:GLog=%7B%0D%20%20%20%20left%3A910%2C%20%0D%20%20%20%20top%3A5%2C%20%0D%20%20%20%20width%3A640%2C%20%0D%20%20%20%20height%3A707%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%20ResultSet%3A3%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D; isc_cState=ready; JSESSIONID=1d2ujb8o60nz0 === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8 === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Content-Length:677 === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - session exists: 1d2ujb8o60nz0 === 2013-03-14 14:53:03,780 [l0-5] DEBUG IDACall - remote user: null === 2013-03-14 14:53:03,783 [l0-5] DEBUG XML - Parsed XML from (in memory stream): 2ms === 2013-03-14 14:53:03,785 [l0-5] DEBUG RPCManager - Processing 1 requests. === 2013-03-14 14:53:03,786 [l0-5] DEBUG RPCManager - Request #1 (RPCRequest) data: { appID:"isc_builtin", className:"builtin", methodName:"getAvailableScriptEngines", arguments:[ ], is_ISC_RPC_DMI:true } === 2013-03-14 14:53:03,786 [l0-5] INFO IDACall - Performing 1 operation(s) === 2013-03-14 14:53:03,808 [l0-5] DEBUG XML - Parsed XML from jar:file:/C:/Users/usus/workspace/cubegrid/war/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_builtin.app.xml: 13ms === 2013-03-14 14:53:03,811 [l0-5] DEBUG XML - Parsed XML from C:\Users\usus\workspace\cubegrid\war\cubegrid\sc\system\schema\Application.ds.xml: 2ms === 2013-03-14 14:53:03,826 [l0-5] DEBUG XML - Parsed XML from C:\Users\usus\workspace\cubegrid\war\cubegrid\sc\system\schema\ServerObject.ds.xml: 11ms === 2013-03-14 14:53:03,832 [l0-5] DEBUG XML - Parsed XML from C:\Users\usus\workspace\cubegrid\war\cubegrid\sc\system\schema\Method.ds.xml: 2ms === 2013-03-14 14:53:03,838 [l0-5] DEBUG RPCDMI - appConfig: isc.Application.create({ rpcBindings:[ { ID:"builtin", className:"com.isomorphic.rpc.BuiltinRPC", visibleMethods:[ { name:"downloadWSDL" }, { name:"downloadClientContent" }, { name:"downloadClientExport" }, { name:"xmlToJS" }, { name:"uploadProgressCheck" }, { name:"saveFile" }, { name:"appendToFile" }, { name:"loadFile" }, { name:"deleteFile" }, { name:"loadSharedXML" }, { name:"saveSharedXML" }, { name:"getAvailableScriptEngines" }, { name:"devConsoleEvalServerScript" }, { name:"evalJava" }, { name:"getLogNames" }, { name:"getLogEntries" }, { name:"getLogThresholds" }, { name:"setLogThreshold" }, { name:"getPdfObject" } ] }, { ID:"builtin_tools", className:"com.isomorphic.tools.BuiltinRPC", visibleMethods:[ { name:"getDataSourceFromTable" }, { name:"getDataSourceJSONFromTable" }, { name:"getDataSourceFromHibernateMapping" }, { name:"getDataSourceJSONFromHibernateMapping" }, { name:"getTables" }, { name:"getFieldsFromTable" }, { name:"getBeanFields" }, { name:"getHibernateBeans" }, { name:"getDatabaseProductNameAndVersion" }, { name:"getDatabaseTableTypes" }, { name:"setAttributes" }, { name:"clearAttributes" }, { name:"getAttributes" }, { name:"getAttribute" }, { name:"getDataSourceConfigFromJavaClass" }, { args:"cName", language:"groovy", name:"getJavaSource", script:"\n if (!com.isomorphic.auth.DevModeAuthFilter.devModeAuthorized(request)) throw new Exception(\"Not Authorized\"); \n //import org.apache.bcel.Repository;\n\n try {\n return org.apache.bcel.Repository.lookupClass(cName).toString();\n } catch (Throwable e) {\n return \"Unable to reverse engineer class \"+cName+\": \"+e.getMessage();\n }\n " }, { name:"loadDataSource" }, { name:"dsFromXML" }, { name:"dsConfigFromXML" }, { name:"getDefinedDataSources" } ] }, { ID:"builtin_adminconsole", className:"com.isomorphic.tools.AdminConsole", visibleMethods:[ { name:"getDefinedDatabases" }, { name:"testDB" }, { name:"saveDBConfig" }, { name:"setDefaultDB" }, { name:"importDataSources" }, { name:"discoverJNDIDatabases" } ] } ] }) === 2013-03-14 14:53:03,839 [l0-5] WARN RequestContext - rpcRequest.execute() failed: java.lang.Exception: Attempt to execute RPC DMI Builtin 'getAvailableScriptEngines' DENIED by server.properties configuration. To enable this method, add it to the list of methods under RPCManager.enabledBuiltinMethods in server.properties at com.isomorphic.rpc.RPCDMI.execute(RPCDMI.java:180) at com.isomorphic.rpc.RPCDMI.execute(RPCDMI.java:66) at com.isomorphic.rpc.RPCRequest.execute(RPCRequest.java:231) at com.isomorphic.servlet.IDACall.handleRPCRequest(IDACall.java:285) at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:169) at com.isomorphic.servlet.IDACall.processRequest(IDACall.java:138) at com.isomorphic.servlet.IDACall.doPost(IDACall.java:74) at javax.servlet.http.HttpServlet.service(HttpServlet.java:637) at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:152) at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487) at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1097) at com.isomorphic.servlet.CompressionFilter.doFilter(CompressionFilter.java:259) at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088) at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360) at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216) at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181) at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:729) at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.handler.RequestLogHandler.handle(RequestLogHandler.java:49) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.Server.handle(Server.java:324) at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505) at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:843) at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:647) at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211) at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380) at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:395) at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:488) === 2013-03-14 14:53:03,840 [l0-5] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2013-03-14 14:53:03,840 [l0-5] INFO Compression - /cubegrid/sc/IDACall: 285 -> 218 bytes === 2013-03-14 14:53:03,911 [l0-5] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/Menu/menu_button.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:03,914 [l0-5] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/Menu/menu_button.png === 2013-03-14 14:53:03,925 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/actions/help.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:03,928 [l0-6] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/SectionHeader/opener_closed.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:03,933 [l0-5] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/SectionHeader/opener_opened.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:03,933 [l0-6] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/SectionHeader/opener_closed.png === 2013-03-14 14:53:03,935 [l0-5] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/SectionHeader/opener_opened.png === 2013-03-14 14:53:03,956 [l0-1] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/actions/help.png === 2013-03-14 14:53:05,335 [l0-5] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/DynamicForm/unchecked_Disabled.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:05,337 [l0-5] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/DynamicForm/unchecked_Disabled.png === 2013-03-14 14:53:05,338 [l0-3] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/Scrollbar/hthumb_grip.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:05,339 [l0-6] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/Scrollbar/hscroll_track.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:05,341 [l0-2] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/Scrollbar/hscroll_start.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:05,341 [l0-6] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/Scrollbar/hscroll_track.png === 2013-03-14 14:53:05,342 [l0-3] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/Scrollbar/hthumb_grip.png === 2013-03-14 14:53:05,343 [l0-4] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/Scrollbar/hscroll_end.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:05,343 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/system/reference/skin/images/server_client_exchange.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:53:05,344 [l0-1] INFO Download - File C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/reference/skin/images/server_client_exchange.png not found, sending 404 === 2013-03-14 14:53:05,345 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/Scrollbar/hscroll_end.png === 2013-03-14 14:53:05,346 [l0-2] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/Scrollbar/hscroll_start.png [WARN] 404 - GET /cubegrid/sc/system/reference/skin/images/server_client_exchange.png (127.0.0.1) 1453 bytes Request headers Host: 127.0.0.1:8888 User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0 Accept: image/png,image/*;q=0.8,*/*;q=0.5 Accept-Language: en-US,en;q=0.5 Accept-Encoding: gzip, deflate Referer: http://127.0.0.1:8888/cubegrid/sc/system/helpers/Log.html Cookie: GLog=%7B%0D%20%20%20%20left%3A910%2C%20%0D%20%20%20%20top%3A5%2C%20%0D%20%20%20%20width%3A640%2C%20%0D%20%20%20%20height%3A707%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%20ResultSet%3A3%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Atrue%0D%7D; isc_cState=ready; JSESSIONID=1d2ujb8o60nz0 Connection: keep-alive Response headers X-Included-Test2: true X-Included-Test: true Content-Type: text/html; charset=iso-8859-1 Content-Length: 1453 === 2013-03-14 14:54:42,375 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/Scrollbar/hscroll_Over_track.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:54:42,382 [l0-1] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/Scrollbar/hscroll_Over_track.png === 2013-03-14 14:54:43,898 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/system/development/ISC_ServerLogViewer.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:54:43,910 [l0-1] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/system/development/ISC_ServerLogViewer.js === 2013-03-14 14:54:43,911 [l0-1] INFO Compression - /cubegrid/sc/system/development/ISC_ServerLogViewer.js: 8875 -> 3048 bytes === 2013-03-14 14:54:44,052 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:54:44,060 [l0-1] INFO Compression - /cubegrid/sc/IDACall: 271 -> 208 bytes === 2013-03-14 14:54:46,013 [l0-1] INFO RequestContext - URL: '/cubegrid/sc/skins/Enterprise/images/pickers/comboBoxPicker_Over.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0': Moz (Gecko) with Accept-Encoding header === 2013-03-14 14:54:46,015 [l0-1] INFO Download - done streaming: C:/Users/usus/workspace/cubegrid/war/cubegrid/sc/skins/Enterprise/images/pickers/comboBoxPicker_Over.png