Uploaded image for project: 'Ambari'
  1. Ambari
  2. AMBARI-10160

Hive Metastore alert check "show databases" results in a Tez session causing RM to be unresponsive

    XMLWordPrintableJSON

    Details

    • Type: Bug
    • Status: Resolved
    • Priority: Critical
    • Resolution: Fixed
    • Affects Version/s: 2.0.0
    • Fix Version/s: 2.0.0
    • Component/s: ambari-server
    • Labels:
      None

      Description

      The HS2 check does this:

      export HIVE_CONF_DIR='/etc/hive/conf.server/' ; hive --hiveconf hive.metastore.uris=thrift://revo3.hortonworks.local:9083 -e 'show databases;'
      

      Looks like this does this to hive:

      [3/19/15, 7:47:37 PM] Paul Codding: 2015-03-19 18:44:22,959 INFO  [main]: parse.ParseDriver (ParseDriver.java:parse(185)) - Parsing command: show databases
      2015-03-19 18:44:23,801 INFO  [main]: parse.ParseDriver (ParseDriver.java:parse(206)) - Parse Completed
      2015-03-19 18:44:23,809 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=parse start=1426808662932 end=1426808663809 duration=877 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:23,818 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogBegin(108)) - <PERFLOG method=semanticAnalyze from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:24,002 INFO  [main]: ql.Driver (Driver.java:compile(427)) - Semantic Analysis Completed
      2015-03-19 18:44:24,003 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=semanticAnalyze start=1426808663818 end=1426808664003 duration=185 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:24,386 INFO  [main]: exec.ListSinkOperator (Operator.java:initialize(346)) - Initializing Self OP[0]
      2015-03-19 18:44:24,394 INFO  [main]: exec.ListSinkOperator (Operator.java:initializeChildren(419)) - Operator 0 OP initialized
      2015-03-19 18:44:24,395 INFO  [main]: exec.ListSinkOperator (Operator.java:initialize(394)) - Initialization Done 0 OP
      2015-03-19 18:44:24,419 INFO  [main]: ql.Driver (Driver.java:getSchema(235)) - Returning Hive schema: Schema(fieldSchemas:[FieldSchema(name:database_name, type:string, comment:from deserializer)], properties:null)
      2015-03-19 18:44:24,420 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=compile start=1426808662818 end=1426808664420 duration=1602 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:24,420 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogBegin(108)) - <PERFLOG method=Driver.execute from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:24,420 INFO  [main]: ql.Driver (Driver.java:execute(1285)) - Starting command: show databases
      2015-03-19 18:44:25,090 INFO  [main]: impl.TimelineClientImpl (TimelineClientImpl.java:serviceInit(285)) - Timeline service address: http://revo2.hortonworks.local:8188/ws/v1/timeline/
      2015-03-19 18:44:25,093 INFO  [main]: hooks.ATSHook (ATSHook.java:<init>(87)) - Created ATS Hook
      2015-03-19 18:44:25,093 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogBegin(108)) - <PERFLOG method=PreHook.org.apache.hadoop.hive.ql.hooks.ATSHook from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,098 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=PreHook.org.apache.hadoop.hive.ql.hooks.ATSHook start=1426808665093 end=1426808665098 duration=5 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,103 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=TimeToSubmit start=1426808662818 end=1426808665103 duration=2285 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,103 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogBegin(108)) - <PERFLOG method=runTasks from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,103 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogBegin(108)) - <PERFLOG method=task.DDL.Stage-0 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,114 INFO  [main]: ql.Driver (Driver.java:launchTask(1602)) - Starting task [Stage-0:DDL] in serial mode
      2015-03-19 18:44:25,309 INFO  [main]: exec.DDLTask (DDLTask.java:showDatabases(2173)) - results : 1
      2015-03-19 18:44:25,317 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=runTasks start=1426808665103 end=1426808665317 duration=214 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,319 INFO  [main]: hooks.ATSHook (ATSHook.java:<init>(87)) - Created ATS Hook
      2015-03-19 18:44:25,319 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogBegin(108)) - <PERFLOG method=PostHook.org.apache.hadoop.hive.ql.hooks.ATSHook from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,320 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=PostHook.org.apache.hadoop.hive.ql.hooks.ATSHook start=1426808665319 end=1426808665320 duration=1 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,321 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=Driver.execute start=1426808664420 end=1426808665321 duration=901 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,330 INFO  [main]: ql.Driver (SessionState.java:printInfo(824)) - OK
      2015-03-19 18:44:25,331 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogBegin(108)) - <PERFLOG method=releaseLocks from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,331 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=releaseLocks start=1426808665331 end=1426808665331 duration=0 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,332 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=Driver.run start=1426808662817 end=1426808665332 duration=2515 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,353 INFO  [main]: Configuration.deprecation (Configuration.java:warnOnceIfDeprecated(1051)) - mapred.input.dir is deprecated. Instead, use mapreduce.input.fileinputformat.inputdir
      2015-03-19 18:44:25,536 INFO  [main]: mapred.FileInputFormat (FileInputFormat.java:listStatus(247)) - Total input paths to process : 1
      2015-03-19 18:44:25,635 INFO  [main]: exec.ListSinkOperator (Operator.java:close(595)) - 0 finished. closing... 
      2015-03-19 18:44:25,635 INFO  [main]: exec.ListSinkOperator (Operator.java:close(613)) - 0 Close done
      2015-03-19 18:44:25,660 INFO  [main]: CliDriver (SessionState.java:printInfo(824)) - Time taken: 2.529 seconds, Fetched: 1 row(s)
      2015-03-19 18:44:25,660 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogBegin(108)) - <PERFLOG method=releaseLocks from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,662 INFO  [main]: log.PerfLogger (PerfLogger.java:PerfLogEnd(135)) - </PERFLOG method=releaseLocks start=1426808665660 end=1426808665662 duration=2 from=org.apache.hadoop.hive.ql.Driver>
      2015-03-19 18:44:25,708 INFO  [main]: tez.TezSessionPoolManager (TezSessionPoolManager.java:close(174)) - Closing tez session default? false
      2015-03-19 18:44:25,709 INFO  [main]: tez.TezSessionState (TezSessionState.java:close(263)) - Closing Tez Session
      2015-03-19 18:44:25,710 INFO  [main]: client.TezClient (TezClient.java:stop(434)) - Shutting down Tez Session, sessionName=HIVE-f96da6a9-ad75-4949-b8ba-a9e3b65278d3, applicationId=application_1426808089446_0009
      [3/19/15, 7:47:50 PM] Paul Codding: salient
      [3/19/15, 7:47:50 PM] Paul Codding: 2015-03-19 18:44:22,959 INFO  [main]: parse.ParseDriver (ParseDriver.java:parse(185)) - Parsing command: show databases
      2015-03-19 18:44:23,801 INFO  [main]: parse.ParseDriver (ParseDriver.java:parse(206)) - Parse Completed
      

      Changing this check to use the MR enginer instead of TEZ corrects the problem:

      export HIVE_CONF_DIR='/etc/hive/conf.server/' ; hive --hiveconf hive.metastore.uris=thrift://revo3.hortonworks.local:9083 --hiveconf hive.execution.engine=mr -e 'show databases;'
      

        Attachments

        1. AMBARI-10160.patch
          0.9 kB
          Jonathan Hurley

          Issue Links

            Activity

              People

              • Assignee:
                jonathanhurley Jonathan Hurley
                Reporter:
                jonathanhurley Jonathan Hurley
              • Votes:
                0 Vote for this issue
                Watchers:
                2 Start watching this issue

                Dates

                • Created:
                  Updated:
                  Resolved: