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 2015/08/21 06:01:41 UTC
Build failed in Jenkins: Tajo-master-build #814
See <https://builds.apache.org/job/Tajo-master-build/814/>
------------------------------------------
[...truncated 9316 lines...]
=> exprs: (min(?cast (TEXT)))
=> target list: ?min_1 (TEXT)
=> out schema:{(1) ?min_1 (TEXT)}
=> in schema:{(2) default.lineitem.l_orderkey (INT4), ?cast (TEXT)}
SCAN(0) on default.lineitem
=> target list: default.lineitem.l_orderkey (INT4), CAST (default.lineitem.l_orderkey (INT4) AS TEXT) as ?cast
=> out schema: {(2) default.lineitem.l_orderkey (INT4), ?cast (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_1440128444601_2003_000002 [ROOT]
=======================================================
[Incoming]
[q_1440128444601_2003] 1 => 2 (type=HASH_SHUFFLE, key=, num=1)
GROUP_BY(2)()
=> exprs: (min(?min_1 (TEXT)))
=> target list: total_min (TEXT)
=> out schema:{(1) total_min (TEXT)}
=> in schema:{(1) ?min_1 (TEXT)}
SCAN(6) on eb_1440128444601_2003_000001
=> out schema: {(1) ?min_1 (TEXT)}
=> in sc2015-08-21 04:02:02,439 INFO: org.apache.tajo.querymaster.Stage (transition(1356)) - Stage completed - eb_1440128444601_2005_000001 (total=1, success=1, killed=0)
2015-08-21 04:02:02,439 INFO: org.apache.tajo.storage.HashShuffleAppenderManager (close(155)) - Close HashShuffleAppender:eb_1440128444601_2005_000002, intermediates=1
2015-08-21 04:02:02,439 INFO: org.apache.tajo.querymaster.Query (handle(855)) - Processing q_1440128444601_2005 of type STAGE_COMPLETED
2015-08-21 04:02:02,439 INFO: org.apache.tajo.querymaster.Stage (finalizeShuffleReport(1255)) - eb_1440128444601_2005_000002, Finalized HASH_SHUFFLE reports: 1
2015-08-21 04:02:02,439 INFO: org.apache.tajo.querymaster.Stage (transition(1356)) - Stage completed - eb_1440128444601_2005_000002 (total=1, success=1, killed=0)
2015-08-21 04:02:02,440 INFO: org.apache.tajo.querymaster.Query (handle(855)) - Processing q_1440128444601_2005 of type STAGE_COMPLETED
2015-08-21 04:02:02,440 INFO: org.apache.tajo.worker.TaskManager (stopExecutionBlock(161)) - Stopped execution block:eb_1440128444601_2005_000002
2015-08-21 04:02:02,440 INFO: org.apache.tajo.engine.planner.global.ParallelExecutionQueue (next(95)) - Next executable block eb_1440128444601_2005_000003
2015-08-21 04:02:02,440 INFO: org.apache.tajo.querymaster.Query (executeNextBlock(757)) - Scheduling Stage:eb_1440128444601_2005_000003
2015-08-21 04:02:02,440 INFO: org.apache.tajo.querymaster.Stage (calculateShuffleOutputNum(1007)) - ============>>>>> Unexpected Case! <<<<<================
2015-08-21 04:02:02,440 INFO: org.apache.tajo.querymaster.Stage (calculateShuffleOutputNum(1011)) - eb_1440128444601_2005_000003, Table's volume is approximately 1 MB
2015-08-21 04:02:02,440 INFO: org.apache.tajo.querymaster.Stage (calculateShuffleOutputNum(1014)) - eb_1440128444601_2005_000003, The determined number of partitions is 1
2015-08-21 04:02:02,441 INFO: org.apache.tajo.querymaster.Stage (initTaskScheduler(882)) - org.apache.tajo.querymaster.DefaultTaskScheduler is chosen for the task scheduling for eb_1440128444601_2005_000003
2015-08-21 04:02:02,441 INFO: org.apache.tajo.querymaster.Repartitioner (scheduleFragmentsForJoinQuery(261)) - [Distributed Join Strategy] : Symmetric Repartition Join
2015-08-21 04:02:02,441 INFO: org.apache.tajo.querymaster.Repartitioner (scheduleSymmetricRepartitionJoin(357)) - Larger intermediate data is approximately 1 MB
2015-08-21 04:02:02,441 INFO: org.apache.tajo.querymaster.Repartitioner (scheduleSymmetricRepartitionJoin(360)) - The calculated number of tasks is 1
2015-08-21 04:02:02,441 INFO: org.apache.tajo.querymaster.Repartitioner (scheduleSymmetricRepartitionJoin(361)) - The number of total shuffle keys is 1
2015-08-21 04:02:02,441 INFO: org.apache.tajo.querymaster.Repartitioner (scheduleSymmetricRepartitionJoin(365)) - The determined number of join tasks is 1
2015-08-21 04:02:02,442 INFO: org.apache.tajo.querymaster.Stage (run(834)) - 1 objects are scheduled
2015-08-21 04:02:02,442 INFO: org.apache.tajo.querymaster.DefaultTaskScheduler (start(130)) - Start TaskScheduler
2015-08-21 04:02:02,444 INFO: org.apache.tajo.worker.TaskManager (createExecutionBlock(112)) - QueryMaster Address:asf905.gq1.ygridcore.net:12954
2015-08-21 04:02:02,445 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(119)) - Tajo Root Dir: hdfs://localhost:45801/tajo
2015-08-21 04:02:02,445 INFO: org.apache.tajo.worker.ExecutionBlockContext (init(120)) - Worker Local Dir: file://<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/3ea803ab-38d5-44fb-82dd-5ec6a277754e/tajo-localdir>
2015-08-21 04:02:02,446 INFO: org.apache.tajo.worker.TaskManager (handle(182)) - Running ExecutionBlocks: 1, running tasks:0, availableResource: (Memory:1000, Disks:3, vCores:2)
2015-08-21 04:02:02,446 INFO: org.apache.tajo.worker.TaskImpl (<init>(114)) - Task basedir is created (<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/3ea803ab-38d5-44fb-82dd-5ec6a277754e/tajo-localdir/q_1440128444601_2005/output/3)>
2015-08-21 04:02:02,447 INFO: org.apache.Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.071 sec - in org.apache.tajo.worker.TestDeletionService
Running org.apache.tajo.cli.tools.TestDDLBuilder
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec - in org.apache.tajo.cli.tools.TestDDLBuilder
Running org.apache.tajo.cli.tools.TestTajoDump
2015-08-21 04:02:21,530 INFO: org.apache.tajo.session.SessionManager (createSession(80)) - Session de2394f3-03eb-43b4-ae85-0f7a779758fd is created.
2015-08-21 04:02:21,531 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: CREATE DATABASE IF NOT EXISTS "TestTajoDump"
2015-08-21 04:02:21,531 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
CREATE_DATABASE(0) IF NOT EXISTS TestTajoDump
2015-08-21 04:02:21,531 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-08-21 04:02:21,531 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
CREATE_DATABASE(0) IF NOT EXISTS TestTajoDump
2015-08-21 04:02:21,532 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(286)) - =============================================
2015-08-21 04:02:21,532 INFO: org.apache.tajo.catalog.CatalogServer (createDatabase(402)) - database "TestTajoDump" is created
Run: testDump1 Used memory: 595 MBytes, Active Threads:243
2015-08-21 04:02:21,535 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: CREATE TABLE "TestTajoDump"."TableName1" ("Age" int, "FirstName" TEXT, lastname TEXT)
2015-08-21 04:02:21,536 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-08-21 04:02:21,536 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-08-21 04:02:21,536 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-08-21 04:02:21,536 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(286)) - =============================================
2015-08-21 04:02:21,540 INFO: org.apache.tajo.catalog.CatalogServer (createTable(667)) - relation "TestTajoDump.TableName1" is added to the catalog (127.0.0.1:12948)
2015-08-21 04:02:21,545 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: DROP TABLE "TestTajoDump"."TableName1"
2015-08-21 04:02:21,546 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-08-21 04:02:21,546 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-08-21 04:02:21,546 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-08-21 04:02:21,546 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(286)) - =============================================
2015-08-21 04:02:21,546 INFO: org.apache.tajo.catalog.CatalogServer (dropTable(697)) - relation "TestTajoDump.TableName1" is deleted from the catalog (127.0.0.1:12948)
2015-08-21 04:02:21,547 INFO: or2015-08-21 04:02:28,210 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(358)) - Saving query summary: hdfs://localhost:45801/tmp/tajo-test-history/20150821/query-detail/q_1440129747206_0001/query.hist
2015-08-21 04:02:28,217 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43979 is added to blk_1073748680_7856{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e8bbff5e-864d-40d2-9c47-868b4f4f6f3f:NORMAL:127.0.0.1:43979|FINALIZED]]} size 0
2015-08-21 04:02:28,220 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(372)) - Saving query unit: hdfs://localhost:45801/tmp/tajo-test-history/20150821/query-detail/q_1440129747206_0001/eb_1440129747206_0001_000000.hist
2015-08-21 04:02:28,224 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43979 is added to blk_1073748681_7857{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-873f2aca-9e67-42dc-92ff-b93d3a0fb5cc:NORMAL:127.0.0.1:43979|FINALIZED]]} size 0
2015-08-21 04:02:28,226 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(372)) - Saving query unit: hdfs://localhost:45801/tmp/tajo-test-history/20150821/query-detail/q_1440129747206_0001/eb_1440129747206_0001_000001.hist
2015-08-21 04:02:28,230 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43979 is added to blk_1073748682_7858{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e8bbff5e-864d-40d2-9c47-868b4f4f6f3f:NORMAL:127.0.0.1:43979|RBW]]} size 0
2015-08-21 04:02:28,232 INFO: org.apache.tajo.util.history.HistoryWriter (writeQueryHistory(372)) - Saving query unit: hdfs://localhost:45801/tmp/tajo-test-history/20150821/query-detail/q_1440129747206_0001/eb_1440129747206_0001_000002.hist
2015-08-21 04:02:28,236 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43979 is added to blk_1073748683_7859{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-873f2aca-9e67-42dc-92ff-b93d3a0fb5cc:NORMAL:127.0.0.1:43979|RBW]]} size 0
2015-08-21 04:02:28,258 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-08-21 04:02:28,258 INFO: org.apache.tajo.util.history.HistoryWriter (run(268)) - HistoryWriter_127.0.0.1_28090 stopped.
2015-08-21 04:02:28,260 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748681_7857 127.0.0.1:43979
2015-08-21 04:02:28,260 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748682_7858 127.0.0.1:43979
2015-08-21 04:02:28,260 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748683_7859 127.0.0.1:43979
2015-08-21 04:02:28,261 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748680_7856 127.0.0.1:43979
2015-08-21 04:02:28,262 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: CREATE DATABASE IF NOT EXISTS "TestHistoryWriterReader"
2015-08-21 04:02:28,262 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
CREATE_DATABASE(0) IF NOT EXISTS TestHistoryWriterReader
2015-08-21 04:02:28,262 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-08-21 04:02:28,263 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
CREATE_DATABASE(0) IF NOT EXISTS TestHistoryWriterReader
2015-08-21 04:02:28,263 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(286)) - =============================================
2015-08-21 04:02:28,263 INFO: org.apache.tajo.master.exec.DDLExecutor (createDatabase(247)) - database "TestHistoryWriterReader" is already exists.
2015-08-21 04:02:28,265 INFO: org.apache.tajo.util.history.HistoryWriter (run(224)) - HistoryWriter_127.0.0.1_28090 started.
2015-08-21 04:02:28,265 INFO: org.apache.tajo.util.history.HistoryCleaner (run(62)) - History cleaner started: expiry day=7
2015-08-21 04:02:29,269 INFO: org.apache.tajo.util.history.HistoryWriter (rollingQuerySummaryWriter(425)) - Create query history file: hdfs://localhost:45801/tmp/tajo-test-history/20150821/query-list/query-list-040229.hist
2015-08-21 04:02:29,304 INFO: org.apache.tajo.util.history.HistoryWriter (run(268)) - HistoryWriter_127.0.0.1_28090 stopped.
2015-08-21 04:02:29,308 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43979 is added to blk_1073748684_7860{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e8bbff5e-864d-40d2-9c47-868b4f4f6f3f:NORMAL:127.0.0.1:43979|FINALIZED]]} size 397
2015-08-21 04:02:29,309 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-08-21 04:02:29,310 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748684_7860 127.0.0.1:43979
2015-08-21 04:02:29,311 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(240)) - SQL: CREATE DATABASE IF NOT EXISTS "TestHistoryWriterReader"
2015-08-21 04:02:29,312 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
CREATE_DATABASE(0) IF NOT EXISTS TestHistoryWriterReader
2015-08-21 04:02:29,312 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-08-21 04:02:29,312 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
CREATE_DATABASE(0) IF NOT EXISTS TestHistoryWriterReader
2015-08-21 04:02:29,312 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(286)) - =============================================
2015-08-21 04:02:29,312 INFO: org.apache.tajo.master.exec.DDLExecutor (createDatabase(247)) - database "TestHistoryWriterReader" is already exists.
2015-08-21 04:02:29,314 INFO: org.apache.tajo.util.history.HistoryWriter (run(224)) - HistoryWriter_127.0.0.1_28090 started.
2015-08-21 04:02:29,315 INFO: org.apache.tajo.util.history.HistoryCleaner (run(62)) - History cleaner started: expiry day=7
2015-08-21 04:02:30,320 INFO: org.apache.tajo.util.history.HistoryWriter (rollingQuerySummaryWriter(425)) - Create query history file: hdfs://localhost:45801/tmp/tajo-test-history/20150821/query-list/query-list-040230.hist
2015-08-21 04:02:30,380 INFO: org.apache.tajo.util.history.HistoryWriter (run(268)) - HistoryWriter_127.0.0.1_28090 stopped.
2015-08-21 04:02:30,383 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43979 is added to blk_1073748685_7861{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-873f2aca-9e67-42dc-92ff-b93d3a0fb5cc:NORMAL:127.0.0.1:43979|FINALIZED]]} size 2000
2015-08-21 04:02:30,384 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-08-21 04:02:30,385 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748685_7861 127.0.0.1:43979
2015-08-21 04:02:30,387 INFO: org.apache.tajo.session.SessionManager (removeSession(86)) - Session 00b06ebe-fbee-438e-9231-aabbe5535f33 is removed.
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.231 sec - in org.apache.tajo.util.history.TestHistoryWriterReader
Running org.apache.tajo.util.TestJSPUtil
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 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
2015-08-21 04:02:30,507 INFO: BlockStateChange (invalidateWorkForOneNode(3488)) - BLOCK* BlockManager: ask 127.0.0.1:43979 to delete [blk_1073748680_7856, blk_1073748681_7857, blk_1073748682_7858, blk_1073748683_7859, blk_1073748684_7860, blk_1073748685_7861]
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.131 sec - in org.apache.tajo.storage.TestFileFragment
Running org.apache.tajo.storage.TestRowFile
2015-08-21 04:02:30,534 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43979 is added to blk_1073748686_7862{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-e8bbff5e-864d-40d2-9c47-868b4f4f6f3f:NORMAL:127.0.0.1:43979|FINALIZED]]} size 0
2015-08-21 04:02:30,547 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43979 is added to blk_1073748687_7863{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-873f2aca-9e67-42dc-92ff-b93d3a0fb5cc:NORMAL:127.0.0.1:43979|RBW]]} size 0
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.056 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
2015-08-21 04:02:30,593 INFO: org.mortbay.log (info(67)) - Shutdown hook executing
2015-08-21 04:02:30,593 INFO: org.mortbay.log (info(67)) - Shutdown hook complete
ader initialized will read a total of 2 records.
Aug 21, 2015 3:54:46 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: at row 0. reading next block
Aug 21, 2015 3:54:46 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordReader: block read in memory in 2 ms. row count = 2
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [BIT_PACKED, PLAIN, RLE]
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [BIT_PACKED, PLAIN, RLE]
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [BIT_PACKED, PLAIN, RLE]
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [BIT_PACKED, PLAIN, RLE]
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [BIT_PACKED, PLAIN, RLE]
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 65B for [l_shipdate_function] BINARY: 1 values, 20B raw, 20B comp, 1 pages, encodings: [BIT_PACKED, PLAIN, RLE]
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.InternalParquetRecordWriter: Flushing mem columnStore to file. allocated memory: 26
Aug 21, 2015 3:55:02 AM INFO: org.apache.parquet.hadoop.ColumnChunkPageWriteStore: written 43B for [l_orderkey] INT32: 1 values