See <https://builds.apache.org/job/Tajo-master-jdk8-nightly/113/changes>
Changes: [jhkim] TAJO-1799: Fix incorrect event handler when kill-query failed. ------------------------------------------ [...truncated 727905 lines...] 2015-08-24 04:45:38,938 INFO: org.apache.tajo.pullserver.TajoPullServerService (init(203)) - Tajo PullServer initialized: readaheadLength=4194304 2015-08-24 04:45:38,944 INFO: org.apache.tajo.worker.Fetcher (get(135)) - Get real fetch from remote host 2015-08-24 04:45:38,947 INFO: org.apache.tajo.worker.Fetcher (get(174)) - Fetcher finished:3 ms, FETCH_FAILED, URI:http://127.0.0.1:36460/?qid=q_0000000000000_0000&sid=1&p=1&type=h&ta=1_0 Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.949 sec - in org.apache.tajo.worker.TestFetcher Running org.apache.tajo.worker.TestTaskManager 2015-08-24 04:45:38,983 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:2048, Disks:4, vCores:4) 2015-08-24 04:45:38,984 INFO: org.apache.tajo.worker.TaskExecutor (serviceStart(96)) - Started TaskExecutor[4], Fetcher executor[2] 2015-08-24 04:45:38,984 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:38,984 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:38,989 INFO: org.apache.tajo.worker.TaskManager (handle(182)) - Running ExecutionBlocks: 1, running tasks:0, availableResource: (Memory:1536, Disks:4, vCores:3) 2015-08-24 04:45:38,991 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:38,993 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:38,993 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(111)) - NodeStatusUpdater stopped. 2015-08-24 04:45:38,993 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(262)) - Heartbeat Thread stopped. 2015-08-24 04:45:39,036 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:2048, Disks:4, vCores:4) 2015-08-24 04:45:39,038 INFO: org.apache.tajo.worker.TaskExecutor (serviceStart(96)) - Started TaskExecutor[4], Fetcher executor[2] 2015-08-24 04:45:39,038 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:39,038 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:39,042 INFO: org.apache.tajo.worker.TaskManager (handle(182)) - Running ExecutionBlocks: 1, running tasks:0, availableResource: (Memory:2048, Disks:4, vCores:4) 2015-08-24 04:45:39,044 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:39,046 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:39,046 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(111)) - NodeStatusUpdater stopped. 2015-08-24 04:45:39,047 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(262)) - Heartbeat Thread stopped. Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.103 sec - in org.apache.tajo.worker.TestTaskManager Running org.apache.tajo.worker.TestNodeStatusUpdater 2015-08-24 04:45:39,091 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:1000, Disks:2, vCores:2) 2015-08-24 04:45:39,094 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:39,094 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:39,096 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:39,097 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:39,138 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:1000, Disks:2, vCores:2) 2015-08-24 04:45:39,145 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:39,146 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:40,150 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:40,152 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:40,192 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:1000, Disks:2, vCores:2) 2015-08-24 04:45:40,195 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:40,196 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:40,197 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:40,199 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:40,243 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:1000, Disks:2, vCores:2) 2015-08-24 04:45:40,246 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:40,246 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:40,248 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:40,250 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.201 sec - in org.apache.tajo.worker.TestNodeStatusUpdater Running org.apache.tajo.worker.TestDeletionService Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.073 sec - in org.apache.tajo.worker.TestDeletionService Running org.apache.tajo.worker.TestNodeResourceManager 2015-08-24 04:45:42,376 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:2048, Disks:4, vCores:4) 2015-08-24 04:45:42,377 INFO: org.apache.tajo.worker.TaskExecutor (serviceStart(96)) - Started TaskExecutor[4], Fetcher executor[2] 2015-08-24 04:45:42,378 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:42,378 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:42,653 INFO: org.apache.tajo.worker.TaskManager (handle(182)) - Running ExecutionBlocks: 1, running tasks:0, availableResource: (Memory:1536, Disks:4, vCores:3) 2015-08-24 04:45:46,362 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:46,362 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:46,366 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(111)) - NodeStatusUpdater stopped. 2015-08-24 04:45:46,383 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(262)) - Heartbeat Thread stopped. 2015-08-24 04:45:46,427 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:2048, Disks:4, vCores:4) 2015-08-24 04:45:46,429 INFO: org.apache.tajo.worker.TaskExecutor (serviceStart(96)) - Started TaskExecutor[4], Fetcher executor[2] 2015-08-24 04:45:46,429 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:46,432 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:46,435 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:46,437 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:46,437 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(111)) - NodeStatusUpdater stopped. 2015-08-24 04:45:46,437 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(262)) - Heartbeat Thread stopped. 2015-08-24 04:45:46,507 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:2048, Disks:4, vCores:4) 2015-08-24 04:45:46,550 INFO: org.apache.tajo.worker.TaskExecutor (serviceStart(96)) - Started TaskExecutor[4], Fetcher executor[2] 2015-08-24 04:45:46,550 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:46,551 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:46,567 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:46,567 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:46,568 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(111)) - NodeStatusUpdater stopped. 2015-08-24 04:45:46,572 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(262)) - Heartbeat Thread stopped. 2015-08-24 04:45:46,632 INFO: org.apache.tajo.worker.NodeResourceManager (serviceInit(66)) - Initialized NodeResourceManager for (Memory:2048, Disks:4, vCores:4) 2015-08-24 04:45:46,644 INFO: org.apache.tajo.worker.TaskExecutor (serviceStart(96)) - Started TaskExecutor[4], Fetcher executor[2] 2015-08-24 04:45:46,644 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(97)) - Queueing threshold:1 2015-08-24 04:45:46,644 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStart(101)) - NodeStatusUpdater started. 2015-08-24 04:45:46,646 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE.reporters in tajo-metrics.properties 2015-08-24 04:45:46,647 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property NODE-JVM.reporters in tajo-metrics.properties 2015-08-24 04:45:46,647 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(111)) - NodeStatusUpdater stopped. 2015-08-24 04:45:46,647 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(262)) - Heartbeat Thread stopped. Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.324 sec - in org.apache.tajo.worker.TestNodeResourceManager eader initialized will read a total of 2 records. Aug 24, 2015 4:25:56 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: at row 0. reading next block Aug 24, 2015 4:25:56 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: block read in memory in 2 ms. row count = 2 Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26 Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26 Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26 Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26 Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:19 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: RecordReader initialized will read a total of 1 records. Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: at row 0. reading next block Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: block read in memory in 1 ms. row count = 1 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: RecordReader initialized will read a total of 1 records. Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: at row 0. reading next block Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: block read in memory in 1 ms. row count = 1 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: RecordReader initialized will read a total of 1 records. Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: at row 0. reading next block Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: block read in memory in 1 ms. row count = 1 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: RecordReader initialized will read a total of 1 records. Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: at row 0. reading next block Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: block read in memory in 1 ms. row count = 1 Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: RecordReader initialized will read a total of 1 records. Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: at row 0. reading next block Aug 24, 2015 4:26:20 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: block read in memory in 1 ms. row count = 1 Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 212 Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 5 values, 10B raw, 10B comp, 1 pages, encodings: [RLE, PLAIN_DICTIONARY, BIT_PACKED], dic { 3 entries, 12B raw, 3B comp} Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 123B for [l_shipdate] BINARY: 5 values, 76B raw, 76B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 123B for [l_shipdate_function] BINARY: 5 values, 76B raw, 76B comp, 1 pages, encodings: [RLE, BIT_PACKED, PLAIN] Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: reading another 1 footers Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.ParquetFileReader: Initiating action with parallelism: 5 Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: RecordReader initialized will read a total of 5 records. Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: at row 0. reading next block Aug 24, 2015 4:26:23 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: block read in memory in 2 ms. row count = 5 2015-08-24 04:45:46,736 INFO: org.mortbay.log (info(67)) - Shutdown hook executing 2015-08-24 04:45:46,736 INFO: org.mortbay.log (info(67)) - Shutdown hook complete 2015-08-24 04:45:46,676 INFO: org.apache.tajo.worker.TajoWorker (run(567)) - ============================================ 2015-08-24 04:45:46,679 INFO: org.apache.tajo.master.TajoMaster (run(538)) - ============================================ 2015-08-24 04:45:46,764 INFO: org.apache.tajo.master.TajoMaster (run(539)) - TajoMaster received SIGINT Signal 2015-08-24 04:45:46,764 INFO: org.apache.tajo.master.TajoMaster (run(540)) - ============================================ 2015-08-24 04:45:46,764 INFO: org.apache.tajo.worker.TajoWorker (run(568)) - TajoWorker received SIGINT Signal 2015-08-24 04:45:46,764 INFO: org.apache.tajo.worker.TajoWorker (run(569)) - ============================================ 2015-08-24 04:45:46,764 INFO: org.apache.tajo.session.SessionManager (removeSession(86)) - Session 6f750fb9-3326-4cc8-8959-ca8baf0c8fc6 is removed. 2015-08-24 04:45:46,764 INFO: org.apache.tajo.session.SessionManager (removeSession(86)) - Session 0c76004b-1899-4470-bf3c-5e3afa3c7463 is removed. 2015-08-24 04:45:46,790 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (Tajo-REST) listened on 0:0:0:0:0:0:0:0:15015) shutdown 2015-08-24 04:45:46,792 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped. 2015-08-24 04:45:46,796 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(178)) - Catalog Server (127.0.0.1:15012) shutdown 2015-08-24 04:45:46,798 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:15012) shutdown 2015-08-24 04:45:46,801 INFO: org.apache.tajo.util.history.HistoryWriter (run(268)) - HistoryWriter_127.0.0.1_15014 stopped. 2015-08-24 04:45:46,807 INFO: org.apache.tajo.util.history.HistoryWriter (run(268)) - HistoryWriter_asf903.gq1.ygridcore.net_15016 stopped. 2015-08-24 04:45:46,807 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped 2015-08-24 04:45:46,844 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42058 is added to blk_1073741838_1014{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-1ab2f43a-047a-456e-b9f9-3d8cf7bc97eb:NORMAL:127.0.0.1:42058|RBW]]} size 1960 2015-08-24 04:45:46,845 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped 2015-08-24 04:45:46,845 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:15014) shutdown 2015-08-24 04:45:46,856 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:15013) shutdown 2015-08-24 04:45:46,870 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:15011) shutdown 2015-08-24 04:45:46,871 INFO: org.apache.tajo.master.TajoMaster (serviceStop(406)) - Tajo Master main thread exiting 2015-08-24 04:45:46,901 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(111)) - NodeStatusUpdater stopped. 2015-08-24 04:45:46,901 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(262)) - Heartbeat Thread stopped. 2015-08-24 04:45:46,911 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:15018) shutdown 2015-08-24 04:45:46,912 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped 2015-08-24 04:45:46,914 INFO: org.apache.tajo.querymaster.QueryMaster (run(417)) - QueryMaster heartbeat thread stopped 2015-08-24 04:45:46,917 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(168)) - QueryMaster stopped 2015-08-24 04:45:46,917 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(99)) - TajoWorkerClientService stopping 2015-08-24 04:45:46,918 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:15017) shutdown 2015-08-24 04:45:46,918 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(103)) - TajoWorkerClientService stopped 2015-08-24 04:45:46,925 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:15016) shutdown 2015-08-24 04:45:46,925 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped 2015-08-24 04:45:46,928 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(377)) - TajoWorker main thread exiting Results : Failed tests: TestDDLBuilder.testBuildDDLForExternalTable:64 expected:<...) USING TEXT WITH ('[compression.codec'='org.apache.hadoop.io.compress.GzipCodec', 'text.delimiter'='|]') PARTITION BY COLU...> but was:<...) USING TEXT WITH ('[text.delimiter'='|', 'compression.codec'='org.apache.hadoop.io.compress.GzipCodec]') PARTITION BY COLU...> TestDDLBuilder.testBuildDDLForBaseTable:103 expected:<...) USING TEXT WITH ('[compression.codec'='org.apache.hadoop.io.compress.GzipCodec', 'text.delimiter'='|]');> but was:<...) USING TEXT WITH ('[text.delimiter'='|', 'compression.codec'='org.apache.hadoop.io.compress.GzipCodec]');> TestDDLBuilder.testBuildDDLQuotedTableName:90 expected:<...) USING TEXT WITH ('[compression.codec'='org.apache.hadoop.io.compress.GzipCodec', 'text.delimiter'='|]') PARTITION BY COLU...> but was:<...) USING TEXT WITH ('[text.delimiter'='|', 'compression.codec'='org.apache.hadoop.io.compress.GzipCodec]') PARTITION BY COLU...> Tests run: 1689, Failures: 3, Errors: 0, Skipped: 0 [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary: [INFO] [INFO] Tajo Main ......................................... SUCCESS [ 3.974 s] [INFO] Tajo Project POM .................................. SUCCESS [ 5.172 s] [INFO] Tajo Maven Plugins ................................ SUCCESS [ 5.518 s] [INFO] Tajo Common ....................................... SUCCESS [ 29.146 s] [INFO] Tajo Algebra ...................................... SUCCESS [ 2.731 s] [INFO] Tajo Catalog Common ............................... SUCCESS [ 4.985 s] [INFO] Tajo Plan ......................................... SUCCESS [ 7.074 s] [INFO] Tajo Rpc Common ................................... SUCCESS [ 1.539 s] [INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 49.359 s] [INFO] Tajo Catalog Client ............................... SUCCESS [ 1.709 s] [INFO] Tajo Catalog Server ............................... SUCCESS [ 10.730 s] [INFO] Tajo Storage Common ............................... SUCCESS [ 10.012 s] [INFO] Tajo HDFS Storage ................................. SUCCESS [01:19 min] [INFO] Tajo PullServer ................................... SUCCESS [ 1.764 s] [INFO] Tajo Client ....................................... SUCCESS [ 3.381 s] [INFO] Tajo CLI tools .................................... SUCCESS [ 2.863 s] [INFO] ASM (thirdparty) .................................. SUCCESS [ 2.397 s] [INFO] Tajo RESTful Container ............................ SUCCESS [ 5.480 s] [INFO] Tajo Metrics ...................................... SUCCESS [ 1.396 s] [INFO] Tajo Core ......................................... SUCCESS [ 14.355 s] [INFO] Tajo RPC .......................................... SUCCESS [ 1.001 s] [INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 15.647 s] [INFO] Tajo Catalog Drivers .............................. SUCCESS [ 0.099 s] [INFO] Tajo Catalog ...................................... SUCCESS [ 1.022 s] [INFO] Tajo Client Example ............................... SUCCESS [ 1.112 s] [INFO] Tajo HBase Storage ................................ SUCCESS [ 5.391 s] [INFO] Tajo Cluster Tests ................................ SUCCESS [ 2.884 s] [INFO] Tajo JDBC Driver .................................. SUCCESS [ 34.634 s] [INFO] Tajo Storage ...................................... SUCCESS [ 1.024 s] [INFO] Tajo Distribution ................................. SUCCESS [ 6.711 s] [INFO] Tajo Core Tests ................................... FAILURE [24:25 min] [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 29:39 min [INFO] Finished at: 2015-08-24T04:45:48+00:00 [INFO] Final Memory: 146M/1953M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.17:test (default-test) on project tajo-core-tests: There are test failures. [ERROR] [ERROR] Please refer to <https://builds.apache.org/job/Tajo-master-jdk8-nightly/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 Archiving artifacts Sending artifact delta relative to Tajo-master-jdk8-nightly #82 Archived 1 artifacts Archive block size is 32768 Received 0 blocks and 58885222 bytes Compression is 0.0% Took 18 sec Recording test results
