[ 
https://issues.apache.org/jira/browse/HIVE-5245?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13791589#comment-13791589
 ] 

jeff little commented on HIVE-5245:
-----------------------------------

Task Logs: 'attempt_201308241420_3665_m_000000_0'
syslog logs
2013-10-10 23:25:14,771 INFO org.apache.hadoop.util.NativeCodeLoader: Loaded 
the native-hadoop library
2013-10-10 23:25:14,841 INFO org.apache.hadoop.mapred.TaskRunner: Creating 
symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/distcache/-6415303628198910415_1127677245_586502988/namenode/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/-mr-10010/319df19a-bb7f-44d8-8bc5-e2cc1b034bb2
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/HIVE_PLAN319df19a-bb7f-44d8-8bc5-e2cc1b034bb2
2013-10-10 23:25:14,846 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/org
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/org
2013-10-10 23:25:14,847 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/javolution
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/javolution
2013-10-10 23:25:14,847 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/META-INF
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/META-INF
2013-10-10 23:25:14,848 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/.job.jar.crc
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/.job.jar.crc
2013-10-10 23:25:14,849 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/javaewah
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/javaewah
2013-10-10 23:25:14,850 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/com
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/com
2013-10-10 23:25:14,850 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/hive-exec-log4j.properties
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/hive-exec-log4j.properties
2013-10-10 23:25:14,851 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/javax
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/javax
2013-10-10 23:25:14,852 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/job.jar
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/job.jar
2013-10-10 23:25:15,089 INFO org.apache.hadoop.util.ProcessTree: setsid exited 
with exit code 0
2013-10-10 23:25:15,091 INFO org.apache.hadoop.mapred.Task:  Using 
ResourceCalculatorPlugin : 
org.apache.hadoop.util.LinuxResourceCalculatorPlugin@28bb494b
2013-10-10 23:25:15,493 INFO com.hadoop.compression.lzo.GPLNativeCodeLoader: 
Loaded native gpl library
2013-10-10 23:25:15,495 INFO com.hadoop.compression.lzo.LzoCodec: Successfully 
loaded & initialized native-lzo library [hadoop-lzo rev 
6bb1b7f8b9044d8df9b4d2b6641db7658aab3cf8]
2013-10-10 23:25:15,503 INFO 
org.apache.hadoop.hive.ql.io.HiveContextAwareRecordReader: Processing file 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130813/test_02.txt
2013-10-10 23:25:15,503 INFO org.apache.hadoop.mapred.MapTask: numReduceTasks: 0
2013-10-10 23:25:15,511 INFO ExecMapper: maximum memory = 200998912
2013-10-10 23:25:15,511 INFO ExecMapper: conf classpath = 
[file:/home/hadoop/package/hadoop-1.0.4/conf.cluster/, 
file:/usr/lib/jvm/java-1.6.0-sun-1.6.0.30.x86_64/lib/tools.jar, 
file:/home/hadoop/package/hadoop-1.0.4/build/classes/, 
file:/home/hadoop/package/hadoop-1.0.4/build/test/classes/, 
file:/home/hadoop/package/hadoop-1.0.4/, 
file:/home/hadoop/package/hadoop-1.0.4/hadoop-core-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/asm-3.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/aspectjrt-1.6.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/aspectjtools-1.6.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-beanutils-1.7.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-beanutils-core-1.8.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-cli-1.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-codec-1.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-collections-3.2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-configuration-1.6.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-daemon-1.0.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-digester-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-el-1.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-httpclient-3.0.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-io-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-lang-2.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-logging-1.1.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-logging-api-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-math-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-net-1.4.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/core-3.1.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-capacity-scheduler-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-fairscheduler-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-lzo-0.4.15.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-thriftfs-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hsqldb-1.8.0.10.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jackson-core-asl-1.8.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jackson-mapper-asl-1.8.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jasper-compiler-5.5.12.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jasper-runtime-5.5.12.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jdeb-0.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-core-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-json-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-server-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jets3t-0.6.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jetty-6.1.26.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jetty-util-6.1.26.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsch-0.1.42.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/junit-4.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/kfs-0.2.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/log4j-1.2.15.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/mockito-all-1.8.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/oro-2.0.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/servlet-api-2.5-20081211.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/slf4j-api-1.4.3.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/slf4j-log4j12-1.4.3.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/xmlenc-0.52.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsp-2.1/jsp-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsp-2.1/jsp-api-2.1.jar, 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/classes,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/distcache/-7362175280706972069_54005676_586503270/namenode/home/hadoop/hdfs/tmp/mapred/staging/hadoop/.staging/job_201308241420_3665/libjars/hive-contrib-0.11.0.jar/,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/]
2013-10-10 23:25:15,511 INFO ExecMapper: thread classpath = 
[file:/home/hadoop/package/hadoop-1.0.4/conf.cluster/, 
file:/usr/lib/jvm/java-1.6.0-sun-1.6.0.30.x86_64/lib/tools.jar, 
file:/home/hadoop/package/hadoop-1.0.4/build/classes/, 
file:/home/hadoop/package/hadoop-1.0.4/build/test/classes/, 
file:/home/hadoop/package/hadoop-1.0.4/, 
file:/home/hadoop/package/hadoop-1.0.4/hadoop-core-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/asm-3.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/aspectjrt-1.6.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/aspectjtools-1.6.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-beanutils-1.7.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-beanutils-core-1.8.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-cli-1.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-codec-1.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-collections-3.2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-configuration-1.6.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-daemon-1.0.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-digester-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-el-1.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-httpclient-3.0.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-io-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-lang-2.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-logging-1.1.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-logging-api-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-math-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-net-1.4.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/core-3.1.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-capacity-scheduler-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-fairscheduler-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-lzo-0.4.15.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-thriftfs-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hsqldb-1.8.0.10.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jackson-core-asl-1.8.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jackson-mapper-asl-1.8.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jasper-compiler-5.5.12.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jasper-runtime-5.5.12.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jdeb-0.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-core-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-json-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-server-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jets3t-0.6.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jetty-6.1.26.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jetty-util-6.1.26.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsch-0.1.42.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/junit-4.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/kfs-0.2.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/log4j-1.2.15.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/mockito-all-1.8.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/oro-2.0.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/servlet-api-2.5-20081211.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/slf4j-api-1.4.3.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/slf4j-log4j12-1.4.3.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/xmlenc-0.52.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsp-2.1/jsp-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsp-2.1/jsp-api-2.1.jar, 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/classes,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/distcache/-7362175280706972069_54005676_586503270/namenode/home/hadoop/hdfs/tmp/mapred/staging/hadoop/.staging/job_201308241420_3665/libjars/hive-contrib-0.11.0.jar/,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000000_0/work/]
2013-10-10 23:25:15,548 INFO org.apache.hadoop.hive.ql.exec.MapOperator: Adding 
alias b to work list for file 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130812
2013-10-10 23:25:15,549 INFO org.apache.hadoop.hive.ql.exec.MapOperator: Adding 
alias b to work list for file 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130813
2013-10-10 23:25:15,551 INFO org.apache.hadoop.hive.ql.exec.MapOperator: dump 
TS struct<id:int,course:string,score:string,record_day:string>
2013-10-10 23:25:15,551 INFO ExecMapper: 
<MAP>Id =5
  <Children>
    <TS>Id =0
      <Children>
        <MAPJOIN>Id =1
          <Children>
            <SEL>Id =2
              <Children>
                <FS>Id =3
                  <Parent>Id = 2 null<\Parent>
                <\FS>
              <\Children>
              <Parent>Id = 1 null<\Parent>
            <\SEL>
          <\Children>
          <Parent>Id = 4 
        <HASHTABLEDUMMY>Id =4
          <Children>null
          <\Children>
        <\HASHTABLEDUMMY>Id = 0 null<\Parent>
        <\MAPJOIN>
      <\Children>
      <Parent>Id = 5 null<\Parent>
    <\TS>
  <\Children>
<\MAP>
2013-10-10 23:25:15,552 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 
Initializing Self 5 MAP
2013-10-10 23:25:15,552 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
Initializing Self 0 TS
2013-10-10 23:25:15,552 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
Operator 0 TS initialized
2013-10-10 23:25:15,552 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
Initializing children of 0 TS
2013-10-10 23:25:15,552 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initializing child 1 MAPJOIN
2013-10-10 23:25:15,552 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
Initialization Done 0 TS
2013-10-10 23:25:15,552 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 
Initialization Done 5 MAP
2013-10-10 23:25:15,552 INFO ExecMapper: Initializing dummy operator
2013-10-10 23:25:15,552 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: Initializing Self 4 
HASHTABLEDUMMY
2013-10-10 23:25:15,564 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: Operator 4 
HASHTABLEDUMMY initialized
2013-10-10 23:25:15,565 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: Initializing children of 
4 HASHTABLEDUMMY
2013-10-10 23:25:15,565 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initializing child 1 MAPJOIN
2013-10-10 23:25:15,565 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initializing Self 1 MAPJOIN
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.CommonJoinOperator: 
JOIN struct<_col0:int,_col1:string,_col2:string,_col3:string> totalsz = 4
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Operator 1 MAPJOIN initialized
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initializing children of 1 MAPJOIN
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Initializing child 2 SEL
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Initializing Self 2 SEL
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
SELECT struct<_col0:int,_col1:string,_col2:string,_col3:string>
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Operator 2 SEL initialized
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Initializing children of 2 SEL
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Initializing child 3 FS
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Initializing Self 3 FS
2013-10-10 23:25:15,580 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Operator 3 FS initialized
2013-10-10 23:25:15,580 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Initialization Done 3 FS
2013-10-10 23:25:15,580 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Initialization Done 2 SEL
2013-10-10 23:25:15,584 INFO 
org.apache.hadoop.hive.ql.exec.persistence.HashMapWrapper: maximum memory: 
200998912
2013-10-10 23:25:15,584 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initialization Done 1 MAPJOIN
2013-10-10 23:25:15,584 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: Initialization Done 4 
HASHTABLEDUMMY
2013-10-10 23:25:15,588 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 
Processing alias b for file 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130813
2013-10-10 23:25:15,589 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
******* Load from HashTable File: input : 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130813/test_02.txt
2013-10-10 23:25:15,590 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator:    
Load back 1 hashtable file from tmp file 
uri:/home/hadoop/hdfs/mapred/local/taskTracker/distcache/-8026335471844171088_-517161708_586502978/namenode/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/-mr-10006/HashTable-Stage-6/Stage-6.tar.gz/MapJoin-mapfile480--.hashtable
2013-10-10 23:25:15,605 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 5 
forwarding 1 rows
2013-10-10 23:25:15,605 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
0 forwarding 1 rows
2013-10-10 23:25:15,606 WARN org.apache.hadoop.hive.serde2.lazy.LazyStruct: 
Extra bytes detected at the end of the row! Ignoring similar problems.
2013-10-10 23:25:15,606 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
forwarding 1 rows
2013-10-10 23:25:15,606 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
forwarding 1 rows
2013-10-10 23:25:15,606 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Final Path: FS 
hdfs://namenode:9000/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/_tmp.-ext-10001/000000_0
2013-10-10 23:25:15,607 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Writing to temp file: FS 
hdfs://namenode:9000/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/_task_tmp.-ext-10001/_tmp.000000_0
2013-10-10 23:25:15,607 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
New Final Path: FS 
hdfs://namenode:9000/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/_tmp.-ext-10001/000000_0
2013-10-10 23:25:15,657 INFO ExecMapper: ExecMapper: processing 1 rows: used 
memory = 31440456
2013-10-10 23:25:15,657 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
forwarding 10 rows
2013-10-10 23:25:15,657 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
forwarding 10 rows
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 5 
finished. closing... 
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 5 
forwarded 8 rows
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 
DESERIALIZE_ERRORS:0
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
0 finished. closing... 
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
0 forwarded 8 rows
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
0 Close done
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 5 
Close done
2013-10-10 23:25:15,658 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: 4 finished. closing... 
2013-10-10 23:25:15,658 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: 4 forwarded 0 rows
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
finished. closing... 
2013-10-10 23:25:15,658 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
forwarded 12 rows
2013-10-10 23:25:15,662 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
finished. closing... 
2013-10-10 23:25:15,662 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
forwarded 12 rows
2013-10-10 23:25:15,662 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 3 
finished. closing... 
2013-10-10 23:25:15,662 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 3 
forwarded 0 rows
2013-10-10 23:25:15,719 ERROR 
org.apache.hadoop.hive.ql.stats.jdbc.JDBCStatsPublisher: Error during 
instantiating JDBC driver org.apache.derby.jdbc.EmbeddedDriver. 
java.lang.ClassNotFoundException: org.apache.derby.jdbc.EmbeddedDriver
        at java.net.URLClassLoader$1.run(URLClassLoader.java:202)
        at java.security.AccessController.doPrivileged(Native Method)
        at java.net.URLClassLoader.findClass(URLClassLoader.java:190)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:306)
        at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:301)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
        at java.lang.Class.forName0(Native Method)
        at java.lang.Class.forName(Class.java:169)
        at 
org.apache.hadoop.hive.ql.stats.jdbc.JDBCStatsPublisher.connect(JDBCStatsPublisher.java:68)
        at 
org.apache.hadoop.hive.ql.exec.FileSinkOperator.publishStats(FileSinkOperator.java:963)
        at 
org.apache.hadoop.hive.ql.exec.FileSinkOperator.closeOp(FileSinkOperator.java:872)
        at org.apache.hadoop.hive.ql.exec.Operator.close(Operator.java:588)
        at org.apache.hadoop.hive.ql.exec.Operator.close(Operator.java:597)
        at org.apache.hadoop.hive.ql.exec.Operator.close(Operator.java:597)
        at org.apache.hadoop.hive.ql.exec.Operator.close(Operator.java:597)
        at org.apache.hadoop.hive.ql.exec.ExecMapper.close(ExecMapper.java:201)
        at org.apache.hadoop.mapred.MapRunner.run(MapRunner.java:57)
        at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
        at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
        at org.apache.hadoop.mapred.Child$4.run(Child.java:255)
        at java.security.AccessController.doPrivileged(Native Method)
        at javax.security.auth.Subject.doAs(Subject.java:396)
        at 
org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1121)
        at org.apache.hadoop.mapred.Child.main(Child.java:249)
2013-10-10 23:25:15,720 ERROR org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
StatsPublishing error: cannot connect to database
2013-10-10 23:25:15,720 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
TABLE_ID_1_ROWCOUNT:12
2013-10-10 23:25:15,720 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
Close done
2013-10-10 23:25:15,720 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
Close done
2013-10-10 23:25:15,720 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: 4 Close done
2013-10-10 23:25:15,720 INFO ExecMapper: ExecMapper: processed 8 rows: used 
memory = 34940376
2013-10-10 23:25:15,724 INFO org.apache.hadoop.mapred.Task: 
Task:attempt_201308241420_3665_m_000000_0 is done. And is in the process of 
commiting
2013-10-10 23:25:18,083 INFO org.apache.hadoop.mapred.Task: Task 
'attempt_201308241420_3665_m_000000_0' done.
2013-10-10 23:25:18,098 INFO org.apache.hadoop.mapred.TaskLogsTruncater: 
Initializing logs' truncater with mapRetainSize=-1 and reduceRetainSize=-1
2013-10-10 23:25:18,115 INFO org.apache.hadoop.io.nativeio.NativeIO: 
Initialized cache for UID to User mapping with a cache timeout of 14400 seconds.
2013-10-10 23:25:18,115 INFO org.apache.hadoop.io.nativeio.NativeIO: Got 
UserName hadoop for UID 500 from the native implementation

Task Logs: 'attempt_201308241420_3665_m_000001_0'
2013-10-10 23:25:14,771 INFO org.apache.hadoop.util.NativeCodeLoader: Loaded 
the native-hadoop library
2013-10-10 23:25:14,841 INFO org.apache.hadoop.mapred.TaskRunner: Creating 
symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/distcache/-6415303628198910415_1127677245_586502988/namenode/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/-mr-10010/319df19a-bb7f-44d8-8bc5-e2cc1b034bb2
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/HIVE_PLAN319df19a-bb7f-44d8-8bc5-e2cc1b034bb2
2013-10-10 23:25:14,845 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/org
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/org
2013-10-10 23:25:14,846 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/javolution
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/javolution
2013-10-10 23:25:14,847 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/META-INF
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/META-INF
2013-10-10 23:25:14,848 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/.job.jar.crc
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/.job.jar.crc
2013-10-10 23:25:14,849 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/javaewah
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/javaewah
2013-10-10 23:25:14,849 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/com
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/com
2013-10-10 23:25:14,850 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/hive-exec-log4j.properties
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/hive-exec-log4j.properties
2013-10-10 23:25:14,851 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/javax
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/javax
2013-10-10 23:25:14,852 INFO 
org.apache.hadoop.filecache.TrackerDistributedCacheManager: Creating symlink: 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/job.jar
 <- 
/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/job.jar
2013-10-10 23:25:15,089 INFO org.apache.hadoop.util.ProcessTree: setsid exited 
with exit code 0
2013-10-10 23:25:15,092 INFO org.apache.hadoop.mapred.Task:  Using 
ResourceCalculatorPlugin : 
org.apache.hadoop.util.LinuxResourceCalculatorPlugin@5d2412e7
2013-10-10 23:25:15,493 INFO com.hadoop.compression.lzo.GPLNativeCodeLoader: 
Loaded native gpl library
2013-10-10 23:25:15,495 INFO com.hadoop.compression.lzo.LzoCodec: Successfully 
loaded & initialized native-lzo library [hadoop-lzo rev 
6bb1b7f8b9044d8df9b4d2b6641db7658aab3cf8]
2013-10-10 23:25:15,503 INFO 
org.apache.hadoop.hive.ql.io.HiveContextAwareRecordReader: Processing file 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130812/test_02.txt
2013-10-10 23:25:15,503 INFO org.apache.hadoop.mapred.MapTask: numReduceTasks: 0
2013-10-10 23:25:15,510 INFO ExecMapper: maximum memory = 200998912
2013-10-10 23:25:15,510 INFO ExecMapper: conf classpath = 
[file:/home/hadoop/package/hadoop-1.0.4/conf.cluster/, 
file:/usr/lib/jvm/java-1.6.0-sun-1.6.0.30.x86_64/lib/tools.jar, 
file:/home/hadoop/package/hadoop-1.0.4/build/classes/, 
file:/home/hadoop/package/hadoop-1.0.4/build/test/classes/, 
file:/home/hadoop/package/hadoop-1.0.4/, 
file:/home/hadoop/package/hadoop-1.0.4/hadoop-core-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/asm-3.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/aspectjrt-1.6.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/aspectjtools-1.6.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-beanutils-1.7.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-beanutils-core-1.8.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-cli-1.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-codec-1.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-collections-3.2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-configuration-1.6.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-daemon-1.0.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-digester-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-el-1.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-httpclient-3.0.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-io-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-lang-2.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-logging-1.1.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-logging-api-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-math-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-net-1.4.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/core-3.1.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-capacity-scheduler-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-fairscheduler-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-lzo-0.4.15.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-thriftfs-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hsqldb-1.8.0.10.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jackson-core-asl-1.8.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jackson-mapper-asl-1.8.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jasper-compiler-5.5.12.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jasper-runtime-5.5.12.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jdeb-0.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-core-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-json-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-server-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jets3t-0.6.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jetty-6.1.26.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jetty-util-6.1.26.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsch-0.1.42.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/junit-4.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/kfs-0.2.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/log4j-1.2.15.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/mockito-all-1.8.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/oro-2.0.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/servlet-api-2.5-20081211.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/slf4j-api-1.4.3.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/slf4j-log4j12-1.4.3.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/xmlenc-0.52.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsp-2.1/jsp-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsp-2.1/jsp-api-2.1.jar, 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/classes,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/distcache/-7362175280706972069_54005676_586503270/namenode/home/hadoop/hdfs/tmp/mapred/staging/hadoop/.staging/job_201308241420_3665/libjars/hive-contrib-0.11.0.jar/,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/]
2013-10-10 23:25:15,511 INFO ExecMapper: thread classpath = 
[file:/home/hadoop/package/hadoop-1.0.4/conf.cluster/, 
file:/usr/lib/jvm/java-1.6.0-sun-1.6.0.30.x86_64/lib/tools.jar, 
file:/home/hadoop/package/hadoop-1.0.4/build/classes/, 
file:/home/hadoop/package/hadoop-1.0.4/build/test/classes/, 
file:/home/hadoop/package/hadoop-1.0.4/, 
file:/home/hadoop/package/hadoop-1.0.4/hadoop-core-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/asm-3.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/aspectjrt-1.6.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/aspectjtools-1.6.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-beanutils-1.7.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-beanutils-core-1.8.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-cli-1.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-codec-1.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-collections-3.2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-configuration-1.6.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-daemon-1.0.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-digester-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-el-1.0.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-httpclient-3.0.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-io-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-lang-2.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-logging-1.1.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-logging-api-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-math-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/commons-net-1.4.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/core-3.1.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-capacity-scheduler-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-fairscheduler-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-lzo-0.4.15.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hadoop-thriftfs-1.0.4.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/hsqldb-1.8.0.10.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jackson-core-asl-1.8.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jackson-mapper-asl-1.8.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jasper-compiler-5.5.12.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jasper-runtime-5.5.12.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jdeb-0.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-core-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-json-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jersey-server-1.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jets3t-0.6.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jetty-6.1.26.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jetty-util-6.1.26.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsch-0.1.42.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/junit-4.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/kfs-0.2.2.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/log4j-1.2.15.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/mockito-all-1.8.5.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/oro-2.0.8.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/servlet-api-2.5-20081211.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/slf4j-api-1.4.3.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/slf4j-log4j12-1.4.3.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/xmlenc-0.52.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsp-2.1/jsp-2.1.jar, 
file:/home/hadoop/package/hadoop-1.0.4/lib/jsp-2.1/jsp-api-2.1.jar, 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/classes,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/jars/,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/distcache/-7362175280706972069_54005676_586503270/namenode/home/hadoop/hdfs/tmp/mapred/staging/hadoop/.staging/job_201308241420_3665/libjars/hive-contrib-0.11.0.jar/,
 
file:/home/hadoop/hdfs/mapred/local/taskTracker/hadoop/jobcache/job_201308241420_3665/attempt_201308241420_3665_m_000001_0/work/]
2013-10-10 23:25:15,547 INFO org.apache.hadoop.hive.ql.exec.MapOperator: Adding 
alias b to work list for file 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130812
2013-10-10 23:25:15,549 INFO org.apache.hadoop.hive.ql.exec.MapOperator: dump 
TS struct<id:int,course:string,score:string,record_day:string>
2013-10-10 23:25:15,550 INFO org.apache.hadoop.hive.ql.exec.MapOperator: Adding 
alias b to work list for file 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130813
2013-10-10 23:25:15,550 INFO ExecMapper: 
<MAP>Id =5
  <Children>
    <TS>Id =0
      <Children>
        <MAPJOIN>Id =1
          <Children>
            <SEL>Id =2
              <Children>
                <FS>Id =3
                  <Parent>Id = 2 null<\Parent>
                <\FS>
              <\Children>
              <Parent>Id = 1 null<\Parent>
            <\SEL>
          <\Children>
          <Parent>Id = 4 
        <HASHTABLEDUMMY>Id =4
          <Children>null
          <\Children>
        <\HASHTABLEDUMMY>Id = 0 null<\Parent>
        <\MAPJOIN>
      <\Children>
      <Parent>Id = 5 null<\Parent>
    <\TS>
  <\Children>
<\MAP>
2013-10-10 23:25:15,551 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 
Initializing Self 5 MAP
2013-10-10 23:25:15,551 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
Initializing Self 0 TS
2013-10-10 23:25:15,551 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
Operator 0 TS initialized
2013-10-10 23:25:15,551 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
Initializing children of 0 TS
2013-10-10 23:25:15,551 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initializing child 1 MAPJOIN
2013-10-10 23:25:15,551 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
Initialization Done 0 TS
2013-10-10 23:25:15,551 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 
Initialization Done 5 MAP
2013-10-10 23:25:15,551 INFO ExecMapper: Initializing dummy operator
2013-10-10 23:25:15,551 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: Initializing Self 4 
HASHTABLEDUMMY
2013-10-10 23:25:15,564 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: Operator 4 
HASHTABLEDUMMY initialized
2013-10-10 23:25:15,564 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: Initializing children of 
4 HASHTABLEDUMMY
2013-10-10 23:25:15,564 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initializing child 1 MAPJOIN
2013-10-10 23:25:15,564 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initializing Self 1 MAPJOIN
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.CommonJoinOperator: 
JOIN struct<_col0:int,_col1:string,_col2:string,_col3:string> totalsz = 4
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Operator 1 MAPJOIN initialized
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initializing children of 1 MAPJOIN
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Initializing child 2 SEL
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Initializing Self 2 SEL
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
SELECT struct<_col0:int,_col1:string,_col2:string,_col3:string>
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Operator 2 SEL initialized
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Initializing children of 2 SEL
2013-10-10 23:25:15,575 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Initializing child 3 FS
2013-10-10 23:25:15,576 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Initializing Self 3 FS
2013-10-10 23:25:15,580 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Operator 3 FS initialized
2013-10-10 23:25:15,580 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Initialization Done 3 FS
2013-10-10 23:25:15,580 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 
Initialization Done 2 SEL
2013-10-10 23:25:15,583 INFO 
org.apache.hadoop.hive.ql.exec.persistence.HashMapWrapper: maximum memory: 
200998912
2013-10-10 23:25:15,583 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
Initialization Done 1 MAPJOIN
2013-10-10 23:25:15,583 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: Initialization Done 4 
HASHTABLEDUMMY
2013-10-10 23:25:15,587 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 
Processing alias b for file 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130812
2013-10-10 23:25:15,588 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 
******* Load from HashTable File: input : 
hdfs://namenode:9000/user/hive/warehouse/test.db/test_02/record_day=20130812/test_02.txt
2013-10-10 23:25:15,589 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator:    
Load back 1 hashtable file from tmp file 
uri:/home/hadoop/hdfs/mapred/local/taskTracker/distcache/-8026335471844171088_-517161708_586502978/namenode/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/-mr-10006/HashTable-Stage-6/Stage-6.tar.gz/MapJoin-mapfile480--.hashtable
2013-10-10 23:25:15,605 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 5 
forwarding 1 rows
2013-10-10 23:25:15,605 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
0 forwarding 1 rows
2013-10-10 23:25:15,605 WARN org.apache.hadoop.hive.serde2.lazy.LazyStruct: 
Extra bytes detected at the end of the row! Ignoring similar problems.
2013-10-10 23:25:15,605 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
forwarding 1 rows
2013-10-10 23:25:15,605 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
forwarding 1 rows
2013-10-10 23:25:15,606 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Final Path: FS 
hdfs://namenode:9000/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/_tmp.-ext-10001/000001_0
2013-10-10 23:25:15,606 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
Writing to temp file: FS 
hdfs://namenode:9000/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/_task_tmp.-ext-10001/_tmp.000001_0
2013-10-10 23:25:15,606 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
New Final Path: FS 
hdfs://namenode:9000/tmp/hive-hadoop/hive_2013-10-10_23-21-25_380_3054038040192061682/_tmp.-ext-10001/000001_0
2013-10-10 23:25:15,649 INFO ExecMapper: ExecMapper: processing 1 rows: used 
memory = 31506032
2013-10-10 23:25:15,649 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
forwarding 10 rows
2013-10-10 23:25:15,649 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
forwarding 10 rows
2013-10-10 23:25:15,649 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 5 
finished. closing... 
2013-10-10 23:25:15,650 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 5 
forwarded 8 rows
2013-10-10 23:25:15,650 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 
DESERIALIZE_ERRORS:0
2013-10-10 23:25:15,650 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
0 finished. closing... 
2013-10-10 23:25:15,650 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
0 forwarded 8 rows
2013-10-10 23:25:15,650 INFO org.apache.hadoop.hive.ql.exec.TableScanOperator: 
0 Close done
2013-10-10 23:25:15,650 INFO org.apache.hadoop.hive.ql.exec.MapOperator: 5 
Close done
2013-10-10 23:25:15,650 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: 4 finished. closing... 
2013-10-10 23:25:15,650 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: 4 forwarded 0 rows
2013-10-10 23:25:15,650 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
finished. closing... 
2013-10-10 23:25:15,650 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
forwarded 12 rows
2013-10-10 23:25:15,653 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
finished. closing... 
2013-10-10 23:25:15,654 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
forwarded 12 rows
2013-10-10 23:25:15,654 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 3 
finished. closing... 
2013-10-10 23:25:15,654 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 3 
forwarded 0 rows
2013-10-10 23:25:15,713 ERROR 
org.apache.hadoop.hive.ql.stats.jdbc.JDBCStatsPublisher: Error during 
instantiating JDBC driver org.apache.derby.jdbc.EmbeddedDriver. 
java.lang.ClassNotFoundException: org.apache.derby.jdbc.EmbeddedDriver
        at java.net.URLClassLoader$1.run(URLClassLoader.java:202)
        at java.security.AccessController.doPrivileged(Native Method)
        at java.net.URLClassLoader.findClass(URLClassLoader.java:190)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:306)
        at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:301)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
        at java.lang.Class.forName0(Native Method)
        at java.lang.Class.forName(Class.java:169)
        at 
org.apache.hadoop.hive.ql.stats.jdbc.JDBCStatsPublisher.connect(JDBCStatsPublisher.java:68)
        at 
org.apache.hadoop.hive.ql.exec.FileSinkOperator.publishStats(FileSinkOperator.java:963)
        at 
org.apache.hadoop.hive.ql.exec.FileSinkOperator.closeOp(FileSinkOperator.java:872)
        at org.apache.hadoop.hive.ql.exec.Operator.close(Operator.java:588)
        at org.apache.hadoop.hive.ql.exec.Operator.close(Operator.java:597)
        at org.apache.hadoop.hive.ql.exec.Operator.close(Operator.java:597)
        at org.apache.hadoop.hive.ql.exec.Operator.close(Operator.java:597)
        at org.apache.hadoop.hive.ql.exec.ExecMapper.close(ExecMapper.java:201)
        at org.apache.hadoop.mapred.MapRunner.run(MapRunner.java:57)
        at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
        at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
        at org.apache.hadoop.mapred.Child$4.run(Child.java:255)
        at java.security.AccessController.doPrivileged(Native Method)
        at javax.security.auth.Subject.doAs(Subject.java:396)
        at 
org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1121)
        at org.apache.hadoop.mapred.Child.main(Child.java:249)
2013-10-10 23:25:15,714 ERROR org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
StatsPublishing error: cannot connect to database
2013-10-10 23:25:15,714 INFO org.apache.hadoop.hive.ql.exec.FileSinkOperator: 
TABLE_ID_1_ROWCOUNT:12
2013-10-10 23:25:15,714 INFO org.apache.hadoop.hive.ql.exec.SelectOperator: 2 
Close done
2013-10-10 23:25:15,714 INFO org.apache.hadoop.hive.ql.exec.MapJoinOperator: 1 
Close done
2013-10-10 23:25:15,714 INFO 
org.apache.hadoop.hive.ql.exec.HashTableDummyOperator: 4 Close done
2013-10-10 23:25:15,714 INFO ExecMapper: ExecMapper: processed 8 rows: used 
memory = 35005952
2013-10-10 23:25:15,718 INFO org.apache.hadoop.mapred.Task: 
Task:attempt_201308241420_3665_m_000001_0 is done. And is in the process of 
commiting
2013-10-10 23:25:18,085 INFO org.apache.hadoop.mapred.Task: Task 
'attempt_201308241420_3665_m_000001_0' done.
2013-10-10 23:25:18,100 INFO org.apache.hadoop.mapred.TaskLogsTruncater: 
Initializing logs' truncater with mapRetainSize=-1 and reduceRetainSize=-1
2013-10-10 23:25:18,117 INFO org.apache.hadoop.io.nativeio.NativeIO: 
Initialized cache for UID to User mapping with a cache timeout of 14400 seconds.
2013-10-10 23:25:18,117 INFO org.apache.hadoop.io.nativeio.NativeIO: Got 
UserName hadoop for UID 500 from the native implementation

Hi,Yin Huai, this are the logs of 2 tasks for this CTAS. Otherwise, the hive 
version is 0.11!

> hive create table as select(CTAS) can not work(not support) with join on 
> operator
> ---------------------------------------------------------------------------------
>
>                 Key: HIVE-5245
>                 URL: https://issues.apache.org/jira/browse/HIVE-5245
>             Project: Hive
>          Issue Type: Bug
>          Components: HiveServer2
>    Affects Versions: 0.11.0
>            Reporter: jeff little
>              Labels: CTAS, hive
>   Original Estimate: 96h
>  Remaining Estimate: 96h
>
> hello everyone, recently i came across one hive problem as below:
> hive (test)> create table test_09 as
>            > select a.* from test_01 a
>            > join test_02 b
>            > on (a.id=b.id);
> Automatically selecting local only mode for query
> Total MapReduce jobs = 2
> setting HADOOP_USER_NAME        hadoop
> 13/09/09 17:22:36 WARN conf.Configuration: 
> file:/tmp/hadoop/hive_2013-09-09_17-22-34_848_1629553341892012305/-local-10008/jobconf.xml:a
>  attempt to override final parameter: mapred.system.dir;  Ignoring.
> 13/09/09 17:22:36 WARN conf.Configuration: 
> file:/tmp/hadoop/hive_2013-09-09_17-22-34_848_1629553341892012305/-local-10008/jobconf.xml:a
>  attempt to override final parameter: mapred.local.dir;  Ignoring.
> Execution log at: /tmp/hadoop/.log
> 2013-09-09 05:22:36     Starting to launch local task to process map join;    
>   maximum memory = 932118528
> 2013-09-09 05:22:37     Processing rows:        4       Hashtable size: 4     
>   Memory usage:   113068056       rate:   0.121
> 2013-09-09 05:22:37     Dump the hashtable into file: 
> file:/tmp/hadoop/hive_2013-09-09_17-22-34_848_1629553341892012305/-local-10005/HashTable-Stage-6/MapJoin-mapfile90--.hashtable
> 2013-09-09 05:22:37     Upload 1 File to: 
> file:/tmp/hadoop/hive_2013-09-09_17-22-34_848_1629553341892012305/-local-10005/HashTable-Stage-6/MapJoin-mapfile90--.hashtable
>  File size: 788
> 2013-09-09 05:22:37     End of local task; Time Taken: 0.444 sec.
> Execution completed successfully
> Mapred Local Task Succeeded . Convert the Join into MapJoin
> Mapred Local Task Succeeded . Convert the Join into MapJoin
> Launching Job 1 out of 2
> Number of reduce tasks is set to 0 since there's no reduce operator
> 13/09/09 17:22:38 WARN conf.Configuration: 
> file:/tmp/hadoop/hive_2013-09-09_17-22-34_848_1629553341892012305/-local-10009/jobconf.xml:a
>  attempt to override final parameter: mapred.system.dir;  Ignoring.
> 13/09/09 17:22:38 WARN conf.Configuration: 
> file:/tmp/hadoop/hive_2013-09-09_17-22-34_848_1629553341892012305/-local-10009/jobconf.xml:a
>  attempt to override final parameter: mapred.local.dir;  Ignoring.
> Execution log at: /tmp/hadoop/.log
> Job running in-process (local Hadoop)
> Hadoop job information for null: number of mappers: 0; number of reducers: 0
> 2013-09-09 17:22:41,807 null map = 0%,  reduce = 0%
> 2013-09-09 17:22:44,814 null map = 100%,  reduce = 0%
> Ended Job = job_local_0001
> Execution completed successfully
> Mapred Local Task Succeeded . Convert the Join into MapJoin
> Stage-7 is filtered out by condition resolver.
> OK
> Time taken: 13.138 seconds
> hive (test)> select * from test_09;
> FAILED: SemanticException [Error 10001]: Line 1:14 Table not found 'test_09'
> hive (test)>
> Problem:
> I can't get the created table, namely this CTAS is nonavailable, and this 
> table is not created by this hql sentence at all.who can explain for 
> me.Thanks.



--
This message was sent by Atlassian JIRA
(v6.1#6144)

Reply via email to