Uploaded image for project: 'Hive'
  1. Hive
  2. HIVE-22171

Issues while trying to insert into a table

    XMLWordPrintableJSON

Details

    • Task
    • Status: Open
    • Major
    • Resolution: Unresolved
    • None
    • None
    • None
    • None

    Description

      java.sql.SQLException: Error while processing statement: FAILED: Execution Error, return code 2 from org.apache.hadoop.hive.ql.exec.tez.TezTask. Vertex failed, vertexName=Map 1, vertexId=vertex_1567624202104_2443_1_01, diagnostics=[Task failed, taskId=task_1567624202104_2443_1_01_000002, diagnostics=[TaskAttempt 0 failed, info=[Container container_e103_1567624202104_2443_01_000002 finished with diagnostics set to [Container failed, exitCode=-104. Container [pid=2449,containerID=container_e103_1567624202104_2443_01_000002] is running beyond physical memory limits. Current usage: 6.1 GB of 6 GB physical memory used; 8.9 GB of 12.6 GB virtual memory used. Killing container.
      Dump of the process-tree for container_e103_1567624202104_2443_01_000002 :

      • PID PPID PGRPID SESSID CMD_NAME USER_MODE_TIME(MILLIS) SYSTEM_TIME(MILLIS) VMEM_USAGE(BYTES) RSSMEM_USAGE(PAGES) FULL_CMD_LINE
      • 2449 2447 2449 2449 (bash) 0 0 115900416 305 /bin/bash -c /etc/alternatives/jdk/bin/java -server -Djava.net.preferIPv4Stack=true -Dhdp.version=2.6.5.0-292 -XX:+PrintGCDetails -verbose:gc -XX:+PrintGCTimeStamps -XX:+UseNUMA -XX:+UseParallelGC -Xmx6554m -Dlog4j.configuratorClass=org.apache.tez.common.TezLog4jConfigurator -Dlog4j.configuration=tez-container-log4j.properties -Dyarn.app.container.log.dir=/grid/6/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000002 -Dtez.root.logger=INFO,CLA -Djava.io.tmpdir=/grid/9/hadoop/yarn/local/usercache/x010722/appcache/application_1567624202104_2443/container_e103_1567624202104_2443_01_000002/tmp org.apache.tez.runtime.task.TezChild 10.19.232.34 41227 container_e103_1567624202104_2443_01_000002 application_1567624202104_2443 1 1>/grid/6/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000002/stdout 2>/grid/6/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000002/stderr
      • 2461 2449 2449 2449 (java) 14283 3448 9414467584 1590493 /etc/alternatives/jdk/bin/java -server -Djava.net.preferIPv4Stack=true -Dhdp.version=2.6.5.0-292 -XX:+PrintGCDetails -verbose:gc -XX:+PrintGCTimeStamps -XX:+UseNUMA -XX:+UseParallelGC -Xmx6554m -Dlog4j.configuratorClass=org.apache.tez.common.TezLog4jConfigurator -Dlog4j.configuration=tez-container-log4j.properties -Dyarn.app.container.log.dir=/grid/6/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000002 -Dtez.root.logger=INFO,CLA -Djava.io.tmpdir=/grid/9/hadoop/yarn/local/usercache/x010722/appcache/application_1567624202104_2443/container_e103_1567624202104_2443_01_000002/tmp org.apache.tez.runtime.task.TezChild 10.19.232.34 41227 container_e103_1567624202104_2443_01_000002 application_1567624202104_2443 1

      Container killed on request. Exit code is 143
      Container exited with a non-zero exit code 143.
      ]], TaskAttempt 1 failed, info=[Error: Failure while running task:java.lang.RuntimeException: java.lang.RuntimeException: org.apache.hadoop.hive.ql.metadata.HiveException: Hive Runtime Error while processing row {"dimquoteid":0,"dimquotedescid":0,"datedimidquotecreate":0,"datedimidquotesale":0,"dimquoteidparent":"

      {C4DFBEF6-D938-E711-80DE-00155D601E14}","dimquoteidcopiedfromquotenbr":0,"dimquoteidoriginalchildwinner":0,"dimquoteidpurchasecomparativequote":0,"dimquoteidcurrentchildwinner":0,"dimquoteidpurchased":0,"sessionid":null,"agreementsystemcarriercode":"ASI","altagreementsystemcarriercode":"BLT","altissuancesystemcode":"BLT","altquoteid":null,"bindablerateind":null,"buydnqind":null,"buystartind":null,"dnqeverind":0,"issuancesystemcode":"ASI","kickoutind":0,"originalquotesourcecategorycode":"CQCR","originalquotesourcecode":0,"productcode":"HO","propertypartnercode":"ASI","quotechannelcode":"DI","quotecreatedate":"","quotefinishind":1,"quotekey":0,"quotesoldind":0,"quotestartind":1,"quotenbr":null,"quotepolicytermeffectivedate":null,"quotepolicytermexpirationdate":null,"quotesaledate":"","quotetypecode":"C","soldpolicynbr":0,"statecode":null,"uwcarriercode":"ASI","partitiondate":"2017-05-15","datecreated":"2017-05-14 15:32:56.207","rdsid":null,"policyid":"{C4DFBEF6-D938-E711-80DE-00155D601E14}","quoteiterationtransactiondatetime":"2017-05-14 15:32:56.207"}
      at org.apache.hadoop.hive.ql.exec.tez.TezProcessor.initializeAndRunProcessor(TezProcessor.java:173)
      at org.apache.hadoop.hive.ql.exec.tez.TezProcessor.run(TezProcessor.java:139)
      at org.apache.tez.runtime.LogicalIOProcessorRuntimeTask.run(LogicalIOProcessorRuntimeTask.java:347)
      at org.apache.tez.runtime.task.TezTaskRunner$TaskRunnerCallable$1.run(TezTaskRunner.java:194)
      at org.apache.tez.runtime.task.TezTaskRunner$TaskRunnerCallable$1.run(TezTaskRunner.java:185)
      at java.security.AccessController.doPrivileged(Native Method)
      at javax.security.auth.Subject.doAs(Subject.java:422)
      at org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1869)
      at org.apache.tez.runtime.task.TezTaskRunner$TaskRunnerCallable.callInternal(TezTaskRunner.java:185)
      at org.apache.tez.runtime.task.TezTaskRunner$TaskRunnerCallable.callInternal(TezTaskRunner.java:181)
      at org.apache.tez.common.CallableWithNdc.call(CallableWithNdc.java:36)
      at java.util.concurrent.FutureTask.run(FutureTask.java:266)
      at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
      at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
      at java.lang.Thread.run(Thread.java:748)
      Caused by: java.lang.RuntimeException: org.apache.hadoop.hive.ql.metadata.HiveException: Hive Runtime Error while processing row {"dimquoteid":0,"dimquotedescid":0,"datedimidquotecreate":0,"datedimidquotesale":0,"dimquoteidparent":"{C4DFBEF6-D938-E711-80DE-00155D601E14}

      ","dimquoteidcopiedfromquotenbr":0,"dimquoteidoriginalchildwinner":0,"dimquoteidpurchasecomparativequote":0,"dimquoteidcurrentchildwinner":0,"dimquoteidpurchased":0,"sessionid":null,"agreementsystemcarriercode":"ASI","altagreementsystemcarriercode":"BLT","altissuancesystemcode":"BLT","altquoteid":null,"bindablerateind":null,"buydnqind":null,"buystartind":null,"dnqeverind":0,"issuancesystemcode":"ASI","kickoutind":0,"originalquotesourcecategorycode":"CQCR","originalquotesourcecode":0,"productcode":"HO","propertypartnercode":"ASI","quotechannelcode":"DI","quotecreatedate":"","quotefinishind":1,"quotekey":0,"quotesoldind":0,"quotestartind":1,"quotenbr":null,"quotepolicytermeffectivedate":null,"quotepolicytermexpirationdate":null,"quotesaledate":"","quotetypecode":"C","soldpolicynbr":0,"statecode":null,"uwcarriercode":"ASI","partitiondate":"2017-05-15","datecreated":"2017-05-14 15:32:56.207","rdsid":null,"policyid":"{C4DFBEF6-D938-E711-80DE-00155D601E14}","quoteiterationtransactiondatetime":"2017-05-14 15:32:56.207"}
      at org.apache.hadoop.hive.ql.exec.tez.MapRecordSource.processRow(MapRecordSource.java:96)
      at org.apache.hadoop.hive.ql.exec.tez.MapRecordSource.pushRecord(MapRecordSource.java:73)
      at org.apache.hadoop.hive.ql.exec.tez.MapRecordProcessor.run(MapRecordProcessor.java:325)
      at org.apache.hadoop.hive.ql.exec.tez.TezProcessor.initializeAndRunProcessor(TezProcessor.java:150)
      ... 14 more
      Caused by: org.apache.hadoop.hive.ql.metadata.HiveException: Hive Runtime Error while processing row {"dimquoteid":0,"dimquotedescid":0,"datedimidquotecreate":0,"datedimidquotesale":0,"dimquoteidparent":"

      {C4DFBEF6-D938-E711-80DE-00155D601E14}

      ","dimquoteidcopiedfromquotenbr":0,"dimquoteidoriginalchildwinner":0,"dimquoteidpurchasecomparativequote":0,"dimquoteidcurrentchildwinner":0,"dimquoteidpurchased":0,"sessionid":null,"agreementsystemcarriercode":"ASI","altagreementsystemcarriercode":"BLT","altissuancesystemcode":"BLT","altquoteid":null,"bindablerateind":null,"buydnqind":null,"buystartind":null,"dnqeverind":0,"issuancesystemcode":"ASI","kickoutind":0,"originalquotesourcecategorycode":"CQCR","originalquotesourcecode":0,"productcode":"HO","propertypartnercode":"ASI","quotechannelcode":"DI","quotecreatedate":"","quotefinishind":1,"quotekey":0,"quotesoldind":0,"quotestartind":1,"quotenbr":null,"quotepolicytermeffectivedate":null,"quotepolicytermexpirationdate":null,"quotesaledate":"","quotetypecode":"C","soldpolicynbr":0,"statecode":null,"uwcarriercode":"ASI","partitiondate":"2017-05-15","datecreated":"2017-05-14 15:32:56.207","rdsid":null,"policyid":"{C4DFBEF6-D938-E711-80DE-00155D601E14}","quoteiterationtransactiondatetime":"2017-05-14 15:32:56.207"}
      at org.apache.hadoop.hive.ql.exec.MapOperator.process(MapOperator.java:565)
      at org.apache.hadoop.hive.ql.exec.tez.MapRecordSource.processRow(MapRecordSource.java:88)
      ... 17 more
      Caused by: org.apache.hadoop.hive.ql.metadata.HiveException: Unexpected exception: org.apache.hadoop.hive.ql.metadata.HiveException: java.io.IOException: Filesystem closed
      at org.apache.hadoop.hive.ql.exec.MapJoinOperator.process(MapJoinOperator.java:448)
      at org.apache.hadoop.hive.ql.exec.Operator.forward(Operator.java:841)
      at org.apache.hadoop.hive.ql.exec.TableScanOperator.process(TableScanOperator.java:133)
      at org.apache.hadoop.hive.ql.exec.MapOperator$MapOpCtx.forward(MapOperator.java:170)
      at org.apache.hadoop.hive.ql.exec.MapOperator.process(MapOperator.java:555)
      ... 18 more
      Caused by: org.apache.hadoop.hive.ql.metadata.HiveException: org.apache.hadoop.hive.ql.metadata.HiveException: java.io.IOException: Filesystem closed
      at org.apache.hadoop.hive.ql.exec.FileSinkOperator.createBucketFiles(FileSinkOperator.java:580)
      at org.apache.hadoop.hive.ql.exec.FileSinkOperator.createNewPaths(FileSinkOperator.java:889)
      at org.apache.hadoop.hive.ql.exec.FileSinkOperator.getDynOutPaths(FileSinkOperator.java:996)
      at org.apache.hadoop.hive.ql.exec.FileSinkOperator.process(FileSinkOperator.java:719)
      at org.apache.hadoop.hive.ql.exec.Operator.forward(Operator.java:841)
      at org.apache.hadoop.hive.ql.exec.SelectOperator.process(SelectOperator.java:88)
      at org.apache.hadoop.hive.ql.exec.Operator.forward(Operator.java:841)
      at org.apache.hadoop.hive.ql.exec.CommonJoinOperator.internalForward(CommonJoinOperator.java:644)
      at org.apache.hadoop.hive.ql.exec.CommonJoinOperator.createForwardJoinObject(CommonJoinOperator.java:439)
      at org.apache.hadoop.hive.ql.exec.CommonJoinOperator.genObject(CommonJoinOperator.java:531)
      at org.apache.hadoop.hive.ql.exec.CommonJoinOperator.genObject(CommonJoinOperator.java:528)
      at org.apache.hadoop.hive.ql.exec.CommonJoinOperator.genJoinObject(CommonJoinOperator.java:457)
      at org.apache.hadoop.hive.ql.exec.CommonJoinOperator.checkAndGenObject(CommonJoinOperator.java:758)
      at org.apache.hadoop.hive.ql.exec.MapJoinOperator.process(MapJoinOperator.java:436)
      ... 22 more
      Caused by: org.apache.hadoop.hive.ql.metadata.HiveException: java.io.IOException: Filesystem closed
      at org.apache.hadoop.hive.ql.exec.FileSinkOperator.createBucketForFileIdx(FileSinkOperator.java:645)
      at org.apache.hadoop.hive.ql.exec.FileSinkOperator.createBucketFiles(FileSinkOperator.java:569)
      ... 35 more
      Caused by: java.io.IOException: Filesystem closed
      at org.apache.hadoop.hdfs.DFSClient.checkOpen(DFSClient.java:826)
      at org.apache.hadoop.hdfs.DFSClient.getFileInfo(DFSClient.java:2174)
      at org.apache.hadoop.hdfs.DistributedFileSystem$26.doCall(DistributedFileSystem.java:1442)
      at org.apache.hadoop.hdfs.DistributedFileSystem$26.doCall(DistributedFileSystem.java:1438)
      at org.apache.hadoop.fs.FileSystemLinkResolver.resolve(FileSystemLinkResolver.java:81)
      at org.apache.hadoop.hdfs.DistributedFileSystem.getFileStatus(DistributedFileSystem.java:1454)
      at org.apache.hadoop.fs.FileSystem.exists(FileSystem.java:1448)
      at org.apache.hadoop.fs.FileSystem.deleteOnExit(FileSystem.java:1403)
      at org.apache.hadoop.hive.ql.exec.FileSinkOperator.createBucketForFileIdx(FileSinkOperator.java:618)
      ... 36 more
      ], TaskAttempt 2 failed, info=[Container container_e103_1567624202104_2443_01_000010 finished with diagnostics set to [Container failed, exitCode=-104. Container [pid=19208,containerID=container_e103_1567624202104_2443_01_000010] is running beyond physical memory limits. Current usage: 6.1 GB of 6 GB physical memory used; 8.9 GB of 12.6 GB virtual memory used. Killing container.
      Dump of the process-tree for container_e103_1567624202104_2443_01_000010 :

      • PID PPID PGRPID SESSID CMD_NAME USER_MODE_TIME(MILLIS) SYSTEM_TIME(MILLIS) VMEM_USAGE(BYTES) RSSMEM_USAGE(PAGES) FULL_CMD_LINE
      • 19220 19208 19208 19208 (java) 13420 3599 9419460608 1606021 /etc/alternatives/jdk/bin/java -server -Djava.net.preferIPv4Stack=true -Dhdp.version=2.6.5.0-292 -XX:+PrintGCDetails -verbose:gc -XX:+PrintGCTimeStamps -XX:+UseNUMA -XX:+UseParallelGC -Xmx6554m -Dlog4j.configuratorClass=org.apache.tez.common.TezLog4jConfigurator -Dlog4j.configuration=tez-container-log4j.properties -Dyarn.app.container.log.dir=/grid/4/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000010 -Dtez.root.logger=INFO,CLA -Djava.io.tmpdir=/grid/5/hadoop/yarn/local/usercache/x010722/appcache/application_1567624202104_2443/container_e103_1567624202104_2443_01_000010/tmp org.apache.tez.runtime.task.TezChild 10.19.232.34 41227 container_e103_1567624202104_2443_01_000010 application_1567624202104_2443 1
      • 19208 19206 19208 19208 (bash) 0 0 115900416 306 /bin/bash -c /etc/alternatives/jdk/bin/java -server -Djava.net.preferIPv4Stack=true -Dhdp.version=2.6.5.0-292 -XX:+PrintGCDetails -verbose:gc -XX:+PrintGCTimeStamps -XX:+UseNUMA -XX:+UseParallelGC -Xmx6554m -Dlog4j.configuratorClass=org.apache.tez.common.TezLog4jConfigurator -Dlog4j.configuration=tez-container-log4j.properties -Dyarn.app.container.log.dir=/grid/4/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000010 -Dtez.root.logger=INFO,CLA -Djava.io.tmpdir=/grid/5/hadoop/yarn/local/usercache/x010722/appcache/application_1567624202104_2443/container_e103_1567624202104_2443_01_000010/tmp org.apache.tez.runtime.task.TezChild 10.19.232.34 41227 container_e103_1567624202104_2443_01_000010 application_1567624202104_2443 1 1>/grid/4/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000010/stdout 2>/grid/4/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000010/stderr

      Container killed on request. Exit code is 143
      Container exited with a non-zero exit code 143.
      ]], TaskAttempt 3 failed, info=[Container container_e103_1567624202104_2443_01_000013 finished with diagnostics set to [Container failed, exitCode=-104. Container [pid=10158,containerID=container_e103_1567624202104_2443_01_000013] is running beyond physical memory limits. Current usage: 6.1 GB of 6 GB physical memory used; 8.9 GB of 12.6 GB virtual memory used. Killing container.
      Dump of the process-tree for container_e103_1567624202104_2443_01_000013 :

      • PID PPID PGRPID SESSID CMD_NAME USER_MODE_TIME(MILLIS) SYSTEM_TIME(MILLIS) VMEM_USAGE(BYTES) RSSMEM_USAGE(PAGES) FULL_CMD_LINE
      • 10170 10158 10158 10158 (java) 15129 3347 9411821568 1589958 /etc/alternatives/jdk/bin/java -server -Djava.net.preferIPv4Stack=true -Dhdp.version=2.6.5.0-292 -XX:+PrintGCDetails -verbose:gc -XX:+PrintGCTimeStamps -XX:+UseNUMA -XX:+UseParallelGC -Xmx6554m -Dlog4j.configuratorClass=org.apache.tez.common.TezLog4jConfigurator -Dlog4j.configuration=tez-container-log4j.properties -Dyarn.app.container.log.dir=/grid/2/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000013 -Dtez.root.logger=INFO,CLA -Djava.io.tmpdir=/grid/1/hadoop/yarn/local/usercache/x010722/appcache/application_1567624202104_2443/container_e103_1567624202104_2443_01_000013/tmp org.apache.tez.runtime.task.TezChild 10.19.232.34 41227 container_e103_1567624202104_2443_01_000013 application_1567624202104_2443 1
      • 10158 10156 10158 10158 (bash) 0 0 115900416 306 /bin/bash -c /etc/alternatives/jdk/bin/java -server -Djava.net.preferIPv4Stack=true -Dhdp.version=2.6.5.0-292 -XX:+PrintGCDetails -verbose:gc -XX:+PrintGCTimeStamps -XX:+UseNUMA -XX:+UseParallelGC -Xmx6554m -Dlog4j.configuratorClass=org.apache.tez.common.TezLog4jConfigurator -Dlog4j.configuration=tez-container-log4j.properties -Dyarn.app.container.log.dir=/grid/2/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000013 -Dtez.root.logger=INFO,CLA -Djava.io.tmpdir=/grid/1/hadoop/yarn/local/usercache/x010722/appcache/application_1567624202104_2443/container_e103_1567624202104_2443_01_000013/tmp org.apache.tez.runtime.task.TezChild 10.19.232.34 41227 container_e103_1567624202104_2443_01_000013 application_1567624202104_2443 1 1>/grid/2/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000013/stdout 2>/grid/2/hadoop/yarn/log/application_1567624202104_2443/container_e103_1567624202104_2443_01_000013/stderr

      Container killed on request. Exit code is 143
      Container exited with a non-zero exit code 143.
      ]]], Vertex did not succeed due to OWN_TASK_FAILURE, failedTasks:1 killedTasks:2, Vertex vertex_1567624202104_2443_1_01 [Map 1] killed/failed due to:OWN_TASK_FAILURE]DAG did not succeed due to VERTEX_FAILURE. failedVertices:1 killedVertices:0
      (less...)

      Attachments

        Issue Links

          relates to

          Improvement - An improvement or enhancement to an existing feature or task. HIVE-26346 Default Tez memory limits occasionally result in killing container

          • Major - Major loss of function.
          • Open

          Activity

            People

              Unassigned Unassigned
              DoanTran Bishop Theodore
              Votes:
              0 Vote for this issue
              Watchers:
              1 Start watching this issue

              Dates

                Created:
                Updated: