You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@tajo.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/02/15 10:04:56 UTC

Build failed in Jenkins: Tajo-0.11.2-build #169

See <https://builds.apache.org/job/Tajo-0.11.2-build/169/>

------------------------------------------
[...truncated 721997 lines...]
2016-02-15 09:04:34,721 INFO: org.apache.tajo.worker.TaskManager (handle(181)) - Running ExecutionBlocks: 1, running tasks:0, availableResource: (Memory:500, Disks:6, vCores:2)
2016-02-15 09:04:34,722 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(291)) - Output File Path: hdfs://localhost:54072/tajo/warehouse/default/nullcharsession/.staging/q_1455522996562_2150/RESULT/part-04-000000-000
2016-02-15 09:04:34,722 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - Output File Path: hdfs://localhost:54072/tajo/warehouse/default/nullcharsession/.staging/q_1455522996562_2150/RESULT/part-04-000000-000
2016-02-15 09:04:34,722 INFO: org.apache.tajo.worker.TaskImpl (initPlan(159)) - * Task ta_1455522996562_2150_000004_000000_00 is initialized. InterQuery: false, Shuffle: null, Fragments: 1, Fetches:1, Local dir: <https://builds.apache.org/job/Tajo-0.11.2-build/ws/tajo-core-tests/target/test-data/845d2eb9-f7d6-491e-a50e-a45553160825/tajo-localdir/q_1455522996562_2150/output/4/0_0>
2016-02-15 09:04:34,725 INFO: org.apache.tajo.worker.TaskImpl (getFetchRunners(744)) - Create shuffle Fetchers local:1, remote:0
2016-02-15 09:04:34,726 INFO: org.apache.tajo.worker.TaskImpl (waitForFetch(383)) - ta_1455522996562_2150_000004_000000_00 All fetches are done!
2016-02-15 09:04:34,729 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1455522996562_2150_000004_000000_00] Total merge time: 0 msec
2016-02-15 09:04:34,734 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:33823 is added to blk_1073748420_7596{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e305b687-8a35-462b-9c39-a7f24ea17ef4:NORMAL:127.0.0.1:33823|RBW]]} size 0
2016-02-15 09:04:34,735 INFO: org.apache.tajo.worker.TaskImpl (run(472)) - ta_1455522996562_2150_000004_000000_00 is complete. 9 ms elapsed, final state:TA_SUCCEEDED
2016-02-15 09:04:34,735 INFO: org.apache.tajo.querymaster.Stage (transition(1365)) - Stage - eb_1455522996562_2150_000004 finalize NONE_SHUFFLE (total=1, success=1, killed=0)
2016-02-15 09:04:34,735 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (stop(164)) - Task Scheduler stopped
2016-02-15 09:04:34,736 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (run(127)) - TaskScheduler schedulingThread stopped
2016-02-15 09:04:34,736 INFO: org.apache.tajo.querymaster.Stage (transition(1423)) - Stage completed - eb_1455522996562_2150_000004 (total=1, success=1, killed=0)
2016-02-15 09:04:34,736 INFO: org.apache.tajo.querymaster.Query (handle(861)) - Processing q_1455522996562_2150 of type STAGE_COMPLETED
2016-02-15 09:04:34,736 INFO: org.apache.tajo.engine.planner.global.ParallelExecutionQueue (next(95)) - Next executable block eb_1455522996562_2150_000005
2016-02-15 09:04:34,736 INFO: org.apache.tajo.querymaster.Query (transition(808)) - Complete Stage[eb_1455522996562_2150_000004], State: SUCCEEDED, 4/4. 
2016-02-15 09:04:34,736 INFO: org.apache.tajo.worker.ExecutionBlockContext (stop(176)) - Worker's task counter - total:1, succeeded: 1, killed: 0, failed: 0
2016-02-15 09:04:34,736 INFO: org.apache.tajo.querymaster.Query (handle(861)) - Processing q_1455522996562_2150 of type QUERY_COMPLETED
2016-02-15 09:04:34,737 INFO: org.apache.tajo.worker.TaskManager (stopExecutionBlock(160)) - Stopped execution block:eb_1455522996562_2150_000004
2016-02-15 09:04:34,739 INFO: org.apache.tajo.storage.FileTablespace (commitOutputData(964)) - Moved from the staging dir to the output directory 'hdfs://localhost:54072/tajo/warehouse/default/nullcharsession
2016-02-15 09:04:34,745 INFO: org.apache.tajo.catalog.CatalogServer (createTable(694)) - relation "default.nullcharsession" is added to the catalog (127.0.0.1:24235)
2016-02-15 09:04:34,746 INFO: org.apache.tajo.querymaster.Query (handle(879)) - q_1455522996562_2150 Query Transitioned from QUERY_RUNNING to QUERY_SUCCEEDED
2016-02-15 09:04:34,746 INFO: org.apache.tajo.querymaster.QueryMasterTask (handle(297)) - Query completion notified from q_1455522996562_2150 final state: QUERY_SUCCEEDED
2016-02-15 09:04:34,747 INFO: org.apache.tajo.master.QueryInProgress (heartbeat(257)) - Received QueryMaster heartbeat:q_1455522996562_2150,state=QUERY_SUCCEEDED,progress=1.0, queryMaster=asf908.gq1.ygridcore.net
2016-02-15 09:04:34,747 INFO: org.apache.tajo.master.QueryManager (stopQuery(279)) - Stop QueryInProgress:q_1455522996562_2150
2016-02-15 09:04:34,747 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(173)) - Stopping QueryMasterTask:q_1455522996562_2150
2016-02-15 09:04:34,747 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(122)) - =========================================================
2016-02-15 09:04:34,747 INFO: org.apache.tajo.querymaster.QueryMasterTask (cleanupQuery(474)) - Cleanup resources of all workers. Query: q_1455522996562_2150, workers: 1
2016-02-15 09:04:34,747 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(123)) - Stop query:q_1455522996562_2150
2016-02-15 09:04:34,747 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(189)) - Stopped QueryMasterTask:q_1455522996562_2150
2016-02-15 09:04:35,110 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: create table testFailCreateTablePartitionedOtherExceptColumn (deptname text, score int4)PARTITION BY RANGE (score)( PARTITION sub_part1 VALUES LESS THAN (2),PARTITION sub_part2 VALUES LESS THAN (5),PARTITION sub_part2 VALUES LESS THAN (MAXVALUE) )
2016-02-15 09:04:35,118 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: create table testFailCreateTablePartitionedOtherExceptColumn (deptname text, score int4)PARTITION BY LIST (deptname)( PARTITION sub_part1 VALUES('r&d', 'design'),PARTITION sub_part2 VALUES('sales', 'hr') )
2016-02-15 09:04:35,120 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: create table testFailCreateTablePartitionedOtherExceptColumn (deptname text, score int4)PARTITION BY HASH (deptname)PARTITIONS 2
2016-02-15 09:04:35,122 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 0b29e987-16f7-4884-b546-93ca16191214 is removed.
Tests run: 26, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.43 sec - in org.apache.tajo.client.TestTajoClient
Running org.apache.tajo.client.TestQueryClientExceptions
2016-02-15 09:04:35,127 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session 36ec883b-eebf-47c0-9ca0-bedb89aac3e2 is created.
2016-02-15 09:04:35,129 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: create table default.lineitem (name int);
2016-02-15 09:04:35,129 WARN: org.apache.tajo.plan.verifier.VerificationState (addVerification(41)) - org.apache.tajo.plan.verifier.PreLogicalPlanVerifier:assertRelationNoExistence(187) causes: table 'default.lineitem' already exists
2016-02-15 09:04:35,483 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(365)) - Saving query summary: hdfs://localhost:54072/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455522996562_2150/query.hist
2016-02-15 09:04:35,490 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:33823 is added to blk_1073748421_7597{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e305b687-8a35-462b-9c39-a7f24ea17ef4:NORMAL:127.0.0.1:33823|RBW]]} size 14774
2016-02-15 09:04:35,545 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: select * from unknown_table
2016-02-15 09:04:35,546 WARN: org.apache.tajo.plan.verifier.VerificationState (addVerification(41)) - org.apache.tajo.plan.verifier.PreLogicalPlanVerifier:assertRelationExistence(158) causes: relation 'default.unknown_table' does not exist
2016-02-15 09:04:35,547 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: create table default.lineitem (name int);
2016-02-15 09:04:35,547 WARN: org.apache.tajo.plan.verifier.VerificationState (addVerification(41)) - org.apache.tajo.plan.verifier.PreLogicalPlanVerifier:assertRelationNoExistence(187) causes: table 'default.lineitem' already exists
2016-02-15 09:04:35,650 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: select * from unknown_table
2016-02-15 09:04:35,650 WARN: org.apache.tajo.plan.verifier.VerificationState (addVerification(41)) - org.apache.tajo.plan.verifier.PreLogicalPlanVerifier:assertRelationExistence(158) causes: relation 'default.unknown_table' does not exist
2016-02-15 09:04:35,764 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 36ec883b-eebf-47c0-9ca0-bedb89aac3e2 is removed.
Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.639 sec - in org.apache.tajo.client.TestQueryClientExceptions
Running org.apache.tajo.resource.TestResources
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec - in org.apache.tajo.resource.TestResources
2016-02-15 09:04:35,771 INFO: org.mortbay.log (info(67)) - Shutdown hook executing
2016-02-15 09:04:35,772 INFO: org.mortbay.log (info(67)) - Shutdown hook complete
w, 20B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:03 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:04 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 15, 2016 8:54:04 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:04 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 8:54:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:07 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 212
Feb 15, 2016 8:54:07 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 5 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, PLAIN_DICTIONARY, BIT_PACKED], dic { 3 entries, 12B raw, 3B comp}
Feb 15, 2016 8:54:07 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 123B for [l_shipdate] BINARY: 5 values, 76B raw, 76B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:07 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 123B for [l_shipdate_function] BINARY: 5 values, 76B raw, 76B comp, 1 pages, encodings: [RLE, PLAIN, BIT_PACKED]
Feb 15, 2016 8:54:08 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 8:54:08 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 8:54:08 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
2016-02-15 09:04:35,779 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 003c51b8-8eb5-4b21-ace3-d84eaea3187b is removed.
2016-02-15 09:04:35,782 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session d459bd4e-697c-4a0a-946d-86db1a6232d6 is removed.
2016-02-15 09:04:35,784 INFO: org.apache.tajo.worker.TajoWorker (run(569)) - ============================================
2016-02-15 09:04:35,784 INFO: org.apache.tajo.worker.TajoWorker (run(570)) - TajoWorker received SIGINT Signal
2016-02-15 09:04:35,784 INFO: org.apache.tajo.worker.TajoWorker (run(571)) - ============================================
2016-02-15 09:04:35,786 WARN: org.apache.hadoop.hdfs.DFSClient (completeFile(2283)) - Caught exception 
java.lang.InterruptedException: sleep interrupted
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.DFSOutputStream.completeFile(DFSOutputStream.java:2277)
	at org.apache.hadoop.hdfs.DFSOutputStream.closeImpl(DFSOutputStream.java:2238)
	at org.apache.hadoop.hdfs.DFSOutputStream.close(DFSOutputStream.java:2204)
	at org.apache.hadoop.fs.FSDataOutputStream$PositionCache.close(FSDataOutputStream.java:72)
	at org.apache.hadoop.fs.FSDataOutputStream.close(FSDataOutputStream.java:106)
	at org.apache.hadoop.io.IOUtils.cleanup(IOUtils.java:244)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.writeQueryHistory(HistoryWriter.java:369)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.writeHistory(HistoryWriter.java:318)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.run(HistoryWriter.java:244)
2016-02-15 09:04:35,786 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-15 09:04:35,791 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:33823 is added to blk_1073745632_4808{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e305b687-8a35-462b-9c39-a7f24ea17ef4:NORMAL:127.0.0.1:33823|RBW]]} size 726
2016-02-15 09:04:35,791 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:54072/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455522996562_2150/eb_1455522996562_2150_000002.hist
2016-02-15 09:04:35,796 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:33823 is added to blk_1073748422_7598{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e305b687-8a35-462b-9c39-a7f24ea17ef4:NORMAL:127.0.0.1:33823|RBW]]} size 0
2016-02-15 09:04:35,799 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:54072/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455522996562_2150/eb_1455522996562_2150_000003.hist
2016-02-15 09:04:35,804 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:33823 is added to blk_1073748423_7599{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e305b687-8a35-462b-9c39-a7f24ea17ef4:NORMAL:127.0.0.1:33823|RBW]]} size 0
2016-02-15 09:04:35,804 ERROR: org.apache.tajo.util.history.HistoryWriter (writeHistory(321)) - Error while saving query history: q_1455522996562_2150:Filesystem closed
java.io.IOException: Filesystem closed
	at org.apache.hadoop.hdfs.DFSClient.checkOpen(DFSClient.java:808)
	at org.apache.hadoop.hdfs.DFSClient.create(DFSClient.java:1695)
	at org.apache.hadoop.hdfs.DFSClient.create(DFSClient.java:1638)
	at org.apache.hadoop.hdfs.DistributedFileSystem$7.doCall(DistributedFileSystem.java:448)
	at org.apache.hadoop.hdfs.DistributedFileSystem$7.doCall(DistributedFileSystem.java:444)
	at org.apache.hadoop.fs.FileSystemLinkResolver.resolve(FileSystemLinkResolver.java:81)
	at org.apache.hadoop.hdfs.DistributedFileSystem.create(DistributedFileSystem.java:459)
	at org.apache.hadoop.hdfs.DistributedFileSystem.create(DistributedFileSystem.java:387)
	at org.apache.hadoop.fs.FileSystem.create(FileSystem.java:909)
	at org.apache.hadoop.fs.FileSystem.create(FileSystem.java:890)
	at org.apache.hadoop.fs.FileSystem.create(FileSystem.java:816)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.writeQueryHistory(HistoryWriter.java:377)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.writeHistory(HistoryWriter.java:318)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.run(HistoryWriter.java:244)
2016-02-15 09:04:35,805 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(113)) - NodeStatusUpdater stopped.
2016-02-15 09:04:35,805 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_asf908.gq1.ygridcore.net_24239 stopped.
2016-02-15 09:04:35,805 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(261)) - Heartbeat Thread stopped.
2016-02-15 09:04:35,806 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:24241) shutdown
2016-02-15 09:04:35,807 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped
2016-02-15 09:04:35,807 INFO: org.apache.tajo.querymaster.QueryMaster (run(432)) - QueryMaster heartbeat thread stopped
2016-02-15 09:04:35,809 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(164)) - QueryMaster stopped
2016-02-15 09:04:35,809 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(98)) - TajoWorkerClientService stopping
2016-02-15 09:04:35,809 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:24240) shutdown
2016-02-15 09:04:35,809 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(102)) - TajoWorkerClientService stopped
2016-02-15 09:04:35,809 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:24239) shutdown
2016-02-15 09:04:35,809 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped
2016-02-15 09:04:35,810 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(379)) - TajoWorker main thread exiting
2016-02-15 09:04:39,018 INFO: org.apache.tajo.master.TajoMaster (run(580)) - ============================================
2016-02-15 09:04:39,019 INFO: org.apache.tajo.master.TajoMaster (run(581)) - TajoMaster received SIGINT Signal
2016-02-15 09:04:39,019 INFO: org.apache.tajo.master.TajoMaster (run(582)) - ============================================
2016-02-15 09:04:39,020 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:24238) shutdown
2016-02-15 09:04:39,020 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2016-02-15 09:04:39,025 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_24237 stopped.
2016-02-15 09:04:39,025 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:24237) shutdown
2016-02-15 09:04:39,025 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-15 09:04:41,230 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:24236) shutdown
2016-02-15 09:04:41,230 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(188)) - Catalog Server (127.0.0.1:24235) shutdown
2016-02-15 09:04:41,231 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:24235) shutdown
2016-02-15 09:04:41,231 INFO: org.apache.tajo.catalog.store.DerbyStore (close(2901)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-0.11.2-build/ws/tajo-core-tests/target/test-data/845d2eb9-f7d6-491e-a50e-a45553160825/db;create=true)>
2016-02-15 09:04:41,233 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:24234) shutdown
2016-02-15 09:04:41,233 INFO: org.apache.tajo.master.TajoMaster (serviceStop(440)) - Tajo Master main thread exiting
2016-02-15 09:04:41,268 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(68)) - Derby shutdown complete normally.
2016-02-15 09:04:41,268 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(75)) - Shutdown database

Results :

Failed tests: 
  TestHBaseTable.testCreateNotExistsExternalHBaseTable:167 null
Tests in error: 
  TestHBaseTable.testBinaryMappedQuery:326 » RetriesExhausted Failed after attem...
  TestHBaseTable.testCTAS:1293->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testColumnKeyValueSelectQuery:385 » RetriesExhausted Failed aft...
  TestHBaseTable.testCompositeRowIndexPredication:512->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testCreateExternalHBaseTable:196 » RetriesExhausted Failed afte...
  TestHBaseTable.testCreateHBaseTable:127->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testGetSplitsWhenRestartHBase:1443->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testGetTableVolume:246 » RetriesExhausted Failed after attempts...
  TestHBaseTable.testIndexPredication:467->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertInto:742->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoBinaryMultiRegion:1053->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoColumnKeyValue:1108->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoDifferentType:1198->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoLocation:1390->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegion:824->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegion2:880->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegionMultiRowFields:994->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegionWithSplitFile:937->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoRowField:1234->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoUsingPut:1340->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertValues1:782->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testJoin:702->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testNonForwardQuery:664->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testRowFieldSelectQuery:428 » RetriesExhausted Failed after att...
  TestHBaseTable.testSimpleSelectQuery:288 » RetriesExhausted Failed after attem...

Tests run: 1715, Failures: 1, Errors: 25, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  2.074 s]
[INFO] Tajo Project POM .................................. SUCCESS [  2.370 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  3.563 s]
[INFO] Tajo Common ....................................... SUCCESS [ 38.014 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  2.996 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  5.705 s]
[INFO] Tajo Plan ......................................... SUCCESS [  6.902 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  1.379 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [02:25 min]
[INFO] Tajo Catalog Client ............................... SUCCESS [  1.404 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [01:22 min]
[INFO] Tajo Storage Common ............................... SUCCESS [  3.690 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [01:26 min]
[INFO] Tajo PullServer ................................... SUCCESS [  1.073 s]
[INFO] Tajo Client ....................................... SUCCESS [  2.445 s]
[INFO] Tajo CLI tools .................................... SUCCESS [  1.942 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [  5.706 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [  1.817 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [  4.468 s]
[INFO] Tajo Metrics ...................................... SUCCESS [  1.790 s]
[INFO] Tajo Core ......................................... SUCCESS [  6.114 s]
[INFO] Tajo RPC .......................................... SUCCESS [  0.924 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 31.628 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [  0.054 s]
[INFO] Tajo Catalog ...................................... SUCCESS [  0.953 s]
[INFO] Tajo Client Example ............................... SUCCESS [  1.031 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [  4.408 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [  2.999 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 38.601 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [  0.862 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [  1.019 s]
[INFO] Tajo Storage ...................................... SUCCESS [  1.041 s]
[INFO] Tajo Distribution ................................. SUCCESS [  6.503 s]
[INFO] Tajo Core Tests ................................... FAILURE [  01:08 h]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 01:16 h
[INFO] Finished at: 2016-02-15T09:04:41+00:00
[INFO] Final Memory: 137M/927M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.19:test (default-test) on project tajo-core-tests: There are test failures.
[ERROR] 
[ERROR] Please refer to <https://builds.apache.org/job/Tajo-0.11.2-build/ws/tajo-core-tests/target/surefire-reports> for the individual test results.
[ERROR] -> [Help 1]
[ERROR] 
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR] 
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :tajo-core-tests
Build step 'Execute shell' marked build as failure
Archiving artifacts

Build failed in Jenkins: Tajo-0.11.2-build #170

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Tajo-0.11.2-build/170/changes>

Changes:

[jhkim] TAJO-2074: Upgrade hadoop and netty.

------------------------------------------
[...truncated 729976 lines...]
2016-02-15 10:21:09,780 INFO: org.apache.tajo.querymaster.Query (handle(861)) - Processing q_1455527640068_2150 of type STAGE_COMPLETED
2016-02-15 10:21:09,780 INFO: org.apache.tajo.engine.planner.global.ParallelExecutionQueue (next(95)) - Next executable block eb_1455527640068_2150_000004
2016-02-15 10:21:09,780 INFO: org.apache.tajo.querymaster.Query (executeNextBlock(761)) - Scheduling Stage:eb_1455527640068_2150_000004
2016-02-15 10:21:09,780 INFO: org.apache.tajo.worker.ExecutionBlockContext (stop(176)) - Worker's task counter - total:1, succeeded: 1, killed: 0, failed: 0
2016-02-15 10:21:09,780 INFO: org.apache.tajo.querymaster.Stage (initTaskScheduler(915)) - org.apache.tajo.querymaster.DefaultTaskScheduler is chosen for the task scheduling for eb_1455527640068_2150_000004
2016-02-15 10:21:09,781 INFO: org.apache.tajo.querymaster.Stage (getNonLeafTaskNum(1109)) - eb_1455527640068_2150_000004, Table's volume is approximately 1 MB
2016-02-15 10:21:09,781 INFO: org.apache.tajo.querymaster.Stage (getNonLeafTaskNum(1114)) - eb_1455527640068_2150_000004, The determined number of non-leaf tasks is 1
2016-02-15 10:21:09,781 INFO: org.apache.tajo.worker.TaskManager (stopExecutionBlock(160)) - Stopped execution block:eb_1455527640068_2150_000003
2016-02-15 10:21:09,781 INFO: org.apache.tajo.querymaster.Repartitioner (scheduleRangeShuffledFetches(688)) - eb_1455527640068_2150_000004, Try to divide [(1,1), (5,3)) into 1 sub ranges (total units: 1)
2016-02-15 10:21:09,781 INFO: org.apache.tajo.engine.utils.TupleUtil (setMaxRangeIfNull(71)) - Set null into range: default.orders.o_orderkey, current tuple is (5,NULL)
2016-02-15 10:21:09,782 INFO: org.apache.tajo.querymaster.Stage (run(867)) - 1 objects are scheduled
2016-02-15 10:21:09,782 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (start(135)) - Start TaskScheduler
2016-02-15 10:21:09,784 INFO: org.apache.tajo.worker.TaskManager (createExecutionBlock(112)) - QueryMaster Address:asf908.gq1.ygridcore.net:22865
2016-02-15 10:21:09,786 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(128)) - Tajo Root Dir: hdfs://localhost:39593/tajo
2016-02-15 10:21:09,786 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(129)) - Worker Local Dir: file://<https://builds.apache.org/job/Tajo-0.11.2-build/ws/tajo-core-tests/target/test-data/f27c0e6a-8be3-45c9-a053-633d1c2a01d7/tajo-localdir>
2016-02-15 10:21:09,787 INFO: org.apache.tajo.worker.TaskManager (handle(181)) - Running ExecutionBlocks: 1, running tasks:0, availableResource: (Memory:500, Disks:6, vCores:2)
2016-02-15 10:21:09,788 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(291)) - Output File Path: hdfs://localhost:39593/tajo/warehouse/default/nullcharsession/.staging/q_1455527640068_2150/RESULT/part-04-000000-000
2016-02-15 10:21:09,788 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - Output File Path: hdfs://localhost:39593/tajo/warehouse/default/nullcharsession/.staging/q_1455527640068_2150/RESULT/part-04-000000-000
2016-02-15 10:21:09,788 INFO: org.apache.tajo.worker.TaskImpl (initPlan(159)) - * Task ta_1455527640068_2150_000004_000000_00 is initialized. InterQuery: false, Shuffle: null, Fragments: 1, Fetches:1, Local dir: <https://builds.apache.org/job/Tajo-0.11.2-build/ws/tajo-core-tests/target/test-data/f27c0e6a-8be3-45c9-a053-633d1c2a01d7/tajo-localdir/q_1455527640068_2150/output/4/0_0>
2016-02-15 10:21:09,792 INFO: org.apache.tajo.worker.TaskImpl (getFetchRunners(744)) - Create shuffle Fetchers local:1, remote:0
2016-02-15 10:21:09,792 INFO: org.apache.tajo.worker.TaskImpl (waitForFetch(383)) - ta_1455527640068_2150_000004_000000_00 All fetches are done!
2016-02-15 10:21:09,795 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1455527640068_2150_000004_000000_00] Total merge time: 0 msec
2016-02-15 10:21:09,801 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073748418_7594{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-88eebddb-9ff2-4826-b251-39ebebb8a5c1:NORMAL:127.0.0.1:58499|FINALIZED]]} size 0
2016-02-15 10:21:09,802 INFO: org.apache.tajo.worker.TaskImpl (run(472)) - ta_1455527640068_2150_000004_000000_00 is complete. 10 ms elapsed, final state:TA_SUCCEEDED
2016-02-15 10:21:09,803 INFO: org.apache.tajo.querymaster.Stage (transition(1365)) - Stage - eb_1455527640068_2150_000004 finalize NONE_SHUFFLE (total=1, success=1, killed=0)
2016-02-15 10:21:09,803 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (stop(164)) - Task Scheduler stopped
2016-02-15 10:21:09,803 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (run(127)) - TaskScheduler schedulingThread stopped
2016-02-15 10:21:09,803 INFO: org.apache.tajo.querymaster.Stage (transition(1423)) - Stage completed - eb_1455527640068_2150_000004 (total=1, success=1, killed=0)
2016-02-15 10:21:09,803 INFO: org.apache.tajo.querymaster.Query (handle(861)) - Processing q_1455527640068_2150 of type STAGE_COMPLETED
2016-02-15 10:21:09,803 INFO: org.apache.tajo.engine.planner.global.ParallelExecutionQueue (next(95)) - Next executable block eb_1455527640068_2150_000005
2016-02-15 10:21:09,803 INFO: org.apache.tajo.worker.ExecutionBlockContext (stop(176)) - Worker's task counter - total:1, succeeded: 1, killed: 0, failed: 0
2016-02-15 10:21:09,804 INFO: org.apache.tajo.querymaster.Query (transition(808)) - Complete Stage[eb_1455527640068_2150_000004], State: SUCCEEDED, 4/4. 
2016-02-15 10:21:09,804 INFO: org.apache.tajo.querymaster.Query (handle(861)) - Processing q_1455527640068_2150 of type QUERY_COMPLETED
2016-02-15 10:21:09,804 INFO: org.apache.tajo.worker.TaskManager (stopExecutionBlock(160)) - Stopped execution block:eb_1455527640068_2150_000004
2016-02-15 10:21:09,807 INFO: org.apache.tajo.storage.FileTablespace (commitOutputData(964)) - Moved from the staging dir to the output directory 'hdfs://localhost:39593/tajo/warehouse/default/nullcharsession
2016-02-15 10:21:09,812 INFO: org.apache.tajo.catalog.CatalogServer (createTable(694)) - relation "default.nullcharsession" is added to the catalog (127.0.0.1:22859)
2016-02-15 10:21:09,812 INFO: org.apache.tajo.querymaster.Query (handle(879)) - q_1455527640068_2150 Query Transitioned from QUERY_RUNNING to QUERY_SUCCEEDED
2016-02-15 10:21:09,812 INFO: org.apache.tajo.querymaster.QueryMasterTask (handle(297)) - Query completion notified from q_1455527640068_2150 final state: QUERY_SUCCEEDED
2016-02-15 10:21:09,813 INFO: org.apache.tajo.master.QueryInProgress (heartbeat(257)) - Received QueryMaster heartbeat:q_1455527640068_2150,state=QUERY_SUCCEEDED,progress=1.0, queryMaster=asf908.gq1.ygridcore.net
2016-02-15 10:21:09,813 INFO: org.apache.tajo.master.QueryManager (stopQuery(279)) - Stop QueryInProgress:q_1455527640068_2150
2016-02-15 10:21:09,813 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(122)) - =========================================================
2016-02-15 10:21:09,813 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(123)) - Stop query:q_1455527640068_2150
2016-02-15 10:21:09,813 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(173)) - Stopping QueryMasterTask:q_1455527640068_2150
2016-02-15 10:21:09,813 INFO: org.apache.tajo.querymaster.QueryMasterTask (cleanupQuery(474)) - Cleanup resources of all workers. Query: q_1455527640068_2150, workers: 1
2016-02-15 10:21:09,814 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(189)) - Stopped QueryMasterTask:q_1455527640068_2150
2016-02-15 10:21:09,940 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(365)) - Saving query summary: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2148/query.hist
2016-02-15 10:21:09,947 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073748419_7595{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-b9d64e55-0132-49dd-a101-616297a0193f:NORMAL:127.0.0.1:58499|FINALIZED]]} size 0
2016-02-15 10:21:09,949 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2148/eb_1455527640068_2148_000002.hist
2016-02-15 10:21:09,952 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2148/eb_1455527640068_2148_000001.hist
2016-02-15 10:21:09,955 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(365)) - Saving query summary: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2149/query.hist
2016-02-15 10:21:09,961 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073748420_7596{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-88eebddb-9ff2-4826-b251-39ebebb8a5c1:NORMAL:127.0.0.1:58499|FINALIZED]]} size 0
2016-02-15 10:21:09,964 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2149/eb_1455527640068_2149_000002.hist
2016-02-15 10:21:09,966 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2149/eb_1455527640068_2149_000001.hist
2016-02-15 10:21:09,970 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(365)) - Saving query summary: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2150/query.hist
2016-02-15 10:21:09,976 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073748421_7597{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-b9d64e55-0132-49dd-a101-616297a0193f:NORMAL:127.0.0.1:58499|FINALIZED]]} size 0
2016-02-15 10:21:09,978 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2150/eb_1455527640068_2150_000001.hist
2016-02-15 10:21:09,983 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073748422_7598{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-88eebddb-9ff2-4826-b251-39ebebb8a5c1:NORMAL:127.0.0.1:58499|RBW]]} size 0
2016-02-15 10:21:09,985 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2150/eb_1455527640068_2150_000002.hist
2016-02-15 10:21:09,989 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073748423_7599{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-b9d64e55-0132-49dd-a101-616297a0193f:NORMAL:127.0.0.1:58499|FINALIZED]]} size 0
2016-02-15 10:21:09,991 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2150/eb_1455527640068_2150_000004.hist
2016-02-15 10:21:09,995 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073748424_7600{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-88eebddb-9ff2-4826-b251-39ebebb8a5c1:NORMAL:127.0.0.1:58499|RBW]]} size 0
2016-02-15 10:21:09,998 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39593/tmp/tajo-jenkins/staging/history/20160215/query-detail/q_1455527640068_2150/eb_1455527640068_2150_000003.hist
2016-02-15 10:21:10,002 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073748425_7601{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-b9d64e55-0132-49dd-a101-616297a0193f:NORMAL:127.0.0.1:58499|FINALIZED]]} size 0
2016-02-15 10:21:10,176 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: create table testFailCreateTablePartitionedOtherExceptColumn (deptname text, score int4)PARTITION BY RANGE (score)( PARTITION sub_part1 VALUES LESS THAN (2),PARTITION sub_part2 VALUES LESS THAN (5),PARTITION sub_part2 VALUES LESS THAN (MAXVALUE) )
2016-02-15 10:21:10,186 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: create table testFailCreateTablePartitionedOtherExceptColumn (deptname text, score int4)PARTITION BY LIST (deptname)( PARTITION sub_part1 VALUES('r&d', 'design'),PARTITION sub_part2 VALUES('sales', 'hr') )
2016-02-15 10:21:10,189 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: create table testFailCreateTablePartitionedOtherExceptColumn (deptname text, score int4)PARTITION BY HASH (deptname)PARTITIONS 2
2016-02-15 10:21:10,190 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 847dd895-a04d-4a0b-8299-a278bf2e2e8f is removed.
Tests run: 26, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.532 sec - in org.apache.tajo.client.TestTajoClient
Running org.apache.tajo.client.TestQueryClientExceptions
2016-02-15 10:21:10,195 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session 457c1087-9990-4781-8052-ef059deb4cdc is created.
2016-02-15 10:21:10,196 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: create table default.lineitem (name int);
2016-02-15 10:21:10,197 WARN: org.apache.tajo.plan.verifier.VerificationState (addVerification(41)) - org.apache.tajo.plan.verifier.PreLogicalPlanVerifier:assertRelationNoExistence(187) causes: table 'default.lineitem' already exists
2016-02-15 10:21:10,627 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: select * from unknown_table
2016-02-15 10:21:10,628 WARN: org.apache.tajo.plan.verifier.VerificationState (addVerification(41)) - org.apache.tajo.plan.verifier.PreLogicalPlanVerifier:assertRelationExistence(158) causes: relation 'default.unknown_table' does not exist
2016-02-15 10:21:10,629 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: create table default.lineitem (name int);
2016-02-15 10:21:10,630 WARN: org.apache.tajo.plan.verifier.VerificationState (addVerification(41)) - org.apache.tajo.plan.verifier.PreLogicalPlanVerifier:assertRelationNoExistence(187) causes: table 'default.lineitem' already exists
2016-02-15 10:21:10,747 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: select * from unknown_table
2016-02-15 10:21:10,748 WARN: org.apache.tajo.plan.verifier.VerificationState (addVerification(41)) - org.apache.tajo.plan.verifier.PreLogicalPlanVerifier:assertRelationExistence(158) causes: relation 'default.unknown_table' does not exist
2016-02-15 10:21:10,847 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 457c1087-9990-4781-8052-ef059deb4cdc is removed.
Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.642 sec - in org.apache.tajo.client.TestQueryClientExceptions
Running org.apache.tajo.resource.TestResources
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec - in org.apache.tajo.resource.TestResources
2016-02-15 10:21:10,855 INFO: org.mortbay.log (info(67)) - Shutdown hook executing
2016-02-15 10:21:10,855 INFO: org.mortbay.log (info(67)) - Shutdown hook complete
shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:01 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 15, 2016 10:11:01 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:01 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:02 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 15, 2016 10:11:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:02 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 15, 2016 10:11:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 10:11:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:05 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 212
Feb 15, 2016 10:11:05 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 5 values, 10B raw, 10B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN_DICTIONARY], dic { 3 entries, 12B raw, 3B comp}
Feb 15, 2016 10:11:05 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 123B for [l_shipdate] BINARY: 5 values, 76B raw, 76B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:05 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 123B for [l_shipdate_function] BINARY: 5 values, 76B raw, 76B comp, 1 pages, encodings: [BIT_PACKED, RLE, PLAIN]
Feb 15, 2016 10:11:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 15, 2016 10:11:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 15, 2016 10:11:05 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
2016-02-15 10:21:10,862 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 630ddeb2-84ac-4e94-a3cd-16648f226f0e is removed.
2016-02-15 10:21:10,865 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session c12f3728-5c14-45dc-a980-7114304426ec is removed.
2016-02-15 10:21:10,865 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58499 is added to blk_1073745872_5048{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-88eebddb-9ff2-4826-b251-39ebebb8a5c1:NORMAL:127.0.0.1:58499|RBW]]} size 957704
2016-02-15 10:21:10,869 INFO: org.apache.tajo.worker.TajoWorker (run(569)) - ============================================
2016-02-15 10:21:10,869 INFO: org.apache.tajo.worker.TajoWorker (run(570)) - TajoWorker received SIGINT Signal
2016-02-15 10:21:10,869 INFO: org.apache.tajo.worker.TajoWorker (run(571)) - ============================================
2016-02-15 10:21:10,871 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_asf908.gq1.ygridcore.net_22863 stopped.
2016-02-15 10:21:10,871 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-15 10:21:11,272 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(113)) - NodeStatusUpdater stopped.
2016-02-15 10:21:11,272 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(261)) - Heartbeat Thread stopped.
2016-02-15 10:21:11,272 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:22865) shutdown
2016-02-15 10:21:11,272 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped
2016-02-15 10:21:11,273 INFO: org.apache.tajo.querymaster.QueryMaster (run(432)) - QueryMaster heartbeat thread stopped
2016-02-15 10:21:11,273 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(164)) - QueryMaster stopped
2016-02-15 10:21:11,273 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(98)) - TajoWorkerClientService stopping
2016-02-15 10:21:11,274 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:22864) shutdown
2016-02-15 10:21:11,274 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(102)) - TajoWorkerClientService stopped
2016-02-15 10:21:11,274 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:22863) shutdown
2016-02-15 10:21:11,274 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped
2016-02-15 10:21:11,275 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(379)) - TajoWorker main thread exiting
2016-02-15 10:21:14,479 INFO: org.apache.tajo.master.TajoMaster (run(580)) - ============================================
2016-02-15 10:21:14,480 INFO: org.apache.tajo.master.TajoMaster (run(581)) - TajoMaster received SIGINT Signal
2016-02-15 10:21:14,480 INFO: org.apache.tajo.master.TajoMaster (run(582)) - ============================================
2016-02-15 10:21:14,480 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:22862) shutdown
2016-02-15 10:21:14,480 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2016-02-15 10:21:14,484 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:22861) shutdown
2016-02-15 10:21:14,485 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-15 10:21:14,484 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_22861 stopped.
2016-02-15 10:21:16,689 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:22860) shutdown
2016-02-15 10:21:16,689 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(188)) - Catalog Server (127.0.0.1:22859) shutdown
2016-02-15 10:21:16,690 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:22859) shutdown
2016-02-15 10:21:16,690 INFO: org.apache.tajo.catalog.store.DerbyStore (close(2901)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-0.11.2-build/ws/tajo-core-tests/target/test-data/f27c0e6a-8be3-45c9-a053-633d1c2a01d7/db;create=true)>
2016-02-15 10:21:16,690 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:22858) shutdown
2016-02-15 10:21:16,691 INFO: org.apache.tajo.master.TajoMaster (serviceStop(440)) - Tajo Master main thread exiting
2016-02-15 10:21:16,726 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(68)) - Derby shutdown complete normally.
2016-02-15 10:21:16,726 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(75)) - Shutdown database

Results :

Failed tests: 
  TestHBaseTable.testCreateNotExistsExternalHBaseTable:167 null
Tests in error: 
  TestHBaseTable.testBinaryMappedQuery:326 » RetriesExhausted Failed after attem...
  TestHBaseTable.testCTAS:1293->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testColumnKeyValueSelectQuery:385 » RetriesExhausted Failed aft...
  TestHBaseTable.testCompositeRowIndexPredication:512->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testCreateExternalHBaseTable:196 » RetriesExhausted Failed afte...
  TestHBaseTable.testCreateHBaseTable:127->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testGetSplitsWhenRestartHBase:1443->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testGetTableVolume:246 » RetriesExhausted Failed after attempts...
  TestHBaseTable.testIndexPredication:467->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertInto:742->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoBinaryMultiRegion:1053->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoColumnKeyValue:1108->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoDifferentType:1198->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoLocation:1390->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegion:824->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegion2:880->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegionMultiRowFields:994->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegionWithSplitFile:937->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoRowField:1234->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertIntoUsingPut:1340->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testInsertValues1:782->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testJoin:702->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testNonForwardQuery:664->QueryTestCaseBase.executeString:391 » TajoInternal
  TestHBaseTable.testRowFieldSelectQuery:428 » RetriesExhausted Failed after att...
  TestHBaseTable.testSimpleSelectQuery:288 » RetriesExhausted Failed after attem...

Tests run: 1715, Failures: 1, Errors: 25, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  2.002 s]
[INFO] Tajo Project POM .................................. SUCCESS [  1.263 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  5.552 s]
[INFO] Tajo Common ....................................... SUCCESS [ 39.548 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  3.173 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  5.954 s]
[INFO] Tajo Plan ......................................... SUCCESS [  6.892 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  2.959 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [02:25 min]
[INFO] Tajo Catalog Client ............................... SUCCESS [  1.641 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [01:14 min]
[INFO] Tajo Storage Common ............................... SUCCESS [  6.552 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [01:23 min]
[INFO] Tajo PullServer ................................... SUCCESS [  2.410 s]
[INFO] Tajo Client ....................................... SUCCESS [  2.470 s]
[INFO] Tajo CLI tools .................................... SUCCESS [  2.717 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [  6.033 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [  1.774 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [  4.169 s]
[INFO] Tajo Metrics ...................................... SUCCESS [  1.849 s]
[INFO] Tajo Core ......................................... SUCCESS [  6.206 s]
[INFO] Tajo RPC .......................................... SUCCESS [  0.927 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 34.607 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [  0.103 s]
[INFO] Tajo Catalog ...................................... SUCCESS [  0.977 s]
[INFO] Tajo Client Example ............................... SUCCESS [  1.037 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [  5.729 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [  3.578 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 40.500 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [  0.912 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [  1.046 s]
[INFO] Tajo Storage ...................................... SUCCESS [  1.004 s]
[INFO] Tajo Distribution ................................. SUCCESS [  5.904 s]
[INFO] Tajo Core Tests ................................... FAILURE [  01:07 h]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 01:15 h
[INFO] Finished at: 2016-02-15T10:21:17+00:00
[INFO] Final Memory: 139M/916M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.19:test (default-test) on project tajo-core-tests: There are test failures.
[ERROR] 
[ERROR] Please refer to <https://builds.apache.org/job/Tajo-0.11.2-build/ws/tajo-core-tests/target/surefire-reports> for the individual test results.
[ERROR] -> [Help 1]
[ERROR] 
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR] 
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :tajo-core-tests
Build step 'Execute shell' marked build as failure
Archiving artifacts
Updating TAJO-2074