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

Build failed in Jenkins: Tajo-master-build #1050

See <https://builds.apache.org/job/Tajo-master-build/1050/>

------------------------------------------
[...truncated 741097 lines...]
	at org.apache.tajo.engine.planner.physical.StoreTableExec.next(StoreTableExec.java:122)
	at org.apache.tajo.worker.TaskImpl.run(TaskImpl.java:420)
	at org.apache.tajo.worker.TaskContainer.run(TaskContainer.java:65)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:745)
2016-01-14 19:21:05,991 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37148 is added to blk_1073749081_8257{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-22cb703a-21a9-477b-a504-d444da3c9637:NORMAL:127.0.0.1:37148|RBW]]} size 0
2016-01-14 19:21:05,993 INFO: org.apache.tajo.worker.TaskImpl (run(477)) - ta_1452797624853_2256_000001_000000_00 is complete. 8 ms elapsed, final state:TA_FAILED
2016-01-14 19:21:05,994 ERROR: org.apache.tajo.querymaster.TaskAttempt (transition(437)) - ta_1452797624853_2256_000001_000000_00 FROM asf900.gq1.ygridcore.net >> internal error: testQueryFailure
2016-01-14 19:21:05,994 INFO: org.apache.tajo.querymaster.Task (transition(655)) - ====================================================================================
2016-01-14 19:21:05,994 INFO: org.apache.tajo.querymaster.Task (transition(656)) - >>> Task Failed: ta_1452797624853_2256_000001_000000_00, retry:true, attempts:1 <<<
2016-01-14 19:21:05,994 INFO: org.apache.tajo.querymaster.Task (transition(658)) - ====================================================================================
2016-01-14 19:21:05,995 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (increaseConcurrency(526)) - Assigned host : 127.0.0.1, Unknown Volume : -1, Concurrency : 1
2016-01-14 19:21:05,996 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (assignToLeafTasks(922)) - Assigned Local/Rack/Total: (0/2/2), Attempted Cancel/Assign/Total: (0/2/2), Locality: 0.00%, Rack host: asf900.gq1.ygridcore.net
2016-01-14 19:21:05,996 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(274)) - Output File Path: hdfs://localhost:47620/tmp/tajo-jenkins/staging/q_1452797624853_2256/RESULT/part-01-000000-000
2016-01-14 19:21:05,996 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - Output File Path: hdfs://localhost:47620/tmp/tajo-jenkins/staging/q_1452797624853_2256/RESULT/part-01-000000-000
2016-01-14 19:21:05,996 INFO: org.apache.tajo.worker.TaskImpl (initPlan(159)) - * Task ta_1452797624853_2256_000001_000000_01 is initialized. InterQuery: false, Shuffle: null, Fragments: 1, Fetches:0, Local dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/90067ff4-c869-4948-923b-1f672fdaba2c/tajo-localdir/q_1452797624853_2256/output/1/0_1>
2016-01-14 19:21:05,998 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073749081_8257 127.0.0.1:37148 
2016-01-14 19:21:05,999 ERROR: org.apache.tajo.worker.TaskImpl (run(425)) - internal error: testQueryFailure
org.apache.tajo.exception.TajoInternalError: internal error: testQueryFailure
	at org.apache.tajo.engine.function.FailFunction.eval(FailFunction.java:65)
	at org.apache.tajo.plan.function.ClassBasedScalarFunctionInvoke.eval(ClassBasedScalarFunctionInvoke.java:55)
	at org.apache.tajo.plan.expr.GeneralFunctionEval.eval(GeneralFunctionEval.java:60)
	at org.apache.tajo.engine.planner.Projector.eval(Projector.java:76)
	at org.apache.tajo.engine.planner.physical.SeqScanExec.next(SeqScanExec.java:296)
	at org.apache.tajo.engine.planner.physical.StoreTableExec.next(StoreTableExec.java:122)
	at org.apache.tajo.worker.TaskImpl.run(TaskImpl.java:420)
	at org.apache.tajo.worker.TaskContainer.run(TaskContainer.java:65)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:745)
2016-01-14 19:21:06,001 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37148 is added to blk_1073749082_8258{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-22cb703a-21a9-477b-a504-d444da3c9637:NORMAL:127.0.0.1:37148|RBW]]} size 0
2016-01-14 19:21:06,002 INFO: org.apache.tajo.worker.TaskImpl (run(477)) - ta_1452797624853_2256_000001_000000_01 is complete. 6 ms elapsed, final state:TA_FAILED
2016-01-14 19:21:06,002 ERROR: org.apache.tajo.querymaster.TaskAttempt (transition(437)) - ta_1452797624853_2256_000001_000000_01 FROM asf900.gq1.ygridcore.net >> internal error: testQueryFailure
2016-01-14 19:21:06,002 INFO: org.apache.tajo.querymaster.Task (transition(655)) - ====================================================================================
2016-01-14 19:21:06,002 INFO: org.apache.tajo.querymaster.Task (transition(656)) - >>> Task Failed: ta_1452797624853_2256_000001_000000_01, retry:true, attempts:2 <<<
2016-01-14 19:21:06,002 INFO: org.apache.tajo.querymaster.Task (transition(658)) - ====================================================================================
2016-01-14 19:21:06,003 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (increaseConcurrency(526)) - Assigned host : 127.0.0.1, Unknown Volume : -1, Concurrency : 1
2016-01-14 19:21:06,004 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (assignToLeafTasks(922)) - Assigned Local/Rack/Total: (0/3/3), Attempted Cancel/Assign/Total: (0/3/3), Locality: 0.00%, Rack host: asf900.gq1.ygridcore.net
2016-01-14 19:21:06,004 INFO: org.apache.tajo.storage.FileTablespace (getAppenderFilePath(274)) - Output File Path: hdfs://localhost:47620/tmp/tajo-jenkins/staging/q_1452797624853_2256/RESULT/part-01-000000-000
2016-01-14 19:21:06,004 INFO: org.apache.tajo.worker.TaskImpl (initPlan(152)) - Output File Path: hdfs://localhost:47620/tmp/tajo-jenkins/staging/q_1452797624853_2256/RESULT/part-01-000000-000
2016-01-14 19:21:06,004 INFO: org.apache.tajo.worker.TaskImpl (initPlan(159)) - * Task ta_1452797624853_2256_000001_000000_02 is initialized. InterQuery: false, Shuffle: null, Fragments: 1, Fetches:0, Local dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/90067ff4-c869-4948-923b-1f672fdaba2c/tajo-localdir/q_1452797624853_2256/output/1/0_2>
2016-01-14 19:21:06,006 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073749082_8258 127.0.0.1:37148 
2016-01-14 19:21:06,007 ERROR: org.apache.tajo.worker.TaskImpl (run(425)) - internal error: testQueryFailure
org.apache.tajo.exception.TajoInternalError: internal error: testQueryFailure
	at org.apache.tajo.engine.function.FailFunction.eval(FailFunction.java:65)
	at org.apache.tajo.plan.function.ClassBasedScalarFunctionInvoke.eval(ClassBasedScalarFunctionInvoke.java:55)
	at org.apache.tajo.plan.expr.GeneralFunctionEval.eval(GeneralFunctionEval.java:60)
	at org.apache.tajo.engine.planner.Projector.eval(Projector.java:76)
	at org.apache.tajo.engine.planner.physical.SeqScanExec.next(SeqScanExec.java:296)
	at org.apache.tajo.engine.planner.physical.StoreTableExec.next(StoreTableExec.java:122)
	at org.apache.tajo.worker.TaskImpl.run(TaskImpl.java:420)
	at org.apache.tajo.worker.TaskContainer.run(TaskContainer.java:65)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:745)
2016-01-14 19:21:06,009 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37148 is added to blk_1073749083_8259{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-22cb703a-21a9-477b-a504-d444da3c9637:NORMAL:127.0.0.1:37148|RBW]]} size 0
2016-01-14 19:21:06,010 INFO: org.apache.tajo.worker.TaskImpl (run(477)) - ta_1452797624853_2256_000001_000000_02 is complete. 6 ms elapsed, final state:TA_FAILED
2016-01-14 19:21:06,010 ERROR: org.apache.tajo.querymaster.TaskAttempt (transition(437)) - ta_1452797624853_2256_000001_000000_02 FROM asf900.gq1.ygridcore.net >> internal error: testQueryFailure
2016-01-14 19:21:06,010 INFO: org.apache.tajo.querymaster.Task (transition(655)) - ====================================================================================
2016-01-14 19:21:06,010 INFO: org.apache.tajo.querymaster.Task (transition(656)) - >>> Task Failed: ta_1452797624853_2256_000001_000000_02, retry:false, attempts:3 <<<
2016-01-14 19:21:06,010 INFO: org.apache.tajo.querymaster.Task (transition(658)) - ====================================================================================
2016-01-14 19:21:06,011 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (stop(164)) - Task Scheduler stopped
2016-01-14 19:21:06,011 INFO: org.apache.tajo.querymaster.Stage (transition(1404)) - Stage completed - eb_1452797624853_2256_000001 (total=1, success=0, killed=0)
2016-01-14 19:21:06,011 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (stop(164)) - Task Scheduler stopped
2016-01-14 19:21:06,012 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (run(127)) - TaskScheduler schedulingThread stopped
2016-01-14 19:21:06,012 INFO: org.apache.tajo.worker.ExecutionBlockContext (stop(175)) - Worker's task counter - total:3, succeeded: 0, killed: 0, failed: 3
2016-01-14 19:21:06,012 INFO: org.apache.tajo.querymaster.Query (handle(867)) - Processing q_1452797624853_2256 of type STAGE_COMPLETED
2016-01-14 19:21:06,012 INFO: org.apache.tajo.querymaster.Query (transition(814)) - Complete Stage[eb_1452797624853_2256_000001], State: FAILED, 1/1. 
2016-01-14 19:21:06,012 INFO: org.apache.tajo.worker.TaskManager (stopExecutionBlock(160)) - Stopped execution block:eb_1452797624853_2256_000001
2016-01-14 19:21:06,012 INFO: org.apache.tajo.querymaster.Query (handle(867)) - Processing q_1452797624853_2256 of type QUERY_COMPLETED
2016-01-14 19:21:06,012 INFO: org.apache.tajo.querymaster.Query (handle(885)) - q_1452797624853_2256 Query Transitioned from QUERY_RUNNING to QUERY_FAILED
2016-01-14 19:21:06,012 INFO: org.apache.tajo.querymaster.QueryMasterTask (handle(296)) - Query completion notified from q_1452797624853_2256 final state: QUERY_FAILED
2016-01-14 19:21:06,013 INFO: org.apache.tajo.master.QueryInProgress (heartbeat(257)) - Received QueryMaster heartbeat:q_1452797624853_2256,state=QUERY_FAILED,progress=0.0, queryMaster=asf900.gq1.ygridcore.net
2016-01-14 19:21:06,013 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(172)) - Stopping QueryMasterTask:q_1452797624853_2256
2016-01-14 19:21:06,013 WARN: org.apache.tajo.master.QueryInProgress (heartbeat(272)) - q_1452797624853_2256 is stopped because 
2016-01-14 19:21:06,013 INFO: org.apache.tajo.master.QueryManager (stopQuery(279)) - Stop QueryInProgress:q_1452797624853_2256
2016-01-14 19:21:06,013 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(122)) - =========================================================
2016-01-14 19:21:06,013 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(123)) - Stop query:q_1452797624853_2256
2016-01-14 19:21:06,013 INFO: org.apache.tajo.querymaster.QueryMasterTask (cleanupQuery(473)) - Cleanup resources of all workers. Query: q_1452797624853_2256, workers: 1
2016-01-14 19:21:06,014 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(188)) - Stopped QueryMasterTask:q_1452797624853_2256
2016-01-14 19:21:06,074 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: CREATE DATABASE IF NOT EXISTS "TestTajoCliNegatives"
2016-01-14 19:21:06,075 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(281)) - Non Optimized Query: 

-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------

CREATE_DATABASE(0) IF NOT EXISTS TestTajoCliNegatives

2016-01-14 19:21:06,075 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - =============================================
2016-01-14 19:21:06,075 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - Optimized Query: 

-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------

CREATE_DATABASE(0) IF NOT EXISTS TestTajoCliNegatives

2016-01-14 19:21:06,075 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - =============================================
2016-01-14 19:21:06,075 INFO: org.apache.tajo.master.exec.DDLExecutor (createDatabase(245)) - database "TestTajoCliNegatives" is already exists.
Used heap: 315.8 MiB/889.0 MiB, direct:33.6 MiB/33.6 MiB, mapped:0 B/0 B, Active Threads: 347, Run: TestTajoCliNegatives.testDescTable
2016-01-14 19:21:06,077 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session b7a83f3b-c53b-4da2-a936-5b9653c886fe is removed.
2016-01-14 19:21:06,084 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 04d73a10-96fb-4024-b04d-815a3f103def is removed.
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.573 sec - in org.apache.tajo.cli.tsql.TestTajoCliNegatives
Running org.apache.tajo.cli.tsql.TestDefaultCliOutputFormatter
2016-01-14 19:21:06,095 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session c845d66e-3eb4-446f-9487-f40d9599d532 is created.
2016-01-14 19:21:06,096 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session c845d66e-3eb4-446f-9487-f40d9599d532 is removed.
2016-01-14 19:21:06,099 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session 743e53c2-4b9d-435f-8f37-8424fe0b8e3a is created.
2016-01-14 19:21:06,100 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 743e53c2-4b9d-435f-8f37-8424fe0b8e3a is removed.
2016-01-14 19:21:06,102 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session 5183c9d2-04ec-463c-8225-8c83ffe8a5a3 is created.
2016-01-14 19:21:06,104 INFO: BlockStateChange (invalidateWorkForOneNode(3488)) - BLOCK* BlockManager: ask 127.0.0.1:37148 to delete [blk_1073749074_8250, blk_1073749075_8251, blk_1073749076_8252, blk_1073749078_8254, blk_1073749081_8257, blk_1073749082_8258]
2016-01-14 19:21:06,114 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 5183c9d2-04ec-463c-8225-8c83ffe8a5a3 is removed.
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 sec - in org.apache.tajo.cli.tsql.TestDefaultCliOutputFormatter
Running org.apache.tajo.cli.tsql.TestSimpleParser
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec - in org.apache.tajo.cli.tsql.TestSimpleParser
Running org.apache.tajo.cli.tsql.commands.TestHdfsCommand
2016-01-14 19:21:06,125 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session 8de1e679-e664-4629-bab7-e29bb450b40e is created.
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.045 sec - in org.apache.tajo.cli.tsql.commands.TestHdfsCommand
Running org.apache.tajo.cli.tsql.commands.TestExecExternalShellCommand
2016-01-14 19:21:06,168 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session aa777c28-687c-4580-a395-66a190026e08 is created.
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.018 sec - in org.apache.tajo.cli.tsql.commands.TestExecExternalShellCommand
2016-01-14 19:21:06,191 INFO: org.mortbay.log (info(67)) - Shutdown hook executing
2016-01-14 19:21:06,192 INFO: org.mortbay.log (info(67)) - Shutdown hook complete
2016-01-14 19:21:06,200 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session aa777c28-687c-4580-a395-66a190026e08 is removed.
Jan 14, 2016 6:57:21 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 14, 2016 6:57:21 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 14, 2016 6:57:36 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 14, 2016 6:57:36 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 14, 2016 6:57:36 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 14, 2016 6:57:36 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 14, 2016 6:57:36 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 14, 2016 6:57:39 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
2016-01-14 19:21:06,205 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 8de1e679-e664-4629-bab7-e29bb450b40e is removed.
2016-01-14 19:21:06,209 INFO: org.apache.tajo.worker.TajoWorker (run(518)) - ============================================
2016-01-14 19:21:06,209 INFO: org.apache.tajo.worker.TajoWorker (run(519)) - TajoWorker received SIGINT Signal
2016-01-14 19:21:06,209 INFO: org.apache.tajo.worker.TajoWorker (run(520)) - ============================================
2016-01-14 19:21:06,217 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_asf900.gq1.ygridcore.net_30494 stopped.
2016-01-14 19:21:06,218 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-01-14 19:21:06,256 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(113)) - NodeStatusUpdater stopped.
2016-01-14 19:21:06,256 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(261)) - Heartbeat Thread stopped.
2016-01-14 19:21:06,256 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:30496) shutdown
2016-01-14 19:21:06,258 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped
2016-01-14 19:21:06,258 INFO: org.apache.tajo.querymaster.QueryMaster (run(428)) - QueryMaster heartbeat thread stopped
2016-01-14 19:21:06,259 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(164)) - QueryMaster stopped
2016-01-14 19:21:06,259 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(98)) - TajoWorkerClientService stopping
2016-01-14 19:21:06,259 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:30495) shutdown
2016-01-14 19:21:06,259 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(102)) - TajoWorkerClientService stopped
2016-01-14 19:21:06,259 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:30494) shutdown
2016-01-14 19:21:06,259 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped
2016-01-14 19:21:06,260 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(332)) - TajoWorker main thread exiting
2016-01-14 19:21:08,470 INFO: org.apache.tajo.master.TajoMaster (run(568)) - ============================================
2016-01-14 19:21:08,470 INFO: org.apache.tajo.master.TajoMaster (run(569)) - TajoMaster received SIGINT Signal
2016-01-14 19:21:08,470 INFO: org.apache.tajo.master.TajoMaster (run(570)) - ============================================
2016-01-14 19:21:08,471 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (Tajo-REST) listened on 0:0:0:0:0:0:0:0:30493) shutdown
2016-01-14 19:21:08,471 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2016-01-14 19:21:08,480 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37148 is added to blk_1073741834_1010{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-22cb703a-21a9-477b-a504-d444da3c9637:NORMAL:127.0.0.1:37148|RBW]]} size 704
2016-01-14 19:21:08,481 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_30492 stopped.
2016-01-14 19:21:08,483 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:30492) shutdown
2016-01-14 19:21:08,483 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-01-14 19:21:08,484 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:30491) shutdown
2016-01-14 19:21:08,485 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(182)) - Catalog Server (127.0.0.1:30490) shutdown
2016-01-14 19:21:08,485 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:30490) shutdown
2016-01-14 19:21:08,487 INFO: org.apache.tajo.catalog.store.DerbyStore (close(2978)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/90067ff4-c869-4948-923b-1f672fdaba2c/db;create=true)>
2016-01-14 19:21:08,489 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:30489) shutdown
2016-01-14 19:21:08,490 INFO: org.apache.tajo.master.TajoMaster (serviceStop(424)) - Tajo Master main thread exiting
2016-01-14 19:21:08,542 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(68)) - Derby shutdown complete normally.
2016-01-14 19:21:08,542 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(75)) - Shutdown database

Results :

Failed tests: 
  TestQueryResult.testTemporalResultOnClose:49 null

Tests run: 1732, Failures: 1, Errors: 0, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  2.448 s]
[INFO] Tajo Project POM .................................. SUCCESS [  2.290 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  4.704 s]
[INFO] Tajo Common ....................................... SUCCESS [ 37.359 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  3.364 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  6.407 s]
[INFO] Tajo Plan ......................................... SUCCESS [  9.124 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  1.578 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [02:25 min]
[INFO] Tajo Catalog Client ............................... SUCCESS [  1.605 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 13.622 s]
[INFO] Tajo Storage Common ............................... SUCCESS [  3.384 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [01:11 min]
[INFO] Tajo PullServer ................................... SUCCESS [  1.889 s]
[INFO] Tajo Client ....................................... SUCCESS [  3.031 s]
[INFO] Tajo CLI tools .................................... SUCCESS [  2.511 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [  4.830 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [  2.188 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [  4.698 s]
[INFO] Tajo Metrics ...................................... SUCCESS [  1.823 s]
[INFO] Tajo Core ......................................... SUCCESS [  9.624 s]
[INFO] Tajo RPC .......................................... SUCCESS [  1.209 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 14.828 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [  0.067 s]
[INFO] Tajo Catalog ...................................... SUCCESS [  1.137 s]
[INFO] Tajo Client Example ............................... SUCCESS [  1.052 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [  5.110 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [  3.305 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 40.783 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [  0.944 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [  1.268 s]
[INFO] Tajo S3 storage ................................... SUCCESS [  0.270 s]
[INFO] Tajo Storage ...................................... SUCCESS [  0.981 s]
[INFO] Tajo Distribution ................................. SUCCESS [  5.414 s]
[INFO] Tajo Core Tests ................................... FAILURE [27:38 min]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 34:29 min
[INFO] Finished at: 2016-01-14T19:21:09+00:00
[INFO] Final Memory: 150M/1970M
[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-master-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

Jenkins build is back to normal : Tajo-master-build #1051

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