See <https://builds.apache.org/job/Tajo-master-build/572/changes>
Changes:
[jihun] TAJO-1313: Tajo-dump creates DDLs for information_schema tables
------------------------------------------
[...truncated 377636 lines...]
2015-02-02 08:41:18,470 INFO: org.apache.tajo.master.QueryInProgress
(connectQueryMaster(139)) - Connect to
QueryMaster:asf905.gq1.ygridcore.net/67.195.81.149:12808
2015-02-02 08:41:18,470 INFO: org.apache.tajo.master.QueryInProgress
(submmitQueryToMaster(159)) - Call executeQuery to
:asf905.gq1.ygridcore.net:12808,q_1422865619187_0891
2015-02-02 08:41:18,472 INFO:
org.apache.tajo.querymaster.QueryMasterManagerService (executeQuery(249)) -
Receive executeQuery request:q_1422865619187_0891
2015-02-02 08:41:18,472 INFO: org.apache.tajo.querymaster.QueryMaster
(handle(402)) - Start QueryStartEventHandler:q_1422865619187_0891
2015-02-02 08:41:18,477 INFO: org.apache.tajo.querymaster.QueryMasterTask
(initStagingDir(388)) - The staging dir
'hdfs://localhost:43169/tmp/tajo-jenkins/staging/q_1422865619187_0891' is
created.
2015-02-02 08:41:18,673 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (build(123)) -
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
[LogicalPlan]
> ProjectionNode is eliminated.
-----------------------------
SCAN(0) on default.lineitem
=> filter: default.lineitem.l_returnflag (TEXT) = R AND
default.lineitem.l_quantity (FLOAT8) > 20.0
=> 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)}
2015-02-02 08:41:18,673 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (build(165)) -
-------------------------------------------------------------------------------
Execution Block Graph (TERMINAL - eb_1422865619187_0891_000002)
-------------------------------------------------------------------------------
|-eb_1422865619187_0891_000002
|-eb_1422865619187_0891_000001
-------------------------------------------------------------------------------
Order of Execution
-------------------------------------------------------------------------------
1: eb_1422865619187_0891_000001
2: eb_1422865619187_0891_000002
-------------------------------------------------------------------------------
=======================================================
Block Id: eb_1422865619187_0891_000001 [ROOT]
=======================================================
SCAN(0) on default.lineitem
=> filter: default.lineitem.l_returnflag (TEXT) = R AND
default.lineitem.l_quantity (FLOAT8) > 20.0
=> 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_1422865619187_0891_000002 [TERMINAL]
=======================================================
2015-02-02 08:41:18,674 INFO: org.apache.tajo.querymaster.Query (<init>(223)) -
=======================================================
The order of execution:
1: eb_1422865619187_0891_000001
2: eb_1422865619187_0891_000002
=======================================================
2015-02-02 08:41:18,674 INFO: org.apache.tajo.querymaster.Query (handle(712)) -
Processing q_1422865619187_0891 of type START
2015-02-02 08:41:18,675 INFO: org.apache.tajo.querymaster.Stage
(initTaskScheduler(846)) - org.apache.tajo.querymaster.DefaultTaskScheduler is
chosen for the task scheduling for eb_1422865619187_0891_000001
2015-02-02 08:41:18,675 INFO: org.apache.tajo.querymaster.Query (handle(730)) -
q_1422865619187_0891 Query Transitioned from QUERY_NEW to QUERY_RUNNING
2015-02-02 08:41:18,677 INFO: org.apache.tajo.storage.FileStorageManager
(listStatus(359)) - Total input paths to process : 1
2015-02-02 08:41:18,678 INFO: org.apache.tajo.storage.FileStorageManager
(getSplits(589)) - Total # of splits: 1
2015-02-02 08:41:18,678 INFO: org.apache.tajo.querymaster.Stage (run(798)) - 1
objects are scheduled
2015-02-02 08:41:18,678 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler
(start(91)) - Start TaskScheduler
2015-02-02 08:41:18,679 INFO: org.apache.tajo.worker.TajoResourceAllocator
(calculateNumRequestContainers(102)) - CalculateNumberRequestContainer - Number
of Tasks=1, Number of Cluster Slots=1
2015-02-02 08:41:18,679 INFO: org.apache.tajo.querymaster.Stage
(allocateContainers(1059)) - Request Container for eb_1422865619187_0891_000001
containers=1
2015-02-02 08:41:18,679 INFO: org.apache.tajo.worker.TajoResourceAllocator
(run(256)) - Start TajoWorkerAllocationThread
2015-02-02 08:41:18,681 INFO: org.apache.tajo.worker.TajoResourceAllocator
(run(369)) - Stop TajoWorkerAllocationThread
2015-02-02 08:41:18,681 INFO: org.apache.tajo.querymaster.Stage
(transition(1170)) - Stage (eb_1422865619187_0891_000001) has 1 containers!
2015-02-02 08:41:18,683 INFO: org.apache.tajo.worker.TaskRunnerManager
(handle(165)) - ======================== Processing
eb_1422865619187_0891_000001 of type START
2015-02-02 08:41:18,683 INFO: org.apache.tajo.worker.ExecutionBlockContext
(init(122)) - Tajo Root Dir: hdfs://localhost:43169/tajo
2015-02-02 08:41:18,683 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/fa2b8d2e-5955-46fb-9b8a-369e284ce72a/tajo-localdir>
2015-02-02 08:41:18,683 INFO: org.apache.tajo.worker.ExecutionBlockContext
(init(126)) - QueryMaster Address:asf905.gq1.ygridcore.net/67.195.81.149:12808
2015-02-02 08:41:18,685 INFO: org.apache.tajo.worker.TaskRunnerManager
(handle(181)) - Start
TaskRunner:eb_1422865619187_0891_000001,container_1422865619187_0891_01_003286
2015-02-02 08:41:18,685 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/fa2b8d2e-5955-46fb-9b8a-369e284ce72a/tajo-localdir/q_1422865619187_0891/output/1)>
2015-02-02 08:41:18,686 INFO: org.apache.tajo.worker.TaskRunner (run(180)) -
TaskRunner startup
2015-02-02 08:41:18,686 INFO: org.apache.tajo.worker.TaskRunner (run(211)) -
Request GetTask:
eb_1422865619187_0891_000001,container_1422865619187_0891_01_003286
2015-02-02 08:41:18,687 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler
(allocateRackTask(739)) - Assigned Local/Rack/Total: (0/1/1), Locality: 0.00%,
Rack host: asf905.gq1.ygridcore.net
2015-02-02 08:41:18,688 INFO: org.apache.tajo.worker.TaskRunner (run(255)) -
Accumulated Received Task: 1
2015-02-02 08:41:18,689 INFO: org.apache.tajo.worker.TaskRunner (run(264)) -
Initializing: ta_1422865619187_0891_000001_000000_00
2015-02-02 08:41:18,689 INFO: org.apache.tajo.storage.FileStorageManager
(getAppenderFilePath(283)) - Output File Path:
hdfs://localhost:43169/tmp/tajo-jenkins/staging/q_1422865619187_0891/RESULT/part-01-000000-000
2015-02-02 08:41:18,689 INFO: org.apache.tajo.worker.Task (<init>(155)) -
Output File Path:
hdfs://localhost:43169/tmp/tajo-jenkins/staging/q_1422865619187_0891/RESULT/part-01-000000-000
2015-02-02 08:41:18,690 INFO: org.apache.tajo.worker.TaskAttemptContext
(setState(145)) - Query status of ta_1422865619187_0891_000001_000000_00 is
changed to TA_PENDING
2015-02-02 08:41:18,690 INFO: org.apache.tajo.worker.Task (<init>(162)) -
==================================
2015-02-02 08:41:18,690 INFO: org.apache.tajo.worker.Task (<init>(163)) - *
Stage ta_1422865619187_0891_000001_000000_00 is initialized
2015-02-02 08:41:18,690 INFO: org.apache.tajo.worker.Task (<init>(164)) - *
InterQuery: false, Fragments (num: 1), Fetches (total:0) :
2015-02-02 08:41:18,690 INFO: org.apache.tajo.worker.Task (<init>(174)) - *
Local task dir:
<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/fa2b8d2e-5955-46fb-9b8a-369e284ce72a/tajo-localdir/q_1422865619187_0891/output/1/0_0>
2015-02-02 08:41:18,690 INFO: org.apache.tajo.worker.Task (<init>(179)) -
==================================
2015-02-02 08:41:18,691 INFO: org.apache.tajo.worker.TaskAttemptContext
(setState(145)) - Query status of ta_1422865619187_0891_000001_000000_00 is
changed to TA_RUNNING
2015-02-02 08:41:18,702 INFO: BlockStateChange (logAddStoredBlock(2383)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34019 is added to
blk_1073746815_5991{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-04393913-5ea1-47d8-a85c-85fbd83a21d1:NORMAL|RBW]]}
size 0
2015-02-02 08:41:18,703 INFO: org.apache.tajo.worker.TaskAttemptContext
(setState(145)) - Query status of ta_1422865619187_0891_000001_000000_00 is
changed to TA_SUCCEEDED
2015-02-02 08:41:18,704 INFO: org.apache.tajo.worker.Task (run(455)) -
ta_1422865619187_0891_000001_000000_00 completed. Worker's task counter -
total:1, succeeded: 1, killed: 0, failed: 0
2015-02-02 08:41:18,704 INFO: org.apache.tajo.worker.TaskRunner (run(211)) -
Request GetTask:
eb_1422865619187_0891_000001,container_1422865619187_0891_01_003286
2015-02-02 08:41:18,704 INFO: org.apache.tajo.querymaster.Stage
(transition(1337)) - Stage finalize - eb_1422865619187_0891_000001 (total=1,
success=1, killed=0)
2015-02-02 08:41:18,704 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler
(stop(152)) - Task Scheduler stopped
2015-02-02 08:41:18,705 INFO: org.apache.tajo.querymaster.QueryMaster
(cleanupExecutionBlock(181)) - cleanup executionBlocks:
2015-02-02 08:41:18,704 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler
(run(109)) - TaskScheduler schedulingThread stopped
2015-02-02 08:41:18,705 INFO: org.apache.tajo.worker.TaskRunner (run(249)) -
Received ShouldDie
flag:eb_1422865619187_0891_000001,container_1422865619187_0891_01_003286
2015-02-02 08:41:18,705 INFO: org.apache.tajo.worker.TaskRunner (stop(151)) -
Stop TaskRunner:
eb_1422865619187_0891_000001,container_1422865619187_0891_01_003286
2015-02-02 08:41:18,705 INFO: org.apache.tajo.worker.TaskRunnerManager
(stopTaskRunner(116)) - Stop
Task:eb_1422865619187_0891_000001,container_1422865619187_0891_01_003286
2015-02-02 08:41:18,706 INFO: org.apache.tajo.querymaster.Stage
(transition(1343)) - eb_1422865619187_0891_000001, waiting for shuffle reports.
expected Tasks:1
2015-02-02 08:41:18,706 INFO:
org.apache.tajo.master.rm.TajoWorkerResourceManager
(releaseWorkerResource(513)) - Release Resource: 0.5,512
2015-02-02 08:41:18,707 INFO: org.apache.tajo.worker.TaskRunnerManager
(handle(165)) - ======================== Processing
eb_1422865619187_0891_000001 of type STOP
2015-02-02 08:41:18,707 INFO:
org.apache.tajo.storage.HashShuffleAppenderManager (close(132)) - Close
HashShuffleAppender:eb_1422865619187_0891_000001, not a hash shuffle
2015-02-02 08:41:18,707 INFO:
org.apache.tajo.storage.HashShuffleAppenderManager (close(132)) - Close
HashShuffleAppender:eb_1422865619187_0891_000001, not a hash shuffle
2015-02-02 08:41:18,707 INFO: org.apache.tajo.worker.TaskRunnerManager
(handle(203)) - Stopped execution block:eb_1422865619187_0891_000001
2015-02-02 08:41:18,707 INFO: org.apache.tajo.querymaster.Stage
(transition(1323)) - eb_1422865619187_0891_000001, Finalized shuffle reports: 1
2015-02-02 08:41:18,708 INFO: org.apache.tajo.querymaster.Stage
(transition(1387)) - Stage completed - eb_1422865619187_0891_000001 (total=1,
success=1, killed=0)
2015-02-02 08:41:18,708 INFO: org.apache.tajo.querymaster.Query (handle(712)) -
Processing q_1422865619187_0891 of type STAGE_COMPLETED
2015-02-02 08:41:18,708 INFO: org.apache.tajo.querymaster.Query (handle(712)) -
Processing q_1422865619187_0891 of type QUERY_COMPLETED
2015-02-02 08:41:18,709 INFO: org.apache.tajo.querymaster.Query (handle(730)) -
q_1422865619187_0891 Query Transitioned from QUERY_RUNNING to QUERY_SUCCEEDED
2015-02-02 08:41:18,709 INFO: org.apache.tajo.querymaster.QueryMasterTask
(handle(276)) - Query completion notified from q_1422865619187_0891
2015-02-02 08:41:18,709 INFO: org.apache.tajo.querymaster.QueryMasterTask
(handle(287)) - Query final state: QUERY_SUCCEEDED
2015-02-02 08:41:18,709 INFO: org.apache.tajo.querymaster.QueryMasterTask
(stop(183)) - Stopping QueryMasterTask:q_1422865619187_0891
2015-02-02 08:41:18,710 INFO: org.apache.tajo.querymaster.QueryMasterTask
(stop(196)) - Stopped QueryMasterTask:q_1422865619187_0891
2015-02-02 08:41:18,710 INFO: org.apache.tajo.querymaster.QueryMaster
(cleanup(205)) - cleanup query resources : q_1422865619187_0891
2015-02-02 08:41:18,710 INFO: org.apache.tajo.master.QueryInProgress
(heartbeat(196)) - Received QueryMaster
heartbeat:q_1422865619187_0891,state=QUERY_SUCCEEDED,progress=1.0,
queryMaster=asf905.gq1.ygridcore.net
2015-02-02 08:41:18,710 INFO: org.apache.tajo.master.QueryManager
(stopQuery(238)) - Stop QueryInProgress:q_1422865619187_0891
2015-02-02 08:41:18,710 INFO: org.apache.tajo.master.QueryInProgress
(stopProgress(97)) - =========================================================
2015-02-02 08:41:18,710 INFO: org.apache.tajo.master.QueryInProgress
(stopProgress(98)) - Stop query:q_1422865619187_0891
2015-02-02 08:41:18,711 INFO:
org.apache.tajo.master.rm.TajoWorkerResourceManager
(releaseWorkerResource(513)) - Release Resource: 0.0,512
2015-02-02 08:41:18,711 INFO:
org.apache.tajo.master.rm.TajoWorkerResourceManager (releaseQueryMaster(535)) -
Released QueryMaster (q_1422865619187_0891) resource.
2015-02-02 08:41:18,713 INFO: org.apache.tajo.util.history.HistoryWriter
(writeQueryHistory(359)) - Saving query summary:
hdfs://localhost:43169/tmp/tajo-jenkins/staging/history/20150202/query-detail/q_1422865619187_0891/query.hist
2015-02-02 08:41:18,719 INFO: BlockStateChange (logAddStoredBlock(2383)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34019 is added to
blk_1073746816_5992{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-ae7ab581-1242-4572-96eb-041ee402d26c:NORMAL|RBW]]}
size 0
2015-02-02 08:41:18,721 INFO: org.apache.tajo.util.history.HistoryWriter
(writeQueryHistory(373)) - Saving query unit:
hdfs://localhost:43169/tmp/tajo-jenkins/staging/history/20150202/query-detail/q_1422865619187_0891/eb_1422865619187_0891_000001.hist
2015-02-02 08:41:18,725 INFO: BlockStateChange (logAddStoredBlock(2383)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34019 is added to
blk_1073746817_5993{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-04393913-5ea1-47d8-a85c-85fbd83a21d1:NORMAL|RBW]]}
size 0
2015-02-02 08:41:18,985 INFO: org.apache.tajo.session.SessionManager
(removeSession(79)) - Session eaeba236-2aad-48bd-b143-52c7808acdd8 is removed.
2015-02-02 08:41:18,989 INFO: org.apache.tajo.master.GlobalEngine
(updateQuery(196)) - SQL: DROP TABLE IF EXISTS "TestTajoJdbc".table1
2015-02-02 08:41:18,989 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(239)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-02-02 08:41:18,990 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(241)) - =============================================
2015-02-02 08:41:18,990 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(242)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-02-02 08:41:18,990 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(243)) - =============================================
2015-02-02 08:41:18,990 INFO: org.apache.tajo.master.exec.DDLExecutor
(dropTable(281)) - relation "TestTajoJdbc.table1" is already exists.
2015-02-02 08:41:18,993 INFO: org.apache.tajo.master.exec.DDLExecutor
(dropDatabase(186)) - database TestTajoJdbc is dropped.
2015-02-02 08:41:18,995 INFO: org.apache.tajo.session.SessionManager
(removeSession(79)) - Session aa553a74-39c4-47a1-934d-6a155dc6c1c0 is removed.
Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.963 sec - in
org.apache.tajo.jdbc.TestTajoJdbc
2015-02-02 08:41:19,004 INFO: org.apache.tajo.worker.TajoWorker (run(600)) -
============================================
2015-02-02 08:41:19,006 INFO: org.apache.tajo.worker.TajoWorker (run(601)) -
TajoWorker received SIGINT Signal
2015-02-02 08:41:19,006 INFO: org.apache.tajo.worker.TajoWorker (run(602)) -
============================================
2015-02-02 08:41:19,007 INFO: org.apache.tajo.util.history.HistoryWriter
(run(265)) - HistoryWriter_asf905.gq1.ygridcore.net_12808 stopped.
2015-02-02 08:41:19,014 INFO: org.apache.tajo.util.history.HistoryCleaner
(run(134)) - History cleaner stopped
2015-02-02 08:41:19,013 INFO: org.apache.tajo.master.TajoMaster (run(560)) -
============================================
2015-02-02 08:41:19,016 INFO: org.apache.tajo.master.TajoMaster (run(561)) -
TajoMaster received SIGINT Signal
2015-02-02 08:41:19,016 INFO: org.apache.tajo.master.TajoMaster (run(562)) -
============================================
2015-02-02 08:41:19,016 INFO: org.apache.tajo.session.SessionManager
(removeSession(79)) - Session 93e6f5bb-0dc4-43d9-ac1c-cf6cda690eb2 is removed.
2015-02-02 08:41:19,016 INFO: org.apache.tajo.catalog.CatalogServer (stop(198))
- Catalog Server (127.0.0.1:12803) shutdown
Feb 2, 2015 8:35:04 AM INFO: parquet.hadoop.ParquetFileReader: reading another
1 footers
Feb 2, 2015 8:35:04 AM INFO: parquet.hadoop.ParquetFileReader: reading another
1 footers
Feb 2, 2015 8:35:16 AM INFO: parquet.hadoop.ParquetFileReader: reading another
1 footers
Feb 2, 2015 8:35:17 AM INFO: parquet.hadoop.ParquetFileReader: reading another
1 footers
Feb 2, 2015 8:35:17 AM INFO: parquet.hadoop.ParquetFileReader: reading another
1 footers
Feb 2, 2015 8:35:17 AM INFO: parquet.hadoop.ParquetFileReader: reading another
1 footers
Feb 2, 2015 8:35:17 AM INFO: parquet.hadoop.ParquetFileReader: reading another
1 footers
Feb 2, 2015 8:35:19 AM INFO: parquet.hadoop.ParquetFileReader: reading another
1 footers
2015-02-02 08:41:19,017 INFO: org.apache.tajo.session.SessionManager
(removeSession(79)) - Session e01878a9-e7f7-4a2d-88b2-d195ae16b481 is removed.
2015-02-02 08:41:19,017 INFO: org.apache.tajo.worker.WorkerHeartbeatService
(run(231)) - Worker Resource Heartbeat Thread stopped.
2015-02-02 08:41:19,018 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(126)) - Rpc (CatalogProtocol) listened on 127.0.0.1:12803) shutdown
2015-02-02 08:41:19,020 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(126)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:12808)
shutdown
2015-02-02 08:41:19,021 INFO:
org.apache.tajo.querymaster.QueryMasterManagerService (stop(110)) -
QueryMasterManagerService stopped
2015-02-02 08:41:19,021 INFO: org.apache.tajo.querymaster.QueryMaster
(run(470)) - QueryMaster heartbeat thread stopped
2015-02-02 08:41:19,021 INFO: org.apache.tajo.util.history.HistoryWriter
(run(265)) - HistoryWriter_127.0.0.1_12805 stopped.
2015-02-02 08:41:19,023 INFO: org.apache.tajo.querymaster.QueryMaster
(stop(168)) - QueryMaster stop
2015-02-02 08:41:19,023 INFO: org.apache.tajo.worker.TajoWorkerClientService
(stop(99)) - TajoWorkerClientService stopping
2015-02-02 08:41:19,025 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(126)) - Rpc (QueryMasterClientProtocol) listened on
0:0:0:0:0:0:0:0:12807) shutdown
2015-02-02 08:41:19,025 INFO: org.apache.tajo.worker.TajoWorkerClientService
(stop(103)) - TajoWorkerClientService stopped
2015-02-02 08:41:19,026 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(126)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:12806)
shutdown
2015-02-02 08:41:19,026 INFO: org.apache.tajo.worker.TajoWorkerManagerService
(stop(97)) - TajoWorkerManagerService stopped
2015-02-02 08:41:19,026 INFO: BlockStateChange (logAddStoredBlock(2383)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34019 is added to
blk_1073741834_1010{blockUCState=COMMITTED, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-ae7ab581-1242-4572-96eb-041ee402d26c:NORMAL|RBW]]}
size 1700870
2015-02-02 08:41:19,026 INFO: org.apache.tajo.worker.TajoWorker
(serviceStop(417)) - TajoWorker main thread exiting
2015-02-02 08:41:19,428 INFO: org.apache.tajo.util.history.HistoryCleaner
(run(134)) - History cleaner stopped
2015-02-02 08:41:19,429 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(126)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:12805)
shutdown
2015-02-02 08:41:19,430 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(126)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:12804)
shutdown
2015-02-02 08:41:19,431 ERROR:
org.apache.tajo.master.rm.TajoWorkerResourceManager (run(346)) -
java.lang.InterruptedException
2015-02-02 08:41:19,431 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(126)) - Rpc (TajoResourceTrackerProtocol) listened on
127.0.0.1:12802) shutdown
2015-02-02 08:41:19,432 INFO: org.apache.tajo.master.TajoMaster (stop(394)) -
Tajo Master main thread exiting
Results :
Failed tests:
TestKillQuery.testIgnoreStageStateFromKilled:167 expected:<QUERY_KILLED> but
was:<QUERY_ERROR>
Tests run: 1341, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Tajo Main ......................................... SUCCESS [ 1.677 s]
[INFO] Tajo Project POM .................................. SUCCESS [ 1.170 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [ 2.801 s]
[INFO] Tajo Common ....................................... SUCCESS [ 24.060 s]
[INFO] Tajo Algebra ...................................... SUCCESS [ 1.303 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [ 6.276 s]
[INFO] Tajo Plan ......................................... SUCCESS [ 5.810 s]
[INFO] Tajo Rpc .......................................... SUCCESS [ 25.212 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [ 1.070 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 10.179 s]
[INFO] Tajo Storage Common ............................... SUCCESS [ 10.617 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [ 41.214 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [ 2.948 s]
[INFO] Tajo PullServer ................................... SUCCESS [ 0.804 s]
[INFO] Tajo Client ....................................... SUCCESS [ 3.379 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 0.828 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [ 0.586 s]
[INFO] Tajo Core ......................................... FAILURE [14:40 min]
[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: 17:00 min
[INFO] Finished at: 2015-02-02T08:41:19+00:00
[INFO] Final Memory: 93M/1109M
[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-1313