You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@flink.apache.org by "Xintong Song (Jira)" <ji...@apache.org> on 2021/08/13 02:50:00 UTC

[jira] [Created] (FLINK-23746) SuccessAfterNetworkBuffersFailureITCase.testSuccessfulProgramAfterFailure fails due to AskTimeoutException

Xintong Song created FLINK-23746:
------------------------------------

             Summary: SuccessAfterNetworkBuffersFailureITCase.testSuccessfulProgramAfterFailure fails due to AskTimeoutException
                 Key: FLINK-23746
                 URL: https://issues.apache.org/jira/browse/FLINK-23746
             Project: Flink
          Issue Type: Bug
          Components: Runtime / Coordination
    Affects Versions: 1.14.0
            Reporter: Xintong Song
             Fix For: 1.14.0


https://dev.azure.com/apache-flink/apache-flink/_build/results?buildId=22020&view=logs&j=a57e0635-3fad-5b08-57c7-a4142d7d6fa9&t=2ef0effc-1da1-50e5-c2bd-aab434b1c5b7&l=10401

{code}
Aug 12 23:01:56 [ERROR] Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 33.224 s <<< FAILURE! - in org.apache.flink.test.misc.SuccessAfterNetworkBuffersFailureITCase
Aug 12 23:01:56 [ERROR] testSuccessfulProgramAfterFailure  Time elapsed: 20.554 s  <<< ERROR!
Aug 12 23:01:56 org.apache.flink.runtime.client.JobExecutionException: Job execution failed.
Aug 12 23:01:56 	at org.apache.flink.runtime.jobmaster.JobResult.toJobExecutionResult(JobResult.java:144)
Aug 12 23:01:56 	at org.apache.flink.runtime.minicluster.MiniClusterJobClient.lambda$getJobExecutionResult$3(MiniClusterJobClient.java:137)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:616)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:591)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.complete(CompletableFuture.java:1975)
Aug 12 23:01:56 	at org.apache.flink.runtime.rpc.akka.AkkaInvocationHandler.lambda$invokeRpc$0(AkkaInvocationHandler.java:250)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:774)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:750)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.complete(CompletableFuture.java:1975)
Aug 12 23:01:56 	at org.apache.flink.util.concurrent.FutureUtils.doForward(FutureUtils.java:1389)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.ClassLoadingUtils.lambda$null$1(ClassLoadingUtils.java:93)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.ClassLoadingUtils.runWithContextClassLoader(ClassLoadingUtils.java:68)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.ClassLoadingUtils.lambda$guardCompletionWithContextClassLoader$2(ClassLoadingUtils.java:92)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:774)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:750)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.complete(CompletableFuture.java:1975)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.AkkaFutureUtils$1.onComplete(AkkaFutureUtils.java:47)
Aug 12 23:01:56 	at akka.dispatch.OnComplete.internal(Future.scala:300)
Aug 12 23:01:56 	at akka.dispatch.OnComplete.internal(Future.scala:297)
Aug 12 23:01:56 	at akka.dispatch.japi$CallbackBridge.apply(Future.scala:224)
Aug 12 23:01:56 	at akka.dispatch.japi$CallbackBridge.apply(Future.scala:221)
Aug 12 23:01:56 	at scala.concurrent.impl.CallbackRunnable.run(Promise.scala:60)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.AkkaFutureUtils$DirectExecutionContext.execute(AkkaFutureUtils.java:65)
Aug 12 23:01:56 	at scala.concurrent.impl.CallbackRunnable.executeWithValue(Promise.scala:68)
Aug 12 23:01:56 	at scala.concurrent.impl.Promise$DefaultPromise.$anonfun$tryComplete$1(Promise.scala:284)
Aug 12 23:01:56 	at scala.concurrent.impl.Promise$DefaultPromise.$anonfun$tryComplete$1$adapted(Promise.scala:284)
Aug 12 23:01:56 	at scala.concurrent.impl.Promise$DefaultPromise.tryComplete(Promise.scala:284)
Aug 12 23:01:56 	at akka.pattern.PromiseActorRef.$bang(AskSupport.scala:621)
Aug 12 23:01:56 	at akka.pattern.PipeToSupport$PipeableFuture$$anonfun$pipeTo$1.applyOrElse(PipeToSupport.scala:24)
Aug 12 23:01:56 	at akka.pattern.PipeToSupport$PipeableFuture$$anonfun$pipeTo$1.applyOrElse(PipeToSupport.scala:23)
Aug 12 23:01:56 	at scala.concurrent.Future.$anonfun$andThen$1(Future.scala:532)
Aug 12 23:01:56 	at scala.concurrent.impl.Promise.liftedTree1$1(Promise.scala:29)
Aug 12 23:01:56 	at scala.concurrent.impl.Promise.$anonfun$transform$1(Promise.scala:29)
Aug 12 23:01:56 	at scala.concurrent.impl.CallbackRunnable.run(Promise.scala:60)
Aug 12 23:01:56 	at akka.dispatch.BatchingExecutor$AbstractBatch.processBatch(BatchingExecutor.scala:63)
Aug 12 23:01:56 	at akka.dispatch.BatchingExecutor$BlockableBatch.$anonfun$run$1(BatchingExecutor.scala:100)
Aug 12 23:01:56 	at scala.runtime.java8.JFunction0$mcV$sp.apply(JFunction0$mcV$sp.java:12)
Aug 12 23:01:56 	at scala.concurrent.BlockContext$.withBlockContext(BlockContext.scala:81)
Aug 12 23:01:56 	at akka.dispatch.BatchingExecutor$BlockableBatch.run(BatchingExecutor.scala:100)
Aug 12 23:01:56 	at akka.dispatch.TaskInvocation.run(AbstractDispatcher.scala:49)
Aug 12 23:01:56 	at akka.dispatch.ForkJoinExecutorConfigurator$AkkaForkJoinTask.exec(ForkJoinExecutorConfigurator.scala:48)
Aug 12 23:01:56 	at java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:289)
Aug 12 23:01:56 	at java.util.concurrent.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:1056)
Aug 12 23:01:56 	at java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1692)
Aug 12 23:01:56 	at java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:175)
Aug 12 23:01:56 Caused by: org.apache.flink.runtime.JobException: Recovery is suppressed by NoRestartBackoffTimeStrategy
Aug 12 23:01:56 	at org.apache.flink.runtime.executiongraph.failover.flip1.ExecutionFailureHandler.handleFailure(ExecutionFailureHandler.java:138)
Aug 12 23:01:56 	at org.apache.flink.runtime.executiongraph.failover.flip1.ExecutionFailureHandler.getFailureHandlingResult(ExecutionFailureHandler.java:82)
Aug 12 23:01:56 	at org.apache.flink.runtime.scheduler.DefaultScheduler.handleTaskFailure(DefaultScheduler.java:228)
Aug 12 23:01:56 	at org.apache.flink.runtime.scheduler.DefaultScheduler.maybeHandleTaskFailure(DefaultScheduler.java:218)
Aug 12 23:01:56 	at org.apache.flink.runtime.scheduler.DefaultScheduler.updateTaskExecutionStateInternal(DefaultScheduler.java:209)
Aug 12 23:01:56 	at org.apache.flink.runtime.scheduler.SchedulerBase.updateTaskExecutionState(SchedulerBase.java:679)
Aug 12 23:01:56 	at org.apache.flink.runtime.scheduler.UpdateSchedulerNgOnInternalFailuresListener.notifyTaskFailure(UpdateSchedulerNgOnInternalFailuresListener.java:51)
Aug 12 23:01:56 	at org.apache.flink.runtime.executiongraph.DefaultExecutionGraph.notifySchedulerNgAboutInternalTaskFailure(DefaultExecutionGraph.java:1465)
Aug 12 23:01:56 	at org.apache.flink.runtime.executiongraph.Execution.processFail(Execution.java:1130)
Aug 12 23:01:56 	at org.apache.flink.runtime.executiongraph.Execution.processFail(Execution.java:1070)
Aug 12 23:01:56 	at org.apache.flink.runtime.executiongraph.Execution.markFailed(Execution.java:909)
Aug 12 23:01:56 	at org.apache.flink.runtime.executiongraph.Execution.lambda$deploy$5(Execution.java:613)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:774)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:750)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$Completion.run(CompletableFuture.java:456)
Aug 12 23:01:56 	at org.apache.flink.runtime.rpc.akka.AkkaRpcActor.lambda$handleRunAsync$4(AkkaRpcActor.java:455)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.ClassLoadingUtils.runWithContextClassLoader(ClassLoadingUtils.java:68)
Aug 12 23:01:56 	at org.apache.flink.runtime.rpc.akka.AkkaRpcActor.handleRunAsync(AkkaRpcActor.java:455)
Aug 12 23:01:56 	at org.apache.flink.runtime.rpc.akka.AkkaRpcActor.handleRpcMessage(AkkaRpcActor.java:213)
Aug 12 23:01:56 	at org.apache.flink.runtime.rpc.akka.FencedAkkaRpcActor.handleRpcMessage(FencedAkkaRpcActor.java:78)
Aug 12 23:01:56 	at org.apache.flink.runtime.rpc.akka.AkkaRpcActor.handleMessage(AkkaRpcActor.java:163)
Aug 12 23:01:56 	at akka.japi.pf.UnitCaseStatement.apply(CaseStatements.scala:24)
Aug 12 23:01:56 	at akka.japi.pf.UnitCaseStatement.apply(CaseStatements.scala:20)
Aug 12 23:01:56 	at scala.PartialFunction.applyOrElse(PartialFunction.scala:123)
Aug 12 23:01:56 	at scala.PartialFunction.applyOrElse$(PartialFunction.scala:122)
Aug 12 23:01:56 	at akka.japi.pf.UnitCaseStatement.applyOrElse(CaseStatements.scala:20)
Aug 12 23:01:56 	at scala.PartialFunction$OrElse.applyOrElse(PartialFunction.scala:171)
Aug 12 23:01:56 	at scala.PartialFunction$OrElse.applyOrElse(PartialFunction.scala:172)
Aug 12 23:01:56 	at scala.PartialFunction$OrElse.applyOrElse(PartialFunction.scala:172)
Aug 12 23:01:56 	at akka.actor.Actor.aroundReceive(Actor.scala:537)
Aug 12 23:01:56 	at akka.actor.Actor.aroundReceive$(Actor.scala:535)
Aug 12 23:01:56 	at akka.actor.AbstractActor.aroundReceive(AbstractActor.scala:220)
Aug 12 23:01:56 	at akka.actor.ActorCell.receiveMessage(ActorCell.scala:580)
Aug 12 23:01:56 	at akka.actor.ActorCell.invoke(ActorCell.scala:548)
Aug 12 23:01:56 	at akka.dispatch.Mailbox.processMailbox(Mailbox.scala:270)
Aug 12 23:01:56 	at akka.dispatch.Mailbox.run(Mailbox.scala:231)
Aug 12 23:01:56 	at akka.dispatch.Mailbox.exec(Mailbox.scala:243)
Aug 12 23:01:56 	... 4 more
Aug 12 23:01:56 Caused by: java.util.concurrent.CompletionException: java.util.concurrent.TimeoutException: Invocation of [LocalRpcInvocation(TaskExecutorGateway.submitTask(TaskDeploymentDescriptor, JobMasterId, Time))] at recipient [akka://flink/user/rpc/taskmanager_1] timed out.
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.encodeRelay(CompletableFuture.java:326)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.completeRelay(CompletableFuture.java:338)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.uniRelay(CompletableFuture.java:925)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$UniRelay.tryFire(CompletableFuture.java:913)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:1990)
Aug 12 23:01:56 	at org.apache.flink.runtime.rpc.akka.AkkaInvocationHandler.lambda$invokeRpc$0(AkkaInvocationHandler.java:246)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:774)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:750)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:1990)
Aug 12 23:01:56 	at org.apache.flink.util.concurrent.FutureUtils.doForward(FutureUtils.java:1387)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.ClassLoadingUtils.lambda$null$1(ClassLoadingUtils.java:93)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.ClassLoadingUtils.runWithContextClassLoader(ClassLoadingUtils.java:68)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.ClassLoadingUtils.lambda$guardCompletionWithContextClassLoader$2(ClassLoadingUtils.java:92)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:774)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:750)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:1990)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.AkkaFutureUtils$1.onComplete(AkkaFutureUtils.java:45)
Aug 12 23:01:56 	at akka.dispatch.OnComplete.internal(Future.scala:299)
Aug 12 23:01:56 	at akka.dispatch.OnComplete.internal(Future.scala:297)
Aug 12 23:01:56 	at akka.dispatch.japi$CallbackBridge.apply(Future.scala:224)
Aug 12 23:01:56 	at akka.dispatch.japi$CallbackBridge.apply(Future.scala:221)
Aug 12 23:01:56 	at scala.concurrent.impl.CallbackRunnable.run(Promise.scala:60)
Aug 12 23:01:56 	at org.apache.flink.runtime.concurrent.akka.AkkaFutureUtils$DirectExecutionContext.execute(AkkaFutureUtils.java:65)
Aug 12 23:01:56 	at scala.concurrent.impl.CallbackRunnable.executeWithValue(Promise.scala:68)
Aug 12 23:01:56 	at scala.concurrent.impl.Promise$DefaultPromise.$anonfun$tryComplete$1(Promise.scala:284)
Aug 12 23:01:56 	at scala.concurrent.impl.Promise$DefaultPromise.$anonfun$tryComplete$1$adapted(Promise.scala:284)
Aug 12 23:01:56 	at scala.concurrent.impl.Promise$DefaultPromise.tryComplete(Promise.scala:284)
Aug 12 23:01:56 	at akka.pattern.PromiseActorRef$.$anonfun$apply$1(AskSupport.scala:729)
Aug 12 23:01:56 	at akka.actor.Scheduler$$anon$7.run(Scheduler.scala:479)
Aug 12 23:01:56 	at akka.dispatch.internal.SameThreadExecutionContext$$anon$1.unbatchedExecute(SameThreadExecutionContext.scala:21)
Aug 12 23:01:56 	at akka.dispatch.BatchingExecutor.execute(BatchingExecutor.scala:133)
Aug 12 23:01:56 	at akka.dispatch.BatchingExecutor.execute$(BatchingExecutor.scala:124)
Aug 12 23:01:56 	at akka.dispatch.internal.SameThreadExecutionContext$$anon$1.execute(SameThreadExecutionContext.scala:20)
Aug 12 23:01:56 	at akka.actor.LightArrayRevolverScheduler$TaskHolder.executeTask(LightArrayRevolverScheduler.scala:365)
Aug 12 23:01:56 	at akka.actor.LightArrayRevolverScheduler$$anon$3.executeBucket$1(LightArrayRevolverScheduler.scala:314)
Aug 12 23:01:56 	at akka.actor.LightArrayRevolverScheduler$$anon$3.nextTick(LightArrayRevolverScheduler.scala:318)
Aug 12 23:01:56 	at akka.actor.LightArrayRevolverScheduler$$anon$3.run(LightArrayRevolverScheduler.scala:270)
Aug 12 23:01:56 	at java.lang.Thread.run(Thread.java:748)
Aug 12 23:01:56 Caused by: java.util.concurrent.TimeoutException: Invocation of [LocalRpcInvocation(TaskExecutorGateway.submitTask(TaskDeploymentDescriptor, JobMasterId, Time))] at recipient [akka://flink/user/rpc/taskmanager_1] timed out.
Aug 12 23:01:56 	at org.apache.flink.runtime.jobmaster.RpcTaskManagerGateway.submitTask(RpcTaskManagerGateway.java:60)
Aug 12 23:01:56 	at org.apache.flink.runtime.executiongraph.Execution.lambda$deploy$4(Execution.java:589)
Aug 12 23:01:56 	at java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1604)
Aug 12 23:01:56 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
Aug 12 23:01:56 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
Aug 12 23:01:56 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
Aug 12 23:01:56 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
Aug 12 23:01:56 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
Aug 12 23:01:56 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
Aug 12 23:01:56 	... 1 more
Aug 12 23:01:56 Caused by: akka.pattern.AskTimeoutException: Ask timed out on [Actor[akka://flink/user/rpc/taskmanager_1#-791314098]] after [10000 ms]. Message of type [org.apache.flink.runtime.rpc.messages.LocalRpcInvocation]. A typical reason for `AskTimeoutException` is that the recipient actor didn't send a reply.
{code}



--
This message was sent by Atlassian Jira
(v8.3.4#803005)