You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@geode.apache.org by "ASF subversion and git services (JIRA)" <ji...@apache.org> on 2017/10/30 19:02:00 UTC
[jira] [Commented] (GEODE-3919) [CI Failure]
org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest >
testConflationWithSameEntryPuts FAILED
[ https://issues.apache.org/jira/browse/GEODE-3919?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16225552#comment-16225552 ]
ASF subversion and git services commented on GEODE-3919:
--------------------------------------------------------
Commit b9edaa0eaf2d37b41c5b7f39554bb91d298fa1c2 in geode's branch refs/heads/feature/GEODE-3919 from [~barry.oglesby]
[ https://gitbox.apache.org/repos/asf?p=geode.git;h=b9edaa0 ]
GEODE-3919: Changed test to wait for the appropriate queue size since conflation is async
> [CI Failure] org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest > testConflationWithSameEntryPuts FAILED
> ----------------------------------------------------------------------------------------------------------------------------
>
> Key: GEODE-3919
> URL: https://issues.apache.org/jira/browse/GEODE-3919
> Project: Geode
> Issue Type: Bug
> Components: wan
> Reporter: nabarun
>
> Stacktrace
> {noformat}
> org.apache.geode.test.dunit.RMIException: While invoking org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$804/1364985273.run in VM 1 running on Host 6c7835da774c with 8 VMs
> at org.apache.geode.test.dunit.VM.invoke(VM.java:393)
> at org.apache.geode.test.dunit.VM.invoke(VM.java:363)
> at org.apache.geode.test.dunit.VM.invoke(VM.java:308)
> at org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest.testConflationWithSameEntryPuts(ParallelWANStatsDUnitTest.java:509)
> 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.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.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
> at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
> at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:114)
> at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:57)
> at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:66)
> 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:109)
> 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:147)
> at org.gradle.internal.remote.internal.hub.MessageHubBackedObjectConnection$DispatchWrapper.dispatch(MessageHubBackedObjectConnection.java:129)
> 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.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:46)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
> at java.lang.Thread.run(Thread.java:748)
> Caused by: java.lang.AssertionError: expected:<2> but was:<3>
> at org.junit.Assert.fail(Assert.java:88)
> at org.junit.Assert.failNotEquals(Assert.java:834)
> at org.junit.Assert.assertEquals(Assert.java:645)
> at org.junit.Assert.assertEquals(Assert.java:631)
> at org.apache.geode.internal.cache.wan.WANTestBase.testQueueSize(WANTestBase.java:2564)
> at org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest.lambda$testConflationWithSameEntryPuts$ca180b8$2(ParallelWANStatsDUnitTest.java:509)
> 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 hydra.MethExecutor.executeObject(MethExecutor.java:245)
> at org.apache.geode.test.dunit.standalone.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:70)
> at sun.reflect.GeneratedMethodAccessor5.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:568)
> at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:826)
> at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:683)
> at java.security.AccessController.doPrivileged(Native Method)
> at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:682)
> ... 3 more
> {noformat}
> Complete Logs
> {noformat}
> [setup] START TEST ParallelWANStatsDUnitTest.testConflationWithSameEntryPuts
> [vm6] [info 2017/10/27 02:10:53.924 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm6] [info 2017/10/27 02:10:53.924 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm0] [info 2017/10/27 02:10:53.929 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1540386649.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1540386649@3cd3d1dc
> [vm0] [info 2017/10/27 02:10:53.929 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1540386649.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1540386649@3cd3d1dc (took 0 ms)
> [vm1] [info 2017/10/27 02:10:53.930 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/231701002.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/231701002@17cd5860
> [vm1] [info 2017/10/27 02:10:53.930 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/231701002.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/231701002@17cd5860 (took 0 ms)
> [vm2] [info 2017/10/27 02:10:53.931 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/587868161.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/587868161@2e58f553
> [vm2] [info 2017/10/27 02:10:53.931 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/587868161.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/587868161@2e58f553 (took 0 ms)
> [vm3] [info 2017/10/27 02:10:53.932 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1348692615.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1348692615@2f3012f1
> [vm3] [info 2017/10/27 02:10:53.932 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1348692615.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1348692615@2f3012f1 (took 0 ms)
> [vm4] [info 2017/10/27 02:10:53.937 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/958556531.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/958556531@7fba5614
> [vm4] [info 2017/10/27 02:10:53.938 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/958556531.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/958556531@7fba5614 (took 0 ms)
> [vm5] [info 2017/10/27 02:10:53.938 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1828305518.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1828305518@29b2f514
> [vm5] [info 2017/10/27 02:10:53.938 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1828305518.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1828305518@29b2f514 (took 0 ms)
> [vm6] [info 2017/10/27 02:10:53.939 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/819945348.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/819945348@9c04edf
> [vm6] [info 2017/10/27 02:10:53.939 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/819945348.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/819945348@9c04edf (took 0 ms)
> [vm7] [info 2017/10/27 02:10:53.941 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1828305518.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1828305518@29b2f514
> [vm7] [info 2017/10/27 02:10:53.941 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1828305518.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$10/1828305518@29b2f514 (took 0 ms)
> [info 2017/10/27 02:10:53.941 UTC <Test worker> tid=22] <ExpectedException action=add>Connection refused</ExpectedException>
> [info 2017/10/27 02:10:53.941 UTC <Test worker> tid=22] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm0] [info 2017/10/27 02:10:53.942 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm0] [info 2017/10/27 02:10:53.942 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm0] [info 2017/10/27 02:10:53.942 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm0] [info 2017/10/27 02:10:53.942 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm1] [info 2017/10/27 02:10:53.943 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm1] [info 2017/10/27 02:10:53.943 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm1] [info 2017/10/27 02:10:53.943 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm1] [info 2017/10/27 02:10:53.943 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm2] [info 2017/10/27 02:10:53.944 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm2] [info 2017/10/27 02:10:53.945 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm2] [info 2017/10/27 02:10:53.945 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm2] [info 2017/10/27 02:10:53.945 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm3] [info 2017/10/27 02:10:53.945 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm3] [info 2017/10/27 02:10:53.946 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm3] [info 2017/10/27 02:10:53.946 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm3] [info 2017/10/27 02:10:53.946 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm4] [info 2017/10/27 02:10:53.950 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm4] [info 2017/10/27 02:10:53.950 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm4] [info 2017/10/27 02:10:53.950 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm4] [info 2017/10/27 02:10:53.951 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 1 ms)
> [vm5] [info 2017/10/27 02:10:53.954 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm5] [info 2017/10/27 02:10:53.954 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm5] [info 2017/10/27 02:10:53.954 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm5] [info 2017/10/27 02:10:53.954 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm6] [info 2017/10/27 02:10:53.955 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm6] [info 2017/10/27 02:10:53.955 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm6] [info 2017/10/27 02:10:53.955 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm6] [info 2017/10/27 02:10:53.955 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [info 2017/10/27 02:10:53.957 UTC <Test worker> tid=22] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [info 2017/10/27 02:10:53.958 UTC <Test worker> tid=22] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm7] [info 2017/10/27 02:10:53.957 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm7] [info 2017/10/27 02:10:53.957 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm7] [info 2017/10/27 02:10:53.957 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection refused</ExpectedException>
> [vm7] [info 2017/10/27 02:10:53.957 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm0] [info 2017/10/27 02:10:53.959 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm0] [info 2017/10/27 02:10:53.959 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm0] [info 2017/10/27 02:10:53.959 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm0] [info 2017/10/27 02:10:53.959 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm1] [info 2017/10/27 02:10:53.960 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm1] [info 2017/10/27 02:10:53.960 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm1] [info 2017/10/27 02:10:53.960 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm1] [info 2017/10/27 02:10:53.961 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm2] [info 2017/10/27 02:10:53.961 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm2] [info 2017/10/27 02:10:53.962 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm2] [info 2017/10/27 02:10:53.962 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm2] [info 2017/10/27 02:10:53.962 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm3] [info 2017/10/27 02:10:53.962 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm3] [info 2017/10/27 02:10:53.963 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm3] [info 2017/10/27 02:10:53.963 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm3] [info 2017/10/27 02:10:53.963 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm4] [info 2017/10/27 02:10:53.964 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm4] [info 2017/10/27 02:10:53.965 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm4] [info 2017/10/27 02:10:53.965 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm4] [info 2017/10/27 02:10:53.965 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm5] [info 2017/10/27 02:10:53.965 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm5] [info 2017/10/27 02:10:53.965 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm5] [info 2017/10/27 02:10:53.966 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm5] [info 2017/10/27 02:10:53.966 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm6] [info 2017/10/27 02:10:53.966 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm6] [info 2017/10/27 02:10:53.967 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm6] [info 2017/10/27 02:10:53.967 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm6] [info 2017/10/27 02:10:53.967 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [info 2017/10/27 02:10:53.968 UTC <Test worker> tid=22] <ExpectedException action=add>Connection reset</ExpectedException>
> [info 2017/10/27 02:10:53.968 UTC <Test worker> tid=22] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm0] [info 2017/10/27 02:10:53.969 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm0] [info 2017/10/27 02:10:53.970 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm0] [info 2017/10/27 02:10:53.970 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm0] [info 2017/10/27 02:10:53.970 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm1] [info 2017/10/27 02:10:53.970 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm1] [info 2017/10/27 02:10:53.971 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm1] [info 2017/10/27 02:10:53.971 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm7] [info 2017/10/27 02:10:53.967 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm7] [info 2017/10/27 02:10:53.968 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm7] [info 2017/10/27 02:10:53.968 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Software caused connection abort</ExpectedException>
> [vm7] [info 2017/10/27 02:10:53.968 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm1] [info 2017/10/27 02:10:53.971 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm2] [info 2017/10/27 02:10:53.971 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm2] [info 2017/10/27 02:10:53.971 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm2] [info 2017/10/27 02:10:53.971 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm2] [info 2017/10/27 02:10:53.972 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm3] [info 2017/10/27 02:10:53.972 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm3] [info 2017/10/27 02:10:53.972 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm3] [info 2017/10/27 02:10:53.972 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm3] [info 2017/10/27 02:10:53.972 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm4] [info 2017/10/27 02:10:53.973 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm4] [info 2017/10/27 02:10:53.973 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm4] [info 2017/10/27 02:10:53.973 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm4] [info 2017/10/27 02:10:53.973 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm5] [info 2017/10/27 02:10:53.973 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm5] [info 2017/10/27 02:10:53.974 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm5] [info 2017/10/27 02:10:53.974 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm5] [info 2017/10/27 02:10:53.974 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm6] [info 2017/10/27 02:10:53.974 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm6] [info 2017/10/27 02:10:53.974 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm6] [info 2017/10/27 02:10:53.974 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm6] [info 2017/10/27 02:10:53.974 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm7] [info 2017/10/27 02:10:53.975 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException"
> [vm7] [info 2017/10/27 02:10:53.975 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm7] [info 2017/10/27 02:10:53.975 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=add>Connection reset</ExpectedException>
> [vm7] [info 2017/10/27 02:10:53.975 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.IgnoredException$2.run with 0 args on object: "IgnoredException addIgnoredException" (took 0 ms)
> [vm0] [info 2017/10/27 02:10:53.982 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$91/1568688055.call with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$91/1568688055@9772204
> [vm0] distributed system properties: {distributed-system-id=1, start-locator=localhost[21849],server=true,peer=true,hostname-for-clients=localhost, mcast-port=0, log-level=info, off-heap-memory-size=300m, disable-auto-reconnect=true, enable-cluster-configuration=false, locators=localhost[21849], use-cluster-configuration=false}
> [vm0] [info 2017/10/27 02:10:53.987 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Startup Configuration:
> [vm0] ### GemFire Properties defined with api ###
> [vm0] disable-auto-reconnect=true
> [vm0] distributed-system-id=1
> [vm0] enable-cluster-configuration=false
> [vm0] locators=localhost[21849]
> [vm0] log-level=info
> [vm0] mcast-port=0
> [vm0] off-heap-memory-size=300m
> [vm0] start-locator=localhost[21849],server=true,peer=true,hostname-for-clients=localhost
> [vm0] use-cluster-configuration=false
> [vm0] ### GemFire Properties using default values ###
> [vm0] ack-severe-alert-threshold=0
> [vm0] ack-wait-threshold=15
> [vm0] archive-disk-space-limit=0
> [vm0] archive-file-size-limit=0
> [vm0] async-distribution-timeout=0
> [vm0] async-max-queue-size=8
> [vm0] async-queue-timeout=60000
> [vm0] bind-address=
> [vm0] cache-xml-file=cache.xml
> [vm0] cluster-configuration-dir=
> [vm0] cluster-ssl-ciphers=any
> [vm0] cluster-ssl-enabled=false
> [vm0] cluster-ssl-keystore=
> [vm0] cluster-ssl-keystore-password=
> [vm0] cluster-ssl-keystore-type=
> [vm0] cluster-ssl-protocols=any
> [vm0] cluster-ssl-require-authentication=true
> [vm0] cluster-ssl-truststore=
> [vm0] cluster-ssl-truststore-password=
> [vm0] conflate-events=server
> [vm0] conserve-sockets=true
> [vm0] delta-propagation=true
> [vm0] deploy-working-dir=/tmp/gemfire-build/geode/geode-wan/build/distributedTest129/dunit/vm0
> [vm0] disable-tcp=false
> [vm0] distributed-transactions=false
> [vm0] durable-client-id=
> [vm0] durable-client-timeout=300
> [vm0] enable-network-partition-detection=true
> [vm0] enable-time-statistics=false
> [vm0] enforce-unique-host=false
> [vm0] gateway-ssl-ciphers=any
> [vm0] gateway-ssl-enabled=false
> [vm0] gateway-ssl-keystore=
> [vm0] gateway-ssl-keystore-password=
> [vm0] gateway-ssl-keystore-type=
> [vm0] gateway-ssl-protocols=any
> [vm0] gateway-ssl-require-authentication=true
> [vm0] gateway-ssl-truststore=
> [vm0] gateway-ssl-truststore-password=
> [vm0] groups=
> [vm0] http-service-bind-address=
> [vm0] http-service-port=7070
> [vm0] http-service-ssl-ciphers=any
> [vm0] http-service-ssl-enabled=false
> [vm0] http-service-ssl-keystore=
> [vm0] http-service-ssl-keystore-password=
> [vm0] http-service-ssl-keystore-type=
> [vm0] http-service-ssl-protocols=any
> [vm0] http-service-ssl-require-authentication=false
> [vm0] http-service-ssl-truststore=
> [vm0] http-service-ssl-truststore-password=
> [vm0] jmx-manager=false
> [vm0] jmx-manager-access-file=
> [vm0] jmx-manager-bind-address=
> [vm0] jmx-manager-hostname-for-clients=
> [vm0] jmx-manager-http-port=7070
> [vm0] jmx-manager-password-file=
> [vm0] jmx-manager-port=1099
> [vm0] jmx-manager-ssl-ciphers=any
> [vm0] jmx-manager-ssl-enabled=false
> [vm0] jmx-manager-ssl-keystore=
> [vm0] jmx-manager-ssl-keystore-password=
> [vm0] jmx-manager-ssl-keystore-type=
> [vm0] jmx-manager-ssl-protocols=any
> [vm0] jmx-manager-ssl-require-authentication=true
> [vm0] jmx-manager-ssl-truststore=
> [vm0] jmx-manager-ssl-truststore-password=
> [vm0] jmx-manager-start=false
> [vm0] jmx-manager-update-rate=2000
> [vm0] load-cluster-configuration-from-dir=false
> [vm0] locator-wait-time=0
> [vm0] lock-memory=false
> [vm0] log-disk-space-limit=0
> [vm0] log-file=
> [vm0] log-file-size-limit=0
> [vm0] max-num-reconnect-tries=3
> [vm0] max-wait-time-reconnect=60000
> [vm0] mcast-address=239.192.81.1
> [vm0] mcast-flow-control=1048576, 0.25, 5000
> [vm0] mcast-recv-buffer-size=1048576
> [vm0] mcast-send-buffer-size=65535
> [vm0] mcast-ttl=32
> [vm0] member-timeout=5000
> [vm0] membership-port-range=32769-61000
> [vm0] memcached-bind-address=
> [vm0] memcached-port=0
> [vm0] memcached-protocol=ASCII
> [vm0] name=
> [vm0] redis-bind-address=
> [vm0] redis-password=
> [vm0] redis-port=0
> [vm0] redundancy-zone=
> [vm0] remote-locators=
> [vm0] remove-unresponsive-client=false
> [vm0] roles=
> [vm0] security-client-accessor=
> [vm0] security-client-accessor-pp=
> [vm0] security-client-auth-init=
> [vm0] security-client-authenticator=
> [vm0] security-client-dhalgo=
> [vm0] security-log-file=
> [vm0] security-log-level=config
> [vm0] security-manager=
> [vm0] security-peer-auth-init=
> [vm0] security-peer-authenticator=
> [vm0] security-peer-verifymember-timeout=1000
> [vm0] security-post-processor=
> [vm0] security-udp-dhalgo=
> [vm0] server-bind-address=
> [vm0] server-ssl-ciphers=any
> [vm0] server-ssl-enabled=false
> [vm0] server-ssl-keystore=
> [vm0] server-ssl-keystore-password=
> [vm0] server-ssl-keystore-type=
> [vm0] server-ssl-protocols=any
> [vm0] server-ssl-require-authentication=true
> [vm0] server-ssl-truststore=
> [vm0] server-ssl-truststore-password=
> [vm0] socket-buffer-size=32768
> [vm0] socket-lease-time=60000
> [vm0] ssl-ciphers=any
> [vm0] ssl-cluster-alias=
> [vm0] ssl-default-alias=
> [vm0] ssl-enabled-components=
> [vm0] ssl-gateway-alias=
> [vm0] ssl-jmx-alias=
> [vm0] ssl-keystore=
> [vm0] ssl-keystore-password=
> [vm0] ssl-keystore-type=
> [vm0] ssl-locator-alias=
> [vm0] ssl-protocols=any
> [vm0] ssl-require-authentication=true
> [vm0] ssl-server-alias=
> [vm0] ssl-truststore=
> [vm0] ssl-truststore-password=
> [vm0] ssl-truststore-type=
> [vm0] ssl-web-alias=
> [vm0] ssl-web-require-authentication=false
> [vm0] start-dev-rest-api=false
> [vm0] statistic-archive-file=
> [vm0] statistic-sample-rate=1000
> [vm0] statistic-sampling-enabled=true
> [vm0] tcp-port=0
> [vm0] udp-fragment-size=60000
> [vm0] udp-recv-buffer-size=1048576
> [vm0] udp-send-buffer-size=65535
> [vm0] user-command-packages=
> [vm0] [info 2017/10/27 02:10:53.988 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Allocating 314572800 bytes of off-heap memory. The maximum size of a single off-heap object is 314572800 bytes.
> [vm0] [warn 2017/10/27 02:10:53.996 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Could not load client protocol
> [vm0] org.apache.geode.internal.cache.tier.sockets.ServiceLoadingFailureException: There is no ClientProtocolService implementation found in JVM
> [vm0] at org.apache.geode.internal.cache.tier.sockets.ClientProtocolServiceLoader.loadService(ClientProtocolServiceLoader.java:27)
> [vm0] at org.apache.geode.internal.cache.tier.sockets.TcpServerFactory.<init>(TcpServerFactory.java:38)
> [vm0] at org.apache.geode.distributed.internal.InternalLocator.<init>(InternalLocator.java:503)
> [vm0] at org.apache.geode.distributed.internal.InternalLocator.createLocator(InternalLocator.java:272)
> [vm0] at org.apache.geode.distributed.internal.InternalDistributedSystem.startInitLocator(InternalDistributedSystem.java:840)
> [vm0] at org.apache.geode.distributed.internal.InternalDistributedSystem.initialize(InternalDistributedSystem.java:726)
> [vm0] at org.apache.geode.distributed.internal.InternalDistributedSystem.newInstance(InternalDistributedSystem.java:350)
> [vm0] at org.apache.geode.distributed.internal.InternalDistributedSystem.newInstance(InternalDistributedSystem.java:336)
> [vm0] at org.apache.geode.distributed.internal.InternalDistributedSystem.newInstance(InternalDistributedSystem.java:330)
> [vm0] at org.apache.geode.distributed.DistributedSystem.connect(DistributedSystem.java:205)
> [vm0] at org.apache.geode.test.dunit.internal.JUnit4DistributedTestCase.getSystem(JUnit4DistributedTestCase.java:180)
> [vm0] at org.apache.geode.internal.cache.wan.WANTestBase.createFirstLocatorWithDSId(WANTestBase.java:283)
> [vm0] at org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest.lambda$testConflationWithSameEntryPuts$a2e85a4$1(ParallelWANStatsDUnitTest.java:494)
> [vm0] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> [vm0] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> [vm0] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> [vm0] at java.lang.reflect.Method.invoke(Method.java:498)
> [vm0] at hydra.MethExecutor.executeObject(MethExecutor.java:245)
> [vm0] at org.apache.geode.test.dunit.standalone.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:70)
> [vm0] at sun.reflect.GeneratedMethodAccessor5.invoke(Unknown Source)
> [vm0] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> [vm0] at java.lang.reflect.Method.invoke(Method.java:498)
> [vm0] at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:357)
> [vm0] at sun.rmi.transport.Transport$1.run(Transport.java:200)
> [vm0] at sun.rmi.transport.Transport$1.run(Transport.java:197)
> [vm0] at java.security.AccessController.doPrivileged(Native Method)
> [vm0] at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
> [vm0] at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:568)
> [vm0] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:826)
> [vm0] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:683)
> [vm0] at java.security.AccessController.doPrivileged(Native Method)
> [vm0] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:682)
> [vm0] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
> [vm0] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
> [vm0] at java.lang.Thread.run(Thread.java:748)
> [vm0] [info 2017/10/27 02:10:53.997 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Starting peer location for Distribution Locator on localhost/127.0.0.1
> [vm0] [info 2017/10/27 02:10:53.998 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Starting Distribution Locator on localhost/127.0.0.1
> [vm0] [info 2017/10/27 02:10:53.998 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Locator was created at Fri Oct 27 02:10:53 UTC 2017
> [vm0] [info 2017/10/27 02:10:53.998 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Listening on port 21849 bound on address localhost/127.0.0.1
> [vm0] [info 2017/10/27 02:10:53.999 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] GemFire peer location service starting. Other locators: localhost[21849] Locators preferred as coordinators: true Network partition detection enabled: true View persistence file: locator21849view.dat
> [vm0] [info 2017/10/27 02:10:53.999 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Peer locator attempting to recover from localhost/127.0.0.1:21849
> [vm0] [info 2017/10/27 02:10:54.001 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Peer locator was unable to recover state from this locator
> [vm0] [info 2017/10/27 02:10:54.001 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] recovery file not found: /tmp/gemfire-build/geode/geode-wan/build/distributedTest129/dunit/vm0/locator21849view.dat
> [vm0] [info 2017/10/27 02:10:54.004 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Starting membership services
> [vm0] [info 2017/10/27 02:10:54.035 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] JGroups channel created (took 31ms)
> [vm0] [info 2017/10/27 02:10:54.060 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] GemFire P2P Listener started on /172.17.0.6:40708
> [vm0] [info 2017/10/27 02:10:54.061 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] This member is hosting a locator will be preferred as a membership coordinator
> [vm0] [info 2017/10/27 02:10:54.061 UTC <Geode Failure Detection Server thread 0> tid=2088] Started failure detection server thread on /172.17.0.6:50525.
> [vm0] [info 2017/10/27 02:10:54.091 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Peer locator is connecting to local membership services with ID 172.17.0.6(174)<ec>:32770
> [vm0] [info 2017/10/27 02:10:54.105 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] This member is becoming the membership coordinator with address 172.17.0.6(174)<ec>:32770
> [vm0] [info 2017/10/27 02:10:54.105 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] received new view: View[172.17.0.6(174)<ec><v0>:32770|0] members: [172.17.0.6(174)<ec><v0>:32770{lead}]
> [vm0] old view is: null
> [vm0] [info 2017/10/27 02:10:54.105 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Peer locator received new membership view: View[172.17.0.6(174)<ec><v0>:32770|0] members: [172.17.0.6(174)<ec><v0>:32770{lead}]
> [vm0] [info 2017/10/27 02:10:54.106 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] ViewCreator starting on:172.17.0.6(174)<ec><v0>:32770
> [vm0] [info 2017/10/27 02:10:54.107 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Finished joining (took 15ms).
> [vm0] [info 2017/10/27 02:10:54.107 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Starting DistributionManager 172.17.0.6(174)<ec><v0>:32770. (took 105 ms)
> [vm0] [info 2017/10/27 02:10:54.108 UTC <Geode Membership View Creator> tid=2091] View Creator thread is starting
> [vm0] [info 2017/10/27 02:10:54.108 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Initial (distribution manager) view = View[172.17.0.6(174)<ec><v0>:32770|0] members: [172.17.0.6(174)<ec><v0>:32770{lead}]
> [vm0] [info 2017/10/27 02:10:54.109 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Admitting member <172.17.0.6(174)<ec><v0>:32770>. Now there are 1 non-admin member(s).
> [vm0] [info 2017/10/27 02:10:54.109 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] 172.17.0.6(174)<ec><v0>:32770 is the elder and the only member.
> [vm0] [info 2017/10/27 02:10:54.110 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Did not hear back from any other system. I am the first one.
> [vm0] [info 2017/10/27 02:10:54.110 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Starting server location for Distribution Locator on localhost/127.0.0.1[21849]
> [vm0] [info 2017/10/27 02:10:54.125 UTC <Geode Membership View Creator> tid=2091] no recipients for new view aside from myself
> [vm0] [info 2017/10/27 02:10:54.133 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: 21849
> [vm0] from org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$91/1568688055.call with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$91/1568688055@9772204 (took 151 ms)
> [vm2] [info 2017/10/27 02:10:54.137 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$147/1175997502.call with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$147/1175997502@48aaeb87
> [vm2] distributed system properties: {distributed-system-id=2, start-locator=localhost[20150],server=true,peer=true,hostname-for-clients=localhost, mcast-port=0, log-level=info, off-heap-memory-size=300m, remote-locators=localhost[21849], disable-auto-reconnect=true, enable-cluster-configuration=false, locators=localhost[20150], use-cluster-configuration=false}
> [vm2] [info 2017/10/27 02:10:54.142 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Startup Configuration:
> [vm2] ### GemFire Properties defined with api ###
> [vm2] disable-auto-reconnect=true
> [vm2] distributed-system-id=2
> [vm2] enable-cluster-configuration=false
> [vm2] locators=localhost[20150]
> [vm2] log-level=info
> [vm2] mcast-port=0
> [vm2] off-heap-memory-size=300m
> [vm2] remote-locators=localhost[21849]
> [vm2] start-locator=localhost[20150],server=true,peer=true,hostname-for-clients=localhost
> [vm2] use-cluster-configuration=false
> [vm2] ### GemFire Properties using default values ###
> [vm2] ack-severe-alert-threshold=0
> [vm2] ack-wait-threshold=15
> [vm2] archive-disk-space-limit=0
> [vm2] archive-file-size-limit=0
> [vm2] async-distribution-timeout=0
> [vm2] async-max-queue-size=8
> [vm2] async-queue-timeout=60000
> [vm2] bind-address=
> [vm2] cache-xml-file=cache.xml
> [vm2] cluster-configuration-dir=
> [vm2] cluster-ssl-ciphers=any
> [vm2] cluster-ssl-enabled=false
> [vm2] cluster-ssl-keystore=
> [vm2] cluster-ssl-keystore-password=
> [vm2] cluster-ssl-keystore-type=
> [vm2] cluster-ssl-protocols=any
> [vm2] cluster-ssl-require-authentication=true
> [vm2] cluster-ssl-truststore=
> [vm2] cluster-ssl-truststore-password=
> [vm2] conflate-events=server
> [vm2] conserve-sockets=true
> [vm2] delta-propagation=true
> [vm2] deploy-working-dir=/tmp/gemfire-build/geode/geode-wan/build/distributedTest129/dunit/vm2
> [vm2] disable-tcp=false
> [vm2] distributed-transactions=false
> [vm2] durable-client-id=
> [vm2] durable-client-timeout=300
> [vm2] enable-network-partition-detection=true
> [vm2] enable-time-statistics=false
> [vm2] enforce-unique-host=false
> [vm2] gateway-ssl-ciphers=any
> [vm2] gateway-ssl-enabled=false
> [vm2] gateway-ssl-keystore=
> [vm2] gateway-ssl-keystore-password=
> [vm2] gateway-ssl-keystore-type=
> [vm2] gateway-ssl-protocols=any
> [vm2] gateway-ssl-require-authentication=true
> [vm2] gateway-ssl-truststore=
> [vm2] gateway-ssl-truststore-password=
> [vm2] groups=
> [vm2] http-service-bind-address=
> [vm2] http-service-port=7070
> [vm2] http-service-ssl-ciphers=any
> [vm2] http-service-ssl-enabled=false
> [vm2] http-service-ssl-keystore=
> [vm2] http-service-ssl-keystore-password=
> [vm2] http-service-ssl-keystore-type=
> [vm2] http-service-ssl-protocols=any
> [vm2] http-service-ssl-require-authentication=false
> [vm2] http-service-ssl-truststore=
> [vm2] http-service-ssl-truststore-password=
> [vm2] jmx-manager=false
> [vm2] jmx-manager-access-file=
> [vm2] jmx-manager-bind-address=
> [vm2] jmx-manager-hostname-for-clients=
> [vm2] jmx-manager-http-port=7070
> [vm2] jmx-manager-password-file=
> [vm2] jmx-manager-port=1099
> [vm2] jmx-manager-ssl-ciphers=any
> [vm2] jmx-manager-ssl-enabled=false
> [vm2] jmx-manager-ssl-keystore=
> [vm2] jmx-manager-ssl-keystore-password=
> [vm2] jmx-manager-ssl-keystore-type=
> [vm2] jmx-manager-ssl-protocols=any
> [vm2] jmx-manager-ssl-require-authentication=true
> [vm2] jmx-manager-ssl-truststore=
> [vm2] jmx-manager-ssl-truststore-password=
> [vm2] jmx-manager-start=false
> [vm2] jmx-manager-update-rate=2000
> [vm2] load-cluster-configuration-from-dir=false
> [vm2] locator-wait-time=0
> [vm2] lock-memory=false
> [vm2] log-disk-space-limit=0
> [vm2] log-file=
> [vm2] log-file-size-limit=0
> [vm2] max-num-reconnect-tries=3
> [vm2] max-wait-time-reconnect=60000
> [vm2] mcast-address=239.192.81.1
> [vm2] mcast-flow-control=1048576, 0.25, 5000
> [vm2] mcast-recv-buffer-size=1048576
> [vm2] mcast-send-buffer-size=65535
> [vm2] mcast-ttl=32
> [vm2] member-timeout=5000
> [vm2] membership-port-range=32769-61000
> [vm2] memcached-bind-address=
> [vm2] memcached-port=0
> [vm2] memcached-protocol=ASCII
> [vm2] name=
> [vm2] redis-bind-address=
> [vm2] redis-password=
> [vm2] redis-port=0
> [vm2] redundancy-zone=
> [vm2] remove-unresponsive-client=false
> [vm2] roles=
> [vm2] security-client-accessor=
> [vm2] security-client-accessor-pp=
> [vm2] security-client-auth-init=
> [vm2] security-client-authenticator=
> [vm2] security-client-dhalgo=
> [vm2] security-log-file=
> [vm2] security-log-level=config
> [vm2] security-manager=
> [vm2] security-peer-auth-init=
> [vm2] security-peer-authenticator=
> [vm2] security-peer-verifymember-timeout=1000
> [vm2] security-post-processor=
> [vm2] security-udp-dhalgo=
> [vm2] server-bind-address=
> [vm2] server-ssl-ciphers=any
> [vm2] server-ssl-enabled=false
> [vm2] server-ssl-keystore=
> [vm2] server-ssl-keystore-password=
> [vm2] server-ssl-keystore-type=
> [vm2] server-ssl-protocols=any
> [vm2] server-ssl-require-authentication=true
> [vm2] server-ssl-truststore=
> [vm2] server-ssl-truststore-password=
> [vm2] socket-buffer-size=32768
> [vm2] socket-lease-time=60000
> [vm2] ssl-ciphers=any
> [vm2] ssl-cluster-alias=
> [vm2] ssl-default-alias=
> [vm2] ssl-enabled-components=
> [vm2] ssl-gateway-alias=
> [vm2] ssl-jmx-alias=
> [vm2] ssl-keystore=
> [vm2] ssl-keystore-password=
> [vm2] ssl-keystore-type=
> [vm2] ssl-locator-alias=
> [vm2] ssl-protocols=any
> [vm2] ssl-require-authentication=true
> [vm2] ssl-server-alias=
> [vm2] ssl-truststore=
> [vm2] ssl-truststore-password=
> [vm2] ssl-truststore-type=
> [vm2] ssl-web-alias=
> [vm2] ssl-web-require-authentication=false
> [vm2] start-dev-rest-api=false
> [vm2] statistic-archive-file=
> [vm2] statistic-sample-rate=1000
> [vm2] statistic-sampling-enabled=true
> [vm2] tcp-port=0
> [vm2] udp-fragment-size=60000
> [vm2] udp-recv-buffer-size=1048576
> [vm2] udp-send-buffer-size=65535
> [vm2] user-command-packages=
> [vm2] [info 2017/10/27 02:10:54.146 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Allocating 314572800 bytes of off-heap memory. The maximum size of a single off-heap object is 314572800 bytes.
> [vm2] [warn 2017/10/27 02:10:54.155 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Could not load client protocol
> [vm2] org.apache.geode.internal.cache.tier.sockets.ServiceLoadingFailureException: There is no ClientProtocolService implementation found in JVM
> [vm2] at org.apache.geode.internal.cache.tier.sockets.ClientProtocolServiceLoader.loadService(ClientProtocolServiceLoader.java:27)
> [vm2] at org.apache.geode.internal.cache.tier.sockets.TcpServerFactory.<init>(TcpServerFactory.java:38)
> [vm2] at org.apache.geode.distributed.internal.InternalLocator.<init>(InternalLocator.java:503)
> [vm2] at org.apache.geode.distributed.internal.InternalLocator.createLocator(InternalLocator.java:272)
> [vm2] at org.apache.geode.distributed.internal.InternalDistributedSystem.startInitLocator(InternalDistributedSystem.java:840)
> [vm2] at org.apache.geode.distributed.internal.InternalDistributedSystem.initialize(InternalDistributedSystem.java:726)
> [vm2] at org.apache.geode.distributed.internal.InternalDistributedSystem.newInstance(InternalDistributedSystem.java:350)
> [vm2] at org.apache.geode.distributed.internal.InternalDistributedSystem.newInstance(InternalDistributedSystem.java:336)
> [vm2] at org.apache.geode.distributed.internal.InternalDistributedSystem.newInstance(InternalDistributedSystem.java:330)
> [vm2] at org.apache.geode.distributed.DistributedSystem.connect(DistributedSystem.java:205)
> [vm2] at org.apache.geode.test.dunit.internal.JUnit4DistributedTestCase.getSystem(JUnit4DistributedTestCase.java:180)
> [vm2] at org.apache.geode.internal.cache.wan.WANTestBase.createFirstRemoteLocator(WANTestBase.java:340)
> [vm2] at org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest.lambda$testConflationWithSameEntryPuts$3486106b$1(ParallelWANStatsDUnitTest.java:495)
> [vm2] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> [vm2] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> [vm2] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> [vm2] at java.lang.reflect.Method.invoke(Method.java:498)
> [vm2] at hydra.MethExecutor.executeObject(MethExecutor.java:245)
> [vm2] at org.apache.geode.test.dunit.standalone.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:70)
> [vm2] at sun.reflect.GeneratedMethodAccessor158.invoke(Unknown Source)
> [vm2] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> [vm2] at java.lang.reflect.Method.invoke(Method.java:498)
> [vm2] at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:357)
> [vm2] at sun.rmi.transport.Transport$1.run(Transport.java:200)
> [vm2] at sun.rmi.transport.Transport$1.run(Transport.java:197)
> [vm2] at java.security.AccessController.doPrivileged(Native Method)
> [vm2] at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
> [vm2] at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:568)
> [vm2] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:826)
> [vm2] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:683)
> [vm2] at java.security.AccessController.doPrivileged(Native Method)
> [vm2] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:682)
> [vm2] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
> [vm2] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
> [vm2] at java.lang.Thread.run(Thread.java:748)
> [vm2] [info 2017/10/27 02:10:54.156 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Starting peer location for Distribution Locator on localhost/127.0.0.1
> [vm2] [info 2017/10/27 02:10:54.156 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Starting Distribution Locator on localhost/127.0.0.1
> [vm2] [info 2017/10/27 02:10:54.156 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Locator was created at Fri Oct 27 02:10:54 UTC 2017
> [vm2] [info 2017/10/27 02:10:54.156 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Listening on port 20150 bound on address localhost/127.0.0.1
> [vm2] [info 2017/10/27 02:10:54.157 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] GemFire peer location service starting. Other locators: localhost[20150] Locators preferred as coordinators: true Network partition detection enabled: true View persistence file: locator20150view.dat
> [vm2] [info 2017/10/27 02:10:54.157 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Peer locator attempting to recover from localhost/127.0.0.1:20150
> [vm2] [info 2017/10/27 02:10:54.160 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Peer locator was unable to recover state from this locator
> [vm2] [info 2017/10/27 02:10:54.160 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] recovery file not found: /tmp/gemfire-build/geode/geode-wan/build/distributedTest129/dunit/vm2/locator20150view.dat
> [vm2] [info 2017/10/27 02:10:54.163 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Starting membership services
> [vm2] [info 2017/10/27 02:10:54.186 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] JGroups channel created (took 23ms)
> [vm2] [info 2017/10/27 02:10:54.187 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] GemFire P2P Listener started on /172.17.0.6:44653
> [vm2] [info 2017/10/27 02:10:54.187 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] This member is hosting a locator will be preferred as a membership coordinator
> [vm2] [info 2017/10/27 02:10:54.188 UTC <Geode Failure Detection Server thread 0> tid=3498] Started failure detection server thread on /172.17.0.6:52823.
> [vm2] [info 2017/10/27 02:10:54.188 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Peer locator is connecting to local membership services with ID 172.17.0.6(209)<ec>:32771
> [vm2] [info 2017/10/27 02:10:54.194 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] This member is becoming the membership coordinator with address 172.17.0.6(209)<ec>:32771
> [vm2] [info 2017/10/27 02:10:54.194 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] received new view: View[172.17.0.6(209)<ec><v0>:32771|0] members: [172.17.0.6(209)<ec><v0>:32771{lead}]
> [vm2] old view is: null
> [vm2] [info 2017/10/27 02:10:54.194 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Peer locator received new membership view: View[172.17.0.6(209)<ec><v0>:32771|0] members: [172.17.0.6(209)<ec><v0>:32771{lead}]
> [vm2] [info 2017/10/27 02:10:54.195 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] ViewCreator starting on:172.17.0.6(209)<ec><v0>:32771
> [vm2] [info 2017/10/27 02:10:54.195 UTC <Geode Membership View Creator> tid=3501] View Creator thread is starting
> [vm2] [info 2017/10/27 02:10:54.196 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Finished joining (took 8ms).
> [vm2] [info 2017/10/27 02:10:54.196 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Starting DistributionManager 172.17.0.6(209)<ec><v0>:32771. (took 35 ms)
> [vm2] [info 2017/10/27 02:10:54.196 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Initial (distribution manager) view = View[172.17.0.6(209)<ec><v0>:32771|0] members: [172.17.0.6(209)<ec><v0>:32771{lead}]
> [vm2] [info 2017/10/27 02:10:54.196 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Admitting member <172.17.0.6(209)<ec><v0>:32771>. Now there are 1 non-admin member(s).
> [vm2] [info 2017/10/27 02:10:54.196 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] 172.17.0.6(209)<ec><v0>:32771 is the elder and the only member.
> [vm2] [info 2017/10/27 02:10:54.202 UTC <Geode Membership View Creator> tid=3501] no recipients for new view aside from myself
> [vm2] [info 2017/10/27 02:10:54.204 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Did not hear back from any other system. I am the first one.
> [vm2] [info 2017/10/27 02:10:54.204 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Starting server location for Distribution Locator on localhost/127.0.0.1[20150]
> [vm2] [info 2017/10/27 02:10:54.217 UTC <WAN Locator Discovery Thread> tid=3504] Locator discovery task exchanged locator information localhost[20150] with localhost[21849]: {1=[localhost[21849]], 2=[localhost[20150]]}.
> [vm2] [info 2017/10/27 02:10:54.221 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: 20150
> [vm2] from org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$147/1175997502.call with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$147/1175997502@48aaeb87 (took 83 ms)
> [vm1] [info 2017/10/27 02:10:54.226 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$73/1277607861.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$73/1277607861@5c005b86
> [vm1] distributed system properties: {locators=localhost[21849], off-heap-memory-size=300m, enable-cluster-configuration=false, use-cluster-configuration=false, mcast-port=0, disable-auto-reconnect=true, log-level=info}
> [vm1] [info 2017/10/27 02:10:54.232 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Startup Configuration:
> [vm1] ### GemFire Properties defined with api ###
> [vm1] disable-auto-reconnect=true
> [vm1] enable-cluster-configuration=false
> [vm1] locators=localhost[21849]
> [vm1] log-level=info
> [vm1] mcast-port=0
> [vm1] off-heap-memory-size=300m
> [vm1] use-cluster-configuration=false
> [vm1] ### GemFire Properties using default values ###
> [vm1] ack-severe-alert-threshold=0
> [vm1] ack-wait-threshold=15
> [vm1] archive-disk-space-limit=0
> [vm1] archive-file-size-limit=0
> [vm1] async-distribution-timeout=0
> [vm1] async-max-queue-size=8
> [vm1] async-queue-timeout=60000
> [vm1] bind-address=
> [vm1] cache-xml-file=cache.xml
> [vm1] cluster-configuration-dir=
> [vm1] cluster-ssl-ciphers=any
> [vm1] cluster-ssl-enabled=false
> [vm1] cluster-ssl-keystore=
> [vm1] cluster-ssl-keystore-password=
> [vm1] cluster-ssl-keystore-type=
> [vm1] cluster-ssl-protocols=any
> [vm1] cluster-ssl-require-authentication=true
> [vm1] cluster-ssl-truststore=
> [vm1] cluster-ssl-truststore-password=
> [vm1] conflate-events=server
> [vm1] conserve-sockets=true
> [vm1] delta-propagation=true
> [vm1] deploy-working-dir=/tmp/gemfire-build/geode/geode-wan/build/distributedTest129/dunit/vm1
> [vm1] disable-tcp=false
> [vm1] distributed-system-id=-1
> [vm1] distributed-transactions=false
> [vm1] durable-client-id=
> [vm1] durable-client-timeout=300
> [vm1] enable-network-partition-detection=true
> [vm1] enable-time-statistics=false
> [vm1] enforce-unique-host=false
> [vm1] gateway-ssl-ciphers=any
> [vm1] gateway-ssl-enabled=false
> [vm1] gateway-ssl-keystore=
> [vm1] gateway-ssl-keystore-password=
> [vm1] gateway-ssl-keystore-type=
> [vm1] gateway-ssl-protocols=any
> [vm1] gateway-ssl-require-authentication=true
> [vm1] gateway-ssl-truststore=
> [vm1] gateway-ssl-truststore-password=
> [vm1] groups=
> [vm1] http-service-bind-address=
> [vm1] http-service-port=7070
> [vm1] http-service-ssl-ciphers=any
> [vm1] http-service-ssl-enabled=false
> [vm1] http-service-ssl-keystore=
> [vm1] http-service-ssl-keystore-password=
> [vm1] http-service-ssl-keystore-type=
> [vm1] http-service-ssl-protocols=any
> [vm1] http-service-ssl-require-authentication=false
> [vm1] http-service-ssl-truststore=
> [vm1] http-service-ssl-truststore-password=
> [vm1] jmx-manager=false
> [vm1] jmx-manager-access-file=
> [vm1] jmx-manager-bind-address=
> [vm1] jmx-manager-hostname-for-clients=
> [vm1] jmx-manager-http-port=7070
> [vm1] jmx-manager-password-file=
> [vm1] jmx-manager-port=1099
> [vm1] jmx-manager-ssl-ciphers=any
> [vm1] jmx-manager-ssl-enabled=false
> [vm1] jmx-manager-ssl-keystore=
> [vm1] jmx-manager-ssl-keystore-password=
> [vm1] jmx-manager-ssl-keystore-type=
> [vm1] jmx-manager-ssl-protocols=any
> [vm1] jmx-manager-ssl-require-authentication=true
> [vm1] jmx-manager-ssl-truststore=
> [vm1] jmx-manager-ssl-truststore-password=
> [vm1] jmx-manager-start=false
> [vm1] jmx-manager-update-rate=2000
> [vm1] load-cluster-configuration-from-dir=false
> [vm1] locator-wait-time=0
> [vm1] lock-memory=false
> [vm1] log-disk-space-limit=0
> [vm1] log-file=
> [vm1] log-file-size-limit=0
> [vm1] max-num-reconnect-tries=3
> [vm1] max-wait-time-reconnect=60000
> [vm1] mcast-address=239.192.81.1
> [vm1] mcast-flow-control=1048576, 0.25, 5000
> [vm1] mcast-recv-buffer-size=1048576
> [vm1] mcast-send-buffer-size=65535
> [vm1] mcast-ttl=32
> [vm1] member-timeout=5000
> [vm1] membership-port-range=32769-61000
> [vm1] memcached-bind-address=
> [vm1] memcached-port=0
> [vm1] memcached-protocol=ASCII
> [vm1] name=
> [vm1] redis-bind-address=
> [vm1] redis-password=
> [vm1] redis-port=0
> [vm1] redundancy-zone=
> [vm1] remote-locators=
> [vm1] remove-unresponsive-client=false
> [vm1] roles=
> [vm1] security-client-accessor=
> [vm1] security-client-accessor-pp=
> [vm1] security-client-auth-init=
> [vm1] security-client-authenticator=
> [vm1] security-client-dhalgo=
> [vm1] security-log-file=
> [vm1] security-log-level=config
> [vm1] security-manager=
> [vm1] security-peer-auth-init=
> [vm1] security-peer-authenticator=
> [vm1] security-peer-verifymember-timeout=1000
> [vm1] security-post-processor=
> [vm1] security-udp-dhalgo=
> [vm1] server-bind-address=
> [vm1] server-ssl-ciphers=any
> [vm1] server-ssl-enabled=false
> [vm1] server-ssl-keystore=
> [vm1] server-ssl-keystore-password=
> [vm1] server-ssl-keystore-type=
> [vm1] server-ssl-protocols=any
> [vm1] server-ssl-require-authentication=true
> [vm1] server-ssl-truststore=
> [vm1] server-ssl-truststore-password=
> [vm1] socket-buffer-size=32768
> [vm1] socket-lease-time=60000
> [vm1] ssl-ciphers=any
> [vm1] ssl-cluster-alias=
> [vm1] ssl-default-alias=
> [vm1] ssl-enabled-components=
> [vm1] ssl-gateway-alias=
> [vm1] ssl-jmx-alias=
> [vm1] ssl-keystore=
> [vm1] ssl-keystore-password=
> [vm1] ssl-keystore-type=
> [vm1] ssl-locator-alias=
> [vm1] ssl-protocols=any
> [vm1] ssl-require-authentication=true
> [vm1] ssl-server-alias=
> [vm1] ssl-truststore=
> [vm1] ssl-truststore-password=
> [vm1] ssl-truststore-type=
> [vm1] ssl-web-alias=
> [vm1] ssl-web-require-authentication=false
> [vm1] start-dev-rest-api=false
> [vm1] start-locator=
> [vm1] statistic-archive-file=
> [vm1] statistic-sample-rate=1000
> [vm1] statistic-sampling-enabled=true
> [vm1] tcp-port=0
> [vm1] udp-fragment-size=60000
> [vm1] udp-recv-buffer-size=1048576
> [vm1] udp-send-buffer-size=65535
> [vm1] user-command-packages=
> [vm1] [info 2017/10/27 02:10:54.233 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Allocating 314572800 bytes of off-heap memory. The maximum size of a single off-heap object is 314572800 bytes.
> [vm1] [info 2017/10/27 02:10:54.245 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Starting membership services
> [vm1] [info 2017/10/27 02:10:54.264 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] JGroups channel created (took 19ms)
> [vm1] [info 2017/10/27 02:10:54.266 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] GemFire P2P Listener started on /172.17.0.6:43961
> [vm1] [info 2017/10/27 02:10:54.266 UTC <Geode Failure Detection Server thread 0> tid=1612] Started failure detection server thread on /172.17.0.6:56914.
> [vm0] [info 2017/10/27 02:10:54.275 UTC <locator request thread[1]> tid=2073] This member is becoming coordinator
> [vm1] [info 2017/10/27 02:10:54.279 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Attempting to join the distributed system through coordinator 172.17.0.6(174)<ec><v0>:32770 using address 172.17.0.6(184):32772
> [vm0] [info 2017/10/27 02:10:54.281 UTC <unicast receiver,6c7835da774c-11497> tid=2084] received join request from 172.17.0.6(184):32772
> [vm0] [info 2017/10/27 02:10:54.292 UTC <unicast receiver,6c7835da774c-11497> tid=2084] Received a join request from 172.17.0.6(184):32772
> [vm0] [info 2017/10/27 02:10:54.593 UTC <Geode Membership View Creator> tid=2091] View Creator is processing 1 requests for the next membership view
> [vm0] [info 2017/10/27 02:10:54.594 UTC <Geode Membership View Creator> tid=2091] preparing new view View[172.17.0.6(174)<ec><v0>:32770|1] members: [172.17.0.6(174)<ec><v0>:32770{lead}, 172.17.0.6(184)<v1>:32772]
> [vm1] [info 2017/10/27 02:10:54.595 UTC <unicast receiver,6c7835da774c-51291> tid=1608] received new view: View[172.17.0.6(174)<ec><v0>:32770|1] members: [172.17.0.6(174)<ec><v0>:32770{lead}, 172.17.0.6(184)<v1>:32772]
> [vm1] old view is: null
> [vm1] [info 2017/10/27 02:10:54.597 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Finished joining (took 330ms).
> [vm0] [info 2017/10/27 02:10:54.597 UTC <Geode Membership View Creator> tid=2091] finished waiting for responses to view preparation
> [vm1] [info 2017/10/27 02:10:54.597 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Starting DistributionManager 172.17.0.6(184)<v1>:32772. (took 354 ms)
> [vm0] [info 2017/10/27 02:10:54.597 UTC <Geode Membership View Creator> tid=2091] received new view: View[172.17.0.6(174)<ec><v0>:32770|1] members: [172.17.0.6(174)<ec><v0>:32770{lead}, 172.17.0.6(184)<v1>:32772]
> [vm0] old view is: View[172.17.0.6(174)<ec><v0>:32770|0] members: [172.17.0.6(174)<ec><v0>:32770{lead}]
> [vm0] [info 2017/10/27 02:10:54.597 UTC <Geode Membership View Creator> tid=2091] Peer locator received new membership view: View[172.17.0.6(174)<ec><v0>:32770|1] members: [172.17.0.6(174)<ec><v0>:32770{lead}, 172.17.0.6(184)<v1>:32772]
> [vm1] [info 2017/10/27 02:10:54.598 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initial (distribution manager) view = View[172.17.0.6(174)<ec><v0>:32770|1] members: [172.17.0.6(174)<ec><v0>:32770{lead}, 172.17.0.6(184)<v1>:32772]
> [vm1] [info 2017/10/27 02:10:54.598 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Admitting member <172.17.0.6(174)<ec><v0>:32770>. Now there are 1 non-admin member(s).
> [vm1] [info 2017/10/27 02:10:54.598 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Admitting member <172.17.0.6(184)<v1>:32772>. Now there are 2 non-admin member(s).
> [vm0] [info 2017/10/27 02:10:54.603 UTC <Geode Membership View Creator> tid=2091] sending new view View[172.17.0.6(174)<ec><v0>:32770|1] members: [172.17.0.6(174)<ec><v0>:32770{lead}, 172.17.0.6(184)<v1>:32772]
> [vm0] [info 2017/10/27 02:10:54.603 UTC <View Message Processor> tid=2097] Membership: Processing addition < 172.17.0.6(184)<v1>:32772 >
> [vm0] [info 2017/10/27 02:10:54.607 UTC <View Message Processor> tid=2097] Admitting member <172.17.0.6(184)<v1>:32772>. Now there are 2 non-admin member(s).
> [vm0] [info 2017/10/27 02:10:54.613 UTC <Pooled High Priority Message Processor 1> tid=2100] Member 172.17.0.6(184)<v1>:32772 is equivalent or in the same redundancy zone.
> [vm1] [info 2017/10/27 02:10:54.630 UTC <P2P message reader for 172.17.0.6(174)<ec><v0>:32770 shared unordered uid=151 port=58856> tid=1619] Member 172.17.0.6(174)<ec><v0>:32770 is equivalent or in the same redundancy zone.
> [vm1] [info 2017/10/27 02:10:54.697 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] No locator(s) found with cluster configuration service
> [vm1] [info 2017/10/27 02:10:54.799 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Requesting cluster configuration
> [vm1] [info 2017/10/27 02:10:54.916 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initializing region _monitoringRegion_172.17.0.6<v1>32772
> [vm1] [info 2017/10/27 02:10:54.925 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initialization of region _monitoringRegion_172.17.0.6<v1>32772 completed
> [vm1] 879.168: [GC (Allocation Failure) [PSYoungGen: 138596K->12772K(138240K)] 145145K->20462K(487936K), 0.1181238 secs] [Times: user=0.50 sys=0.22, real=0.12 secs]
> [vm1] [info 2017/10/27 02:10:56.751 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Loading previously deployed jars
> [vm1] [info 2017/10/27 02:10:56.789 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initializing region PdxTypes
> [vm1] [info 2017/10/27 02:10:56.791 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initialization of region PdxTypes completed
> [vm1] [info 2017/10/27 02:10:56.796 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$73/1277607861.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$73/1277607861@5c005b86 (took 2570 ms)
> [vm1] [info 2017/10/27 02:10:56.799 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$85/1004723347.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$85/1004723347@76fdead8
> [vm1] [info 2017/10/27 02:10:56.800 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Could not connect</ExpectedException>
> [vm1] [info 2017/10/27 02:10:56.800 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Could not connect</ExpectedException>
> [vm1] [info 2017/10/27 02:10:56.800 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>Could not connect</ExpectedException>
> [vm1] [info 2017/10/27 02:10:56.868 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Created disk store ny with unique id a2637c5303fe4671-8e05a21edd6ac3ca
> [vm1] [info 2017/10/27 02:10:56.896 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] recovery region initialization took 2 ms
> [vm1] [info 2017/10/27 02:10:56.965 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initializing region gatewayEventIdIndexMetaData
> [vm1] [info 2017/10/27 02:10:56.970 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initialization of region gatewayEventIdIndexMetaData completed
> [locator] [warn 2017/10/27 02:10:56.983 UTC <WAN Locator Discovery Thread> tid=82] Locator discovery task could not exchange locator information 6c7835da774c[33186] with localhost[0] after 89 retry attempts. Retrying in 10,000 ms.
> [vm1] [info 2017/10/27 02:10:57.009 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] ConcurrentParallelGatewaySenderEventProcessor: dispatcher threads 1
> [vm1] [info 2017/10/27 02:10:57.081 UTC <Event Processor for GatewaySender_ny_0> tid=1653] AutoConnectionSource UpdateLocatorListTask started with interval=10,000 ms.
> [vm1] [info 2017/10/27 02:10:57.088 UTC <Event Processor for GatewaySender_ny_0> tid=1653] Pool ny started with multiuser-authentication=false
> [vm1] [warn 2017/10/27 02:10:57.092 UTC <Event Processor for GatewaySender_ny_0> tid=1653] ny: Could not connect.
> [vm1] [info 2017/10/27 02:10:57.094 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Started ParallelGatewaySender{id=ny,remoteDsId=2,isRunning =true}
> [vm1] [info 2017/10/27 02:10:57.094 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Could not connect</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.094 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Could not connect</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.094 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Could not connect</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.094 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$85/1004723347.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$85/1004723347@76fdead8 (took 294 ms)
> [vm1] [info 2017/10/27 02:10:57.098 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$86/1532438260.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$86/1532438260@49e63caf
> [vm1] [info 2017/10/27 02:10:57.098 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>org.apache.geode.internal.cache.ForceReattemptException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.098 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>org.apache.geode.internal.cache.ForceReattemptException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.098 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>org.apache.geode.internal.cache.ForceReattemptException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.099 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>org.apache.geode.cache.persistence.PartitionOfflineException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.099 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>org.apache.geode.cache.persistence.PartitionOfflineException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.099 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=add>org.apache.geode.cache.persistence.PartitionOfflineException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.157 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initializing region __PR
> [vm1] [info 2017/10/27 02:10:57.158 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initialization of region __PR completed
> [vm1] [info 2017/10/27 02:10:57.197 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Partitioned Region /testConflationWithSameEntryPuts_PR is born with prId=78 ident:#testConflationWithSameEntryPuts_PR
> [vm1] [info 2017/10/27 02:10:57.287 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Partitioned Region /ny_PARALLEL_GATEWAY_SENDER_QUEUE is born with prId=79 ident:#ny_PARALLEL_GATEWAY_SENDER_QUEUE
> [vm1] [info 2017/10/27 02:10:57.348 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Created oplog#1 drf for disk store ny.
> [vm1] [info 2017/10/27 02:10:57.356 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Created oplog#1 crf for disk store ny.
> [vm1] [info 2017/10/27 02:10:57.416 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.internal.cache.ForceReattemptException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.417 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.internal.cache.ForceReattemptException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.417 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.internal.cache.ForceReattemptException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.417 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.cache.persistence.PartitionOfflineException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.417 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.cache.persistence.PartitionOfflineException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.417 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.cache.persistence.PartitionOfflineException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:57.417 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$86/1532438260.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$86/1532438260@49e63caf (took 319 ms)
> [vm1] [info 2017/10/27 02:10:57.437 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$87/36437346.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$87/36437346@5d5d02dc
> [vm1] [info 2017/10/27 02:10:57.459 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initializing region _B__testConflationWithSameEntryPuts__PR_0
> [vm1] [info 2017/10/27 02:10:57.460 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initialization of region _B__testConflationWithSameEntryPuts__PR_0 completed
> [vm1] [info 2017/10/27 02:10:57.485 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initializing region _B__ny__PARALLEL__GATEWAY__SENDER__QUEUE_0
> [vm1] [info 2017/10/27 02:10:57.486 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Region /__PR/_B__ny__PARALLEL__GATEWAY__SENDER__QUEUE_0 was created on this member with the persistent id /172.17.0.6:/tmp/gemfire-build/geode/geode-wan/build/distributedTest129/dunit/vm1/ny_disk_1509070256802_1 created at timestamp 1509070257256 version 0 diskStoreId a2637c5303fe4671-8e05a21edd6ac3ca name null.
> [vm1] [info 2017/10/27 02:10:57.487 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Initialization of region _B__ny__PARALLEL__GATEWAY__SENDER__QUEUE_0 completed
> [vm1] [warn 2017/10/27 02:10:57.948 UTC <Event Processor for GatewaySender_ny_0> tid=1653] During normal processing, unsuccessfully dispatched 10 events (batch #0)
> [vm1] [info 2017/10/27 02:10:58.004 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$87/36437346.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$87/36437346@5d5d02dc (took 566 ms)
> [vm1] [info 2017/10/27 02:10:58.009 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$89/973605575.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$89/973605575@79604436
> [vm1] [info 2017/10/27 02:10:58.020 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: EXCEPTION_OCCURRED
> [vm1] java.lang.AssertionError: expected:<2> but was:<3>
> [vm1] at org.junit.Assert.fail(Assert.java:88)
> [vm1] at org.junit.Assert.failNotEquals(Assert.java:834)
> [vm1] at org.junit.Assert.assertEquals(Assert.java:645)
> [vm1] at org.junit.Assert.assertEquals(Assert.java:631)
> [vm1] at org.apache.geode.internal.cache.wan.WANTestBase.testQueueSize(WANTestBase.java:2564)
> [vm1] at org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest.lambda$testConflationWithSameEntryPuts$ca180b8$2(ParallelWANStatsDUnitTest.java:509)
> [vm1] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> [vm1] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> [vm1] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> [vm1] at java.lang.reflect.Method.invoke(Method.java:498)
> [vm1] at hydra.MethExecutor.executeObject(MethExecutor.java:245)
> [vm1] at org.apache.geode.test.dunit.standalone.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:70)
> [vm1] at sun.reflect.GeneratedMethodAccessor5.invoke(Unknown Source)
> [vm1] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> [vm1] at java.lang.reflect.Method.invoke(Method.java:498)
> [vm1] at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:357)
> [vm1] at sun.rmi.transport.Transport$1.run(Transport.java:200)
> [vm1] at sun.rmi.transport.Transport$1.run(Transport.java:197)
> [vm1] at java.security.AccessController.doPrivileged(Native Method)
> [vm1] at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
> [vm1] at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:568)
> [vm1] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:826)
> [vm1] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:683)
> [vm1] at java.security.AccessController.doPrivileged(Native Method)
> [vm1] at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:682)
> [vm1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
> [vm1] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
> [vm1] at java.lang.Thread.run(Thread.java:748)
> [vm1] from org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$89/973605575.run with 0 args on object: org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest$$Lambda$89/973605575@79604436 (took 11 ms)
> [vm0] [info 2017/10/27 02:10:58.036 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$33/1635708752.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$33/1635708752@619d0d25
> [vm0] [info 2017/10/27 02:10:58.037 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Stopping Distribution Locator on localhost/127.0.0.1[21849]
> [vm2] [info 2017/10/27 02:10:58.037 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$48/2119698258.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$48/2119698258@70819aeb
> [vm2] [info 2017/10/27 02:10:58.037 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Stopping Distribution Locator on localhost/127.0.0.1[20150]
> [vm1] [info 2017/10/27 02:10:58.038 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$33/1735203446.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$33/1735203446@25c4034a
> [vm0] [info 2017/10/27 02:10:58.039 UTC <Distribution Locator on localhost/127.0.0.1> tid=2072] locator shutting down
> [vm2] [info 2017/10/27 02:10:58.040 UTC <Distribution Locator on localhost/127.0.0.1> tid=3482] locator shutting down
> [vm6] [info 2017/10/27 02:10:58.040 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$54/1474203483.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$54/1474203483@a05aabe
> [vm3] [info 2017/10/27 02:10:58.040 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$46/1246309361.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$46/1246309361@347c3892
> [vm6] [info 2017/10/27 02:10:58.041 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$54/1474203483.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$54/1474203483@a05aabe (took 0 ms)
> [vm0] [info 2017/10/27 02:10:58.040 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Distribution Locator on localhost/127.0.0.1[21849] is stopped
> [vm4] [info 2017/10/27 02:10:58.042 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$55/888189434.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$55/888189434@664a6641
> [vm4] [info 2017/10/27 02:10:58.042 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$55/888189434.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$55/888189434@664a6641 (took 0 ms)
> [vm3] [info 2017/10/27 02:10:58.041 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$46/1246309361.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$46/1246309361@347c3892 (took 0 ms)
> [vm7] [info 2017/10/27 02:10:58.041 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$55/2008484108.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$55/2008484108@4679babd
> [vm7] [info 2017/10/27 02:10:58.041 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$55/2008484108.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$55/2008484108@4679babd (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.043 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Distribution Locator on localhost/127.0.0.1[20150] is stopped
> [vm5] [info 2017/10/27 02:10:58.043 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$54/383544531.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$54/383544531@746552d
> [vm5] [info 2017/10/27 02:10:58.044 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$54/383544531.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$54/383544531@746552d (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.045 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Shutting down DistributionManager 172.17.0.6(209)<ec><v0>:32771.
> [vm0] [info 2017/10/27 02:10:58.045 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Shutting down DistributionManager 172.17.0.6(174)<ec><v0>:32770.
> [vm1] [info 2017/10/27 02:10:58.047 UTC <Pooled High Priority Message Processor 1> tid=1628] received leave request from 172.17.0.6(174)<ec><v0>:32770 for 172.17.0.6(174)<ec><v0>:32770
> [vm1] [info 2017/10/27 02:10:58.054 UTC <Pooled High Priority Message Processor 1> tid=1628] This member is becoming the membership coordinator with address 172.17.0.6(184)<v1>:32772
> [vm1] [info 2017/10/27 02:10:58.054 UTC <Pooled High Priority Message Processor 1> tid=1628] ViewCreator starting on:172.17.0.6(184)<v1>:32772
> [vm1] [info 2017/10/27 02:10:58.055 UTC <Geode Membership View Creator> tid=1692] View Creator thread is starting
> [vm1] [info 2017/10/27 02:10:58.056 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] GemFireCache[id = 2006551713; isClosing = true; isShutDownAll = false; created = Fri Oct 27 02:10:54 UTC 2017; server = false; copyOnRead = false; lockLease = 120; lockTimeout = 60]: Now closing.
> [vm1] [info 2017/10/27 02:10:58.080 UTC <Pooled High Priority Message Processor 1> tid=1628] Member at 172.17.0.6(174)<ec><v0>:32770 gracefully left the distributed cache: shutdown message received
> [vm1] [info 2017/10/27 02:10:58.082 UTC <BatchRemovalThread> tid=1654] The QueueRemovalThread is done.
> [vm1] [info 2017/10/27 02:10:58.088 UTC <Geode Membership View Creator> tid=1692] received new view: View[172.17.0.6(184)<v1>:32772|9] members: [172.17.0.6(184)<v1>:32772{lead}] shutdown: [172.17.0.6(174)<ec><v0>:32770]
> [vm1] old view is: View[172.17.0.6(174)<ec><v0>:32770|1] members: [172.17.0.6(174)<ec><v0>:32770{lead}, 172.17.0.6(184)<v1>:32772]
> [vm1] [info 2017/10/27 02:10:58.091 UTC <Geode Membership View Creator> tid=1692] no recipients for new view aside from myself
> [vm1] [info 2017/10/27 02:10:58.100 UTC <View Message Processor> tid=1694] 172.17.0.6(184)<v1>:32772 is the elder and the only member.
> [vm1] [info 2017/10/27 02:10:58.108 UTC <GatewaySender Proxy Stomper> tid=1697] Destroying connection pool ny
> [vm1] [info 2017/10/27 02:10:58.130 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Stopped ParallelGatewaySender{id=ny,remoteDsId=2,isRunning =false}
> [vm2] [info 2017/10/27 02:10:58.151 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Now closing distribution for 172.17.0.6(209)<ec><v0>:32771
> [vm2] [info 2017/10/27 02:10:58.151 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Stopping membership services
> [vm2] [info 2017/10/27 02:10:58.152 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] GMSHealthMonitor server socket is closed in stopServices().
> [vm2] [info 2017/10/27 02:10:58.152 UTC <Geode Failure Detection Server thread 0> tid=3498] GMSHealthMonitor server thread exiting
> [vm2] [info 2017/10/27 02:10:58.152 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] GMSHealthMonitor serverSocketExecutor is terminated
> [vm0] [info 2017/10/27 02:10:58.152 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Now closing distribution for 172.17.0.6(174)<ec><v0>:32770
> [vm0] [info 2017/10/27 02:10:58.152 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Stopping membership services
> [vm0] [info 2017/10/27 02:10:58.154 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] GMSHealthMonitor server socket is closed in stopServices().
> [vm1] [info 2017/10/27 02:10:58.154 UTC <unicast receiver,6c7835da774c-51291> tid=1608] received leave request from 172.17.0.6<ec><v0>:32770 for 172.17.0.6(174)<ec><v0>:32770
> [vm0] [info 2017/10/27 02:10:58.155 UTC <Geode Failure Detection Server thread 0> tid=2088] GMSHealthMonitor server thread exiting
> [vm0] [info 2017/10/27 02:10:58.155 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] GMSHealthMonitor serverSocketExecutor is terminated
> [vm2] [info 2017/10/27 02:10:58.156 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] DistributionManager stopped in 111ms.
> [vm2] [info 2017/10/27 02:10:58.156 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Marking DistributionManager 172.17.0.6(209)<ec><v0>:32771 as closed.
> [vm2] [info 2017/10/27 02:10:58.160 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$48/2119698258.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$48/2119698258@70819aeb (took 123 ms)
> [vm0] [info 2017/10/27 02:10:58.167 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] DistributionManager stopped in 122ms.
> [vm0] [info 2017/10/27 02:10:58.167 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Marking DistributionManager 172.17.0.6(174)<ec><v0>:32770 as closed.
> [vm0] [info 2017/10/27 02:10:58.168 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$33/1635708752.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$33/1635708752@619d0d25 (took 131 ms)
> [vm1] [info 2017/10/27 02:10:58.201 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Created oplog#1 krf for disk store ny.
> [vm1] [info 2017/10/27 02:10:58.258 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Shutting down DistributionManager 172.17.0.6(184)<v1>:32772.
> [vm1] [info 2017/10/27 02:10:58.361 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Now closing distribution for 172.17.0.6(184)<v1>:32772
> [vm1] [info 2017/10/27 02:10:58.361 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Stopping membership services
> [vm1] [info 2017/10/27 02:10:58.363 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] GMSHealthMonitor server socket is closed in stopServices().
> [vm1] [info 2017/10/27 02:10:58.364 UTC <Geode Failure Detection Server thread 0> tid=1612] GMSHealthMonitor server thread exiting
> [vm1] [info 2017/10/27 02:10:58.365 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] GMSHealthMonitor serverSocketExecutor is terminated
> [vm1] [info 2017/10/27 02:10:58.379 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] DistributionManager stopped in 121ms.
> [vm1] [info 2017/10/27 02:10:58.379 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Marking DistributionManager 172.17.0.6(184)<v1>:32772 as closed.
> [vm1] [info 2017/10/27 02:10:58.383 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$33/1735203446.run with 0 args on object: org.apache.geode.internal.cache.wan.WANTestBase$$Lambda$33/1735203446@25c4034a (took 345 ms)
> [vm0] [info 2017/10/27 02:10:58.386 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm0] [info 2017/10/27 02:10:58.386 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm1] [info 2017/10/27 02:10:58.387 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm1] [info 2017/10/27 02:10:58.387 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.390 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm2] [info 2017/10/27 02:10:58.390 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm4] [info 2017/10/27 02:10:58.392 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm4] [info 2017/10/27 02:10:58.392 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm5] [info 2017/10/27 02:10:58.393 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm5] [info 2017/10/27 02:10:58.393 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm6] [info 2017/10/27 02:10:58.393 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm6] [info 2017/10/27 02:10:58.394 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm7] [info 2017/10/27 02:10:58.394 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm7] [info 2017/10/27 02:10:58.394 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [info 2017/10/27 02:10:58.395 UTC <Test worker> tid=22] <ExpectedException action=remove>Connection refused</ExpectedException>
> [info 2017/10/27 02:10:58.395 UTC <Test worker> tid=22] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.396 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm0] [info 2017/10/27 02:10:58.396 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.396 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.396 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm1] [info 2017/10/27 02:10:58.397 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm3] [info 2017/10/27 02:10:58.391 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm3] [info 2017/10/27 02:10:58.391 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm1] [info 2017/10/27 02:10:58.397 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.397 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.397 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.398 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm2] [info 2017/10/27 02:10:58.398 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm2] [info 2017/10/27 02:10:58.398 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm2] [info 2017/10/27 02:10:58.399 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm3] [info 2017/10/27 02:10:58.399 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm3] [info 2017/10/27 02:10:58.399 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm3] [info 2017/10/27 02:10:58.399 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm3] [info 2017/10/27 02:10:58.399 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm4] [info 2017/10/27 02:10:58.400 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm4] [info 2017/10/27 02:10:58.400 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm4] [info 2017/10/27 02:10:58.400 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm4] [info 2017/10/27 02:10:58.400 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm5] [info 2017/10/27 02:10:58.401 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm5] [info 2017/10/27 02:10:58.401 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm5] [info 2017/10/27 02:10:58.401 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm5] [info 2017/10/27 02:10:58.401 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm6] [info 2017/10/27 02:10:58.402 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm6] [info 2017/10/27 02:10:58.402 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm6] [info 2017/10/27 02:10:58.402 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm6] [info 2017/10/27 02:10:58.402 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm7] [info 2017/10/27 02:10:58.403 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm7] [info 2017/10/27 02:10:58.403 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm7] [info 2017/10/27 02:10:58.403 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection refused</ExpectedException>
> [vm7] [info 2017/10/27 02:10:58.403 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [info 2017/10/27 02:10:58.403 UTC <Test worker> tid=22] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [info 2017/10/27 02:10:58.404 UTC <Test worker> tid=22] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.405 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm0] [info 2017/10/27 02:10:58.405 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.405 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.406 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm1] [info 2017/10/27 02:10:58.409 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm1] [info 2017/10/27 02:10:58.409 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.410 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.410 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.410 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm2] [info 2017/10/27 02:10:58.410 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm2] [info 2017/10/27 02:10:58.411 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm2] [info 2017/10/27 02:10:58.411 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm3] [info 2017/10/27 02:10:58.411 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm3] [info 2017/10/27 02:10:58.411 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm3] [info 2017/10/27 02:10:58.411 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm3] [info 2017/10/27 02:10:58.411 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm5] [info 2017/10/27 02:10:58.413 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm5] [info 2017/10/27 02:10:58.413 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm5] [info 2017/10/27 02:10:58.413 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm5] [info 2017/10/27 02:10:58.413 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm6] [info 2017/10/27 02:10:58.414 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm6] [info 2017/10/27 02:10:58.414 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm6] [info 2017/10/27 02:10:58.414 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm6] [info 2017/10/27 02:10:58.414 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm4] [info 2017/10/27 02:10:58.412 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm4] [info 2017/10/27 02:10:58.412 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm4] [info 2017/10/27 02:10:58.412 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm4] [info 2017/10/27 02:10:58.412 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm7] [info 2017/10/27 02:10:58.415 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm7] [info 2017/10/27 02:10:58.415 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm7] [info 2017/10/27 02:10:58.415 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Software caused connection abort</ExpectedException>
> [vm7] [info 2017/10/27 02:10:58.415 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [info 2017/10/27 02:10:58.415 UTC <Test worker> tid=22] <ExpectedException action=remove>Connection reset</ExpectedException>
> [info 2017/10/27 02:10:58.416 UTC <Test worker> tid=22] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.416 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm0] [info 2017/10/27 02:10:58.417 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.417 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm0] [info 2017/10/27 02:10:58.417 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm1] [info 2017/10/27 02:10:58.418 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm1] [info 2017/10/27 02:10:58.418 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.418 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.418 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.419 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm2] [info 2017/10/27 02:10:58.420 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm2] [info 2017/10/27 02:10:58.420 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm2] [info 2017/10/27 02:10:58.420 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm3] [info 2017/10/27 02:10:58.421 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm3] [info 2017/10/27 02:10:58.421 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm3] [info 2017/10/27 02:10:58.421 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm3] [info 2017/10/27 02:10:58.421 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm4] [info 2017/10/27 02:10:58.421 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm4] [info 2017/10/27 02:10:58.422 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm4] [info 2017/10/27 02:10:58.422 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm4] [info 2017/10/27 02:10:58.422 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm5] [info 2017/10/27 02:10:58.422 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm5] [info 2017/10/27 02:10:58.422 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm5] [info 2017/10/27 02:10:58.422 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm5] [info 2017/10/27 02:10:58.422 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm6] [info 2017/10/27 02:10:58.423 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm6] [info 2017/10/27 02:10:58.423 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm6] [info 2017/10/27 02:10:58.423 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm6] [info 2017/10/27 02:10:58.423 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm7] [info 2017/10/27 02:10:58.424 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove"
> [vm7] [info 2017/10/27 02:10:58.424 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm7] [info 2017/10/27 02:10:58.424 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] <ExpectedException action=remove>Connection reset</ExpectedException>
> [vm7] [info 2017/10/27 02:10:58.424 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.IgnoredException$1.run with 0 args on object: "IgnoredException remove" (took 0 ms)
> [vm0] [info 2017/10/27 02:10:58.425 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm0] [info 2017/10/27 02:10:58.425 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm1] [info 2017/10/27 02:10:58.426 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm1] [info 2017/10/27 02:10:58.426 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Could not connect</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.426 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>Could not connect</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.427 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.internal.cache.ForceReattemptException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.427 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.internal.cache.ForceReattemptException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.427 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.cache.persistence.PartitionOfflineException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.427 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] <ExpectedException action=remove>org.apache.geode.cache.persistence.PartitionOfflineException</ExpectedException>
> [vm1] [info 2017/10/27 02:10:58.427 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.427 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm2] [info 2017/10/27 02:10:58.428 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm4] [info 2017/10/27 02:10:58.429 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm4] [info 2017/10/27 02:10:58.429 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm3] [info 2017/10/27 02:10:58.428 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm3] [info 2017/10/27 02:10:58.429 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm5] [info 2017/10/27 02:10:58.430 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm5] [info 2017/10/27 02:10:58.430 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm6] [info 2017/10/27 02:10:58.431 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm6] [info 2017/10/27 02:10:58.431 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm7] [info 2017/10/27 02:10:58.432 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm7] [info 2017/10/27 02:10:58.432 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [locator] [info 2017/10/27 02:10:58.434 UTC <RMI TCP Connection(20)-172.17.0.6> tid=83] Received method: org.apache.geode.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$40/127087543.run with 0 args on object: org.apache.geode.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$40/127087543@69011bdb
> [locator] [info 2017/10/27 02:10:58.435 UTC <RMI TCP Connection(20)-172.17.0.6> tid=83] Got result: null
> [locator] from org.apache.geode.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$40/127087543.run with 0 args on object: org.apache.geode.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$40/127087543@69011bdb (took 0 ms)
> [vm0] [info 2017/10/27 02:10:58.438 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS)
> [vm0] [info 2017/10/27 02:10:58.438 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS) (took 0 ms)
> [vm1] [info 2017/10/27 02:10:58.440 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS)
> [vm1] [info 2017/10/27 02:10:58.440 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS) (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.441 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS)
> [vm2] [info 2017/10/27 02:10:58.441 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS) (took 0 ms)
> [vm3] [info 2017/10/27 02:10:58.442 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS)
> [vm3] [info 2017/10/27 02:10:58.442 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS) (took 0 ms)
> [vm4] [info 2017/10/27 02:10:58.443 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS)
> [vm4] [info 2017/10/27 02:10:58.443 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS) (took 0 ms)
> [vm5] [info 2017/10/27 02:10:58.444 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS)
> [vm5] [info 2017/10/27 02:10:58.444 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS) (took 0 ms)
> [vm6] [info 2017/10/27 02:10:58.444 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS)
> [vm6] [info 2017/10/27 02:10:58.445 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS) (took 0 ms)
> [vm7] [info 2017/10/27 02:10:58.445 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS)
> [vm7] [info 2017/10/27 02:10:58.446 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(disconnectFromDS) (took 0 ms)
> Previously run tests: [SerialWANConflationDUnitTest, DistTXWANDUnitTest, ConcurrentParallelGatewaySenderOffHeapDUnitTest, ParallelGatewaySenderQueueOverflowOffHeapDUnitTest, StopGatewayReceiverCommandDUnitTest, ParallelWANPropagationDUnitTest, ParallelWANStatsDUnitTest]
> [vm0] [info 2017/10/27 02:10:58.451 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm0] [info 2017/10/27 02:10:58.452 UTC <RMI TCP Connection(22)-172.17.0.6> tid=30] Got result: null
> [vm0] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm1] [info 2017/10/27 02:10:58.454 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm1] [info 2017/10/27 02:10:58.454 UTC <RMI TCP Connection(13)-172.17.0.6> tid=30] Got result: null
> [vm1] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm2] [info 2017/10/27 02:10:58.455 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm2] [info 2017/10/27 02:10:58.455 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm2] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm3] [info 2017/10/27 02:10:58.456 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm3] [info 2017/10/27 02:10:58.456 UTC <RMI TCP Connection(12)-172.17.0.6> tid=30] Got result: null
> [vm3] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm4] [info 2017/10/27 02:10:58.457 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm4] [info 2017/10/27 02:10:58.457 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm4] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm5] [info 2017/10/27 02:10:58.459 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm5] [info 2017/10/27 02:10:58.459 UTC <RMI TCP Connection(7)-172.17.0.6> tid=30] Got result: null
> [vm5] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm6] [info 2017/10/27 02:10:58.460 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm6] [info 2017/10/27 02:10:58.460 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm6] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm7] [info 2017/10/27 02:10:58.461 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Received method: org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm7] [info 2017/10/27 02:10:58.461 UTC <RMI TCP Connection(6)-172.17.0.6> tid=30] Got result: null
> [vm7] from org.apache.geode.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.4.14#64029)