Uploaded image for project: 'Flink'
  1. Flink
  2. FLINK-21104

UnalignedCheckpointITCase.execute failed with "IllegalStateException"

    XMLWordPrintableJSON

Details

    Description

      https://dev.azure.com/apache-flink/apache-flink/_build/results?buildId=12383&view=logs&j=5c8e7682-d68f-54d1-16a2-a09310218a49&t=f508e270-48d6-5f1e-3138-42a17e0714f0

      2021-01-22T15:17:34.6711152Z [ERROR] execute[Parallel union, p = 10](org.apache.flink.test.checkpointing.UnalignedCheckpointITCase)  Time elapsed: 3.903 s  <<< ERROR!
2021-01-22T15:17:34.6711736Z org.apache.flink.runtime.client.JobExecutionException: Job execution failed.
2021-01-22T15:17:34.6712204Z 	at org.apache.flink.runtime.jobmaster.JobResult.toJobExecutionResult(JobResult.java:144)
2021-01-22T15:17:34.6712779Z 	at org.apache.flink.runtime.minicluster.MiniClusterJobClient.lambda$getJobExecutionResult$2(MiniClusterJobClient.java:117)
2021-01-22T15:17:34.6713344Z 	at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:616)
2021-01-22T15:17:34.6713816Z 	at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:591)
2021-01-22T15:17:34.6714454Z 	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488)
2021-01-22T15:17:34.6714952Z 	at java.util.concurrent.CompletableFuture.complete(CompletableFuture.java:1975)
2021-01-22T15:17:34.6715472Z 	at org.apache.flink.runtime.rpc.akka.AkkaInvocationHandler.lambda$invokeRpc$0(AkkaInvocationHandler.java:238)
2021-01-22T15:17:34.6716026Z 	at java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:774)
2021-01-22T15:17:34.6716631Z 	at java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:750)
2021-01-22T15:17:34.6717128Z 	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488)
2021-01-22T15:17:34.6717616Z 	at java.util.concurrent.CompletableFuture.complete(CompletableFuture.java:1975)
2021-01-22T15:17:34.6718105Z 	at org.apache.flink.runtime.concurrent.FutureUtils$1.onComplete(FutureUtils.java:1046)
2021-01-22T15:17:34.6718596Z 	at akka.dispatch.OnComplete.internal(Future.scala:264)
2021-01-22T15:17:34.6718973Z 	at akka.dispatch.OnComplete.internal(Future.scala:261)
2021-01-22T15:17:34.6719364Z 	at akka.dispatch.japi$CallbackBridge.apply(Future.scala:191)
2021-01-22T15:17:34.6719748Z 	at akka.dispatch.japi$CallbackBridge.apply(Future.scala:188)
2021-01-22T15:17:34.6720155Z 	at scala.concurrent.impl.CallbackRunnable.run(Promise.scala:36)
2021-01-22T15:17:34.6720641Z 	at org.apache.flink.runtime.concurrent.Executors$DirectExecutionContext.execute(Executors.java:73)
2021-01-22T15:17:34.6721236Z 	at scala.concurrent.impl.CallbackRunnable.executeWithValue(Promise.scala:44)
2021-01-22T15:17:34.6721706Z 	at scala.concurrent.impl.Promise$DefaultPromise.tryComplete(Promise.scala:252)
2021-01-22T15:17:34.6722205Z 	at akka.pattern.PromiseActorRef.$bang(AskSupport.scala:572)
2021-01-22T15:17:34.6722663Z 	at akka.pattern.PipeToSupport$PipeableFuture$$anonfun$pipeTo$1.applyOrElse(PipeToSupport.scala:22)
2021-01-22T15:17:34.6723214Z 	at akka.pattern.PipeToSupport$PipeableFuture$$anonfun$pipeTo$1.applyOrElse(PipeToSupport.scala:21)
2021-01-22T15:17:34.6723723Z 	at scala.concurrent.Future$$anonfun$andThen$1.apply(Future.scala:436)
2021-01-22T15:17:34.6724146Z 	at scala.concurrent.Future$$anonfun$andThen$1.apply(Future.scala:435)
2021-01-22T15:17:34.6724726Z 	at scala.concurrent.impl.CallbackRunnable.run(Promise.scala:36)
2021-01-22T15:17:34.6725198Z 	at akka.dispatch.BatchingExecutor$AbstractBatch.processBatch(BatchingExecutor.scala:55)
2021-01-22T15:17:34.6725861Z 	at akka.dispatch.BatchingExecutor$BlockableBatch$$anonfun$run$1.apply$mcV$sp(BatchingExecutor.scala:91)
2021-01-22T15:17:34.6726525Z 	at akka.dispatch.BatchingExecutor$BlockableBatch$$anonfun$run$1.apply(BatchingExecutor.scala:91)
2021-01-22T15:17:34.6727278Z 	at akka.dispatch.BatchingExecutor$BlockableBatch$$anonfun$run$1.apply(BatchingExecutor.scala:91)
2021-01-22T15:17:34.6727773Z 	at scala.concurrent.BlockContext$.withBlockContext(BlockContext.scala:72)
2021-01-22T15:17:34.6728484Z 	at akka.dispatch.BatchingExecutor$BlockableBatch.run(BatchingExecutor.scala:90)
2021-01-22T15:17:34.6728969Z 	at akka.dispatch.TaskInvocation.run(AbstractDispatcher.scala:40)
2021-01-22T15:17:34.6729666Z 	at akka.dispatch.ForkJoinExecutorConfigurator$AkkaForkJoinTask.exec(ForkJoinExecutorConfigurator.scala:44)
2021-01-22T15:17:34.6730373Z 	at akka.dispatch.forkjoin.ForkJoinTask.doExec(ForkJoinTask.java:260)
2021-01-22T15:17:34.6731022Z 	at akka.dispatch.forkjoin.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:1339)
2021-01-22T15:17:34.6731538Z 	at akka.dispatch.forkjoin.ForkJoinPool.runWorker(ForkJoinPool.java:1979)
2021-01-22T15:17:34.6732005Z 	at akka.dispatch.forkjoin.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:107)
2021-01-22T15:17:34.6732658Z Caused by: org.apache.flink.runtime.JobException: Recovery is suppressed by FixedDelayRestartBackoffTimeStrategy(maxNumberRestartAttempts=5, backoffTimeMS=100)
2021-01-22T15:17:34.6733458Z 	at org.apache.flink.runtime.executiongraph.failover.flip1.ExecutionFailureHandler.handleFailure(ExecutionFailureHandler.java:118)
2021-01-22T15:17:34.6734201Z 	at org.apache.flink.runtime.executiongraph.failover.flip1.ExecutionFailureHandler.getFailureHandlingResult(ExecutionFailureHandler.java:80)
2021-01-22T15:17:34.6735053Z 	at org.apache.flink.runtime.scheduler.DefaultScheduler.handleTaskFailure(DefaultScheduler.java:221)
2021-01-22T15:17:34.6735609Z 	at org.apache.flink.runtime.scheduler.DefaultScheduler.maybeHandleTaskFailure(DefaultScheduler.java:212)
2021-01-22T15:17:34.6736307Z 	at org.apache.flink.runtime.scheduler.DefaultScheduler.updateTaskExecutionStateInternal(DefaultScheduler.java:203)
2021-01-22T15:17:34.6736911Z 	at org.apache.flink.runtime.scheduler.SchedulerBase.updateTaskExecutionState(SchedulerBase.java:655)
2021-01-22T15:17:34.6737449Z 	at org.apache.flink.runtime.scheduler.SchedulerNG.updateTaskExecutionState(SchedulerNG.java:81)
2021-01-22T15:17:34.6737982Z 	at org.apache.flink.runtime.jobmaster.JobMaster.updateTaskExecutionState(JobMaster.java:434)
2021-01-22T15:17:34.6738537Z 	at sun.reflect.GeneratedMethodAccessor19.invoke(Unknown Source)
2021-01-22T15:17:34.6738959Z 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2021-01-22T15:17:34.6739411Z 	at java.lang.reflect.Method.invoke(Method.java:498)
2021-01-22T15:17:34.6739868Z 	at org.apache.flink.runtime.rpc.akka.AkkaRpcActor.handleRpcInvocation(AkkaRpcActor.java:306)
2021-01-22T15:17:34.6740384Z 	at org.apache.flink.runtime.rpc.akka.AkkaRpcActor.handleRpcMessage(AkkaRpcActor.java:213)
2021-01-22T15:17:34.6741074Z 	at org.apache.flink.runtime.rpc.akka.FencedAkkaRpcActor.handleRpcMessage(FencedAkkaRpcActor.java:77)
2021-01-22T15:17:34.6741613Z 	at org.apache.flink.runtime.rpc.akka.AkkaRpcActor.handleMessage(AkkaRpcActor.java:159)
2021-01-22T15:17:34.6742141Z 	at akka.japi.pf.UnitCaseStatement.apply(CaseStatements.scala:26)
2021-01-22T15:17:34.6742562Z 	at akka.japi.pf.UnitCaseStatement.apply(CaseStatements.scala:21)
2021-01-22T15:17:34.6742996Z 	at scala.PartialFunction$class.applyOrElse(PartialFunction.scala:123)
2021-01-22T15:17:34.6743424Z 	at akka.japi.pf.UnitCaseStatement.applyOrElse(CaseStatements.scala:21)
2021-01-22T15:17:34.6743880Z 	at scala.PartialFunction$OrElse.applyOrElse(PartialFunction.scala:170)
2021-01-22T15:17:34.6744460Z 	at scala.PartialFunction$OrElse.applyOrElse(PartialFunction.scala:171)
2021-01-22T15:17:34.6744893Z 	at scala.PartialFunction$OrElse.applyOrElse(PartialFunction.scala:171)
2021-01-22T15:17:34.6745316Z 	at akka.actor.Actor$class.aroundReceive(Actor.scala:517)
2021-01-22T15:17:34.6745743Z 	at akka.actor.AbstractActor.aroundReceive(AbstractActor.scala:225)
2021-01-22T15:17:34.6746231Z 	at akka.actor.ActorCell.receiveMessage(ActorCell.scala:592)
2021-01-22T15:17:34.6746634Z 	at akka.actor.ActorCell.invoke(ActorCell.scala:561)
2021-01-22T15:17:34.6747025Z 	at akka.dispatch.Mailbox.processMailbox(Mailbox.scala:258)
2021-01-22T15:17:34.6747539Z 	at akka.dispatch.Mailbox.run(Mailbox.scala:225)
2021-01-22T15:17:34.6748083Z 	at akka.dispatch.Mailbox.exec(Mailbox.scala:235)
2021-01-22T15:17:34.6748542Z 	... 4 more
2021-01-22T15:17:34.6749084Z Caused by: java.lang.IllegalStateException: Internal error, #stopPersisting for last checkpoint has not been called.
2021-01-22T15:17:34.6749801Z 	at org.apache.flink.util.Preconditions.checkState(Preconditions.java:193)
2021-01-22T15:17:34.6750591Z 	at org.apache.flink.runtime.io.network.partition.consumer.ChannelStatePersister.startPersisting(ChannelStatePersister.java:76)
2021-01-22T15:17:34.6751492Z 	at org.apache.flink.runtime.io.network.partition.consumer.LocalInputChannel.checkpointStarted(LocalInputChannel.java:127)
2021-01-22T15:17:34.6752218Z 	at org.apache.flink.runtime.io.network.partition.consumer.IndexedInputGate.checkpointStarted(IndexedInputGate.java:36)
2021-01-22T15:17:34.6753167Z 	at org.apache.flink.streaming.runtime.io.checkpointing.UnalignedController.preProcessFirstBarrier(UnalignedController.java:72)
2021-01-22T15:17:34.6753967Z 	at org.apache.flink.streaming.runtime.io.checkpointing.AlternatingController.preProcessFirstBarrier(AlternatingController.java:116)
2021-01-22T15:17:34.6754832Z 	at org.apache.flink.streaming.runtime.io.checkpointing.SingleCheckpointBarrierHandler.handleBarrier(SingleCheckpointBarrierHandler.java:170)
2021-01-22T15:17:34.6755708Z 	at org.apache.flink.streaming.runtime.io.checkpointing.SingleCheckpointBarrierHandler.processBarrier(SingleCheckpointBarrierHandler.java:128)
2021-01-22T15:17:34.6756473Z 	at org.apache.flink.streaming.runtime.io.checkpointing.CheckpointedInputGate.handleEvent(CheckpointedInputGate.java:179)
2021-01-22T15:17:34.6757119Z 	at org.apache.flink.streaming.runtime.io.checkpointing.CheckpointedInputGate.pollNext(CheckpointedInputGate.java:156)
2021-01-22T15:17:34.6757726Z 	at org.apache.flink.streaming.runtime.io.StreamTaskNetworkInput.emitNext(StreamTaskNetworkInput.java:180)
2021-01-22T15:17:34.6758401Z 	at org.apache.flink.streaming.runtime.io.StreamOneInputProcessor.processInput(StreamOneInputProcessor.java:65)
2021-01-22T15:17:34.6758943Z 	at org.apache.flink.streaming.runtime.tasks.StreamTask.processInput(StreamTask.java:400)
2021-01-22T15:17:34.6759507Z 	at org.apache.flink.streaming.runtime.tasks.mailbox.MailboxProcessor.runMailboxLoop(MailboxProcessor.java:190)
2021-01-22T15:17:34.6760075Z 	at org.apache.flink.streaming.runtime.tasks.StreamTask.runMailboxLoop(StreamTask.java:609)
2021-01-22T15:17:34.6760567Z 	at org.apache.flink.streaming.runtime.tasks.StreamTask.invoke(StreamTask.java:573)
2021-01-22T15:17:34.6761032Z 	at org.apache.flink.runtime.taskmanager.Task.doRun(Task.java:763)
2021-01-22T15:17:34.6761601Z 	at org.apache.flink.runtime.taskmanager.Task.run(Task.java:565)
2021-01-22T15:17:34.6761957Z 	at java.lang.Thread.run(Thread.java:748)

      Attachments

        Issue Links

          is caused by

          Bug - A problem which impairs or prevents the functions of the product. FLINK-20654 Unaligned checkpoint recovery may lead to corrupted data stream

          • Critical - Crashes, loss of data, severe memory leak.
          • Closed
          is duplicated by

          New Feature - A new feature of the product, which has yet to be developed. FLINK-21137 Maven plugin surefire failed due to test failure

          • Major - Major loss of function.
          • Closed
          relates to

          Bug - A problem which impairs or prevents the functions of the product. FLINK-20824 BlockingShuffleITCase. testSortMergeBlockingShuffle test failed with "Inconsistent availability: expected true"

          • Critical - Crashes, loss of data, severe memory leak.
          • Closed
          links to

          Web Link GitHub Pull Request #14736

          Web Link GitHub Pull Request #14750

          Web Link GitHub Pull Request #14797

          Activity

            People

              pnowojski Piotr Nowojski
              hxbks2ks Huang Xingbo
              Votes:
              0 Vote for this issue
              Watchers:
              9 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved: