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 2014/10/02 09:44:46 UTC
Build failed in Jenkins: Tajo-master-build #384
See <https://builds.apache.org/job/Tajo-master-build/384/changes>
Changes:
[hyunsik] TAJO-1081: Non-forwarded (simple) query shows wrong rows.
------------------------------------------
[...truncated 313182 lines...]
-----------------------------
Optimization Log:
[LogicalPlan]
> ProjectionNode is eliminated.
-----------------------------
SCAN(0) on default.lineitem
=> filter: default.lineitem.l_quantity (FLOAT8) > 20.0 AND default.lineitem.l_returnflag (TEXT) = R
=> target list: default.lineitem.l_orderkey (INT4), default.lineitem.l_quantity (FLOAT8), default.lineitem.l_returnflag (TEXT)
=> out schema: {(3) default.lineitem.l_orderkey (INT4),default.lineitem.l_quantity (FLOAT8),default.lineitem.l_returnflag (TEXT)}
=> in schema: {(16) default.lineitem.l_orderkey (INT4),default.lineitem.l_partkey (INT4),default.lineitem.l_suppkey (INT4),default.lineitem.l_linenumber (INT4),default.lineitem.l_quantity (FLOAT8),default.lineitem.l_extendedprice (FLOAT8),default.lineitem.l_discount (FLOAT8),default.lineitem.l_tax (FLOAT8),default.lineitem.l_returnflag (TEXT),default.lineitem.l_linestatus (TEXT),default.lineitem.l_shipdate (TEXT),default.lineitem.l_commitdate (TEXT),default.lineitem.l_receiptdate (TEXT),default.lineitem.l_shipinstruct (TEXT),default.lineitem.l_shipmode (TEXT),default.lineitem.l_comment (TEXT)}
2014-10-02 07:43:52,513 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(507)) - =============================================
2014-10-02 07:43:52,513 INFO: org.apache.tajo.master.GlobalEngine (executeQueryInternal(314)) - Query is forwarded to :0
2014-10-02 07:43:52,514 INFO: org.apache.tajo.master.TajoAsyncDispatcher (start(101)) - AsyncDispatcher started:QueryInProgress:q_1412235058396_0739
2014-10-02 07:43:52,514 INFO: org.apache.tajo.master.querymaster.QueryInProgress (startQueryMaster(165)) - Initializing QueryInProgress for QueryID=q_1412235058396_0739
2014-10-02 07:43:52,514 INFO: org.apache.tajo.master.querymaster.QueryInProgress (connectQueryMaster(209)) - Connect to QueryMaster:asf905.gq1.ygridcore.net/67.195.81.149:40237
2014-10-02 07:43:52,515 INFO: org.apache.tajo.master.querymaster.QueryInProgress (submmitQueryToMaster(229)) - Call executeQuery to :asf905.gq1.ygridcore.net:40237,q_1412235058396_0739
2014-10-02 07:43:52,517 INFO: org.apache.tajo.master.querymaster.QueryMasterManagerService (executeQuery(250)) - Receive executeQuery request:q_1412235058396_0739
2014-10-02 07:43:52,517 INFO: org.apache.tajo.master.querymaster.QueryMaster (handle(473)) - Start QueryStartEventHandler:q_1412235058396_0739
2014-10-02 07:43:52,522 INFO: org.apache.tajo.master.querymaster.QueryMasterTask (initStagingDir(405)) - The staging dir 'hdfs://localhost:55253/tmp/tajo-jenkins/staging/q_1412235058396_0739' is created.
2014-10-02 07:43:52,751 INFO: org.apache.tajo.engine.planner.global.GlobalPlanner (build(117)) -
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
[LogicalPlan]
> ProjectionNode is eliminated.
-----------------------------
SCAN(0) on default.lineitem
=> filter: default.lineitem.l_quantity (FLOAT8) > 20.0 AND default.lineitem.l_returnflag (TEXT) = R
=> target list: default.lineitem.l_orderkey (INT4), default.lineitem.l_quantity (FLOAT8), default.lineitem.l_returnflag (TEXT)
=> out schema: {(3) default.lineitem.l_orderkey (INT4),default.lineitem.l_quantity (FLOAT8),default.lineitem.l_returnflag (TEXT)}
=> in schema: {(16) default.lineitem.l_orderkey (INT4),default.lineitem.l_partkey (INT4),default.lineitem.l_suppkey (INT4),default.lineitem.l_linenumber (INT4),default.lineitem.l_quantity (FLOAT8),default.lineitem.l_extendedprice (FLOAT8),default.lineitem.l_discount (FLOAT8),default.lineitem.l_tax (FLOAT8),default.lineitem.l_returnflag (TEXT),default.lineitem.l_linestatus (TEXT),default.lineitem.l_shipdate (TEXT),default.lineitem.l_commitdate (TEXT),default.lineitem.l_receiptdate (TEXT),default.lineitem.l_shipinstruct (TEXT),default.lineitem.l_shipmode (TEXT),default.lineitem.l_comment (TEXT)}
2014-10-02 07:43:52,752 INFO: org.apache.tajo.engine.planner.global.GlobalPlanner (build(159)) -
-------------------------------------------------------------------------------
Execution Block Graph (TERMINAL - eb_1412235058396_0739_000002)
-------------------------------------------------------------------------------
|-eb_1412235058396_0739_000002
|-eb_1412235058396_0739_000001
-------------------------------------------------------------------------------
Order of Execution
-------------------------------------------------------------------------------
1: eb_1412235058396_0739_000001
2: eb_1412235058396_0739_000002
-------------------------------------------------------------------------------
=======================================================
Block Id: eb_1412235058396_0739_000001 [ROOT]
=======================================================
SCAN(0) on default.lineitem
=> filter: default.lineitem.l_quantity (FLOAT8) > 20.0 AND default.lineitem.l_returnflag (TEXT) = R
=> target list: default.lineitem.l_orderkey (INT4), default.lineitem.l_quantity (FLOAT8), default.lineitem.l_returnflag (TEXT)
=> out schema: {(3) default.lineitem.l_orderkey (INT4),default.lineitem.l_quantity (FLOAT8),default.lineitem.l_returnflag (TEXT)}
=> in schema: {(16) default.lineitem.l_orderkey (INT4),default.lineitem.l_partkey (INT4),default.lineitem.l_suppkey (INT4),default.lineitem.l_linenumber (INT4),default.lineitem.l_quantity (FLOAT8),default.lineitem.l_extendedprice (FLOAT8),default.lineitem.l_discount (FLOAT8),default.lineitem.l_tax (FLOAT8),default.lineitem.l_returnflag (TEXT),default.lineitem.l_linestatus (TEXT),default.lineitem.l_shipdate (TEXT),default.lineitem.l_commitdate (TEXT),default.lineitem.l_receiptdate (TEXT),default.lineitem.l_shipinstruct (TEXT),default.lineitem.l_shipmode (TEXT),default.lineitem.l_comment (TEXT)}
=======================================================
Block Id: eb_1412235058396_0739_000002 [TERMINAL]
=======================================================
2014-10-02 07:43:52,752 INFO: org.apache.tajo.master.querymaster.Query (<init>(227)) -
=======================================================
The order of execution:
1: eb_1412235058396_0739_000001
2: eb_1412235058396_0739_000002
=======================================================
2014-10-02 07:43:52,752 INFO: org.apache.tajo.master.TajoAsyncDispatcher (start(101)) - AsyncDispatcher started:q_1412235058396_0739
2014-10-02 07:43:52,752 INFO: org.apache.tajo.master.querymaster.Query (handle(843)) - Processing q_1412235058396_0739 of type START
2014-10-02 07:43:52,753 INFO: org.apache.tajo.master.querymaster.Query (handle(861)) - q_1412235058396_0739 Query Transitioned from QUERY_NEW to QUERY_RUNNING
2014-10-02 07:43:52,753 INFO: org.apache.tajo.master.querymaster.SubQuery (initTaskScheduler(708)) - org.apache.tajo.master.DefaultTaskScheduler is chosen for the task scheduling for eb_1412235058396_0739_000001
2014-10-02 07:43:52,756 INFO: org.apache.tajo.storage.AbstractStorageManager (listStatus(385)) - Total input paths to process : 1
2014-10-02 07:43:52,757 INFO: org.apache.tajo.storage.AbstractStorageManager (getSplits(614)) - Total # of splits: 1
2014-10-02 07:43:52,758 INFO: org.apache.tajo.master.querymaster.SubQuery (run(668)) - 1 objects are scheduled
2014-10-02 07:43:52,758 INFO: org.apache.tajo.master.DefaultTaskScheduler (start(89)) - Start TaskScheduler
2014-10-02 07:43:52,758 INFO: org.apache.tajo.worker.TajoResourceAllocator (calculateNumRequestContainers(100)) - CalculateNumberRequestContainer - Number of Tasks=1, Number of Cluster Slots=1
2014-10-02 07:43:52,758 INFO: org.apache.tajo.master.querymaster.SubQuery (allocateContainers(916)) - Request Container for eb_1412235058396_0739_000001 containers=1
2014-10-02 07:43:52,759 INFO: org.apache.tajo.worker.TajoResourceAllocator (run(252)) - Start TajoWorkerAllocationThread
2014-10-02 07:43:52,760 INFO: org.apache.tajo.worker.TajoResourceAllocator (run(389)) - Stop TajoWorkerAllocationThread
2014-10-02 07:43:52,760 INFO: org.apache.tajo.master.querymaster.SubQuery (transition(1024)) - SubQuery (eb_1412235058396_0739_000001) has 1 containers!
2014-10-02 07:43:52,762 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(165)) - ======================== Processing eb_1412235058396_0739_000001 of type START
2014-10-02 07:43:52,763 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(122)) - Tajo Root Dir: hdfs://localhost:55253/tajo
2014-10-02 07:43:52,763 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(123)) - Worker Local Dir: file://<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/742ab17a-a914-4700-8d6f-452f5f193acd/tajo-localdir>
2014-10-02 07:43:52,763 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(126)) - QueryMaster Address:asf905.gq1.ygridcore.net/67.195.81.149:40237
2014-10-02 07:43:52,764 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(181)) - Start TaskRunner:eb_1412235058396_0739_000001,container_1412235058396_0739_01_002796
2014-10-02 07:43:52,765 INFO: org.apache.tajo.worker.TaskRunner (init(121)) - TaskRunner basedir is created (<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/742ab17a-a914-4700-8d6f-452f5f193acd/tajo-localdir/q_1412235058396_0739/output/1)>
2014-10-02 07:43:52,765 INFO: org.apache.tajo.worker.TaskRunner (run(180)) - TaskRunner startup
2014-10-02 07:43:52,766 INFO: org.apache.tajo.worker.TaskRunner (run(211)) - Request GetTask: eb_1412235058396_0739_000001,container_1412235058396_0739_01_002796
2014-10-02 07:43:52,767 INFO: org.apache.tajo.master.DefaultTaskScheduler (allocateRackTask(734)) - Assigned Local/Rack/Total: (0/1/1), Locality: 0.00%, Rack host: asf905.gq1.ygridcore.net
2014-10-02 07:43:52,768 INFO: org.apache.tajo.worker.TaskRunner (run(255)) - Accumulated Received Task: 1
2014-10-02 07:43:52,768 INFO: org.apache.tajo.worker.TaskRunner (run(264)) - Initializing: ta_1412235058396_0739_000001_000000_00
2014-10-02 07:43:52,770 INFO: org.apache.tajo.worker.Task (<init>(197)) - Output File Path: hdfs://localhost:55253/tmp/tajo-jenkins/staging/q_1412235058396_0739/RESULT/part-01-000000-000
2014-10-02 07:43:52,770 INFO: org.apache.tajo.worker.TaskAttemptContext (setState(145)) - Query status of ta_1412235058396_0739_000001_000000_00 is changed to TA_PENDING
2014-10-02 07:43:52,770 INFO: org.apache.tajo.worker.Task (<init>(204)) - ==================================
2014-10-02 07:43:52,770 INFO: org.apache.tajo.worker.Task (<init>(205)) - * Subquery ta_1412235058396_0739_000001_000000_00 is initialized
2014-10-02 07:43:52,770 INFO: org.apache.tajo.worker.Task (<init>(206)) - * InterQuery: false, Fragments (num: 1), Fetches (total:0) :
2014-10-02 07:43:52,770 INFO: org.apache.tajo.worker.Task (<init>(216)) - * Local task dir: <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/742ab17a-a914-4700-8d6f-452f5f193acd/tajo-localdir/q_1412235058396_0739/output/1/0_0>
2014-10-02 07:43:52,770 INFO: org.apache.tajo.worker.Task (<init>(221)) - ==================================
2014-10-02 07:43:52,771 INFO: org.apache.tajo.worker.TaskAttemptContext (setState(145)) - Query status of ta_1412235058396_0739_000001_000000_00 is changed to TA_RUNNING
2014-10-02 07:43:52,804 INFO: BlockStateChange (logAddStoredBlock(2383)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37533 is added to blk_1073743081_2257{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-2cbe89bf-7675-4a93-9bda-41be34e88fc8:NORMAL|RBW]]} size 0
2014-10-02 07:43:52,805 INFO: org.apache.tajo.worker.TaskAttemptContext (setState(145)) - Query status of ta_1412235058396_0739_000001_000000_00 is changed to TA_SUCCEEDED
2014-10-02 07:43:52,806 INFO: org.apache.tajo.worker.Task (run(499)) - ta_1412235058396_0739_000001_000000_00 completed. Worker's task counter - total:1, succeeded: 1, killed: 0, failed: 0
2014-10-02 07:43:52,806 INFO: org.apache.tajo.worker.TaskRunner (run(211)) - Request GetTask: eb_1412235058396_0739_000001,container_1412235058396_0739_01_002796
2014-10-02 07:43:52,806 INFO: org.apache.tajo.master.querymaster.SubQuery (transition(1088)) - [eb_1412235058396_0739_000001] Task Completion Event (Total: 1, Success: 1, Killed: 0, Failed: 0)
2014-10-02 07:43:52,806 INFO: org.apache.tajo.master.querymaster.SubQuery (transition(1190)) - subQuery completed - eb_1412235058396_0739_000001 (total=1, success=1, killed=0)
2014-10-02 07:43:52,806 INFO: org.apache.tajo.master.DefaultTaskScheduler (run(107)) - TaskScheduler schedulingThread stopped
2014-10-02 07:43:52,806 INFO: org.apache.tajo.master.DefaultTaskScheduler (stop(148)) - Task Scheduler stopped
2014-10-02 07:43:52,807 INFO: org.apache.tajo.worker.TaskRunner (run(249)) - Received ShouldDie flag:eb_1412235058396_0739_000001,container_1412235058396_0739_01_002796
2014-10-02 07:43:52,807 INFO: org.apache.tajo.master.querymaster.QueryMaster (cleanupExecutionBlock(186)) - cleanup executionBlocks:
2014-10-02 07:43:52,807 INFO: org.apache.tajo.worker.TaskRunner (stop(151)) - Stop TaskRunner: eb_1412235058396_0739_000001,container_1412235058396_0739_01_002796
2014-10-02 07:43:52,807 INFO: org.apache.tajo.worker.TaskRunnerManager (stopTaskRunner(116)) - Stop Task:eb_1412235058396_0739_000001,container_1412235058396_0739_01_002796
2014-10-02 07:43:52,808 INFO: org.apache.tajo.master.querymaster.Query (handle(843)) - Processing q_1412235058396_0739 of type SUBQUERY_COMPLETED
2014-10-02 07:43:52,808 INFO: org.apache.tajo.master.querymaster.Query (handle(843)) - Processing q_1412235058396_0739 of type QUERY_COMPLETED
2014-10-02 07:43:52,809 INFO: org.apache.tajo.master.rm.TajoWorkerResourceManager (releaseWorkerResource(514)) - Release Resource: 0.5,512
2014-10-02 07:43:52,809 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(165)) - ======================== Processing eb_1412235058396_0739_000001 of type STOP
2014-10-02 07:43:52,809 INFO: org.apache.tajo.storage.HashShuffleAppenderManager (close(132)) - Close HashShuffleAppender:eb_1412235058396_0739_000001, not a hash shuffle
2014-10-02 07:43:52,809 INFO: org.apache.tajo.master.querymaster.Query (handle(861)) - q_1412235058396_0739 Query Transitioned from QUERY_RUNNING to QUERY_SUCCEEDED
2014-10-02 07:43:52,809 INFO: org.apache.tajo.master.querymaster.QueryMasterTask (handle(323)) - Query completion notified from q_1412235058396_0739
2014-10-02 07:43:52,810 INFO: org.apache.tajo.master.querymaster.QueryMasterTask (handle(334)) - Query final state: QUERY_SUCCEEDED
2014-10-02 07:43:52,810 INFO: org.apache.tajo.master.querymaster.SubQuery (receiveExecutionBlockReport(1162)) - eb_1412235058396_0739_000001, receiveExecutionBlockReport:1
2014-10-02 07:43:52,810 INFO: org.apache.tajo.storage.HashShuffleAppenderManager (close(132)) - Close HashShuffleAppender:eb_1412235058396_0739_000001, not a hash shuffle
2014-10-02 07:43:52,810 INFO: org.apache.tajo.worker.TaskRunnerManager (handle(201)) - Stopped execution block:eb_1412235058396_0739_000001
2014-10-02 07:43:52,810 INFO: org.apache.tajo.master.querymaster.QueryMasterTask (stop(188)) - Stopping QueryMasterTask:q_1412235058396_0739
2014-10-02 07:43:52,810 INFO: org.apache.tajo.master.querymaster.QueryInProgress (heartbeat(265)) - Received QueryMaster heartbeat:q_1412235058396_0739,state=QUERY_SUCCEEDED,progress=1.0, queryMaster=asf905.gq1.ygridcore.net
2014-10-02 07:43:52,811 INFO: org.apache.tajo.master.querymaster.QueryInProgress (stop(116)) - =========================================================
2014-10-02 07:43:52,811 INFO: org.apache.tajo.master.querymaster.QueryInProgress (stop(117)) - Stop query:q_1412235058396_0739
2014-10-02 07:43:52,811 INFO: org.apache.tajo.master.rm.TajoWorkerResourceManager (releaseWorkerResource(514)) - Release Resource: 0.0,512
2014-10-02 07:43:52,811 INFO: org.apache.tajo.master.querymaster.QueryJobManager (stopQuery(204)) - Stop QueryInProgress:q_1412235058396_0739
2014-10-02 07:43:52,811 INFO: org.apache.tajo.master.rm.TajoWorkerResourceManager (stopQueryMaster(536)) - Released QueryMaster (q_1412235058396_0739) resource.
2014-10-02 07:43:52,811 INFO: org.apache.tajo.master.querymaster.QueryInProgress (stop(125)) - q_1412235058396_0739 QueryMaster stopped
2014-10-02 07:43:52,811 WARN: org.apache.tajo.master.TajoAsyncDispatcher (stop(115)) - Interrupted Exception while stopping
2014-10-02 07:43:52,812 INFO: org.apache.tajo.master.TajoAsyncDispatcher (stop(122)) - AsyncDispatcher stopped:q_1412235058396_0739
2014-10-02 07:43:52,812 WARN: org.apache.tajo.master.TajoAsyncDispatcher (stop(115)) - Interrupted Exception while stopping
2014-10-02 07:43:52,812 INFO: org.apache.tajo.master.TajoAsyncDispatcher (stop(122)) - AsyncDispatcher stopped:QueryInProgress:q_1412235058396_0739
2014-10-02 07:43:52,812 INFO: org.apache.tajo.master.querymaster.QueryMasterTask (stop(243)) - Stopped QueryMasterTask:q_1412235058396_0739
2014-10-02 07:43:52,812 INFO: org.apache.tajo.master.querymaster.QueryMaster (cleanup(210)) - cleanup query resources : q_1412235058396_0739
2014-10-02 07:43:53,025 INFO: org.apache.tajo.worker.TajoWorkerClientService (closeQuery(229)) - Stop Query:q_1412235058396_0739
2014-10-02 07:43:53,028 INFO: org.apache.tajo.master.GlobalEngine (dropDatabase(824)) - database TestTajoJdbc is dropped.
2014-10-02 07:43:53,030 INFO: org.apache.tajo.master.session.SessionManager (removeSession(79)) - Session 5bd747ed-fdef-4e6a-9b57-c3e2064de564 is removed.
Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.036 sec - in org.apache.tajo.jdbc.TestTajoJdbc
2014-10-02 07:43:53,037 INFO: org.apache.tajo.worker.TajoWorker (run(578)) - ============================================
2014-10-02 07:43:53,040 INFO: org.apache.tajo.worker.TajoWorker (run(579)) - TajoWorker received SIGINT Signal
2014-10-02 07:43:53,040 INFO: org.apache.tajo.worker.TajoWorker (run(580)) - ============================================
Oct 2, 2014 7:38:22 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Oct 2, 2014 7:38:22 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Oct 2, 2014 7:38:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Oct 2, 2014 7:38:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Oct 2, 2014 7:38:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Oct 2, 2014 7:38:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Oct 2, 2014 7:38:35 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Oct 2, 2014 7:38:38 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
2014-10-02 07:43:53,067 INFO: org.apache.tajo.worker.TajoWorker (run(578)) - ============================================
2014-10-02 07:43:53,068 INFO: org.apache.tajo.worker.TajoWorker (run(579)) - TajoWorker received SIGINT Signal
2014-10-02 07:43:53,069 INFO: org.apache.tajo.worker.TajoWorker (run(580)) - ============================================
2014-10-02 07:43:53,080 INFO: org.apache.tajo.master.session.SessionManager (removeSession(79)) - Session 4d4c09b6-1ce3-43d6-bce0-7a84c495bf27 is removed.
2014-10-02 07:43:53,081 INFO: org.apache.tajo.master.session.SessionManager (removeSession(79)) - Session 4af42aac-b2c0-4b5a-a95b-bfb1c6da1126 is removed.
2014-10-02 07:43:53,081 INFO: org.apache.tajo.master.session.SessionManager (removeSession(79)) - Session 26ccc279-ff18-41af-8ef4-d8441e2d480f is removed.
2014-10-02 07:43:53,081 INFO: org.apache.tajo.master.session.SessionManager (removeSession(79)) - Session 36cf4018-b1be-42e3-8c3b-6ecb32e379b8 is removed.
2014-10-02 07:43:53,081 INFO: org.apache.tajo.master.session.SessionManager (removeSession(79)) - Session 07d9e99d-8df6-4adc-b6a9-ec1ca560e37d is removed.
2014-10-02 07:43:53,140 INFO: org.apache.tajo.worker.WorkerHeartbeatService (run(242)) - Worker Resource Heartbeat Thread stopped.
2014-10-02 07:43:53,140 INFO: org.apache.tajo.worker.WorkerHeartbeatService (run(242)) - Worker Resource Heartbeat Thread stopped.
2014-10-02 07:43:53,148 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(128)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:40237) shutdown
2014-10-02 07:43:53,150 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(128)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:40318) shutdown
2014-10-02 07:43:53,150 INFO: org.apache.tajo.master.querymaster.QueryMasterManagerService (stop(111)) - QueryMasterManagerService stopped
2014-10-02 07:43:53,150 INFO: org.apache.tajo.master.querymaster.QueryMasterManagerService (stop(111)) - QueryMasterManagerService stopped
2014-10-02 07:43:53,151 INFO: org.apache.tajo.master.querymaster.QueryMaster (run(553)) - QueryMaster heartbeat thread stopped
2014-10-02 07:43:53,152 INFO: org.apache.tajo.master.querymaster.QueryMaster (run(553)) - QueryMaster heartbeat thread stopped
2014-10-02 07:43:53,153 INFO: org.apache.tajo.master.TajoAsyncDispatcher (stop(122)) - AsyncDispatcher stopped:querymaster_1412235780688
2014-10-02 07:43:53,153 INFO: org.apache.tajo.master.querymaster.QueryMaster (stop(173)) - QueryMaster stop
2014-10-02 07:43:53,153 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(108)) - TajoWorkerClientService stopping
2014-10-02 07:43:53,154 INFO: org.apache.tajo.master.TajoAsyncDispatcher (stop(122)) - AsyncDispatcher stopped:querymaster_1412235059376
2014-10-02 07:43:53,154 INFO: org.apache.tajo.master.querymaster.QueryMaster (stop(173)) - QueryMaster stop
2014-10-02 07:43:53,154 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(108)) - TajoWorkerClientService stopping
2014-10-02 07:43:53,157 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(128)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:40236) shutdown
2014-10-02 07:43:53,157 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(112)) - TajoWorkerClientService stopped
2014-10-02 07:43:53,158 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(128)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:40317) shutdown
2014-10-02 07:43:53,158 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(112)) - TajoWorkerClientService stopped
2014-10-02 07:43:53,163 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(128)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:40235) shutdown
2014-10-02 07:43:53,163 INFO: org.apache.tajo.worker.TajoWorkerManagerService (stop(97)) - TajoWorkerManagerService stopped
2014-10-02 07:43:53,164 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(376)) - TajoWorker main thread exiting
2014-10-02 07:43:53,166 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(128)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:40316) shutdown
2014-10-02 07:43:53,166 INFO: org.apache.tajo.worker.TajoWorkerManagerService (stop(97)) - TajoWorkerManagerService stopped
2014-10-02 07:43:53,167 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(376)) - TajoWorker main thread exiting
Results :
Failed tests:
TestTajoCli.testLocalQueryWithoutFrom:177->assertOutputResult:94->assertOutputResult:98->assertOutputResult:116 expected:<...bc, 123
(1 rows, , [0 B selected)
?substr
-------------------------------
123
(1 rows, , 0 B] selected)> but was:<...bc, 123
(1 rows, , [unknown bytes selected)
?substr
-------------------------------
123
(1 rows, , unknown bytes] selected)>
Tests run: 1173, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Tajo Main ......................................... SUCCESS [ 1.543 s]
[INFO] Tajo Project POM .................................. SUCCESS [ 1.110 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [ 2.778 s]
[INFO] Tajo Common ....................................... SUCCESS [ 51.123 s]
[INFO] Tajo Algebra ...................................... SUCCESS [ 1.366 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [ 5.608 s]
[INFO] Tajo Rpc .......................................... SUCCESS [ 25.600 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [ 1.025 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 5.701 s]
[INFO] Tajo Storage ...................................... SUCCESS [ 46.602 s]
[INFO] Tajo Core PullServer .............................. SUCCESS [ 0.849 s]
[INFO] Tajo Client ....................................... SUCCESS [ 3.127 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 0.592 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [ 0.991 s]
[INFO] Tajo Core ......................................... FAILURE [13:15 min]
[INFO] Tajo Catalog Drivers .............................. SKIPPED
[INFO] Tajo Catalog ...................................... SKIPPED
[INFO] Tajo Distribution ................................. SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 15:44 min
[INFO] Finished at: 2014-10-02T07:43:53+00:00
[INFO] Final Memory: 50M/381M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.16: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-1081
Jenkins build is back to normal : Tajo-master-build #385
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Tajo-master-build/385/changes>