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)
