kylin-user mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Li Yang <liy...@apache.org>
Subject Re: Kylin sample cube: Cube empty / timeout visiting cube, after build
Date Sun, 08 May 2016 11:15:17 GMT
Btw, Kylin has been connecting to HBase well, because Kylin stores its
metadata also in HBase and that part is working.

On Sun, May 8, 2016 at 7:12 PM, Li Yang <liyang@apache.org> wrote:

> > java.lang.NullPointerException
> > at
> org.apache.kylin.storage.hbase.cube.v2.CubeHBaseEndpointRPC$1.run(CubeHBaseEndpointRPC.java:326)
>
> This is the cause of query exception. It is further caused by
> table.coprocessorService() returning a null. So it seems something wrong
> with your HTable.
>
> > the display always shows my cube as being 0.0 bytes
>
> Plus this evidence... Suggest check the cube's HTable, try scan it from
> HBase shell and see if any rows in it. The table is broken then fix HBase.
> If no rows in it, then there must be something wrong during build process.
>
>
> On Wed, May 4, 2016 at 3:05 AM, Phillip Rhodes <prhodes@mammothdata.com>
> wrote:
>
>> Yep, I've restarted numerous times as I've been interating on this.
>> I did it again just now to be sure, and got the same error.
>>
>> One thing I'm curious about... since this is happening in an HBase RPC
>> related class, I suspect it may have something to do with Kylin's
>> ability to talk to HBase.  Now building the cube seems to work, so at
>> that level Kylin is talking to HBase OK, as far as I can tell, but I
>> wonder if it uses a different mechanism at query time, as opposed to
>> build time?
>>
>> Is Kylin connecting to Zookeeper and getting the HBase Master info
>> from Zookeeper, when it runs a query? If so, are there any settings
>> that might need to be twiddled, relating to how it finds Zookeeper,
>> etc?
>>
>>
>>
>> Phil
>>
>>
>> On Tue, May 3, 2016 at 2:38 PM, Jason Wang (WDG) <jasowang@microsoft.com>
>> wrote:
>> > Have you tried to restart your kylin server? This might be a cache
>> problem.
>> >
>> > -----Original Message-----
>> > From: Phillip Rhodes [mailto:prhodes@mammothdata.com]
>> > Sent: Tuesday, May 3, 2016 11:12 AM
>> > To: user@kylin.apache.org
>> > Subject: Re: Kylin sample cube: Cube empty / timeout visiting cube,
>> after build
>> >
>> > Kylin 1.5.1, using HBase 0.9.8 with MapR 5.0.0
>> >
>> > Here's a longer (and newer) snippet of the kylin.log showing the error
>> I'm getting.
>> >
>> >
>> > Thanks,
>> >
>> >
>> > Phil
>> >
>> >
>> > ==========================[QUERY]===============================
>> > SQL: select part_dt, sum(price) as total_selled, count(distinct
>> > seller_id) as sellers from kylin_sales group by part_dt order by part_dt
>> > User: ADMIN
>> > Success: false
>> > Duration: 0.0
>> > Project: null
>> > Realization Names: []
>> > Cuboid Ids: []
>> > Total scan count: 0
>> > Result row count: 0
>> > Accept Partial: true
>> > Is Partial Result: false
>> > Hit Exception Cache: false
>> > Storage cache used: false
>> > Message: Trying to normalized a project name which is null
>> ==========================[QUERY]===============================
>> >
>> > 2016-05-03 04:34:16,822 ERROR [http-bio-7070-exec-2]
>> > controller.BasicController:44 :
>> > org.apache.kylin.rest.exception.InternalErrorException: Trying to
>> normalized a project name which is null at
>> org.apache.kylin.rest.controller.QueryController.doQueryWithCache(QueryController.java:224)
>> > at
>> org.apache.kylin.rest.controller.QueryController.query(QueryController.java:94)
>> > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at
>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>> > at
>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>> > at java.lang.reflect.Method.invoke(Method.java:497)
>> > at
>> org.springframework.web.method.support.InvocableHandlerMethod.invoke(InvocableHandlerMethod.java:213)
>> > at
>> org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:126)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:96)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:617)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:578)
>> > at
>> org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:80)
>> > at
>> org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:923)
>> > at
>> org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:852)
>> > at
>> org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:882)
>> > at
>> org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:789)
>> > at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
>> > at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
>> > 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:330)
>> > at
>> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118)
>> > at
>> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilter(BasicAuthenticationFilter.java:150)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter.doFilter(DefaultLoginPageGeneratingFilter.java:91)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:183)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:105)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
>> > at
>> org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
>> > at
>> org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
>> > at
>> org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259)
>> > 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:195)
>> > at
>> com.thetransactioncompany.cors.CORSFilter.doFilter(CORSFilter.java:266)
>> > 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:504)
>> > 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:950)
>> > at
>> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
>> > at
>> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:421)
>> > at
>> org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1074)
>> > at
>> org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:611)
>> > at
>> org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:314)
>> > at
>> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
>> > at
>> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> > at
>> org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
>> > at java.lang.Thread.run(Thread.java:745)
>> > 2016-05-03 04:34:22,018 DEBUG [http-bio-7070-exec-3]
>> > service.CacheService:144 : Creating a new data source, OLAP data source
>> pointing to kylin_metadata@hbase
>> > 2016-05-03 04:34:22,022 INFO  [http-bio-7070-exec-3]
>> > project.ProjectL2Cache:172 : Loading L2 project cache for LEARN_KYLIN
>> > 2016-05-03 04:34:22,023 INFO  [http-bio-7070-exec-3]
>> > realization.RealizationRegistry:75 : Initializing RealizationRegistry
>> with metadata url kylin_metadata@hbase
>> > 2016-05-03 04:34:22,541 INFO  [http-bio-7070-exec-3]
>> > reflections.Reflections:224 : Reflections took 503 ms to scan 18 urls,
>> producing 274 keys and 2131 values
>> > 2016-05-03 04:34:22,549 INFO  [http-bio-7070-exec-3]
>> > invertedindex.IIManager:101 : Initializing IIManager with config
>> kylin_metadata@hbase
>> > 2016-05-03 04:34:22,554 DEBUG [http-bio-7070-exec-3]
>> > invertedindex.IIManager:226 : Loading II from folder
>> kylin_metadata(key='/invertedindex')@kylin_metadata@hbase
>> > 2016-05-03 04:34:22,555 DEBUG [http-bio-7070-exec-3]
>> > invertedindex.IIManager:232 : Loaded 0 II(s)
>> > 2016-05-03 04:34:22,555 INFO  [http-bio-7070-exec-3]
>> > realization.RealizationRegistry:103 : RealizationRegistry is
>> {INVERTED_INDEX=org.apache.kylin.invertedindex.IIManager@79b1c3c,
>> > CUBE=org.apache.kylin.cube.CubeManager@299efc5f,
>> > HYBRID=org.apache.kylin.storage.hybrid.HybridManager@120c16bc}
>> > 2016-05-03 04:34:22,559 INFO  [http-bio-7070-exec-3]
>> > schema.OLAPSchemaFactory:135 : Schema json:{
>> >     "version": "1.0",
>> >     "defaultSchema": "DEFAULT",
>> >     "schemas": [
>> >         {
>> >             "type": "custom",
>> >             "name": "DEFAULT",
>> >             "factory":
>> "org.apache.kylin.query.schema.OLAPSchemaFactory",
>> >             "operand": {
>> >                 "project": "LEARN_KYLIN"
>> >             },
>> >             "functions": [
>> >                {
>> >                    name: 'MASSIN',
>> >                    className: 'org.apache.kylin.query.udf.MassInUDF'
>> >                }
>> >               ]
>> >         }
>> >     ]
>> > }
>> > 2016-05-03 04:34:22,560 DEBUG [http-bio-7070-exec-3]
>> > service.CacheService:149 : The new temp olap json is :{
>> >     "version": "1.0",
>> >     "defaultSchema": "DEFAULT",
>> >     "schemas": [
>> >         {
>> >             "type": "custom",
>> >             "name": "DEFAULT",
>> >             "factory":
>> "org.apache.kylin.query.schema.OLAPSchemaFactory",
>> >             "operand": {
>> >                 "project": "LEARN_KYLIN"
>> >             },
>> >             "functions": [
>> >                {
>> >                    name: 'MASSIN',
>> >                    className: 'org.apache.kylin.query.udf.MassInUDF'
>> >                }
>> >               ]
>> >         }
>> >     ]
>> > }
>> >
>> > 2016-05-03 04:34:22,998 DEBUG [http-bio-7070-exec-3]
>> > service.QueryService:289 : getting table metas
>> > 2016-05-03 04:34:23,050 INFO  [http-bio-7070-exec-3]
>> > project.ProjectL2Cache:172 : Loading L2 project cache for learn_kylin
>> > 2016-05-03 04:34:23,051 DEBUG [http-bio-7070-exec-3]
>> > service.QueryService:307 : getting column metas
>> > 2016-05-03 04:34:23,090 DEBUG [http-bio-7070-exec-3]
>> > service.QueryService:321 : done column metas
>> > 2016-05-03 04:34:23,845 DEBUG [http-bio-7070-exec-10]
>> > controller.UserController:64 : authentication.getPrincipal() is
>> > org.springframework.security.core.userdetails.User@3b40b2f: Username:
>> > ADMIN; Password: [PROTECTED]; Enabled: true; AccountNonExpired: true;
>> > credentialsNonExpired: true; AccountNonLocked: true; Granted
>> > Authorities: ROLE_ADMIN,ROLE_ANALYST,ROLE_MODELER
>> > 2016-05-03 04:34:23,965 DEBUG [http-bio-7070-exec-5]
>> > hbase.HBaseResourceStore:260 : Update row /project/learn_kylin.json
>> from oldTs: 1460427992000, to newTs: 1462217663955, operation result:
>> > true
>> > 2016-05-03 04:34:23,966 INFO  [pool-3-thread-1]
>> > restclient.Broadcaster:101 : new broadcast
>> event:BroadcastEvent{type=project, name=learn_kylin, action=update}
>> > 2016-05-03 04:34:23,971 INFO  [http-bio-7070-exec-9]
>> > controller.CacheController:64 : wipe cache type: PROJECT event:UPDATE
>> name:learn_kylin
>> > 2016-05-03 04:34:23,971 INFO  [http-bio-7070-exec-9]
>> > service.CacheService:171 : rebuild cache type: PROJECT name:learn_kylin
>> > 2016-05-03 04:34:23,973 INFO  [http-bio-7070-exec-9]
>> > service.CacheService:124 : removeOLAPDataSource is called for project
>> learn_kylin
>> > 2016-05-03 04:34:24,099 INFO  [http-bio-7070-exec-7]
>> > project.ProjectL2Cache:172 : Loading L2 project cache for learn_kylin
>> > 2016-05-03 04:34:24,102 INFO  [http-bio-7070-exec-7]
>> > controller.TableController:89 : Return all table metadata in 3 seconds
>> > 2016-05-03 04:34:24,852 DEBUG [http-bio-7070-exec-2]
>> > controller.UserController:64 : authentication.getPrincipal() is
>> > org.springframework.security.core.userdetails.User@3b40b2f: Username:
>> > ADMIN; Password: [PROTECTED]; Enabled: true; AccountNonExpired: true;
>> > credentialsNonExpired: true; AccountNonLocked: true; Granted
>> > Authorities: ROLE_ADMIN,ROLE_ANALYST,ROLE_MODELER
>> > 2016-05-03 04:34:25,034 DEBUG [http-bio-7070-exec-8]
>> > service.CacheService:144 : Creating a new data source, OLAP data source
>> pointing to kylin_metadata@hbase
>> > 2016-05-03 04:34:25,034 INFO  [http-bio-7070-exec-8]
>> > project.ProjectL2Cache:172 : Loading L2 project cache for LEARN_KYLIN
>> > 2016-05-03 04:34:25,035 INFO  [http-bio-7070-exec-8]
>> > schema.OLAPSchemaFactory:135 : Schema json:{
>> >     "version": "1.0",
>> >     "defaultSchema": "DEFAULT",
>> >     "schemas": [
>> >         {
>> >             "type": "custom",
>> >             "name": "DEFAULT",
>> >             "factory":
>> "org.apache.kylin.query.schema.OLAPSchemaFactory",
>> >             "operand": {
>> >                 "project": "LEARN_KYLIN"
>> >             },
>> >             "functions": [
>> >                {
>> >                    name: 'MASSIN',
>> >                    className: 'org.apache.kylin.query.udf.MassInUDF'
>> >                }
>> >               ]
>> >         }
>> >     ]
>> > }
>> > 2016-05-03 04:34:25,036 DEBUG [http-bio-7070-exec-8]
>> > service.CacheService:149 : The new temp olap json is :{
>> >     "version": "1.0",
>> >     "defaultSchema": "DEFAULT",
>> >     "schemas": [
>> >         {
>> >             "type": "custom",
>> >             "name": "DEFAULT",
>> >             "factory":
>> "org.apache.kylin.query.schema.OLAPSchemaFactory",
>> >             "operand": {
>> >                 "project": "LEARN_KYLIN"
>> >             },
>> >             "functions": [
>> >                {
>> >                    name: 'MASSIN',
>> >                    className: 'org.apache.kylin.query.udf.MassInUDF'
>> >                }
>> >               ]
>> >         }
>> >     ]
>> > }
>> >
>> > 2016-05-03 04:34:25,055 DEBUG [http-bio-7070-exec-8]
>> > service.QueryService:289 : getting table metas
>> > 2016-05-03 04:34:25,056 DEBUG [http-bio-7070-exec-8]
>> > service.QueryService:307 : getting column metas
>> > 2016-05-03 04:34:25,068 DEBUG [http-bio-7070-exec-8]
>> > service.QueryService:321 : done column metas
>> > 2016-05-03 04:34:30,695 INFO  [http-bio-7070-exec-3]
>> > controller.QueryController:174 : Using project: learn_kylin
>> > 2016-05-03 04:34:30,696 INFO  [http-bio-7070-exec-3]
>> > controller.QueryController:175 : The original query:  select part_dt,
>> > sum(price) as total_selled, count(distinct seller_id) as sellers from
>> kylin_sales group by part_dt order by part_dt
>> > 2016-05-03 04:34:30,697 INFO  [http-bio-7070-exec-3]
>> > service.QueryService:265 : The corrected query: select part_dt,
>> > sum(price) as total_selled, count(distinct seller_id) as sellers from
>> kylin_sales group by part_dt order by part_dt LIMIT 50000
>> > 2016-05-03 04:34:31,218 INFO  [http-bio-7070-exec-3]
>> > routing.QueryRouter:48 : The project manager's reference is
>> org.apache.kylin.metadata.project.ProjectManager@5c4a45fc
>> > 2016-05-03 04:34:31,219 INFO  [http-bio-7070-exec-3]
>> > routing.QueryRouter:60 : Find candidates by table DEFAULT.KYLIN_SALES
>> and project=LEARN_KYLIN :
>> > org.apache.kylin.query.routing.Candidate@408561ee
>> > 2016-05-03 04:34:31,222 INFO  [http-bio-7070-exec-3]
>> > routing.QueryRouter:49 : Applying rule: class
>> org.apache.kylin.query.routing.rules.RemoveUncapableRealizationsRule,
>> > realizations before: [kylin_sales_cube(CUBE)], realizations after:
>> > [kylin_sales_cube(CUBE)]
>> > 2016-05-03 04:34:31,222 INFO  [http-bio-7070-exec-3]
>> > routing.QueryRouter:49 : Applying rule: class
>> org.apache.kylin.query.routing.rules.RealizationSortRule, realizations
>> > before: [kylin_sales_cube(CUBE)], realizations after:
>> > [kylin_sales_cube(CUBE)]
>> > 2016-05-03 04:34:31,222 INFO  [http-bio-7070-exec-3]
>> > routing.QueryRouter:72 : The realizations remaining:
>> > [kylin_sales_cube(CUBE)] And the final chosen one is the first one
>> > 2016-05-03 04:34:31,513 DEBUG [http-bio-7070-exec-3]
>> > enumerator.OLAPEnumerator:107 : query storage...
>> > 2016-05-03 04:34:31,522 INFO  [http-bio-7070-exec-3]
>> > v2.CubeStorageQuery:251 : exactAggregation is true
>> > 2016-05-03 04:34:31,522 INFO  [http-bio-7070-exec-3]
>> > v2.CubeStorageQuery:357 : Memory budget is set to: 3109290
>> > 2016-05-03 04:34:31,550 DEBUG [http-bio-7070-exec-3]
>> > v2.CubeHBaseEndpointRPC:256 : New scanner for current segment
>> kylin_sales_cube[20120101000000_20160501000000] will use
>> SCAN_FILTER_AGGR_CHECKMEM as endpoint's behavior
>> > 2016-05-03 04:34:31,562 DEBUG [http-bio-7070-exec-3]
>> > v2.CubeHBaseEndpointRPC:291 : Serialized scanRequestBytes 321 bytes,
>> rawScanBytesString 46 bytes
>> > 2016-05-03 04:34:31,562 INFO  [http-bio-7070-exec-3]
>> > v2.CubeHBaseEndpointRPC:294 : The scan(s) info for current segment is
>> as below, shard part of start/end key is set to 0
>> > 2016-05-03 04:34:31,562 INFO  [http-bio-7070-exec-3]
>> > v2.CubeHBaseRPC:309 : Visiting hbase table KYLIN_JFVKIFVB8S: cuboid
>> exact match, from 64 to 64 Start:
>> > \x00\x00\x00\x00\x00\x00\x00\x00\x00\x40\x00\x00\x00
>> > (\x00\x00\x00\x00\x00\x00\x00\x00\x00@\x00\x00\x00) Stop:
>> > \x00\x00\x00\x00\x00\x00\x00\x00\x00\x40\xFF\xFF\xFF\x00
>> > (\x00\x00\x00\x00\x00\x00\x00\x00\x00@\xFF\xFF\xFF\x00), No Fuzzy Key
>> > 2016-05-03 04:34:31,563 DEBUG [http-bio-7070-exec-3]
>> > v2.CubeHBaseEndpointRPC:300 : Submitting rpc to 1 shards starting from
>> shard 0, scan requests count 1
>> > 2016-05-03 04:34:31,582 INFO  [http-bio-7070-exec-3]
>> > v2.CubeHBaseEndpointRPC:125 : Timeout for ExpectedSizeIterator is
>> > 60000
>> > 2016-05-03 04:34:31,588 DEBUG [http-bio-7070-exec-3]
>> > enumerator.OLAPEnumerator:127 : return TupleIterator...
>> > 2016-05-03 04:34:31,592 ERROR [pool-9-thread-1]
>> > v2.CubeHBaseEndpointRPC:98 : Execution exception when running task in
>> > pool-9-thread-1
>> > 2016-05-03 04:34:31,592 ERROR [pool-9-thread-1]
>> > v2.CubeHBaseEndpointRPC:108 : Caught exception in thread
>> > pool-9-thread-1:
>> > java.lang.NullPointerException
>> > at
>> org.apache.kylin.storage.hbase.cube.v2.CubeHBaseEndpointRPC$1.run(CubeHBaseEndpointRPC.java:326)
>> > at
>> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
>> > at java.util.concurrent.FutureTask.run(FutureTask.java:266)
>> > at
>> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
>> > at
>> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> > at java.lang.Thread.run(Thread.java:745)
>> > 2016-05-03 04:35:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:35:31,589 ERROR [http-bio-7070-exec-3]
>> > controller.QueryController:209 : Exception when execute sql
>> > java.sql.SQLException: Error while executing SQL "select part_dt,
>> > sum(price) as total_selled, count(distinct seller_id) as sellers from
>> kylin_sales group by part_dt order by part_dt LIMIT 50000": Timeout
>> visiting cube!
>> > 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:143)
>> > at
>> org.apache.calcite.avatica.AvaticaStatement.executeQuery(AvaticaStatement.java:186)
>> > at
>> org.apache.kylin.rest.service.QueryService.execute(QueryService.java:356)
>> > at
>> org.apache.kylin.rest.service.QueryService.queryWithSqlMassage(QueryService.java:272)
>> > at
>> org.apache.kylin.rest.service.QueryService.query(QueryService.java:118)
>> > at
>> org.apache.kylin.rest.service.QueryService$$FastClassByCGLIB$$4957273f.invoke(<generated>)
>> > at net.sf.cglib.proxy.MethodProxy.invoke(MethodProxy.java:204)
>> > at
>> org.springframework.aop.framework.Cglib2AopProxy$DynamicAdvisedInterceptor.intercept(Cglib2AopProxy.java:618)
>> > at
>> org.apache.kylin.rest.service.QueryService$$EnhancerByCGLIB$$c9bef1fc.query(<generated>)
>> > at
>> org.apache.kylin.rest.controller.QueryController.doQueryWithCache(QueryController.java:192)
>> > at
>> org.apache.kylin.rest.controller.QueryController.query(QueryController.java:94)
>> > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at
>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>> > at
>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>> > at java.lang.reflect.Method.invoke(Method.java:497)
>> > at
>> org.springframework.web.method.support.InvocableHandlerMethod.invoke(InvocableHandlerMethod.java:213)
>> > at
>> org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:126)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:96)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:617)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:578)
>> > at
>> org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:80)
>> > at
>> org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:923)
>> > at
>> org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:852)
>> > at
>> org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:882)
>> > at
>> org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:789)
>> > at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
>> > at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
>> > 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:330)
>> > at
>> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118)
>> > at
>> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilter(BasicAuthenticationFilter.java:150)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter.doFilter(DefaultLoginPageGeneratingFilter.java:91)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:183)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:105)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
>> > at
>> org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
>> > at
>> org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
>> > at
>> org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259)
>> > 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:195)
>> > at
>> com.thetransactioncompany.cors.CORSFilter.doFilter(CORSFilter.java:266)
>> > 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:504)
>> > 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:950)
>> > at
>> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
>> > at
>> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:421)
>> > at
>> org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1074)
>> > at
>> org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:611)
>> > at
>> org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:316)
>> > at
>> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
>> > at
>> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> > at
>> org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
>> > at java.lang.Thread.run(Thread.java:745)
>> > Caused by: java.lang.RuntimeException: Timeout visiting cube!
>> > at
>> org.apache.kylin.storage.hbase.cube.v2.CubeHBaseEndpointRPC$ExpectedSizeIterator.next(CubeHBaseEndpointRPC.java:142)
>> > at
>> org.apache.kylin.storage.hbase.cube.v2.CubeHBaseEndpointRPC$ExpectedSizeIterator.next(CubeHBaseEndpointRPC.java:113)
>> > at
>> com.google.common.collect.TransformedIterator.next(TransformedIterator.java:48)
>> > at com.google.common.collect.Iterators$6.hasNext(Iterators.java:583)
>> > at
>> org.apache.kylin.storage.hbase.cube.v2.SequentialCubeTupleIterator.hasNext(SequentialCubeTupleIterator.java:96)
>> > at
>> org.apache.kylin.query.enumerator.OLAPEnumerator.moveNext(OLAPEnumerator.java:74)
>> > at Baz$1$1.moveNext(Unknown Source)
>> > at
>> org.apache.calcite.linq4j.EnumerableDefaults.groupBy_(EnumerableDefaults.java:819)
>> > at
>> org.apache.calcite.linq4j.EnumerableDefaults.groupBy(EnumerableDefaults.java:754)
>> > at
>> org.apache.calcite.linq4j.DefaultEnumerable.groupBy(DefaultEnumerable.java:302)
>> > at Baz.bind(Unknown Source)
>> > at
>> org.apache.calcite.jdbc.CalcitePrepare$CalciteSignature.enumerable(CalcitePrepare.java:326)
>> > at
>> org.apache.calcite.jdbc.CalciteConnectionImpl.enumerable(CalciteConnectionImpl.java:281)
>> > at
>> org.apache.calcite.jdbc.CalciteMetaImpl._createIterable(CalciteMetaImpl.java:545)
>> > at
>> org.apache.calcite.jdbc.CalciteMetaImpl.createIterable(CalciteMetaImpl.java:536)
>> > at
>> org.apache.calcite.avatica.AvaticaResultSet.execute(AvaticaResultSet.java:187)
>> > at
>> org.apache.calcite.jdbc.CalciteResultSet.execute(CalciteResultSet.java:65)
>> > at
>> org.apache.calcite.jdbc.CalciteResultSet.execute(CalciteResultSet.java:44)
>> > at
>> org.apache.calcite.avatica.AvaticaConnection$1.execute(AvaticaConnection.java:566)
>> > at
>> org.apache.calcite.jdbc.CalciteMetaImpl.prepareAndExecute(CalciteMetaImpl.java:578)
>> > at
>> org.apache.calcite.avatica.AvaticaConnection.prepareAndExecuteInternal(AvaticaConnection.java:571)
>> > at
>> org.apache.calcite.avatica.AvaticaStatement.executeInternal(AvaticaStatement.java:135)
>> > ... 80 more
>> > 2016-05-03 04:35:31,591 INFO  [http-bio-7070-exec-3]
>> service.QueryService:249 :
>> > ==========================[QUERY]===============================
>> > SQL: select part_dt, sum(price) as total_selled, count(distinct
>> > seller_id) as sellers from kylin_sales group by part_dt order by part_dt
>> > User: ADMIN
>> > Success: false
>> > Duration: 0.0
>> > Project: learn_kylin
>> > Realization Names: [kylin_sales_cube]
>> > Cuboid Ids: [64]
>> > Total scan count: 0
>> > Result row count: 0
>> > Accept Partial: true
>> > Is Partial Result: false
>> > Hit Exception Cache: false
>> > Storage cache used: false
>> > Message: Error while executing SQL "select part_dt, sum(price) as
>> total_selled, count(distinct seller_id) as sellers from kylin_sales group
>> by part_dt order by part_dt LIMIT 50000": Timeout visiting cube!
>> > ==========================[QUERY]===============================
>> >
>> > 2016-05-03 04:35:31,592 ERROR [http-bio-7070-exec-3]
>> > controller.BasicController:44 :
>> > org.apache.kylin.rest.exception.InternalErrorException: Error while
>> executing SQL "select part_dt, sum(price) as total_selled, count(distinct
>> seller_id) as sellers from kylin_sales group by part_dt order by part_dt
>> LIMIT 50000": Timeout visiting cube!
>> > at
>> org.apache.kylin.rest.controller.QueryController.doQueryWithCache(QueryController.java:224)
>> > at
>> org.apache.kylin.rest.controller.QueryController.query(QueryController.java:94)
>> > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at
>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>> > at
>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>> > at java.lang.reflect.Method.invoke(Method.java:497)
>> > at
>> org.springframework.web.method.support.InvocableHandlerMethod.invoke(InvocableHandlerMethod.java:213)
>> > at
>> org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:126)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:96)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:617)
>> > at
>> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:578)
>> > at
>> org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:80)
>> > at
>> org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:923)
>> > at
>> org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:852)
>> > at
>> org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:882)
>> > at
>> org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:789)
>> > at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
>> > at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
>> > 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:330)
>> > at
>> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118)
>> > at
>> org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilter(BasicAuthenticationFilter.java:150)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter.doFilter(DefaultLoginPageGeneratingFilter.java:91)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:183)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:105)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
>> > at
>> org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
>> > at
>> org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
>> > at
>> org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
>> > at
>> org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
>> > at
>> org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259)
>> > 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:195)
>> > at
>> com.thetransactioncompany.cors.CORSFilter.doFilter(CORSFilter.java:266)
>> > 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:504)
>> > 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:950)
>> > at
>> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
>> > at
>> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:421)
>> > at
>> org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1074)
>> > at
>> org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:611)
>> > at
>> org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:316)
>> > at
>> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
>> > at
>> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> > at
>> org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
>> > at java.lang.Thread.run(Thread.java:745)
>> > 2016-05-03 04:36:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:37:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:38:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:39:05,119 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:40:05,119 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:41:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:42:05,119 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:43:05,119 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:44:05,119 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:45:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:46:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:47:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:48:05,119 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:49:05,119 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:50:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:51:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:52:05,119 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:53:05,120 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:56:02,197 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:56:02,206 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:56:05,121 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:57:05,121 INFO  [pool-1-thread-1]
>> > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual
>> running, 0 ready, 2 others
>> > 2016-05-03 04:57:22,712 DEBUG [Thread-8]
>> > threadpool.DefaultScheduler:182 : Closing zk connection
>> > 2016-05-03 04:58:54,467 INFO  [localhost-startStop-1]
>> > core.SpringSecurityCoreVersion:33 : You are running with Spring
>> Security Core 3.1.2.RELEASE
>> > 2016-05-03 04:58:54,471 INFO  [localhost-startStop-1]
>> > config.SecurityNamespaceHandler:59 : Spring Security 'config' module
>> version is 3.1.2.RELEASE
>> > 2016-05-03 04:58:54,517 INFO  [localhost-startStop-1]
>> > method.GlobalMethodSecurityBeanDefinitionParser:141 : Using bean
>> 'expressionHandler' as method ExpressionHandler implementation
>> > 2016-05-03 04:58:54,581 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'permitAll' for
>> > /api/user/authentication*/**
>> > 2016-05-03 04:58:54,582 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'isAuthenticated()' for
>> > /api/query*/**
>> > 2016-05-03 04:58:54,582 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'isAuthenticated()' for
>> > /api/metadata*/**
>> > 2016-05-03 04:58:54,583 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'permitAll' for /api/**/metrics
>> > 2016-05-03 04:58:54,583 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'permitAll' for /api/cache*/**
>> > 2016-05-03 04:58:54,583 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'hasAnyRole('ROLE_ANALYST')' for
>> /api/cubes/src/tables
>> > 2016-05-03 04:58:54,584 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'isAuthenticated()' for
>> > /api/cubes*/**
>> > 2016-05-03 04:58:54,584 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'isAuthenticated()' for
>> > /api/models*/**
>> > 2016-05-03 04:58:54,584 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'isAuthenticated()' for
>> > /api/streaming*/**
>> > 2016-05-03 04:58:54,585 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'isAuthenticated()' for
>> > /api/job*/**
>> > 2016-05-03 04:58:54,585 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'permitAll' for /api/admin/config
>> > 2016-05-03 04:58:54,585 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'permitAll' for /api/projects
>> > 2016-05-03 04:58:54,585 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'hasRole('ROLE_ADMIN')' for
>> > /api/admin*/**
>> > 2016-05-03 04:58:54,587 INFO  [localhost-startStop-1]
>> > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access
>> control expression attribute 'isAuthenticated()' for /api/**
>> > 2016-05-03 04:58:54,606 INFO  [localhost-startStop-1]
>> > http.AuthenticationConfigBuilder:465 : No login page configured. The
>> default internal one will be used. Use the 'login-page' attribute to set
>> the URL of the login page.
>> >
>> > On Tue, May 3, 2016 at 5:05 AM, Li Yang <liyang@apache.org> wrote:
>> >> What's Kylin version? And more kylin.log is needed. Those lines before
>> >> the stack trace.
>> >>
>> >> On Sat, Apr 30, 2016 at 2:54 AM, Phillip Rhodes
>> >> <prhodes@mammothdata.com>
>> >> wrote:
>> >>>
>> >>> Kylin gang:
>> >>>
>> >>> I've installed Kylin with MapR distribution, and things seem to work
>> >>> fine up to a point.  I ran the sample.sh script and I now have the
>> >>> "learning_kylin" project, and I can run "build" on the cube and the
>> >>> job reports success at 100% complete.
>> >>>
>> >>> But.. after doing this, the display always shows my cube as being 0.0
>> >>> bytes, and if I run the sample query from the documentation, I get a
>> >>> "timeout visiting cube" error.
>> >>>
>> >>> The other weird thing I've noticed, is that the "build" dialog is
>> >>> showing a start date of today's date, and I can't edit it.  Not sure
>> >>> if that has anything to do with the weirdness I'm seeing or not, but
>> >>> can anyone tell me how Kylin determines what value to put there?
>> >>>
>> >>>
>> >>> Anyway, any thoughts on how to debug this are greatly appreciated.
>> >>> I've examined the logs, but don't see anything that jumps out to me
>> >>> as terribly useful.  Here's what I find:
>> >>>
>> >>> ==========================[QUERY]===============================
>> >>> SQL: select part_dt, sum(price) as total_selled, count(distinct
>> >>> seller_id) as sellers from kylin_sales group by part_dt order by
>> >>> part_dt
>> >>> User: ADMIN
>> >>> Success: false
>> >>> Duration: 0.0
>> >>> Project: learn_kylin
>> >>> Realization Names: [kylin_sales_cube] Cuboid Ids: [64] Total scan
>> >>> count: 0 Result row count: 0 Accept Partial: true Is Partial Result:
>> >>> false Hit Exception Cache: false Storage cache used: false
>> >>> Message: Error while executing SQL "select part_dt, sum(price) as
>> >>> total_selled, count(distinct seller_id) as sellers from kylin_sales
>> >>> group by part_dt order by part_dt LIMIT 50000": Timeout visiting
>> >>> cube!
>> >>> ==========================[QUERY]===============================
>> >>>
>> >>> 2016-04-30 03:45:32,310 ERROR [http-bio-7070-exec-9]
>> >>> controller.BasicController:44 :
>> >>> org.apache.kylin.rest.exception.InternalErrorException: Error while
>> >>> executing SQL "select part_dt, sum(price) as total_selled,
>> >>> count(distinct seller_id) as sellers from kylin_sales group by
>> >>> part_dt order by part_dt LIMIT 50000": Timeout visiting cube!
>> >>>        at
>> >>>
>> org.apache.kylin.rest.controller.QueryController.doQueryWithCache(QueryController.java:224)
>> >>>        at
>> >>>
>> org.apache.kylin.rest.controller.QueryController.query(QueryController.java:94)
>> >>>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>> >>>        at
>> >>>
>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>> >>>        at
>> >>>
>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>> >>>        at java.lang.reflect.Method.invoke(Method.java:497)
>> >>>        at
>> >>>
>> org.springframework.web.method.support.InvocableHandlerMethod.invoke(InvocableHandlerMethod.java:213)
>> >>>        at
>> >>>
>> org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:126)
>> >>>        at
>> >>>
>> org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:96)
>> >>>        at
>> >>>
>> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:617)
>> >>>        at
>> >>>
>> org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:578)
>> >>>        at
>> >>>
>> org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:80)
>> >>>        at
>> >>>
>> org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:923)
>> >>>        at
>> >>>
>> org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:852)
>> >>>        at
>> >>>
>> org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:882)
>> >>>        at
>> >>> org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServ
>> >>> let.java:789)
>> >>>
>> >>>
>> >>>
>> >>> Thanks,
>> >>>
>> >>>
>> >>> Phil
>> >>
>> >>
>> >
>>
>
>

Mime
View raw message