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/10/23 06:40:34 UTC

Build failed in Jenkins: Tajo-master-jdk8-nightly #204

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

Changes:

[hyunsik] TAJO-1643: SQLParse can't parse table alias in in brackets.

------------------------------------------
[...truncated 238804 lines...]
2015-10-23 04:41:10,147 INFO: org.apache.tajo.master.QueryInProgress (heartbeat(259)) - Received QueryMaster heartbeat:q_1445574622357_0691,state=QUERY_SUCCEEDED,progress=1.0, queryMaster=asf906.gq1.ygridcore.net
2015-10-23 04:41:10,147 INFO: org.apache.tajo.master.QueryManager (stopQuery(279)) - Stop QueryInProgress:q_1445574622357_0691
2015-10-23 04:41:10,147 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(172)) - Stopping QueryMasterTask:q_1445574622357_0691
2015-10-23 04:41:10,147 INFO: org.apache.tajo.querymaster.QueryMasterTask (cleanupQuery(473)) - Cleanup resources of all workers. Query: q_1445574622357_0691, workers: 1
2015-10-23 04:41:10,147 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(124)) - =========================================================
2015-10-23 04:41:10,147 INFO: org.apache.tajo.querymaster.QueryMasterTask (serviceStop(188)) - Stopped QueryMasterTask:q_1445574622357_0691
2015-10-23 04:41:10,147 INFO: org.apache.tajo.master.QueryInProgress (stopProgress(125)) - Stop query:q_1445574622357_0691
2015-10-23 04:41:10,446 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(176)) - Query: DROP TABLE table1 PURGE
2015-10-23 04:41:10,446 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query: 

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


2015-10-23 04:41:10,447 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-10-23 04:41:10,447 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query: 

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


2015-10-23 04:41:10,447 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-10-23 04:41:10,451 INFO: org.apache.tajo.catalog.CatalogServer (dropTable(721)) - relation "TestInsertQuery.table1" is deleted from the catalog (127.0.0.1:47898)
2015-10-23 04:41:10,451 INFO: org.apache.tajo.storage.FileTablespace (purgeTable(680)) - Delete table data dir: hdfs://localhost:54013/tajo/warehouse/TestInsertQuery/table1
2015-10-23 04:41:10,452 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073744115_3291 127.0.0.1:39733 
2015-10-23 04:41:10,452 INFO: BlockStateChange (addToInvalidates(1106)) - BLOCK* addToInvalidates: blk_1073744116_3292 127.0.0.1:39733 
2015-10-23 04:41:10,452 INFO: org.apache.tajo.master.exec.DDLExecutor (dropTable(327)) - relation "TestInsertQuery.table1" is  purged.
2015-10-23 04:41:10,453 INFO: org.apache.tajo.master.GlobalEngine (updateQuery(239)) - SQL: CREATE DATABASE IF NOT EXISTS "TestInsertQuery"
2015-10-23 04:41:10,453 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query: 

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

CREATE_DATABASE(0) IF NOT EXISTS TestInsertQuery

2015-10-23 04:41:10,453 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-10-23 04:41:10,454 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query: 

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

CREATE_DATABASE(0) IF NOT EXISTS TestInsertQuery

2015-10-23 04:41:10,454 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-10-23 04:41:10,454 INFO: org.apache.tajo.master.exec.DDLExecutor (createDatabase(246)) - database "TestInsertQuery" is already exists.
Run: testFixedCharSelect Used memory: 279 MBytes, Active Threads:258
2015-10-23 04:41:10,456 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(176)) - Query: create table test1 (col1 char(5))
2015-10-23 04:41:10,456 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query: 

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


2015-10-23 04:41:10,457 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-10-23 04:41:10,457 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query: 

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


2015-10-23 04:41:10,457 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-10-23 04:41:10,460 INFO: org.apache.tajo.catalog.CatalogServer (createTable(691)) - relation "TestInsertQuery.test1" is added to the catalog (127.0.0.1:47898)
2015-10-23 04:41:10,460 INFO: org.apache.tajo.master.exec.DDLExecutor (create(112)) - relation 'TestInsertQuery.test1' created.
2015-10-23 04:41:10,461 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(176)) - Query: insert into test1 select 'a'
2015-10-23 04:41:10,464 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query: 

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

INSERT(1) INTO TestInsertQuery.test1
  => {(1) TestInsertQuery.test1.col1 (CHAR(5))}

2015-10-23 04:41:10,464 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-10-23 04:41:10,464 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query: 

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

INSERT(1) INTO TestInsertQuery.test1
  => {(1) TestInsertQuery.test1.col1 (CHAR(5))}

2015-10-23 04:41:10,464 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-10-23 04:41:10,473 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:39733 is added to blk_1073744119_3295{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-ac700c5f-0166-462d-8e5f-53726da6998a:NORMAL:127.0.0.1:39733|FINALIZED]]} size 0
2015-10-23 04:41:10,476 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(176)) - Query: insert into test1 select 'abc'
2015-10-23 04:41:10,479 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query: 

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

INSERT(1) INTO TestInsertQuery.test1
  => {(1) TestInsertQuery.test1.col1 (CHAR(5))}

2015-10-23 04:41:10,479 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-10-23 04:41:10,479 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query: 

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

INSERT(1) INTO TestInsertQuery.test1
  => {(1) TestInsertQuery.test1.col1 (CHAR(5))}

2015-10-23 04:41:10,480 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-10-23 04:41:10,486 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:39733 is added to blk_1073744120_3296{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-dd0cfef3-fd15-4e0e-bf95-6b4c281f0153:NORMAL:127.0.0.1:39733|FINALIZED]]} size 0
2015-10-23 04:41:10,490 INFO: org.apache.tajo.master.GlobalEngine (executeQuery(176)) - Query: insert into test1 select 'abcde'
2015-10-23 04:41:10,494 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(280)) - Non Optimized Query: 

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

INSERT(1) INTO TestInsertQuery.test1
  => {(1) TestInsertQuery.test1.col1 (CHAR(5))}

2015-10-23 04:41:10,494 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(282)) - =============================================
2015-10-23 04:41:10,494 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(283)) - Optimized Query: 

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

INSERT(1) INTO TestInsertQuery.test1
  => {(1) TestInsertQuery.test1.col1 (CHAR(5))}

2015-10-23 04:41:10,495 INFO: org.apache.tajo.master.GlobalEngine (createLogicalPlan(284)) - =============================================
2015-10-23 04:41:10,502 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:39733 is added to blk_1073744121_3297{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-dd0cfef3-fd15-4e0e-bf95-6b4c281f0153:NORMAL:127.0.0.1:39733|RBW]]} size 6
2015-10-23 04:41:10,541 INFO: BlockStateChange (invalidateWorkForOneNode(3488)) - BLOCK* BlockManager: ask 127.0.0.1:39733 to delete [blk_1073744114_3290, blk_1073744115_3291, blk_1073744116_3292, blk_1073744103_3279, blk_1073744104_3280, blk_1073744109_3285]
Killed

Results :

Tests run: 632, Failures: 0, Errors: 0, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  1.538 s]
[INFO] Tajo Project POM .................................. SUCCESS [  1.426 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  2.588 s]
[INFO] Tajo Common ....................................... SUCCESS [ 30.092 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  2.277 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  4.895 s]
[INFO] Tajo Plan ......................................... SUCCESS [  6.899 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  1.168 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 49.986 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [  1.405 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 11.076 s]
[INFO] Tajo Storage Common ............................... SUCCESS [  2.642 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [ 47.995 s]
[INFO] Tajo PullServer ................................... SUCCESS [  0.883 s]
[INFO] Tajo Client ....................................... SUCCESS [  2.589 s]
[INFO] Tajo CLI tools .................................... SUCCESS [  1.666 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [  3.804 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [  1.977 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [  3.658 s]
[INFO] Tajo Metrics ...................................... SUCCESS [  1.368 s]
[INFO] Tajo Core ......................................... SUCCESS [  6.688 s]
[INFO] Tajo RPC .......................................... SUCCESS [  0.905 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [  9.361 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [  0.045 s]
[INFO] Tajo Catalog ...................................... SUCCESS [  0.958 s]
[INFO] Tajo Client Example ............................... SUCCESS [  1.008 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [  3.307 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [  2.327 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 33.591 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [  0.825 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [  0.876 s]
[INFO] Tajo Storage ...................................... SUCCESS [  0.956 s]
[INFO] Tajo Distribution ................................. SUCCESS [  5.403 s]
[INFO] Tajo Core Tests ................................... FAILURE [10:59 min]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 15:06 min
[INFO] Finished at: 2015-10-23T04:41:10+00:00
[INFO] Final Memory: 164M/2098M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.17:test (default-test) on project tajo-core-tests: 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-jdk8-nightly/ws/tajo-core-tests> && /home/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/jre/bin/java -Xms512m -Xmx1024m -XX:MaxPermSize=152m -Dfile.encoding=UTF-8 -Dderby.storage.pageSize=1024 -Dderby.stream.error.file=/dev/null -jar <https://builds.apache.org/job/Tajo-master-jdk8-nightly/ws/tajo-core-tests/target/surefire/surefirebooter4364346875990516804.jar> <https://builds.apache.org/job/Tajo-master-jdk8-nightly/ws/tajo-core-tests/target/surefire/surefire2804435677005932024tmp> <https://builds.apache.org/job/Tajo-master-jdk8-nightly/ws/tajo-core-tests/target/surefire/surefire_14755249182584686441tmp>
[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-tests
Build step 'Execute shell' marked build as failure
Archiving artifacts
Recording test results

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

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