Hadoop distribution/Version is Cloudera - CDH5.7 / 2.6.0 Hbase version: 1.2.0
On Tue, May 3, 2016 at 11:57 PM, hongbin ma <[email protected]> wrote: > The "timeout" is not the root cause, it's bad log requires improving ( > https://issues.apache.org/jira/browse/KYLIN-1645) > > The root cause seems similar to > > http://apache-kylin.74782.x6.nabble.com/Re-My-kylin-cube-build-successfully-but-when-query-I-meetthisexception-td4351.html#none > , > can you share the version of your hadoop, hbase, etc ? > > On Wed, May 4, 2016 at 11:49 AM, Amit Jain <[email protected]> wrote: > > > Here is the text from kylin.log > > > > > =============================================================================================================================================== > > 2016-05-03 15:01:51,151 INFO [localhost-startStop-1] > > core.SpringSecurityCoreVersion:33 : You are running with Spring Security > > Core 3.1.2.RELEASE > > 2016-05-03 15:01:51,153 INFO [localhost-startStop-1] > > config.SecurityNamespaceHandler:59 : Spring Security 'config' module > > version is 3.1.2.RELEASE > > 2016-05-03 15:01:51,168 INFO [localhost-startStop-1] > > method.GlobalMethodSecurityBeanDefinitionParser:141 : Using bean > > 'expressionHandler' as method ExpressionHandler implementation > > 2016-05-03 15:01:51,208 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'permitAll' for /api/user/authentication*/** > > 2016-05-03 15:01:51,208 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'isAuthenticated()' for /api/query*/** > > 2016-05-03 15:01:51,208 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'isAuthenticated()' for /api/metadata*/** > > 2016-05-03 15:01:51,208 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'permitAll' for /api/**/metrics > > 2016-05-03 15:01:51,209 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'permitAll' for /api/cache*/** > > 2016-05-03 15:01:51,209 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'hasAnyRole('ROLE_ANALYST')' for > > /api/cubes/src/tables > > 2016-05-03 15:01:51,209 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'isAuthenticated()' for /api/cubes*/** > > 2016-05-03 15:01:51,209 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'isAuthenticated()' for /api/models*/** > > 2016-05-03 15:01:51,209 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'isAuthenticated()' for /api/streaming*/** > > 2016-05-03 15:01:51,209 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'isAuthenticated()' for /api/job*/** > > 2016-05-03 15:01:51,210 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'permitAll' for /api/admin/config > > 2016-05-03 15:01:51,210 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'permitAll' for /api/projects > > 2016-05-03 15:01:51,210 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'hasRole('ROLE_ADMIN')' for /api/admin*/** > > 2016-05-03 15:01:51,211 INFO [localhost-startStop-1] > > http.FilterInvocationSecurityMetadataSourceParser:134 : Creating access > > control expression attribute 'isAuthenticated()' for /api/** > > 2016-05-03 15:01:51,225 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. > > 2016-05-03 15:01:51,229 INFO [localhost-startStop-1] > > http.HttpSecurityBeanDefinitionParser:264 : Checking sorted filter chain: > > [Root bean: class > > > > > [org.springframework.security.web.context.SecurityContextPersistenceFilter]; > > scope=; abstract=false; lazyInit=false; autowireMode=0; > dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 300, Root bean: class > > [org.springframework.security.web.authentication.logout.LogoutFilter]; > > scope=; abstract=false; lazyInit=false; autowireMode=0; > dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 400, > > > > > <org.springframework.security.web.authentication.UsernamePasswordAuthenticationFilter#0>, > > order = 800, Root bean: class > > > > > [org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter]; > > scope=; abstract=false; lazyInit=false; autowireMode=0; > dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 1000, Root bean: class > > > > > [org.springframework.security.web.authentication.www.BasicAuthenticationFilter]; > > scope=; abstract=false; lazyInit=false; autowireMode=0; > dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 1200, Root bean: class > > [org.springframework.security.web.savedrequest.RequestCacheAwareFilter]; > > scope=; abstract=false; lazyInit=false; autowireMode=0; > dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 1300, Root bean: class > > > > > [org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter]; > > scope=; abstract=false; lazyInit=false; autowireMode=0; > dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 1400, Root bean: class > > > > > [org.springframework.security.web.authentication.AnonymousAuthenticationFilter]; > > scope=; abstract=false; lazyInit=false; autowireMode=0; > dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 1700, Root bean: class > > [org.springframework.security.web.session.SessionManagementFilter]; > scope=; > > abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 1800, Root bean: class > > [org.springframework.security.web.access.ExceptionTranslationFilter]; > > scope=; abstract=false; lazyInit=false; autowireMode=0; > dependencyCheck=0; > > autowireCandidate=true; primary=false; factoryBeanName=null; > > factoryMethodName=null; initMethodName=null; destroyMethodName=null, > order > > = 1900, > > > > > <org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0>, > > order = 2000] > > 2016-05-03 15:01:51,418 WARN [localhost-startStop-1] > > common.KylinConfig:162 : KYLIN_CONF property was not set, will seek > > KYLIN_HOME env variable > > 2016-05-03 15:01:51,456 INFO [localhost-startStop-1] > > security.PasswordPlaceholderConfigurer:177 : Loading properties file from > > resource loaded through InputStream > > 2016-05-03 15:01:51,833 INFO [localhost-startStop-1] util.Version:27 : > > HV000001: Hibernate Validator 5.1.3.Final > > 2016-05-03 15:01:52,383 INFO [localhost-startStop-1] > > init.InitialTaskManager:36 : Kylin service is starting..... > > 2016-05-03 15:01:52,909 INFO [localhost-startStop-1] > > filter.AnnotationSizeOfFilter:53 : Using regular expression provided > > through VM argument net.sf.ehcache.pool.sizeof.ignore.pattern for > > IgnoreSizeOf annotation : ^.*cache\..*IgnoreSizeOf$ > > 2016-05-03 15:01:52,919 INFO [localhost-startStop-1] > > sizeof.JvmInformation:545 : Detected JVM data model settings of: 64-Bit > > HotSpot JVM with Compressed OOPs and Concurrent Mark-and-Sweep GC > > 2016-05-03 15:01:53,151 INFO [localhost-startStop-1] > > sizeof.AgentLoader:197 : Extracted agent jar to temporary file > > bin/../tomcat/temp/ehcache-sizeof-agent6516450038826818696.jar > > 2016-05-03 15:01:53,152 INFO [localhost-startStop-1] > > sizeof.AgentLoader:137 : Trying to load agent @ > > bin/../tomcat/temp/ehcache-sizeof-agent6516450038826818696.jar > > 2016-05-03 15:01:53,157 INFO [localhost-startStop-1] > > impl.DefaultSizeOfEngine:113 : using Agent sizeof engine > > 2016-05-03 15:01:53,319 INFO [localhost-startStop-1] > cube.CubeManager:124 > > : Initializing CubeManager with config kylin_metadata@hbase > > 2016-05-03 15:01:53,322 INFO [localhost-startStop-1] > > persistence.ResourceStore:82 : Using metadata url kylin_metadata@hbase > for > > resource store > > 2016-05-03 15:01:53,470 INFO [localhost-startStop-1] > > hbase.HBaseConnection:139 : connection is null or closed, creating a new > > one > > 2016-05-03 15:01:54,927 DEBUG [localhost-startStop-1] > > hbase.HBaseConnection:185 : HTable 'kylin_metadata' already exists > > 2016-05-03 15:01:54,979 DEBUG [localhost-startStop-1] > cube.CubeManager:811 > > : Loading Cube from folder > kylin_metadata(key='/cube')@kylin_metadata@hbase > > 2016-05-03 15:01:55,064 INFO [localhost-startStop-1] > > cube.CubeDescManager:91 : Initializing CubeDescManager with config > > kylin_metadata@hbase > > 2016-05-03 15:01:55,064 INFO [localhost-startStop-1] > > cube.CubeDescManager:197 : Reloading Cube Metadata from folder > > kylin_metadata(key='/cube_desc')@kylin_metadata@hbase > > 2016-05-03 15:01:55,112 DEBUG [localhost-startStop-1] > > metadata.MetadataManager:315 : Reloading SourceTable from folder > > kylin_metadata(key='/table')@kylin_metadata@hbase > > 2016-05-03 15:01:55,159 DEBUG [localhost-startStop-1] > > metadata.MetadataManager:324 : Loaded 3 SourceTable(s) > > 2016-05-03 15:01:55,159 DEBUG [localhost-startStop-1] > > metadata.MetadataManager:256 : Reloading SourceTable exd info from folder > > kylin_metadata(key='/table_exd')@kylin_metadata@hbase > > 2016-05-03 15:01:55,196 DEBUG [localhost-startStop-1] > > metadata.MetadataManager:265 : Loaded 2 SourceTable EXD(s) > > 2016-05-03 15:01:55,197 DEBUG [localhost-startStop-1] > > metadata.MetadataManager:429 : Reloading DataModel from folder > > kylin_metadata(key='/model_desc')@kylin_metadata@hbase > > 2016-05-03 15:01:55,224 DEBUG [localhost-startStop-1] > > metadata.MetadataManager:443 : Loaded 2 DataModel(s) > > 2016-05-03 15:01:55,225 DEBUG [localhost-startStop-1] > > metadata.MetadataManager:301 : Reloading ExternalFilter from folder > > kylin_metadata(key='/ext_filter')@kylin_metadata@hbase > > 2016-05-03 15:01:55,229 DEBUG [localhost-startStop-1] > > metadata.MetadataManager:310 : Loaded 0 SourceTable(s) > > 2016-05-03 15:01:55,246 DEBUG [localhost-startStop-1] > > cube.CubeDescManager:222 : Loaded 2 Cube(s) > > 2016-05-03 15:01:55,256 DEBUG [localhost-startStop-1] > cube.CubeManager:846 > > : Reloaded new cube: Tutorial_Cube with reference > > beingCUBE[name=Tutorial_Cube] having 1 segments:KYLIN_3UZ4ZT17UO > > 2016-05-03 15:01:55,259 DEBUG [localhost-startStop-1] > cube.CubeManager:846 > > : Reloaded new cube: kylin_sales_cube with reference > > beingCUBE[name=kylin_sales_cube] having 2 > > segments:KYLIN_K7Z527EQEX,KYLIN_ENZP3OPKTE > > 2016-05-03 15:01:55,259 DEBUG [localhost-startStop-1] > cube.CubeManager:817 > > : Loaded 2 Cube(s) > > 2016-05-03 15:01:55,353 INFO [localhost-startStop-1] > > controller.JobController:83 : Initializing Job Engine .... > > 2016-05-03 15:01:55,358 INFO [Thread-11] manager.ExecutableManager:73 : > > Using metadata url: kylin_metadata@hbase > > 2016-05-03 15:01:55,363 INFO [Thread-11] dao.ExecutableDao:65 : Using > > metadata url: kylin_metadata@hbase > > 2016-05-03 15:01:55,393 INFO [localhost-startStop-1] > > badquery.BadQueryHistoryManager:42 : Initializing BadQueryHistoryManager > > with config kylin_metadata@hbase > > 2016-05-03 15:01:55,950 INFO [localhost-startStop-1] > > web.DefaultSecurityFilterChain:28 : Creating filter chain: > > org.springframework.security.web.util.AnyRequestMatcher@1, > > > > > [org.springframework.security.web.context.SecurityContextPersistenceFilter@4a349ef9 > > , > > > > > org.springframework.security.web.authentication.logout.LogoutFilter@44b1137e > > , > > > > > org.springframework.security.web.authentication.UsernamePasswordAuthenticationFilter@4576d86d > > , > > > > > org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter@7d7affbb > > , > > > > > org.springframework.security.web.authentication.www.BasicAuthenticationFilter@162b8e59 > > , > > > > > org.springframework.security.web.savedrequest.RequestCacheAwareFilter@58e806e > > , > > > > > org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@4e91b89b > > , > > > > > org.springframework.security.web.authentication.AnonymousAuthenticationFilter@40eef069 > > , > > org.springframework.security.web.session.SessionManagementFilter@6e99ecd > , > > > org.springframework.security.web.access.ExceptionTranslationFilter@53b8a846 > > , > > > > > org.springframework.security.web.access.intercept.FilterSecurityInterceptor@2fb69b > > ] > > 2016-05-03 15:02:05,485 INFO [pool-5-thread-1] > > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual > running, > > 0 ready, 6 others > > 2016-05-03 15:02:39,492 DEBUG [http-bio-7070-exec-9] > > service.AdminService:90 : Get Kylin Runtime Config > > 2016-05-03 15:02:41,280 DEBUG [http-bio-7070-exec-1] > > 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 15:02:41,369 DEBUG [http-bio-7070-exec-3] > > 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 15:02:41,515 INFO [http-bio-7070-exec-3] > > project.ProjectManager:88 : Initializing ProjectManager with metadata url > > kylin_metadata@hbase > > 2016-05-03 15:02:41,529 DEBUG [http-bio-7070-exec-3] > > project.ProjectManager:104 : Loading Project from folder > > kylin_metadata(key='/project')@kylin_metadata@hbase > > 2016-05-03 15:02:41,540 DEBUG [http-bio-7070-exec-3] > > project.ProjectManager:109 : Loaded 2 Project(s) > > 2016-05-03 15:02:41,540 DEBUG [http-bio-7070-exec-3] > > controller.ProjectController:97 : 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 15:02:41,731 INFO [http-bio-7070-exec-9] > > kafka.KafkaConfigManager:204 : Reloading Kafka Metadata from folder > > kylin_metadata(key='/kafka')@kylin_metadata@hbase > > 2016-05-03 15:02:41,735 DEBUG [http-bio-7070-exec-9] > > kafka.KafkaConfigManager:229 : Loaded 0 KafkaConfig(s) > > 2016-05-03 15:02:41,743 INFO [http-bio-7070-exec-10] > > streaming.StreamingManager:218 : Reloading Streaming Metadata from folder > > kylin_metadata(key='/streaming')@kylin_metadata@hbase > > 2016-05-03 15:02:41,751 DEBUG [http-bio-7070-exec-10] > > streaming.StreamingManager:243 : Loaded 0 StreamingConfig(s) > > 2016-05-03 15:02:49,864 INFO [http-bio-7070-exec-10] > > realization.RealizationRegistry:75 : Initializing RealizationRegistry > with > > metadata url kylin_metadata@hbase > > 2016-05-03 15:02:49,864 INFO [http-bio-7070-exec-1] > > project.ProjectL2Cache:172 : Loading L2 project cache for Tutorial > > 2016-05-03 15:02:50,239 INFO [http-bio-7070-exec-10] > > reflections.Reflections:224 : Reflections took 358 ms to scan 18 urls, > > producing 274 keys and 2131 values > > 2016-05-03 15:02:50,243 INFO [http-bio-7070-exec-10] > > hybrid.HybridManager:82 : Initializing HybridManager with config > > kylin_metadata@hbase > > 2016-05-03 15:02:50,248 DEBUG [http-bio-7070-exec-10] > > hybrid.HybridManager:92 : Loading Hybrid from folder > > kylin_metadata(key='/hybrid')@kylin_metadata@hbase > > 2016-05-03 15:02:50,248 DEBUG [http-bio-7070-exec-10] > > hybrid.HybridManager:98 : Loaded 0 Hybrid(s) > > 2016-05-03 15:02:50,250 INFO [http-bio-7070-exec-10] > > invertedindex.IIManager:101 : Initializing IIManager with config > > kylin_metadata@hbase > > 2016-05-03 15:02:50,255 DEBUG [http-bio-7070-exec-10] > > invertedindex.IIManager:226 : Loading II from folder > > kylin_metadata(key='/invertedindex')@kylin_metadata@hbase > > 2016-05-03 15:02:50,255 DEBUG [http-bio-7070-exec-10] > > invertedindex.IIManager:232 : Loaded 0 II(s) > > 2016-05-03 15:02:50,258 INFO [http-bio-7070-exec-10] > > realization.RealizationRegistry:103 : RealizationRegistry is > > {CUBE=org.apache.kylin.cube.CubeManager@46c95a9d, > > HYBRID=org.apache.kylin.storage.hybrid.HybridManager@4d5c1db9, > > INVERTED_INDEX=org.apache.kylin.invertedindex.IIManager@5aa3845c} > > 2016-05-03 15:02:50,260 INFO [http-bio-7070-exec-1] > > controller.TableController:89 : Return all table metadata in 396 seconds > > 2016-05-03 15:02:54,910 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 15:02:55,053 DEBUG [http-bio-7070-exec-10] > > service.CacheService:144 : Creating a new data source, OLAP data source > > pointing to kylin_metadata@hbase > > 2016-05-03 15:02:55,055 INFO [http-bio-7070-exec-10] > > project.ProjectL2Cache:172 : Loading L2 project cache for TUTORIAL > > 2016-05-03 15:02:55,060 INFO [http-bio-7070-exec-10] > > schema.OLAPSchemaFactory:135 : Schema json:{ > > "version": "1.0", > > "defaultSchema": "DEFAULT", > > "schemas": [ > > { > > "type": "custom", > > "name": "DEFAULT", > > "factory": "org.apache.kylin.query.schema.OLAPSchemaFactory", > > "operand": { > > "project": "TUTORIAL" > > }, > > "functions": [ > > { > > name: 'MASSIN', > > className: 'org.apache.kylin.query.udf.MassInUDF' > > } > > ] > > } > > ] > > } > > 2016-05-03 15:02:55,061 DEBUG [http-bio-7070-exec-10] > > 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": "TUTORIAL" > > }, > > "functions": [ > > { > > name: 'MASSIN', > > className: 'org.apache.kylin.query.udf.MassInUDF' > > } > > ] > > } > > ] > > } > > > > 2016-05-03 15:02:55,368 DEBUG [http-bio-7070-exec-10] > > service.QueryService:289 : getting table metas > > 2016-05-03 15:02:55,416 DEBUG [http-bio-7070-exec-10] > > service.QueryService:307 : getting column metas > > 2016-05-03 15:02:55,454 DEBUG [http-bio-7070-exec-10] > > service.QueryService:321 : done column metas > > 2016-05-03 15:03:05,474 INFO [pool-5-thread-1] > > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual > running, > > 0 ready, 6 others > > 2016-05-03 15:03:20,325 INFO [http-bio-7070-exec-5] > > controller.QueryController:174 : Using project: Tutorial > > 2016-05-03 15:03:20,326 INFO [http-bio-7070-exec-5] > > 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 LIMIT 50000 > > 2016-05-03 15:03:20,825 INFO [http-bio-7070-exec-5] > routing.QueryRouter:48 > > : The project manager's reference is > > org.apache.kylin.metadata.project.ProjectManager@972713a > > 2016-05-03 15:03:20,826 INFO [http-bio-7070-exec-5] > routing.QueryRouter:60 > > : Find candidates by table DEFAULT.KYLIN_SALES and project=TUTORIAL : > > org.apache.kylin.query.routing.Candidate@6ab02f87 > > 2016-05-03 15:03:20,828 INFO [http-bio-7070-exec-5] > routing.QueryRouter:49 > > : Applying rule: class > > org.apache.kylin.query.routing.rules.RemoveUncapableRealizationsRule, > > realizations before: [Tutorial_Cube(CUBE)], realizations after: > > [Tutorial_Cube(CUBE)] > > 2016-05-03 15:03:20,829 INFO [http-bio-7070-exec-5] > routing.QueryRouter:49 > > : Applying rule: class > > org.apache.kylin.query.routing.rules.RealizationSortRule, realizations > > before: [Tutorial_Cube(CUBE)], realizations after: [Tutorial_Cube(CUBE)] > > 2016-05-03 15:03:20,829 INFO [http-bio-7070-exec-5] > routing.QueryRouter:72 > > : The realizations remaining: [Tutorial_Cube(CUBE)] And the final chosen > > one is the first one > > 2016-05-03 15:03:21,076 DEBUG [http-bio-7070-exec-5] > > enumerator.OLAPEnumerator:107 : query storage... > > 2016-05-03 15:03:21,090 INFO [http-bio-7070-exec-5] > > v2.CubeStorageQuery:251 : exactAggregation is true > > 2016-05-03 15:03:21,093 INFO [http-bio-7070-exec-5] > > v2.CubeStorageQuery:357 : Memory budget is set to: 784134 > > 2016-05-03 15:03:21,105 INFO [http-bio-7070-exec-5] > > dict.DictionaryManager:385 : DictionaryManager(91588327) loading > > DictionaryInfo(loadDictObj:true) at > > > /dict/DEFAULT.KYLIN_CAL_DT/CAL_DT/7f549503-b7f8-4ac9-b826-0f2ceaed1304.dict > > 2016-05-03 15:03:21,134 DEBUG [http-bio-7070-exec-5] > > v2.CubeHBaseEndpointRPC:256 : New scanner for current segment > > Tutorial_Cube[20111230000000_20160430000000] will use > > SCAN_FILTER_AGGR_CHECKMEM as endpoint's behavior > > 2016-05-03 15:03:21,148 DEBUG [http-bio-7070-exec-5] > > v2.CubeHBaseEndpointRPC:291 : Serialized scanRequestBytes 320 bytes, > > rawScanBytesString 46 bytes > > 2016-05-03 15:03:21,148 INFO [http-bio-7070-exec-5] > > 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 15:03:21,150 INFO [http-bio-7070-exec-5] v2.CubeHBaseRPC:309 > : > > Visiting hbase table KYLIN_3UZ4ZT17UO: cuboid exact match, from 8 to 8 > > Start: \x00\x00\x00\x00\x00\x00\x00\x00\x00\x08\x00\x00\x00 > > (\x00\x00\x00\x00\x00\x00\x00\x00\x00\x08\x00\x00\x00) Stop: > > \x00\x00\x00\x00\x00\x00\x00\x00\x00\x08\xFF\xFF\xFF\x00 > > (\x00\x00\x00\x00\x00\x00\x00\x00\x00\x08\xFF\xFF\xFF\x00), No Fuzzy Key > > 2016-05-03 15:03:21,150 DEBUG [http-bio-7070-exec-5] > > v2.CubeHBaseEndpointRPC:300 : Submitting rpc to 1 shards starting from > > shard 1, scan requests count 1 > > 2016-05-03 15:03:21,220 INFO [http-bio-7070-exec-5] > > v2.CubeHBaseEndpointRPC:125 : Timeout for ExpectedSizeIterator is 60000 > > 2016-05-03 15:03:21,227 DEBUG [http-bio-7070-exec-5] > > enumerator.OLAPEnumerator:127 : return TupleIterator... > > 2016-05-03 15:03:21,284 ERROR [pool-7-thread-1] > v2.CubeHBaseEndpointRPC:98 > > : Execution exception when running task in pool-7-thread-1 > > 2016-05-03 15:03:21,285 ERROR [pool-7-thread-1] > v2.CubeHBaseEndpointRPC:108 > > : Caught exception in thread pool-7-thread-1: > > java.lang.RuntimeException: Error when visiting cubes by endpoint: > > at > > > > > org.apache.kylin.storage.hbase.cube.v2.CubeHBaseEndpointRPC$1.run(CubeHBaseEndpointRPC.java:323) > > at > java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) > > at java.util.concurrent.FutureTask.run(FutureTask.java:262) > > at > > > > > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) > > at > > > > > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) > > at java.lang.Thread.run(Thread.java:745) > > Caused by: org.apache.hadoop.hbase.DoNotRetryIOException: > > org.apache.hadoop.hbase.DoNotRetryIOException: > java.lang.NoSuchMethodError: > > > > > org.apache.hadoop.hbase.coprocessor.RegionCoprocessorEnvironment.getRegion()Lorg/apache/hadoop/hbase/regionserver/HRegion; > > at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2212) > > at org.apache.hadoop.hbase.ipc.CallRunner.run(CallRunner.java:109) > > at > > > org.apache.hadoop.hbase.ipc.RpcExecutor.consumerLoop(RpcExecutor.java:133) > > at org.apache.hadoop.hbase.ipc.RpcExecutor$1.run(RpcExecutor.java:108) > > at java.lang.Thread.run(Thread.java:745) > > Caused by: java.lang.NoSuchMethodError: > > > > > org.apache.hadoop.hbase.coprocessor.RegionCoprocessorEnvironment.getRegion()Lorg/apache/hadoop/hbase/regionserver/HRegion; > > at > > > > > org.apache.kylin.storage.hbase.cube.v2.coprocessor.endpoint.CubeVisitService.visitCube(CubeVisitService.java:158) > > at > > > > > org.apache.kylin.storage.hbase.cube.v2.coprocessor.endpoint.generated.CubeVisitProtos$CubeVisitService.callMethod(CubeVisitProtos.java:3800) > > at > > > org.apache.hadoop.hbase.regionserver.HRegion.execService(HRegion.java:7789) > > at > > > > > org.apache.hadoop.hbase.regionserver.RSRpcServices.execServiceOnRegion(RSRpcServices.java:1988) > > at > > > > > org.apache.hadoop.hbase.regionserver.RSRpcServices.execService(RSRpcServices.java:1970) > > at > > > > > org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$2.callBlockingMethod(ClientProtos.java:33652) > > at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2170) > > ... 4 more > > > > at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) > > at > > > > > sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:57) > > at > > > > > sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) > > at java.lang.reflect.Constructor.newInstance(Constructor.java:526) > > at > > > > > org.apache.hadoop.ipc.RemoteException.instantiateException(RemoteException.java:106) > > at > > > > > org.apache.hadoop.ipc.RemoteException.unwrapRemoteException(RemoteException.java:95) > > at > > > > > org.apache.hadoop.hbase.protobuf.ProtobufUtil.getRemoteException(ProtobufUtil.java:327) > > at > > > > > org.apache.hadoop.hbase.protobuf.ProtobufUtil.execService(ProtobufUtil.java:1624) > > at > > > > > org.apache.hadoop.hbase.ipc.RegionCoprocessorRpcChannel$1.call(RegionCoprocessorRpcChannel.java:92) > > at > > > > > org.apache.hadoop.hbase.ipc.RegionCoprocessorRpcChannel$1.call(RegionCoprocessorRpcChannel.java:89) > > at > > > > > org.apache.hadoop.hbase.client.RpcRetryingCaller.callWithRetries(RpcRetryingCaller.java:126) > > at > > > > > org.apache.hadoop.hbase.ipc.RegionCoprocessorRpcChannel.callExecService(RegionCoprocessorRpcChannel.java:95) > > at > > > > > org.apache.hadoop.hbase.ipc.CoprocessorRpcChannel.callMethod(CoprocessorRpcChannel.java:56) > > at > > > > > org.apache.kylin.storage.hbase.cube.v2.coprocessor.endpoint.generated.CubeVisitProtos$CubeVisitService$Stub.visitCube(CubeVisitProtos.java:3861) > > at > > > > > org.apache.kylin.storage.hbase.cube.v2.CubeHBaseEndpointRPC$2.call(CubeHBaseEndpointRPC.java:361) > > at > > > > > org.apache.kylin.storage.hbase.cube.v2.CubeHBaseEndpointRPC$2.call(CubeHBaseEndpointRPC.java:357) > > at org.apache.hadoop.hbase.client.HTable$15.call(HTable.java:1797) > > ... 4 more > > Caused by: > > > > > org.apache.hadoop.hbase.ipc.RemoteWithExtrasException(org.apache.hadoop.hbase.DoNotRetryIOException): > > org.apache.hadoop.hbase.DoNotRetryIOException: > java.lang.NoSuchMethodError: > > > > > org.apache.hadoop.hbase.coprocessor.RegionCoprocessorEnvironment.getRegion()Lorg/apache/hadoop/hbase/regionserver/HRegion; > > at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2212) > > at org.apache.hadoop.hbase.ipc.CallRunner.run(CallRunner.java:109) > > at > > > org.apache.hadoop.hbase.ipc.RpcExecutor.consumerLoop(RpcExecutor.java:133) > > at org.apache.hadoop.hbase.ipc.RpcExecutor$1.run(RpcExecutor.java:108) > > at java.lang.Thread.run(Thread.java:745) > > Caused by: java.lang.NoSuchMethodError: > > > > > org.apache.hadoop.hbase.coprocessor.RegionCoprocessorEnvironment.getRegion()Lorg/apache/hadoop/hbase/regionserver/HRegion; > > at > > > > > org.apache.kylin.storage.hbase.cube.v2.coprocessor.endpoint.CubeVisitService.visitCube(CubeVisitService.java:158) > > at > > > > > org.apache.kylin.storage.hbase.cube.v2.coprocessor.endpoint.generated.CubeVisitProtos$CubeVisitService.callMethod(CubeVisitProtos.java:3800) > > at > > > org.apache.hadoop.hbase.regionserver.HRegion.execService(HRegion.java:7789) > > at > > > > > org.apache.hadoop.hbase.regionserver.RSRpcServices.execServiceOnRegion(RSRpcServices.java:1988) > > at > > > > > org.apache.hadoop.hbase.regionserver.RSRpcServices.execService(RSRpcServices.java:1970) > > at > > > > > org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$2.callBlockingMethod(ClientProtos.java:33652) > > at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2170) > > ... 4 more > > > > at > org.apache.hadoop.hbase.ipc.RpcClientImpl.call(RpcClientImpl.java:1268) > > at > > > > > org.apache.hadoop.hbase.ipc.AbstractRpcClient.callBlockingMethod(AbstractRpcClient.java:226) > > at > > > > > org.apache.hadoop.hbase.ipc.AbstractRpcClient$BlockingRpcChannelImplementation.callBlockingMethod(AbstractRpcClient.java:331) > > at > > > > > org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$BlockingStub.execService(ClientProtos.java:34118) > > at > > > > > org.apache.hadoop.hbase.protobuf.ProtobufUtil.execService(ProtobufUtil.java:1620) > > ... 13 more > > 2016-05-03 15:04:05,474 INFO [pool-5-thread-1] > > threadpool.DefaultScheduler:106 : Job Fetcher: 0 running, 0 actual > running, > > 0 ready, 6 others > > 2016-05-03 15:04:21,229 ERROR [http-bio-7070-exec-5] > > 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$$f73318de.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:57) > > at > > > > > sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) > > at java.lang.reflect.Method.invoke(Method.java:606) > > 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:201) > > 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: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.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 15:04:21,233 INFO [http-bio-7070-exec-5] > > 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 LIMIT 50000 > > User: ADMIN > > Success: false > > Duration: 0.0 > > Project: Tutorial > > Realization Names: [Tutorial_Cube] > > Cuboid Ids: [8] > > 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 15:04:21,237 ERROR [http-bio-7070-exec-5] > > 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:57) > > at > > > > > sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) > > at java.lang.reflect.Method.invoke(Method.java:606) > > 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:201) > > 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: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) > > > > > > > =============================================================================================================================================== > > > > On Tue, May 3, 2016 at 9:56 PM, hongbin ma <[email protected]> wrote: > > > > > Hi Amit > > > > > > seems no attachment is found > > > > > > On Tue, May 3, 2016 at 11:09 PM, Amit Jain <[email protected]> wrote: > > > > > > > Hi Li, > > > > Log file is attached. Please let me know your findings. > > > > Thanks for your help. > > > > Amit > > > > > > > > On Tue, May 3, 2016 at 5:00 AM, Li Yang <[email protected]> wrote: > > > > > > > >> Could you share kylin.log? There must be something else behind the > > > timeout > > > >> error. > > > >> > > > >> On Fri, Apr 29, 2016 at 11:53 AM, Amit Jain <[email protected]> > wrote: > > > >> > > > >> > I'm getting following error when running the query as described on > > > >> > http://kylin.apache.org/docs15/tutorial/kylin_sample.html > > > >> > I'm get to the step where the cube build succeeds but when I run > the > > > >> query > > > >> > on Insight, I get the error. > > > >> > > > > >> > 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! > > > >> > > > > >> > Please note that I'm running this on a 5 Node Hadoop Cluster with > > > >> CDH5.7 on > > > >> > AWS. I tried installing Kylin on datanode first and got this > error. > > > >> Later I > > > >> > installed Kylin on namenode and still getting the same error > > message. > > > >> > I can make Kylin work on CDH VM with single node but not on a > Hadoop > > > >> > multinode cluster. > > > >> > Please let me know how to fix this. > > > >> > Thanks > > > >> > Amit > > > >> > > > > >> > > > > > > > > > > > > > > > > > -- > > > Regards, > > > > > > *Bin Mahone | 马洪宾* > > > Apache Kylin: http://kylin.io > > > Github: https://github.com/binmahone > > > > > > > > > -- > Regards, > > *Bin Mahone | 马洪宾* > Apache Kylin: http://kylin.io > Github: https://github.com/binmahone >
