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

[jira] [Created] (FLINK-21659) Running HA per-job cluster (rocks, incremental) end-to-end test fails

Guowei Ma created FLINK-21659:
---------------------------------

             Summary: Running HA per-job cluster (rocks, incremental) end-to-end test fails
                 Key: FLINK-21659
                 URL: https://issues.apache.org/jira/browse/FLINK-21659
             Project: Flink
          Issue Type: Bug
          Components: Runtime / Checkpointing
    Affects Versions: 1.13.0
            Reporter: Guowei Ma


https://dev.azure.com/apache-flink/apache-flink/_build/results?buildId=14232&view=logs&j=4dd4dbdd-1802-5eb7-a518-6acd9d24d0fc&t=8d6b4dd3-4ca1-5611-1743-57a7d76b395a

It seems that the task deployed to the TaskManager0 is stuck and cause that the checkpoint fails.

{code:java}
java.util.concurrent.CompletionException: java.util.concurrent.TimeoutException: Invocation of public abstract java.util.concurrent.CompletableFuture org.apache.flink.runtime.taskexecutor.TaskExecutorGateway.submitTask(org.apache.flink.runtime.deployment.TaskDeploymentDescriptor,org.apache.flink.runtime.jobmaster.JobMasterId,org.apache.flink.api.common.time.Time) timed out.
        at java.util.concurrent.CompletableFuture.encodeRelay(CompletableFuture.java:326) ~[?:1.8.0_282]
        at java.util.concurrent.CompletableFuture.completeRelay(CompletableFuture.java:338) ~[?:1.8.0_282]
        at java.util.concurrent.CompletableFuture.uniRelay(CompletableFuture.java:925) ~[?:1.8.0_282]
        at java.util.concurrent.CompletableFuture$UniRelay.tryFire(CompletableFuture.java:913) ~[?:1.8.0_282]
        at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488) ~[?:1.8.0_282]
        at java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:1990) ~[?:1.8.0_282]
        at org.apache.flink.runtime.rpc.akka.AkkaInvocationHandler.lambda$invokeRpc$0(AkkaInvocationHandler.java:234) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:774) ~[?:1.8.0_282]
        at java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:750) ~[?:1.8.0_282]
        at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:488) ~[?:1.8.0_282]
        at java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:1990) ~[?:1.8.0_282]
        at org.apache.flink.runtime.concurrent.FutureUtils$1.onComplete(FutureUtils.java:1064) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.dispatch.OnComplete.internal(Future.scala:263) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.dispatch.OnComplete.internal(Future.scala:261) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.dispatch.japi$CallbackBridge.apply(Future.scala:191) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.dispatch.japi$CallbackBridge.apply(Future.scala:188) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at scala.concurrent.impl.CallbackRunnable.run(Promise.scala:36) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at org.apache.flink.runtime.concurrent.Executors$DirectExecutionContext.execute(Executors.java:73) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at scala.concurrent.impl.CallbackRunnable.executeWithValue(Promise.scala:44) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at scala.concurrent.impl.Promise$DefaultPromise.tryComplete(Promise.scala:252) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.pattern.PromiseActorRef$$anonfun$1.apply$mcV$sp(AskSupport.scala:644) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.actor.Scheduler$$anon$4.run(Scheduler.scala:205) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at scala.concurrent.Future$InternalCallbackExecutor$.unbatchedExecute(Future.scala:601) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at scala.concurrent.BatchingExecutor$class.execute(BatchingExecutor.scala:109) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at scala.concurrent.Future$InternalCallbackExecutor$.execute(Future.scala:599) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.actor.LightArrayRevolverScheduler$TaskHolder.executeTask(LightArrayRevolverScheduler.scala:328) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.actor.LightArrayRevolverScheduler$$anon$4.executeBucket$1(LightArrayRevolverScheduler.scala:279) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.actor.LightArrayRevolverScheduler$$anon$4.nextTick(LightArrayRevolverScheduler.scala:283) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.actor.LightArrayRevolverScheduler$$anon$4.run(LightArrayRevolverScheduler.scala:235) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_282]
Caused by: java.util.concurrent.TimeoutException: Invocation of public abstract java.util.concurrent.CompletableFuture org.apache.flink.runtime.taskexecutor.TaskExecutorGateway.submitTask(org.apache.flink.runtime.deployment.TaskDeploymentDescriptor,org.apache.flink.runtime.jobmaster.JobMasterId,org.apache.flink.api.common.time.Time) timed out.
        at org.apache.flink.runtime.jobmaster.RpcTaskManagerGateway.submitTask(RpcTaskManagerGateway.java:60) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at org.apache.flink.runtime.executiongraph.Execution.lambda$deploy$5(Execution.java:592) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1604) ~[?:1.8.0_282]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) ~[?:1.8.0_282]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_282]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) ~[?:1.8.0_282]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) ~[?:1.8.0_282]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_282]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_282]
        ... 1 more
Caused by: akka.pattern.AskTimeoutException: Ask timed out on [Actor[akka.tcp://flink@10.1.0.4:35179/user/rpc/taskmanager_0#1422311381]] after [10000 ms]. Message of type [org.apache.flink.runtime.rpc.messages.RemoteRpcInvocation]. A typical reason for `AskTimeoutException` is that the recipient actor didn't send a reply.
        at akka.pattern.PromiseActorRef$$anonfun$2.apply(AskSupport.scala:635) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.pattern.PromiseActorRef$$anonfun$2.apply(AskSupport.scala:635) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        at akka.pattern.PromiseActorRef$$anonfun$1.apply$mcV$sp(AskSupport.scala:648) ~[flink-dist_2.11-1.13-SNAPSHOT.jar:1.13-SNAPSHOT]
        ... 9 more
{code}



{code:java}
2021-03-06 22:06:41,900 INFO  org.apache.flink.runtime.taskmanager.Task                    [] - SlidingWindowCheckMapper -> Sink: SlidingWindowCheckPrintSink (4/4)#0 (e3e42e42c7aba1b3aee131d1495a8879) switched from DEPLOYING to RUNNING.
2021-03-06 22:06:41,905 INFO  org.apache.flink.contrib.streaming.state.restore.RocksDBIncrementalRestoreOperation [] - Finished restoring from state handle: IncrementalRemoteKeyedStateHandle{backendIdentifier=cdfd9446-4af3-440c-b82a-49335ae76a73, keyGroupRange=KeyGroupRange{startKeyGroup=0, endKeyGroup=31}, checkpointId=1, sharedState={}, privateState={MANIFEST-000006=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/70bbf281-731e-4875-ba35-822dddcb901c', dataBytes=174}, OPTIONS-000010=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/fd7e14cf-26b4-405c-a345-b019acc5e7fd', dataBytes=10293}, CURRENT=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/fa1925de-4c05-448c-b919-6d4b2b32fecf', dataBytes=16}}, metaStateHandle=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/chk-1/8b92d764-54a9-428e-9af4-15c24f6b6b94', dataBytes=1759}, registered=false} without rescaling.
2021-03-06 22:06:41,905 INFO  org.apache.flink.contrib.streaming.state.RocksDBKeyedStateBackendBuilder [] - Finished building RocksDB keyed state-backend at /tmp/flink-io-04e0a1f5-82ce-4fc3-bfea-cf9a8062dc32/job_00000000000000000000000000000000_op_StreamFlatMap_149799a3e2c39804818236cc493c243c__1_4__uuid_60fc0ec3-548a-48a2-bd40-0e169a3af6a8.
2021-03-06 22:06:41,906 INFO  org.apache.flink.api.java.typeutils.TypeExtractor            [] - class org.apache.flink.streaming.tests.Event does not contain a setter for field key
2021-03-06 22:06:41,906 INFO  org.apache.flink.api.java.typeutils.TypeExtractor            [] - Class class org.apache.flink.streaming.tests.Event cannot be used as a POJO type because not all fields are valid POJO fields, and must be processed as GenericType. Please read the Flink documentation on "Data Types & Serialization" for details of the effect on performance.
2021-03-06 22:06:41,906 INFO  org.apache.flink.contrib.streaming.state.EmbeddedRocksDBStateBackend [] - Getting managed memory shared cache for RocksDB.
2021-03-06 22:06:41,906 INFO  org.apache.flink.contrib.streaming.state.EmbeddedRocksDBStateBackend [] - Obtained shared RocksDB cache of size 60397978 bytes
2021-03-06 22:06:41,913 INFO  org.apache.flink.runtime.io.network.partition.consumer.SingleInputGate [] - Converting recovered input channels (4 channels)
2021-03-06 22:06:41,922 INFO  org.apache.flink.contrib.streaming.state.restore.RocksDBIncrementalRestoreOperation [] - Starting to restore from state handle: IncrementalRemoteKeyedStateHandle{backendIdentifier=5b4d023f-89b6-4a32-9792-aef1c2025170, keyGroupRange=KeyGroupRange{startKeyGroup=96, endKeyGroup=127}, checkpointId=1, sharedState={}, privateState={MANIFEST-000006=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/1d83c262-60f2-4672-924a-b588f4b6eb8e', dataBytes=174}, OPTIONS-000010=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/58d63b81-3876-4c90-b811-372036f779a9', dataBytes=10293}, CURRENT=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/f436a46d-5705-4bea-96d5-8d2b9265e273', dataBytes=16}}, metaStateHandle=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/chk-1/9ae2387a-c160-478e-8c0c-0b7eea417902', dataBytes=1759}, registered=false} without rescaling.
2021-03-06 22:06:41,948 INFO  org.apache.flink.runtime.io.network.partition.consumer.SingleInputGate [] - Converting recovered input channels (4 channels)
2021-03-06 22:06:41,957 INFO  org.apache.flink.runtime.io.network.partition.consumer.SingleInputGate [] - Converting recovered input channels (4 channels)
2021-03-06 22:06:41,957 INFO  org.apache.flink.runtime.io.network.partition.consumer.SingleInputGate [] - Converting recovered input channels (4 channels)
2021-03-06 22:06:41,958 INFO  org.apache.flink.runtime.io.network.partition.consumer.SingleInputGate [] - Converting recovered input channels (4 channels)
2021-03-06 22:06:41,980 INFO  org.apache.flink.contrib.streaming.state.restore.RocksDBIncrementalRestoreOperation [] - Finished restoring from state handle: IncrementalRemoteKeyedStateHandle{backendIdentifier=5b4d023f-89b6-4a32-9792-aef1c2025170, keyGroupRange=KeyGroupRange{startKeyGroup=96, endKeyGroup=127}, checkpointId=1, sharedState={}, privateState={MANIFEST-000006=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/1d83c262-60f2-4672-924a-b588f4b6eb8e', dataBytes=174}, OPTIONS-000010=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/58d63b81-3876-4c90-b811-372036f779a9', dataBytes=10293}, CURRENT=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/f436a46d-5705-4bea-96d5-8d2b9265e273', dataBytes=16}}, metaStateHandle=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/chk-1/9ae2387a-c160-478e-8c0c-0b7eea417902', dataBytes=1759}, registered=false} without rescaling.
2021-03-06 22:06:41,980 INFO  org.apache.flink.contrib.streaming.state.RocksDBKeyedStateBackendBuilder [] - Finished building RocksDB keyed state-backend at /tmp/flink-io-04e0a1f5-82ce-4fc3-bfea-cf9a8062dc32/job_00000000000000000000000000000000_op_StreamFlatMap_149799a3e2c39804818236cc493c243c__4_4__uuid_fdb6da31-5938-4721-b2e7-cd9c1ed80e64.
2021-03-06 22:06:41,981 INFO  org.apache.flink.api.java.typeutils.TypeExtractor            [] - class org.apache.flink.streaming.tests.Event does not contain a setter for field key
2021-03-06 22:06:41,981 INFO  org.apache.flink.api.java.typeutils.TypeExtractor            [] - Class class org.apache.flink.streaming.tests.Event cannot be used as a POJO type because not all fields are valid POJO fields, and must be processed as GenericType. Please read the Flink documentation on "Data Types & Serialization" for details of the effect on performance.
2021-03-06 22:06:41,995 INFO  org.apache.flink.contrib.streaming.state.restore.RocksDBIncrementalRestoreOperation [] - Finished restoring from state handle: IncrementalRemoteKeyedStateHandle{backendIdentifier=ab6511b2-2f5a-461d-a792-596cc37335b2, keyGroupRange=KeyGroupRange{startKeyGroup=32, endKeyGroup=63}, checkpointId=1, sharedState={}, privateState={MANIFEST-000006=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/58d731de-71ee-4e0c-b6cb-6b3d8a40b9e8', dataBytes=174}, OPTIONS-000010=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/c1e99168-5764-43b3-94ac-2b47d52c9359', dataBytes=10293}, CURRENT=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/ebd20002-06a2-408f-af3e-96b2396f28bc', dataBytes=16}}, metaStateHandle=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/chk-1/abe86e2e-81b8-436b-ac5b-a7bfe99cd5b9', dataBytes=1759}, registered=false} without rescaling.
2021-03-06 22:06:41,995 INFO  org.apache.flink.contrib.streaming.state.RocksDBKeyedStateBackendBuilder [] - Finished building RocksDB keyed state-backend at /tmp/flink-io-04e0a1f5-82ce-4fc3-bfea-cf9a8062dc32/job_00000000000000000000000000000000_op_StreamFlatMap_149799a3e2c39804818236cc493c243c__2_4__uuid_3651a398-3cad-4213-9413-5a099e1be7a6.
2021-03-06 22:06:41,996 INFO  org.apache.flink.api.java.typeutils.TypeExtractor            [] - class org.apache.flink.streaming.tests.Event does not contain a setter for field key
2021-03-06 22:06:41,996 INFO  org.apache.flink.api.java.typeutils.TypeExtractor            [] - Class class org.apache.flink.streaming.tests.Event cannot be used as a POJO type because not all fields are valid POJO fields, and must be processed as GenericType. Please read the Flink documentation on "Data Types & Serialization" for details of the effect on performance.
2021-03-06 22:06:42,000 INFO  org.apache.flink.contrib.streaming.state.restore.RocksDBIncrementalRestoreOperation [] - Finished restoring from state handle: IncrementalRemoteKeyedStateHandle{backendIdentifier=31f91080-7828-43cd-9223-e2875f7f156e, keyGroupRange=KeyGroupRange{startKeyGroup=64, endKeyGroup=95}, checkpointId=1, sharedState={}, privateState={MANIFEST-000006=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/1e3a4fdb-cf0a-49fe-8245-585fa99ada6f', dataBytes=174}, OPTIONS-000010=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/4b13e65e-4b4e-4765-93a7-62d01d893c78', dataBytes=10293}, CURRENT=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/shared/e7e9b1e2-56a5-482a-9490-84475f4d393e', dataBytes=16}}, metaStateHandle=ByteStreamStateHandle{handleName='file:/home/vsts/work/1/s/flink-end-to-end-tests/test-scripts/temp-test-directory-24023426140/checkpoints/00000000000000000000000000000000/chk-1/e81bfead-083e-477d-9aad-43ee2d043d47', dataBytes=1759}, registered=false} without rescaling.
2021-03-06 22:06:42,000 INFO  org.apache.flink.contrib.streaming.state.RocksDBKeyedStateBackendBuilder [] - Finished building RocksDB keyed state-backend at /tmp/flink-io-04e0a1f5-82ce-4fc3-bfea-cf9a8062dc32/job_00000000000000000000000000000000_op_StreamFlatMap_149799a3e2c39804818236cc493c243c__3_4__uuid_a7f6e3d8-50ef-425d-a40e-49e856d6f799.
2021-03-06 22:06:42,000 INFO  org.apache.flink.api.java.typeutils.TypeExtractor            [] - class org.apache.flink.streaming.tests.Event does not contain a setter for field key
2021-03-06 22:06:42,000 INFO  org.apache.flink.api.java.typeutils.TypeExtractor            [] - Class class org.apache.flink.streaming.tests.Event cannot be used as a POJO type because not all fields are valid POJO fields, and must be processed as GenericType. Please read the Flink documentation on "Data Types & Serialization" for details of the effect on performance.
2021-03-06 22:06:42,006 INFO  org.apache.flink.runtime.io.network.partition.consumer.SingleInputGate [] - Converting recovered input channels (4 channels)
2021-03-06 22:06:42,007 INFO  org.apache.flink.runtime.io.network.partition.consumer.SingleInputGate [] - Converting recovered input channels (4 channels)
{code}





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