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/02/16 09:31:16 UTC

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

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

Changes:

[jihoonson] TAJO-2033: Printing out query status with progress bar in TSQL.

------------------------------------------
[...truncated 741407 lines...]
2016-02-16 08:31:08,906 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - =============================================
2016-02-16 08:31:08,907 INFO: org.apache.tajo.master.exec.DDLExecutor (createDatabase(245)) - database "TestHistoryWriterReader" is already exists.
2016-02-16 08:31:08,909 INFO: org.apache.tajo.util.history.HistoryWriter (run(231)) - HistoryWriter_127.0.0.1_28090 started.
2016-02-16 08:31:08,909 INFO: org.apache.tajo.util.history.HistoryCleaner (run(62)) - History cleaner started: expiry day=7
2016-02-16 08:31:09,910 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(365)) - Saving query summary: hdfs://localhost:45056/tmp/tajo-test-history/20160216/query-detail/q_1455611468909_0001/query.hist
2016-02-16 08:31:09,915 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:54654 is added to blk_1073749130_8306{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-2157c584-9f3f-45a5-8808-c326d98e5a84:NORMAL:127.0.0.1:54654|FINALIZED]]} size 0
2016-02-16 08:31:09,916 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:45056/tmp/tajo-test-history/20160216/query-detail/q_1455611468909_0001/eb_1455611468909_0001_000000.hist
2016-02-16 08:31:09,919 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:54654 is added to blk_1073749131_8307{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-705b3759-3ef9-426a-99a0-02cc7dada001:NORMAL:127.0.0.1:54654|FINALIZED]]} size 0
2016-02-16 08:31:09,920 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:45056/tmp/tajo-test-history/20160216/query-detail/q_1455611468909_0001/eb_1455611468909_0001_000001.hist
2016-02-16 08:31:09,923 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:54654 is added to blk_1073749132_8308{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-2157c584-9f3f-45a5-8808-c326d98e5a84:NORMAL:127.0.0.1:54654|FINALIZED]]} size 0
2016-02-16 08:31:09,924 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(379)) - Saving query unit: hdfs://localhost:45056/tmp/tajo-test-history/20160216/query-detail/q_1455611468909_0001/eb_1455611468909_0001_000002.hist
2016-02-16 08:31:09,927 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:54654 is added to blk_1073749133_8309{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-705b3759-3ef9-426a-99a0-02cc7dada001:NORMAL:127.0.0.1:54654|RBW]]} size 0
2016-02-16 08:31:09,942 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_28090 stopped.
2016-02-16 08:31:09,942 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-16 08:31:09,945 INFO: BlockStateChange (addToInvalidates(1103)) - BLOCK* addToInvalidates: blk_1073749131_8307 127.0.0.1:54654 
2016-02-16 08:31:09,945 INFO: BlockStateChange (addToInvalidates(1103)) - BLOCK* addToInvalidates: blk_1073749132_8308 127.0.0.1:54654 
2016-02-16 08:31:09,945 INFO: BlockStateChange (addToInvalidates(1103)) - BLOCK* addToInvalidates: blk_1073749133_8309 127.0.0.1:54654 
2016-02-16 08:31:09,945 INFO: BlockStateChange (addToInvalidates(1103)) - BLOCK* addToInvalidates: blk_1073749130_8306 127.0.0.1:54654 
2016-02-16 08:31:09,946 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: CREATE DATABASE IF NOT EXISTS "TestHistoryWriterReader"
2016-02-16 08:31:09,946 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(281)) - Non Optimized Query: 

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

CREATE_DATABASE(0) IF NOT EXISTS TestHistoryWriterReader

2016-02-16 08:31:09,946 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - =============================================
2016-02-16 08:31:09,947 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - Optimized Query: 

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

CREATE_DATABASE(0) IF NOT EXISTS TestHistoryWriterReader

2016-02-16 08:31:09,947 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - =============================================
2016-02-16 08:31:09,947 INFO: org.apache.tajo.master.exec.DDLExecutor (createDatabase(245)) - database "TestHistoryWriterReader" is already exists.
2016-02-16 08:31:09,949 INFO: org.apache.tajo.util.history.HistoryWriter (run(231)) - HistoryWriter_127.0.0.1_28090 started.
2016-02-16 08:31:09,949 INFO: org.apache.tajo.util.history.HistoryCleaner (run(62)) - History cleaner started: expiry day=7
2016-02-16 08:31:10,951 INFO: org.apache.tajo.util.history.HistoryWriter (rollingQuerySummaryWriter(432)) - Create query history file: hdfs://localhost:45056/tmp/tajo-test-history/20160216/query-list/query-list-083110.hist
2016-02-16 08:31:11,085 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_28090 stopped.
2016-02-16 08:31:11,088 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:54654 is added to blk_1073749134_8310{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-2157c584-9f3f-45a5-8808-c326d98e5a84:NORMAL:127.0.0.1:54654|RBW]]} size 397
2016-02-16 08:31:11,089 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-16 08:31:11,090 INFO: BlockStateChange (addToInvalidates(1103)) - BLOCK* addToInvalidates: blk_1073749134_8310 127.0.0.1:54654 
2016-02-16 08:31:11,091 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: CREATE DATABASE IF NOT EXISTS "TestHistoryWriterReader"
2016-02-16 08:31:11,091 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(281)) - Non Optimized Query: 

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

CREATE_DATABASE(0) IF NOT EXISTS TestHistoryWriterReader

2016-02-16 08:31:11,091 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - =============================================
2016-02-16 08:31:11,092 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - Optimized Query: 

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

CREATE_DATABASE(0) IF NOT EXISTS TestHistoryWriterReader

2016-02-16 08:31:11,092 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - =============================================
2016-02-16 08:31:11,092 INFO: org.apache.tajo.master.exec.DDLExecutor (createDatabase(245)) - database "TestHistoryWriterReader" is already exists.
2016-02-16 08:31:11,094 INFO: org.apache.tajo.util.history.HistoryWriter (run(231)) - HistoryWriter_127.0.0.1_28090 started.
2016-02-16 08:31:11,094 INFO: org.apache.tajo.util.history.HistoryCleaner (run(62)) - History cleaner started: expiry day=7
2016-02-16 08:31:11,099 INFO: BlockStateChange (invalidateWorkForOneNode(3482)) - BLOCK* BlockManager: ask 127.0.0.1:54654 to delete [blk_1073749130_8306, blk_1073749131_8307, blk_1073749132_8308, blk_1073749133_8309, blk_1073749134_8310]
2016-02-16 08:31:12,097 INFO: org.apache.tajo.util.history.HistoryWriter (rollingQuerySummaryWriter(432)) - Create query history file: hdfs://localhost:45056/tmp/tajo-test-history/20160216/query-list/query-list-083112.hist
2016-02-16 08:31:12,218 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_28090 stopped.
2016-02-16 08:31:12,219 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:54654 is added to blk_1073749135_8311{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-705b3759-3ef9-426a-99a0-02cc7dada001:NORMAL:127.0.0.1:54654|RBW]]} size 2000
2016-02-16 08:31:12,219 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-16 08:31:12,221 INFO: BlockStateChange (addToInvalidates(1103)) - BLOCK* addToInvalidates: blk_1073749135_8311 127.0.0.1:54654 
2016-02-16 08:31:12,229 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 07e92b71-abc0-4e80-b364-b3655ee28d11 is removed.
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.366 sec - in org.apache.tajo.util.history.TestHistoryWriterReader
Running org.apache.tajo.util.TestRpcParamFactory
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.037 sec - in org.apache.tajo.util.TestRpcParamFactory
Running org.apache.tajo.util.TestJSPUtil
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.043 sec - in org.apache.tajo.util.TestJSPUtil
Running org.apache.tajo.TestTajoIds
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec - in org.apache.tajo.TestTajoIds
Running org.apache.tajo.storage.TestFileFragment
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.105 sec - in org.apache.tajo.storage.TestFileFragment
Running org.apache.tajo.storage.TestRowFile
2016-02-16 08:31:12,433 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:54654 is added to blk_1073749136_8312{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-2157c584-9f3f-45a5-8808-c326d98e5a84:NORMAL:127.0.0.1:54654|FINALIZED]]} size 0
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.035 sec - in org.apache.tajo.storage.TestRowFile
Running org.apache.tajo.resource.TestResources
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec - in org.apache.tajo.resource.TestResources
w, 20B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:00 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 16, 2016 8:25:01 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:02 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 212
Feb 16, 2016 8:25:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 5 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN_DICTIONARY, RLE, BIT_PACKED], dic { 3 entries, 12B raw, 3B comp}
Feb 16, 2016 8:25:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 123B for [l_shipdate] BINARY: 5 values, 76B raw, 76B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 123B for [l_shipdate_function] BINARY: 5 values, 76B raw, 76B comp, 1 pages, encodings: [PLAIN, RLE, BIT_PACKED]
Feb 16, 2016 8:25:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
Feb 16, 2016 8:25:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers
Feb 16, 2016 8:25:03 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5
2016-02-16 08:31:12,464 INFO: org.mortbay.log (info(67)) - Shutdown hook executing
2016-02-16 08:31:12,464 INFO: org.mortbay.log (info(67)) - Shutdown hook complete
2016-02-16 08:31:12,473 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session d573276d-646a-4fd5-967d-536be0ab8f85 is removed.
2016-02-16 08:31:12,479 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session b4717109-2cff-4ca9-a86f-257f5ac016c8 is removed.
2016-02-16 08:31:12,480 INFO: org.apache.tajo.worker.TajoWorker (run(518)) - ============================================
2016-02-16 08:31:12,480 INFO: org.apache.tajo.worker.TajoWorker (run(519)) - TajoWorker received SIGINT Signal
2016-02-16 08:31:12,480 INFO: org.apache.tajo.worker.TajoWorker (run(520)) - ============================================
2016-02-16 08:31:12,482 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_asf905.gq1.ygridcore.net_43771 stopped.
2016-02-16 08:31:12,483 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-16 08:31:12,484 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(261)) - Heartbeat Thread stopped.
2016-02-16 08:31:12,484 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(113)) - NodeStatusUpdater stopped.
2016-02-16 08:31:12,487 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:43773) shutdown
2016-02-16 08:31:12,487 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped
2016-02-16 08:31:12,487 INFO: org.apache.tajo.querymaster.QueryMaster (run(432)) - QueryMaster heartbeat thread stopped
2016-02-16 08:31:12,487 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(164)) - QueryMaster stopped
2016-02-16 08:31:12,488 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(98)) - TajoWorkerClientService stopping
2016-02-16 08:31:12,488 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:43772) shutdown
2016-02-16 08:31:12,488 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(102)) - TajoWorkerClientService stopped
2016-02-16 08:31:12,488 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:43771) shutdown
2016-02-16 08:31:12,488 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped
2016-02-16 08:31:12,489 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(332)) - TajoWorker main thread exiting
2016-02-16 08:31:14,099 INFO: BlockStateChange (invalidateWorkForOneNode(3482)) - BLOCK* BlockManager: ask 127.0.0.1:54654 to delete [blk_1073749135_8311]
2016-02-16 08:31:14,692 INFO: org.apache.tajo.master.TajoMaster (run(568)) - ============================================
2016-02-16 08:31:14,692 INFO: org.apache.tajo.master.TajoMaster (run(569)) - TajoMaster received SIGINT Signal
2016-02-16 08:31:14,692 INFO: org.apache.tajo.master.TajoMaster (run(570)) - ============================================
2016-02-16 08:31:14,693 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:43770) shutdown
2016-02-16 08:31:14,693 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2016-02-16 08:31:14,699 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_43769 stopped.
2016-02-16 08:31:14,701 INFO: BlockStateChange (logAddStoredBlock(2621)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:54654 is added to blk_1073741838_1014{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-2157c584-9f3f-45a5-8808-c326d98e5a84:NORMAL:127.0.0.1:54654|RBW]]} size 700
2016-02-16 08:31:14,702 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-02-16 08:31:14,703 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:43769) shutdown
2016-02-16 08:31:16,806 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:43768) shutdown
2016-02-16 08:31:16,807 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(182)) - Catalog Server (127.0.0.1:43767) shutdown
2016-02-16 08:31:16,808 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:43767) shutdown
2016-02-16 08:31:16,808 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/b6a9097d-5068-48e2-a0f0-26c7dc70001c/db;create=true)>
2016-02-16 08:31:16,808 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:43766) shutdown
2016-02-16 08:31:16,809 INFO: org.apache.tajo.master.TajoMaster (serviceStop(424)) - Tajo Master main thread exiting
2016-02-16 08:31:16,852 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(68)) - Derby shutdown complete normally.
2016-02-16 08:31:16,852 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(75)) - Shutdown database

Results :

Failed tests: 
  TestTajoCli.testSelectResultWithNullTrueDeprecated:320->verifySelectResultWithNullTrue:314->assertOutputResult:106->assertOutputResult:110->assertOutputResult:128 expected:<...xecute '\help set'.
[]c_custkey,  o_orderk...> but was:<...xecute '\help set'.
[
]c_custkey,  o_orderk...>

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

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  2.897 s]
[INFO] Tajo Project POM .................................. SUCCESS [  1.515 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  2.679 s]
[INFO] Tajo Common ....................................... SUCCESS [ 28.440 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  3.152 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  5.096 s]
[INFO] Tajo Plan ......................................... SUCCESS [  7.292 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  1.272 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [02:24 min]
[INFO] Tajo Catalog Client ............................... SUCCESS [  1.453 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 59.869 s]
[INFO] Tajo Storage Common ............................... SUCCESS [  3.121 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [01:04 min]
[INFO] Tajo PullServer ................................... SUCCESS [  0.969 s]
[INFO] Tajo Client ....................................... SUCCESS [  2.667 s]
[INFO] Tajo CLI tools .................................... SUCCESS [  1.901 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [  3.837 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [  1.788 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [  3.801 s]
[INFO] Tajo Metrics ...................................... SUCCESS [  1.771 s]
[INFO] Tajo Core ......................................... SUCCESS [  6.779 s]
[INFO] Tajo RPC .......................................... SUCCESS [  0.948 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 25.491 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [  0.088 s]
[INFO] Tajo Catalog ...................................... SUCCESS [  0.945 s]
[INFO] Tajo Client Example ............................... SUCCESS [  1.007 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [  4.145 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [  2.917 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 34.786 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [  0.838 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [  0.960 s]
[INFO] Tajo S3 storage ................................... SUCCESS [  0.251 s]
[INFO] Tajo Storage ...................................... SUCCESS [  0.990 s]
[INFO] Tajo Distribution ................................. SUCCESS [  6.370 s]
[INFO] Tajo Core Tests ................................... FAILURE [21:46 min]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 28:57 min
[INFO] Finished at: 2016-02-16T08:31:17+00:00
[INFO] Final Memory: 157M/1665M
[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
Updating TAJO-2033

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

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