=== 2013-06-26 09:59:03,725 [l0-0] DEBUG XML - Parsed XML from (in memory stream): 32ms === 2013-06-26 09:59:03,740 [l0-3] DEBUG XML - Parsed XML from (in memory stream): 31ms === 2013-06-26 09:59:03,740 [l0-0] DEBUG RPCManager - Processing 1 requests. === 2013-06-26 09:59:03,756 [l0-0] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ operator:"and", criteria:[ { fieldName:"searchType", operator:"equals", value:"ind" }, { fieldName:"arrEnt", operator:"equals", value:[ "Crohn Disease" ] }, { fieldName:"arrEntLen", operator:"equals", value:1 }, { fieldName:"ind", operator:"equals", value:"Crohn Disease" } ], _constructor:"AdvancedCriteria" }, operationConfig:{ dataSource:"rvi_today", operationType:"fetch", textMatchStyle:"exact" }, sortBy:[ "-phaserank", "-ravi" ], componentId:"isc_RVITodayArea_14_0", appID:"builtinApplication", operation:"opIDSearchMe", oldValues:{ operator:"and", criteria:[ { fieldName:"searchType", operator:"equals", value:"ind" }, { fieldName:"arrEnt", operator:"equals", value:[ "Crohn Disease" ] }, { fieldName:"arrEntLen", operator:"equals", value:1 }, { fieldName:"ind", operator:"equals", value:"Crohn Disease" } ], _constructor:"AdvancedCriteria" } } === 2013-06-26 09:59:03,771 [l0-0] INFO IDACall - Performing 1 operation(s) === 2013-06-26 09:59:03,771 [l0-0] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2013-06-26 09:59:03,771 [l0-0] DEBUG DeclarativeSecurity - DataSource rvi_today is not in the pre-checked list, processing... === 2013-06-26 09:59:03,771 [l0-0] DEBUG AppBase - [builtinApplication.opIDSearchMe] No userTypes defined, allowing anyone access to all operations for this application === 2013-06-26 09:59:03,771 [l0-0] DEBUG AppBase - [builtinApplication.opIDSearchMe] No public zero-argument method named '_opIDSearchMe' found, performing generic datasource operation === 2013-06-26 09:59:03,771 [l0-0] INFO SQLDataSource - [builtinApplication.opIDSearchMe] Performing fetch operation with criteria: {criteria:[{fieldName:"searchType",operator:"equals",value:"ind"},{criteria:[{value:"Crohn Disease",fieldName:"arrEnt",operator:"equals"}],operator:"or"},{fieldName:"arrEntLen",operator:"equals",value:1},{fieldName:"ind",operator:"equals",value:"Crohn Disease"}],operator:"and",_constructor:"AdvancedCriteria"} values: {criteria:[{fieldName:"searchType",operator:"equals",value:"ind"},{criteria:[{value:"Crohn Disease",fieldName:"arrEnt",operator:"equals"}],operator:"or"},{fieldName:"arrEntLen",operator:"equals",value:1},{fieldName:"ind",operator:"equals",value:"Crohn Disease"}],operator:"and",_constructor:"AdvancedCriteria"} === 2013-06-26 09:59:03,771 [l0-3] DEBUG RPCManager - Processing 1 requests. === 2013-06-26 09:59:03,771 [l0-3] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ user_name:"esmith" }, operationConfig:{ dataSource:"dashboard_info", operationType:"fetch", textMatchStyle:"exact" }, startRow:0, endRow:75, componentId:"isc_ListGrid_2", appID:"builtinApplication", operation:"customBuildDashboard", oldValues:{ user_name:"esmith" } } === 2013-06-26 09:59:03,771 [l0-3] INFO IDACall - Performing 1 operation(s) === 2013-06-26 09:59:03,771 [l0-3] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2013-06-26 09:59:03,771 [l0-3] DEBUG DeclarativeSecurity - DataSource dashboard_info is not in the pre-checked list, processing... === 2013-06-26 09:59:03,771 [l0-3] DEBUG AppBase - [builtinApplication.customBuildDashboard] No userTypes defined, allowing anyone access to all operations for this application === 2013-06-26 09:59:03,771 [l0-3] DEBUG AppBase - [builtinApplication.customBuildDashboard] No public zero-argument method named '_customBuildDashboard' found, performing generic datasource operation === 2013-06-26 09:59:03,771 [l0-3] INFO SQLDataSource - [builtinApplication.customBuildDashboard] Performing fetch operation with criteria: {user_name:"esmith"} values: {user_name:"esmith"} === 2013-06-26 09:59:03,818 [l0-0] INFO SQLDataSource - [builtinApplication.opIDSearchMe] Executing SQL query on 'Mysql': === 2013-06-26 09:59:03,818 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.opIDSearchMe] Executing pingTest 'select 1 from dual' on connection 665443615 === 2013-06-26 09:59:03,818 [l0-0] DEBUG SQLConnectionManager - [builtinApplication.opIDSearchMe] Returning borrowed connection '665443615' === 2013-06-26 09:59:03,818 [l0-0] DEBUG SQLDriver - [builtinApplication.opIDSearchMe] About to execute SQL query in 'Mysql' using connection '665443615' === 2013-06-26 09:59:03,818 [l0-0] INFO SQLDriver - [builtinApplication.opIDSearchMe] Executing SQL query on 'Mysql': === 2013-06-26 09:59:03,818 [l0-3] INFO SQLDataSource - [builtinApplication.customBuildDashboard] Executing SQL query on 'Mysql': SELECT DISTINCT dashboard_info.dashboard_title, dashboard_info.ui_page, dashboard_info.tab_position, dashboard_info.url, dashboard_info.dashboard_hover FROM ( relaybdlive.dash_roles dash_roles INNER JOIN relaybdlive.user_roles user_roles ON (dash_roles.role_name = user_roles.role_name)) INNER JOIN relaybdlive.dashboard_info dashboard_info ON (dash_roles.dash_name = dashboard_info.dash_name) WHERE (user_roles.user_name = 'esmith') ORDER BY dashboard_info.tab_position ASC === 2013-06-26 09:59:03,834 [l0-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.customBuildDashboard] Executing pingTest 'select 1 from dual' on connection 1266334942 === 2013-06-26 09:59:03,834 [l0-3] DEBUG SQLConnectionManager - [builtinApplication.customBuildDashboard] Returning borrowed connection '1266334942' === 2013-06-26 09:59:03,834 [l0-3] DEBUG SQLDriver - [builtinApplication.customBuildDashboard] About to execute SQL query in 'Mysql' using connection '1266334942' === 2013-06-26 09:59:03,834 [l0-3] INFO SQLDriver - [builtinApplication.customBuildDashboard] Executing SQL query on 'Mysql': SELECT DISTINCT dashboard_info.dashboard_title, dashboard_info.ui_page, dashboard_info.tab_position, dashboard_info.url, dashboard_info.dashboard_hover FROM ( relaybdlive.dash_roles dash_roles INNER JOIN relaybdlive.user_roles user_roles ON (dash_roles.role_name = user_roles.role_name)) INNER JOIN relaybdlive.dashboard_info dashboard_info ON (dash_roles.dash_name = dashboard_info.dash_name) WHERE (user_roles.user_name = 'esmith') ORDER BY dashboard_info.tab_position ASC === 2013-06-26 09:59:03,834 [l0-3] INFO DSResponse - [builtinApplication.customBuildDashboard] DSResponse: List with 17 items === 2013-06-26 09:59:03,834 [l0-3] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "1266334942" === 2013-06-26 09:59:03,834 [l0-3] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1266334942 === 2013-06-26 09:59:03,834 [l0-3] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2013-06-26 09:59:03,865 [l0-3] DEBUG RPCManager - non-DMI response, dropExtraFields: false === 2013-06-26 09:59:03,865 [l0-0] INFO SQLDriver - [builtinApplication.opIDSearchMe] Execute of select: on db: Mysql threw exception: java.sql.SQLException: Can not issue empty query. - assuming stale connection and retrying query. === 2013-06-26 09:59:03,865 [l0-0] DEBUG SQLConnectionManager - [builtinApplication.opIDSearchMe] About to close PoolableConnection with hashcode "665443615" === 2013-06-26 09:59:03,865 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.opIDSearchMe] Executing pingTest 'select 1 from dual' on connection 665443615 === 2013-06-26 09:59:03,865 [l0-3] INFO Compression - /winter/sc/IDACall: 3547 -> 1074 bytes === 2013-06-26 09:59:03,881 [l0-0] DEBUG PoolableSQLConnectionFactory - [builtinApplication.opIDSearchMe] makeObject() created a pooled Connection '274047897' === 2013-06-26 09:59:03,881 [l0-0] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "274047897" === 2013-06-26 09:59:03,881 [l0-0] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 274047897 === 2013-06-26 09:59:03,881 [l0-0] WARN RequestContext - dsRequest.execute() failed: java.sql.SQLException: Can not issue empty query. at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1073) at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987) at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982) at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927) at com.mysql.jdbc.StatementImpl.checkNullOrEmptyQuery(StatementImpl.java:514) at com.mysql.jdbc.StatementImpl.executeQuery(StatementImpl.java:1427) at org.apache.commons.dbcp.DelegatingStatement.executeQuery(DelegatingStatement.java:208) at com.isomorphic.sql.SQLDriver.getTransformedResults(SQLDriver.java:592) at com.isomorphic.sql.SQLDriver.executeQuery(SQLDriver.java:848) at com.isomorphic.sql.SQLDataSource.executeNativeQuery(SQLDataSource.java:407) at com.isomorphic.sql.SQLDataSource.executeNativeQuery(SQLDataSource.java:401) at com.isomorphic.sql.SQLDataSource.SQLExecute(SQLDataSource.java:1394) at com.isomorphic.sql.SQLDataSource.processRequest(SQLDataSource.java:306) at com.isomorphic.sql.SQLDataSource.executeFetch(SQLDataSource.java:250) at com.isomorphic.datasource.DataSource.execute(DataSource.java:1367) 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:2033) at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:216) at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:173) at com.isomorphic.servlet.IDACall.processRequest(IDACall.java:138) at com.isomorphic.servlet.IDACall.doPost(IDACall.java:74) at javax.servlet.http.HttpServlet.service(HttpServlet.java:637) at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:152) at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487) at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1097) at com.isomorphic.servlet.CompressionFilter.doFilter(CompressionFilter.java:259) at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088) at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360) at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216) at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181) at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:729) at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.handler.RequestLogHandler.handle(RequestLogHandler.java:49) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.Server.handle(Server.java:324) at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505) at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:843) at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:647) at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211) at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380) at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:395) at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:488) === 2013-06-26 09:59:03,881 [l0-0] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2013-06-26 09:59:03,881 [l0-0] DEBUG RPCManager - non-DMI response, dropExtraFields: false === 2013-06-26 09:59:03,881 [l0-0] INFO Compression - /winter/sc/IDACall: 147 -> 135 bytes === 2013-06-26 09:59:04,380 [l0-0] INFO RequestContext - URL: '/winter/userSearch', User-Agent: 'Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101 Firefox/21.0': Moz (Gecko) with Accept-Encoding header URL for Tableau render is : http://viz.relaytm.com/views/BDliverebuild/Sheet6?ind=Crohn%20Disease&:embed=y&:display_count=no <