See <https://builds.apache.org/job/Tajo-master-nightly/704/changes>
Changes:
[hyunsik] initial work for TAJO-1591.
[hyunsik] Fixed some literal string to constants.
[hyunsik] Add error log message to exception.
[hyunsik] TAJO-1359: Add nested field projector and language extension to
project nested record. (hyunsik)
------------------------------------------
[...truncated 404311 lines...]
=======================================================
[Incoming]
[q_1431397714678_0000] 1 => 3 (type=HASH_SHUFFLE, key=default.large1.large1_id
(INT4), num=32)
[q_1431397714678_0000] 2 => 3 (type=HASH_SHUFFLE, key=default.large2.large2_id
(INT4), num=32)
[Outgoing]
[q_1431397714678_0000] 3 => 4 (type=HASH_SHUFFLE, key=, num=1)
GROUP_BY(10)()
=> exprs: (count())
=> target list: ?count_3 (INT8)
=> out schema:{(1) ?count_3 (INT8)}
=> in schema:{(0) }
JOIN(6)(INNER)
=> Join Cond: default.large1.large1_id (INT4) = default.large2.large2_id
(INT4)
=> target list:
=> out schema: {(0) }
=> in schema: {(2) default.large1.large1_id (INT4),
default.large2.large2_id (INT4)}
SCAN(9) on eb_1431397714678_0000_000002
=> out schema: {(1) default.large2.large2_id (INT4)}
=> in schema: {(1) default.large2.large2_id (INT4)}
SCAN(8) on eb_1431397714678_0000_000001
=> out schema: {(1) default.large1.large1_id (INT4)}
=> in schema: {(1) default.large1.large1_id (INT4)}
=======================================================
Block Id: eb_1431397714678_0000_000004 [ROOT]
=======================================================
[Incoming]
[q_1431397714678_0000] 3 => 4 (type=HASH_SHUFFLE, key=, num=1)
GROUP_BY(4)()
=> exprs: (count(?count_3 (INT8)))
=> target list: ?count (INT8)
=> out schema:{(1) ?count (INT8)}
=> in schema:{(1) ?count_3 (INT8)}
SCAN(11) on eb_1431397714678_0000_000003
=> out schema: {(1) ?count_3 (INT8)}
=> in schema: {(1) ?count_3 (INT8)}
=======================================================
Block Id: eb_1431397714678_0000_000005 [TERMINAL]
=======================================================
2015-05-12 02:28:34,680 INFO: org.apache.tajo.catalog.CatalogServer (stop(196))
- Catalog Server (127.0.0.1:17906) shutdown
2015-05-12 02:28:34,681 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:17906) shutdown
2015-05-12 02:28:34,726 INFO: org.apache.tajo.TajoTestingCluster
(startCatalogCluster(304)) - Apache Derby repository is set to
jdbc:derby:<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core/target/test-data/8528a3de-f9d0-4a0d-8bcc-645a98320fcc/db>
2015-05-12 02:28:34,726 INFO: org.apache.tajo.catalog.CatalogServer
(serviceInit(131)) - Catalog Store Class: org.apache.tajo.catalog.store.MemStore
2015-05-12 02:28:34,727 INFO: org.apache.tajo.rpc.RpcChannelFactory
(createServerChannelFactory(141)) - Create CatalogProtocol-80
ServerSocketChannelFactory. Worker:2
2015-05-12 02:28:34,729 INFO: org.apache.tajo.rpc.NettyServerBase (start(130))
- Rpc (CatalogProtocol) listens on /127.0.0.1:17907
2015-05-12 02:28:34,729 INFO: org.apache.tajo.catalog.CatalogServer
(start(191)) - Catalog Server startup (127.0.0.1:17907)
2015-05-12 02:28:34,730 INFO: org.apache.tajo.catalog.CatalogServer
(createTablespace(235)) - tablespace "default"
(<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core/target/test-data/TestBroadcastJoinPlan)>
is created
2015-05-12 02:28:34,730 INFO: org.apache.tajo.catalog.CatalogServer
(createDatabase(376)) - database "default" is created
2015-05-12 02:28:35,574 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(603)) - relation "default.small1" is added to the catalog
(127.0.0.1:17907)
2015-05-12 02:28:35,575 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(603)) - relation "default.small2" is added to the catalog
(127.0.0.1:17907)
2015-05-12 02:28:35,575 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(603)) - relation "default.small3" is added to the catalog
(127.0.0.1:17907)
2015-05-12 02:28:35,575 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(603)) - relation "default.large1" is added to the catalog
(127.0.0.1:17907)
2015-05-12 02:28:35,575 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(603)) - relation "default.large2" is added to the catalog
(127.0.0.1:17907)
2015-05-12 02:28:35,575 INFO: org.apache.tajo.catalog.CatalogServer
(createTable(603)) - relation "default.large3" is added to the catalog
(127.0.0.1:17907)
2015-05-12 02:28:35,887 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (build(128)) -
-----------------------------
Query Block Graph
-----------------------------
|-#ROOT
-----------------------------
Optimization Log:
[LogicalPlan]
> ProjectionNode is eliminated.
[#ROOT]
> Non-optimized join order: ((default.small1 âθ default.small2)
âθ default.small3) (cost: 8.016010002E10)
> Optimized join order : ((default.small1 âθ default.small2)
âθ default.small3) (cost: 8.012006001E10)
-----------------------------
GROUP_BY(6)()
=> exprs: (count())
=> target list: ?count (INT8)
=> out schema:{(1) ?count (INT8)}
=> in schema:{(0) }
JOIN(9)(INNER)
=> Join Cond: default.small1.small1_id (INT4) = default.small3.small3_id
(INT4)
=> target list:
=> out schema: {(0) }
=> in schema: {(2) default.small1.small1_id (INT4),
default.small3.small3_id (INT4)}
SCAN(3) on default.small3
=> target list: default.small3.small3_id (INT4)
=> out schema: {(1) default.small3.small3_id (INT4)}
=> in schema: {(2) default.small3.small3_id (INT4),
default.small3.small3_contents (TEXT)}
JOIN(8)(INNER)
=> Join Cond: default.small1.small1_id (INT4) =
default.small2.small2_id (INT4)
=> target list: default.small1.small1_id (INT4)
=> out schema: {(1) default.small1.small1_id (INT4)}
=> in schema: {(2) default.small1.small1_id (INT4),
default.small2.small2_id (INT4)}
SCAN(1) on default.small2
=> target list: default.small2.small2_id (INT4)
=> out schema: {(1) default.small2.small2_id (INT4)}
=> in schema: {(2) default.small2.small2_id (INT4),
default.small2.small2_contents (TEXT)}
SCAN(0) on default.small1
=> target list: default.small1.small1_id (INT4)
=> out schema: {(1) default.small1.small1_id (INT4)}
=> in schema: {(2) default.small1.small1_id (INT4),
default.small1.small1_contents (TEXT)}
2015-05-12 02:28:35,888 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (buildJoinPlan(314)) -
JoinNode's left table default.small1 (20010) is marked a broadcasted table
2015-05-12 02:28:35,888 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (buildJoinPlan(327)) -
JoinNode's right table default.small2 (20010) is marked a broadcasted table
2015-05-12 02:28:35,888 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (buildJoinPlan(350)) - The
table default.small3 (20010) is marked a broadcasted table
2015-05-12 02:28:35,888 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (buildJoinPlan(377)) - Set
execution's plan with join Join (typeINNER,filter=default.small1.small1_id
(INT4) = default.small3.small3_id (INT4)) for broadcast join
2015-05-12 02:28:35,888 INFO:
org.apache.tajo.engine.planner.global.GlobalPlanner (build(170)) -
-------------------------------------------------------------------------------
Execution Block Graph (TERMINAL - eb_1431397715887_0000_000005)
-------------------------------------------------------------------------------
|-eb_1431397715887_0000_000005
|-eb_1431397715887_0000_000004
|-eb_1431397715887_0000_000003
-------------------------------------------------------------------------------
Order of Execution
-------------------------------------------------------------------------------
1: eb_1431397715887_0000_000003
2: eb_1431397715887_0000_000004
3: eb_1431397715887_0000_000005
-------------------------------------------------------------------------------
=======================================================
Block Id: eb_1431397715887_0000_000003 [LEAF]
=======================================================
[Outgoing]
[q_1431397715887_0000] 3 => 4 (type=HASH_SHUFFLE, key=, num=1)
[Enforcers]
0: type=Broadcast, tables=default.small1
1: type=Broadcast, tables=default.small2
2: type=Broadcast, tables=default.small3
GROUP_BY(11)()
=> exprs: (count())
=> target list: ?count_5 (INT8)
=> out schema:{(1) ?count_5 (INT8)}
=> in schema:{(0) }
JOIN(9)(INNER)
=> Join Cond: default.small1.small1_id (INT4) = default.small3.small3_id
(INT4)
=> target list:
=> out schema: {(0) }
=> in schema: {(2) default.small1.small1_id (INT4),
default.small3.small3_id (INT4)}
SCAN(3) on default.small3
=> target list: default.small3.small3_id (INT4)
=> out schema: {(1) default.small3.small3_id (INT4)}
=> in schema: {(2) default.small3.small3_id (INT4),
default.small3.small3_contents (TEXT)}
JOIN(8)(INNER)
=> Join Cond: default.small1.small1_id (INT4) =
default.small2.small2_id (INT4)
=> target list: default.small1.small1_id (INT4)
=> out schema: {(1) default.small1.small1_id (INT4)}
=> in schema: {(2) default.small1.small1_id (INT4),
default.small2.small2_id (INT4)}
SCAN(1) on default.small2
=> target list: default.small2.small2_id (INT4)
=> out schema: {(1) default.small2.small2_id (INT4)}
=> in schema: {(2) default.small2.small2_id (INT4),
default.small2.small2_contents (TEXT)}
SCAN(0) on default.small1
=> target list: default.small1.small1_id (INT4)
=> out schema: {(1) default.small1.small1_id (INT4)}
=> in schema: {(2) default.small1.small1_id (INT4),
default.small1.small1_contents (TEXT)}
=======================================================
Block Id: eb_1431397715887_0000_000004 [ROOT]
=======================================================
[Incoming]
[q_1431397715887_0000] 3 => 4 (type=HASH_SHUFFLE, key=, num=1)
GROUP_BY(6)()
=> exprs: (count(?count_5 (INT8)))
=> target list: ?count (INT8)
=> out schema:{(1) ?count (INT8)}
=> in schema:{(1) ?count_5 (INT8)}
SCAN(12) on eb_1431397715887_0000_000003
=> out schema: {(1) ?count_5 (INT8)}
=> in schema: {(1) ?count_5 (INT8)}
=======================================================
Block Id: eb_1431397715887_0000_000005 [TERMINAL]
=======================================================
2015-05-12 02:28:35,890 INFO: org.apache.tajo.catalog.CatalogServer (stop(196))
- Catalog Server (127.0.0.1:17907) shutdown
2015-05-12 02:28:35,890 INFO: org.apache.tajo.rpc.NettyServerBase
(shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:17907) shutdown
2015-05-12 02:28:35,937 INFO: org.apache.tajo.TajoTestingCluster
(startCatalogCluster(304)) - Apache Derby repository is set to
jdbc:derby:<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core/target/test-data/ab3791a8-6bfa-447d-848e-8f512a79ce7c/db>
2015-05-12 02:28:35,937 INFO: org.apache.tajo.catalog.CatalogServer
(serviceInit(131)) - Catalog Store Class: org.apache.tajo.catalog.store.MemStore
2015-05-12 02:28:35,937 INFO: org.apache.tajo.rpc.RpcChannelFactory
(createServerChannelFactory(141)) - Create CatalogProtocol-81
ServerSocketChannelFactory. Worker:2
2015-05-12 02:28:35,939 INFO: org.apache.tajo.rpc.NettyServerBase (start(130))
- Rpc (CatalogProtocol) listens on /127.0.0.1:17908
2015-05-12 02:28:35,939 INFO: org.apache.tajo.catalog.CatalogServer
(start(191)) - Catalog Server startup (127.0.0.1:17908)
2015-05-12 02:28:35,939 INFO: org.apache.tajo.catalog.CatalogServer
(createTablespace(235)) - tablespace "default"
(<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core/target/test-data/TestBroadcastJoinPlan)>
is created
2015-05-12 02:28:35,939 INFO: org.apache.tajo.catalog.CatalogServer
(createDatabase(376)) - database "default" is created
Killed
Results :
Tests run: 1312, Failures: 0, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Tajo Main ......................................... SUCCESS [ 2.066 s]
[INFO] Tajo Project POM .................................. SUCCESS [ 1.597 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [ 3.118 s]
[INFO] Tajo Common ....................................... SUCCESS [ 26.388 s]
[INFO] Tajo Algebra ...................................... SUCCESS [ 2.537 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [ 7.339 s]
[INFO] Tajo Plan ......................................... SUCCESS [ 7.131 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [ 1.416 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 45.951 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [ 0.968 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 10.543 s]
[INFO] Tajo Storage Common ............................... SUCCESS [ 11.974 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [ 56.281 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [ 3.407 s]
[INFO] Tajo PullServer ................................... SUCCESS [ 1.037 s]
[INFO] Tajo Client ....................................... SUCCESS [ 3.624 s]
[INFO] Tajo CLI tools .................................... SUCCESS [ 1.773 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 3.143 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [ 1.568 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [ 4.366 s]
[INFO] Tajo Core ......................................... FAILURE [20:01 min]
[INFO] Tajo RPC .......................................... SKIPPED
[INFO] Tajo Catalog Drivers Hive ......................... SKIPPED
[INFO] Tajo Catalog Drivers .............................. SKIPPED
[INFO] Tajo Catalog ...................................... SKIPPED
[INFO] Tajo Storage ...................................... SKIPPED
[INFO] Tajo Distribution ................................. SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 23:19 min
[INFO] Finished at: 2015-05-12T02:28:36+00:00
[INFO] Final Memory: 98M/1076M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal
org.apache.maven.plugins:maven-surefire-plugin:2.17:test (default-test) on
project tajo-core: Execution default-test of goal
org.apache.maven.plugins:maven-surefire-plugin:2.17:test failed: The forked VM
terminated without properly saying goodbye. VM crash or System.exit called?
[ERROR] Command was /bin/sh -c cd
<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core> &&
/home/jenkins/tools/java/jdk1.6.0_45-64/jre/bin/java -Xms512m -Xmx1024m
-XX:MaxPermSize=152m -Dfile.encoding=UTF-8 -jar
<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core/target/surefire/surefirebooter4412773046942184047.jar>
<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core/target/surefire/surefire97898262359471189tmp>
<https://builds.apache.org/job/Tajo-master-nightly/ws/tajo-core/target/surefire/surefire_115561339535174771701tmp>
[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/PluginExecutionException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :tajo-core
Build step 'Execute shell' marked build as failure
Archiving artifacts
Recording test results
