=== 2012-12-27 12:11:03,682 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/RecordEditor/filter.png === 2012-12-27 12:11:03,673 [l0-2] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/loadingSmall.gif === 2012-12-27 12:11:03,688 [l0-5] INFO IDACall - Performing 1 operation(s) === 2012-12-27 12:11:03,688 [l0-5] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2012-12-27 12:11:03,688 [l0-5] DEBUG DeclarativeSecurity - DataSource columnMeta is not in the pre-checked list, processing... === 2012-12-27 12:11:03,699 [l0-5] DEBUG AppBase - [builtinApplication.columnMeta_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2012-12-27 12:11:03,700 [l0-5] DEBUG AppBase - [builtinApplication.columnMeta_fetch] No public zero-argument method named '_columnMeta_fetch' found, performing generic datasource operation === 2012-12-27 12:11:03,713 [l0-5] INFO SQLDataSource - [builtinApplication.columnMeta_fetch] Performing fetch operation with criteria: {} values: {} === 2012-12-27 12:11:03,724 [l0-5] INFO SQLWhereClause - [builtinApplication.columnMeta_fetch] empty condition === 2012-12-27 12:11:03,725 [l0-5] INFO SQLDataSource - [builtinApplication.columnMeta_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2012-12-27 12:11:03,895 [l0-5] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause === 2012-12-27 12:11:03,896 [l0-5] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] Eval'd row count query: SELECT COUNT(*) FROM dbo.Column_meta WHERE ('1'='1') === 2012-12-27 12:11:03,896 [l0-5] DEBUG SQLConnectionManager - [builtinApplication.columnMeta_fetch] Returning borrowed connection '509147697' === 2012-12-27 12:11:03,896 [l0-5] DEBUG SQLDriver - [builtinApplication.columnMeta_fetch] About to execute SQL query in 'SQLServer' using connection '509147697' === 2012-12-27 12:11:03,896 [l0-5] INFO SQLDriver - [builtinApplication.columnMeta_fetch] Executing SQL query on 'SQLServer': SELECT COUNT(*) FROM dbo.Column_meta WHERE ('1'='1') === 2012-12-27 12:11:03,902 [l0-5] 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 12:11:03,902 [l0-5] DEBUG PoolableSQLConnectionFactory - [builtinApplication.columnMeta_fetch] Passing JDBC URL only to getConnection === 2012-12-27 12:11:03,924 [l0-5] DEBUG SQLConnectionManager - [builtinApplication.columnMeta_fetch] Returning borrowed UNPOOLED connection '494360698' === 2012-12-27 12:11:03,925 [l0-5] DEBUG SQLServerDriver - [builtinApplication.columnMeta_fetch] SQL Server version is '10.50.1600' === 2012-12-27 12:11:03,925 [l0-5] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] Using SQL Limit query === 2012-12-27 12:11:03,926 [l0-5] DEBUG SQLDataSource - [builtinApplication.columnMeta_fetch] Using PK as default sorter: id === 2012-12-27 12:11:03,926 [l0-5] DEBUG SQLServerDriver - [builtinApplication.columnMeta_fetch] Using PK as default sorter: com.isomorphic.sql.SQLOrderClause@61422b02 === 2012-12-27 12:11:03,926 [l0-5] 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 12:11:03,926 [l0-5] DEBUG SQLConnectionManager - [builtinApplication.columnMeta_fetch] Returning borrowed connection '509147697' === 2012-12-27 12:11:03,949 [l0-5] INFO DSResponse - [builtinApplication.columnMeta_fetch] DSResponse: List with 75 items === 2012-12-27 12:11:03,950 [l0-5] DEBUG SQLConnectionManager - [builtinApplication.columnMeta_fetch] About to close PoolableConnection with hashcode "509147697" === 2012-12-27 12:11:03,950 [l0-5] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "509147697" === 2012-12-27 12:11:03,950 [l0-5] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2012-12-27 12:11:03,952 [l0-5] DEBUG RPCManager - non-DMI response, dropExtraFields: false === 2012-12-27 12:11:03,967 [l0-5] INFO Compression - /register/sc/IDACall: 25719 -> 5217 bytes === 2012-12-27 12:11:05,283 [l0-5] 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 12:11:05,287 [l0-2] 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 12:11:05,287 [l0-5] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vscroll_start.png === 2012-12-27 12:11:05,291 [l0-2] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vscroll_track.png === 2012-12-27 12:11:05,292 [l0-3] 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 12:11:05,297 [l0-3] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vscroll_end.png === 2012-12-27 12:11:05,299 [l0-4] 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 12:11:05,301 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vthumb_grip.png === 2012-12-27 12:11:26,314 [l0-4] 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 12:11:26,314 [l0-4] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:52917 === 2012-12-27 12:11:26,314 [l0-4] 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 12:11:26,314 [l0-4] DEBUG IDACall - Header Name:Value pair: Accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8 === 2012-12-27 12:11:26,315 [l0-4] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5 === 2012-12-27 12:11:26,315 [l0-4] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate === 2012-12-27 12:11:26,315 [l0-4] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive === 2012-12-27 12:11:26,315 [l0-4] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:52917/Register.html?gwt.codesvr=127.0.0.1:52913 === 2012-12-27 12:11:26,315 [l0-4] 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=11uexcz7zbxjm === 2012-12-27 12:11:26,318 [l0-4] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8 === 2012-12-27 12:11:26,318 [l0-4] DEBUG IDACall - Header Name:Value pair: Content-Length:943 === 2012-12-27 12:11:26,318 [l0-4] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache === 2012-12-27 12:11:26,319 [l0-4] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache === 2012-12-27 12:11:26,319 [l0-4] DEBUG IDACall - session exists: 11uexcz7zbxjm === 2012-12-27 12:11:26,319 [l0-4] DEBUG IDACall - remote user: null === 2012-12-27 12:11:26,324 [l0-4] DEBUG XML - Parsed XML from (in memory stream): 4ms === 2012-12-27 12:11:26,330 [l0-4] DEBUG RPCManager - Processing 1 requests. === 2012-12-27 12:11:26,333 [l0-4] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ typ_id:"17" }, operationConfig:{ dataSource:"biViewObj", operationType:"fetch", textMatchStyle:"exact" }, componentId:"isc_TreeGrid_0", appID:"builtinApplication", operation:"biViewObj_fetch", oldValues:{ typ_id:"17" } } === 2012-12-27 12:11:26,333 [l0-4] INFO IDACall - Performing 1 operation(s) === 2012-12-27 12:11:26,408 [l0-4] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2012-12-27 12:11:26,409 [l0-4] DEBUG DeclarativeSecurity - DataSource biViewObj is not in the pre-checked list, processing... === 2012-12-27 12:11:26,409 [l0-4] DEBUG AppBase - [builtinApplication.biViewObj_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2012-12-27 12:11:26,409 [l0-4] DEBUG AppBase - [builtinApplication.biViewObj_fetch] No public zero-argument method named '_biViewObj_fetch' found, performing generic datasource operation === 2012-12-27 12:11:26,410 [l0-4] INFO SQLDataSource - [builtinApplication.biViewObj_fetch] Performing fetch operation with criteria: {typ_id:"17"} values: {typ_id:"17"} === 2012-12-27 12:11:26,411 [l0-4] INFO SQLDataSource - [builtinApplication.biViewObj_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE BI_view_obj.typ_base = $criteria.typ_id === 2012-12-27 12:11:26,420 [l0-4] 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 = '17' === 2012-12-27 12:11:26,420 [l0-4] DEBUG SQLConnectionManager - [builtinApplication.biViewObj_fetch] Returning borrowed connection '509147697' === 2012-12-27 12:11:26,420 [l0-4] DEBUG SQLDriver - [builtinApplication.biViewObj_fetch] About to execute SQL query in 'SQLServer' using connection '509147697' === 2012-12-27 12:11:26,421 [l0-4] 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 = '17' === 2012-12-27 12:11:26,583 [l0-4] INFO DSResponse - [builtinApplication.biViewObj_fetch] DSResponse: List with 5 items === 2012-12-27 12:11:26,584 [l0-4] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "509147697" === 2012-12-27 12:11:26,584 [l0-4] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2012-12-27 12:11:26,586 [l0-4] DEBUG RPCManager - non-DMI response, dropExtraFields: true === 2012-12-27 12:11:26,590 [l0-4] INFO Compression - /register/sc/IDACall: 2563 -> 654 bytes === 2012-12-27 12:11:26,976 [l0-4] 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 12:11:26,980 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/TreeGrid/opener_closed.png === 2012-12-27 12:11:26,985 [l0-3] 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 12:11:26,988 [l0-3] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/TreeGrid/folder_closed.png === 2012-12-27 12:11:28,402 [l0-3] INFO RequestContext - URL: '/register/sc/skins/Enterprise/images/TreeGrid/opener_opened.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 12:11:28,405 [l0-3] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/TreeGrid/opener_opened.png === 2012-12-27 12:11:28,407 [l0-4] INFO RequestContext - URL: '/register/sc/skins/Enterprise/images/TreeGrid/folder_open.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 12:11:28,410 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/TreeGrid/folder_open.png === 2012-12-27 12:11:28,421 [l0-2] 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 12:11:28,424 [l0-2] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/TreeGrid/file.png === 2012-12-27 12:11:29,613 [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 12:11:29,613 [l0-2] DEBUG IDACall - Header Name:Value pair: Host:127.0.0.1:52917 === 2012-12-27 12:11:29,613 [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 12:11:29,613 [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 12:11:29,614 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Language:en-US,en;q=0.5 === 2012-12-27 12:11:29,614 [l0-2] DEBUG IDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate === 2012-12-27 12:11:29,615 [l0-2] DEBUG IDACall - Header Name:Value pair: Connection:keep-alive === 2012-12-27 12:11:29,615 [l0-2] DEBUG IDACall - Header Name:Value pair: Referer:http://127.0.0.1:52917/Register.html?gwt.codesvr=127.0.0.1:52913 === 2012-12-27 12:11:29,615 [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=11uexcz7zbxjm === 2012-12-27 12:11:29,619 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Type:application/x-www-form-urlencoded; charset=UTF-8 === 2012-12-27 12:11:29,619 [l0-2] DEBUG IDACall - Header Name:Value pair: Content-Length:1026 === 2012-12-27 12:11:29,619 [l0-2] DEBUG IDACall - Header Name:Value pair: Pragma:no-cache === 2012-12-27 12:11:29,619 [l0-2] DEBUG IDACall - Header Name:Value pair: Cache-Control:no-cache === 2012-12-27 12:11:29,619 [l0-2] DEBUG IDACall - session exists: 11uexcz7zbxjm === 2012-12-27 12:11:29,619 [l0-2] DEBUG IDACall - remote user: null === 2012-12-27 12:11:29,624 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 3ms === 2012-12-27 12:11:29,626 [l0-2] DEBUG RPCManager - Processing 1 requests. === 2012-12-27 12:11:29,628 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ }, operationConfig:{ dataSource:"fillPropertObj", operationType:"fetch", textMatchStyle:"substring" }, startRow:0, endRow:1000, componentId:"isc_ListGrid_1", appID:"builtinApplication", operation:"fillPropertObj_fetch", oldValues:{ } } === 2012-12-27 12:11:29,628 [l0-2] INFO IDACall - Performing 1 operation(s) === 2012-12-27 12:11:29,628 [l0-2] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2012-12-27 12:11:29,628 [l0-2] DEBUG DeclarativeSecurity - DataSource fillPropertObj is not in the pre-checked list, processing... === 2012-12-27 12:11:29,628 [l0-2] DEBUG AppBase - [builtinApplication.fillPropertObj_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2012-12-27 12:11:29,628 [l0-2] DEBUG AppBase - [builtinApplication.fillPropertObj_fetch] No public zero-argument method named '_fillPropertObj_fetch' found, performing generic datasource operation === 2012-12-27 12:11:29,629 [l0-2] INFO SQLDataSource - [builtinApplication.fillPropertObj_fetch] Performing fetch operation with criteria: {} values: {} === 2012-12-27 12:11:29,629 [l0-2] WARN SQLSelectClause - [builtinApplication.fillPropertObj_fetch] SQLSelectClause is null or zero size, remap and conversions won't work! === 2012-12-27 12:11:29,629 [l0-2] INFO SQLWhereClause - [builtinApplication.fillPropertObj_fetch] empty condition === 2012-12-27 12:11:29,629 [l0-2] INFO SQLDataSource - [builtinApplication.fillPropertObj_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2012-12-27 12:11:29,629 [l0-2] DEBUG SQLDataSource - [builtinApplication.fillPropertObj_fetch] Executing row count query: SELECT COUNT(*) FROM $defaultTableClause WHERE $defaultWhereClause === 2012-12-27 12:11:29,630 [l0-2] DEBUG SQLDataSource - [builtinApplication.fillPropertObj_fetch] Eval'd row count query: SELECT COUNT(*) FROM dbo.fillPropertObj WHERE ('1'='1') === 2012-12-27 12:11:29,630 [l0-2] DEBUG SQLConnectionManager - [builtinApplication.fillPropertObj_fetch] Returning borrowed connection '509147697' === 2012-12-27 12:11:29,630 [l0-2] DEBUG SQLDriver - [builtinApplication.fillPropertObj_fetch] About to execute SQL query in 'SQLServer' using connection '509147697' === 2012-12-27 12:11:29,630 [l0-2] INFO SQLDriver - [builtinApplication.fillPropertObj_fetch] Executing SQL query on 'SQLServer': SELECT COUNT(*) FROM dbo.fillPropertObj WHERE ('1'='1') === 2012-12-27 12:11:29,633 [l0-2] INFO SQLDriver - [builtinApplication.fillPropertObj_fetch] Execute of select: SELECT COUNT(*) FROM dbo.fillPropertObj WHERE ('1'='1') on db: SQLServer threw exception: com.microsoft.sqlserver.jdbc.SQLServerException: Недопустимое имя объекта "dbo.fillPropertObj". - assuming stale connection and retrying query. === 2012-12-27 12:11:29,633 [l0-2] DEBUG SQLConnectionManager - [builtinApplication.fillPropertObj_fetch] About to close PoolableConnection with hashcode "509147697" === 2012-12-27 12:11:29,634 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.fillPropertObj_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 12:11:29,634 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.fillPropertObj_fetch] Passing JDBC URL only to getConnection === 2012-12-27 12:11:29,644 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.fillPropertObj_fetch] makeObject() created a pooled Connection '2114222846' === 2012-12-27 12:11:29,645 [l0-2] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "2114222846" === 2012-12-27 12:11:29,646 [l0-2] WARN RequestContext - dsRequest.execute() failed: com.microsoft.sqlserver.jdbc.SQLServerException: Недопустимое имя объекта "dbo.fillPropertObj". at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDatabaseError(SQLServerException.java:196) at com.microsoft.sqlserver.jdbc.SQLServerStatement.getNextResult(SQLServerStatement.java:1454) at com.microsoft.sqlserver.jdbc.SQLServerStatement.doExecuteStatement(SQLServerStatement.java:786) at com.microsoft.sqlserver.jdbc.SQLServerStatement$StmtExecCmd.doExecute(SQLServerStatement.java:685) at com.microsoft.sqlserver.jdbc.TDSCommand.execute(IOBuffer.java:4026) at com.microsoft.sqlserver.jdbc.SQLServerConnection.executeCommand(SQLServerConnection.java:1416) at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeCommand(SQLServerStatement.java:185) at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeStatement(SQLServerStatement.java:160) at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeQuery(SQLServerStatement.java:620) at org.apache.commons.dbcp.DelegatingStatement.executeQuery(DelegatingStatement.java:208) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:592) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:493) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:486) at com.isomorphic.sql.SQLDriver.getScalarResult(SQLDriver.java:637) at com.isomorphic.sql.SQLDriver.executeScalar(SQLDriver.java:855) at com.isomorphic.sql.SQLDataSource.executeWindowedSelect(SQLDataSource.java:1714) at com.isomorphic.sql.SQLDataSource.SQLExecute(SQLDataSource.java:1389) 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:2017) 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) === 2012-12-27 12:11:29,648 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2012-12-27 12:11:29,649 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false === 2012-12-27 12:11:29,650 [l0-2] INFO Compression - /register/sc/IDACall: 191 -> 178 bytes === 2012-12-27 12:11:29,881 [l0-2] INFO RequestContext - URL: '/register/sc/skins/Enterprise/images/Dialog/warn.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 12:11:29,885 [l0-2] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Dialog/warn.png === 2012-12-27 12:11:29,982 [l0-4] INFO RequestContext - URL: '/register/sc/skins/Enterprise/images/headerIcons/close.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 12:11:29,985 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/headerIcons/close.png === 2012-12-27 12:11:30,965 [l0-4] INFO RequestContext - URL: '/register/sc/skins/Enterprise/images/Scrollbar/vscroll_Over_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 12:11:30,970 [l0-4] INFO Download - done streaming: C:/Users/usus/workspace/register/war/register/sc/skins/Enterprise/images/Scrollbar/vscroll_Over_track.png