2017-04-11 20:06:30,797 DEBUG [com.isomorphic.pool.ISCKeyedObjectPool] - Borrowing object for 'Object' 2017-04-11 20:06:30,797 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Created DataSource 92 of type 'Object' and assigned it to thread http-bio-8080-exec-5 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Created DataSource 92 of type 'Object' in the pooling flow 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Activated DataSource 92 of type 'Object' 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.BasicDataSource] - Validating a 'Object' at path '' 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.xsi: value is: http://www.w3.org/2000/10/XMLSchema-instance 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/transactionNum as Object.transactionNum type: long 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.pool.ISCKeyedObjectPool] - Borrowing object for 'List' 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.store.DataStructCache] - getInstanceFile (success): 'List' instance of datasources: 0ms 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.BasicDataSource] - Using class com.isomorphic.datasource.ListType as implementer for DataSource List 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Created DataSource 93 of type 'List' and assigned it to thread http-bio-8080-exec-5 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Created DataSource 93 of type 'List' in the pooling flow 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Activated DataSource 93 of type 'List' 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/operations as Object.operations type: List 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.pool.ISCKeyedObjectPool] - Borrowing object for 'elem' 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.store.DataStructCache] - getInstanceFile (failure): 'elem' instance of datasources: 0ms 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Tried to create DataSource of type 'elem' but null was returned 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Created DataSource null of type 'elem' in the pooling flow 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.BasicDataSource] - Validating a 'Object' at path '/transaction/operations' 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/operations/elem/criteria as Object.criteria type: Object 2017-04-11 20:06:30,799 DEBUG [com.isomorphic.datasource.BasicDataSource] - Validating a 'Object' at path '/transaction/operations/elem/criteria' 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/operations/elem/criteria/criteria/RequestUserID as Object.RequestUserID type: long 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.RequestStartDate: value is: 2017-01-01 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.RequestEndDate: value is: 2017-01-31 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/operations/elem/criteria/criteria/RequestManagerID as Object.RequestManagerID type: long 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.BasicDataSource] - Done validating a 'Object' at path '/transaction/operations/elem/criteria': 1ms 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/operations/elem/operationConfig as Object.operationConfig type: Object 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.BasicDataSource] - Validating a 'Object' at path '/transaction/operations/elem/operationConfig' 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.dataSource: value is: accounts 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.operationType: value is: fetch 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.textMatchStyle: value is: exact 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.BasicDataSource] - Done validating a 'Object' at path '/transaction/operations/elem/operationConfig': 0ms 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.componentId: value is: isc_ListGrid_0 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.appID: value is: builtinApplication 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.operation: value is: accounts_fetch 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/operations/elem/oldValues as Object.oldValues type: Object 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.BasicDataSource] - Validating a 'Object' at path '/transaction/operations/elem/oldValues' 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/operations/elem/oldValues/oldValues/RequestUserID as Object.RequestUserID type: long 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.RequestStartDate: value is: 2017-01-01 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Value provided for unknown field: Object.RequestEndDate: value is: 2017-01-31 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.validation.Validation] - Validating field: /transaction/operations/elem/oldValues/oldValues/RequestManagerID as Object.RequestManagerID type: long 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.BasicDataSource] - Done validating a 'Object' at path '/transaction/operations/elem/oldValues': 0ms 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.BasicDataSource] - Done validating a 'Object' at path '/transaction/operations': 1ms 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.BasicDataSource] - Done validating a 'List' at path '/transaction/operations': 1ms 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.BasicDataSource] - Done validating a 'Object' at path '': 1ms 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.timing.Timing] - DataSource record created from XML with document element: 'transaction': 4ms 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.rpc.RPCManager] - Processing 1 requests. 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.pool.ISCKeyedObjectPool] - Borrowing object for 'accounts' 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Activated DataSource 91 of type 'accounts' 2017-04-11 20:06:30,800 DEBUG [com.isomorphic.datasource.DSRequest] - Caching instance 91 of DS 'accounts' from DSRequest.getDataSource() 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.DSRequest] - Caching instance 91 of DS accounts 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.timing.Timing] - Time to convert org.apache.commons.collections.map.LinkedMap to JS Object: 0ms 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.rpc.RPCManager] - Request #1 (DSRequest) payload: { criteria:{ RequestUserID:123, RequestStartDate:"2017-01-01", RequestEndDate:"2017-01-31", RequestManagerID:567 }, operationConfig:{ dataSource:"accounts", repo:null, operationType:"fetch", textMatchStyle:"exact" }, componentId:"isc_ListGrid_0", appID:"builtinApplication", operation:"accounts_fetch", oldValues:{ RequestUserID:123, RequestStartDate:"2017-01-01", RequestEndDate:"2017-01-31", RequestManagerID:567 } } 2017-04-11 20:06:30,801 INFO [com.isomorphic.servlet.IDACall] - Performing 1 operation(s) 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.pool.ISCKeyedObjectPool] - Borrowing object for 'users' 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.PoolableDataSourceFactory] - Activated DataSource 90 of type 'users' 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.Relation] - Caching instance of toDS 'users' in the DSRequest map 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.DeclarativeSecurity] - Processing security checks for DataSource null, field null 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.DeclarativeSecurity] - DataSource accounts is not in the pre-checked list, processing... 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.DeclarativeSecurity] - Processing security checks for DataSource users, field UserID 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.DeclarativeSecurity] - DataSource users is not in the pre-checked list, processing... 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.DeclarativeSecurity] - Processing security checks for DataSource users, field UserName 2017-04-11 20:06:30,801 DEBUG [com.isomorphic.datasource.DeclarativeSecurity] - DataSource users is not in the pre-checked list, processing... 2017-04-11 20:06:30,802 INFO [com.isomorphic.rpc.ServerObject] - DMI on Spring bean: accountService 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.interfaces.InterfaceProvider] - Instantiating com.isomorphic.spring.SpringBeanFactory to satisfy request for an ISpringBeanFactory 2017-04-11 20:06:30,802 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] - Returning cached instance of singleton bean 'accountService' 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.interfaces.InterfaceProvider] - Instantiating com.isomorphic.spring.SpringBeanFactory to satisfy request for an ISpringBeanFactory 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - adaptArgsAndInvoke: public com.isomorphic.datasource.DSResponse com.jsb.server.accounts.AccountServiceImpl.fetchAccounts(com.isomorphic.datasource.DSRequest) requiredArgs: [] optionalArgs: [com.isomorphic.servlet.RequestContext, javax.servlet.http.HttpServletRequest, javax.servlet.http.HttpServletResponse, javax.servlet.ServletContext, org.springframework.beans.factory.BeanFactory, org.springframework.context.ApplicationContext, javax.servlet.http.HttpSession, com.isomorphic.rpc.RPCManager, com.isomorphic.datasource.DSRequest, com.isomorphic.datasource.DataSource, java.sql.Connection, com.isomorphic.log.Logger, java.util.Map] 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: com.isomorphic.servlet.RequestContext fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: javax.servlet.http.HttpServletRequest fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: javax.servlet.http.HttpServletResponse fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: javax.servlet.ServletContext fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: org.springframework.beans.factory.BeanFactory fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: org.springframework.context.ApplicationContext fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: javax.servlet.http.HttpSession fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: com.isomorphic.rpc.RPCManager fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - checking whether type: com.isomorphic.datasource.DSRequest fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - Successfully adapted optional arg type: com.isomorphic.datasource.DSRequest to type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - method takes: 1 args. I've assembled: 1 args 2017-04-11 20:06:30,802 DEBUG [com.isomorphic.base.Reflection] - invoking method: com.isomorphic.datasource.DSResponse com.jsb.server.accounts.AccountServiceImpl.fetchAccounts(com.isomorphic.datasource.DSRequest) with arg types: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,802 INFO [com.jsb.server.accounts.AccountServiceImpl] - fetching accounts 2017-04-11 20:06:30,803 INFO [com.jsb.server.accounts.AccountServiceImpl] - returning 3 accounts 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.datasource.DeclarativeSecurity] - Processing security checks for DataSource null, field null 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.datasource.DeclarativeSecurity] - Request is not a client request, ignoring security checks. 2017-04-11 20:06:30,803 INFO [com.isomorphic.rpc.ServerObject] - DMI on Spring bean: accountService 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.interfaces.InterfaceProvider] - Instantiating com.isomorphic.spring.SpringBeanFactory to satisfy request for an ISpringBeanFactory 2017-04-11 20:06:30,803 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] - Returning cached instance of singleton bean 'accountService' 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.interfaces.InterfaceProvider] - Instantiating com.isomorphic.spring.SpringBeanFactory to satisfy request for an ISpringBeanFactory 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - adaptArgsAndInvoke: public com.isomorphic.datasource.DSResponse com.jsb.server.accounts.AccountServiceImpl.fetchUsers(com.isomorphic.datasource.DSRequest) requiredArgs: [] optionalArgs: [com.isomorphic.servlet.RequestContext, javax.servlet.http.HttpServletRequest, javax.servlet.http.HttpServletResponse, javax.servlet.ServletContext, org.springframework.beans.factory.BeanFactory, org.springframework.context.ApplicationContext, javax.servlet.http.HttpSession, com.isomorphic.rpc.RPCManager, com.isomorphic.datasource.DSRequest, com.isomorphic.datasource.DataSource, java.sql.Connection, com.isomorphic.log.Logger, java.util.Map] 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: com.isomorphic.servlet.RequestContext fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: javax.servlet.http.HttpServletRequest fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: javax.servlet.http.HttpServletResponse fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: javax.servlet.ServletContext fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: org.springframework.beans.factory.BeanFactory fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: org.springframework.context.ApplicationContext fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: javax.servlet.http.HttpSession fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: com.isomorphic.rpc.RPCManager fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - checking whether type: com.isomorphic.datasource.DSRequest fulfills type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,803 DEBUG [com.isomorphic.base.Reflection] - Successfully adapted optional arg type: com.isomorphic.datasource.DSRequest to type: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,804 DEBUG [com.isomorphic.base.Reflection] - method takes: 1 args. I've assembled: 1 args 2017-04-11 20:06:30,804 DEBUG [com.isomorphic.base.Reflection] - invoking method: com.isomorphic.datasource.DSResponse com.jsb.server.accounts.AccountServiceImpl.fetchUsers(com.isomorphic.datasource.DSRequest) with arg types: com.isomorphic.datasource.DSRequest 2017-04-11 20:06:30,804 INFO [com.jsb.server.accounts.AccountServiceImpl] - fetching users 2017-04-11 20:06:30,804 INFO [com.jsb.server.accounts.AccountServiceImpl] - returning 5 users 2017-04-11 20:06:30,804 INFO [com.isomorphic.datasource.DSResponse] - DSResponse: List with 5 items 2017-04-11 20:06:30,804 DEBUG [com.isomorphic.datasource.DSRequest] - About to free up resources for request of type fetch on DataSource users 2017-04-11 20:06:30,804 DEBUG [com.isomorphic.datasource.DSRequest] - Ignoring freeResources call because this is not a primary request! 2017-04-11 20:06:30,804 WARN [com.isomorphic.datasource.DSRequest] - In manual filter, we found filter values for which there is no corresponding field in the first record of the resultset. This may be expected, but it may be an indicator that you are not fetching all required fields - manual (ie, non-SQL) sort and filter can only work if you actually fetch the criteria and sortBy fields from the database. Affected fields: RequestUserID, RequestStartDate, RequestEndDate, RequestManagerID 2017-04-11 20:06:30,804 DEBUG [com.isomorphic.datasource.DSRequest] - About to free up resources for request of type fetch on DataSource accounts 2017-04-11 20:06:30,804 DEBUG [com.isomorphic.datasource.DSRequest] - Ignoring freeResources call because this is not a primary request! 2017-04-11 20:06:30,804 WARN [com.isomorphic.servlet.RequestContext] - dsRequest.execute() failed: java.lang.UnsupportedOperationException at java.util.AbstractList.remove(AbstractList.java:161) at java.util.AbstractList$Itr.remove(AbstractList.java:374) at com.isomorphic.datasource.DSRequest.applyManualFilterAndSort(DSRequest.java:6082) at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:2739) at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:230) at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:187) at com.isomorphic.servlet.IDACall.processRequest(IDACall.java:152) at com.isomorphic.servlet.IDACall._processRequest(IDACall.java:119) at com.isomorphic.servlet.IDACall.doPost(IDACall.java:79) at javax.servlet.http.HttpServlet.service(HttpServlet.java:650) at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:162) at javax.servlet.http.HttpServlet.service(HttpServlet.java:731) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208) at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208) at com.isomorphic.servlet.CompressionFilter._doFilter(CompressionFilter.java:260) at com.isomorphic.servlet.BaseFilter.doFilter(BaseFilter.java:88) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:505) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103) at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:956) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:423) at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1079) at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:625) at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:318) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) at java.lang.Thread.run(Thread.java:745) 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.servlet.RequestContext] - Setting headers to disable caching 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.rpc.RPCManager] - Content type for RPC transaction: text/plain; charset=UTF-8 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.servlet.RequestContext] - Getting output stream via servletResponse.getWriter() 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.servlet.ProxyHttpServletResponse] - Using charset: UTF-8 (CompressionFilter) 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.rpc.RPCManager] - non-DMI response, dropExtraFields: false 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.timing.Timing] - Time to convert java.util.ArrayList to JS Object: 0ms 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.datasource.DSRequest] - Ignoring freeQueueResources call because this is not a primary request! 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.datasource.DSRequest] - Ignoring freeQueueResources call because this is not a primary request! 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.datasource.DSRequest] - Ignoring freeResources call because they have already been freed 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.datasource.DSRequest] - Ignoring freeQueueResources call because they have already been freed 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.timing.Timing] - Request: /acc/com.jsb.Main/sc/IDACall (start->finish): 11ms 2017-04-11 20:06:30,805 DEBUG [com.isomorphic.compression.Compression] - /acc/com.jsb.Main/sc/IDACall: Using upstream-specified mime type: text/plain; charset=UTF-8 (container-derived mime type was: null) 2017-04-11 20:06:30,805 INFO [com.isomorphic.servlet.Compression] - /acc/com.jsb.Main/sc/IDACall: 138 -> 126 bytes 2017-04-11 20:06:30,812 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/blank.gif' Path Info: '/Enterprise/images/blank.gif' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\blank.gif' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\blank.gif' 2017-04-11 20:06:30,812 INFO [com.isomorphic.servlet.RequestContext] - CGET URL: '/acc/com.jsb.Main/sc/skins/Enterprise/images/blank.gif', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:24.0) Gecko/20100101 Firefox/24.0': Moz (Gecko) with Accept-Encoding header 2017-04-11 20:06:30,813 DEBUG [com.isomorphic.compression.Compression] - /acc/com.jsb.Main/sc/skins/Enterprise/images/blank.gif: Mime type 'image/gif' is not compressable - not compressing 2017-04-11 20:06:30,813 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/blank.gif' Path Info: '/Enterprise/images/blank.gif' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\blank.gif' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\blank.gif' 2017-04-11 20:06:30,813 DEBUG [com.isomorphic.download.Download] - request for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\blank.gif 2017-04-11 20:06:30,813 INFO [com.isomorphic.download.Download] - Returning 304: Not modified on conditional get of: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\blank.gif 2017-04-11 20:06:30,813 DEBUG [com.isomorphic.download.Download] - Expiration for static file: 86400 seconds from download 2017-04-11 20:06:30,813 DEBUG [com.isomorphic.download.Download] - done sending 304 for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\blank.gif 2017-04-11 20:06:30,813 DEBUG [com.isomorphic.timing.Timing] - Request: /acc/com.jsb.Main/sc/skins/Enterprise/images/blank.gif (start->finish): 0ms 2017-04-11 20:06:30,814 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/minimize.png' Path Info: '/Enterprise/images/headerIcons/minimize.png' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\headerIcons\minimize.png' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\minimize.png' 2017-04-11 20:06:30,814 INFO [com.isomorphic.servlet.RequestContext] - CGET URL: '/acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/minimize.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:24.0) Gecko/20100101 Firefox/24.0': Moz (Gecko) with Accept-Encoding header 2017-04-11 20:06:30,814 DEBUG [com.isomorphic.compression.Compression] - /acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/minimize.png: Mime type 'image/png' is not compressable - not compressing 2017-04-11 20:06:30,814 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/close.png' Path Info: '/Enterprise/images/headerIcons/close.png' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\headerIcons\close.png' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\close.png' 2017-04-11 20:06:30,814 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/loadingSmall.gif' Path Info: '/Enterprise/images/loadingSmall.gif' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\loadingSmall.gif' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\loadingSmall.gif' 2017-04-11 20:06:30,814 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/minimize.png' Path Info: '/Enterprise/images/headerIcons/minimize.png' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\headerIcons\minimize.png' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\minimize.png' 2017-04-11 20:06:30,814 INFO [com.isomorphic.servlet.RequestContext] - CGET URL: '/acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/close.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:24.0) Gecko/20100101 Firefox/24.0': Moz (Gecko) with Accept-Encoding header 2017-04-11 20:06:30,817 INFO [com.isomorphic.servlet.RequestContext] - CGET URL: '/acc/com.jsb.Main/sc/skins/Enterprise/images/loadingSmall.gif', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:24.0) Gecko/20100101 Firefox/24.0': Moz (Gecko) with Accept-Encoding header 2017-04-11 20:06:30,817 DEBUG [com.isomorphic.compression.Compression] - /acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/close.png: Mime type 'image/png' is not compressable - not compressing 2017-04-11 20:06:30,817 DEBUG [com.isomorphic.download.Download] - request for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\minimize.png 2017-04-11 20:06:30,817 DEBUG [com.isomorphic.compression.Compression] - /acc/com.jsb.Main/sc/skins/Enterprise/images/loadingSmall.gif: Mime type 'image/gif' is not compressable - not compressing 2017-04-11 20:06:30,817 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/close.png' Path Info: '/Enterprise/images/headerIcons/close.png' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\headerIcons\close.png' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\close.png' 2017-04-11 20:06:30,817 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/loadingSmall.gif' Path Info: '/Enterprise/images/loadingSmall.gif' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\loadingSmall.gif' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\loadingSmall.gif' 2017-04-11 20:06:30,817 DEBUG [com.isomorphic.download.Download] - request for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\close.png 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.download.Download] - request for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\loadingSmall.gif 2017-04-11 20:06:30,818 INFO [com.isomorphic.download.Download] - Returning 304: Not modified on conditional get of: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\minimize.png 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.download.Download] - Expiration for static file: 86400 seconds from download 2017-04-11 20:06:30,818 INFO [com.isomorphic.download.Download] - Returning 304: Not modified on conditional get of: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\close.png 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.download.Download] - Expiration for static file: 86400 seconds from download 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.download.Download] - done sending 304 for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\minimize.png 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.timing.Timing] - Request: /acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/minimize.png (start->finish): 4ms 2017-04-11 20:06:30,818 INFO [com.isomorphic.download.Download] - Returning 304: Not modified on conditional get of: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\loadingSmall.gif 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.download.Download] - done sending 304 for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\headerIcons\close.png 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.download.Download] - Expiration for static file: 86400 seconds from download 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.timing.Timing] - Request: /acc/com.jsb.Main/sc/skins/Enterprise/images/headerIcons/close.png (start->finish): 1ms 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.download.Download] - done sending 304 for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\loadingSmall.gif 2017-04-11 20:06:30,818 DEBUG [com.isomorphic.timing.Timing] - Request: /acc/com.jsb.Main/sc/skins/Enterprise/images/loadingSmall.gif (start->finish): 1ms 2017-04-11 20:06:30,990 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/Dialog/warn.png' Path Info: '/Enterprise/images/Dialog/warn.png' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\Dialog\warn.png' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\Dialog\warn.png' 2017-04-11 20:06:30,990 INFO [com.isomorphic.servlet.RequestContext] - CGET URL: '/acc/com.jsb.Main/sc/skins/Enterprise/images/Dialog/warn.png', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:24.0) Gecko/20100101 Firefox/24.0': Moz (Gecko) with Accept-Encoding header 2017-04-11 20:06:30,990 DEBUG [com.isomorphic.compression.Compression] - /acc/com.jsb.Main/sc/skins/Enterprise/images/Dialog/warn.png: Mime type 'image/png' is not compressable - not compressing 2017-04-11 20:06:30,990 DEBUG [com.isomorphic.servlet.RequestContext] - Paths for request: Servlet path: '/com.jsb.Main/sc/skins' Request URI: '/acc/com.jsb.Main/sc/skins/Enterprise/images/Dialog/warn.png' Path Info: '/Enterprise/images/Dialog/warn.png' Path Translated: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\Enterprise\images\Dialog\warn.png' Real FileSystem Path: 'C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\acc\com.jsb.Main\sc\skins\Enterprise\images\Dialog\warn.png' 2017-04-11 20:06:30,990 DEBUG [com.isomorphic.download.Download] - request for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\Dialog\warn.png 2017-04-11 20:06:30,991 INFO [com.isomorphic.download.Download] - Returning 304: Not modified on conditional get of: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\Dialog\warn.png 2017-04-11 20:06:30,991 DEBUG [com.isomorphic.download.Download] - Expiration for static file: 86400 seconds from download 2017-04-11 20:06:30,991 DEBUG [com.isomorphic.download.Download] - done sending 304 for file: C:\DEV\TZWEB\AccountProj\out\artifacts\AccountProj_Web_exploded\com.jsb.Main\sc\skins\Enterprise\images\Dialog\warn.png 2017-04-11 20:06:30,991 DEBUG [com.isomorphic.timing.Timing] - Request: /acc/com.jsb.Main/sc/skins/Enterprise/images/Dialog/warn.png (start->finish): 1ms