As some users met same issue like this, let’s use this JIRA to track and discuss. https://issues.apache.org/jira/browse/KYLIN-1651
Thanks, Dong Original Message Sender:Amit [email protected] Recipient:[email protected] Date:Wednesday, May 4, 2016 12:18 Subject:Re: Timeout visiting cube! 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
