=== 2012-05-31 15:36:31,784 [main] INFO ISCInit - Isomorphic SmartClient Framework - Initializing === 2012-05-31 15:36:31,784 [main] INFO ConfigLoader - Attempting to load framework.properties from CLASSPATH === 2012-05-31 15:36:31,847 [main] INFO ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/D:/svn/cpm/branches/twig_soa_test/emm/extree/war/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties === 2012-05-31 15:36:31,847 [main] INFO ConfigLoader - Attempting to load project.properties from CLASSPATH === 2012-05-31 15:36:31,847 [main] INFO ConfigLoader - Unable to locate project.properties in CLASSPATH === 2012-05-31 15:36:31,847 [main] INFO ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/D:/svn/cpm/branches/twig_soa_test/emm/extree/war/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties === 2012-05-31 15:36:31,847 [main] INFO ConfigLoader - Attempting to load server.properties from CLASSPATH === 2012-05-31 15:36:31,847 [main] INFO ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/D:/svn/cpm/branches/twig_soa_test/emm/extree/war/WEB-INF/classes/server.properties === 2012-05-31 15:36:31,847 [main] INFO Logger - Logging system started. === 2012-05-31 15:36:31,847 [main] INFO ISCInit - Isomorphic SmartClient Framework (v8.2p_2012-05-11/EVAL Deployment 2012-05-11) - Initialization Complete === 2012-05-31 15:36:31,847 [main] INFO ISCInit - Auto-detected webRoot - using: D:\svn\cpm\branches\twig_soa_test\emm\extree\war === 2012-05-31 15:36:44,315 [l0-2] INFO RequestContext - URL: '/extree/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 5.2; WOW64; rv:10.0) Gecko/20100101 Firefox/10.0': Moz (Gecko) with Accept-Encoding header === 2012-05-31 15:36:44,347 [l0-2] INFO PoolManager - SmartClient pooling disabled for 'taskorg' objects === 2012-05-31 15:36:44,362 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\schema\builtinTypes.xml: 0ms === 2012-05-31 15:36:44,393 [l0-0] INFO Compression - /extree/sc/modules/ISC_Core.js: 711565 -> 184480 bytes === 2012-05-31 15:36:44,425 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\ds\taskorg.ds.xml: 0ms === 2012-05-31 15:36:44,440 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\schema\DataSource.ds.xml: 15ms === 2012-05-31 15:36:44,472 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\schema\DataSourceField.ds.xml: 0ms === 2012-05-31 15:36:44,503 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\schema\ValueMap.ds.xml: 0ms === 2012-05-31 15:36:44,534 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\ds\location.ds.xml: 0ms === 2012-05-31 15:36:44,534 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\ds\gcc.ds.xml: 0ms === 2012-05-31 15:36:44,550 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\ds\geodetic.ds.xml: 0ms === 2012-05-31 15:36:44,550 [l0-2] INFO Compression - /extree/sc/DataSourceLoader: 3426 -> 667 bytes === 2012-05-31 15:36:49,315 [l0-2] INFO RequestContext - URL: '/extree/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 5.2; WOW64; rv:10.0) Gecko/20100101 Firefox/10.0': Moz (Gecko) with Accept-Encoding header === 2012-05-31 15:36:49,331 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms === 2012-05-31 15:36:49,331 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\schema\List.ds.xml: 0ms === 2012-05-31 15:36:49,347 [l0-2] DEBUG RPCManager - Processing 1 requests. === 2012-05-31 15:36:49,347 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ }, operationConfig:{ dataSource:"taskorg", operationType:"fetch", textMatchStyle:"exact" }, componentId:"isc_TreeGrid_0", appID:"builtinApplication", operation:"taskorg_fetch", oldValues:{ } } === 2012-05-31 15:36:49,362 [l0-2] INFO IDACall - Performing 1 operation(s) === 2012-05-31 15:36:49,362 [l0-2] DEBUG AppBase - [builtinApplication.taskorg_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2012-05-31 15:36:49,362 [l0-2] DEBUG AppBase - [builtinApplication.taskorg_fetch] No public zero-argument method named '_taskorg_fetch' found, performing generic datasource operation === 2012-05-31 15:36:49,362 [l0-2] INFO SQLDataSource - [builtinApplication.taskorg_fetch] Performing fetch operation with criteria: {} values: {} === 2012-05-31 15:36:49,378 [l0-2] INFO SQLWhereClause - [builtinApplication.taskorg_fetch] empty condition === 2012-05-31 15:36:49,378 [l0-2] INFO SQLDataSource - [builtinApplication.taskorg_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2012-05-31 15:36:49,456 [l0-2] INFO SQLDataSource - [builtinApplication.taskorg_fetch] Executing SQL query on 'HSQLDB': SELECT taskorgTable.CommsStatus, taskorgTable.DamageState, taskorgTable.Instrumented, taskorgTable.NodeIcon, taskorgTable.NodeLabel, taskorgTable.NodeType, taskorgTable.ParentUuid, taskorgTable.Uuid FROM taskorgTable WHERE ('1'='1') === 2012-05-31 15:36:49,534 [l0-2] INFO PoolManager - [builtinApplication.taskorg_fetch] SmartClient pooling disabled for 'HSQLDB' objects === 2012-05-31 15:36:49,534 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.taskorg_fetch] Initializing SQL config for 'HSQLDB' from system config - using DriverManager: org.hsqldb.jdbcDriver === 2012-05-31 15:36:49,534 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.taskorg_fetch] org.hsqldb.jdbcDriver lookup successful === 2012-05-31 15:36:49,534 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.taskorg_fetch] DriverManager fetching connection for HSQLDB via jdbc url jdbc:hsqldb:hsql://localhost/isomorphic === 2012-05-31 15:36:49,534 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.taskorg_fetch] Passing JDBC URL only to getConnection === 2012-05-31 15:36:49,956 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.taskorg_fetch] Returning unpooled Connection === 2012-05-31 15:36:49,956 [l0-2] INFO SQLDriver - [builtinApplication.taskorg_fetch] Executing SQL query on 'HSQLDB': SELECT taskorgTable.CommsStatus, taskorgTable.DamageState, taskorgTable.Instrumented, taskorgTable.NodeIcon, taskorgTable.NodeLabel, taskorgTable.NodeType, taskorgTable.ParentUuid, taskorgTable.Uuid FROM taskorgTable WHERE ('1'='1') === 2012-05-31 15:36:49,972 [l0-2] INFO DSResponse - [builtinApplication.taskorg_fetch] DSResponse: List with 7 items === 2012-05-31 15:36:49,972 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2012-05-31 15:36:49,972 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false === 2012-05-31 15:36:49,972 [l0-2] INFO Compression - /extree/sc/IDACall: 1361 -> 395 bytes === 2012-05-31 15:36:56,159 [l0-2] INFO RequestContext - URL: '/extree/tools/dsGenerator.jsp', User-Agent: 'Mozilla/5.0 (Windows NT 5.2; WOW64; rv:10.0) Gecko/20100101 Firefox/10.0': Moz (Gecko) with Accept-Encoding header === 2012-05-31 15:36:57,222 [l0-2] DEBUG LoadISCTag - isomorphicURI not specified in tag, defaulting to: ../../extree/sc/ === 2012-05-31 15:36:57,222 [l0-2] INFO Compression - /extree/tools/dsGenerator.jsp: 3371 -> 1181 bytes === 2012-05-31 15:36:57,878 [l0-2] INFO RequestContext - URL: '/extree/tools/batchDSGeneratorOperations.jsp', User-Agent: 'Mozilla/5.0 (Windows NT 5.2; WOW64; rv:10.0) Gecko/20100101 Firefox/10.0': Moz (Gecko) with Accept-Encoding header === 2012-05-31 15:36:58,222 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 16ms === 2012-05-31 15:36:58,222 [l0-2] DEBUG RPCManager - Processing 1 requests. === 2012-05-31 15:36:58,222 [l0-2] DEBUG RPCManager - Request #1 (RPCRequest) data: { appID:"isc_builtin", className:"com.isomorphic.tools.AdminConsole", methodName:"getDefinedDatabases", arguments:[ true ], is_ISC_RPC_DMI:true } === 2012-05-31 15:36:58,222 [l0-2] DEBUG XML - Parsed XML from jar:file:/D:/svn/cpm/branches/twig_soa_test/emm/extree/war/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_builtin.app.xml: 0ms === 2012-05-31 15:36:58,222 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\schema\Application.ds.xml: 0ms === 2012-05-31 15:36:58,222 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\schema\ServerObject.ds.xml: 0ms === 2012-05-31 15:36:58,237 [l0-2] DEBUG XML - Parsed XML from D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\schema\Method.ds.xml: 0ms === 2012-05-31 15:36:58,237 [l0-2] 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" } ] } ] }) === 2012-05-31 15:36:58,253 [l0-2] INFO SQLConnectionManager - Autodetecting datasources at JNDI root: __root__ === 2012-05-31 15:36:58,253 [l0-2] WARN SQLConnectionManager - Failure during JNDI datasource autoDetection: Need to specify class name in environment or system property, or as an applet parameter, or in an application resource file: java.naming.factory.initial === 2012-05-31 15:36:58,253 [l0-2] INFO SQLConnectionManager - Autodetecting datasources at JNDI root: java:comp === 2012-05-31 15:36:58,253 [l0-2] WARN SQLConnectionManager - Failure during JNDI datasource autoDetection: Need to specify class name in environment or system property, or as an applet parameter, or in an application resource file: java.naming.factory.initial === 2012-05-31 15:36:58,253 [l0-2] INFO SQLConnectionManager - Autodetecting datasources at JNDI root: java:comp/env === 2012-05-31 15:36:58,253 [l0-2] WARN SQLConnectionManager - Failure during JNDI datasource autoDetection: Need to specify class name in environment or system property, or as an applet parameter, or in an application resource file: java.naming.factory.initial === 2012-05-31 15:36:58,253 [l0-2] DEBUG BuiltinRPC - Testing DB connection for database: Oracle === 2012-05-31 15:36:58,268 [l0-2] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'Oracle' from system config - using DataSource: oracle.jdbc.pool.OracleDataSource === 2012-05-31 15:36:58,268 [l0-2] INFO BuiltinRPC - testDB (Oracle) error: java.sql.SQLException: java.lang.ClassNotFoundException: oracle.jdbc.pool.OracleDataSource === 2012-05-31 15:36:58,268 [l0-2] DEBUG BuiltinRPC - Testing DB connection for database: Mysql === 2012-05-31 15:36:58,268 [l0-2] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'Mysql' from system config - using DataSource: com.mysql.jdbc.jdbc2.optional.MysqlDataSource === 2012-05-31 15:36:58,268 [l0-2] INFO BuiltinRPC - testDB (Mysql) error: java.sql.SQLException: java.lang.ClassNotFoundException: com.mysql.jdbc.jdbc2.optional.MysqlDataSource === 2012-05-31 15:36:58,268 [l0-2] DEBUG BuiltinRPC - Testing DB connection for database: HSQLDB === 2012-05-31 15:36:58,268 [l0-2] DEBUG PoolableSQLConnectionFactory - DriverManager fetching connection for HSQLDB via jdbc url jdbc:hsqldb:hsql://localhost/isomorphic === 2012-05-31 15:36:58,268 [l0-2] DEBUG PoolableSQLConnectionFactory - Passing JDBC URL only to getConnection === 2012-05-31 15:36:58,268 [l0-2] DEBUG PoolableSQLConnectionFactory - Returning unpooled Connection === 2012-05-31 15:36:58,284 [l0-2] DEBUG BuiltinRPC - Testing DB connection for database: Cache === 2012-05-31 15:36:58,284 [l0-2] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'Cache' from system config - using DataSource: com.intersys.jdbc.CacheDataSource === 2012-05-31 15:36:58,284 [l0-2] INFO BuiltinRPC - testDB (Cache) error: java.sql.SQLException: java.lang.ClassNotFoundException: com.intersys.jdbc.CacheDataSource === 2012-05-31 15:36:58,284 [l0-2] DEBUG BuiltinRPC - Testing DB connection for database: SQLServer === 2012-05-31 15:36:58,284 [l0-2] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'SQLServer' from system config - using DriverManager: com.microsoft.jdbc.sqlserver.SQLServerDriver === 2012-05-31 15:36:58,284 [l0-2] INFO BuiltinRPC - testDB (SQLServer) error: java.sql.SQLException: java.lang.ClassNotFoundException: com.microsoft.jdbc.sqlserver.SQLServerDriver === 2012-05-31 15:36:58,284 [l0-2] DEBUG BuiltinRPC - Testing DB connection for database: PostgreSQL === 2012-05-31 15:36:58,284 [l0-2] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'PostgreSQL' from system config - using DriverManager: org.postgresql.Driver === 2012-05-31 15:36:58,284 [l0-2] INFO BuiltinRPC - testDB (PostgreSQL) error: java.sql.SQLException: java.lang.ClassNotFoundException: org.postgresql.Driver === 2012-05-31 15:36:58,284 [l0-2] DEBUG BuiltinRPC - Testing DB connection for database: DB2 === 2012-05-31 15:36:58,284 [l0-2] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'DB2' from system config - using DataSource: COM.ibm.db2.jdbc.DB2DataSource === 2012-05-31 15:36:58,284 [l0-2] INFO BuiltinRPC - testDB (DB2) error: java.sql.SQLException: java.lang.ClassNotFoundException: COM.ibm.db2.jdbc.DB2DataSource === 2012-05-31 15:36:58,284 [l0-2] DEBUG BuiltinRPC - Testing DB connection for database: Firebird === 2012-05-31 15:36:58,284 [l0-2] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'Firebird' from system config - using DriverManager: org.firebirdsql.jdbc.FBDriver === 2012-05-31 15:36:58,284 [l0-2] INFO BuiltinRPC - testDB (Firebird) error: java.sql.SQLException: java.lang.ClassNotFoundException: org.firebirdsql.jdbc.FBDriver === 2012-05-31 15:36:58,284 [l0-2] DEBUG RPCDMI - rpc returned data === 2012-05-31 15:36:58,284 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2012-05-31 15:36:58,284 [l0-2] INFO Compression - /extree/tools/batchDSGeneratorOperations.jsp: 2782 -> 853 bytes === 2012-05-31 15:36:58,315 [l0-2] INFO RequestContext - URL: '/extree/tools/batchDSGeneratorOperations.jsp', User-Agent: 'Mozilla/5.0 (Windows NT 5.2; WOW64; rv:10.0) Gecko/20100101 Firefox/10.0': Moz (Gecko) with Accept-Encoding header === 2012-05-31 15:36:58,315 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms === 2012-05-31 15:36:58,331 [l0-2] DEBUG RPCManager - Processing 1 requests. === 2012-05-31 15:36:58,331 [l0-2] DEBUG RPCManager - Request #1 (RPCRequest) data: { appID:"isc_builtin", className:"com.isomorphic.tools.BuiltinRPC", methodName:"getTables", arguments:[ "sql", "HSQLDB", true, true, null, "", null, null ], is_ISC_RPC_DMI:true } === 2012-05-31 15:36:58,331 [l0-2] 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" } ] } ] }) === 2012-05-31 15:36:58,331 [l0-2] DEBUG PoolableSQLConnectionFactory - DriverManager fetching connection for HSQLDB via jdbc url jdbc:hsqldb:hsql://localhost/isomorphic === 2012-05-31 15:36:58,331 [l0-2] DEBUG PoolableSQLConnectionFactory - Passing JDBC URL only to getConnection === 2012-05-31 15:36:58,331 [l0-2] DEBUG PoolableSQLConnectionFactory - Returning unpooled Connection === 2012-05-31 15:36:58,347 [l0-2] DEBUG RPCDMI - rpc returned data === 2012-05-31 15:36:58,347 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2012-05-31 15:36:58,347 [l0-2] INFO Compression - /extree/tools/batchDSGeneratorOperations.jsp: 88 -> 76 bytes === 2012-05-31 15:37:04,675 [l0-2] INFO RequestContext - URL: '/extree/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 5.2; WOW64; rv:10.0) Gecko/20100101 Firefox/10.0': Moz (Gecko) with Accept-Encoding header === 2012-05-31 15:37:04,675 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 0ms === 2012-05-31 15:37:04,675 [l0-2] DEBUG RPCManager - Processing 1 requests. === 2012-05-31 15:37:04,675 [l0-2] DEBUG RPCManager - Request #1 (RPCRequest) data: { appID:"isc_builtin", className:"builtin", methodName:"getAvailableScriptEngines", arguments:[ ], is_ISC_RPC_DMI:true } === 2012-05-31 15:37:04,675 [l0-2] INFO IDACall - Performing 1 operation(s) === 2012-05-31 15:37:04,675 [l0-2] 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" } ] } ] }) === 2012-05-31 15:37:04,675 [l0-2] DEBUG RPCDMI - rpc returned data === 2012-05-31 15:37:04,675 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2012-05-31 15:37:04,675 [l0-2] INFO Compression - /extree/sc/IDACall: 80 -> 86 bytes === 2012-05-31 15:37:06,721 [l0-2] INFO Download - Returning 304: Not modified on conditional get of: D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\skins\Enterprise\images\cssButton\button_Over_stretch.png === 2012-05-31 15:37:06,831 [l0-2] INFO Download - Returning 304: Not modified on conditional get of: D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\skins\Enterprise\images\pickers\comboBoxPicker_Over.png === 2012-05-31 15:37:40,659 [l0-2] DEBUG HibernateDataSource - Instantiating Hibernate config and session factory from file D:/svn/cpm/branches/twig_soa_test/emm/extree/war/WEB-INF/classes/hibernate.cfg.xml === 2012-05-31 15:37:49,909 [l0-2] INFO Download - Returning 304: Not modified on conditional get of: D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\system\development\ISC_ServerLogViewer.js === 2012-05-31 15:37:49,909 [l0-3] INFO Download - Returning 304: Not modified on conditional get of: D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\skins\Enterprise\images\Tab\top\tab_Selected_Over_start.png === 2012-05-31 15:37:49,909 [l0-5] INFO Download - Returning 304: Not modified on conditional get of: D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\skins\Enterprise\images\Tab\top\tab_Selected_Over_end.png === 2012-05-31 15:37:49,909 [l0-4] INFO Download - Returning 304: Not modified on conditional get of: D:\svn\cpm\branches\twig_soa_test\emm\extree\war\extree\sc\skins\Enterprise\images\Tab\top\tab_Selected_Over_stretch.png === 2012-05-31 15:37:49,940 [l0-4] INFO RequestContext - URL: '/extree/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 5.2; WOW64; rv:10.0) Gecko/20100101 Firefox/10.0': Moz (Gecko) with Accept-Encoding header === 2012-05-31 15:37:49,940 [l0-4] INFO Compression - /extree/sc/IDACall: 81 -> 86 bytes === 2012-05-31 15:37:50,096 [l0-4] INFO RequestContext - URL: '/extree/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 5.2; WOW64; rv:10.0) Gecko/20100101 Firefox/10.0': Moz (Gecko) with Accept-Encoding header