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/01/28 08:39:06 UTC

Build failed in Jenkins: Tajo-master-nightly #970

See <https://builds.apache.org/job/Tajo-master-nightly/970/changes>

Changes:

[jihoonson] TAJO-2036: Prevent out of memory in the master server, if the query

[jhkim] TAJO-2065: Increase default heap size.

------------------------------------------
[...truncated 741523 lines...]
2016-01-28 07:38:14,489 INFO: org.apache.tajo.master.TajoMaster (checkAndInitializeSystemDirectories(270)) - Tajo Warehouse dir: hdfs://localhost:55151/tajo/warehouse
2016-01-28 07:38:14,490 INFO: org.apache.tajo.master.TajoMaster (checkAndInitializeSystemDirectories(279)) - Staging dir: hdfs://localhost:55151/tajo/warehouse
2016-01-28 07:38:16,002 INFO: org.apache.tajo.master.rm.TajoResourceManager (serviceInit(97)) - Loaded resource scheduler : class org.apache.tajo.master.scheduler.SimpleScheduler
2016-01-28 07:38:16,017 INFO: org.apache.tajo.rpc.NettyServerBase (start(129)) - Rpc (TajoResourceTrackerProtocol) listens on /127.0.0.1:52909
2016-01-28 07:38:16,017 INFO: org.apache.tajo.master.rm.TajoResourceTracker (serviceInit(99)) - TajoResourceTracker starts up (localhost/127.0.0.1:52909)
2016-01-28 07:38:16,017 INFO: org.apache.tajo.catalog.CatalogServer (serviceInit(125)) - Catalog Store Class: org.apache.tajo.catalog.store.DerbyStore
2016-01-28 07:38:16,018 INFO: org.apache.tajo.catalog.store.DerbyStore (<init>(155)) - Loaded the Catalog driver (org.apache.derby.jdbc.EmbeddedDriver)
2016-01-28 07:38:16,018 INFO: org.apache.tajo.catalog.store.DerbyStore (<init>(161)) - Trying to connect database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core-tests/target/test-data/9ec9f78f-33c9-478b-8b15-0c45f12d02fe/db;create=true)>
2016-01-28 07:38:16,019 INFO: org.apache.tajo.catalog.store.DerbyStore (<init>(163)) - Connected to database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core-tests/target/test-data/9ec9f78f-33c9-478b-8b15-0c45f12d02fe/db;create=true)>
2016-01-28 07:38:16,028 INFO: org.apache.tajo.catalog.store.DerbyStore (<init>(175)) - The meta table of CatalogServer already is created.
2016-01-28 07:38:16,028 INFO: org.apache.tajo.catalog.store.DerbyStore (verifySchemaVersion(279)) - The compatibility of the catalog schema (version: 12) has been verified.
Jan 28, 2016 7:38:16 AM org.glassfish.jersey.server.ApplicationHandler initialize
INFO: Initiating Jersey application, version Jersey: 2.6 2014-02-18 21:52:53...
2016-01-28 07:38:16,186 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceInit(109)) - Tajo Rest Service initialized.
2016-01-28 07:38:16,186 INFO: org.apache.tajo.master.TajoMaster (serviceInit(215)) - Tajo Master is initialized.
2016-01-28 07:38:16,186 INFO: org.apache.tajo.master.TajoMaster (serviceStart(307)) - TajoMaster is starting up
2016-01-28 07:38:16,195 INFO: org.apache.tajo.master.TajoMaster (checkBaseTBSpaceAndDatabase(407)) - Default database (default) is already prepared.
2016-01-28 07:38:16,220 INFO: org.apache.tajo.rpc.NettyServerBase (start(129)) - Rpc (CatalogProtocol) listens on /127.0.0.1:58022
2016-01-28 07:38:16,220 INFO: org.apache.tajo.catalog.CatalogServer (serviceStart(176)) - Catalog Server startup (127.0.0.1:58022)
2016-01-28 07:38:16,243 INFO: org.apache.tajo.rpc.NettyServerBase (start(129)) - Rpc (TajoMasterClientProtocol) listens on /127.0.0.1:45937
2016-01-28 07:38:16,243 INFO: org.apache.tajo.master.TajoMasterClientService (serviceStart(104)) - Instantiated TajoMasterClientService at localhost/127.0.0.1:45937
2016-01-28 07:38:16,246 INFO: org.apache.tajo.rpc.NettyServerBase (start(129)) - Rpc (QueryCoordinatorProtocol) listens on /127.0.0.1:47870
2016-01-28 07:38:16,246 INFO: org.apache.tajo.master.QueryCoordinatorService (serviceStart(70)) - Instantiated TajoMasterService at localhost/127.0.0.1:47870
2016-01-28 07:38:16,248 INFO: org.apache.tajo.rpc.NettyServerBase (start(129)) - Rpc (Tajo-REST) listens on /127.0.0.1:38177
2016-01-28 07:38:16,248 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStart(118)) - Tajo Rest Service started.
2016-01-28 07:38:16,250 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(140)) - No property MASTER.reporters in tajo-metrics.properties
2016-01-28 07:38:16,250 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(140)) - No property MASTER-JVM.reporters in tajo-metrics.properties
2016-01-28 07:38:16,256 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073749138_8314 127.0.0.1:34142 
2016-01-28 07:38:16,259 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 07:38:16,270 INFO: org.apache.tajo.ha.HdfsServiceTracker (createLockFile(224)) - Lock file already exists at (hdfs://localhost:55151/tajo/system/ha/active/active.lock)
2016-01-28 07:38:16,303 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34142 is added to blk_1073749139_8315{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-468f500c-13b8-4093-b850-e41b7adfac3f:NORMAL:127.0.0.1:34142|RBW]]} size 0
2016-01-28 07:38:16,305 INFO: org.apache.tajo.ha.HdfsServiceTracker (register(187)) - This is added to backup master (127.0.0.1:47870)
2016-01-28 07:38:16,317 INFO: org.apache.tajo.util.history.HistoryWriter (run(231)) - HistoryWriter_127.0.0.1_47870 started.
2016-01-28 07:38:16,319 INFO: org.apache.tajo.util.history.HistoryCleaner (run(62)) - History cleaner started: expiry day=7
2016-01-28 07:38:16,356 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session c1f384d8-45dc-4290-9899-45c939160e56 is created.
2016-01-28 07:38:16,362 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: CREATE TABLE default.ha_test1 (age int);
2016-01-28 07:38:16,366 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(281)) - Non Optimized Query: 

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


2016-01-28 07:38:16,366 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - =============================================
2016-01-28 07:38:16,366 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - Optimized Query: 

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


2016-01-28 07:38:16,367 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - =============================================
2016-01-28 07:38:16,371 INFO: org.apache.tajo.catalog.CatalogServer (createTable(688)) - relation "default.ha_test1" is added to the catalog (127.0.0.1:43481)
2016-01-28 07:38:16,371 INFO: org.apache.tajo.master.exec.DDLExecutor (create(112)) - relation 'default.ha_test1' created.
2016-01-28 07:38:16,373 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(177)) - Query: CREATE TABLE default.ha_test2 (age int);
2016-01-28 07:38:16,374 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(281)) - Non Optimized Query: 

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


2016-01-28 07:38:16,374 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - =============================================
2016-01-28 07:38:16,374 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - Optimized Query: 

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


2016-01-28 07:38:16,374 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(285)) - =============================================
2016-01-28 07:38:16,378 INFO: org.apache.tajo.catalog.CatalogServer (createTable(688)) - relation "default.ha_test2" is added to the catalog (127.0.0.1:43481)
2016-01-28 07:38:16,378 INFO: org.apache.tajo.master.exec.DDLExecutor (create(112)) - relation 'default.ha_test2' created.
2016-01-28 07:38:16,380 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session c1f384d8-45dc-4290-9899-45c939160e56 is removed.
2016-01-28 07:38:16,413 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session e1a49182-aaa4-485f-8fed-89cfb927ba3e is created.
2016-01-28 07:38:16,416 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session e1a49182-aaa4-485f-8fed-89cfb927ba3e is removed.
2016-01-28 07:38:16,441 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073749137_8313 127.0.0.1:34142 
2016-01-28 07:38:16,444 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:47663) shutdown
2016-01-28 07:38:16,444 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2016-01-28 07:38:16,448 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:47460) shutdown
2016-01-28 07:38:16,448 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_47460 stopped.
2016-01-28 07:38:16,450 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-01-28 07:38:17,112 INFO: BlockStateChange (invalidateWorkForOneNode(3488)) - BLOCK* BlockManager: ask 127.0.0.1:34142 to delete [blk_1073749137_8313, blk_1073741825_1001, blk_1073749138_8314]
2016-01-28 07:38:17,325 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073749139_8315 127.0.0.1:34142 
2016-01-28 07:38:17,361 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34142 is added to blk_1073749140_8316{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-468f500c-13b8-4093-b850-e41b7adfac3f:NORMAL:127.0.0.1:34142|RBW]]} size 0
2016-01-28 07:38:17,471 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34142 is added to blk_1073749141_8317{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-468f500c-13b8-4093-b850-e41b7adfac3f:NORMAL:127.0.0.1:34142|RBW]]} size 0
2016-01-28 07:38:17,479 INFO: org.apache.tajo.ha.HdfsServiceTracker (register(156)) - This is added to active master (127.0.0.1:47870)
2016-01-28 07:38:18,650 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:57385) shutdown
2016-01-28 07:38:18,651 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(182)) - Catalog Server (127.0.0.1:43481) shutdown
2016-01-28 07:38:18,652 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:43481) shutdown
2016-01-28 07:38:18,652 INFO: org.apache.tajo.catalog.store.DerbyStore (close(2978)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core-tests/target/test-data/9ec9f78f-33c9-478b-8b15-0c45f12d02fe/db;create=true)>
2016-01-28 07:38:18,659 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:58723) shutdown
2016-01-28 07:38:18,660 INFO: org.apache.tajo.master.TajoMaster (serviceStop(424)) - Tajo Master main thread exiting
2016-01-28 07:38:18,679 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session 11b697eb-2412-49a0-94e9-bed2e547621a is created.
2016-01-28 07:38:18,685 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 11b697eb-2412-49a0-94e9-bed2e547621a is removed.
2016-01-28 07:38:18,699 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073749140_8316 127.0.0.1:34142 
2016-01-28 07:38:18,707 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:38177) shutdown
2016-01-28 07:38:18,707 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2016-01-28 07:38:18,715 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_47870 stopped.
2016-01-28 07:38:18,715 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-01-28 07:38:18,720 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:47870) shutdown
2016-01-28 07:38:20,113 INFO: BlockStateChange (invalidateWorkForOneNode(3488)) - BLOCK* BlockManager: ask 127.0.0.1:34142 to delete [blk_1073749139_8315, blk_1073749140_8316]
2016-01-28 07:38:20,939 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:45937) shutdown
2016-01-28 07:38:20,940 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(182)) - Catalog Server (127.0.0.1:58022) shutdown
2016-01-28 07:38:20,941 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:58022) shutdown
2016-01-28 07:38:20,941 INFO: org.apache.tajo.catalog.store.DerbyStore (close(2978)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core-tests/target/test-data/9ec9f78f-33c9-478b-8b15-0c45f12d02fe/db;create=true)>
2016-01-28 07:38:20,943 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:52909) shutdown
2016-01-28 07:38:20,944 INFO: org.apache.tajo.master.TajoMaster (serviceStop(424)) - Tajo Master main thread exiting
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 8.21 sec - in org.apache.tajo.ha.TestHAServiceHDFSImpl
Running org.apache.tajo.parser.sql.TestSQLAnalyzer
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.818 sec - in org.apache.tajo.parser.sql.TestSQLAnalyzer
2016-01-28 07:38:24,777 INFO: org.mortbay.log (info(67)) - Shutdown hook executing
2016-01-28 07:38:24,777 INFO: org.mortbay.log (info(67)) - Shutdown hook complete
2016-01-28 07:38:24,785 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 4958f443-febd-489b-a308-4816d02cb66b is removed.
Jan 28, 2016 7:23:08 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 28, 2016 7:23:09 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 28, 2016 7:23:25 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 28, 2016 7:23:25 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 28, 2016 7:23:25 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 28, 2016 7:23:25 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 28, 2016 7:23:25 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Jan 28, 2016 7:23:27 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
2016-01-28 07:38:24,821 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 631faa45-ffec-429a-bf8e-7ea587928244 is removed.
2016-01-28 07:38:24,828 INFO: org.apache.tajo.worker.TajoWorker (run(518)) - ============================================
2016-01-28 07:38:24,831 INFO: org.apache.tajo.worker.TajoWorker (run(519)) - TajoWorker received SIGINT Signal
2016-01-28 07:38:24,831 INFO: org.apache.tajo.worker.TajoWorker (run(520)) - ============================================
2016-01-28 07:38:24,842 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_asf909.gq1.ygridcore.net_43358 stopped.
2016-01-28 07:38:24,842 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-01-28 07:38:25,073 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(113)) - NodeStatusUpdater stopped.
2016-01-28 07:38:25,073 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(261)) - Heartbeat Thread stopped.
2016-01-28 07:38:25,074 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:43360) shutdown
2016-01-28 07:38:25,075 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped
2016-01-28 07:38:25,075 INFO: org.apache.tajo.querymaster.QueryMaster (run(432)) - QueryMaster heartbeat thread stopped
2016-01-28 07:38:25,076 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(164)) - QueryMaster stopped
2016-01-28 07:38:25,076 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(98)) - TajoWorkerClientService stopping
2016-01-28 07:38:25,077 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:43359) shutdown
2016-01-28 07:38:25,077 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(102)) - TajoWorkerClientService stopped
2016-01-28 07:38:25,078 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:43358) shutdown
2016-01-28 07:38:25,078 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped
2016-01-28 07:38:25,094 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(332)) - TajoWorker main thread exiting
2016-01-28 07:38:27,304 INFO: org.apache.tajo.master.TajoMaster (run(568)) - ============================================
2016-01-28 07:38:27,309 INFO: org.apache.tajo.master.TajoMaster (run(569)) - TajoMaster received SIGINT Signal
2016-01-28 07:38:27,309 INFO: org.apache.tajo.master.TajoMaster (run(570)) - ============================================
2016-01-28 07:38:27,309 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (Tajo-REST) listened on 127.0.0.1:43357) shutdown
2016-01-28 07:38:27,309 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2016-01-28 07:38:27,320 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_43356 stopped.
2016-01-28 07:38:27,328 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34142 is added to blk_1073741857_1033{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-468f500c-13b8-4093-b850-e41b7adfac3f:NORMAL:127.0.0.1:34142|RBW]]} size 731
2016-01-28 07:38:27,332 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:43356) shutdown
2016-01-28 07:38:27,332 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2016-01-28 07:38:29,446 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:43355) shutdown
2016-01-28 07:38:29,446 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(182)) - Catalog Server (127.0.0.1:43354) shutdown
2016-01-28 07:38:29,446 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (CatalogProtocol) listened on 127.0.0.1:43354) shutdown
2016-01-28 07:38:29,447 INFO: org.apache.tajo.catalog.store.DerbyStore (close(2978)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core-tests/target/test-data/9ec9f78f-33c9-478b-8b15-0c45f12d02fe/db;create=true)>
2016-01-28 07:38:29,447 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(172)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:43353) shutdown
2016-01-28 07:38:29,448 INFO: org.apache.tajo.master.TajoMaster (serviceStop(424)) - Tajo Master main thread exiting
2016-01-28 07:38:29,485 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(68)) - Derby shutdown complete normally.
2016-01-28 07:38:29,486 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(75)) - Shutdown database

Results :

Failed tests: 
  TestSimpleScheduler.testReserveResourceWithWorkerPriority:209 null
Tests in error: 
  TestNodeStatusUpdater.setup:117 » Runtime Invalid resource worker memory alloc...
  TestNodeStatusUpdater.setup:117 » Runtime Invalid resource worker memory alloc...
  TestNodeStatusUpdater.setup:117 » Runtime Invalid resource worker memory alloc...
  TestNodeStatusUpdater.setup:117 » Runtime Invalid resource worker memory alloc...
  TestTaskExecutor.setup:129 » Runtime Invalid resource worker memory allocation...
  TestTaskExecutor.setup:129 » Runtime Invalid resource worker memory allocation...

Tests run: 1734, Failures: 1, Errors: 6, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  3.593 s]
[INFO] Tajo Project POM .................................. SUCCESS [  3.416 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  5.560 s]
[INFO] Tajo Common ....................................... SUCCESS [ 48.399 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  4.333 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  9.103 s]
[INFO] Tajo Plan ......................................... SUCCESS [ 12.110 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  1.642 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [02:29 min]
[INFO] Tajo Catalog Client ............................... SUCCESS [  2.393 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [01:15 min]
[INFO] Tajo Storage Common ............................... SUCCESS [  5.347 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [01:51 min]
[INFO] Tajo PullServer ................................... SUCCESS [  1.737 s]
[INFO] Tajo Client ....................................... SUCCESS [  4.247 s]
[INFO] Tajo CLI tools .................................... SUCCESS [  3.301 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [  7.324 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [  4.435 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [  6.804 s]
[INFO] Tajo Metrics ...................................... SUCCESS [  2.096 s]
[INFO] Tajo Core ......................................... SUCCESS [ 15.461 s]
[INFO] Tajo RPC .......................................... SUCCESS [  1.081 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 39.437 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [  0.236 s]
[INFO] Tajo Catalog ...................................... SUCCESS [  1.194 s]
[INFO] Tajo Client Example ............................... SUCCESS [  1.225 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [  7.500 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [  4.461 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 51.449 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [  1.152 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [  2.926 s]
[INFO] Tajo S3 storage ................................... SUCCESS [  0.484 s]
[INFO] Tajo Storage ...................................... SUCCESS [  1.155 s]
[INFO] Tajo Distribution ................................. SUCCESS [  8.884 s]
[INFO] Tajo Core Tests ................................... FAILURE [24:01 min]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 34:00 min
[INFO] Finished at: 2016-01-28T07:38:30+00:00
[INFO] Final Memory: 159M/2036M
[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-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
Recording test results

Jenkins build is back to normal : Tajo-master-nightly #971

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