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 17:28:17 UTC

Build failed in Jenkins: Tajo-0.11.0-build #80

See <https://builds.apache.org/job/Tajo-0.11.0-build/80/changes>

Changes:

[blrunner] TAJO-1887: Disable the alter table add partition statement temporarily.

------------------------------------------
[...truncated 743592 lines...]

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 1 * Sending client request on thread main
1 > DELETE http://127.0.0.1:40911/rest/databases/TestDropDatabaseNotFound

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 58 * Server has received a request on thread Tajo-REST-5 #0
58 > DELETE http://127.0.0.1:40911/rest/databases/TestDropDatabaseNotFound
58 > Accept: text/html, image/gif, image/jpeg, *; q=.2, */*; q=.2
58 > Connection: keep-alive
58 > Content-Length: 0
58 > Host: 127.0.0.1:40911
58 > User-Agent: Jersey/2.6 (HttpUrlConnection 1.7.0_25)

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 58 * Server responded with a response on thread Tajo-REST-5 #0
58 < 404

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 1 * Client response received on thread main
1 < 404

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 1 * Sending client request on thread main
1 > GET http://127.0.0.1:40911/rest/databases/testGetDatabaseNotFound

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 59 * Server has received a request on thread Tajo-REST-5 #1
59 > GET http://127.0.0.1:40911/rest/databases/testGetDatabaseNotFound
59 > Accept: text/html, image/gif, image/jpeg, *; q=.2, */*; q=.2
59 > Connection: keep-alive
59 > Content-Length: 0
59 > Host: 127.0.0.1:40911
59 > User-Agent: Jersey/2.6 (HttpUrlConnection 1.7.0_25)

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 59 * Server responded with a response on thread Tajo-REST-5 #1
59 < 404

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 1 * Client response received on thread main
1 < 404

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 1 * Sending client request on thread main
1 > POST http://127.0.0.1:40911/rest/databases
1 > Content-Type: application/json

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 60 * Server has received a request on thread Tajo-REST-5 #0
60 > POST http://127.0.0.1:40911/rest/databases
60 > Accept: text/html, image/gif, image/jpeg, *; q=.2, */*; q=.2
60 > Connection: keep-alive
60 > Content-Length: 40
60 > Content-Type: application/json
60 > Host: 127.0.0.1:40911
60 > User-Agent: Jersey/2.6 (HttpUrlConnection 1.7.0_25)

2015-09-29 15:27:55,614 INFO: org.apache.tajo.catalog.CatalogServer (createDatabase(421)) - database "TestDatabasesResource" is created
Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 60 * Server responded with a response on thread Tajo-REST-5 #0
60 < 201
60 < Location: http://127.0.0.1:40911/rest/databases/TestDatabasesResource

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 1 * Client response received on thread main
1 < 201
1 < Location: http://127.0.0.1:40911/rest/databases/TestDatabasesResource

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 2 * Sending client request on thread main
2 > GET http://127.0.0.1:40911/rest/databases

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 61 * Server has received a request on thread Tajo-REST-5 #1
61 > GET http://127.0.0.1:40911/rest/databases
61 > Accept: text/html, image/gif, image/jpeg, *; q=.2, */*; q=.2
61 > Connection: keep-alive
61 > Content-Length: 0
61 > Host: 127.0.0.1:40911
61 > User-Agent: Jersey/2.6 (HttpUrlConnection 1.7.0_25)

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 61 * Server responded with a response on thread Tajo-REST-5 #1
61 < 200
61 < Content-Type: application/json

Sep 29, 2015 3:27:55 PM org.glassfish.jersey.filter.LoggingFilter log
INFO: 2 * Client response received on thread main
2 < 200
2 < Content-Type: application/json

2015-09-29 15:27:55,620 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 54008502-05d8-4097-8541-639e9bc0955b is removed.
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.204 sec - in org.apache.tajo.ws.rs.resources.TestDatabasesResource
2015-09-29 15:27:55,625 INFO: org.mortbay.log (invoke0(?)) - Shutdown hook executing
2015-09-29 15:27:55,626 INFO: org.mortbay.log (invoke(?)) - Shutdown hook complete
Sep 29, 2015 3:17:57 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 29, 2015 3:17:57 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 29, 2015 3:18:18 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 29, 2015 3:18:18 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 29, 2015 3:18:18 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 29, 2015 3:18:18 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 29, 2015 3:18:18 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Sep 29, 2015 3:18:21 PM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
2015-09-29 15:27:55,630 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session e41918ec-48e7-4405-a7e0-2dbd60be709f is removed.
2015-09-29 15:27:55,633 INFO: org.apache.tajo.session.SessionManager (removeSession(85)) - Session 21ef84ae-a1d3-49fd-97c6-cc780b1c4b76 is removed.
2015-09-29 15:27:55,635 INFO: org.apache.tajo.worker.TajoWorker (run(565)) - ============================================
2015-09-29 15:27:55,636 INFO: org.apache.tajo.worker.TajoWorker (run(566)) - TajoWorker received SIGINT Signal
2015-09-29 15:27:55,636 INFO: org.apache.tajo.worker.TajoWorker (run(567)) - ============================================
2015-09-29 15:27:55,637 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_asf904.gq1.ygridcore.net_40912 stopped.
2015-09-29 15:27:55,637 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-09-29 15:27:55,655 INFO: BlockStateChange (logAddStoredBlock(2624)) - BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:51450 is added to blk_1073747897_7073{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-15de94a8-d8f7-45e9-b57c-9dca885ac1a4:NORMAL:127.0.0.1:51450|RBW]]} size 1593
2015-09-29 15:27:55,692 INFO: org.apache.tajo.worker.NodeStatusUpdater (serviceStop(115)) - NodeStatusUpdater stopped.
2015-09-29 15:27:55,692 INFO: org.apache.tajo.worker.NodeStatusUpdater (run(265)) - Heartbeat Thread stopped.
2015-09-29 15:27:55,694 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:40914) shutdown
2015-09-29 15:27:55,694 INFO: org.apache.tajo.querymaster.QueryMasterManagerService (serviceStop(106)) - QueryMasterManagerService stopped
2015-09-29 15:27:55,694 INFO: org.apache.tajo.querymaster.QueryMaster (run(427)) - QueryMaster heartbeat thread stopped
2015-09-29 15:27:55,695 INFO: org.apache.tajo.querymaster.QueryMaster (serviceStop(162)) - QueryMaster stopped
2015-09-29 15:27:55,695 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(98)) - TajoWorkerClientService stopping
2015-09-29 15:27:55,696 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:40913) shutdown
2015-09-29 15:27:55,696 INFO: org.apache.tajo.worker.TajoWorkerClientService (stop(102)) - TajoWorkerClientService stopped
2015-09-29 15:27:55,697 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:40912) shutdown
2015-09-29 15:27:55,697 INFO: org.apache.tajo.worker.TajoWorkerManagerService (serviceStop(93)) - TajoWorkerManagerService stopped
2015-09-29 15:27:55,698 INFO: org.apache.tajo.worker.TajoWorker (serviceStop(375)) - TajoWorker main thread exiting
2015-09-29 15:27:55,878 ERROR: org.apache.tajo.util.history.HistoryWriter (writeHistory(330)) - Error while saving query summary: q_1443536760605_2188:null
java.nio.channels.ClosedChannelException
	at org.apache.hadoop.hdfs.DFSOutputStream.checkClosed(DFSOutputStream.java:1521)
	at org.apache.hadoop.fs.FSOutputSummer.write(FSOutputSummer.java:104)
	at org.apache.hadoop.fs.FSDataOutputStream$PositionCache.write(FSDataOutputStream.java:58)
	at java.io.DataOutputStream.write(DataOutputStream.java:107)
	at java.io.FilterOutputStream.write(FilterOutputStream.java:97)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.writeQuerySummary(HistoryWriter.java:406)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.writeHistory(HistoryWriter.java:328)
	at org.apache.tajo.util.history.HistoryWriter$WriterThread.run(HistoryWriter.java:244)
2015-09-29 15:28:00,107 INFO: org.apache.tajo.master.TajoMaster (run(580)) - ============================================
2015-09-29 15:28:00,108 INFO: org.apache.tajo.master.TajoMaster (run(581)) - TajoMaster received SIGINT Signal
2015-09-29 15:28:00,108 INFO: org.apache.tajo.master.TajoMaster (run(582)) - ============================================
2015-09-29 15:28:00,109 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (Tajo-REST) listened on 0:0:0:0:0:0:0:0:40911) shutdown
2015-09-29 15:28:00,109 INFO: org.apache.tajo.ws.rs.TajoRestService (serviceStop(129)) - Tajo Rest Service stopped.
2015-09-29 15:28:00,110 INFO: org.apache.tajo.util.history.HistoryWriter (run(275)) - HistoryWriter_127.0.0.1_40910 stopped.
2015-09-29 15:28:00,110 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (QueryCoordinatorProtocol) listened on 127.0.0.1:40910) shutdown
2015-09-29 15:28:00,110 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoMasterClientProtocol) listened on 127.0.0.1:40909) shutdown
2015-09-29 15:28:00,110 INFO: org.apache.tajo.util.history.HistoryCleaner (run(136)) - History cleaner stopped
2015-09-29 15:28:00,111 INFO: org.apache.tajo.catalog.CatalogServer (serviceStop(189)) - Catalog Server (127.0.0.1:40908) shutdown
2015-09-29 15:28:00,111 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (CatalogProtocol) listened on 127.0.0.1:40908) shutdown
2015-09-29 15:28:00,111 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/fe8ce742-a5b2-44ab-86fa-ac7a233570a5/db;create=true)>
2015-09-29 15:28:00,112 INFO: org.apache.tajo.rpc.NettyServerBase (shutdown(173)) - Rpc (TajoResourceTrackerProtocol) listened on 127.0.0.1:40907) shutdown
2015-09-29 15:28:00,113 INFO: org.apache.tajo.master.TajoMaster (serviceStop(440)) - Tajo Master main thread exiting
2015-09-29 15:28:00,323 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(68)) - Derby shutdown complete normally.
2015-09-29 15:28:00,323 INFO: org.apache.tajo.catalog.store.DerbyStore (shutdown(75)) - Shutdown database

Results :

Failed tests: 
  TestHBaseTable.testCreateNotExistsExternalHBaseTable:168 null

Tests in error: 
  TestHBaseTable.testInsertIntoColumnKeyValue:1062->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testInsertIntoBinaryMultiRegion:1007->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testCompositeRowIndexPredication:466->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testIndexPredication:421->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testRowFieldSelectQuery:382 » RetriesExhausted Failed after att...
  TestHBaseTable.testCTAS:1247->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testJoin:656->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testInsertIntoLocation:1344->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testNonForwardQuery:618->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testInsertInto:696->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testInsertIntoDifferentType:1152->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testBinaryMappedQuery:280 » RetriesExhausted Failed after attem...
  TestHBaseTable.testInsertIntoMultiRegionWithSplitFile:891->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegion:778->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testInsertIntoMultiRegionMultiRowFields:948->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testColumnKeyValueSelectQuery:339 » RetriesExhausted Failed aft...
  TestHBaseTable.testInsertValues1:736->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testSimpleSelectQuery:234 » RetriesExhausted Failed after attem...
  TestHBaseTable.testCreateExternalHBaseTable:197 » RetriesExhausted Failed afte...
  TestHBaseTable.testInsertIntoMultiRegion2:834->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testInsertIntoUsingPut:1294->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testCreateHBaseTable:128->QueryTestCaseBase.executeString:380 » TajoInternal
  TestHBaseTable.testInsertIntoRowField:1188->QueryTestCaseBase.executeString:380 » TajoInternal

Tests run: 1687, Failures: 1, Errors: 23, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  1.815 s]
[INFO] Tajo Project POM .................................. SUCCESS [  1.205 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  2.789 s]
[INFO] Tajo Common ....................................... SUCCESS [ 39.826 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  2.389 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  5.007 s]
[INFO] Tajo Plan ......................................... SUCCESS [  7.001 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  1.267 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [ 52.791 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [  1.336 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [ 12.015 s]
[INFO] Tajo Storage Common ............................... SUCCESS [  2.824 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [ 53.650 s]
[INFO] Tajo PullServer ................................... SUCCESS [  1.054 s]
[INFO] Tajo Client ....................................... SUCCESS [  2.431 s]
[INFO] Tajo CLI tools .................................... SUCCESS [  1.825 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [  4.717 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [  1.867 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [  4.235 s]
[INFO] Tajo Metrics ...................................... SUCCESS [  1.380 s]
[INFO] Tajo Core ......................................... SUCCESS [  6.001 s]
[INFO] Tajo RPC .......................................... SUCCESS [  0.991 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 10.695 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [  0.070 s]
[INFO] Tajo Catalog ...................................... SUCCESS [  1.003 s]
[INFO] Tajo Client Example ............................... SUCCESS [  1.100 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [  3.779 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [  2.667 s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [ 36.151 s]
[INFO] Tajo JDBC storage common .......................... SUCCESS [  0.898 s]
[INFO] Tajo PostgreSQL JDBC storage ...................... SUCCESS [  1.193 s]
[INFO] Tajo Storage ...................................... SUCCESS [  1.027 s]
[INFO] Tajo Distribution ................................. SUCCESS [  5.510 s]
[INFO] Tajo Core Tests ................................... FAILURE [  01:02 h]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 01:06 h
[INFO] Finished at: 2015-09-29T15:28:00+00:00
[INFO] Final Memory: 81M/381M
[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 #79
Archived 1 artifacts
Archive block size is 32768
Received 0 blocks and 59760086 bytes
Compression is 0.0%
Took 32 sec
Updating TAJO-1887

Jenkins build is back to normal : Tajo-0.11.0-build #81

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Tajo-0.11.0-build/81/changes>