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

Dale Emery commented on GEODE-2458:
-----------------------------------

Failure in CI today: 
https://concourse.apachegeode-ci.info/teams/main/pipelines/apache-develop-main/jobs/DistributedTestOpenJDK8/builds/1690

Test results: 
http://files.apachegeode-ci.info/builds/apache-develop-main/1.13.0-SNAPSHOT.0128/test-results/distributedTest/1585547397/

Stack trace:

{noformat}
org.apache.geode.test.dunit.RMIException: While invoking 
org.apache.geode.management.RegionManagementDUnitTest$$Lambda$54/840813390.run 
in VM 0 running on Host 202d105afa0a with 4 VMs
        at org.apache.geode.test.dunit.VM.executeMethodOnObject(VM.java:610)
        at org.apache.geode.test.dunit.VM.invoke(VM.java:437)
        at 
org.apache.geode.management.RegionManagementDUnitTest.testPartitionedRegion(RegionManagementDUnitTest.java:215)
        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:498)
        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.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
        at 
org.apache.geode.test.dunit.rules.AbstractDistributedRule$1.evaluate(AbstractDistributedRule.java:59)
        at 
org.apache.geode.test.dunit.rules.AbstractDistributedRule$1.evaluate(AbstractDistributedRule.java:59)
        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.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.runTestClass(JUnitTestClassExecutor.java:110)
        at 
org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.execute(JUnitTestClassExecutor.java:58)
        at 
org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.execute(JUnitTestClassExecutor.java:38)
        at 
org.gradle.api.internal.tasks.testing.junit.AbstractJUnitTestClassProcessor.processTestClass(AbstractJUnitTestClassProcessor.java:62)
        at 
org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51)
        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:498)
        at 
org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
        at 
org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
        at 
org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32)
        at 
org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93)
        at com.sun.proxy.$Proxy2.processTestClass(Unknown Source)
        at 
org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:118)
        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:498)
        at 
org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
        at 
org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
        at 
org.gradle.internal.remote.internal.hub.MessageHubBackedObjectConnection$DispatchWrapper.dispatch(MessageHubBackedObjectConnection.java:175)
        at 
org.gradle.internal.remote.internal.hub.MessageHubBackedObjectConnection$DispatchWrapper.dispatch(MessageHubBackedObjectConnection.java:157)
        at 
org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:404)
        at 
org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:63)
        at 
org.gradle.internal.concurrent.ManagedExecutorImpl$1.run(ManagedExecutorImpl.java:46)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at 
org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:55)
        at java.lang.Thread.run(Thread.java:748)
Caused by: org.awaitility.core.ConditionTimeoutException: Assertion condition 
defined as a lambda expression in 
org.apache.geode.management.RegionManagementDUnitTest that uses int 
Expected size:<6> but was:<4> in:
<[javax.management.Notification[source=172.17.0.19(246)<v24>-41001][type=gemfire.distributedsystem.cache.region.created][message=Region
 Created With Name 
/RegionManagementDUnitTest_testPartitionedRegion_partitionedRegion],
    
javax.management.Notification[source=172.17.0.19(274)<v26>-41003][type=gemfire.distributedsystem.cache.region.created][message=Region
 Created With Name 
/RegionManagementDUnitTest_testPartitionedRegion_partitionedRegion],
    
javax.management.Notification[source=172.17.0.19(246)<v24>-41001][type=gemfire.distributedsystem.cache.region.closed][message=Region
 Destroyed/Closed With Name 
/RegionManagementDUnitTest_testPartitionedRegion_partitionedRegion],
    
javax.management.Notification[source=172.17.0.19(274)<v26>-41003][type=gemfire.distributedsystem.cache.region.closed][message=Region
 Destroyed/Closed With Name 
/RegionManagementDUnitTest_testPartitionedRegion_partitionedRegion]]> within 
300 seconds.
        at org.awaitility.core.ConditionAwaiter.await(ConditionAwaiter.java:145)
        at 
org.awaitility.core.AssertionCondition.await(AssertionCondition.java:122)
        at 
org.awaitility.core.AssertionCondition.await(AssertionCondition.java:32)
        at org.awaitility.core.ConditionFactory.until(ConditionFactory.java:902)
        at 
org.awaitility.core.ConditionFactory.untilAsserted(ConditionFactory.java:723)
        at 
org.apache.geode.management.RegionManagementDUnitTest.verifyMemberNotifications(RegionManagementDUnitTest.java:652)
        at 
org.apache.geode.management.RegionManagementDUnitTest.lambda$testPartitionedRegion$bb17a952$5(RegionManagementDUnitTest.java:215)
        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:498)
        at 
org.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:123)
        at 
org.apache.geode.test.dunit.internal.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:78)
        at sun.reflect.GeneratedMethodAccessor25.invoke(Unknown Source)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:357)
        at sun.rmi.transport.Transport$1.run(Transport.java:200)
        at sun.rmi.transport.Transport$1.run(Transport.java:197)
        at java.security.AccessController.doPrivileged(Native Method)
        at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
        at 
sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:573)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:834)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:688)
        at java.security.AccessController.doPrivileged(Native Method)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:687)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        ... 1 more
Caused by: java.lang.AssertionError: 
Expected size:<6> but was:<4> in:
<[javax.management.Notification[source=172.17.0.19(246)<v24>-41001][type=gemfire.distributedsystem.cache.region.created][message=Region
 Created With Name 
/RegionManagementDUnitTest_testPartitionedRegion_partitionedRegion],
    
javax.management.Notification[source=172.17.0.19(274)<v26>-41003][type=gemfire.distributedsystem.cache.region.created][message=Region
 Created With Name 
/RegionManagementDUnitTest_testPartitionedRegion_partitionedRegion],
    
javax.management.Notification[source=172.17.0.19(246)<v24>-41001][type=gemfire.distributedsystem.cache.region.closed][message=Region
 Destroyed/Closed With Name 
/RegionManagementDUnitTest_testPartitionedRegion_partitionedRegion],
    
javax.management.Notification[source=172.17.0.19(274)<v26>-41003][type=gemfire.distributedsystem.cache.region.closed][message=Region
 Destroyed/Closed With Name 
/RegionManagementDUnitTest_testPartitionedRegion_partitionedRegion]]>
        at 
org.apache.geode.management.RegionManagementDUnitTest.lambda$verifyMemberNotifications$8(RegionManagementDUnitTest.java:652)
        at 
org.awaitility.core.AssertionCondition$1.eval(AssertionCondition.java:55)
        at 
org.awaitility.core.ConditionAwaiter$ConditionPoller.call(ConditionAwaiter.java:201)
        at 
org.awaitility.core.ConditionAwaiter$ConditionPoller.call(ConditionAwaiter.java:188)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        ... 3 more
{noformat}


> RegionManagementDUnitTest fails with AssertionError in 
> verifyMemberNotifications
> --------------------------------------------------------------------------------
>
>                 Key: GEODE-2458
>                 URL: https://issues.apache.org/jira/browse/GEODE-2458
>             Project: Geode
>          Issue Type: Bug
>          Components: management, tests
>            Reporter: Kirk Lund
>            Assignee: Kirk Lund
>            Priority: Major
>              Labels: Flaky
>             Fix For: 1.2.0
>
>
> This appears to be a race condition. The assertion finds 5 members when 6 is 
> expected and then lists the members as part of the assertion message which 
> then shows 6 members.
> {noformat}
> org.apache.geode.management.RegionManagementDUnitTest > 
> testFixedPRRegionMBean FAILED
>     org.apache.geode.test.dunit.RMIException: While invoking 
> org.apache.geode.test.dunit.NamedRunnable.run in VM 0 running on Host 
> 242824700ff7 with 4 VMs
>         at org.apache.geode.test.dunit.VM.invoke(VM.java:377)
>         at org.apache.geode.test.dunit.VM.invoke(VM.java:347)
>         at org.apache.geode.test.dunit.VM.invoke(VM.java:280)
>         at 
> org.apache.geode.management.RegionManagementDUnitTest.verifyMemberNotifications(RegionManagementDUnitTest.java:580)
>         at 
> org.apache.geode.management.RegionManagementDUnitTest.testFixedPRRegionMBean(RegionManagementDUnitTest.java:227)
>         Caused by:
>         java.lang.AssertionError: 
>         Expected size:<6> but was:<5> in:
>         
> <[javax.management.Notification[source=172.17.0.4(161)<v37>-32770][type=gemfire.distributedsystem.cache.region.created][message=Region
>  Created With Name /MANAGEMENT_FIXED_PR],
>             
> javax.management.Notification[source=172.17.0.4(166)<v38>-32771][type=gemfire.distributedsystem.cache.region.created][message=Region
>  Created With Name /MANAGEMENT_FIXED_PR],
>             
> javax.management.Notification[source=172.17.0.4(171)<v39>-32772][type=gemfire.distributedsystem.cache.region.created][message=Region
>  Created With Name /MANAGEMENT_FIXED_PR],
>             
> javax.management.Notification[source=172.17.0.4(161)<v37>-32770][type=gemfire.distributedsystem.cache.region.closed][message=Region
>  Destroyed/Closed With Name /MANAGEMENT_FIXED_PR],
>             
> javax.management.Notification[source=172.17.0.4(166)<v38>-32771][type=gemfire.distributedsystem.cache.region.closed][message=Region
>  Destroyed/Closed With Name /MANAGEMENT_FIXED_PR],
>             
> javax.management.Notification[source=172.17.0.4(171)<v39>-32772][type=gemfire.distributedsystem.cache.region.closed][message=Region
>  Destroyed/Closed With Name /MANAGEMENT_FIXED_PR]]>
>             at 
> org.apache.geode.management.RegionManagementDUnitTest.lambda$verifyMemberNotifications$3d0515b3$1(RegionManagementDUnitTest.java:582)
> {noformat}
> Each of these tests call verifyMemberNotifications and may fail with this 
> timing failure:
> * testDistributedRegion
> * testFixedPRRegionMBean
> * testPartitionedRegion



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

Reply via email to