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 2015/04/06 05:13:25 UTC
Build failed in Jenkins: Tajo-master-build #653
See <https://builds.apache.org/job/Tajo-master-build/653/changes>
Changes:
[jihun] TAJO-1338: Defines RESTful API for Clients
------------------------------------------
[...truncated 400265 lines...]
2015-04-06 03:13:24,146 INFO: org.apache.tajo.querymaster.Stage (transition(1347)) - Stage finalize - eb_1428288782453_0944_000003 (total=1, success=1, killed=0)
2015-04-06 03:13:24,146 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (stop(152)) - Task Scheduler stopped
2015-04-06 03:13:24,146 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (run(109)) - TaskScheduler schedulingThread stopped
2015-04-06 03:13:24,146 INFO: org.apache.tajo.querymaster.QueryMaster (cleanupExecutionBlock(180)) - cleanup executionBlocks: eb_1428288782453_0944_000001,eb_1428288782453_0944_000002
2015-04-06 03:13:24,146 INFO: org.apache.tajo.worker.TaskRunner (run(259)) - Received ShouldDie flag:eb_1428288782453_0944_000003,container_1428288782453_0944_01_003450
2015-04-06 03:13:24,147 INFO: org.apache.tajo.worker.TaskRunner (stop(153)) - Stop TaskRunner: eb_1428288782453_0944_000003,container_1428288782453_0944_01_003450
2015-04-06 03:13:24,147 INFO: org.apache.tajo.worker.TaskRunnerManager (stopTaskRunner(105)) - Stop Task:eb_1428288782453_0944_000003,container_1428288782453_0944_01_003450
2015-04-06 03:13:24,148 INFO: org.apache.tajo.querymaster.Stage (transition(1353)) - eb_1428288782453_0944_000003, waiting for shuffle reports. expected Tasks:1
2015-04-06 03:13:24,148 INFO: org.apache.tajo.master.rm.TajoWorkerResourceManager (releaseWorkerResource(513)) - Release Resource: 0.5,512
2015-04-06 03:13:24,148 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(151)) - ======================== Processing eb_1428288782453_0944_000003 of type STOP
2015-04-06 03:13:24,149 INFO: org.apache.tajo.storage.HashShuffleAppenderManager (close(134)) - Close HashShuffleAppender:eb_1428288782453_0944_000003, not a hash shuffle
2015-04-06 03:13:24,149 INFO: org.apache.tajo.storage.HashShuffleAppenderManager (close(134)) - Close HashShuffleAppender:eb_1428288782453_0944_000003, not a hash shuffle
2015-04-06 03:13:24,149 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(191)) - Stopped execution block:eb_1428288782453_0944_000003
2015-04-06 03:13:24,149 INFO: org.apache.tajo.querymaster.Stage (transition(1333)) - eb_1428288782453_0944_000003, Finalized shuffle reports: 1
2015-04-06 03:13:24,149 INFO: org.apache.tajo.querymaster.Stage (transition(1397)) - Stage completed - eb_1428288782453_0944_000003 (total=1, success=1, killed=0)
2015-04-06 03:13:24,150 INFO: org.apache.tajo.querymaster.Query (handle(720)) - Processing q_1428288782453_0944 of type STAGE_COMPLETED
2015-04-06 03:13:24,150 INFO: org.apache.tajo.querymaster.Query (executeNextBlock(634)) - Scheduling Stage:eb_1428288782453_0944_000004
2015-04-06 03:13:24,150 INFO: org.apache.tajo.querymaster.Stage (initTaskScheduler(847)) - org.apache.tajo.querymaster.DefaultTaskScheduler is chosen for the task scheduling for eb_1428288782453_0944_000004
2015-04-06 03:13:24,150 INFO: org.apache.tajo.querymaster.Stage (getNonLeafTaskNum(1008)) - eb_1428288782453_0944_000004, Table's volume is approximately 1 MB
2015-04-06 03:13:24,150 INFO: org.apache.tajo.querymaster.Stage (getNonLeafTaskNum(1012)) - eb_1428288782453_0944_000004, The determined number of non-leaf tasks is 1
2015-04-06 03:13:24,151 INFO: org.apache.tajo.querymaster.Repartitioner (scheduleRangeShuffledFetches(700)) - eb_1428288782453_0944_000004, Try to divide [(0=>1, 1=>1), (0=>5, 1=>3)) into 1 sub ranges (total units: 1)
2015-04-06 03:13:24,151 INFO: org.apache.tajo.engine.utils.TupleUtil (setMaxRangeIfNull(109)) - Set null into range: default.orders.o_orderkey, current tuple is (0=>5, 1=>NULL)
2015-04-06 03:13:24,151 INFO: org.apache.tajo.querymaster.Stage (run(799)) - 1 objects are scheduled
2015-04-06 03:13:24,152 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (start(91)) - Start TaskScheduler
2015-04-06 03:13:24,152 INFO: org.apache.tajo.worker.TajoResourceAllocator (calculateNumRequestContainers(102)) - CalculateNumberRequestContainer - Number of Tasks=1, Number of Cluster Slots=1
2015-04-06 03:13:24,152 INFO: org.apache.tajo.querymaster.Stage (allocateContainers(1060)) - Request Container for eb_1428288782453_0944_000004 containers=1
2015-04-06 03:13:24,152 INFO: org.apache.tajo.worker.TajoResourceAllocator (run(262)) - Start TajoWorkerAllocationThread
2015-04-06 03:13:24,153 INFO: org.apache.tajo.worker.TajoResourceAllocator (run(375)) - Stop TajoWorkerAllocationThread
2015-04-06 03:13:24,154 INFO: org.apache.tajo.querymaster.Stage (transition(1174)) - Stage (eb_1428288782453_0944_000004) has 1 containers!
2015-04-06 03:13:24,155 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(151)) - ======================== Processing eb_1428288782453_0944_000004 of type START
2015-04-06 03:13:24,155 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(121)) - Tajo Root Dir: hdfs://localhost:45590/tajo
2015-04-06 03:13:24,155 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(122)) - Worker Local Dir: file://<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/d6e27f02-ca7a-48bb-b13f-ce0f21345560/tajo-localdir>
2015-04-06 03:13:24,155 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(125)) - QueryMaster Address:asf906.gq1.ygridcore.net/67.195.81.150:11906
2015-04-06 03:13:24,156 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(169)) - Start TaskRunner:eb_1428288782453_0944_000004,container_1428288782453_0944_01_003451
2015-04-06 03:13:24,157 INFO: org.apache.tajo.worker.TaskRunner (init(127)) - TaskRunner basedir is created (<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/d6e27f02-ca7a-48bb-b13f-ce0f21345560/tajo-localdir/q_1428288782453_0944/output/4)>
2015-04-06 03:13:24,157 INFO: org.apache.tajo.worker.TaskRunner (run(188)) - TaskRunner startup
2015-04-06 03:13:24,157 INFO: org.apache.tajo.worker.TaskRunner (run(221)) - Request GetTask: eb_1428288782453_0944_000004,container_1428288782453_0944_01_003451
2015-04-06 03:13:24,159 INFO: org.apache.tajo.worker.TaskRunner (run(265)) - Accumulated Received Task: 1
2015-04-06 03:13:24,159 INFO: org.apache.tajo.worker.TaskRunner (run(274)) - Initializing: ta_1428288782453_0944_000004_000000_00
2015-04-06 03:13:24,159 INFO: org.apache.tajo.worker.TaskAttemptContext (setState(145)) - Query status of ta_1428288782453_0944_000004_000000_00 is changed to TA_PENDING
2015-04-06 03:13:24,160 INFO: org.apache.tajo.storage.FileStorageManager (getAppenderFilePath(298)) - Output File Path: hdfs://localhost:45590/tmp/tajo-jenkins/staging/q_1428288782453_0944/RESULT/part-04-000000-000
2015-04-06 03:13:24,160 INFO: org.apache.tajo.worker.Task (initPlan(169)) - Output File Path: hdfs://localhost:45590/tmp/tajo-jenkins/staging/q_1428288782453_0944/RESULT/part-04-000000-000
2015-04-06 03:13:24,160 INFO: org.apache.tajo.worker.Task (initPlan(174)) - ==================================
2015-04-06 03:13:24,160 INFO: org.apache.tajo.worker.Task (initPlan(175)) - * Stage ta_1428288782453_0944_000004_000000_00 is initialized
2015-04-06 03:13:24,160 INFO: org.apache.tajo.worker.Task (initPlan(176)) - * InterQuery: false, Fragments (num: 1), Fetches (total:1) :
2015-04-06 03:13:24,161 INFO: org.apache.tajo.worker.Task (initPlan(186)) - * Local task dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/d6e27f02-ca7a-48bb-b13f-ce0f21345560/tajo-localdir/q_1428288782453_0944/output/4/0_0>
2015-04-06 03:13:24,161 INFO: org.apache.tajo.worker.Task (initPlan(191)) - ==================================
2015-04-06 03:13:24,162 INFO: org.apache.tajo.worker.Task (init(211)) - the directory is created <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/d6e27f02-ca7a-48bb-b13f-ce0f21345560/tajo-localdir/q_1428288782453_0944/in/eb_1428288782453_0944_000004/0/0/eb_1428288782453_0944_000003>
2015-04-06 03:13:24,162 INFO: org.apache.tajo.worker.Task (getFetchRunners(697)) - Try to get local file chunk at local host
2015-04-06 03:13:24,162 INFO: org.apache.tajo.worker.Task (getLocalStoredFileChunk(739)) - getLocalStoredFileChunk starts
2015-04-06 03:13:24,162 INFO: org.apache.tajo.worker.Task (getLocalStoredFileChunk(774)) - PullServer request param: shuffleType=r, sid=3, partId=0, taskIds=[0_0]
2015-04-06 03:13:24,179 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileCunks(686)) - BSTIndex is loaded from disk ((0=>1, 1=>1), (0=>5, 1=>NULL)
2015-04-06 03:13:24,179 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileCunks(710)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/d6e27f02-ca7a-48bb-b13f-ce0f21345560/tajo-localdir/q_1428288782453_0944/output/3/0_0/output/output> (start=(0=>1, 1=>1), end=(0=>5, 1=>NULL), last=true)
2015-04-06 03:13:24,179 INFO: org.apache.tajo.pullserver.TajoPullServerService (getFileCunks(779)) - Retrieve File Chunk: (start=0, length=49, fromRemote=false, ebId=null) <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/d6e27f02-ca7a-48bb-b13f-ce0f21345560/tajo-localdir/q_1428288782453_0944/output/3/0_0/output/output>
2015-04-06 03:13:24,179 INFO: org.apache.tajo.worker.Task (getFetchRunners(725)) - Create a new Fetcher with storeChunk: (start=0, length=49, fromRemote=false, ebId=eb_1428288782453_0944_000003) <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/d6e27f02-ca7a-48bb-b13f-ce0f21345560/tajo-localdir/q_1428288782453_0944/output/3/0_0/output/output>
2015-04-06 03:13:24,180 INFO: org.apache.tajo.worker.TaskAttemptContext (setState(145)) - Query status of ta_1428288782453_0944_000004_000000_00 is changed to TA_RUNNING
2015-04-06 03:13:24,180 INFO: org.apache.tajo.worker.Fetcher (get(138)) - Get pseudo fetch from local host
2015-04-06 03:13:24,180 INFO: org.apache.tajo.worker.Task (run(621)) - Add a new FileChunk to local chunk list
2015-04-06 03:13:24,180 INFO: org.apache.tajo.worker.Task (waitForFetch(366)) - ta_1428288782453_0944_000004_000000_00 All fetches are done!
2015-04-06 03:13:24,181 INFO: org.apache.tajo.worker.Task (localizeFetchedData(577)) - One local chunk is added to listTablets
2015-04-06 03:13:24,185 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (info(70)) - [ta_1428288782453_0944_000004_000000_00] Total merge time: 0 msec
2015-04-06 03:13:24,185 INFO: org.apache.tajo.engine.planner.physical.ExternalSortExec (close(792)) - Delete file: "fragment": {"id": "eb_1428288782453_0944_000003", "path": <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/d6e27f02-ca7a-48bb-b13f-ce0f21345560/tajo-localdir/q_1428288782453_0944/output/3/0_0/output/output",> "start": 0,"length": 49}
2015-04-06 03:13:24,190 INFO: BlockStateChange (logAddStoredBlock(2473)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:59176 is added to blk_1073747040_6216{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-efba173d-af80-429e-8d9b-3fcdfa22963a:NORMAL:127.0.0.1:59176|RBW]]} size 0
2015-04-06 03:13:24,191 INFO: org.apache.tajo.worker.TaskAttemptContext (setState(145)) - Query status of ta_1428288782453_0944_000004_000000_00 is changed to TA_SUCCEEDED
2015-04-06 03:13:24,191 INFO: org.apache.tajo.worker.Task (run(465)) - ta_1428288782453_0944_000004_000000_00 completed. Worker's task counter - total:1, succeeded: 1, killed: 0, failed: 0
2015-04-06 03:13:24,191 INFO: org.apache.tajo.worker.TaskRunner (run(221)) - Request GetTask: eb_1428288782453_0944_000004,container_1428288782453_0944_01_003451
2015-04-06 03:13:24,192 INFO: org.apache.tajo.querymaster.Stage (transition(1347)) - Stage finalize - eb_1428288782453_0944_000004 (total=1, success=1, killed=0)
2015-04-06 03:13:24,192 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (stop(152)) - Task Scheduler stopped
2015-04-06 03:13:24,192 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (run(109)) - TaskScheduler schedulingThread stopped
2015-04-06 03:13:24,192 INFO: org.apache.tajo.querymaster.QueryMaster (cleanupExecutionBlock(180)) - cleanup executionBlocks: eb_1428288782453_0944_000003
2015-04-06 03:13:24,192 INFO: org.apache.tajo.worker.TaskRunner (run(259)) - Received ShouldDie flag:eb_1428288782453_0944_000004,container_1428288782453_0944_01_003451
2015-04-06 03:13:24,193 INFO: org.apache.tajo.worker.TaskRunner (stop(153)) - Stop TaskRunner: eb_1428288782453_0944_000004,container_1428288782453_0944_01_003451
2015-04-06 03:13:24,193 INFO: org.apache.tajo.worker.TaskRunnerManager (stopTaskRunner(105)) - Stop Task:eb_1428288782453_0944_000004,container_1428288782453_0944_01_003451
2015-04-06 03:13:24,193 INFO: org.apache.tajo.querymaster.Stage (transition(1353)) - eb_1428288782453_0944_000004, waiting for shuffle reports. expected Tasks:1
2015-04-06 03:13:24,194 INFO: org.apache.tajo.master.rm.TajoWorkerResourceManager (releaseWorkerResource(513)) - Release Resource: 0.5,512
2015-04-06 03:13:24,194 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(151)) - ======================== Processing eb_1428288782453_0944_000004 of type STOP
2015-04-06 03:13:24,194 INFO: org.apache.tajo.storage.HashShuffleAppenderManager (close(134)) - Close HashShuffleAppender:eb_1428288782453_0944_000004, not a hash shuffle
2015-04-06 03:13:24,195 INFO: org.apache.tajo.storage.HashShuffleAppenderManager (close(134)) - Close HashShuffleAppender:eb_1428288782453_0944_000004, not a hash shuffle
2015-04-06 03:13:24,195 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(191)) - Stopped execution block:eb_1428288782453_0944_000004
2015-04-06 03:13:24,195 INFO: org.apache.tajo.querymaster.Stage (transition(1333)) - eb_1428288782453_0944_000004, Finalized shuffle reports: 1
2015-04-06 03:13:24,195 INFO: org.apache.tajo.querymaster.Stage (transition(1397)) - Stage completed - eb_1428288782453_0944_000004 (total=1, success=1, killed=0)
2015-04-06 03:13:24,195 INFO: org.apache.tajo.querymaster.Query (handle(720)) - Processing q_1428288782453_0944 of type STAGE_COMPLETED
2015-04-06 03:13:24,195 INFO: org.apache.tajo.querymaster.Query (handle(720)) - Processing q_1428288782453_0944 of type QUERY_COMPLETED
2015-04-06 03:13:24,196 INFO: org.apache.tajo.querymaster.Query (handle(738)) - q_1428288782453_0944 Query Transitioned from QUERY_RUNNING to QUERY_SUCCEEDED
2015-04-06 03:13:24,197 INFO: org.apache.tajo.querymaster.QueryMasterTask (handle(285)) - Query completion notified from q_1428288782453_0944
2015-04-06 03:13:24,197 INFO: org.apache.tajo.querymaster.QueryMasterTask (handle(296)) - Query final state: QUERY_SUCCEEDED
2015-04-06 03:13:24,197 INFO: org.apache.tajo.querymaster.QueryMasterTask (stop(192)) - Stopping QueryMasterTask:q_1428288782453_0944
2015-04-06 03:13:24,197 INFO: org.apache.tajo.querymaster.QueryMasterTask (stop(205)) - Stopped QueryMasterTask:q_1428288782453_0944
2015-04-06 03:13:24,198 INFO: org.apache.tajo.querymaster.QueryMaster (cleanup(207)) - cleanup query resources : q_1428288782453_0944
2015-04-06 03:13:24,198 INFO: org.apache.tajo.master.QueryInProgress (heartbeat(229)) - Received QueryMaster heartbeat:q_1428288782453_0944,state=QUERY_SUCCEEDED,progress=1.0, queryMaster=asf906.gq1.ygridcore.net
2015-04-06 03:13:24,198 INFO: org.apache.tajo.master.QueryManager (stopQuery(252)) - Stop QueryInProgress:q_1428288782453_0944
2015-04-06 03:13:24,198 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(109)) - =========================================================
2015-04-06 03:13:24,198 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(110)) - Stop query:q_1428288782453_0944
2015-04-06 03:13:24,198 INFO: org.apache.tajo.master.rm.TajoWorkerResourceManager (releaseWorkerResource(513)) - Release Resource: 0.0,512
2015-04-06 03:13:24,198 INFO: org.apache.tajo.master.rm.TajoWorkerResourceManager (releaseQueryMaster(535)) - Released QueryMaster (q_1428288782453_0944) resource.
2015-04-06 03:13:24,201 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(362)) - Saving query summary: hdfs://localhost:45590/tmp/tajo-jenkins/staging/history/20150406/query-detail/q_1428288782453_0944/query.hist
2015-04-06 03:13:24,207 INFO: BlockStateChange (logAddStoredBlock(2473)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:59176 is added to blk_1073747041_6217{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-cefa959b-4cc9-49b3-9f90-da8daf6d0767:NORMAL:127.0.0.1:59176|FINALIZED]]} size 0
2015-04-06 03:13:24,209 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(376)) - Saving query unit: hdfs://localhost:45590/tmp/tajo-jenkins/staging/history/20150406/query-detail/q_1428288782453_0944/eb_1428288782453_0944_000002.hist
2015-04-06 03:13:24,213 INFO: BlockStateChange (logAddStoredBlock(2473)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:59176 is added to blk_1073747042_6218{blockUCState=COMMITTED, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-cefa959b-4cc9-49b3-9f90-da8daf6d0767:NORMAL:127.0.0.1:59176|RBW]]} size 480
2015-04-06 03:13:24,238 INFO: org.apache.tajo.master.TajoMasterClientService (getQueryResultData(559)) - Send result to client for 5f4ed121-d746-48b5-a0b9-2db96ec8bf04,q_1428288782453_0944, 5 rows
2015-04-06 03:13:24,240 INFO: org.apache.tajo.master.TajoMasterClientService (getQueryResultData(559)) - Send result to client for 5f4ed121-d746-48b5-a0b9-2db96ec8bf04,q_1428288782453_0944, 0 rows
2015-04-06 03:13:24,243 INFO: org.apache.tajo.session.SessionManager (removeSession(79)) - Session 5f4ed121-d746-48b5-a0b9-2db96ec8bf04 is removed.
2015-04-06 03:13:24,246 INFO: org.apache.tajo.session.SessionManager (createSession(73)) - Session 0c9af972-0089-4091-b46c-28e08486d970 is created.
2015-04-06 03:13:24,248 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(150)) - Query: create table "TEST_DESC_TABLE" (col1 int4, col2 int4)
2015-04-06 03:13:24,251 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(239)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-04-06 03:13:24,251 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(241)) - =============================================
2015-04-06 03:13:24,252 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(242)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-04-06 03:13:24,252 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(243)) - =============================================
2015-04-06 03:13:24,254 INFO: org.apache.tajo.catalog.CatalogServer (createTable(605)) - relation "default.TEST_DESC_TABLE" is added to the catalog (127.0.0.1:11900)
2015-04-06 03:13:24,254 INFO: org.apache.tajo.master.exec.DDLExecutor (createTable(249)) - Table default.TEST_DESC_TABLE is created (0)
2015-04-06 03:13:24,259 INFO: org.apache.tajo.session.SessionManager (removeSession(79)) - Session 0c9af972-0089-4091-b46c-28e08486d970 is removed.
Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.253 sec - in org.apache.tajo.cli.tsql.TestTajoCli
2015-04-06 03:13:24,265 INFO: org.apache.tajo.session.SessionManager (removeSession(79)) - Session 21ec0585-6839-4422-bf19-7693d3ddd76e is removed.
Apr 6, 2015 2:59:15 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Apr 6, 2015 2:59:15 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Apr 6, 2015 2:59:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Apr 6, 2015 2:59:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Apr 6, 2015 2:59:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Apr 6, 2015 2:59:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Apr 6, 2015 2:59:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Apr 6, 2015 2:59:38 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
2015-04-06 03:13:24,265 INFO: org.apache.tajo.worker.TajoWorker (run(532)) - ============================================
2015-04-06 03:13:24,266 INFO: org.apache.tajo.master.TajoMaster (run(575)) - ============================================
2015-04-06 03:13:24,269 INFO: org.apache.tajo.worker.TajoWorker (run(533)) - TajoWorker received SIGINT Signal
2015-04-06 03:13:24,269 INFO: org.apache.tajo.worker.TajoWorker (run(534)) - ============================================
2015-04-06 03:13:24,269 INFO: org.apache.tajo.master.TajoMaster (run(576)) - TajoMaster received SIGINT Signal
2015-04-06 03:13:24,269 INFO: org.apache.tajo.master.TajoMaster (run(577)) - ============================================
2015-04-06 03:13:24,270 WARN: org.apache.hadoop.hdfs.DFSClient (completeFile(2275)) - Caught exception
java.lang.InterruptedException: sleep interrupted
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.hdfs.DFSOutputStream.completeFile(DFSOutputStream.java:2269)
at org.apache.hadoop.hdfs.DFSOutputStream.close(DFSOutputStream.java:2234)
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:237)
at org.apache.tajo.util.history.HistoryWriter$WriterThread.writeQueryHistory(HistoryWriter.java:378)
at org.apache.tajo.util.history.HistoryWriter$WriterThread.writeHistory(HistoryWriter.java:315)
at org.apache.tajo.util.history.HistoryWriter$WriterThread.run(HistoryWriter.java:231)
2015-04-06 03:13:24,272 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-04-06 03:13:24,273 INFO: org.apache.tajo.worker.WorkerHeartbeatService (run(227)) - Worker Resource Heartbeat Thread stopped.
2015-04-06 03:13:24,273 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(376)) - Saving query unit: hdfs://localhost:45590/tmp/tajo-jenkins/staging/history/20150406/query-detail/q_1428288782453_0944/eb_1428288782453_0944_000001.hist
2015-04-06 03:13:24,273 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:11906) shutdown
2015-04-06 03:13:24,275 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (stop(110)) - QueryMasterManagerService stopped
2015-04-06 03:13:24,275 INFO: org.apache.tajo.session.SessionManager (removeSession(79)) - Session 07863ec0-3549-4d63-917d-425b0dad677c is removed.
2015-04-06 03:13:24,275 INFO: org.apache.tajo.querymaster.QueryMaster (run(468)) - QueryMaster heartbeat thread stopped
2015-04-06 03:13:24,276 INFO: org.apache.tajo.querymaster.QueryMaster (stop(170)) - QueryMaster stopped
2015-04-06 03:13:24,276 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(99)) - TajoWorkerClientService stopping
2015-04-06 03:13:24,278 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:11905) shutdown
2015-04-06 03:13:24,279 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(103)) - TajoWorkerClientService stopped
2015-04-06 03:13:24,279 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:11904) shutdown
2015-04-06 03:13:24,279 INFO: org.apache.tajo.worker.TajoWorkerManagerService (stop(97)) - TajoWorkerManagerService stopped
2015-04-06 03:13:24,280 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(373)) - TajoWorker main thread exiting
2015-04-06 03:13:24,293 INFO: BlockStateChange (logAddStoredBlock(2473)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:59176 is added to blk_1073747043_6219{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-cefa959b-4cc9-49b3-9f90-da8daf6d0767:NORMAL:127.0.0.1:59176|RBW]]} size 0
2015-04-06 03:13:24,296 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(376)) - Saving query unit: hdfs://localhost:45590/tmp/tajo-jenkins/staging/history/20150406/query-detail/q_1428288782453_0944/eb_1428288782453_0944_000003.hist
2015-04-06 03:13:24,300 INFO: BlockStateChange (logAddStoredBlock(2473)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:59176 is added to blk_1073747044_6220{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-efba173d-af80-429e-8d9b-3fcdfa22963a:NORMAL:127.0.0.1:59176|FINALIZED]]} size 0
2015-04-06 03:13:24,301 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(376)) - Saving query unit: hdfs://localhost:45590/tmp/tajo-jenkins/staging/history/20150406/query-detail/q_1428288782453_0944/eb_1428288782453_0944_000004.hist
2015-04-06 03:13:24,305 INFO: BlockStateChange (logAddStoredBlock(2473)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:59176 is added to blk_1073747045_6221{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-cefa959b-4cc9-49b3-9f90-da8daf6d0767:NORMAL:127.0.0.1:59176|RBW]]} size 0
2015-04-06 03:13:24,306 INFO: org.apache.tajo.util.history.HistoryWriter (run(268)) - HistoryWriter_asf906.gq1.ygridcore.net_11904 stopped.
2015-04-06 03:13:24,320 INFO: BlockStateChange (logAddStoredBlock(2473)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:59176 is added to blk_1073741834_1010{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-efba173d-af80-429e-8d9b-3fcdfa22963a:NORMAL:127.0.0.1:59176|RBW]]} size 414
2015-04-06 03:13:24,379 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (Tajo-REST) listened on 0:0:0:0:0:0:0:0:11903) shutdown
2015-04-06 03:13:24,379 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2015-04-06 03:13:24,380 INFO: org.apache.tajo.catalog.CatalogServer (stop(198)) - Catalog Server (127.0.0.1:11900) shutdown
2015-04-06 03:13:24,380 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:11900) shutdown
2015-04-06 03:13:24,381 INFO: org.apache.tajo.util.history.HistoryWriter (run(268)) - HistoryWriter_127.0.0.1_11902 stopped.
2015-04-06 03:13:24,382 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-04-06 03:13:24,382 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:11902) shutdown
2015-04-06 03:13:24,382 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:11901) shutdown
2015-04-06 03:13:24,383 ERROR: org.apache.tajo.master.rm.TajoWorkerResourceManager (run(346)) - java.lang.InterruptedException
2015-04-06 03:13:24,383 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:11899) shutdown
2015-04-06 03:13:24,383 INFO: org.apache.tajo.master.TajoMaster (stop(409)) - Tajo Master main thread exiting
Results :
Failed tests:
TestKillQuery.testIgnoreStageStateFromKilled:174 expected:<QUERY_KILLED> but was:<QUERY_ERROR>
Tests run: 1440, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Tajo Main ......................................... SUCCESS [ 1.572 s]
[INFO] Tajo Project POM .................................. SUCCESS [ 1.113 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [ 2.665 s]
[INFO] Tajo Common ....................................... SUCCESS [ 25.861 s]
[INFO] Tajo Algebra ...................................... SUCCESS [ 1.308 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [ 6.774 s]
[INFO] Tajo Plan ......................................... SUCCESS [ 5.945 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [ 0.449 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 20.411 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [ 1.040 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 10.021 s]
[INFO] Tajo Storage Common ............................... SUCCESS [ 11.020 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [ 44.128 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [ 3.085 s]
[INFO] Tajo PullServer ................................... SUCCESS [ 0.897 s]
[INFO] Tajo Client ....................................... SUCCESS [ 3.072 s]
[INFO] Tajo CLI tools .................................... SUCCESS [ 0.678 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 2.889 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [ 0.578 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [ 3.285 s]
[INFO] Tajo Core ......................................... FAILURE [20:43 min]
[INFO] Tajo RPC .......................................... SKIPPED
[INFO] Tajo Catalog Drivers .............................. SKIPPED
[INFO] Tajo Catalog ...................................... SKIPPED
[INFO] Tajo Storage ...................................... SKIPPED
[INFO] Tajo Distribution ................................. SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 23:11 min
[INFO] Finished at: 2015-04-06T03:13:24+00:00
[INFO] Final Memory: 103M/1076M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.17:test (default-test) on project tajo-core: There are test failures.
[ERROR]
[ERROR] Please refer to <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/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
Build step 'Execute shell' marked build as failure
Updating TAJO-1338
Jenkins build is back to normal : Tajo-master-build #654
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Tajo-master-build/654/changes>