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
