See <https://builds.apache.org/job/Tajo-master-build/1070/>
------------------------------------------
[...truncated 739622 lines...]
2016-01-28 08:58:38,571 INFO: org.apache.tajo.rpc.NettyServerBase (start(129))
- Rpc (QueryCoordinatorProtocol) listens on /127.0.0.1:59597
2016-01-28 08:58:38,571 INFO: org.apache.tajo.master.QueryCoordinatorService
(serviceStart(70)) - Instantiated TajoMasterService at localhost/127.0.0.1:59597
2016-01-28 08:58:38,572 INFO: org.apache.tajo.rpc.NettyServerBase (start(129))
- Rpc (Tajo-REST) listens on /127.0.0.1:34499
2016-01-28 08:58:38,572 INFO: org.apache.tajo.ws.rs.TajoRestService
(serviceStart(118)) - Tajo Rest Service started.
2016-01-28 08:58:38,574 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics
(setMetricsReporter(140)) - No property MASTER.reporters in
tajo-metrics.properties
2016-01-28 08:58:38,575 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics
(setMetricsReporter(140)) - No property MASTER-JVM.reporters in
tajo-metrics.properties
2016-01-28 08:58:38,579 INFO: BlockStateChange (addToInvalidates(1106)) -
BLOCK* addToInvalidates: blk_1073741825_1001 127.0.0.1:55568
2016-01-28 08:58:38,589 INFO: org.apache.tajo.ha.HdfsServiceTracker
(initSystemDirectory(91)) - System HA dir
'hdfs://localhost:33678/tajo/system/ha' is created
2016-01-28 08:58:38,590 INFO: org.apache.tajo.ha.HdfsServiceTracker
(initSystemDirectory(97)) - System HA Active dir
'hdfs://localhost:33678/tajo/system/ha/active' is created
2016-01-28 08:58:38,591 INFO: org.apache.tajo.ha.HdfsServiceTracker
(initSystemDirectory(103)) - System HA Backup dir
'hdfs://localhost:33678/tajo/system/ha/backup' is created
2016-01-28 08:58:38,598 INFO: BlockStateChange (logAddStoredBlock(2624)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:55568 is added to
blk_1073749133_8309{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-93ab4938-430e-4765-bcab-d6e743be2736:NORMAL:127.0.0.1:55568|RBW]]}
size 0
2016-01-28 08:58:38,618 INFO: BlockStateChange (logAddStoredBlock(2624)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:55568 is added to
blk_1073749134_8310{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-93ab4938-430e-4765-bcab-d6e743be2736:NORMAL:127.0.0.1:55568|RBW]]}
size 0
2016-01-28 08:58:38,620 INFO: org.apache.tajo.ha.HdfsServiceTracker
(register(156)) - This is added to active master (127.0.0.1:59597)
2016-01-28 08:58:38,621 INFO: org.apache.tajo.util.history.HistoryWriter
(run(231)) - HistoryWriter_127.0.0.1_59597 started.
2016-01-28 08:58:38,621 INFO: org.apache.tajo.util.history.HistoryCleaner
(run(62)) - History cleaner started: expiry day=7
2016-01-28 08:58:38,621 INFO: org.apache.tajo.master.TajoMaster
(checkAndInitializeSystemDirectories(245)) - Tajo Root Directory:
hdfs://localhost:33678/tajo
2016-01-28 08:58:38,621 INFO: org.apache.tajo.master.TajoMaster
(checkAndInitializeSystemDirectories(250)) - FileSystem
(hdfs://localhost:33678) is initialized.
2016-01-28 08:58:38,623 INFO: org.apache.tajo.master.TajoMaster
(checkAndInitializeSystemDirectories(270)) - Tajo Warehouse dir:
hdfs://localhost:33678/tajo/warehouse
2016-01-28 08:58:38,623 INFO: org.apache.tajo.master.TajoMaster
(checkAndInitializeSystemDirectories(279)) - Staging dir:
hdfs://localhost:33678/tajo/warehouse
2016-01-28 08:58:39,105 INFO: org.apache.tajo.master.rm.TajoResourceManager
(serviceInit(97)) - Loaded resource scheduler : class
org.apache.tajo.master.scheduler.SimpleScheduler
2016-01-28 08:58:39,106 INFO: org.apache.tajo.rpc.NettyServerBase (start(129))
- Rpc (TajoResourceTrackerProtocol) listens on /127.0.0.1:44008
2016-01-28 08:58:39,107 INFO: org.apache.tajo.master.rm.TajoResourceTracker
(serviceInit(99)) - TajoResourceTracker starts up (localhost/127.0.0.1:44008)
2016-01-28 08:58:39,107 INFO: org.apache.tajo.catalog.CatalogServer
(serviceInit(125)) - Catalog Store Class:
org.apache.tajo.catalog.store.DerbyStore
2016-01-28 08:58:39,107 INFO: org.apache.tajo.catalog.store.DerbyStore
(<init>(155)) - Loaded the Catalog driver (org.apache.derby.jdbc.EmbeddedDriver)
2016-01-28 08:58:39,107 INFO: org.apache.tajo.catalog.store.DerbyStore
(<init>(161)) - Trying to connect database
(jdbc:derby:memory:<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/906174e6-1091-474d-9fa9-8b76e7e509c9/db;create=true)>
2016-01-28 08:58:39,107 INFO: org.apache.tajo.catalog.store.DerbyStore
(<init>(163)) - Connected to database
(jdbc:derby:memory:<https://builds.apache.org/job/Tajo-master-build/ws/tajo-core-tests/target/test-data/906174e6-1091-474d-9fa9-8b76e7e509c9/db;create=true)>
2016-01-28 08:58:39,113 INFO: org.apache.tajo.catalog.store.DerbyStore
(<init>(175)) - The meta table of CatalogServer already is created.
2016-01-28 08:58:39,114 INFO: org.apache.tajo.catalog.store.DerbyStore
(verifySchemaVersion(279)) - The compatibility of the catalog schema (version:
12) has been verified.
Jan 28, 2016 8:58:39 AM org.glassfish.jersey.server.ApplicationHandler
initialize
INFO: Initiating Jersey application, version Jersey: 2.6 2014-02-18 21:52:53...
2016-01-28 08:58:39,175 INFO: org.apache.tajo.ws.rs.TajoRestService
(serviceInit(109)) - Tajo Rest Service initialized.
2016-01-28 08:58:39,175 INFO: org.apache.tajo.master.TajoMaster
(serviceInit(215)) - Tajo Master is initialized.
2016-01-28 08:58:39,175 INFO: org.apache.tajo.master.TajoMaster
(serviceStart(307)) - TajoMaster is starting up
2016-01-28 08:58:39,176 INFO: org.apache.tajo.master.TajoMaster
(checkBaseTBSpaceAndDatabase(407)) - Default database (default) is already
prepared.
2016-01-28 08:58:39,179 INFO: org.apache.tajo.rpc.NettyServerBase (start(129))
- Rpc (CatalogProtocol) listens on /127.0.0.1:53419
2016-01-28 08:58:39,180 INFO: org.apache.tajo.catalog.CatalogServer
(serviceStart(176)) - Catalog Server startup (127.0.0.1:53419)
2016-01-28 08:58:39,182 INFO: org.apache.tajo.rpc.NettyServerBase (start(129))
- Rpc (TajoMasterClientProtocol) listens on /127.0.0.1:44024
2016-01-28 08:58:39,182 INFO: org.apache.tajo.master.TajoMasterClientService
(serviceStart(104)) - Instantiated TajoMasterClientService at
localhost/127.0.0.1:44024
2016-01-28 08:58:39,183 INFO: org.apache.tajo.rpc.NettyServerBase (start(129))
- Rpc (QueryCoordinatorProtocol) listens on /127.0.0.1:55074
2016-01-28 08:58:39,183 INFO: org.apache.tajo.master.QueryCoordinatorService
(serviceStart(70)) - Instantiated TajoMasterService at localhost/127.0.0.1:55074
2016-01-28 08:58:39,183 INFO: org.apache.tajo.rpc.NettyServerBase (start(129))
- Rpc (Tajo-REST) listens on /127.0.0.1:41491
2016-01-28 08:58:39,184 INFO: org.apache.tajo.ws.rs.TajoRestService
(serviceStart(118)) - Tajo Rest Service started.
2016-01-28 08:58:39,185 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics
(setMetricsReporter(140)) - No property MASTER.reporters in
tajo-metrics.properties
2016-01-28 08:58:39,189 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics
(setMetricsReporter(140)) - No property MASTER-JVM.reporters in
tajo-metrics.properties
2016-01-28 08:58:39,193 INFO: BlockStateChange (addToInvalidates(1106)) -
BLOCK* addToInvalidates: blk_1073749134_8310 127.0.0.1:55568
2016-01-28 08:58:39,196 WARN: org.apache.hadoop.hdfs.StateChange
(startFileInternal(2602)) - DIR* NameSystem.startFile:
/tajo/system/ha/active/active.lock /tajo/system/ha/active/active.lock for
client 127.0.0.1 already exists
2016-01-28 08:58:39,205 INFO: org.apache.tajo.ha.HdfsServiceTracker
(createLockFile(224)) - Lock file already exists at
(hdfs://localhost:33678/tajo/system/ha/active/active.lock)
2016-01-28 08:58:39,212 INFO: BlockStateChange (logAddStoredBlock(2624)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:55568 is added to
blk_1073749135_8311{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-93ab4938-430e-4765-bcab-d6e743be2736:NORMAL:127.0.0.1:55568|RBW]]}
size 0
2016-01-28 08:58:39,213 INFO: org.apache.tajo.ha.HdfsServiceTracker
(register(187)) - This is added to backup master (127.0.0.1:55074)
2016-01-28 08:58:39,214 INFO: org.apache.tajo.util.history.HistoryWriter
(run(231)) - HistoryWriter_127.0.0.1_55074 started.
2016-01-28 08:58:39,214 INFO: org.apache.tajo.util.history.HistoryCleaner
(run(62)) - History cleaner started: expiry day=7
2016-01-28 08:58:39,227 INFO: org.apache.tajo.session.SessionManager
(createSession(79)) - Session 70eaa9a0-7982-4301-b7d2-c8a3a4258df1 is created.
2016-01-28 08:58:39,228 INFO: org.apache.tajo.master.GlobalEngine
(executeQuery(177)) - Query: CREATE TABLE default.ha_test1 (age int);
2016-01-28 08:58:39,229 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(281)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2016-01-28 08:58:39,229 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(283)) - =============================================
2016-01-28 08:58:39,230 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(284)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2016-01-28 08:58:39,230 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(285)) - =============================================
2016-01-28 08:58:39,233 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(688)) - relation "default.ha_test1" is added to the catalog
(127.0.0.1:48240)
2016-01-28 08:58:39,234 INFO: org.apache.tajo.master.exec.DDLExecutor
(create(112)) - relation 'default.ha_test1' created.
2016-01-28 08:58:39,234 INFO: org.apache.tajo.master.GlobalEngine
(executeQuery(177)) - Query: CREATE TABLE default.ha_test2 (age int);
2016-01-28 08:58:39,234 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(281)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2016-01-28 08:58:39,235 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(283)) - =============================================
2016-01-28 08:58:39,235 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(284)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2016-01-28 08:58:39,235 INFO: org.apache.tajo.master.GlobalEngine
(createLogicalPlan(285)) - =============================================
2016-01-28 08:58:39,239 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(688)) - relation "default.ha_test2" is added to the catalog
(127.0.0.1:48240)
2016-01-28 08:58:39,239 INFO: org.apache.tajo.master.exec.DDLExecutor
(create(112)) - relation 'default.ha_test2' created.
2016-01-28 08:58:39,239 INFO: org.apache.tajo.session.SessionManager
(removeSession(85)) - Session 70eaa9a0-7982-4301-b7d2-c8a3a4258df1 is removed.
2016-01-28 08:58:39,242 INFO: org.apache.tajo.session.SessionManager
(createSession(79)) - Session 52f83a6c-af02-4785-90b4-ad23234b92dc is created.
2016-01-28 08:58:39,244 INFO: org.apache.tajo.session.SessionManager
(removeSession(85)) - Session 52f83a6c-af02-4785-90b4-ad23234b92dc is removed.
2016-01-28 08:58:39,246 INFO: BlockStateChange (addToInvalidates(1106)) -
BLOCK* addToInvalidates: blk_1073749133_8309 127.0.0.1:55568
2016-01-28 08:58:39,248 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:34499) shutdown
2016-01-28 08:58:39,248 INFO: org.apache.tajo.ws.rs.TajoRestService
(serviceStop(129)) - Tajo Rest Service stopped.
2016-01-28 08:58:39,250 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:59597)
shutdown
2016-01-28 08:58:39,250 INFO: org.apache.tajo.util.history.HistoryWriter
(run(275)) - HistoryWriter_127.0.0.1_59597 stopped.
2016-01-28 08:58:39,250 INFO: org.apache.tajo.util.history.HistoryCleaner
(run(136)) - History cleaner stopped
2016-01-28 08:58:40,221 INFO: BlockStateChange (addToInvalidates(1106)) -
BLOCK* addToInvalidates: blk_1073749135_8311 127.0.0.1:55568
2016-01-28 08:58:40,226 INFO: BlockStateChange (logAddStoredBlock(2624)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:55568 is added to
blk_1073749136_8312{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-93ab4938-430e-4765-bcab-d6e743be2736:NORMAL:127.0.0.1:55568|RBW]]}
size 81
2016-01-28 08:58:40,644 INFO: BlockStateChange (logAddStoredBlock(2624)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:55568 is added to
blk_1073749137_8313{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-93ab4938-430e-4765-bcab-d6e743be2736:NORMAL:127.0.0.1:55568|RBW]]}
size 0
2016-01-28 08:58:40,647 INFO: org.apache.tajo.ha.HdfsServiceTracker
(register(156)) - This is added to active master (127.0.0.1:55074)
2016-01-28 08:58:41,387 INFO: BlockStateChange (invalidateWorkForOneNode(3488))
- BLOCK* BlockManager: ask 127.0.0.1:55568 to delete [blk_1073741825_1001,
blk_1073749133_8309, blk_1073749134_8310, blk_1073749135_8311]
2016-01-28 08:58:41,453 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:48563)
shutdown
2016-01-28 08:58:41,453 INFO: org.apache.tajo.catalog.CatalogServer
(serviceStop(182)) - Catalog Server (127.0.0.1:48240) shutdown
2016-01-28 08:58:41,453 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:48240) shutdown
2016-01-28 08:58:41,455 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/906174e6-1091-474d-9fa9-8b76e7e509c9/db;create=true)>
2016-01-28 08:58:41,455 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on
127.0.0.1:53586) shutdown
2016-01-28 08:58:41,456 INFO: org.apache.tajo.master.TajoMaster
(serviceStop(424)) - Tajo Master main thread exiting
2016-01-28 08:58:41,463 INFO: org.apache.tajo.session.SessionManager
(createSession(79)) - Session a09bfefb-29b6-40ec-839f-b2fd6b9f3edc is created.
2016-01-28 08:58:41,466 INFO: org.apache.tajo.session.SessionManager
(removeSession(85)) - Session a09bfefb-29b6-40ec-839f-b2fd6b9f3edc is removed.
2016-01-28 08:58:41,470 INFO: BlockStateChange (addToInvalidates(1106)) -
BLOCK* addToInvalidates: blk_1073749136_8312 127.0.0.1:55568
2016-01-28 08:58:41,472 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:41491) shutdown
2016-01-28 08:58:41,472 INFO: org.apache.tajo.ws.rs.TajoRestService
(serviceStop(129)) - Tajo Rest Service stopped.
2016-01-28 08:58:41,473 INFO: org.apache.tajo.util.history.HistoryCleaner
(run(136)) - History cleaner stopped
2016-01-28 08:58:41,473 INFO: org.apache.tajo.util.history.HistoryWriter
(run(275)) - HistoryWriter_127.0.0.1_55074 stopped.
2016-01-28 08:58:41,476 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:55074)
shutdown
2016-01-28 08:58:43,678 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:44024)
shutdown
2016-01-28 08:58:43,679 INFO: org.apache.tajo.catalog.CatalogServer
(serviceStop(182)) - Catalog Server (127.0.0.1:53419) shutdown
2016-01-28 08:58:43,679 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:53419) shutdown
2016-01-28 08:58:43,680 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/906174e6-1091-474d-9fa9-8b76e7e509c9/db;create=true)>
2016-01-28 08:58:43,680 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on
127.0.0.1:44008) shutdown
2016-01-28 08:58:43,680 INFO: org.apache.tajo.master.TajoMaster
(serviceStop(424)) - Tajo Master main thread exiting
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.684 sec - in
org.apache.tajo.ha.TestHAServiceHDFSImpl
Running org.apache.tajo.TestTajoIds
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec - in
org.apache.tajo.TestTajoIds
2016-01-28 08:58:43,690 INFO: org.mortbay.log (info(67)) - Shutdown hook
executing
2016-01-28 08:58:43,690 INFO: org.mortbay.log (info(67)) - Shutdown hook
complete
2016-01-28 08:58:43,700 INFO: org.apache.tajo.session.SessionManager
(removeSession(85)) - Session 28ae5974-f56d-4f3c-9781-32157db44f73 is removed.
2016-01-28 08:58:43,705 INFO: org.apache.tajo.session.SessionManager
(removeSession(85)) - Session 9b9a0043-32ce-47ad-b89c-4ac72a3ac808 is removed.
2016-01-28 08:58:43,707 INFO: org.apache.tajo.worker.TajoWorker (run(518)) -
============================================
2016-01-28 08:58:43,707 INFO: org.apache.tajo.worker.TajoWorker (run(519)) -
TajoWorker received SIGINT Signal
2016-01-28 08:58:43,707 INFO: org.apache.tajo.worker.TajoWorker (run(520)) -
============================================
2016-01-28 08:58:43,709 INFO: org.apache.tajo.util.history.HistoryWriter
(run(275)) - HistoryWriter_asf907.gq1.ygridcore.net_42684 stopped.
2016-01-28 08:58:43,710 INFO: org.apache.tajo.util.history.HistoryCleaner
(run(136)) - History cleaner stopped
2016-01-28 08:58:43,742 INFO: org.apache.tajo.worker.NodeStatusUpdater
(serviceStop(113)) - NodeStatusUpdater stopped.
2016-01-28 08:58:43,742 INFO: org.apache.tajo.worker.NodeStatusUpdater
(run(261)) - Heartbeat Thread stopped.
2016-01-28 08:58:43,742 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:42686)
shutdown
2016-01-28 08:58:43,745 INFO:
org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) -
QueryMasterManagerService stopped
2016-01-28 08:58:43,745 INFO: org.apache.tajo.querymaster.QueryMaster
(run(432)) - QueryMaster heartbeat thread stopped
2016-01-28 08:58:43,746 INFO: org.apache.tajo.querymaster.QueryMaster
(serviceStop(164)) - QueryMaster stopped
2016-01-28 08:58:43,746 INFO: org.apache.tajo.worker.TajoWorkerClientService
(stop(98)) - TajoWorkerClientService stopping
2016-01-28 08:58:43,746 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (QueryMasterClientProtocol) listened on
0:0:0:0:0:0:0:0:42685) shutdown
2016-01-28 08:58:43,746 INFO: org.apache.tajo.worker.TajoWorkerClientService
(stop(102)) - TajoWorkerClientService stopped
2016-01-28 08:58:43,747 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:42684)
shutdown
2016-01-28 08:58:43,747 INFO: org.apache.tajo.worker.TajoWorkerManagerService
(serviceStop(93)) - TajoWorkerManagerService stopped
2016-01-28 08:58:43,747 INFO: org.apache.tajo.worker.TajoWorker
(serviceStop(332)) - TajoWorker main thread exiting
2016-01-28 08:58:44,387 INFO: BlockStateChange (invalidateWorkForOneNode(3488))
- BLOCK* BlockManager: ask 127.0.0.1:55568 to delete [blk_1073749136_8312]
2016-01-28 08:58:45,953 INFO: org.apache.tajo.master.TajoMaster (run(568)) -
============================================
2016-01-28 08:58:45,954 INFO: org.apache.tajo.master.TajoMaster (run(569)) -
TajoMaster received SIGINT Signal
2016-01-28 08:58:45,954 INFO: org.apache.tajo.master.TajoMaster (run(570)) -
============================================
2016-01-28 08:58:45,955 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:42683) shutdown
2016-01-28 08:58:45,955 INFO: org.apache.tajo.ws.rs.TajoRestService
(serviceStop(129)) - Tajo Rest Service stopped.
2016-01-28 08:58:45,961 INFO: org.apache.tajo.util.history.HistoryWriter
(run(275)) - HistoryWriter_127.0.0.1_42682 stopped.
2016-01-28 08:58:45,963 INFO: BlockStateChange (logAddStoredBlock(2624)) -
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:55568 is added to
blk_1073741834_1010{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-93ab4938-430e-4765-bcab-d6e743be2736:NORMAL:127.0.0.1:55568|RBW]]}
size 524
2016-01-28 08:58:45,963 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:42682)
shutdown
2016-01-28 08:58:45,964 INFO: org.apache.tajo.util.history.HistoryCleaner
(run(136)) - History cleaner stopped
2016-01-28 08:58:48,067 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:42681)
shutdown
2016-01-28 08:58:48,068 INFO: org.apache.tajo.catalog.CatalogServer
(serviceStop(182)) - Catalog Server (127.0.0.1:42680) shutdown
2016-01-28 08:58:48,068 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:42680) shutdown
2016-01-28 08:58:48,068 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/906174e6-1091-474d-9fa9-8b76e7e509c9/db;create=true)>
2016-01-28 08:58:48,069 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on
127.0.0.1:42679) shutdown
2016-01-28 08:58:48,070 INFO: org.apache.tajo.master.TajoMaster
(serviceStop(424)) - Tajo Master main thread exiting
2016-01-28 08:58:48,129 INFO: org.apache.tajo.catalog.store.DerbyStore
(shutdown(68)) - Derby shutdown complete normally.
2016-01-28 08:58:48,129 INFO: org.apache.tajo.catalog.store.DerbyStore
(shutdown(75)) - Shutdown database
Results :
Tests in error:
TestJoinOnPartitionedTables.testPartialFilterPushDown:95->QueryTestCaseBase.runSimpleTests:622
ยป UndefinedTable
Tests run: 1734, Failures: 0, Errors: 1, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Tajo Main ......................................... SUCCESS [ 1.624 s]
[INFO] Tajo Project POM .................................. SUCCESS [ 1.537 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [ 2.972 s]
[INFO] Tajo Common ....................................... SUCCESS [ 30.748 s]
[INFO] Tajo Algebra ...................................... SUCCESS [ 2.763 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [ 5.270 s]
[INFO] Tajo Plan ......................................... SUCCESS [ 7.156 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [ 1.202 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [02:26 min]
[INFO] Tajo Catalog Client ............................... SUCCESS [ 1.389 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 10.613 s]
[INFO] Tajo Storage Common ............................... SUCCESS [ 2.972 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [ 57.245 s]
[INFO] Tajo PullServer ................................... SUCCESS [ 0.860 s]
[INFO] Tajo Client ....................................... SUCCESS [ 2.633 s]
[INFO] Tajo CLI tools .................................... SUCCESS [ 1.960 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [ 3.694 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [ 1.825 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [ 3.747 s]
[INFO] Tajo Metrics ...................................... SUCCESS [ 1.714 s]
[INFO] Tajo Core ......................................... SUCCESS [ 6.711 s]
[INFO] Tajo RPC .......................................... SUCCESS [ 0.924 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 9.515 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [ 0.078 s]
[INFO] Tajo Catalog ...................................... SUCCESS [ 0.973 s]
[INFO] Tajo Client Example ............................... SUCCESS [ 1.037 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [ 3.672 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [ 2.738 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 33.388 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [ 0.838 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [ 0.824 s]
[INFO] Tajo S3 storage ................................... SUCCESS [ 0.276 s]
[INFO] Tajo Storage ...................................... SUCCESS [ 0.976 s]
[INFO] Tajo Distribution ................................. SUCCESS [ 5.317 s]
[INFO] Tajo Core Tests ................................... FAILURE [21:44 min]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 27:40 min
[INFO] Finished at: 2016-01-28T08:58:48+00:00
[INFO] Final Memory: 151M/1975M
[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
