You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@spark.apache.org by "Tao Wang (JIRA)" <ji...@apache.org> on 2016/08/01 02:42:20 UTC
[jira] [Commented] (SPARK-14559) Netty RPC didn't check channel is
active before sending message
[ https://issues.apache.org/jira/browse/SPARK-14559?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15401456#comment-15401456 ]
Tao Wang commented on SPARK-14559:
----------------------------------
Hi, we have same issues, along with another error sending message:
###
2016-07-13 10:06:10,123 | WARN | [spark-dynamic-executor-allocation] | Error sending message [message = RequestExecutors(32963,133120,Map(9-91-8-220 -> 53119, 9-91-8-219 -> 53306, 9-91-8-208 -> 75446, 9-91
-8-218 -> 87637, 9-96-101-254 -> 76229, 9-91-8-217 -> 53623))] in 2 attempts | org.apache.spark.Logging$class.logWarning(Logging.scala:92)
org.apache.spark.rpc.RpcTimeoutException: Futures timed out after [300 seconds]. This timeout is controlled by spark.network.timeout
at org.apache.spark.rpc.RpcTimeout.org$apache$spark$rpc$RpcTimeout$$createRpcTimeoutException(RpcTimeout.scala:48)
at org.apache.spark.rpc.RpcTimeout$$anonfun$addMessageIfTimeout$1.applyOrElse(RpcTimeout.scala:63)
at org.apache.spark.rpc.RpcTimeout$$anonfun$addMessageIfTimeout$1.applyOrElse(RpcTimeout.scala:59)
at scala.runtime.AbstractPartialFunction.apply(AbstractPartialFunction.scala:33)
at org.apache.spark.rpc.RpcTimeout.awaitResult(RpcTimeout.scala:76)
at org.apache.spark.rpc.RpcEndpointRef.askWithRetry(RpcEndpointRef.scala:101)
at org.apache.spark.rpc.RpcEndpointRef.askWithRetry(RpcEndpointRef.scala:77)
at org.apache.spark.scheduler.cluster.YarnSchedulerBackend.doRequestTotalExecutors(YarnSchedulerBackend.scala:57)
at org.apache.spark.scheduler.cluster.CoarseGrainedSchedulerBackend.requestTotalExecutors(CoarseGrainedSchedulerBackend.scala:426)
at org.apache.spark.SparkContext.requestTotalExecutors(SparkContext.scala:1476)
at org.apache.spark.ExecutorAllocationManager.addExecutors(ExecutorAllocationManager.scala:396)
at org.apache.spark.ExecutorAllocationManager.updateAndSyncNumExecutorsTarget(ExecutorAllocationManager.scala:345)
at org.apache.spark.ExecutorAllocationManager.org$apache$spark$ExecutorAllocationManager$$schedule(ExecutorAllocationManager.scala:299)
at org.apache.spark.ExecutorAllocationManager$$anon$2.run(ExecutorAllocationManager.scala:228)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.util.concurrent.TimeoutException: Futures timed out after [300 seconds]
at scala.concurrent.impl.Promise$DefaultPromise.ready(Promise.scala:219)
at scala.concurrent.impl.Promise$DefaultPromise.result(Promise.scala:223)
at scala.concurrent.Await$$anonfun$result$1.apply(package.scala:107)
at scala.concurrent.BlockContext$DefaultBlockContext$.blockOn(BlockContext.scala:53)
at scala.concurrent.Await$.result(package.scala:107)
at org.apache.spark.rpc.RpcTimeout.awaitResult(RpcTimeout.scala:75)
... 16 more
2016-07-13 10:10:44,928 | ERROR | [shuffle-server-5] | Failed to send RPC 6030874580924985460 to 9-91-8-218/172.18.0.124:46353: java.nio.channels.ClosedChannelException | org.apache.spark.network.client.Tra
nsportClient$2.operationComplete(TransportClient.java:174)
java.nio.channels.ClosedChannelException
2016-07-13 10:10:44,929 | ERROR | [shuffle-server-1] | Failed to send RPC 8715801397093832896 to 9-91-8-208/172.18.0.115:50585: java.nio.channels.ClosedChannelException | org.apache.spark.network.client.Tra
nsportClient$2.operationComplete(TransportClient.java:174)
java.nio.channels.ClosedChannelException
2016-07-13 10:10:44,929 | ERROR | [shuffle-server-0] | Failed to send RPC 7130936020310576573 to 9-91-8-208/172.18.0.115:50597: java.nio.channels.ClosedChannelException | org.apache.spark.network.client.Tra
nsportClient$2.operationComplete(TransportClient.java:174)
java.nio.channels.ClosedChannelException
2016-07-13 10:10:44,929 | ERROR | [shuffle-server-3] | Failed to send RPC 5337112436358516213 to 9-91-8-219/172.18.0.116:56608: java.nio.channels.ClosedChannelException | org.apache.spark.network.client.Tra
nsportClient$2.operationComplete(TransportClient.java:174)
###
it last for a very long time (from 10:00 a.m. to 8:30 p.m.), and failed with too many executors failed(which is caused by error send message RetrieveSparkProps to Driver side).
> Netty RPC didn't check channel is active before sending message
> ---------------------------------------------------------------
>
> Key: SPARK-14559
> URL: https://issues.apache.org/jira/browse/SPARK-14559
> Project: Spark
> Issue Type: Bug
> Components: Spark Core
> Affects Versions: 1.6.0, 1.6.1
> Environment: spark1.6.1 hadoop2.2.0 jdk1.8.0_65
> Reporter: cen yuhai
>
> I have a long-running service. After running for serveral hours, It throwed these exceptions. I found that before sending rpc request by calling sendRpc method in TransportClient, there is no check that whether the channel is still open or active ?
> java.nio.channels.ClosedChannelException
> 4865 16/04/12 11:24:00 ERROR TransportClient: Failed to send RPC 5635696155204230556 to bigdata-arch-hdp407.bh.diditaxi.com/10.234.23.107:55197: java.nio.
> channels.ClosedChannelException
> 4866 java.nio.channels.ClosedChannelException
> 4867 16/04/12 11:24:00 ERROR TransportClient: Failed to send RPC 7319486003318455703 to bigdata-arch-hdp1235.bh.diditaxi.com/10.168.145.239:36439: java.nio.
> channels.ClosedChannelException
> 4868 java.nio.channels.ClosedChannelException
> 4869 16/04/12 11:24:00 ERROR TransportClient: Failed to send RPC 9041854451893215954 to bigdata-arch-hdp1398.bh.diditaxi.com/10.248.117.216:26801: java.nio.
> channels.ClosedChannelException
> 4870 java.nio.channels.ClosedChannelException
> 4871 16/04/12 11:24:00 ERROR TransportClient: Failed to send RPC 6046473497871624501 to bigdata-arch-hdp948.bh.diditaxi.com/10.118.114.81:41903: java.nio.
> channels.ClosedChannelException
> 4872 java.nio.channels.ClosedChannelException
> 4873 16/04/12 11:24:00 ERROR TransportClient: Failed to send RPC 9085605650438705047 to bigdata-arch-hdp1126.bh.diditaxi.com/10.168.146.78:27023: java.nio.
> channels.ClosedChannelException
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
---------------------------------------------------------------------
To unsubscribe, e-mail: issues-unsubscribe@spark.apache.org
For additional commands, e-mail: issues-help@spark.apache.org