[ 
https://issues.apache.org/jira/browse/FLINK-5016?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15645630#comment-15645630
 ] 

Ufuk Celebi commented on FLINK-5016:
------------------------------------

I think you are right, Stephan.

I just had a similar revelation after running this test repeatedly in a for 
loop 
(https://github.com/uce/flink/commit/c2ab977600d3f0de9e1fbe6a1715c1095c7cca03), 
which succeeded (https://travis-ci.org/uce/flink/builds/173942459).

I added sys out calls in order to prevent early time out of the test suite, but 
only afterwards realized that this could be the cause of the original issue.

Looking at the complete logs you see that the test suite starts around ~5 mins 
and 30 seconds before the last log statement, which is in line with the 5 min 
timeout. I think it's OK to increase the no output timeout to 10 mins for now 
and adjust the test suite to give some output.

> EventTimeWindowCheckpointingITCase 
> testTumblingTimeWindowWithKVStateMaxMaxParallelism with RocksDB hangs
> --------------------------------------------------------------------------------------------------------
>
>                 Key: FLINK-5016
>                 URL: https://issues.apache.org/jira/browse/FLINK-5016
>             Project: Flink
>          Issue Type: Bug
>          Components: State Backends, Checkpointing, Tests
>            Reporter: Ufuk Celebi
>              Labels: test-stability
>         Attachments: flink_5016_logs.txt, 
> testPreAggregatedSlidingTimeWindows[ROCKS_DB_FULLY_ASYNC].txt
>
>
> In a branch with unrelated changes, I saw EventTimeWindowCheckpointingITCase 
> testTumblingTimeWindowWithKVStateMaxMaxParallelism with RocksDB hanging
> {code}
> "main" #1 prio=5 os_prio=0 tid=0x00007f8c1400a000 nid=0xb21f waiting on 
> condition [0x00007f8c1de46000]
>    java.lang.Thread.State: TIMED_WAITING (parking)
>       at sun.misc.Unsafe.park(Native Method)
>       - parking to wait for  <0x00000000d772c650> (a 
> scala.concurrent.impl.Promise$CompletionLatch)
>       at 
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
>       at 
> java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
>       at 
> java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
>       at 
> scala.concurrent.impl.Promise$DefaultPromise.tryAwait(Promise.scala:208)
>       at scala.concurrent.impl.Promise$DefaultPromise.ready(Promise.scala:218)
>       at scala.concurrent.impl.Promise$DefaultPromise.ready(Promise.scala:153)
>       at scala.concurrent.Await$$anonfun$ready$1.apply(package.scala:86)
>       at scala.concurrent.Await$$anonfun$ready$1.apply(package.scala:86)
>       at 
> scala.concurrent.BlockContext$DefaultBlockContext$.blockOn(BlockContext.scala:53)
>       at scala.concurrent.Await$.ready(package.scala:86)
>       at scala.concurrent.Await.ready(package.scala)
>       at 
> org.apache.flink.runtime.client.JobClient.awaitJobResult(JobClient.java:260)
>       at 
> org.apache.flink.runtime.client.JobClient.submitJobAndWait(JobClient.java:382)
>       at 
> org.apache.flink.client.program.ClusterClient.run(ClusterClient.java:423)
>       at 
> org.apache.flink.client.program.StandaloneClusterClient.submitJob(StandaloneClusterClient.java:101)
>       at 
> org.apache.flink.client.program.ClusterClient.run(ClusterClient.java:400)
>       at 
> org.apache.flink.client.program.ClusterClient.run(ClusterClient.java:392)
>       at 
> org.apache.flink.streaming.api.environment.RemoteStreamEnvironment.executeRemotely(RemoteStreamEnvironment.java:209)
>       at 
> org.apache.flink.streaming.api.environment.RemoteStreamEnvironment.execute(RemoteStreamEnvironment.java:173)
>       at org.apache.flink.test.util.TestUtils.tryExecute(TestUtils.java:32)
>       at 
> org.apache.flink.test.checkpointing.EventTimeWindowCheckpointingITCase.doTestTumblingTimeWindowWithKVState(EventTimeWindowCheckpointingITCase.java:269)
>       at 
> org.apache.flink.test.checkpointing.EventTimeWindowCheckpointingITCase.testTumblingTimeWindowWithKVStateMaxMaxParallelism(EventTimeWindowCheckpointingITCase.java:206)
>       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>       at 
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>       at 
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>       at java.lang.reflect.Method.invoke(Method.java:483)
>       at 
> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
>       at 
> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
>       at 
> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
>       at 
> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
>       at 
> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
>       at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:48)
>       at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
>       at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>       at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
>       at 
> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
>       at 
> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
>       at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
>       at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
>       at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
>       at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
>       at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
>       at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
>       at org.junit.runners.Suite.runChild(Suite.java:128)
>       at org.junit.runners.Suite.runChild(Suite.java:27)
>       at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
>       at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
>       at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
>       at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
>       at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
>       at 
> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
>       at 
> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
>       at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
>       at 
> org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:283)
>       at 
> org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:173)
>       at 
> org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
>       at 
> org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:128)
>       at 
> org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:203)
>       at 
> org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:155)
>       at 
> org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)
> {code}
> The logs are here: 
> https://s3.amazonaws.com/archive.travis-ci.org/jobs/172994241/log.txt



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Reply via email to