See <https://builds.apache.org/job/Tajo-master-build/916/changes>
Changes: [blrunner] TAJO-1902: Add line delimiter for repair partition in TajoDump. ------------------------------------------ [...truncated 729525 lines...] 2015-09-30 23:11:37,390 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - ================================== 2015-09-30 23:11:37,390 INFO: org.apache.tajo.worker.TaskImpl (initPlan(153)) - * Stage ta_1443653216987_2157_000001_000004_00 is initialized 2015-09-30 23:11:37,390 INFO: org.apache.tajo.worker.TaskImpl (initPlan(154)) - * InterQuery: true, Use RANGE_SHUFFLE shuffle, Fragments (num: 1), Fetches (total:0) : 2015-09-30 23:11:37,391 INFO: org.apache.tajo.worker.TaskImpl (initPlan(164)) - * Local task dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/4_0> 2015-09-30 23:11:37,391 INFO: org.apache.tajo.worker.TaskImpl (initPlan(169)) - ================================== 2015-09-30 23:11:37,391 INFO: org.apache.tajo.engine.planner.physical.RangeShuffleFileWriteExec (init(80)) - Output data directory: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/4_0/output> 2015-09-30 23:11:37,414 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1443653216987_2157_000001_000003_00] Chunks creation time: 0 msec 2015-09-30 23:11:37,414 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1443653216987_2157_000001_000004_00] Chunks creation time: 0 msec 2015-09-30 23:11:37,419 INFO: org.apache.tajo.worker.TaskImpl (run(462)) - ta_1443653216987_2157_000001_000004_00 completed. Worker's task counter - total:5, succeeded: 5, killed: 0, failed: 0 2015-09-30 23:11:37,419 INFO: org.apache.tajo.worker.TaskImpl (run(462)) - ta_1443653216987_2157_000001_000003_00 completed. Worker's task counter - total:5, succeeded: 5, killed: 0, failed: 0 2015-09-30 23:11:37,419 INFO: org.apache.tajo.querymaster.Stage (transition(1248)) - [eb_1443653216987_2157_000001] Task Completion Event (Total: 5, Success: 4, Killed: 0, Failed: 0) 2015-09-30 23:11:37,419 INFO: org.apache.tajo.querymaster.Stage (transition(1350)) - Stage - eb_1443653216987_2157_000001 finalize RANGE_SHUFFLE (total=5, success=5, killed=0) 2015-09-30 23:11:37,420 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (stop(164)) - Task Scheduler stopped 2015-09-30 23:11:37,420 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (run(127)) - TaskScheduler schedulingThread stopped 2015-09-30 23:11:37,420 INFO: org.apache.tajo.querymaster.Stage (transition(1408)) - Stage completed - eb_1443653216987_2157_000001 (total=5, success=5, killed=0) 2015-09-30 23:11:37,420 INFO: org.apache.tajo.querymaster.Query (handle(870)) - Processing q_1443653216987_2157 of type STAGE_COMPLETED 2015-09-30 23:11:37,420 INFO: org.apache.tajo.engine.planner.global.ParallelExecutionQueue (next(95)) - Next executable block eb_1443653216987_2157_000002 2015-09-30 23:11:37,420 INFO: org.apache.tajo.querymaster.Query (executeNextBlock(772)) - Scheduling Stage:eb_1443653216987_2157_000002 2015-09-30 23:11:37,420 INFO: org.apache.tajo.worker.TaskManager (stopExecutionBlock(163)) - Stopped execution block:eb_1443653216987_2157_000001 2015-09-30 23:11:37,437 INFO: org.apache.tajo.querymaster.Stage (initTaskScheduler(902)) - org.apache.tajo.querymaster.DefaultTaskScheduler is chosen for the task scheduling for eb_1443653216987_2157_000002 2015-09-30 23:11:37,437 INFO: org.apache.tajo.querymaster.Stage (getNonLeafTaskNum(1096)) - eb_1443653216987_2157_000002, Table's volume is approximately 1 MB 2015-09-30 23:11:37,437 INFO: org.apache.tajo.querymaster.Stage (getNonLeafTaskNum(1101)) - eb_1443653216987_2157_000002, The determined number of non-leaf tasks is 5 2015-09-30 23:11:37,437 INFO: org.apache.tajo.querymaster.Repartitioner (scheduleRangeShuffledFetches(673)) - eb_1443653216987_2157_000002, Try to divide [(E,5), (A,1)) into 5 sub ranges (total units: 5) 2015-09-30 23:11:37,438 INFO: org.apache.tajo.querymaster.Stage (run(854)) - 5 objects are scheduled 2015-09-30 23:11:37,438 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (start(135)) - Start TaskScheduler 2015-09-30 23:11:37,440 INFO: org.apache.tajo.worker.TaskManager (createExecutionBlock(114)) - QueryMaster Address:asf906.gq1.ygridcore.net:41706 2015-09-30 23:11:37,442 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(119)) - Tajo Root Dir: hdfs://localhost:39371/tajo 2015-09-30 23:11:37,442 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(120)) - Worker Local Dir: file://<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir> 2015-09-30 23:11:37,442 INFO: org.apache.tajo.worker.TaskManager (handle(184)) - Running ExecutionBlocks: 1, running tasks:0, availableResource: (Memory:500, Disks:3, vCores:1) 2015-09-30 23:11:37,443 INFO: org.apache.tajo.worker.TaskImpl (<init>(116)) - Task basedir is created (<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2)> 2015-09-30 23:11:37,443 INFO: org.apache.tajo.worker.TaskImpl (init(197)) - Initializing: ta_1443653216987_2157_000002_000003_00 2015-09-30 23:11:37,443 INFO: org.apache.tajo.worker.TaskImpl (<init>(116)) - Task basedir is created (<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2)> 2015-09-30 23:11:37,443 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(291)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000003-000 2015-09-30 23:11:37,443 INFO: org.apache.tajo.worker.TaskImpl (<init>(116)) - Task basedir is created (<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2)> 2015-09-30 23:11:37,443 INFO: org.apache.tajo.worker.TaskImpl (init(197)) - Initializing: ta_1443653216987_2157_000002_000004_00 2015-09-30 23:11:37,444 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(291)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000004-000 2015-09-30 23:11:37,444 INFO: org.apache.tajo.worker.TaskImpl (initPlan(147)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000004-000 2015-09-30 23:11:37,444 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - ================================== 2015-09-30 23:11:37,444 INFO: org.apache.tajo.worker.TaskImpl (initPlan(153)) - * Stage ta_1443653216987_2157_000002_000004_00 is initialized 2015-09-30 23:11:37,444 INFO: org.apache.tajo.worker.TaskImpl (initPlan(154)) - * InterQuery: false, Fragments (num: 1), Fetches (total:5) : 2015-09-30 23:11:37,444 INFO: org.apache.tajo.worker.TaskImpl (initPlan(164)) - * Local task dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2/4_0> 2015-09-30 23:11:37,444 INFO: org.apache.tajo.worker.TaskImpl (initPlan(169)) - ================================== 2015-09-30 23:11:37,445 INFO: org.apache.tajo.worker.TaskImpl (init(216)) - the directory is created <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/in/eb_1443653216987_2157_000002/4/0/eb_1443653216987_2157_000001> 2015-09-30 23:11:37,443 INFO: org.apache.tajo.worker.TaskImpl (init(197)) - Initializing: ta_1443653216987_2157_000002_000001_00 2015-09-30 23:11:37,443 INFO: org.apache.tajo.worker.TaskImpl (initPlan(147)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000003-000 2015-09-30 23:11:37,450 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - ================================== 2015-09-30 23:11:37,450 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(291)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000001-000 2015-09-30 23:11:37,451 INFO: org.apache.tajo.worker.TaskImpl (initPlan(147)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000001-000 2015-09-30 23:11:37,451 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - ================================== 2015-09-30 23:11:37,451 INFO: org.apache.tajo.worker.TaskImpl (initPlan(153)) - * Stage ta_1443653216987_2157_000002_000001_00 is initialized 2015-09-30 23:11:37,451 INFO: org.apache.tajo.worker.TaskImpl (initPlan(153)) - * Stage ta_1443653216987_2157_000002_000003_00 is initialized 2015-09-30 23:11:37,451 INFO: org.apache.tajo.worker.TaskImpl (initPlan(154)) - * InterQuery: false, Fragments (num: 1), Fetches (total:5) : 2015-09-30 23:11:37,451 INFO: org.apache.tajo.worker.TaskImpl (initPlan(164)) - * Local task dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2/1_0> 2015-09-30 23:11:37,451 INFO: org.apache.tajo.worker.TaskImpl (initPlan(169)) - ================================== 2015-09-30 23:11:37,451 INFO: org.apache.tajo.worker.TaskImpl (initPlan(154)) - * InterQuery: false, Fragments (num: 1), Fetches (total:5) : 2015-09-30 23:11:37,452 INFO: org.apache.tajo.worker.TaskImpl (initPlan(164)) - * Local task dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2/3_0> 2015-09-30 23:11:37,452 INFO: org.apache.tajo.worker.TaskImpl (initPlan(169)) - ================================== 2015-09-30 23:11:37,452 INFO: org.apache.tajo.worker.TaskImpl (init(216)) - the directory is created <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/in/eb_1443653216987_2157_000002/1/0/eb_1443653216987_2157_000001> 2015-09-30 23:11:37,452 INFO: org.apache.tajo.worker.TaskImpl (init(216)) - the directory is created <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/in/eb_1443653216987_2157_000002/3/0/eb_1443653216987_2157_000001> 2015-09-30 23:11:37,467 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/1_0/output/output> (start=(A,5), end=(A,1), last=true) 2015-09-30 23:11:37,474 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/0_0/output/output> (start=(B,5), end=(A,5)) 2015-09-30 23:11:37,474 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(D,4), (D,4)], but request start:(B,5), end: (A,5) 2015-09-30 23:11:37,478 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/1_0/output/output> (start=(D,5), end=(C,5)) 2015-09-30 23:11:37,478 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(A,1), (A,1)], but request start:(D,5), end: (C,5) 2015-09-30 23:11:37,478 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39371/tmp/tajo-jenkins/staging/history/20150930/query-detail/q_1443653216987_2156/eb_1443653216987_2156_000001.hist 2015-09-30 23:11:37,482 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43156 is added to blk_1073748496_7672{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-fe8dff02-b5e0-4f00-879f-f51bd580492b:NORMAL:127.0.0.1:43156|FINALIZED]]} size 0 2015-09-30 23:11:37,483 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:39371/tmp/tajo-jenkins/staging/history/20150930/query-detail/q_1443653216987_2156/eb_1443653216987_2156_000002.hist 2015-09-30 23:11:37,485 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43156 is added to blk_1073748497_7673{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-75d61add-bdd7-4faa-92f4-2c54788f10a8:NORMAL:127.0.0.1:43156|FINALIZED]]} size 0 2015-09-30 23:11:37,491 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/2_0/output/output> (start=(A,5), end=(A,1), last=true) 2015-09-30 23:11:37,491 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(C,3), (C,3)], but request start:(A,5), end: (A,1) 2015-09-30 23:11:37,493 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/1_0/output/output> (start=(B,5), end=(A,5)) 2015-09-30 23:11:37,493 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(A,1), (A,1)], but request start:(B,5), end: (A,5) 2015-09-30 23:11:37,498 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/0_0/output/output> (start=(D,5), end=(C,5)) 2015-09-30 23:11:37,511 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/4_0/output/output> (start=(A,5), end=(A,1), last=true) 2015-09-30 23:11:37,511 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(B,2), (B,2)], but request start:(A,5), end: (A,1) 2015-09-30 23:11:37,511 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/2_0/output/output> (start=(B,5), end=(A,5)) 2015-09-30 23:11:37,511 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(C,3), (C,3)], but request start:(B,5), end: (A,5) 2015-09-30 23:11:37,516 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/2_0/output/output> (start=(D,5), end=(C,5)) 2015-09-30 23:11:37,516 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(C,3), (C,3)], but request start:(D,5), end: (C,5) 2015-09-30 23:11:37,527 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/3_0/output/output> (start=(A,5), end=(A,1), last=true) 2015-09-30 23:11:37,527 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/3_0/output/output> (start=(B,5), end=(A,5)) 2015-09-30 23:11:37,528 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(E,5), (E,5)], but request start:(A,5), end: (A,1) 2015-09-30 23:11:37,528 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(E,5), (E,5)], but request start:(B,5), end: (A,5) 2015-09-30 23:11:37,532 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/3_0/output/output> (start=(D,5), end=(C,5)) 2015-09-30 23:11:37,532 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(E,5), (E,5)], but request start:(D,5), end: (C,5) 2015-09-30 23:11:37,544 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/0_0/output/output> (start=(A,5), end=(A,1), last=true) 2015-09-30 23:11:37,544 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/4_0/output/output> (start=(B,5), end=(A,5)) 2015-09-30 23:11:37,544 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(D,4), (D,4)], but request start:(A,5), end: (A,1) 2015-09-30 23:11:37,545 INFO: org.apache.tajo.worker.TaskImpl (getFetchRunners(725)) - Create shuffle Fetchers local:1, remote:0 2015-09-30 23:11:37,545 INFO: org.apache.tajo.worker.TaskImpl (getFetchRunners(725)) - Create shuffle Fetchers local:1, remote:0 2015-09-30 23:11:37,545 INFO: org.apache.tajo.worker.TaskImpl (run(617)) - Add a new FileChunk to local chunk list 2015-09-30 23:11:37,545 INFO: org.apache.tajo.worker.TaskImpl (run(617)) - Add a new FileChunk to local chunk list 2015-09-30 23:11:37,545 INFO: org.apache.tajo.worker.TaskImpl (waitForFetch(364)) - ta_1443653216987_2157_000002_000004_00 All fetches are done! 2015-09-30 23:11:37,545 INFO: org.apache.tajo.worker.TaskImpl (waitForFetch(364)) - ta_1443653216987_2157_000002_000003_00 All fetches are done! 2015-09-30 23:11:37,547 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1443653216987_2157_000002_000004_00] Total merge time: 0 msec 2015-09-30 23:11:37,547 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1443653216987_2157_000002_000003_00] Total merge time: 0 msec 2015-09-30 23:11:37,547 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (close(791)) - Delete file: "fragment": {"id": "eb_1443653216987_2157_000001", "path": <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/1_0/output/output";,> "start": 0,"length": 10} 2015-09-30 23:11:37,547 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (close(791)) - Delete file: "fragment": {"id": "eb_1443653216987_2157_000001", "path": <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/4_0/output/output";,> "start": 0,"length": 10} 2015-09-30 23:11:37,548 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/4_0/output/output> (start=(D,5), end=(C,5)) 2015-09-30 23:11:37,548 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(B,2), (B,2)], but request start:(D,5), end: (C,5) 2015-09-30 23:11:37,548 INFO: org.apache.tajo.worker.TaskImpl (getFetchRunners(725)) - Create shuffle Fetchers local:1, remote:0 2015-09-30 23:11:37,549 INFO: org.apache.tajo.worker.TaskImpl (run(617)) - Add a new FileChunk to local chunk list 2015-09-30 23:11:37,549 INFO: org.apache.tajo.worker.TaskImpl (waitForFetch(364)) - ta_1443653216987_2157_000002_000001_00 All fetches are done! 2015-09-30 23:11:37,549 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43156 is added to blk_1073748499_7675{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-75d61add-bdd7-4faa-92f4-2c54788f10a8:NORMAL:127.0.0.1:43156|RBW]]} size 0 2015-09-30 23:11:37,550 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1443653216987_2157_000002_000001_00] Total merge time: 0 msec 2015-09-30 23:11:37,550 INFO: org.apache.tajo.worker.TaskImpl (run(462)) - ta_1443653216987_2157_000002_000003_00 completed. Worker's task counter - total:1, succeeded: 1, killed: 0, failed: 0 2015-09-30 23:11:37,550 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43156 is added to blk_1073748498_7674{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-fe8dff02-b5e0-4f00-879f-f51bd580492b:NORMAL:127.0.0.1:43156|RBW]]} size 21 2015-09-30 23:11:37,550 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (close(791)) - Delete file: "fragment": {"id": "eb_1443653216987_2157_000001", "path": <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/0_0/output/output";,> "start": 0,"length": 10} 2015-09-30 23:11:37,550 INFO: org.apache.tajo.querymaster.Stage (transition(1248)) - [eb_1443653216987_2157_000002] Task Completion Event (Total: 5, Success: 1, Killed: 0, Failed: 0) 2015-09-30 23:11:37,552 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43156 is added to blk_1073748500_7676{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-fe8dff02-b5e0-4f00-879f-f51bd580492b:NORMAL:127.0.0.1:43156|RBW]]} size 0 2015-09-30 23:11:37,552 INFO: org.apache.tajo.worker.TaskImpl (run(462)) - ta_1443653216987_2157_000002_000001_00 completed. Worker's task counter - total:2, succeeded: 2, killed: 0, failed: 0 2015-09-30 23:11:37,553 INFO: org.apache.tajo.querymaster.Stage (transition(1248)) - [eb_1443653216987_2157_000002] Task Completion Event (Total: 5, Success: 2, Killed: 0, Failed: 0) 2015-09-30 23:11:37,597 INFO: org.apache.tajo.worker.TaskImpl (<init>(116)) - Task basedir is created (<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2)> 2015-09-30 23:11:37,597 INFO: org.apache.tajo.worker.TaskImpl (init(197)) - Initializing: ta_1443653216987_2157_000002_000002_00 2015-09-30 23:11:37,597 INFO: org.apache.tajo.worker.TaskImpl (<init>(116)) - Task basedir is created (<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2)> 2015-09-30 23:11:37,597 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(291)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000002-000 2015-09-30 23:11:37,597 INFO: org.apache.tajo.worker.TaskImpl (initPlan(147)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000002-000 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - ================================== 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(153)) - * Stage ta_1443653216987_2157_000002_000002_00 is initialized 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(154)) - * InterQuery: false, Fragments (num: 1), Fetches (total:5) : 2015-09-30 23:11:37,597 INFO: org.apache.tajo.worker.TaskImpl (init(197)) - Initializing: ta_1443653216987_2157_000002_000000_00 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(164)) - * Local task dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2/2_0> 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(169)) - ================================== 2015-09-30 23:11:37,598 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(291)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000000-000 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(147)) - Output File Path: hdfs://localhost:39371/tmp/tajo-jenkins/staging/q_1443653216987_2157/RESULT/part-02-000000-000 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - ================================== 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(153)) - * Stage ta_1443653216987_2157_000002_000000_00 is initialized 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(154)) - * InterQuery: false, Fragments (num: 1), Fetches (total:5) : 2015-09-30 23:11:37,598 INFO: org.apache.tajo.worker.TaskImpl (initPlan(164)) - * Local task dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/2/0_0> 2015-09-30 23:11:37,599 INFO: org.apache.tajo.worker.TaskImpl (initPlan(169)) - ================================== 2015-09-30 23:11:37,599 INFO: org.apache.tajo.worker.TaskImpl (init(216)) - the directory is created <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/in/eb_1443653216987_2157_000002/2/0/eb_1443653216987_2157_000001> 2015-09-30 23:11:37,599 INFO: org.apache.tajo.worker.TaskImpl (init(216)) - the directory is created <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/in/eb_1443653216987_2157_000002/0/0/eb_1443653216987_2157_000001> 2015-09-30 23:11:37,618 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/3_0/output/output> (start=(C,5), end=(B,5)) 2015-09-30 23:11:37,618 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/0_0/output/output> (start=(E,5), end=(D,5)) 2015-09-30 23:11:37,618 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(E,5), (E,5)], but request start:(C,5), end: (B,5) 2015-09-30 23:11:37,618 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(D,4), (D,4)], but request start:(E,5), end: (D,5) 2015-09-30 23:11:37,635 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/2_0/output/output> (start=(C,5), end=(B,5)) 2015-09-30 23:11:37,635 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/4_0/output/output> (start=(E,5), end=(D,5)) 2015-09-30 23:11:37,635 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(B,2), (B,2)], but request start:(E,5), end: (D,5) 2015-09-30 23:11:37,652 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/3_0/output/output> (start=(E,5), end=(D,5)) 2015-09-30 23:11:37,653 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/4_0/output/output> (start=(C,5), end=(B,5)) 2015-09-30 23:11:37,653 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(B,2), (B,2)], but request start:(C,5), end: (B,5) 2015-09-30 23:11:37,670 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/0_0/output/output> (start=(C,5), end=(B,5)) 2015-09-30 23:11:37,670 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(D,4), (D,4)], but request start:(C,5), end: (B,5) 2015-09-30 23:11:37,671 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/2_0/output/output> (start=(E,5), end=(D,5)) 2015-09-30 23:11:37,671 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(C,3), (C,3)], but request start:(E,5), end: (D,5) 2015-09-30 23:11:37,688 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/1_0/output/output> (start=(E,5), end=(D,5)) 2015-09-30 23:11:37,689 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(A,1), (A,1)], but request start:(E,5), end: (D,5) 2015-09-30 23:11:37,689 INFO: org.apache.tajo.worker.TaskImpl (getFetchRunners(725)) - Create shuffle Fetchers local:1, remote:0 2015-09-30 23:11:37,689 INFO: org.apache.tajo.worker.TaskImpl (run(617)) - Add a new FileChunk to local chunk list 2015-09-30 23:11:37,689 INFO: org.apache.tajo.worker.TaskImpl (waitForFetch(364)) - ta_1443653216987_2157_000002_000000_00 All fetches are done! 2015-09-30 23:11:37,690 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(688)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/1_0/output/output> (start=(C,5), end=(B,5)) 2015-09-30 23:11:37,690 WARN: org.apache.tajo.pullserver.TajoPullServerService (getFileChunks(698)) - Out of Scope (indexed data [(A,1), (A,1)], but request start:(C,5), end: (B,5) 2015-09-30 23:11:37,690 INFO: org.apache.tajo.worker.TaskImpl (getFetchRunners(725)) - Create shuffle Fetchers local:1, remote:0 2015-09-30 23:11:37,690 INFO: org.apache.tajo.worker.TaskImpl (run(617)) - Add a new FileChunk to local chunk list 2015-09-30 23:11:37,690 INFO: org.apache.tajo.worker.TaskImpl (waitForFetch(364)) - ta_1443653216987_2157_000002_000002_00 All fetches are done! 2015-09-30 23:11:37,691 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1443653216987_2157_000002_000000_00] Total merge time: 0 msec 2015-09-30 23:11:37,691 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (close(791)) - Delete file: "fragment": {"id": "eb_1443653216987_2157_000001", "path": <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/3_0/output/output";,> "start": 0,"length": 10} 2015-09-30 23:11:37,692 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1443653216987_2157_000002_000002_00] Total merge time: 0 msec 2015-09-30 23:11:37,692 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (close(791)) - Delete file: "fragment": {"id": "eb_1443653216987_2157_000001", "path": <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/80e4e630-4f17-4316-9181-a5bd156e31d1/tajo-localdir/q_1443653216987_2157/output/1/2_0/output/output";,> "start": 0,"length": 10} 2015-09-30 23:11:37,694 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43156 is added to blk_1073748501_7677{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-75d61add-bdd7-4faa-92f4-2c54788f10a8:NORMAL:127.0.0.1:43156|FINALIZED]]} size 0 2015-09-30 23:11:37,695 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43156 is added to blk_1073748502_7678{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-fe8dff02-b5e0-4f00-879f-f51bd580492b:NORMAL:127.0.0.1:43156|RBW]]} size 0 2015-09-30 23:11:37,695 INFO: org.apache.tajo.worker.TaskImpl (run(462)) - ta_1443653216987_2157_000002_000000_00 completed. Worker's task counter - total:3, succeeded: 3, killed: 0, failed: 0 2015-09-30 23:11:37,695 INFO: org.apache.tajo.worker.TaskImpl (run(462)) - ta_1443653216987_2157_000002_000002_00 completed. Worker's task counter - total:4, succeeded: 4, killed: 0, failed: 0 2015-09-30 23:11:37,695 INFO: org.apache.tajo.querymaster.Stage (transition(1248)) - [eb_1443653216987_2157_000002] Task Completion Event (Total: 5, Success: 3, Killed: 0, Failed: 0) 2015-09-30 23:11:37,696 INFO: org.apache.tajo.querymaster.Stage (transition(1248)) - [eb_1443653216987_2157_000002] Task Completion Event (Total: 5, Success: 4, Killed: 0, Failed: 0) 2015-09-30 23:11:37,951 INFO: org.apache.tajo.worker.TaskImpl (run(462)) - ta_1443653216987_2157_000002_000004_00 completed. Worker's task counter - total:5, succeeded: 5, killed: 0, failed: 0 2015-09-30 23:11:37,951 INFO: org.apache.tajo.querymaster.Stage (transition(1350)) - Stage - eb_1443653216987_2157_000002 finalize NONE_SHUFFLE (total=5, success=5, killed=0) 2015-09-30 23:11:37,952 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (stop(164)) - Task Scheduler stopped 2015-09-30 23:11:37,952 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (run(127)) - TaskScheduler schedulingThread stopped 2015-09-30 23:11:37,953 INFO: org.apache.tajo.querymaster.Stage (transition(1408)) - Stage completed - eb_1443653216987_2157_000002 (total=5, success=5, killed=0) 2015-09-30 23:11:37,953 INFO: org.apache.tajo.querymaster.Query (handle(870)) - Processing q_1443653216987_2157 of type STAGE_COMPLETED 2015-09-30 23:11:37,953 INFO: org.apache.tajo.engine.planner.global.ParallelExecutionQueue (next(95)) - Next executable block eb_1443653216987_2157_000003 2015-09-30 23:11:37,953 INFO: org.apache.tajo.querymaster.Query (transition(817)) - Complete Stage[eb_1443653216987_2157_000002], State: SUCCEEDED, 2/2. 2015-09-30 23:11:37,953 INFO: org.apache.tajo.querymaster.Query (handle(870)) - Processing q_1443653216987_2157 of type QUERY_COMPLETED 2015-09-30 23:11:37,953 INFO: org.apache.tajo.worker.TaskManager (stopExecutionBlock(163)) - Stopped execution block:eb_1443653216987_2157_000002 2015-09-30 23:11:37,954 INFO: org.apache.tajo.querymaster.Query (handle(888)) - q_1443653216987_2157 Query Transitioned from QUERY_RUNNING to QUERY_SUCCEEDED 2015-09-30 23:11:37,954 INFO: org.apache.tajo.querymaster.QueryMasterTask (handle(296)) - Query completion notified from q_1443653216987_2157 final state: QUERY_SUCCEEDED 2015-09-30 23:11:37,955 INFO: org.apache.tajo.master.QueryInProgress (heartbeat(259)) - Received QueryMaster heartbeat:q_1443653216987_2157,state=QUERY_SUCCEEDED,progress=1.0, queryMaster=asf906.gq1.ygridcore.net 2015-09-30 23:11:37,955 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(172)) - Stopping QueryMasterTask:q_1443653216987_2157 2015-09-30 23:11:37,955 INFO: org.apache.tajo.querymaster.QueryMasterTask (cleanupQuery(473)) - Cleanup resources of all workers. Query: q_1443653216987_2157, workers: 1 2015-09-30 23:11:37,955 INFO: org.apache.tajo.master.QueryManager (stopQuery(279)) - Stop QueryInProgress:q_1443653216987_2157 2015-09-30 23:11:37,956 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(124)) - ========================================================= 2015-09-30 23:11:37,956 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(125)) - Stop query:q_1443653216987_2157 2015-09-30 23:11:37,956 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(188)) - Stopped QueryMasterTask:q_1443653216987_2157 Killed Results : Tests run: 1356, Failures: 0, Errors: 0, Skipped: 0 [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary: [INFO] [INFO] Tajo Main ......................................... SUCCESS [ 3.052 s] [INFO] Tajo Project POM .................................. SUCCESS [ 2.894 s] [INFO] Tajo Maven Plugins ................................ SUCCESS [ 4.821 s] [INFO] Tajo Common ....................................... SUCCESS [ 40.739 s] [INFO] Tajo Algebra ...................................... SUCCESS [ 3.271 s] [INFO] Tajo Catalog Common ............................... SUCCESS [ 6.266 s] [INFO] Tajo Plan ......................................... SUCCESS [ 8.898 s] [INFO] Tajo Rpc Common ................................... SUCCESS [ 1.539 s] [INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 51.450 s] [INFO] Tajo Catalog Client ............................... SUCCESS [ 1.576 s] [INFO] Tajo Catalog Server ............................... SUCCESS [ 14.153 s] [INFO] Tajo Storage Common ............................... SUCCESS [ 3.359 s] [INFO] Tajo HDFS Storage ................................. SUCCESS [ 54.432 s] [INFO] Tajo PullServer ................................... SUCCESS [ 1.251 s] [INFO] Tajo Client ....................................... SUCCESS [ 3.222 s] [INFO] Tajo CLI tools .................................... SUCCESS [ 3.183 s] [INFO] Tajo SQL Parser ................................... SUCCESS [ 5.492 s] [INFO] ASM (thirdparty) .................................. SUCCESS [ 2.791 s] [INFO] Tajo RESTful Container ............................ SUCCESS [ 5.544 s] [INFO] Tajo Metrics ...................................... SUCCESS [ 1.720 s] [INFO] Tajo Core ......................................... SUCCESS [ 9.521 s] [INFO] Tajo RPC .......................................... SUCCESS [ 0.970 s] [INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 14.852 s] [INFO] Tajo Catalog Drivers .............................. SUCCESS [ 0.135 s] [INFO] Tajo Catalog ...................................... SUCCESS [ 1.049 s] [INFO] Tajo Client Example ............................... SUCCESS [ 1.256 s] [INFO] Tajo HBase Storage ................................ SUCCESS [ 5.325 s] [INFO] Tajo Cluster Tests ................................ SUCCESS [ 3.682 s] [INFO] Tajo JDBC Driver .................................. SUCCESS [ 38.327 s] [INFO] Tajo JDBC storage common .......................... SUCCESS [ 0.930 s] [INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [ 43.272 s] [INFO] Tajo Storage ...................................... SUCCESS [ 1.084 s] [INFO] Tajo Distribution ................................. SUCCESS [ 5.797 s] [INFO] Tajo Core Tests ................................... FAILURE [24:56 min] [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 30:43 min [INFO] Finished at: 2015-09-30T23:11:38+00:00 [INFO] Final Memory: 156M/2065M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.17:test (default-test) on project tajo-core-tests: Execution default-test of goal org.apache.maven.plugins:maven-surefire-plugin:2.17:test failed: The forked VM terminated without properly saying goodbye. VM crash or System.exit called? [ERROR] Command was /bin/sh -c cd <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests> && /home/jenkins/jenkins-slave/tools/hudson.model.JDK/jdk1.8.0_45/jre/bin/java -Xms512m -Xmx1024m -XX:MaxPermSize=152m -Dfile.encoding=UTF-8 -Dderby.storage.pageSize=1024 -Dderby.stream.error.file=/dev/null -jar <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/surefire/surefirebooter8461288504331527043.jar> <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/surefire/surefire2760348015650182990tmp> <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/surefire/surefire_158693406123473352272tmp> [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/PluginExecutionException [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 Updating TAJO-1902
