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/09/29 01:00:53 UTC
Build failed in Jenkins: Tajo-0.11.0-build #77
See <https://builds.apache.org/job/Tajo-0.11.0-build/77/changes>
Changes:
[jihoonson] TAJO-1894: Filter condition is ignored when a query involves multiple subqueries and aggregations.
[jihoonson] TAJO-1889: UndefinedColumnException when a query with table subquery is executed on self-describing tables.
[hyunsik] TAJO-1663: Change the variable name storeType to dataFormat.
------------------------------------------
[...truncated 739137 lines...]
2015-09-28 23:00:27,775 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
CREATE_DATABASE(0) IF NOT EXISTS TestNonForwardQueryResultSystemScanner
2015-09-28 23:00:27,775 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-09-28 23:00:27,776 INFO: org.apache.tajo.master.exec.DDLExecutor (createDatabase(245)) - database "TestNonForwardQueryResultSystemScanner" is already exists.
2015-09-28 23:00:27,777 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(176)) - Query: SELECT TYPE FROM INFORMATION_SCHEMA.CLUSTER
2015-09-28 23:00:27,779 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
PROJECTION(1)
=> Targets: information_schema.cluster.type (TEXT)
=> out schema: {(1) information_schema.cluster.type (TEXT)}
=> in schema: {(11) information_schema.cluster.host (TEXT), information_schema.cluster.port (INT4), information_schema.cluster.type (TEXT), information_schema.cluster.status (TEXT), information_schema.cluster.total_cpu (INT4), information_schema.cluster.used_mem (INT8), information_schema.cluster.total_mem (INT8), information_schema.cluster.used_disk (INT4), information_schema.cluster.total_disk (INT4), information_schema.cluster.running_tasks (INT4), information_schema.cluster.last_heartbeat_ts (TIMESTAMP)}
SCAN(0) on information_schema.cluster
=> target list: information_schema.cluster.host (TEXT), information_schema.cluster.port (INT4), information_schema.cluster.type (TEXT), information_schema.cluster.status (TEXT), information_schema.cluster.total_cpu (INT4), information_schema.cluster.used_mem (INT8), information_schema.cluster.total_mem (INT8), information_schema.cluster.used_disk (INT4), information_schema.cluster.total_disk (INT4), information_schema.cluster.running_tasks (INT4), information_schema.cluster.last_heartbeat_ts (TIMESTAMP)
=> out schema: {(11) information_schema.cluster.host (TEXT), information_schema.cluster.port (INT4), information_schema.cluster.type (TEXT), information_schema.cluster.status (TEXT), information_schema.cluster.total_cpu (INT4), information_schema.cluster.used_mem (INT8), information_schema.cluster.total_mem (INT8), information_schema.cluster.used_disk (INT4), information_schema.cluster.total_disk (INT4), information_schema.cluster.running_tasks (INT4), information_schema.cluster.last_heartbeat_ts (TIMESTAMP)}
=> in schema: {(11) information_schema.cluster.host (TEXT), information_schema.cluster.port (INT4), information_schema.cluster.type (TEXT), information_schema.cluster.status (TEXT), information_schema.cluster.total_cpu (INT4), information_schema.cluster.used_mem (INT8), information_schema.cluster.total_mem (INT8), information_schema.cluster.used_disk (INT4), information_schema.cluster.total_disk (INT4), information_schema.cluster.running_tasks (INT4), information_schema.cluster.last_heartbeat_ts (TIMESTAMP)}
2015-09-28 23:00:27,779 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-09-28 23:00:27,780 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
[LogicalPlan]
> ProjectionNode is eliminated.
-----------------------------
SCAN(0) on information_schema.cluster
=> target list: information_schema.cluster.type (TEXT)
=> out schema: {(1) information_schema.cluster.type (TEXT)}
=> in schema: {(11) information_schema.cluster.host (TEXT), information_schema.cluster.port (INT4), information_schema.cluster.type (TEXT), information_schema.cluster.status (TEXT), information_schema.cluster.total_cpu (INT4), information_schema.cluster.used_mem (INT8), information_schema.cluster.total_mem (INT8), information_schema.cluster.used_disk (INT4), information_schema.cluster.total_disk (INT4), information_schema.cluster.running_tasks (INT4), information_schema.cluster.last_heartbeat_ts (TIMESTAMP)}
2015-09-28 23:00:27,780 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-09-28 23:00:27,780 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(124)) - =========================================================
2015-09-28 23:00:27,780 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(125)) - Stop query:q_1443479771399_2210
2015-09-28 23:00:27,780 INFO: org.apache.tajo.engine.planner.global.GlobalPlanner (build(128)) -
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
[LogicalPlan]
> ProjectionNode is eliminated.
-----------------------------
SCAN(0) on information_schema.cluster
=> target list: information_schema.cluster.type (TEXT)
=> out schema: {(1) information_schema.cluster.type (TEXT)}
=> in schema: {(11) information_schema.cluster.host (TEXT), information_schema.cluster.port (INT4), information_schema.cluster.type (TEXT), information_schema.cluster.status (TEXT), information_schema.cluster.total_cpu (INT4), information_schema.cluster.used_mem (INT8), information_schema.cluster.total_mem (INT8), information_schema.cluster.used_disk (INT4), information_schema.cluster.total_disk (INT4), information_schema.cluster.running_tasks (INT4), information_schema.cluster.last_heartbeat_ts (TIMESTAMP)}
2015-09-28 23:00:27,780 INFO: org.apache.tajo.engine.planner.global.GlobalPlanner (build(157)) -
Non-optimized master plan
-------------------------------------------------------------------------------
Execution Block Graph (TERMINAL - eb_1443479771399_2210_000002)
-------------------------------------------------------------------------------
|-eb_1443479771399_2210_000002
|-eb_1443479771399_2210_000001
-------------------------------------------------------------------------------
Order of Execution
-------------------------------------------------------------------------------
1: eb_1443479771399_2210_000001
2: eb_1443479771399_2210_000002
-------------------------------------------------------------------------------
=======================================================
Block Id: eb_1443479771399_2210_000001 [ROOT]
=======================================================
SCAN(0) on information_schema.cluster
=> target list: information_schema.cluster.type (TEXT)
=> out schema: {(1) information_schema.cluster.type (TEXT)}
=> in schema: {(11) information_schema.cluster.host (TEXT), information_schema.cluster.port (INT4), information_schema.cluster.type (TEXT), information_schema.cluster.status (TEXT), information_schema.cluster.total_cpu (INT4), information_schema.cluster.used_mem (INT8), information_schema.cluster.total_mem (INT8), information_schema.cluster.used_disk (INT4), information_schema.cluster.total_disk (INT4), information_schema.cluster.running_tasks (INT4), information_schema.cluster.last_heartbeat_ts (TIMESTAMP)}
=======================================================
Block Id: eb_1443479771399_2210_000002 [TERMINAL]
=======================================================
2015-09-28 23:00:27,781 INFO: org.apache.tajo.engine.planner.global.GlobalPlanner (build(160)) -
Optimized master plan
-------------------------------------------------------------------------------
Execution Block Graph (TERMINAL - eb_1443479771399_2210_000002)
-------------------------------------------------------------------------------
|-eb_1443479771399_2210_000002
|-eb_1443479771399_2210_000001
-------------------------------------------------------------------------------
Order of Execution
-------------------------------------------------------------------------------
1: eb_1443479771399_2210_000001
2: eb_1443479771399_2210_000002
-------------------------------------------------------------------------------
=======================================================
Block Id: eb_1443479771399_2210_000001 [ROOT]
=======================================================
SCAN(0) on information_schema.cluster
=> target list: information_schema.cluster.type (TEXT)
=> out schema: {(1) information_schema.cluster.type (TEXT)}
=> in schema: {(11) information_schema.cluster.host (TEXT), information_schema.cluster.port (INT4), information_schema.cluster.type (TEXT), information_schema.cluster.status (TEXT), information_schema.cluster.total_cpu (INT4), information_schema.cluster.used_mem (INT8), information_schema.cluster.total_mem (INT8), information_schema.cluster.used_disk (INT4), information_schema.cluster.total_disk (INT4), information_schema.cluster.running_tasks (INT4), information_schema.cluster.last_heartbeat_ts (TIMESTAMP)}
=======================================================
Block Id: eb_1443479771399_2210_000002 [TERMINAL]
=======================================================
2015-09-28 23:00:27,789 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session dbd3bece-d697-4f33-991d-ed298f8e9c30 is removed.
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.089 sec - in org.apache.tajo.master.TestNonForwardQueryResultSystemScanner
Running org.apache.tajo.TestQueryIdFactory
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec - in org.apache.tajo.TestQueryIdFactory
2015-09-28 23:00:27,799 INFO: org.mortbay.log (invoke0(?)) - Shutdown hook executing
2015-09-28 23:00:27,800 INFO: org.mortbay.log (invoke(?)) - Shutdown hook complete
2015-09-28 23:00:27,803 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 63757e29-eafc-4870-b408-81afa5c30f55 is removed.
2015-09-28 23:00:27,806 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 36962fb1-6a99-4e7f-9b3c-e6518579ff84 is removed.
2015-09-28 23:00:27,807 INFO: org.apache.tajo.worker.TajoWorker (run(565)) - ============================================
2015-09-28 23:00:27,807 INFO: org.apache.tajo.worker.TajoWorker (run(566)) - TajoWorker received SIGINT Signal
2015-09-28 23:00:27,807 INFO: org.apache.tajo.worker.TajoWorker (run(567)) - ============================================
2015-09-28 23:00:27,809 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_asf902.gq1.ygridcore.net_38255 stopped.
2015-09-28 23:00:27,809 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-09-28 23:00:27,870 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(115)) - NodeStatusUpdater stopped.
2015-09-28 23:00:27,872 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(265)) - Heartbeat Thread stopped.
2015-09-28 23:00:27,873 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:38257) shutdown
2015-09-28 23:00:27,874 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped
2015-09-28 23:00:27,874 INFO: org.apache.tajo.querymaster.QueryMaster (run(427)) - QueryMaster heartbeat thread stopped
2015-09-28 23:00:27,875 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(162)) - QueryMaster stopped
2015-09-28 23:00:27,875 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(98)) - TajoWorkerClientService stopping
2015-09-28 23:00:27,875 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:38256) shutdown
2015-09-28 23:00:27,876 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(102)) - TajoWorkerClientService stopped
2015-09-28 23:00:27,876 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:38255) shutdown
2015-09-28 23:00:27,876 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped
2015-09-28 23:00:27,876 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(375)) - TajoWorker main thread exiting
2015-09-28 23:00:29,292 INFO: BlockStateChange (invalidateWorkForOneNode(3488)) - BLOCK* BlockManager: ask 127.0.0.1:37622 to delete [blk_1073748685_7861]
2015-09-28 23:00:32,288 INFO: org.apache.tajo.master.TajoMaster (run(580)) - ============================================
2015-09-28 23:00:32,289 INFO: org.apache.tajo.master.TajoMaster (run(581)) - TajoMaster received SIGINT Signal
2015-09-28 23:00:32,289 INFO: org.apache.tajo.master.TajoMaster (run(582)) - ============================================
2015-09-28 23:00:32,289 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (Tajo-REST) listened on 0:0:0:0:0:0:0:0:38254) shutdown
2015-09-28 23:00:32,289 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2015-09-28 23:00:32,291 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_38253 stopped.
2015-09-28 23:00:32,295 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37622 is added to blk_1073741838_1014{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-776fd9c6-696b-4dc8-b9a5-c0d686f28c11:NORMAL:127.0.0.1:37622|RBW]]} size 1479
2015-09-28 23:00:32,297 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-09-28 23:00:32,297 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:38253) shutdown
2015-09-28 23:00:32,298 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:38252) shutdown
2015-09-28 23:00:32,298 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(189)) - Catalog Server (127.0.0.1:38251) shutdown
2015-09-28 23:00:32,299 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:38251) shutdown
2015-09-28 23:00:32,299 INFO: org.apache.tajo.catalog.store.DerbyStore (close(3157)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-0.11.0-build/ws/tajo-core-tests/target/test-data/6029a908-076c-489d-aa05-d6ccaee284e2/db;create=true)>
2015-09-28 23:00:32,301 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:38250) shutdown
2015-09-28 23:00:32,301 INFO: org.apache.tajo.master.TajoMaster (serviceStop(440)) - Tajo Master main thread exiting
2015-09-28 23:00:32,559 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(68)) - Derby shutdown complete normally.
2015-09-28 23:00:32,560 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(75)) - Shutdown database
Results :
Failed tests:
TestQueryOnSelfDescTable.testTableSubquery3:130->QueryTestCaseBase.runSimpleTests:617 Result Verification for: 1 th test expected:<...-------------------
[example glossary,1,null,SGML,ISO 8879:1986
]> but was:<...-------------------
[]>
Tests run: 1689, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Tajo Main ......................................... SUCCESS [ 2.202 s]
[INFO] Tajo Project POM .................................. SUCCESS [ 1.660 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [ 3.499 s]
[INFO] Tajo Common ....................................... SUCCESS [ 40.755 s]
[INFO] Tajo Algebra ...................................... SUCCESS [ 2.767 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [ 5.030 s]
[INFO] Tajo Plan ......................................... SUCCESS [ 6.716 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [ 1.520 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 52.069 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [ 1.459 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 13.596 s]
[INFO] Tajo Storage Common ............................... SUCCESS [ 3.203 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [ 55.028 s]
[INFO] Tajo PullServer ................................... SUCCESS [ 1.260 s]
[INFO] Tajo Client ....................................... SUCCESS [ 2.504 s]
[INFO] Tajo CLI tools .................................... SUCCESS [ 2.387 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [ 5.591 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [ 2.168 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [ 5.023 s]
[INFO] Tajo Metrics ...................................... SUCCESS [ 1.431 s]
[INFO] Tajo Core ......................................... SUCCESS [ 6.648 s]
[INFO] Tajo RPC .......................................... SUCCESS [ 0.967 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 15.906 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [ 0.100 s]
[INFO] Tajo Catalog ...................................... SUCCESS [ 1.001 s]
[INFO] Tajo Client Example ............................... SUCCESS [ 1.116 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [ 4.772 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [ 3.006 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 38.444 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [ 0.918 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [ 1.394 s]
[INFO] Tajo Storage ...................................... SUCCESS [ 1.049 s]
[INFO] Tajo Distribution ................................. SUCCESS [ 5.432 s]
[INFO] Tajo Core Tests ................................... FAILURE [24:32 min]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 29:24 min
[INFO] Finished at: 2015-09-28T23:00:32+00:00
[INFO] Final Memory: 81M/417M
[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-0.11.0-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
Archiving artifacts
Sending artifact delta relative to Tajo-0.11.0-build #74
Archived 1 artifacts
Archive block size is 32768
Received 0 blocks and 59769261 bytes
Compression is 0.0%
Took 44 sec
Updating TAJO-1663
Updating TAJO-1894
Updating TAJO-1889
Jenkins build is back to normal : Tajo-0.11.0-build #79
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Tajo-0.11.0-build/79/changes>
Build failed in Jenkins: Tajo-0.11.0-build #78
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Tajo-0.11.0-build/78/>
------------------------------------------
[...truncated 740111 lines...]
2015-09-28 23:57:54,835 INFO: org.apache.tajo.master.TajoMaster (checkAndInitializeSystemDirectories(283)) - Tajo Warehouse dir: hdfs://localhost:40740/tajo/warehouse
2015-09-28 23:57:54,835 INFO: org.apache.tajo.master.TajoMaster (checkAndInitializeSystemDirectories(292)) - Staging dir: hdfs://localhost:40740/tajo/warehouse
2015-09-28 23:57:55,355 INFO: org.apache.tajo.master.rm.TajoResourceManager (serviceInit(97)) - Loaded resource scheduler : class org.apache.tajo.master.scheduler.SimpleScheduler
2015-09-28 23:57:55,356 INFO: org.apache.tajo.rpc.NettyServerBase (start(130)) - Rpc (TajoResourceTrackerProtocol) listens on /127.0.0.1:46162
2015-09-28 23:57:55,356 INFO: org.apache.tajo.master.rm.TajoResourceTracker (serviceInit(99)) - TajoResourceTracker starts up (localhost/127.0.0.1:46162)
2015-09-28 23:57:55,356 INFO: org.apache.tajo.catalog.CatalogServer (serviceInit(132)) - Catalog Store Class: org.apache.tajo.catalog.store.DerbyStore
2015-09-28 23:57:55,357 INFO: org.apache.tajo.catalog.store.DerbyStore (<init>(156)) - Loaded the Catalog driver (org.apache.derby.jdbc.EmbeddedDriver)
2015-09-28 23:57:55,357 INFO: org.apache.tajo.catalog.store.DerbyStore (<init>(162)) - Trying to connect database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-0.11.0-build/ws/tajo-core-tests/target/test-data/3dd54058-c390-4704-abbf-e6a0d252bbdc/db;create=true)>
2015-09-28 23:57:55,357 INFO: org.apache.tajo.catalog.store.DerbyStore (<init>(164)) - Connected to database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-0.11.0-build/ws/tajo-core-tests/target/test-data/3dd54058-c390-4704-abbf-e6a0d252bbdc/db;create=true)>
2015-09-28 23:57:55,368 INFO: org.apache.tajo.catalog.store.DerbyStore (<init>(176)) - The meta table of CatalogServer already is created.
2015-09-28 23:57:55,368 INFO: org.apache.tajo.catalog.store.DerbyStore (verifySchemaVersion(288)) - The compatibility of the catalog schema (version: 12) has been verified.
Sep 28, 2015 11:57:55 PM org.glassfish.jersey.server.ApplicationHandler initialize
INFO: Initiating Jersey application, version Jersey: 2.6 2014-02-18 21:52:53...
2015-09-28 23:57:55,450 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceInit(109)) - Tajo Rest Service initialized.
2015-09-28 23:57:55,451 INFO: org.apache.tajo.master.TajoMaster (serviceInit(218)) - Tajo Master is initialized.
2015-09-28 23:57:55,451 INFO: org.apache.tajo.master.TajoMaster (serviceStart(320)) - TajoMaster is starting up
2015-09-28 23:57:55,451 INFO: org.apache.tajo.master.TajoMaster (checkBaseTBSpaceAndDatabase(423)) - Default database (default) is already prepared.
2015-09-28 23:57:55,455 INFO: org.apache.tajo.rpc.NettyServerBase (start(130)) - Rpc (CatalogProtocol) listens on /127.0.0.1:58830
2015-09-28 23:57:55,455 INFO: org.apache.tajo.catalog.CatalogServer (serviceStart(183)) - Catalog Server startup (127.0.0.1:58830)
2015-09-28 23:57:55,745 INFO: org.apache.tajo.rpc.NettyServerBase (start(130)) - Rpc (TajoMasterClientProtocol) listens on /127.0.0.1:54454
2015-09-28 23:57:55,745 INFO: org.apache.tajo.master.TajoMasterClientService (serviceStart(108)) - Instantiated TajoMasterClientService at localhost/127.0.0.1:54454
2015-09-28 23:57:55,746 INFO: org.apache.tajo.rpc.NettyServerBase (start(130)) - Rpc (QueryCoordinatorProtocol) listens on /127.0.0.1:60705
2015-09-28 23:57:55,747 INFO: org.apache.tajo.master.QueryCoordinatorService (serviceStart(70)) - Instantiated TajoMasterService at localhost/127.0.0.1:60705
2015-09-28 23:57:55,747 INFO: org.apache.tajo.rpc.NettyServerBase (start(130)) - Rpc (Tajo-REST) listens on /0:0:0:0:0:0:0:0:60396
2015-09-28 23:57:55,748 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStart(118)) - Tajo Rest Service started.
2015-09-28 23:57:55,750 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748689_7865 127.0.0.1:40314
2015-09-28 23:57:55,752 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property MASTER.reporters in tajo-metrics.properties
2015-09-28 23:57:55,753 WARN: org.apache.tajo.util.metrics.TajoSystemMetrics (setMetricsReporter(133)) - No property MASTER-JVM.reporters in tajo-metrics.properties
2015-09-28 23:57:55,756 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
2015-09-28 23:57:55,765 INFO: org.apache.tajo.ha.HdfsServiceTracker (createLockFile(227)) - Lock file already exists at (hdfs://localhost:40740/tajo/system/ha/active/active.lock)
2015-09-28 23:57:55,772 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:40314 is added to blk_1073748690_7866{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-6b3186ba-e4fc-4b7e-8818-e8c2f271238f:NORMAL:127.0.0.1:40314|RBW]]} size 81
2015-09-28 23:57:55,917 INFO: BlockStateChange (invalidateWorkForOneNode(3488)) - BLOCK* BlockManager: ask 127.0.0.1:40314 to delete [blk_1073748689_7865, blk_1073741825_1001]
2015-09-28 23:57:56,175 INFO: org.apache.tajo.ha.HdfsServiceTracker (register(187)) - This is added to backup master (127.0.0.1:60705)
2015-09-28 23:57:56,177 INFO: org.apache.tajo.util.history.HistoryWriter (run(231)) - HistoryWriter_127.0.0.1_60705 started.
2015-09-28 23:57:56,178 INFO: org.apache.tajo.util.history.HistoryCleaner (run(62)) - History cleaner started: expiry day=7
2015-09-28 23:57:56,195 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session 04e349ab-e247-45f2-8110-b7d71df51e1d is created.
2015-09-28 23:57:56,196 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(176)) - Query: CREATE TABLE default.ha_test1 (age int);
2015-09-28 23:57:56,198 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-09-28 23:57:56,198 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-09-28 23:57:56,199 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-09-28 23:57:56,199 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-09-28 23:57:56,203 INFO: org.apache.tajo.catalog.CatalogServer (createTable(690)) - relation "default.ha_test1" is added to the catalog (127.0.0.1:58775)
2015-09-28 23:57:56,204 INFO: org.apache.tajo.master.exec.DDLExecutor (create(114)) - relation 'default.ha_test1' created.
2015-09-28 23:57:56,204 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(176)) - Query: CREATE TABLE default.ha_test2 (age int);
2015-09-28 23:57:56,205 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-09-28 23:57:56,205 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-09-28 23:57:56,205 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query:
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
-----------------------------
2015-09-28 23:57:56,205 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-09-28 23:57:56,210 INFO: org.apache.tajo.catalog.CatalogServer (createTable(690)) - relation "default.ha_test2" is added to the catalog (127.0.0.1:58775)
2015-09-28 23:57:56,210 INFO: org.apache.tajo.master.exec.DDLExecutor (create(114)) - relation 'default.ha_test2' created.
2015-09-28 23:57:56,211 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 04e349ab-e247-45f2-8110-b7d71df51e1d is removed.
2015-09-28 23:57:56,214 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session 7c3b0cd8-4d20-4019-b2a4-fef1650d2d8d is created.
2015-09-28 23:57:56,217 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 7c3b0cd8-4d20-4019-b2a4-fef1650d2d8d is removed.
2015-09-28 23:57:56,219 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748688_7864 127.0.0.1:40314
2015-09-28 23:57:56,221 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (Tajo-REST) listened on 0:0:0:0:0:0:0:0:60704) shutdown
2015-09-28 23:57:56,221 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2015-09-28 23:57:56,222 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_60895 stopped.
2015-09-28 23:57:56,222 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-09-28 23:57:56,222 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:60895) shutdown
2015-09-28 23:57:56,224 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:33741) shutdown
2015-09-28 23:57:56,224 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(189)) - Catalog Server (127.0.0.1:58775) shutdown
2015-09-28 23:57:56,225 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:58775) shutdown
2015-09-28 23:57:56,225 INFO: org.apache.tajo.catalog.store.DerbyStore (close(3157)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-0.11.0-build/ws/tajo-core-tests/target/test-data/3dd54058-c390-4704-abbf-e6a0d252bbdc/db;create=true)>
2015-09-28 23:57:56,225 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:43030) shutdown
2015-09-28 23:57:56,226 INFO: org.apache.tajo.master.TajoMaster (serviceStop(440)) - Tajo Master main thread exiting
2015-09-28 23:57:57,184 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748690_7866 127.0.0.1:40314
2015-09-28 23:57:57,190 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:40314 is added to blk_1073748691_7867{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-1aa54f3a-9636-41e4-97d0-4526e79426bc:NORMAL:127.0.0.1:40314|FINALIZED]]} size 0
2015-09-28 23:57:57,216 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:40314 is added to blk_1073748692_7868{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-6b3186ba-e4fc-4b7e-8818-e8c2f271238f:NORMAL:127.0.0.1:40314|FINALIZED]]} size 0
2015-09-28 23:57:57,218 INFO: org.apache.tajo.ha.HdfsServiceTracker (register(156)) - This is added to active master (127.0.0.1:60705)
2015-09-28 23:57:57,236 INFO: org.apache.tajo.session.SessionManager (createSession(79)) - Session e2ac9391-2719-4368-9420-41bd731b36d1 is created.
2015-09-28 23:57:57,239 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session e2ac9391-2719-4368-9420-41bd731b36d1 is removed.
2015-09-28 23:57:57,245 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073748691_7867 127.0.0.1:40314
2015-09-28 23:57:57,247 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (Tajo-REST) listened on 0:0:0:0:0:0:0:0:60396) shutdown
2015-09-28 23:57:57,248 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2015-09-28 23:57:57,249 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_60705 stopped.
2015-09-28 23:57:57,249 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-09-28 23:57:57,250 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:60705) shutdown
2015-09-28 23:57:57,251 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:54454) shutdown
2015-09-28 23:57:57,251 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(189)) - Catalog Server (127.0.0.1:58830) shutdown
2015-09-28 23:57:57,252 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:58830) shutdown
2015-09-28 23:57:57,252 INFO: org.apache.tajo.catalog.store.DerbyStore (close(3157)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-0.11.0-build/ws/tajo-core-tests/target/test-data/3dd54058-c390-4704-abbf-e6a0d252bbdc/db;create=true)>
2015-09-28 23:57:57,253 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:46162) shutdown
2015-09-28 23:57:57,253 INFO: org.apache.tajo.master.TajoMaster (serviceStop(440)) - Tajo Master main thread exiting
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.448 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: 1.443 sec - in org.apache.tajo.parser.sql.TestSQLAnalyzer
2015-09-28 23:57:58,700 INFO: org.mortbay.log (invoke0(?)) - Shutdown hook executing
2015-09-28 23:57:58,700 INFO: org.mortbay.log (invoke(?)) - Shutdown hook complete
Sep 28, 2015 11:40:56 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 28, 2015 11:40:56 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 28, 2015 11:41:10 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 28, 2015 11:41:10 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 28, 2015 11:41:10 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 28, 2015 11:41:10 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 28, 2015 11:41:10 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 28, 2015 11:41:13 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
2015-09-28 23:57:58,704 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session cb820963-7df2-49b0-be88-b9c51533c0c3 is removed.
2015-09-28 23:57:58,707 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 770eae33-1c2c-4806-9013-a85630fe5a86 is removed.
2015-09-28 23:57:58,709 INFO: org.apache.tajo.worker.TajoWorker (run(565)) - ============================================
2015-09-28 23:57:58,710 INFO: org.apache.tajo.worker.TajoWorker (run(566)) - TajoWorker received SIGINT Signal
2015-09-28 23:57:58,710 INFO: org.apache.tajo.worker.TajoWorker (run(567)) - ============================================
2015-09-28 23:57:58,710 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_asf909.gq1.ygridcore.net_19005 stopped.
2015-09-28 23:57:58,712 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-09-28 23:57:58,768 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(115)) - NodeStatusUpdater stopped.
2015-09-28 23:57:58,768 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(265)) - Heartbeat Thread stopped.
2015-09-28 23:57:58,769 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:19007) shutdown
2015-09-28 23:57:58,769 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped
2015-09-28 23:57:58,769 INFO: org.apache.tajo.querymaster.QueryMaster (run(427)) - QueryMaster heartbeat thread stopped
2015-09-28 23:57:58,770 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(162)) - QueryMaster stopped
2015-09-28 23:57:58,770 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(98)) - TajoWorkerClientService stopping
2015-09-28 23:57:58,771 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:19006) shutdown
2015-09-28 23:57:58,771 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(102)) - TajoWorkerClientService stopped
2015-09-28 23:57:58,771 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:19005) shutdown
2015-09-28 23:57:58,771 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped
2015-09-28 23:57:58,772 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(375)) - TajoWorker main thread exiting
2015-09-28 23:57:58,918 INFO: BlockStateChange (invalidateWorkForOneNode(3488)) - BLOCK* BlockManager: ask 127.0.0.1:40314 to delete [blk_1073748688_7864, blk_1073748690_7866, blk_1073748691_7867]
2015-09-28 23:58:03,181 INFO: org.apache.tajo.master.TajoMaster (run(580)) - ============================================
2015-09-28 23:58:03,182 INFO: org.apache.tajo.master.TajoMaster (run(581)) - TajoMaster received SIGINT Signal
2015-09-28 23:58:03,182 INFO: org.apache.tajo.master.TajoMaster (run(582)) - ============================================
2015-09-28 23:58:03,182 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (Tajo-REST) listened on 0:0:0:0:0:0:0:0:19004) shutdown
2015-09-28 23:58:03,182 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2015-09-28 23:58:03,183 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_19003 stopped.
2015-09-28 23:58:03,186 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:40314 is added to blk_1073741857_1033{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-1aa54f3a-9636-41e4-97d0-4526e79426bc:NORMAL:127.0.0.1:40314|RBW]]} size 731
2015-09-28 23:58:03,187 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:19003) shutdown
2015-09-28 23:58:03,187 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-09-28 23:58:03,187 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:19002) shutdown
2015-09-28 23:58:03,188 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(189)) - Catalog Server (127.0.0.1:19001) shutdown
2015-09-28 23:58:03,188 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:19001) shutdown
2015-09-28 23:58:03,189 INFO: org.apache.tajo.catalog.store.DerbyStore (close(3157)) - Close database (jdbc:derby:memory:<https://builds.apache.org/job/Tajo-0.11.0-build/ws/tajo-core-tests/target/test-data/3dd54058-c390-4704-abbf-e6a0d252bbdc/db;create=true)>
2015-09-28 23:58:03,189 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:19000) shutdown
2015-09-28 23:58:03,189 INFO: org.apache.tajo.master.TajoMaster (serviceStop(440)) - Tajo Master main thread exiting
2015-09-28 23:58:03,421 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(68)) - Derby shutdown complete normally.
2015-09-28 23:58:03,421 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(75)) - Shutdown database
Results :
Failed tests:
TestQueryOnSelfDescTable.testTableSubquery3:130->QueryTestCaseBase.runSimpleTests:617 Result Verification for: 1 th test expected:<...-------------------
[example glossary,1,null,SGML,ISO 8879:1986
]> but was:<...-------------------
[]>
Tests run: 1689, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Tajo Main ......................................... SUCCESS [ 1.955 s]
[INFO] Tajo Project POM .................................. SUCCESS [ 1.298 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [ 3.312 s]
[INFO] Tajo Common ....................................... SUCCESS [ 40.210 s]
[INFO] Tajo Algebra ...................................... SUCCESS [ 2.648 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [ 5.007 s]
[INFO] Tajo Plan ......................................... SUCCESS [ 6.509 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [ 1.467 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 52.040 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [ 1.622 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [01:08 min]
[INFO] Tajo Storage Common ............................... SUCCESS [ 2.930 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [01:06 min]
[INFO] Tajo PullServer ................................... SUCCESS [ 1.102 s]
[INFO] Tajo Client ....................................... SUCCESS [ 3.010 s]
[INFO] Tajo CLI tools .................................... SUCCESS [ 3.046 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [ 5.676 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [ 2.507 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [ 4.228 s]
[INFO] Tajo Metrics ...................................... SUCCESS [ 1.547 s]
[INFO] Tajo Core ......................................... SUCCESS [ 9.386 s]
[INFO] Tajo RPC .......................................... SUCCESS [ 0.968 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 37.653 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [ 0.119 s]
[INFO] Tajo Catalog ...................................... SUCCESS [ 1.135 s]
[INFO] Tajo Client Example ............................... SUCCESS [ 1.178 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [ 5.333 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [ 3.686 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 39.559 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [ 1.005 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [ 1.502 s]
[INFO] Tajo Storage ...................................... SUCCESS [ 1.063 s]
[INFO] Tajo Distribution ................................. SUCCESS [ 5.503 s]
[INFO] Tajo Core Tests ................................... FAILURE [25:15 min]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 31:40 min
[INFO] Finished at: 2015-09-28T23:58:03+00:00
[INFO] Final Memory: 82M/457M
[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-0.11.0-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
Archiving artifacts
Sending artifact delta relative to Tajo-0.11.0-build #74
Archived 1 artifacts
Archive block size is 32768
Received 0 blocks and 59767984 bytes
Compression is 0.0%
Took 18 sec