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 12:15:18 UTC

Build failed in Jenkins: Tajo-0.11.0-nightly #60

See <https://builds.apache.org/job/Tajo-0.11.0-nightly/60/changes>

Changes:

[jihoonson] TAJO-1889: UndefinedColumnException when a query with table subquery is executed on self-describing tables. (fix wrong query)

------------------------------------------
[...truncated 946 lines...]
Sep 29, 2015 10:15:03 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35347
Sep 29, 2015 10:15:05 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35347
Sep 29, 2015 10:15:06 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35347
Sep 29, 2015 10:15:07 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35347
Sep 29, 2015 10:15:08 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35347) shutdown
Sep 29, 2015 10:15:08 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35348
Sep 29, 2015 10:15:11 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler userEventTriggered
INFO: Idle connection closed successfully :[id: 0x9a4290d9, /127.0.0.1:33520 :> /127.0.0.1:35348]
Sep 29, 2015 10:15:11 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35348) shutdown
Sep 29, 2015 10:15:11 AM org.apache.tajo.rpc.NettyClientBase doReconnect
WARNING: Exception [org.apache.tajo.rpc.test.DummyProtocol(/127.0.0.1:32871)]: ConnectException: Connection refused: /127.0.0.1:32871
Try to reconnect : /127.0.0.1:32871
Sep 29, 2015 10:15:12 AM org.apache.tajo.rpc.NettyClientBase doReconnect
SEVERE: Max retry count has been exceeded. attempts=2 caused by: java.net.ConnectException: Connection refused: /127.0.0.1:32871
Sep 29, 2015 10:15:12 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:32871
Sep 29, 2015 10:15:13 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:32871
Sep 29, 2015 10:15:14 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler exceptionCaught
SEVERE: Exception [org.apache.tajo.rpc.test.DummyProtocol(/127.0.0.1:32871)]: ClosedChannelException: 
java.nio.channels.ClosedChannelException

Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 24.193 sec - in org.apache.tajo.rpc.TestAsyncRpc
Running org.apache.tajo.rpc.TestRpcClientManager
Sep 29, 2015 10:15:16 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35349
Sep 29, 2015 10:15:16 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35349) shutdown
Sep 29, 2015 10:15:16 AM org.apache.tajo.rpc.RpcClientManager close
INFO: Closing RPC client manager
Sep 29, 2015 10:15:16 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35350
Sep 29, 2015 10:15:16 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler exceptionCaught
SEVERE: Exception [org.apache.tajo.rpc.test.DummyProtocol(/127.0.0.1:35350)]: 
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35350) shutdown
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.RpcClientManager close
INFO: Closing RPC client manager
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35351
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.RpcClientManager close
INFO: Closing RPC client manager
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35351) shutdown
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35352
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35352) shutdown
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.RpcClientManager close
INFO: Closing RPC client manager
Tests run: 4, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 0.128 sec <<< FAILURE! - in org.apache.tajo.rpc.TestRpcClientManager
testRaceCondition(org.apache.tajo.rpc.TestRpcClientManager)  Time elapsed: 0.083 sec  <<< ERROR!
java.util.concurrent.ExecutionException: java.lang.AssertionError
	at java.util.concurrent.FutureTask$Sync.innerGet(FutureTask.java:252)
	at java.util.concurrent.FutureTask.get(FutureTask.java:111)
	at org.apache.tajo.rpc.TestRpcClientManager.testRaceCondition(TestRpcClientManager.java:68)
Caused by: java.lang.AssertionError: null
	at org.junit.Assert.fail(Assert.java:86)
	at org.apache.tajo.rpc.TestRpcClientManager$1.run(TestRpcClientManager.java:59)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
	at java.util.concurrent.FutureTask.run(FutureTask.java:166)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:724)

Running org.apache.tajo.rpc.TestBlockingRpc
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35353
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35353) shutdown
Sep 29, 2015 10:15:17 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35354
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.MonitorClientHandler userEventTriggered
INFO: Server has not respond [id: 0x848e6df0, /127.0.0.1:54702 => /127.0.0.1:35354]
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler exceptionCaught
SEVERE: Exception [org.apache.tajo.rpc.test.DummyProtocol(/127.0.0.1:35354)]: 
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35354) shutdown
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35355
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35355) shutdown
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35356
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.test.impl.DummyProtocolBlockingImpl getNull
INFO: noCallback is called
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35356) shutdown
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35357
Sep 29, 2015 10:15:18 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler userEventTriggered
INFO: Idle connection closed successfully :[id: 0x8d448e88, /127.0.0.1:37553 :> /127.0.0.1:35357]
Sep 29, 2015 10:15:19 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler userEventTriggered
INFO: Idle connection closed successfully :[id: 0xe0332692, /127.0.0.1:37598 :> /127.0.0.1:35357]
Sep 29, 2015 10:15:19 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35357) shutdown
Sep 29, 2015 10:15:19 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35358
Sep 29, 2015 10:15:19 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35358) shutdown
Sep 29, 2015 10:15:19 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :localhost/127.0.0.1:35358
Sep 29, 2015 10:15:20 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler exceptionCaught
SEVERE: Exception [org.apache.tajo.rpc.test.DummyProtocol(localhost/127.0.0.1:35358)]: ClosedChannelException: 
java.nio.channels.ClosedChannelException

Sep 29, 2015 10:15:20 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35359
Sep 29, 2015 10:15:20 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35359) shutdown
Sep 29, 2015 10:15:20 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :localhost/127.0.0.1:35359
Sep 29, 2015 10:15:21 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler exceptionCaught
SEVERE: Exception [org.apache.tajo.rpc.test.DummyProtocol(localhost/127.0.0.1:35359)]: ClosedChannelException: 
java.nio.channels.ClosedChannelException

Sep 29, 2015 10:15:21 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35361
Sep 29, 2015 10:15:22 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35361) shutdown
Sep 29, 2015 10:15:24 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35362
Sep 29, 2015 10:15:25 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35362) shutdown
Sep 29, 2015 10:15:25 AM org.apache.tajo.rpc.NettyClientBase doReconnect
WARNING: Exception [org.apache.tajo.rpc.test.DummyProtocol(/127.0.0.1:53905)]: ConnectException: Connection refused: /127.0.0.1:53905
Try to reconnect : /127.0.0.1:53905
Sep 29, 2015 10:15:26 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:53905
Sep 29, 2015 10:15:26 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:53905) shutdown
Sep 29, 2015 10:15:26 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35363
Sep 29, 2015 10:15:26 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35363) shutdown
Sep 29, 2015 10:15:26 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35364
Sep 29, 2015 10:15:29 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35364) shutdown
Sep 29, 2015 10:15:29 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35365
Sep 29, 2015 10:15:29 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35365
Sep 29, 2015 10:15:30 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35365
Sep 29, 2015 10:15:31 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35365
Sep 29, 2015 10:15:32 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35365
Sep 29, 2015 10:15:33 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:35365
Sep 29, 2015 10:15:34 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35365) shutdown
Sep 29, 2015 10:15:34 AM org.apache.tajo.rpc.NettyServerBase start
INFO: Rpc (DummyProtocol) listens on /127.0.0.1:35366
Sep 29, 2015 10:15:38 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler userEventTriggered
INFO: Idle connection closed successfully :[id: 0x839c56cd, /127.0.0.1:40935 :> /127.0.0.1:35366]
Sep 29, 2015 10:15:38 AM org.apache.tajo.rpc.NettyServerBase shutdown
INFO: Rpc (DummyProtocol) listened on 127.0.0.1:35366) shutdown
Sep 29, 2015 10:15:38 AM org.apache.tajo.rpc.NettyClientBase doReconnect
WARNING: Exception [org.apache.tajo.rpc.test.DummyProtocol(/127.0.0.1:46778)]: ConnectException: Connection refused: /127.0.0.1:46778
Try to reconnect : /127.0.0.1:46778
Sep 29, 2015 10:15:39 AM org.apache.tajo.rpc.NettyClientBase doReconnect
SEVERE: Max retry count has been exceeded. attempts=2 caused by: java.net.ConnectException: Connection refused: /127.0.0.1:46778
Sep 29, 2015 10:15:39 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:46778
Sep 29, 2015 10:15:40 AM org.apache.tajo.rpc.NettyClientBase$1 operationComplete
WARNING: java.nio.channels.ClosedChannelException Try to reconnect :/127.0.0.1:46778
Sep 29, 2015 10:15:41 AM org.apache.tajo.rpc.NettyClientBase$NettyChannelInboundHandler exceptionCaught
SEVERE: Exception [org.apache.tajo.rpc.test.DummyProtocol(/127.0.0.1:46778)]: ClosedChannelException: 
java.nio.channels.ClosedChannelException

Tests run: 16, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 26.428 sec - in org.apache.tajo.rpc.TestBlockingRpc

Results :

Tests in error: 
  TestRpcClientManager.testRaceCondition:68 ยป Execution java.lang.AssertionError

Tests run: 37, Failures: 0, Errors: 1, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  2.528 s]
[INFO] Tajo Project POM .................................. SUCCESS [  2.031 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  3.409 s]
[INFO] Tajo Common ....................................... SUCCESS [ 45.507 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  3.006 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  5.844 s]
[INFO] Tajo Plan ......................................... SUCCESS [  7.578 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  1.551 s]
[INFO] Tajo Protocol Buffer Rpc .......................... FAILURE [ 52.274 s]
[INFO] Tajo Catalog Client ............................... SKIPPED
[INFO] Tajo Catalog Server ............................... SKIPPED
[INFO] Tajo Storage Common ............................... SKIPPED
[INFO] Tajo HDFS Storage ................................. SKIPPED
[INFO] Tajo PullServer ................................... SKIPPED
[INFO] Tajo Client ....................................... SKIPPED
[INFO] Tajo CLI tools .................................... SKIPPED
[INFO] Tajo SQL Parser ................................... SKIPPED
[INFO] ASM (thirdparty) .................................. SKIPPED
[INFO] Tajo RESTful Container ............................ SKIPPED
[INFO] Tajo Metrics ...................................... SKIPPED
[INFO] Tajo Core ......................................... SKIPPED
[INFO] Tajo RPC .......................................... SKIPPED
[INFO] Tajo Catalog Drivers Hive ......................... SKIPPED
[INFO] Tajo Catalog Drivers .............................. SKIPPED
[INFO] Tajo Catalog ...................................... SKIPPED
[INFO] Tajo Client Example ............................... SKIPPED
[INFO] Tajo HBase Storage ................................ SKIPPED
[INFO] Tajo Cluster Tests ................................ SKIPPED
[INFO] Tajo JDBC Driver .................................. SKIPPED
[INFO] Tajo JDBC storage common .......................... SKIPPED
[INFO] Tajo PostgreSQL JDBC storage ...................... SKIPPED
[INFO] Tajo Storage ...................................... SKIPPED
[INFO] Tajo Distribution ................................. SKIPPED
[INFO] Tajo Core Tests ................................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 02:04 min
[INFO] Finished at: 2015-09-29T10:15:43+00:00
[INFO] Final Memory: 55M/351M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.17:test (default-test) on project tajo-rpc-protobuf: There are test failures.
[ERROR] 
[ERROR] Please refer to <https://builds.apache.org/job/Tajo-0.11.0-nightly/ws/tajo-rpc/tajo-rpc-protobuf/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-rpc-protobuf
Build step 'Execute shell' marked build as failure
Archiving artifacts
Recording test results