find this link https://issues.apache.org/jira/browse/CALCITE-1952, kylin is uisng Calcite 1.13.0-kylin-r4, will this causes the query problem?
On Thu, Oct 25, 2018 at 8:29 PM Pengfei Xue <[email protected]> wrote: > hmm, updated my query with `group by`, the exception is still there, how > to track the root cause? > > On Thu, Oct 25, 2018 at 4:28 PM Chao Long <[email protected]> wrote: > >> This question has been added to the FAQ page, please check: >> >> https://kylin.apache.org/docs/gettingstarted/faq.html >> >> >> ------------------ 原始邮件 ------------------ >> *发件人:* "Pengfei Xue"<[email protected]>; >> *发送时间:* 2018年10月25日(星期四) 下午4:21 >> *收件人:* "user"<[email protected]>; >> *主题:* get org.apache.kylin.rest.exception.InternalErrorException when >> querying >> >> hi there, >> >> we are trying to use kylin as the query engine, now, we can successfully >> build the cube, but when we querying, get this error. following is the >> exception stack: >> >> kylin version:2.4.0 >> hbase: 1.2.0 >> >> 2018-10-25 15:52:53,510 INFO [Scheduler 1740251910 FetcherRunner >> 1417466356-45] common.KylinConfig:428 : Creating new manager instance of >> class org.apache.kylin.job.execution.ExecutableManager >> 2018-10-25 15:52:53,510 INFO [Scheduler 1740251910 FetcherRunner >> 1417466356-45] execution.ExecutableManager:68 : Using metadata url: >> kylin_metadata@hbase >> 2018-10-25 15:52:53,510 INFO [Scheduler 1740251910 FetcherRunner >> 1417466356-45] common.KylinConfig:428 : Creating new manager instance of >> class org.apache.kylin.job.dao.ExecutableDao >> 2018-10-25 15:52:53,510 INFO [Scheduler 1740251910 FetcherRunner >> 1417466356-45] dao.ExecutableDao:59 : Using metadata url: >> kylin_metadata@hbase >> 2018-10-25 15:52:53,531 INFO [Scheduler 1740251910 FetcherRunner >> 1417466356-45] threadpool.DefaultScheduler:275 : Job Fetcher: 0 should >> running, 0 actual running, 0 stopped, 0 ready, 7 already succeed, 0 error, >> 0 discarded, 0 others >> 2018-10-25 15:53:00,310 DEBUG [http-bio-7070-exec-4] >> servlet.DispatcherServlet:869 : DispatcherServlet with name 'kylin' >> processing POST request for [/kylin/api/query] >> 2018-10-25 15:53:00,310 DEBUG [http-bio-7070-exec-4] >> annotation.RequestMappingHandlerMapping:310 : Looking up handler method for >> path /query >> 2018-10-25 15:53:00,311 DEBUG [http-bio-7070-exec-4] >> annotation.RequestMappingHandlerMapping:317 : Returning handler method >> [public org.apache.kylin.rest.response.SQLResponse >> org.apache.kylin.rest.controller.QueryController.query(org.apache.kylin.rest.request.PrepareSqlRequest)] >> 2018-10-25 15:53:00,311 DEBUG [http-bio-7070-exec-4] >> support.DefaultListableBeanFactory:251 : Returning cached instance of >> singleton bean 'queryController' >> 2018-10-25 15:53:00,312 DEBUG [http-bio-7070-exec-4] >> cors.DefaultCorsProcessor:77 : Skip CORS processing: request is from same >> origin >> 2018-10-25 15:53:00,312 DEBUG [http-bio-7070-exec-4] >> annotation.RequestResponseBodyMethodProcessor:197 : Read [class >> org.apache.kylin.rest.request.PrepareSqlRequest] as >> "application/json;charset=UTF-8" with >> [org.springframework.http.converter.json.MappingJackson2HttpMessageConverter@11d4ebd3 >> ] >> 2018-10-25 15:53:00,313 INFO [http-bio-7070-exec-4] >> service.QueryService:324 : Check query permission in 1 ms. >> 2018-10-25 15:53:00,313 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] service.QueryService:355 : Using >> project: test1 >> 2018-10-25 15:53:00,313 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] service.QueryService:356 : The >> original query: select * from ML_DEVICE_CHANNEL limit 100; >> 2018-10-25 15:53:00,314 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] project.ProjectL2Cache:195 : >> Loading L2 project cache for test1 >> 2018-10-25 15:53:00,314 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] common.KylinConfig:428 : Creating >> new manager instance of class org.apache.kylin.metadata.TableMetadataManager >> 2018-10-25 15:53:00,314 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:118 : >> Reloading TableDesc from kylin_metadata(key='/table')@kylin_metadata@hbase >> 2018-10-25 15:53:00,336 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:127 : >> Loaded 3 TableDesc(s) out of 3 resource >> 2018-10-25 15:53:00,336 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:118 : >> Reloading TableExtDesc from >> kylin_metadata(key='/table_exd')@kylin_metadata@hbase >> 2018-10-25 15:53:00,359 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:127 : >> Loaded 3 TableExtDesc(s) out of 3 resource >> 2018-10-25 15:53:00,359 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:118 : >> Reloading ExternalFilterDesc from >> kylin_metadata(key='/ext_filter')@kylin_metadata@hbase >> 2018-10-25 15:53:00,363 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:127 : >> Loaded 0 ExternalFilterDesc(s) out of 0 resource >> 2018-10-25 15:53:00,364 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] common.KylinConfig:428 : Creating >> new manager instance of class >> org.apache.kylin.metadata.realization.RealizationRegistry >> 2018-10-25 15:53:00,364 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] realization.RealizationRegistry:54 >> : Initializing RealizationRegistry with metadata url kylin_metadata@hbase >> 2018-10-25 15:53:00,364 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] common.KylinConfig:428 : Creating >> new manager instance of class org.apache.kylin.cube.CubeManager >> 2018-10-25 15:53:00,364 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cube.CubeManager:128 : >> Initializing CubeManager with config null >> 2018-10-25 15:53:00,365 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:118 : >> Reloading CubeInstance from kylin_metadata(key='/cube')@kylin_metadata@hbase >> 2018-10-25 15:53:00,387 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] common.KylinConfig:428 : Creating >> new manager instance of class org.apache.kylin.cube.CubeDescManager >> 2018-10-25 15:53:00,387 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cube.CubeDescManager:87 : >> Initializing CubeDescManager with config kylin_metadata@hbase >> 2018-10-25 15:53:00,387 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:118 : >> Reloading CubeDesc from >> kylin_metadata(key='/cube_desc')@kylin_metadata@hbase >> 2018-10-25 15:53:00,408 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] common.KylinConfig:428 : Creating >> new manager instance of class >> org.apache.kylin.metadata.model.DataModelManager >> 2018-10-25 15:53:00,408 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:118 : >> Reloading DataModelDesc from >> kylin_metadata(key='/model_desc')@kylin_metadata@hbase >> 2018-10-25 15:53:00,424 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] model.DataModelManager:185 : Model >> ML_DEVICE_CHANNEL_MODEL is missing or unloaded yet >> 2018-10-25 15:53:00,426 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] model.DataModelManager:185 : Model >> al_device_status_detail is missing or unloaded yet >> 2018-10-25 15:53:00,427 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] model.DataModelManager:185 : Model >> test is missing or unloaded yet >> 2018-10-25 15:53:00,428 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:127 : >> Loaded 3 DataModelDesc(s) out of 3 resource >> 2018-10-25 15:53:00,432 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:127 : >> Loaded 4 CubeDesc(s) out of 4 resource >> 2018-10-25 15:53:00,436 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:127 : >> Loaded 4 CubeInstance(s) out of 4 resource >> 2018-10-25 15:53:00,436 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] common.KylinConfig:428 : Creating >> new manager instance of class org.apache.kylin.storage.hybrid.HybridManager >> 2018-10-25 15:53:00,436 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] hybrid.HybridManager:71 : >> Initializing HybridManager with config kylin_metadata@hbase >> 2018-10-25 15:53:00,437 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:118 : >> Reloading HybridInstance from >> kylin_metadata(key='/hybrid')@kylin_metadata@hbase >> 2018-10-25 15:53:00,441 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] cachesync.CachedCrudAssist:127 : >> Loaded 0 HybridInstance(s) out of 0 resource >> 2018-10-25 15:53:00,441 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] realization.RealizationRegistry:81 >> : RealizationRegistry is {CUBE=org.apache.kylin.cube.CubeManager@6a519e4, >> HYBRID=org.apache.kylin.storage.hybrid.HybridManager@4146cb24} >> 2018-10-25 15:53:00,441 WARN [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] realization.RealizationRegistry:91 >> : No provider for realization type INVERTED_INDEX >> 2018-10-25 15:53:00,441 WARN [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] realization.RealizationRegistry:91 >> : No provider for realization type INVERTED_INDEX >> 2018-10-25 15:53:00,454 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] service.QueryService:529 : The >> corrected query: select * from ML_DEVICE_CHANNEL limit 100 >> 2018-10-25 15:53:00,462 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] calcite.sql2rel:585 : Plan after >> converting SqlNode to RelNode >> LogicalSort(fetch=[100]) >> LogicalProject(DAY_7_RETAIN_RATE=[$0], PARTITION_DATE=[$1], >> _KY_COUNT__=[$2], _KY_SUM_ML_DEVICE_CHANNEL_DAY_7_RETAIN_RATE_=[$3]) >> OLAPTableScan(table=[[DEFAULT, ML_DEVICE_CHANNEL]], ctx=[], >> fields=[[0, 1, 2, 3]]) >> >> 2018-10-25 15:53:00,464 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] plan.RelOptPlanner:365 : For final >> plan, using rel#226:LogicalSort.NONE.[](input=HepRelVertex#225,fetch=100) >> 2018-10-25 15:53:00,464 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] plan.RelOptPlanner:365 : For final >> plan, using >> rel#224:LogicalProject.NONE.[](input=HepRelVertex#223,DAY_7_RETAIN_RATE=$0,PARTITION_DATE=$1) >> 2018-10-25 15:53:00,464 DEBUG [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] plan.RelOptPlanner:365 : For final >> plan, using rel#217:OLAPTableScan.OLAP.[](table=[DEFAULT, >> ML_DEVICE_CHANNEL],ctx=,fields=[0, 1, 2, 3]) >> 2018-10-25 15:53:00,465 ERROR [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] service.QueryService:449 : >> Exception while executing query >> java.sql.SQLException: Error while executing SQL "select * from >> ML_DEVICE_CHANNEL limit 100": null >> at org.apache.calcite.avatica.Helper.createException(Helper.java:56) >> at org.apache.calcite.avatica.Helper.createException(Helper.java:41) >> at >> org.apache.calcite.avatica.AvaticaStatement.executeInternal(AvaticaStatement.java:156) >> at >> org.apache.calcite.avatica.AvaticaStatement.executeQuery(AvaticaStatement.java:218) >> at >> org.apache.kylin.rest.service.QueryService.execute(QueryService.java:813) >> at >> org.apache.kylin.rest.service.QueryService.queryWithSqlMassage(QueryService.java:543) >> at org.apache.kylin.rest.service.QueryService.query(QueryService.java:178) >> at >> org.apache.kylin.rest.service.QueryService.queryAndUpdateCache(QueryService.java:412) >> at >> org.apache.kylin.rest.service.QueryService.doQueryWithCache(QueryService.java:381) >> at >> org.apache.kylin.rest.service.QueryService.doQueryWithCache(QueryService.java:325) >> at >> org.apache.kylin.rest.controller.QueryController.query(QueryController.java:86) >> at sun.reflect.GeneratedMethodAccessor199.invoke(Unknown Source) >> at >> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) >> at java.lang.reflect.Method.invoke(Method.java:606) >> at >> org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:205) >> at >> org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:133) >> at >> org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:97) >> at >> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:827) >> at >> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:738) >> at >> org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:85) >> at >> org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:967) >> at >> org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:901) >> at >> org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:970) >> at >> org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:872) >> at javax.servlet.http.HttpServlet.service(HttpServlet.java:650) >> at >> org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:846) >> 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 >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:317) >> at >> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:127) >> at >> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:91) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:114) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:137) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:111) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:170) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:63) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilterInternal(BasicAuthenticationFilter.java:158) >> at >> org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:200) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:116) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:64) >> at >> org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:56) >> at >> org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:105) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:214) >> at >> org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:177) >> at >> org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346) >> at >> org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:262) >> at >> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241) >> at >> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208) >> at com.thetransactioncompany.cors.CORSFilter.doFilter(CORSFilter.java:209) >> at com.thetransactioncompany.cors.CORSFilter.doFilter(CORSFilter.java:244) >> 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:219) >> at >> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:110) >> at >> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:169) >> at >> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103) >> at >> org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:962) >> at >> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116) >> at >> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:445) >> at >> org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1115) >> at >> org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:637) >> 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) >> Caused by: java.lang.NullPointerException >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.validate(VolcanoPlanner.java:891) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.register(VolcanoPlanner.java:866) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.ensureRegistered(VolcanoPlanner.java:883) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.ensureRegistered(VolcanoPlanner.java:101) >> at >> org.apache.calcite.rel.AbstractRelNode.onRegister(AbstractRelNode.java:336) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.registerImpl(VolcanoPlanner.java:1496) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.register(VolcanoPlanner.java:863) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.ensureRegistered(VolcanoPlanner.java:883) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.ensureRegistered(VolcanoPlanner.java:101) >> at >> org.apache.calcite.rel.AbstractRelNode.onRegister(AbstractRelNode.java:336) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.registerImpl(VolcanoPlanner.java:1496) >> at >> org.apache.calcite.plan.volcano.VolcanoPlanner.setRoot(VolcanoPlanner.java:308) >> at org.apache.calcite.tools.Programs$5.run(Programs.java:319) >> at >> org.apache.calcite.tools.Programs$SequenceProgram.run(Programs.java:397) >> at org.apache.calcite.prepare.Prepare.optimize(Prepare.java:186) >> at org.apache.calcite.prepare.Prepare.prepareSql(Prepare.java:319) >> at org.apache.calcite.prepare.Prepare.prepareSql(Prepare.java:228) >> at >> org.apache.calcite.prepare.CalcitePrepareImpl.prepare2_(CalcitePrepareImpl.java:801) >> at >> org.apache.calcite.prepare.CalcitePrepareImpl.prepare_(CalcitePrepareImpl.java:656) >> at >> org.apache.calcite.prepare.CalcitePrepareImpl.prepareSql(CalcitePrepareImpl.java:618) >> at >> org.apache.calcite.jdbc.CalciteConnectionImpl.parseQuery(CalciteConnectionImpl.java:214) >> at >> org.apache.calcite.jdbc.CalciteMetaImpl.prepareAndExecute(CalciteMetaImpl.java:603) >> at >> org.apache.calcite.avatica.AvaticaConnection.prepareAndExecuteInternal(AvaticaConnection.java:638) >> at >> org.apache.calcite.avatica.AvaticaStatement.executeInternal(AvaticaStatement.java:149) >> ... 82 more >> 2018-10-25 15:53:00,467 INFO [Query >> 734f5be5-e0f0-4af1-92aa-c37b50b044f7-70] service.QueryService:318 : >> ==========================[QUERY]=============================== >> Query Id: 734f5be5-e0f0-4af1-92aa-c37b50b044f7 >> SQL: select * from ML_DEVICE_CHANNEL limit 100; >> User: ADMIN >> Success: false >> Duration: 0.154 >> Project: test1 >> Realization Names: [] >> Cuboid Ids: [] >> Total scan count: 0 >> Total scan bytes: 0 >> Result row count: 0 >> Accept Partial: true >> Is Partial Result: false >> Hit Exception Cache: false >> Storage cache used: false >> Is Query Push-Down: false >> Is Prepare: false >> Trace URL: null >> Message: null >> while executing SQL: "select * from ML_DEVICE_CHANNEL limit 100" >> ==========================[QUERY]=============================== >> >> 2018-10-25 15:53:00,467 DEBUG [http-bio-7070-exec-4] >> annotation.ExceptionHandlerExceptionResolver:133 : Resolving exception from >> handler [public org.apache.kylin.rest.response.SQLResponse >> org.apache.kylin.rest.controller.QueryController.query(org.apache.kylin.rest.request.PrepareSqlRequest)]: >> org.apache.kylin.rest.exception.InternalErrorException: null >> while executing SQL: "select * from ML_DEVICE_CHANNEL limit 100" >> 2018-10-25 15:53:00,468 DEBUG [http-bio-7070-exec-4] >> annotation.ExceptionHandlerExceptionResolver:375 : Invoking >> @ExceptionHandler method: org.apache.kylin.rest.response.ErrorResponse >> org.apache.kylin.rest.controller.BasicController.handleError(javax.servlet.http.HttpServletRequest,java.lang.Exception) >> 2018-10-25 15:53:00,468 ERROR [http-bio-7070-exec-4] >> controller.BasicController:61 : >> org.apache.kylin.rest.exception.InternalErrorException: null >> while executing SQL: "select * from ML_DEVICE_CHANNEL limit 100" >> at >> org.apache.kylin.rest.service.QueryService.doQueryWithCache(QueryService.java:393) >> at >> org.apache.kylin.rest.service.QueryService.doQueryWithCache(QueryService.java:325) >> at >> org.apache.kylin.rest.controller.QueryController.query(QueryController.java:86) >> at sun.reflect.GeneratedMethodAccessor199.invoke(Unknown Source) >> at >> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) >> at java.lang.reflect.Method.invoke(Method.java:606) >> at >> org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:205) >> at >> org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:133) >> at >> org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:97) >> at >> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:827) >> at >> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:738) >> at >> org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:85) >> at >> org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:967) >> at >> org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:901) >> at >> org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:970) >> at >> org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:872) >> at javax.servlet.http.HttpServlet.service(HttpServlet.java:650) >> at >> org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:846) >> 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 >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:317) >> at >> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:127) >> at >> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:91) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:114) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:137) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:111) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:170) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:63) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilterInternal(BasicAuthenticationFilter.java:158) >> at >> org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:200) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:116) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:64) >> at >> org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:56) >> at >> org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:105) >> at >> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331) >> at >> org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:214) >> at >> org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:177) >> at >> org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346) >> at >> org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:262) >> at >> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241) >> at >> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208) >> at com.thetransactioncompany.cors.CORSFilter.doFilter(CORSFilter.java:209) >> at com.thetransactioncompany.cors.CORSFilter.doFilter(CORSFilter.java:244) >> 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:219) >> at >> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:110) >> at >> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:169) >> at >> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103) >> at >> org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:962) >> at >> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116) >> at >> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:445) >> at >> org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1115) >> at >> org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:637) >> 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) >> 2018-10-25 15:53:00,470 DEBUG [http-bio-7070-exec-4] >> annotation.RequestResponseBodyMethodProcessor:234 : Written >> [org.apache.kylin.rest.response.ErrorResponse@5b5afb24] as >> "application/json" using >> [org.springframework.http.converter.json.MappingJackson2HttpMessageConverter@618a1e64 >> ] >> 2018-10-25 15:53:00,470 DEBUG [http-bio-7070-exec-4] >> servlet.DispatcherServlet:1048 : Null ModelAndView returned to >> DispatcherServlet with name 'kylin': assuming HandlerAdapter completed >> request handling >> 2018-10-25 15:53:00,470 DEBUG [http-bio-7070-exec-4] >> servlet.DispatcherServlet:1000 : Successfully completed request >> 2018-10-25 15:53:02,092 DEBUG [Thread-10-SendThread(10.111.3.187:2181)] >> zookeeper.ClientCnxn:717 : Got ping response for sessionid: >> 0x16661603c500679 after 0ms >> >
