See <https://builds.apache.org/job/Tajo-master-build/764/changes>
Changes:
[jhkim] TAJO-1496: Remove legacy CSVFile. (jinho)
------------------------------------------
[...truncated 64243 lines...]
2015-07-22 10:10:08,076 INFO: org.apache.tajo.master.TajoMasterClientService
(getQueryResultData(538)) - Send result to client for
47b04a31-27b8-4b92-abd0-808d388c9e9a,q_1437559573745_0205, 0 rows
2015-07-22 10:10:08,088 INFO: BlockStateChange (logAddStoredBlock(2473)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56345 is added to
blk_1073742828_2004{blockUCState=COMMITTED, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-c6471180-2fe7-479c-ba8b-b6f8ae338b7e:NORMAL:127.0.0.1:56345|RBW]]}
size 42
2015-07-22 10:10:08,427 INFO: org.apache.tajo.util.history.HistoryWriter
(writeQueryHistory(358)) - Saving query summary:
hdfs://localhost:53053/tmp/tajo-jenkins/staging/history/20150722/query-detail/q_1437559573745_0205/query.hist
2015-07-22 10:10:08,433 INFO: BlockStateChange (logAddStoredBlock(2473)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56345 is added to
blk_1073742829_2005{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-c6471180-2fe7-479c-ba8b-b6f8ae338b7e:NORMAL:127.0.0.1:56345|RBW]]}
size 0
2015-07-22 10:10:08,435 INFO: org.apache.tajo.util.history.HistoryWriter
(writeQueryHistory(372)) - Saving query unit:
hdfs://localhost:53053/tmp/tajo-jenkins/staging/history/20150722/query-detail/q_1437559573745_0205/eb_1437559573745_0205_000001.hist
2015-07-22 10:10:08,439 INFO: BlockStateChange (logAddStoredBlock(2473)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56345 is added to
blk_1073742830_2006{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-734e8f0e-ffbf-4d2d-9ba5-28bc03d95ba9:NORMAL:127.0.0.1:56345|RBW]]}
size 0
2015-07-22 10:10:08,489 INFO: org.apache.tajo.session.SessionManager
(createSession(75)) - Session 9a288a46-4d5d-4a39-b37c-fe539ed1e933 is created.
2015-07-22 10:10:08,494 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(660)) - relation "default.nulltable6" is added to the catalog
(127.0.0.1:30563)
2015-07-22 10:10:08,494 INFO: org.apache.tajo.master.exec.DDLExecutor
(createTable(289)) - Table default.nulltable6 is created (42)
2015-07-22 10:10:08,495 INFO: org.apache.tajo.session.SessionManager
(removeSession(81)) - Session 9a288a46-4d5d-4a39-b37c-fe539ed1e933 is removed.
2015-07-22 10:10:09,496 INFO: org.apache.tajo.master.GlobalEngine
(executeQuery(173)) - Query: select col1, coalesce(col1, 99999), col2,
coalesce(col2, 'null_value'), col3, coalesce(col3, 99999.0),col4 from nulltable6
2015-07-22 10:10:09,587 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(270)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
PROJECTION(1)
=> Targets: default.nulltable6.col1 (INT4), ?coalesce (INT8),
default.nulltable6.col2 (TEXT), ?coalesce_1 (TEXT), default.nulltable6.col3
(FLOAT4), ?coalesce_2 (FLOAT8), default.nulltable6.col4 (BOOLEAN)
=> out schema: {(7) default.nulltable6.col1 (INT4), ?coalesce (INT8),
default.nulltable6.col2 (TEXT), ?coalesce_1 (TEXT), default.nulltable6.col3
(FLOAT4), ?coalesce_2 (FLOAT8), default.nulltable6.col4 (BOOLEAN)}
=> in schema: {(7) default.nulltable6.col1 (INT4), default.nulltable6.col2
(TEXT), default.nulltable6.col3 (FLOAT4), default.nulltable6.col4 (BOOLEAN),
?coalesce (INT8), ?coalesce_1 (TEXT), ?coalesce_2 (FLOAT8)}
SCAN(0) on default.nulltable6
=> target list: default.nulltable6.col1 (INT4), default.nulltable6.col2
(TEXT), default.nulltable6.col3 (FLOAT4), default.nulltable6.col4 (BOOLEAN),
coalesce(CAST (default.nulltable6.col1 (INT4) AS INT8),99999) as ?coalesce,
coalesce(default.nulltable6.col2 (TEXT),null_value) as ?coalesce_1,
coalesce(CAST (default.nulltable6.col3 (FLOAT4) AS FLOAT8),99999.0) as
?coalesce_2
=> out schema: {(7) default.nulltable6.col1 (INT4),
default.nulltable6.col2 (TEXT), default.nulltable6.col3 (FLOAT4),
default.nulltable6.col4 (BOOLEAN), ?coalesce (INT8), ?coalesce_1 (TEXT),
?coalesce_2 (FLOAT8)}
=> in schema: {(4) default.nulltable6.col1 (INT4), default.nulltable6.col2
(TEXT), default.nulltable6.col3 (FLOAT4), default.nulltable6.col4 (BOOLEAN)}
2015-07-22 10:10:09,589 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(272)) - =============================================
2015-07-22 10:10:09,589 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(273)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
[LogicalPlan]
> ProjectionNode is eliminated.
-----------------------------
SCAN(0) on default.nulltable6
=> target list: default.nulltable6.col1 (INT4), coalesce(CAST
(default.nulltable6.col1 (INT4) AS INT8),99999) as ?coalesce,
default.nulltable6.col2 (TEXT), coalesce(default.nulltable6.col2
(TEXT),null_value) as ?coalesce_1, default.nulltable6.col3 (FLOAT4),
coalesce(CAST (default.nulltable6.col3 (FLOAT4) AS FLOAT8),99999.0) as
?coalesce_2, default.nulltable6.col4 (BOOLEAN)
=> out schema: {(7) default.nulltable6.col1 (INT4), ?coalesce (INT8),
default.nulltable6.col2 (TEXT), ?coalesce_1 (TEXT), default.nulltable6.col3
(FLOAT4), ?coalesce_2 (FLOAT8), default.nulltable6.col4 (BOOLEAN)}
=> in schema: {(4) default.nulltable6.col1 (INT4), default.nulltable6.col2
(TEXT), default.nulltable6.col3 (FLOAT4), default.nulltable6.col4 (BOOLEAN)}
2015-07-22 10:10:09,589 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(274)) - =============================================
2015-07-22 10:10:09,590 INFO: org.apache.tajo.master.exec.QueryExecutor
(executeDistributedQuery(506)) - Query q_1437559573745_0206,select col1,
coalesce(col1, 99999), col2, coalesce(col2, 'null_value'), col3, coalesce(col3,
99999.0),col4 from nulltable6, is forwarded to :0
2015-07-22 10:10:09,590 INFO: org.apache.tajo.master.QueryInProgress
(connectQueryMaster(183)) - Try to connect to
QueryMaster:asf903.gq1.ygridcore.net/67.195.81.147:30569
2015-07-22 10:10:09,592 INFO: org.apache.tajo.master.QueryInProgress
(allocateToQueryMaster(162)) - Initializing QueryInProgress for
QueryID=q_1437559573745_0206
2015-07-22 10:10:09,592 INFO: org.apache.tajo.master.scheduler.SimpleScheduler
(run(384)) - Running Queries: 1
2015-07-22 10:10:09,593 INFO: org.apache.tajo.master.QueryInProgress
(submitToQueryMaster(205)) - Call executeQuery to
:asf903.gq1.ygridcore.net:30569,q_1437559573745_0206
2015-07-22 10:10:09,595 INFO:
org.apache.tajo.querymaster.QueryMasterManagerService (executeQuery(236)) -
Receive executeQuery request:q_1437559573745_0206
2015-07-22 10:10:09,595 INFO: org.apache.tajo.querymaster.QueryMaster
(handle(345)) - Start QueryStartEventHandler:q_1437559573745_0206
2015-07-22 10:10:09,823 INFO: org.apache.tajo.querymaster.QueryMasterTask
(initStagingDir(402)) - The staging dir
'hdfs://localhost:53053/tmp/tajo-jenkins/staging/q_1437559573745_0206' is
created.
2015-07-22 10:10:09,823 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (build(128)) -
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
[LogicalPlan]
> ProjectionNode is eliminated.
-----------------------------
SCAN(0) on default.nulltable6
=> target list: default.nulltable6.col1 (INT4), coalesce(CAST
(default.nulltable6.col1 (INT4) AS INT8),99999) as ?coalesce,
default.nulltable6.col2 (TEXT), coalesce(default.nulltable6.col2
(TEXT),null_value) as ?coalesce_1, default.nulltable6.col3 (FLOAT4),
coalesce(CAST (default.nulltable6.col3 (FLOAT4) AS FLOAT8),99999.0) as
?coalesce_2, default.nulltable6.col4 (BOOLEAN)
=> out schema: {(7) default.nulltable6.col1 (INT4), ?coalesce (INT8),
default.nulltable6.col2 (TEXT), ?coalesce_1 (TEXT), default.nulltable6.col3
(FLOAT4), ?coalesce_2 (FLOAT8), default.nulltable6.col4 (BOOLEAN)}
=> in schema: {(4) default.nulltable6.col1 (INT4), default.nulltable6.col2
(TEXT), default.nulltable6.col3 (FLOAT4), default.nulltable6.col4 (BOOLEAN)}
2015-07-22 10:10:09,823 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (build(157)) -
Non-optimized master plan
-------------------------------------------------------------------------------
Execution Block Graph (TERMINAL - eb_1437559573745_0206_000002)
-------------------------------------------------------------------------------
|-eb_1437559573745_0206_000002
|-eb_1437559573745_0206_000001
-------------------------------------------------------------------------------
Order of Execution
-------------------------------------------------------------------------------
1: eb_1437559573745_0206_000001
2: eb_1437559573745_0206_000002
-------------------------------------------------------------------------------
=======================================================
Block Id: eb_1437559573745_0206_000001 [ROOT]
=======================================================
SCAN(0) on default.nulltable6
=> target list: default.nulltable6.col1 (INT4), coalesce(CAST
(default.nulltable6.col1 (INT4) AS INT8),99999) as ?coalesce,
default.nulltable6.col2 (TEXT), coalesce(default.nulltable6.col2
(TEXT),null_value) as ?coalesce_1, default.nulltable6.col3 (FLOAT4),
coalesce(CAST (default.nulltable6.col3 (FLOAT4) AS FLOAT8),99999.0) as
?coalesce_2, default.nulltable6.col4 (BOOLEAN)
=> out schema: {(7) default.nulltable6.col1 (INT4), ?coalesce (INT8),
default.nulltable6.col2 (TEXT), ?coalesce_1 (TEXT), default.nulltable6.col3
(FLOAT4), ?coalesce_2 (FLOAT8), default.nulltable6.col4 (BOOLEAN)}
=> in schema: {(4) default.nulltable6.col1 (INT4), default.nulltable6.col2
(TEXT), default.nulltable6.col3 (FLOAT4), default.nulltable6.col4 (BOOLEAN)}
=======================================================
Block Id: eb_1437559573745_0206_000002 [TERMINAL]
=======================================================
2015-07-22 10:10:09,825 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (build(160)) -
Optimized master plan
-------------------------------------------------------------------------------
Execution Block Graph (TERMINAL - eb_1437559573745_0206_000002)
-------------------------------------------------------------------------------
|-eb_1437559573745_0206_000002
|-eb_1437559573745_0206_000001
-------------------------------------------------------------------------------
Order of Execution
-------------------------------------------------------------------------------
1: eb_1437559573745_0206_000001
2: eb_1437559573745_0206_000002
-------------------------------------------------------------------------------
=======================================================
Block Id: eb_1437559573745_0206_000001 [ROOT]
=======================================================
SCAN(0) on default.nulltable6
=> target list: default.nulltable6.col1 (INT4), coalesce(CAST
(default.nulltable6.col1 (INT4) AS INT8),99999) as ?coalesce,
default.nulltable6.col2 (TEXT), coalesce(default.nulltable6.col2
(TEXT),null_value) as ?coalesce_1, default.nulltable6.col3 (FLOAT4),
coalesce(CAST (default.nulltable6.col3 (FLOAT4) AS FLOAT8),99999.0) as
?coalesce_2, default.nulltable6.col4 (BOOLEAN)
=> out schema: {(7) default.nulltable6.col1 (INT4), ?coalesce (INT8),
default.nulltable6.col2 (TEXT), ?coalesce_1 (TEXT), default.nulltable6.col3
(FLOAT4), ?coalesce_2 (FLOAT8), default.nulltable6.col4 (BOOLEAN)}
=> in schema: {(4) default.nulltable6.col1 (INT4), default.nulltable6.col2
(TEXT), default.nulltable6.col3 (FLOAT4), default.nulltable6.col4 (BOOLEAN)}
=======================================================
Block Id: eb_1437559573745_0206_000002 [TERMINAL]
=======================================================
2015-07-22 10:10:09,825 INFO: org.apache.tajo.querymaster.Query (<init>(234)) -
=======================================================
The order of execution:
1: eb_1437559573745_0206_000001
2: eb_1437559573745_0206_000002
=======================================================
2015-07-22 10:10:09,826 INFO: org.apache.tajo.querymaster.Query (handle(774)) -
Processing q_1437559573745_0206 of type START
2015-07-22 10:10:09,826 INFO:
org.apache.tajo.engine.planner.global.ParallelExecutionQueue (first(84)) -
Initial executable blocks [eb_1437559573745_0206_000001]
2015-07-22 10:10:09,827 INFO: org.apache.tajo.querymaster.Query (handle(792)) -
q_1437559573745_0206 Query Transitioned from QUERY_NEW to QUERY_RUNNING
2015-07-22 10:10:09,827 INFO: org.apache.tajo.querymaster.Stage
(initTaskScheduler(866)) - org.apache.tajo.querymaster.DefaultTaskScheduler is
chosen for the task scheduling for eb_1437559573745_0206_000001
2015-07-22 10:10:09,830 INFO: org.apache.tajo.storage.FileTablespace
(listStatus(384)) - Total input paths to process : 1
2015-07-22 10:10:09,831 INFO: org.apache.tajo.storage.FileTablespace
(getSplits(588)) - Total # of splits: 1
2015-07-22 10:10:09,831 INFO: org.apache.tajo.querymaster.Stage (run(818)) - 1
objects are scheduled
2015-07-22 10:10:09,832 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler
(start(104)) - Start TaskScheduler
2015-07-22 10:10:09,833 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler
(allocateRackTask(760)) - Assigned Local/Rack/Cancel/Total: (0/1/0/1),
Locality: 0.00%, Rack host: asf903.gq1.ygridcore.net
2015-07-22 10:10:09,835 INFO: org.apache.tajo.worker.TaskManager
(createExecutionBlock(113)) - QueryMaster Address:asf903.gq1.ygridcore.net:30569
2015-07-22 10:10:09,838 INFO: org.apache.tajo.worker.ExecutionBlockContext
(init(119)) - Tajo Root Dir: hdfs://localhost:53053/tajo
2015-07-22 10:10:09,838 INFO: org.apache.tajo.worker.ExecutionBlockContext
(init(120)) - Worker Local Dir:
file://<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/52be3494-a74b-4df3-bbeb-717e1fbf5c39/tajo-localdir>
2015-07-22 10:10:09,840 INFO: org.apache.tajo.worker.TaskManager (handle(183))
- Running ExecutionBlocks: 1, running tasks:0, availableResource: (Memory:1000,
Disks:2, vCores:2)
2015-07-22 10:10:09,841 INFO: org.apache.tajo.worker.TaskImpl (<init>(114)) -
Task basedir is created
(<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/52be3494-a74b-4df3-bbeb-717e1fbf5c39/tajo-localdir/q_1437559573745_0206/output/1)>
2015-07-22 10:10:09,841 INFO: org.apache.tajo.worker.TaskAttemptContext
(setState(137)) - Query status of ta_1437559573745_0206_000001_000000_00 is
changed to TA_PENDING
2015-07-22 10:10:09,841 INFO: org.apache.tajo.worker.TaskImpl (init(196)) -
Initializing: ta_1437559573745_0206_000001_000000_00
2015-07-22 10:10:09,842 INFO: org.apache.tajo.storage.FileTablespace
(getAppenderFilePath(310)) - Output File Path:
hdfs://localhost:53053/tmp/tajo-jenkins/staging/q_1437559573745_0206/RESULT/part-01-000000-000
2015-07-22 10:10:09,842 INFO: org.apache.tajo.worker.TaskImpl (initPlan(157)) -
Output File Path:
hdfs://localhost:53053/tmp/tajo-jenkins/staging/q_1437559573745_0206/RESULT/part-01-000000-000
2015-07-22 10:10:09,842 INFO: org.apache.tajo.worker.TaskImpl (initPlan(162)) -
==================================
2015-07-22 10:10:09,842 INFO: org.apache.tajo.worker.TaskImpl (initPlan(163)) -
* Stage ta_1437559573745_0206_000001_000000_00 is initialized
2015-07-22 10:10:09,842 INFO: org.apache.tajo.worker.TaskImpl (initPlan(164)) -
* InterQuery: false, Fragments (num: 1), Fetches (total:0) :
2015-07-22 10:10:09,842 INFO: org.apache.tajo.worker.TaskImpl (initPlan(174)) -
* Local task dir:
<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/test-data/52be3494-a74b-4df3-bbeb-717e1fbf5c39/tajo-localdir/q_1437559573745_0206/output/1/0_0>
2015-07-22 10:10:09,842 INFO: org.apache.tajo.worker.TaskImpl (initPlan(179)) -
==================================
2015-07-22 10:10:09,843 INFO: org.apache.tajo.worker.TaskAttemptContext
(setState(137)) - Query status of ta_1437559573745_0206_000001_000000_00 is
changed to TA_RUNNING
2015-07-22 10:10:09,854 INFO: BlockStateChange (logAddStoredBlock(2473)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56345 is added to
blk_1073742831_2007{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-c6471180-2fe7-479c-ba8b-b6f8ae338b7e:NORMAL:127.0.0.1:56345|FINALIZED]]}
size 0
2015-07-22 10:10:09,855 INFO: org.apache.tajo.worker.TaskAttemptContext
(setState(137)) - Query status of ta_1437559573745_0206_000001_000000_00 is
changed to TA_SUCCEEDED
2015-07-22 10:10:09,855 INFO: org.apache.tajo.worker.TaskImpl (run(457)) -
ta_1437559573745_0206_000001_000000_00 completed. Worker's task counter -
total:1, succeeded: 1, killed: 0, failed: 0
2015-07-22 10:10:09,856 INFO: org.apache.tajo.querymaster.Stage
(transition(1282)) - Stage - eb_1437559573745_0206_000001 finalize NONE_SHUFFLE
(total=1, success=1, killed=0)
2015-07-22 10:10:09,856 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler
(stop(158)) - Task Scheduler stopped
2015-07-22 10:10:09,856 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler
(run(139)) - TaskScheduler schedulingThread stopped
2015-07-22 10:10:09,857 INFO: org.apache.tajo.querymaster.Stage
(transition(1340)) - Stage completed - eb_1437559573745_0206_000001 (total=1,
success=1, killed=0)
2015-07-22 10:10:09,857 INFO: org.apache.tajo.querymaster.Query (handle(774)) -
Processing q_1437559573745_0206 of type STAGE_COMPLETED
2015-07-22 10:10:09,857 INFO:
org.apache.tajo.engine.planner.global.ParallelExecutionQueue (next(95)) - Next
executable block eb_1437559573745_0206_000002
2015-07-22 10:10:09,857 INFO: org.apache.tajo.worker.TaskManager
(stopExecutionBlock(162)) - Stopped execution block:eb_1437559573745_0206_000001
2015-07-22 10:10:09,857 INFO: org.apache.tajo.querymaster.Query
(transition(721)) - Complete Stage[eb_1437559573745_0206_000001], State:
SUCCEEDED, 1/1.
2015-07-22 10:10:09,858 INFO: org.apache.tajo.querymaster.Query (handle(774)) -
Processing q_1437559573745_0206 of type QUERY_COMPLETED
2015-07-22 10:10:09,859 INFO: org.apache.tajo.querymaster.Query (handle(792)) -
q_1437559573745_0206 Query Transitioned from QUERY_RUNNING to QUERY_SUCCEEDED
2015-07-22 10:10:09,859 INFO: org.apache.tajo.querymaster.QueryMasterTask
(handle(311)) - Query completion notified from q_1437559573745_0206 final
state: QUERY_SUCCEEDED
2015-07-22 10:10:09,860 INFO: org.apache.tajo.master.QueryInProgress
(heartbeat(252)) - Received QueryMaster
heartbeat:q_1437559573745_0206,state=QUERY_SUCCEEDED,progress=1.0,
queryMaster=asf903.gq1.ygridcore.net
2015-07-22 10:10:09,860 INFO: org.apache.tajo.querymaster.QueryMasterTask
(serviceStop(179)) - Stopping QueryMasterTask:q_1437559573745_0206
2015-07-22 10:10:09,860 INFO: org.apache.tajo.master.QueryManager
(stopQuery(239)) - Stop QueryInProgress:q_1437559573745_0206
2015-07-22 10:10:09,860 INFO: org.apache.tajo.master.QueryInProgress
(stopProgress(117)) - =========================================================
2015-07-22 10:10:09,860 INFO: org.apache.tajo.master.QueryInProgress
(stopProgress(118)) - Stop query:q_1437559573745_0206
2015-07-22 10:10:09,860 INFO: org.apache.tajo.querymaster.QueryMasterTask
(cleanupQuery(480)) - Cleanup resources of all workers. Query:
q_1437559573745_0206, workers: 1
2015-07-22 10:10:09,861 INFO: org.apache.tajo.querymaster.QueryMasterTask
(serviceStop(204)) - Stopped QueryMasterTask:q_1437559573745_0206
2015-07-22 10:10:10,109 INFO: org.apache.tajo.master.TajoMasterClientService
(getQueryResultData(538)) - Send result to client for
47b04a31-27b8-4b92-abd0-808d388c9e9a,q_1437559573745_0206, 4 rows
2015-07-22 10:10:10,111 INFO: org.apache.tajo.master.TajoMasterClientService
(getQueryResultData(538)) - Send result to client for
47b04a31-27b8-4b92-abd0-808d388c9e9a,q_1437559573745_0206, 0 rows
2015-07-22 10:10:10,141 INFO: BlockStateChange (logAddStoredBlock(2473)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56345 is added to
blk_1073742832_2008{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-734e8f0e-ffbf-4d2d-9ba5-28bc03d95ba9:NORMAL:127.0.0.1:56345|FINALIZED]]}
size 0
2015-07-22 10:10:10,142 INFO: org.apache.tajo.session.SessionManager
(createSession(75)) - Session 9e77ffe3-60ac-40e4-acb3-bba006717c17 is created.
2015-07-22 10:10:10,146 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(660)) - relation "default.nulltable5" is added to the catalog
(127.0.0.1:30563)
2015-07-22 10:10:10,146 INFO: org.apache.tajo.master.exec.DDLExecutor
(createTable(289)) - Table default.nulltable5 is created (42)
2015-07-22 10:10:10,147 INFO: org.apache.tajo.session.SessionManager
(removeSession(81)) - Session 9e77ffe3-60ac-40e4-acb3-bba006717c17 is removed.
2015-07-22 10:10:10,443 INFO: org.apache.tajo.util.history.HistoryWriter
(writeQueryHistory(358)) - Saving query summary:
hdfs://localhost:53053/tmp/tajo-jenkins/staging/history/20150722/query-detail/q_1437559573745_0206/query.hist
2015-07-22 10:10:10,451 INFO: BlockStateChange (logAddStoredBlock(2473)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56345 is added to
blk_1073742833_2009{blockUCState=COMMITTED, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-c6471180-2fe7-479c-ba8b-b6f8ae338b7e:NORMAL:127.0.0.1:56345|RBW]]}
size 5300
2015-07-22 10:10:10,855 INFO: org.apache.tajo.util.history.HistoryWriter
(writeQueryHistory(372)) - Saving query unit:
hdfs://localhost:53053/tmp/tajo-jenkins/staging/history/20150722/query-detail/q_1437559573745_0206/eb_1437559573745_0206_000001.hist
2015-07-22 10:10:10,860 INFO: BlockStateChange (logAddStoredBlock(2473)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56345 is added to
blk_1073742834_2010{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-734e8f0e-ffbf-4d2d-9ba5-28bc03d95ba9:NORMAL:127.0.0.1:56345|FINALIZED]]}
size 0
Killed
Results :
Tests run: 395, Failures: 0, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Tajo Main ......................................... SUCCESS [ 1.786 s]
[INFO] Tajo Project POM .................................. SUCCESS [ 1.167 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [ 2.786 s]
[INFO] Tajo Common ....................................... SUCCESS [ 24.803 s]
[INFO] Tajo Algebra ...................................... SUCCESS [ 1.378 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [ 6.531 s]
[INFO] Tajo Plan ......................................... SUCCESS [ 7.382 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [ 0.426 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 44.522 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [ 1.760 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 10.308 s]
[INFO] Tajo Storage Common ............................... SUCCESS [ 14.156 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [01:23 min]
[INFO] Tajo HBase Storage ................................ SUCCESS [ 3.537 s]
[INFO] Tajo PullServer ................................... SUCCESS [ 1.020 s]
[INFO] Tajo Client ....................................... SUCCESS [ 2.789 s]
[INFO] Tajo CLI tools .................................... SUCCESS [ 0.829 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 3.203 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [ 0.562 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [ 3.252 s]
[INFO] Tajo Core ......................................... FAILURE [04:17 min]
[INFO] Tajo RPC .......................................... SKIPPED
[INFO] Tajo Catalog Drivers Hive ......................... 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: 07:53 min
[INFO] Finished at: 2015-07-22T10:10:10+00:00
[INFO] Final Memory: 105M/1032M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal
org.apache.maven.plugins:maven-surefire-plugin:2.17:test (default-test) on
project tajo-core: Execution default-test of goal
org.apache.maven.plugins:maven-surefire-plugin:2.17:test failed: The forked VM
terminated without properly saying goodbye. VM crash or System.exit called?
[ERROR] Command was /bin/sh -c cd
<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core> &&
/home/jenkins/tools/java/jdk1.6.0_45-64/jre/bin/java -Xms512m -Xmx1024m
-XX:MaxPermSize=152m -Dfile.encoding=UTF-8 -jar
<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/surefire/surefirebooter4235098011429112056.jar>
<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/surefire/surefire3517091917899721167tmp>
<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/target/surefire/surefire_111771698342186032669tmp>
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e
switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please
read the following articles:
[ERROR] [Help 1]
http://cwiki.apache.org/confluence/display/MAVEN/PluginExecutionException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :tajo-core
Build step 'Execute shell' marked build as failure
Updating TAJO-1496
