ISC: Configuring log4j from: file:/C:/Users/usus/workspace/register/war/WEB-INF/classes/log4j.isc.config.xml
=== 2012-12-27 09:35:16,605 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework - Initializing
=== 2012-12-27 09:35:16,614 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
=== 2012-12-27 09:35:16,728 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/Users/usus/workspace/register/war/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties
=== 2012-12-27 09:35:16,728 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
=== 2012-12-27 09:35:16,729 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
=== 2012-12-27 09:35:16,735 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/Users/usus/workspace/register/war/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties
=== 2012-12-27 09:35:16,735 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
=== 2012-12-27 09:35:16,737 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/Users/usus/workspace/register/war/WEB-INF/classes/server.properties
=== 2012-12-27 09:35:16,745 [main] INFO  Logger - Logging system started.
=== 2012-12-27 09:35:16,746 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework (v8.3_2012-11-20/EVAL Deployment 2012-11-20) - Initialization Complete
=== 2012-12-27 09:35:16,753 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\Users\usus\workspace\register\war
=== 2012-12-27 09:35:16,758 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework initialization called from com.isomorphic.base.Base
=== 2012-12-27 09:35:16,758 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework is already initialized
=== 2012-12-27 09:35:16,843 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework initialization called from com.isomorphic.base.Init
=== 2012-12-27 09:35:16,843 [main] INFO  ISCInit - Isomorphic SmartClient/SmartGWT Framework is already initialized
=== 2012-12-27 09:35:29,589 [l0-0] INFO  RequestContext - URL: '/Register.html', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,619 [l0-0] INFO  Compression - /Register.html: 2385 -> 999 bytes
=== 2012-12-27 09:35:29,655 [l0-2] INFO  RequestContext - URL: '/register/register.nocache.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,660 [l0-2] INFO  Compression - /register/register.nocache.js: 16054 -> 3920 bytes
=== 2012-12-27 09:35:29,662 [l0-0] INFO  RequestContext - URL: '/Register.css', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,668 [l0-0] INFO  Compression - /Register.css: 602 -> 368 bytes
=== 2012-12-27 09:35:29,674 [l0-0] INFO  RequestContext - URL: '/register/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,709 [l0-0] INFO  PoolManager - SmartClient pooling disabled for 'columnMeta' objects
=== 2012-12-27 09:35:29,759 [l0-4] INFO  RequestContext - URL: '/register/sc/modules/ISC_Core.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,770 [l0-3] INFO  RequestContext - URL: '/register/sc/modules/ISC_Foundation.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,772 [l0-2] INFO  RequestContext - URL: '/register/sc/initsc.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,776 [l0-5] INFO  RequestContext - URL: '/register/sc/modules/ISC_Containers.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,790 [l0-5] INFO  Compression - /register/sc/modules/ISC_Containers.js: 135750 -> 32244 bytes
=== 2012-12-27 09:35:29,809 [l0-6] INFO  RequestContext - URL: '/register/sc/modules/ISC_Grids.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,816 [l0-3] INFO  Compression - /register/sc/modules/ISC_Foundation.js: 245759 -> 58546 bytes
=== 2012-12-27 09:35:29,827 [l0-5] INFO  RequestContext - URL: '/register/sc/modules/ISC_Forms.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,845 [l0-2] INFO  Compression - /register/sc/initsc.js: 47 -> 72 bytes
=== 2012-12-27 09:35:29,851 [l0-2] INFO  RequestContext - URL: '/register/sc/modules/ISC_Calendar.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,852 [l0-0] DEBUG XML - Parsed XML from C:\Users\usus\workspace\register\war\register\sc\system\schema\builtinTypes.xml: 87ms
=== 2012-12-27 09:35:29,860 [l0-2] INFO  Compression - /register/sc/modules/ISC_Calendar.js: 117740 -> 28936 bytes
=== 2012-12-27 09:35:29,869 [l0-2] INFO  RequestContext - URL: '/register/sc/modules/ISC_DataBinding.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,893 [l0-3] INFO  RequestContext - URL: '/register/sc/modules/ISC_RichTextEditor.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:29,898 [l0-3] INFO  Compression - /register/sc/modules/ISC_RichTextEditor.js: 40675 -> 11399 bytes
=== 2012-12-27 09:35:29,899 [l0-4] INFO  Compression - /register/sc/modules/ISC_Core.js: 783536 -> 205340 bytes
=== 2012-12-27 09:35:29,952 [l0-6] INFO  Compression - /register/sc/modules/ISC_Grids.js: 854111 -> 214493 bytes
=== 2012-12-27 09:35:29,982 [l0-5] INFO  Compression - /register/sc/modules/ISC_Forms.js: 692828 -> 168264 bytes
=== 2012-12-27 09:35:29,983 [l0-3] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/load_skin.js', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:30,023 [l0-0] DEBUG XML - Parsed XML from C:\Users\usus\workspace\register\war\ds\columnMeta.ds.xml: 5ms
=== 2012-12-27 09:35:30,032 [l0-0] DEBUG XML - Parsed XML from C:\Users\usus\workspace\register\war\register\sc\system\schema\DataSource.ds.xml: 7ms
=== 2012-12-27 09:35:30,085 [l0-2] INFO  Compression - /register/sc/modules/ISC_DataBinding.js: 631194 -> 155453 bytes
=== 2012-12-27 09:35:30,123 [l0-3] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/load_skin.js
=== 2012-12-27 09:35:30,126 [l0-3] INFO  Compression - /register/sc/skins/Enterprise/load_skin.js: 55511 -> 9523 bytes
=== 2012-12-27 09:35:30,150 [l0-0] DEBUG XML - Parsed XML from C:\Users\usus\workspace\register\war\register\sc\system\schema\DataSourceField.ds.xml: 19ms
=== 2012-12-27 09:35:30,220 [l0-0] INFO  SQLDataSource - Deriving dataSource columnMeta from table: Column_meta
=== 2012-12-27 09:35:30,287 [l0-0] INFO  PoolManager - SmartClient pooling started for 'SQLServer' objects
=== 2012-12-27 09:35:30,296 [l0-0] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'SQLServer' from system config - using DriverManager:  com.microsoft.sqlserver.jdbc.SQLServerDriver
=== 2012-12-27 09:35:30,336 [l0-0] DEBUG PoolableSQLConnectionFactory - com.microsoft.sqlserver.jdbc.SQLServerDriver lookup successful
=== 2012-12-27 09:35:30,337 [l0-0] DEBUG PoolableSQLConnectionFactory - DriverManager fetching connection for SQLServer via jdbc url jdbc:sqlserver://192.168.1.156:1433;DatabaseName=AC_new;User=sa;Password=sasa
=== 2012-12-27 09:35:30,337 [l0-0] DEBUG PoolableSQLConnectionFactory - Passing JDBC URL only to getConnection
=== 2012-12-27 09:35:30,718 [l0-6] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/skin_styles.css', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:30,720 [l0-6] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/skin_styles.css
=== 2012-12-27 09:35:30,726 [l0-6] INFO  Compression - /register/sc/skins/Enterprise/skin_styles.css: 212163 -> 17048 bytes
=== 2012-12-27 09:35:30,748 [l0-0] DEBUG PoolableSQLConnectionFactory - makeObject() created a pooled Connection '463149067'
=== 2012-12-27 09:35:30,753 [l0-0] DEBUG SQLConnectionManager - Returning borrowed connection '463149067'
=== 2012-12-27 09:35:30,756 [l0-0] INFO  SQLDSGenerator - Fetching column metadata for table: Column_meta
=== 2012-12-27 09:35:30,756 [l0-0] INFO  SQLDSGenerator - =============Using catalog: AC_new
=== 2012-12-27 09:35:30,855 [l0-0] INFO  SQLDSGenerator - Fetching column metadata for Column_meta complete
=== 2012-12-27 09:35:30,861 [l0-0] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "463149067"
=== 2012-12-27 09:35:30,880 [l0-0] DEBUG XML - Parsed XML from C:\Users\usus\workspace\register\war\ds\biViewObj.ds.xml: 3ms
=== 2012-12-27 09:35:30,894 [l0-0] DEBUG XML - Parsed XML from C:\Users\usus\workspace\register\war\register\sc\system\schema\OperationBinding.ds.xml: 4ms
=== 2012-12-27 09:35:30,904 [l0-0] INFO  SQLDataSource - Deriving dataSource biViewObj from table: BI_view_obj
=== 2012-12-27 09:35:30,905 [l0-0] DEBUG SQLConnectionManager - Returning borrowed connection '463149067'
=== 2012-12-27 09:35:30,905 [l0-0] INFO  SQLDSGenerator - Fetching column metadata for table: BI_view_obj
=== 2012-12-27 09:35:30,905 [l0-0] INFO  SQLDSGenerator - =============Using catalog: AC_new
=== 2012-12-27 09:35:30,926 [l0-0] INFO  SQLDSGenerator - Fetching column metadata for BI_view_obj complete
=== 2012-12-27 09:35:30,929 [l0-0] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "463149067"
=== 2012-12-27 09:35:30,985 [l0-0] INFO  RequestContext - URL: '/register/hosted.html', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:30,989 [l0-0] INFO  Compression - /register/hosted.html: 11757 -> 4187 bytes
=== 2012-12-27 09:35:31,004 [l0-6] INFO  RequestContext - URL: '/register/gwt/clean/clean.css', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:31,010 [l0-6] INFO  Compression - /register/gwt/clean/clean.css: 29306 -> 4257 bytes
=== 2012-12-27 09:35:43,540 [l0-6] INFO  RequestContext - URL: '/register/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:43,549 [l0-6] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:50879
=== 2012-12-27 09:35:43,551 [l0-6] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:50879/Register.html?gwt.codesvr=127.0.0.1:50875
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Cookie:GLog=%7B%0D%20%20%20%20left%3A43%2C%20%0D%20%20%20%20top%3A44%2C%20%0D%20%20%20%20width%3A767%2C%20%0D%20%20%20%20height%3A480%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Anull%0D%7D; isc_cState=ready; JSESSIONID=17i79s0lscqm
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Content-Length:1016
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - session exists: null
=== 2012-12-27 09:35:43,552 [l0-6] DEBUG IDACall - remote user: null
=== 2012-12-27 09:35:43,571 [l0-6] DEBUG XML - Parsed XML from (in memory stream): 5ms
=== 2012-12-27 09:35:43,579 [l0-6] DEBUG XML - Parsed XML from C:\Users\usus\workspace\register\war\register\sc\system\schema\List.ds.xml: 6ms
=== 2012-12-27 09:35:43,583 [l0-6] DEBUG RPCManager - Processing 1 requests.
=== 2012-12-27 09:35:43,595 [l0-6] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
    },
    operationConfig:{
        dataSource:"columnMeta",
        operationType:"fetch",
        textMatchStyle:"substring"
    },
    startRow:0,
    endRow:75,
    componentId:"isc_ListGrid_0",
    appID:"builtinApplication",
    operation:"columnMeta_fetch",
    oldValues:{
    }
}
=== 2012-12-27 09:35:43,602 [l0-6] INFO  IDACall - Performing 1 operation(s)
=== 2012-12-27 09:35:43,602 [l0-6] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2012-12-27 09:35:43,602 [l0-6] DEBUG DeclarativeSecurity - DataSource columnMeta is not in the pre-checked list, processing...
=== 2012-12-27 09:35:43,612 [l0-6] DEBUG AppBase - [builtinApplication.columnMeta_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-12-27 09:35:43,613 [l0-6] DEBUG AppBase - [builtinApplication.columnMeta_fetch] No public zero-argument method named '_columnMeta_fetch' found, performing generic datasource operation
=== 2012-12-27 09:35:43,613 [l0-6] INFO  SQLDataSource - [builtinApplication.columnMeta_fetch] Performing fetch operation with
	criteria: {}	values: {}
=== 2012-12-27 09:35:43,623 [l0-6] INFO  SQLWhereClause - [builtinApplication.columnMeta_fetch] empty condition
=== 2012-12-27 09:35:43,625 [l0-6] INFO  SQLDataSource - [builtinApplication.columnMeta_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-12-27 09:35:43,858 [l0-0] INFO  RequestContext - URL: '/favicon.ico', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:43,865 [l0-0] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/blank.gif', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:43,869 [l0-0] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/blank.gif
=== 2012-12-27 09:35:43,871 [l0-0] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/RecordEditor/filter.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:43,874 [l0-0] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/RecordEditor/filter.png
=== 2012-12-27 09:35:43,876 [l0-0] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/loadingSmall.gif', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:43,878 [l0-0] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/loadingSmall.gif
=== 2012-12-27 09:35:43,943 [l0-6] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause
=== 2012-12-27 09:35:43,943 [l0-6] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] Eval'd row count query: SELECT COUNT(*) FROM dbo.Column_meta WHERE ('1'='1')
=== 2012-12-27 09:35:43,944 [l0-6] DEBUG SQLConnectionManager - [builtinApplication.columnMeta_fetch] Returning borrowed connection '463149067'
=== 2012-12-27 09:35:43,944 [l0-6] DEBUG SQLDriver - [builtinApplication.columnMeta_fetch] About to execute SQL query in 'SQLServer' using connection '463149067'
=== 2012-12-27 09:35:43,944 [l0-6] INFO  SQLDriver - [builtinApplication.columnMeta_fetch] Executing SQL query on 'SQLServer': SELECT COUNT(*) FROM dbo.Column_meta WHERE ('1'='1')
=== 2012-12-27 09:35:43,951 [l0-6] DEBUG PoolableSQLConnectionFactory - [builtinApplication.columnMeta_fetch] DriverManager fetching connection for SQLServer via jdbc url jdbc:sqlserver://192.168.1.156:1433;DatabaseName=AC_new;User=sa;Password=sasa
=== 2012-12-27 09:35:43,951 [l0-6] DEBUG PoolableSQLConnectionFactory - [builtinApplication.columnMeta_fetch] Passing JDBC URL only to getConnection
=== 2012-12-27 09:35:43,961 [l0-6] DEBUG SQLConnectionManager - [builtinApplication.columnMeta_fetch] Returning borrowed UNPOOLED connection '211655368'
=== 2012-12-27 09:35:43,961 [l0-6] DEBUG SQLServerDriver - [builtinApplication.columnMeta_fetch] SQL Server version is '10.50.1600'
=== 2012-12-27 09:35:43,961 [l0-6] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] Using SQL Limit query
=== 2012-12-27 09:35:43,962 [l0-6] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] Using PK as default sorter: id
=== 2012-12-27 09:35:43,962 [l0-6] DEBUG SQLServerDriver - [builtinApplication.columnMeta_fetch] Using PK as default sorter: com.isomorphic.sql.SQLOrderClause@7a48d6ee
=== 2012-12-27 09:35:43,963 [l0-6] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] SQL windowed select rows 0->75, result size 75. Query: SELECT * FROM (SELECT *, ROW_NUMBER() OVER (ORDER BY x.id) AS rowID FROM (SELECT TOP 100 PERCENT  Column_meta.IgnoreData, Column_meta.IsRegistr, Column_meta.Name, Column_meta.TP, Column_meta.Typ_id, Column_meta.fullnamekz, Column_meta.fullnamer, Column_meta.id, Column_meta.namekz, Column_meta.namer FROM dbo.Column_meta WHERE ('1'='1')) x) y WHERE y.rowID BETWEEN 1 AND 75
=== 2012-12-27 09:35:43,963 [l0-6] DEBUG SQLConnectionManager - [builtinApplication.columnMeta_fetch] Returning borrowed connection '463149067'
=== 2012-12-27 09:35:43,984 [l0-6] INFO  DSResponse - [builtinApplication.columnMeta_fetch] DSResponse: List with 75 items
=== 2012-12-27 09:35:43,984 [l0-6] DEBUG SQLConnectionManager - [builtinApplication.columnMeta_fetch] About to close PoolableConnection with hashcode "463149067"
=== 2012-12-27 09:35:43,984 [l0-6] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "463149067"
=== 2012-12-27 09:35:43,984 [l0-6] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-12-27 09:35:43,986 [l0-6] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2012-12-27 09:35:43,999 [l0-6] INFO  Compression - /register/sc/IDACall: 25719 -> 5217 bytes
=== 2012-12-27 09:35:45,301 [l0-6] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/Scrollbar/vscroll_start.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:45,303 [l0-6] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vscroll_start.png
=== 2012-12-27 09:35:45,305 [l0-0] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/Scrollbar/vthumb_grip.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:45,309 [l0-0] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vthumb_grip.png
=== 2012-12-27 09:35:45,307 [l0-5] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/Scrollbar/vscroll_track.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:45,312 [l0-5] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vscroll_track.png
=== 2012-12-27 09:35:45,307 [l0-2] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/Scrollbar/vscroll_end.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:45,314 [l0-2] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vscroll_end.png
=== 2012-12-27 09:35:53,426 [l0-2] INFO  RequestContext - URL: '/register/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:53,427 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:50879
=== 2012-12-27 09:35:53,545 [l0-2] DEBUG IDACall - Header Name:Value pair: User-Agent:Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0
=== 2012-12-27 09:35:53,545 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2012-12-27 09:35:53,545 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5
=== 2012-12-27 09:35:53,545 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:50879/Register.html?gwt.codesvr=127.0.0.1:50875
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - Header Name:Value pair: Cookie:GLog=%7B%0D%20%20%20%20left%3A43%2C%20%0D%20%20%20%20top%3A44%2C%20%0D%20%20%20%20width%3A767%2C%20%0D%20%20%20%20height%3A480%2C%20%0D%20%20%20%20priorityDefaults%3A%7B%0D%20%20%20%20%20%20%20%20Log%3A4%0D%20%20%20%20%7D%2C%20%0D%20%20%20%20defaultPriority%3A3%2C%20%0D%20%20%20%20trackRPC%3Anull%0D%7D; isc_cState=ready; JSESSIONID=8q8yzctlfl66
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:943
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - session exists: 8q8yzctlfl66
=== 2012-12-27 09:35:53,552 [l0-2] DEBUG IDACall - remote user: null
=== 2012-12-27 09:35:53,555 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 2ms
=== 2012-12-27 09:35:53,563 [l0-2] DEBUG RPCManager - Processing 1 requests.
=== 2012-12-27 09:35:53,565 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
    criteria:{
        typ_id:"15"
    },
    operationConfig:{
        dataSource:"biViewObj",
        operationType:"fetch",
        textMatchStyle:"exact"
    },
    componentId:"isc_TreeGrid_0",
    appID:"builtinApplication",
    operation:"biViewObj_fetch",
    oldValues:{
        typ_id:"15"
    }
}
=== 2012-12-27 09:35:53,566 [l0-2] INFO  IDACall - Performing 1 operation(s)
=== 2012-12-27 09:35:53,567 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null
=== 2012-12-27 09:35:53,568 [l0-2] DEBUG DeclarativeSecurity - DataSource biViewObj is not in the pre-checked list, processing...
=== 2012-12-27 09:35:53,568 [l0-2] DEBUG AppBase - [builtinApplication.biViewObj_fetch] No userTypes defined, allowing anyone access to all operations for this application
=== 2012-12-27 09:35:53,569 [l0-2] DEBUG AppBase - [builtinApplication.biViewObj_fetch] No public zero-argument method named '_biViewObj_fetch' found, performing generic datasource operation
=== 2012-12-27 09:35:53,569 [l0-2] INFO  SQLDataSource - [builtinApplication.biViewObj_fetch] Performing fetch operation with
	criteria: {typ_id:"15"}	values: {typ_id:"15"}
=== 2012-12-27 09:35:53,581 [l0-2] INFO  SQLDataSource - [builtinApplication.biViewObj_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE BI_view_obj.typ_base = $criteria.typ_id
=== 2012-12-27 09:35:53,589 [l0-2] INFO  SQLDataSource - [builtinApplication.biViewObj_fetch] Executing SQL query on 'SQLServer': SELECT BI_view_obj.ID, BI_view_obj.Measure, BI_view_obj.class_version_id, BI_view_obj.dbeg, BI_view_obj.dend, BI_view_obj.full_cod, BI_view_obj.fullname, BI_view_obj.fullnamekz, BI_view_obj.lev, BI_view_obj.level_code, BI_view_obj.ms_name, BI_view_obj.ms_namekz, BI_view_obj.obj_base, BI_view_obj.obj_ver, BI_view_obj.otrasl, BI_view_obj.par_id, BI_view_obj.par_obj_base, BI_view_obj.tree_id, BI_view_obj.tree_name, BI_view_obj.tree_namekz, BI_view_obj.typ_base, BI_view_obj.typ_name, BI_view_obj.typ_ver, BI_view_obj.typreln_version FROM dbo.BI_view_obj WHERE BI_view_obj.typ_base = '15'
=== 2012-12-27 09:35:53,590 [l0-2] DEBUG SQLConnectionManager - [builtinApplication.biViewObj_fetch] Returning borrowed connection '463149067'
=== 2012-12-27 09:35:53,590 [l0-2] DEBUG SQLDriver - [builtinApplication.biViewObj_fetch] About to execute SQL query in 'SQLServer' using connection '463149067'
=== 2012-12-27 09:35:53,591 [l0-2] INFO  SQLDriver - [builtinApplication.biViewObj_fetch] Executing SQL query on 'SQLServer': SELECT BI_view_obj.ID, BI_view_obj.Measure, BI_view_obj.class_version_id, BI_view_obj.dbeg, BI_view_obj.dend, BI_view_obj.full_cod, BI_view_obj.fullname, BI_view_obj.fullnamekz, BI_view_obj.lev, BI_view_obj.level_code, BI_view_obj.ms_name, BI_view_obj.ms_namekz, BI_view_obj.obj_base, BI_view_obj.obj_ver, BI_view_obj.otrasl, BI_view_obj.par_id, BI_view_obj.par_obj_base, BI_view_obj.tree_id, BI_view_obj.tree_name, BI_view_obj.tree_namekz, BI_view_obj.typ_base, BI_view_obj.typ_name, BI_view_obj.typ_ver, BI_view_obj.typreln_version FROM dbo.BI_view_obj WHERE BI_view_obj.typ_base = '15'
=== 2012-12-27 09:35:53,628 [l0-2] INFO  DSResponse - [builtinApplication.biViewObj_fetch] DSResponse: List with 45 items
=== 2012-12-27 09:35:53,628 [l0-2] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "463149067"
=== 2012-12-27 09:35:53,628 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2012-12-27 09:35:53,630 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: true
=== 2012-12-27 09:35:54,177 [l0-2] INFO  Compression - /register/sc/IDACall: 20818 -> 2573 bytes
=== 2012-12-27 09:35:54,404 [l0-2] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/TreeGrid/opener_closed.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:54,406 [l0-2] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/TreeGrid/opener_closed.png
=== 2012-12-27 09:35:54,409 [l0-2] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/TreeGrid/folder_closed.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:54,412 [l0-2] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/TreeGrid/folder_closed.png
=== 2012-12-27 09:35:54,413 [l0-5] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/TreeGrid/file.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:35:54,416 [l0-5] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/TreeGrid/file.png
=== 2012-12-27 09:37:26,251 [l0-5] INFO  RequestContext - URL: '/register/sc/skins/Enterprise/images/ListGrid/sort_descending.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:16.0) Gecko/20100101 Firefox/16.0': Moz (Gecko) with Accept-Encoding header
=== 2012-12-27 09:37:26,254 [l0-5] INFO  Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/ListGrid/sort_descending.png