geode-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "ASF GitHub Bot (JIRA)" <j...@apache.org>
Subject [jira] [Commented] (GEODE-3919) [CI Failure] org.apache.geode.internal.cache.wan.parallel.ParallelWANStatsDUnitTest > testConflationWithSameEntryPuts FAILED
Date Mon, 30 Oct 2017 19:09:00 GMT

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

ASF GitHub Bot commented on GEODE-3919:
---------------------------------------

boglesby opened a new pull request #994: GEODE-3919: Changed test to wait for the appropriate queue size since…
URL: https://github.com/apache/geode/pull/994
 
 
   … conflation is async
   
   Since conflation is asynchronous to the put operation, the test needs to wait for the queue to reach the correct size rather than just checking it immediately.

----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on GitHub and use the
URL above to go to the specific comment.
 
For queries about this service, please contact Infrastructure at:
users@infra.apache.org


> [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)

Mime
View raw message