[ https://issues.apache.org/jira/browse/GEODE-1698?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Kirk Lund resolved GEODE-1698. ------------------------------ Resolution: Not A Bug Fix Version/s: 1.3.0 > PRColocationDUnitTest.testColocationPartitionedRegionWithNullColocationSpecifiedOnOneNode > ----------------------------------------------------------------------------------------- > > Key: GEODE-1698 > URL: https://issues.apache.org/jira/browse/GEODE-1698 > Project: Geode > Issue Type: Bug > Components: membership > Reporter: Kevin Duling > Labels: ci > Fix For: 1.3.0 > > > In Geode_develop_DistributedTests/3398: > {noformat} > Error Message > com.gemstone.gemfire.distributed.DistributedSystemDisconnectedException: This > connection to a distributed system has been disconnected., caused by > com.gemstone.gemfire.ForcedDisconnectException: Member isn't responding to > heartbeat requests > Stacktrace > com.gemstone.gemfire.distributed.DistributedSystemDisconnectedException: This > connection to a distributed system has been disconnected., caused by > com.gemstone.gemfire.ForcedDisconnectException: Member isn't responding to > heartbeat requests > at > com.gemstone.gemfire.distributed.internal.InternalDistributedSystem.checkConnected(InternalDistributedSystem.java:790) > at > com.gemstone.gemfire.distributed.internal.InternalDistributedSystem.getDistributionManager(InternalDistributedSystem.java:1384) > at > com.gemstone.gemfire.distributed.internal.ReplyProcessor21.getDistributionManager(ReplyProcessor21.java:369) > at > com.gemstone.gemfire.distributed.internal.ReplyProcessor21.postWait(ReplyProcessor21.java:603) > at > com.gemstone.gemfire.distributed.internal.ReplyProcessor21.waitForRepliesUninterruptibly(ReplyProcessor21.java:844) > at > com.gemstone.gemfire.distributed.internal.ReplyProcessor21.waitForRepliesUninterruptibly(ReplyProcessor21.java:796) > at > com.gemstone.gemfire.distributed.internal.ReplyProcessor21.waitForRepliesUninterruptibly(ReplyProcessor21.java:886) > at > com.gemstone.gemfire.internal.cache.UpdateAttributesProcessor.waitForProfileResponse(UpdateAttributesProcessor.java:111) > at > com.gemstone.gemfire.internal.cache.UpdateAttributesProcessor.distribute(UpdateAttributesProcessor.java:99) > at > com.gemstone.gemfire.distributed.internal.DistributionAdvisor.exchangeProfiles(DistributionAdvisor.java:1131) > at > com.gemstone.gemfire.distributed.internal.DistributionAdvisor.initializationGate(DistributionAdvisor.java:458) > at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.initialize(GemFireCacheImpl.java:1096) > at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.basicCreate(GemFireCacheImpl.java:763) > at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.create(GemFireCacheImpl.java:751) > at com.gemstone.gemfire.cache.CacheFactory.create(CacheFactory.java:181) > at com.gemstone.gemfire.cache.CacheFactory.create(CacheFactory.java:172) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase.createCache(JUnit4CacheTestCase.java:120) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase.getCache(JUnit4CacheTestCase.java:263) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase.getCache(JUnit4CacheTestCase.java:242) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase.getCache(JUnit4CacheTestCase.java:234) > at > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest.testColocationPartitionedRegionWithNullColocationSpecifiedOnOneNode(PRColocationDUnitTest.java:1309) > 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:497) > 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:112) > at > org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:56) > 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:497) > at > org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) > at > org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) > at > org.gradle.messaging.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32) > at > org.gradle.messaging.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:497) > at > org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35) > at > org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) > at > org.gradle.messaging.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:360) > at > org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) > at > org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) > at > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) > at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) > at java.lang.Thread.run(Thread.java:745) > Caused by: com.gemstone.gemfire.ForcedDisconnectException: Member isn't > responding to heartbeat requests > at > com.gemstone.gemfire.distributed.internal.membership.gms.mgr.GMSMembershipManager.forceDisconnect(GMSMembershipManager.java:2606) > at > com.gemstone.gemfire.distributed.internal.membership.gms.membership.GMSJoinLeave.forceDisconnect(GMSJoinLeave.java:918) > at > com.gemstone.gemfire.distributed.internal.membership.gms.membership.GMSJoinLeave.processRemoveRequest(GMSJoinLeave.java:593) > at > com.gemstone.gemfire.distributed.internal.membership.gms.membership.GMSJoinLeave.processMessage(GMSJoinLeave.java:1555) > at > com.gemstone.gemfire.distributed.internal.membership.gms.messenger.JGroupsMessenger$JGroupsReceiver.receive(JGroupsMessenger.java:1065) > at org.jgroups.JChannel.invokeCallback(JChannel.java:816) > at org.jgroups.JChannel.up(JChannel.java:741) > at org.jgroups.stack.ProtocolStack.up(ProtocolStack.java:1030) > at org.jgroups.protocols.FRAG2.up(FRAG2.java:165) > at org.jgroups.protocols.FlowControl.up(FlowControl.java:390) > at org.jgroups.protocols.UNICAST3.deliverMessage(UNICAST3.java:1070) > at org.jgroups.protocols.UNICAST3.handleDataReceived(UNICAST3.java:785) > at org.jgroups.protocols.UNICAST3.up(UNICAST3.java:426) > at > com.gemstone.gemfire.distributed.internal.membership.gms.messenger.StatRecorder.up(StatRecorder.java:75) > at > com.gemstone.gemfire.distributed.internal.membership.gms.messenger.AddressManager.up(AddressManager.java:75) > at org.jgroups.protocols.TP.passMessageUp(TP.java:1601) > at org.jgroups.protocols.TP$SingleMessageHandler.run(TP.java:1817) > at org.jgroups.util.DirectExecutor.execute(DirectExecutor.java:10) > at org.jgroups.protocols.TP.handleSingleMessage(TP.java:1729) > at org.jgroups.protocols.TP.receive(TP.java:1654) > at > com.gemstone.gemfire.distributed.internal.membership.gms.messenger.Transport.receive(Transport.java:162) > at org.jgroups.protocols.UDP$PacketReceiver.run(UDP.java:701) > ... 1 more > Standard Output > Previously run tests: [PRClientServerFunctionExecutionNoAckDUnitTest, > PRFunctionExecutionTimeOutDUnitTest, > PRClientServerRegionFunctionExecutionSelectorNoSingleHopDUnitTest, > LocalDataSetDUnitTest, PRColocationDUnitTest] > [vm_0][info 2016/07/25 12:43:17.113 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_0][info 2016/07/25 12:43:17.113 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(setupVM) (took 0 ms) > [vm_1][info 2016/07/25 12:43:17.114 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_1][info 2016/07/25 12:43:17.114 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(setupVM) (took 0 ms) > [vm_2][info 2016/07/25 12:43:17.115 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_2][info 2016/07/25 12:43:17.115 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(setupVM) (took 0 ms) > [vm_3][info 2016/07/25 12:43:17.116 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_3][info 2016/07/25 12:43:17.116 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] Got result: null > [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(setupVM) (took 0 ms) > [setup] START TEST PRColocationDUnitTest.testColocationPartitionedRegion > [vm_0][info 2016/07/25 12:43:17.117 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$14/119712919.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$14/119712919@2a87f435 > [vm_0][info 2016/07/25 12:43:17.117 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$14/119712919.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$14/119712919@2a87f435 > (took 0 ms) > [vm_1][info 2016/07/25 12:43:17.117 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1694237478.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1694237478@60813d32 > [vm_1][info 2016/07/25 12:43:17.118 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1694237478.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1694237478@60813d32 > (took 0 ms) > [vm_2][info 2016/07/25 12:43:17.118 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1756751533.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1756751533@32c07daf > [vm_2][info 2016/07/25 12:43:17.119 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1756751533.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1756751533@32c07daf > (took 0 ms) > [vm_3][info 2016/07/25 12:43:17.119 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$17/1943817067.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$17/1943817067@1c755dca > [vm_3][info 2016/07/25 12:43:17.119 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$17/1943817067.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$17/1943817067@1c755dca > (took 0 ms) > [vm_0][info 2016/07/25 12:43:17.130 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$28/1063736539.run > with 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$28/1063736539@4a6474c4 > [vm_0]distributed system properties: {locators=localhost[50213], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [vm_0][info 2016/07/25 12:43:17.133 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Startup Configuration: > [vm_0] ### GemFire Properties defined with api ### > [vm_0]disable-auto-reconnect=true > [vm_0]enable-cluster-configuration=false > [vm_0]locators=localhost[50213] > [vm_0]log-level=info > [vm_0]mcast-port=0 > [vm_0]use-cluster-configuration=false > [vm_0]### GemFire Properties using default values ### > [vm_0]ack-severe-alert-threshold=0 > [vm_0]ack-wait-threshold=15 > [vm_0]archive-disk-space-limit=0 > [vm_0]archive-file-size-limit=0 > [vm_0]async-distribution-timeout=0 > [vm_0]async-max-queue-size=8 > [vm_0]async-queue-timeout=60000 > [vm_0]bind-address= > [vm_0]cache-xml-file=cache.xml > [vm_0]cluster-configuration-dir= > [vm_0]cluster-ssl-ciphers=any > [vm_0]cluster-ssl-enabled=false > [vm_0]cluster-ssl-keystore= > [vm_0]cluster-ssl-keystore-password= > [vm_0]cluster-ssl-keystore-type= > [vm_0]cluster-ssl-protocols=any > [vm_0]cluster-ssl-require-authentication=true > [vm_0]cluster-ssl-truststore= > [vm_0]cluster-ssl-truststore-password= > [vm_0]conflate-events=server > [vm_0]conserve-sockets=true > [vm_0]delta-propagation=true > [vm_0]deploy-working-dir=. > [vm_0]disable-tcp=false > [vm_0]distributed-system-id=-1 > [vm_0]distributed-transactions=false > [vm_0]durable-client-id= > [vm_0]durable-client-timeout=300 > [vm_0]enable-network-partition-detection=false > [vm_0]enable-time-statistics=false > [vm_0]enforce-unique-host=false > [vm_0]gateway-ssl-ciphers=any > [vm_0]gateway-ssl-enabled=false > [vm_0]gateway-ssl-keystore= > [vm_0]gateway-ssl-keystore-password= > [vm_0]gateway-ssl-keystore-type= > [vm_0]gateway-ssl-protocols=any > [vm_0]gateway-ssl-require-authentication=true > [vm_0]gateway-ssl-truststore= > [vm_0]gateway-ssl-truststore-password= > [vm_0]groups= > [vm_0]http-service-bind-address= > [vm_0]http-service-port=7070 > [vm_0]http-service-ssl-ciphers=any > [vm_0]http-service-ssl-enabled=false > [vm_0]http-service-ssl-keystore= > [vm_0]http-service-ssl-keystore-password= > [vm_0]http-service-ssl-keystore-type= > [vm_0]http-service-ssl-protocols=any > [vm_0]http-service-ssl-require-authentication=false > [vm_0]http-service-ssl-truststore= > [vm_0]http-service-ssl-truststore-password= > [vm_0]jmx-manager=false > [vm_0]jmx-manager-access-file= > [vm_0]jmx-manager-bind-address= > [vm_0]jmx-manager-hostname-for-clients= > [vm_0]jmx-manager-http-port=7070 > [vm_0]jmx-manager-password-file= > [vm_0]jmx-manager-port=1099 > [vm_0]jmx-manager-ssl=false > [vm_0]jmx-manager-ssl-ciphers=any > [vm_0]jmx-manager-ssl-enabled=false > [vm_0]jmx-manager-ssl-keystore= > [vm_0]jmx-manager-ssl-keystore-password= > [vm_0]jmx-manager-ssl-keystore-type= > [vm_0]jmx-manager-ssl-protocols=any > [vm_0]jmx-manager-ssl-require-authentication=true > [vm_0]jmx-manager-ssl-truststore= > [vm_0]jmx-manager-ssl-truststore-password= > [vm_0]jmx-manager-start=false > [vm_0]jmx-manager-update-rate=2000 > [vm_0]load-cluster-configuration-from-dir=false > [vm_0]locator-wait-time=0 > [vm_0]lock-memory=false > [vm_0]log-disk-space-limit=0 > [vm_0]log-file= > [vm_0]log-file-size-limit=0 > [vm_0]max-num-reconnect-tries=3 > [vm_0]max-wait-time-reconnect=60000 > [vm_0]mcast-address=239.192.81.1 > [vm_0]mcast-flow-control=1048576, 0.25, 5000 > [vm_0]mcast-recv-buffer-size=1048576 > [vm_0]mcast-send-buffer-size=65535 > [vm_0]mcast-ttl=32 > [vm_0]member-timeout=5000 > [vm_0]membership-port-range=1024-65535 > [vm_0]memcached-bind-address= > [vm_0]memcached-port=0 > [vm_0]memcached-protocol=ASCII > [vm_0]name= > [vm_0]off-heap-memory-size= > [vm_0]redis-bind-address= > [vm_0]redis-password= > [vm_0]redis-port=0 > [vm_0]redundancy-zone= > [vm_0]remote-locators= > [vm_0]remove-unresponsive-client=false > [vm_0]roles= > [vm_0]security-client-accessor= > [vm_0]security-client-accessor-pp= > [vm_0]security-client-auth-init= > [vm_0]security-client-authenticator= > [vm_0]security-client-dhalgo= > [vm_0]security-log-file= > [vm_0]security-log-level=config > [vm_0]security-manager= > [vm_0]security-peer-auth-init= > [vm_0]security-peer-authenticator= > [vm_0]security-peer-verifymember-timeout=1000 > [vm_0]security-post-processor= > [vm_0]server-bind-address= > [vm_0]server-ssl-ciphers=any > [vm_0]server-ssl-enabled=false > [vm_0]server-ssl-keystore= > [vm_0]server-ssl-keystore-password= > [vm_0]server-ssl-keystore-type= > [vm_0]server-ssl-protocols=any > [vm_0]server-ssl-require-authentication=true > [vm_0]server-ssl-truststore= > [vm_0]server-ssl-truststore-password= > [vm_0]socket-buffer-size=32768 > [vm_0]socket-lease-time=60000 > [vm_0]ssl-ciphers=any > [vm_0]ssl-enabled=false > [vm_0]ssl-protocols=any > [vm_0]ssl-require-authentication=true > [vm_0]start-dev-rest-api=false > [vm_0]start-locator= > [vm_0]statistic-archive-file= > [vm_0]statistic-sample-rate=1000 > [vm_0]statistic-sampling-enabled=true > [vm_0]tcp-port=0 > [vm_0]udp-fragment-size=60000 > [vm_0]udp-recv-buffer-size=1048576 > [vm_0]udp-send-buffer-size=65535 > [vm_0]user-command-packages= > [vm_0][info 2016/07/25 12:43:17.134 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Starting membership services > [vm_0][info 2016/07/25 12:43:17.142 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] JGroups channel created (took 8ms) > [vm_0][info 2016/07/25 12:43:17.144 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] GemFire P2P Listener started on null > [vm_0][info 2016/07/25 12:43:17.144 PDT <Geode Failure Detection Server > thread 0> tid=0xc21] Started failure detection server thread on > kuwait.gemstone.com/10.118.32.93:51006. > [vm_0][info 2016/07/25 12:43:17.146 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Attempting to join the distributed system through coordinator > kuwait(10426:locator)<ec><v0>:1024 using address kuwait(10504)<ec>:1025 > [locator][info 2016/07/25 12:43:17.146 PDT <unicast receiver,kuwait-22220> > tid=0x2a] received join request from kuwait(10504)<ec>:1025 > [locator][info 2016/07/25 12:43:17.347 PDT <Geode Membership View Creator> > tid=0x30] View Creator is processing 4 requests for the next membership view > [locator][info 2016/07/25 12:43:17.347 PDT <Geode Membership View Creator> > tid=0x30] preparing new view View[kuwait(10426:locator)<ec><v0>:1024|193] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}] shutdown: [kuwait(10518)<ec><v191>:1028] > [locator]failure detection ports: 26403 51006 > [vm_0][info 2016/07/25 12:43:17.347 PDT <unicast receiver,kuwait-52318> > tid=0xc1d] received new view: View[kuwait(10426:locator)<ec><v0>:1024|193] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}] shutdown: [kuwait(10518)<ec><v191>:1028] > [vm_0]old view is: null > [locator][info 2016/07/25 12:43:17.348 PDT <Geode Membership View Creator> > tid=0x30] finished waiting for responses to view preparation > [locator][info 2016/07/25 12:43:17.348 PDT <Geode Membership View Creator> > tid=0x30] received new view: View[kuwait(10426:locator)<ec><v0>:1024|193] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}] shutdown: [kuwait(10518)<ec><v191>:1028] > [locator]old view is: View[kuwait(10426:locator)<ec><v0>:1024|192] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10518)<ec><v191>:1028{lead}] > shutdown: [kuwait(10513)<ec><v190>:1027, kuwait(10504)<ec><v188>:1025, > kuwait(10508)<ec><v189>:1026] > [locator][info 2016/07/25 12:43:17.348 PDT <Geode Membership View Creator> > tid=0x30] Peer locator received new membership view: > View[kuwait(10426:locator)<ec><v0>:1024|193] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}] > shutdown: [kuwait(10518)<ec><v191>:1028] > [vm_0][info 2016/07/25 12:43:17.348 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Finished joining (took 204ms). > [vm_0][info 2016/07/25 12:43:17.348 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Starting DistributionManager kuwait(10504)<ec><v193>:1025. (took > 214 ms) > [locator][info 2016/07/25 12:43:17.348 PDT <Geode Membership View Creator> > tid=0x30] sending new view View[kuwait(10426:locator)<ec><v0>:1024|193] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}] shutdown: [kuwait(10518)<ec><v191>:1028] > [locator]failure detection ports: 26403 51006 > [vm_0][info 2016/07/25 12:43:17.348 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initial (distribution manager) view = > View[kuwait(10426:locator)<ec><v0>:1024|193] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}] > shutdown: [kuwait(10518)<ec><v191>:1028] > [locator][info 2016/07/25 12:43:17.348 PDT <View Message Processor> tid=0x3c] > Membership: Processing addition < kuwait(10504)<ec><v193>:1025 > > [vm_0][info 2016/07/25 12:43:17.348 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10426:locator)<ec><v0>:1024>. Now there > are 1 non-admin member(s). > [vm_0][info 2016/07/25 12:43:17.349 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10504)<ec><v193>:1025>. Now there are 2 > non-admin member(s). > [locator][info 2016/07/25 12:43:17.349 PDT <View Message Processor> tid=0x3c] > Admitting member <kuwait(10504)<ec><v193>:1025>. Now there are 2 non-admin > member(s). > [locator][info 2016/07/25 12:43:17.351 PDT <Pooled High Priority Message > Processor 1> tid=0x40] Member kuwait(10504)<ec><v193>:1025 is equivalent or > in the same redundancy zone. > [vm_0][info 2016/07/25 12:43:17.353 PDT <P2P message reader for > kuwait(10426:locator)<ec><v0>:1024 shared unordered uid=180 port=44371> > tid=0xc26] Member kuwait(10426:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [vm_0][info 2016/07/25 12:43:17.363 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initializing region _monitoringRegion_10.118.32.93<v193>1025 > [vm_0][info 2016/07/25 12:43:17.364 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initialization of region _monitoringRegion_10.118.32.93<v193>1025 > completed > [vm_0][info 2016/07/25 12:43:17.368 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] The cache has been created with "use-cluster-configuration=false". > It will not receive any cluster configuration > [vm_0][info 2016/07/25 12:43:17.368 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initializing region PdxTypes > [vm_0][info 2016/07/25 12:43:17.369 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initialization of region PdxTypes completed > [vm_0][info 2016/07/25 12:43:17.369 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_0] from > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$28/1063736539.run > with 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$28/1063736539@4a6474c4 > (took 239 ms) > [vm_1][info 2016/07/25 12:43:17.380 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$26/1563698689.run > with 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$26/1563698689@341fab37 > [vm_1]distributed system properties: {locators=localhost[50213], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [vm_1][info 2016/07/25 12:43:17.383 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Startup Configuration: > [vm_1] ### GemFire Properties defined with api ### > [vm_1]disable-auto-reconnect=true > [vm_1]enable-cluster-configuration=false > [vm_1]locators=localhost[50213] > [vm_1]log-level=info > [vm_1]mcast-port=0 > [vm_1]use-cluster-configuration=false > [vm_1]### GemFire Properties using default values ### > [vm_1]ack-severe-alert-threshold=0 > [vm_1]ack-wait-threshold=15 > [vm_1]archive-disk-space-limit=0 > [vm_1]archive-file-size-limit=0 > [vm_1]async-distribution-timeout=0 > [vm_1]async-max-queue-size=8 > [vm_1]async-queue-timeout=60000 > [vm_1]bind-address= > [vm_1]cache-xml-file=cache.xml > [vm_1]cluster-configuration-dir= > [vm_1]cluster-ssl-ciphers=any > [vm_1]cluster-ssl-enabled=false > [vm_1]cluster-ssl-keystore= > [vm_1]cluster-ssl-keystore-password= > [vm_1]cluster-ssl-keystore-type= > [vm_1]cluster-ssl-protocols=any > [vm_1]cluster-ssl-require-authentication=true > [vm_1]cluster-ssl-truststore= > [vm_1]cluster-ssl-truststore-password= > [vm_1]conflate-events=server > [vm_1]conserve-sockets=true > [vm_1]delta-propagation=true > [vm_1]deploy-working-dir=. > [vm_1]disable-tcp=false > [vm_1]distributed-system-id=-1 > [vm_1]distributed-transactions=false > [vm_1]durable-client-id= > [vm_1]durable-client-timeout=300 > [vm_1]enable-network-partition-detection=false > [vm_1]enable-time-statistics=false > [vm_1]enforce-unique-host=false > [vm_1]gateway-ssl-ciphers=any > [vm_1]gateway-ssl-enabled=false > [vm_1]gateway-ssl-keystore= > [vm_1]gateway-ssl-keystore-password= > [vm_1]gateway-ssl-keystore-type= > [vm_1]gateway-ssl-protocols=any > [vm_1]gateway-ssl-require-authentication=true > [vm_1]gateway-ssl-truststore= > [vm_1]gateway-ssl-truststore-password= > [vm_1]groups= > [vm_1]http-service-bind-address= > [vm_1]http-service-port=7070 > [vm_1]http-service-ssl-ciphers=any > [vm_1]http-service-ssl-enabled=false > [vm_1]http-service-ssl-keystore= > [vm_1]http-service-ssl-keystore-password= > [vm_1]http-service-ssl-keystore-type= > [vm_1]http-service-ssl-protocols=any > [vm_1]http-service-ssl-require-authentication=false > [vm_1]http-service-ssl-truststore= > [vm_1]http-service-ssl-truststore-password= > [vm_1]jmx-manager=false > [vm_1]jmx-manager-access-file= > [vm_1]jmx-manager-bind-address= > [vm_1]jmx-manager-hostname-for-clients= > [vm_1]jmx-manager-http-port=7070 > [vm_1]jmx-manager-password-file= > [vm_1]jmx-manager-port=1099 > [vm_1]jmx-manager-ssl=false > [vm_1]jmx-manager-ssl-ciphers=any > [vm_1]jmx-manager-ssl-enabled=false > [vm_1]jmx-manager-ssl-keystore= > [vm_1]jmx-manager-ssl-keystore-password= > [vm_1]jmx-manager-ssl-keystore-type= > [vm_1]jmx-manager-ssl-protocols=any > [vm_1]jmx-manager-ssl-require-authentication=true > [vm_1]jmx-manager-ssl-truststore= > [vm_1]jmx-manager-ssl-truststore-password= > [vm_1]jmx-manager-start=false > [vm_1]jmx-manager-update-rate=2000 > [vm_1]load-cluster-configuration-from-dir=false > [vm_1]locator-wait-time=0 > [vm_1]lock-memory=false > [vm_1]log-disk-space-limit=0 > [vm_1]log-file= > [vm_1]log-file-size-limit=0 > [vm_1]max-num-reconnect-tries=3 > [vm_1]max-wait-time-reconnect=60000 > [vm_1]mcast-address=239.192.81.1 > [vm_1]mcast-flow-control=1048576, 0.25, 5000 > [vm_1]mcast-recv-buffer-size=1048576 > [vm_1]mcast-send-buffer-size=65535 > [vm_1]mcast-ttl=32 > [vm_1]member-timeout=5000 > [vm_1]membership-port-range=1024-65535 > [vm_1]memcached-bind-address= > [vm_1]memcached-port=0 > [vm_1]memcached-protocol=ASCII > [vm_1]name= > [vm_1]off-heap-memory-size= > [vm_1]redis-bind-address= > [vm_1]redis-password= > [vm_1]redis-port=0 > [vm_1]redundancy-zone= > [vm_1]remote-locators= > [vm_1]remove-unresponsive-client=false > [vm_1]roles= > [vm_1]security-client-accessor= > [vm_1]security-client-accessor-pp= > [vm_1]security-client-auth-init= > [vm_1]security-client-authenticator= > [vm_1]security-client-dhalgo= > [vm_1]security-log-file= > [vm_1]security-log-level=config > [vm_1]security-manager= > [vm_1]security-peer-auth-init= > [vm_1]security-peer-authenticator= > [vm_1]security-peer-verifymember-timeout=1000 > [vm_1]security-post-processor= > [vm_1]server-bind-address= > [vm_1]server-ssl-ciphers=any > [vm_1]server-ssl-enabled=false > [vm_1]server-ssl-keystore= > [vm_1]server-ssl-keystore-password= > [vm_1]server-ssl-keystore-type= > [vm_1]server-ssl-protocols=any > [vm_1]server-ssl-require-authentication=true > [vm_1]server-ssl-truststore= > [vm_1]server-ssl-truststore-password= > [vm_1]socket-buffer-size=32768 > [vm_1]socket-lease-time=60000 > [vm_1]ssl-ciphers=any > [vm_1]ssl-enabled=false > [vm_1]ssl-protocols=any > [vm_1]ssl-require-authentication=true > [vm_1]start-dev-rest-api=false > [vm_1]start-locator= > [vm_1]statistic-archive-file= > [vm_1]statistic-sample-rate=1000 > [vm_1]statistic-sampling-enabled=true > [vm_1]tcp-port=0 > [vm_1]udp-fragment-size=60000 > [vm_1]udp-recv-buffer-size=1048576 > [vm_1]udp-send-buffer-size=65535 > [vm_1]user-command-packages= > [vm_1][info 2016/07/25 12:43:17.385 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Starting membership services > [vm_1][info 2016/07/25 12:43:17.394 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] JGroups channel created (took 9ms) > [vm_1][info 2016/07/25 12:43:17.396 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] GemFire P2P Listener started on null > [vm_1][info 2016/07/25 12:43:17.396 PDT <Geode Failure Detection Server > thread 0> tid=0xcc1] Started failure detection server thread on > kuwait.gemstone.com/10.118.32.93:56242. > [vm_1][info 2016/07/25 12:43:17.398 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Attempting to join the distributed system through coordinator > kuwait(10426:locator)<ec><v0>:1024 using address kuwait(10508)<ec>:1026 > [locator][info 2016/07/25 12:43:17.398 PDT <unicast receiver,kuwait-22220> > tid=0x2a] received join request from kuwait(10508)<ec>:1026 > [locator][info 2016/07/25 12:43:17.699 PDT <Geode Membership View Creator> > tid=0x30] View Creator is processing 1 requests for the next membership view > [locator][info 2016/07/25 12:43:17.699 PDT <Geode Membership View Creator> > tid=0x30] preparing new view View[kuwait(10426:locator)<ec><v0>:1024|194] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026] > [locator]failure detection ports: 26403 51006 56242 > [vm_1][info 2016/07/25 12:43:17.700 PDT <unicast receiver,kuwait-28418> > tid=0xcbd] received new view: View[kuwait(10426:locator)<ec><v0>:1024|194] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026] > [vm_1]old view is: null > [locator][info 2016/07/25 12:43:17.700 PDT <Geode Membership View Creator> > tid=0x30] finished waiting for responses to view preparation > [locator][info 2016/07/25 12:43:17.700 PDT <Geode Membership View Creator> > tid=0x30] received new view: View[kuwait(10426:locator)<ec><v0>:1024|194] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026] > [locator]old view is: View[kuwait(10426:locator)<ec><v0>:1024|193] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}] > shutdown: [kuwait(10518)<ec><v191>:1028] > [vm_1][info 2016/07/25 12:43:17.700 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Finished joining (took 304ms). > [vm_1][info 2016/07/25 12:43:17.700 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Starting DistributionManager kuwait(10508)<ec><v194>:1026. (took > 315 ms) > [locator][info 2016/07/25 12:43:17.700 PDT <Geode Membership View Creator> > tid=0x30] Peer locator received new membership view: > View[kuwait(10426:locator)<ec><v0>:1024|194] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}, > kuwait(10508)<ec><v194>:1026] > [locator][info 2016/07/25 12:43:17.700 PDT <Geode Membership View Creator> > tid=0x30] sending new view View[kuwait(10426:locator)<ec><v0>:1024|194] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026] > [locator]failure detection ports: 26403 51006 56242 > [vm_1][info 2016/07/25 12:43:17.700 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initial (distribution manager) view = > View[kuwait(10426:locator)<ec><v0>:1024|194] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}, > kuwait(10508)<ec><v194>:1026] > [vm_1][info 2016/07/25 12:43:17.700 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10426:locator)<ec><v0>:1024>. Now there > are 1 non-admin member(s). > [locator][info 2016/07/25 12:43:17.700 PDT <View Message Processor> tid=0x3c] > Membership: Processing addition < kuwait(10508)<ec><v194>:1026 > > [vm_1][info 2016/07/25 12:43:17.701 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10504)<ec><v193>:1025>. Now there are 2 > non-admin member(s). > [vm_1][info 2016/07/25 12:43:17.701 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10508)<ec><v194>:1026>. Now there are 3 > non-admin member(s). > [locator][info 2016/07/25 12:43:17.701 PDT <View Message Processor> tid=0x3c] > Admitting member <kuwait(10508)<ec><v194>:1026>. Now there are 3 non-admin > member(s). > [vm_0][info 2016/07/25 12:43:17.701 PDT <unicast receiver,kuwait-52318> > tid=0xc1d] received new view: View[kuwait(10426:locator)<ec><v0>:1024|194] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026] > [vm_0]old view is: View[kuwait(10426:locator)<ec><v0>:1024|193] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}] > shutdown: [kuwait(10518)<ec><v191>:1028] > [vm_0][info 2016/07/25 12:43:17.701 PDT <View Message Processor> tid=0xc34] > Membership: Processing addition < kuwait(10508)<ec><v194>:1026 > > [vm_0][info 2016/07/25 12:43:17.702 PDT <View Message Processor> tid=0xc34] > Admitting member <kuwait(10508)<ec><v194>:1026>. Now there are 3 non-admin > member(s). > [vm_0][info 2016/07/25 12:43:17.703 PDT <Pooled High Priority Message > Processor 1> tid=0xc31] Member kuwait(10508)<ec><v194>:1026 is equivalent or > in the same redundancy zone. > [locator][info 2016/07/25 12:43:17.703 PDT <Pooled High Priority Message > Processor 1> tid=0x40] Member kuwait(10508)<ec><v194>:1026 is equivalent or > in the same redundancy zone. > [vm_1][info 2016/07/25 12:43:17.705 PDT <P2P message reader for > kuwait(10504)<ec><v193>:1025 shared unordered uid=267 port=33618> tid=0xcc9] > Member kuwait(10504)<ec><v193>:1025 is equivalent or in the same redundancy > zone. > [vm_1][info 2016/07/25 12:43:17.706 PDT <P2P message reader for > kuwait(10426:locator)<ec><v0>:1024 shared unordered uid=181 port=33619> > tid=0xcca] Member kuwait(10426:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [vm_1][info 2016/07/25 12:43:17.714 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initializing region _monitoringRegion_10.118.32.93<v194>1026 > [vm_1][info 2016/07/25 12:43:17.716 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initialization of region _monitoringRegion_10.118.32.93<v194>1026 > completed > [vm_1][info 2016/07/25 12:43:17.719 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] The cache has been created with "use-cluster-configuration=false". > It will not receive any cluster configuration > [vm_1][info 2016/07/25 12:43:17.719 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initializing region PdxTypes > [vm_1][info 2016/07/25 12:43:17.722 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Region PdxTypes requesting initial image from > kuwait(10504)<ec><v193>:1025 > [vm_1][info 2016/07/25 12:43:17.724 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] PdxTypes is done getting image from kuwait(10504)<ec><v193>:1025. > isDeltaGII is false > [vm_1][info 2016/07/25 12:43:17.724 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initialization of region PdxTypes completed > [vm_1][info 2016/07/25 12:43:17.724 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_1] from > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$26/1563698689.run > with 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$26/1563698689@341fab37 > (took 344 ms) > [vm_2][info 2016/07/25 12:43:17.734 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Received method: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$26/288578415.run > with 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$26/288578415@33bf154a > [vm_2]distributed system properties: {locators=localhost[50213], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [vm_2][info 2016/07/25 12:43:17.737 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Startup Configuration: > [vm_2] ### GemFire Properties defined with api ### > [vm_2]disable-auto-reconnect=true > [vm_2]enable-cluster-configuration=false > [vm_2]locators=localhost[50213] > [vm_2]log-level=info > [vm_2]mcast-port=0 > [vm_2]use-cluster-configuration=false > [vm_2]### GemFire Properties using default values ### > [vm_2]ack-severe-alert-threshold=0 > [vm_2]ack-wait-threshold=15 > [vm_2]archive-disk-space-limit=0 > [vm_2]archive-file-size-limit=0 > [vm_2]async-distribution-timeout=0 > [vm_2]async-max-queue-size=8 > [vm_2]async-queue-timeout=60000 > [vm_2]bind-address= > [vm_2]cache-xml-file=cache.xml > [vm_2]cluster-configuration-dir= > [vm_2]cluster-ssl-ciphers=any > [vm_2]cluster-ssl-enabled=false > [vm_2]cluster-ssl-keystore= > [vm_2]cluster-ssl-keystore-password= > [vm_2]cluster-ssl-keystore-type= > [vm_2]cluster-ssl-protocols=any > [vm_2]cluster-ssl-require-authentication=true > [vm_2]cluster-ssl-truststore= > [vm_2]cluster-ssl-truststore-password= > [vm_2]conflate-events=server > [vm_2]conserve-sockets=true > [vm_2]delta-propagation=true > [vm_2]deploy-working-dir=. > [vm_2]disable-tcp=false > [vm_2]distributed-system-id=-1 > [vm_2]distributed-transactions=false > [vm_2]durable-client-id= > [vm_2]durable-client-timeout=300 > [vm_2]enable-network-partition-detection=false > [vm_2]enable-time-statistics=false > [vm_2]enforce-unique-host=false > [vm_2]gateway-ssl-ciphers=any > [vm_2]gateway-ssl-enabled=false > [vm_2]gateway-ssl-keystore= > [vm_2]gateway-ssl-keystore-password= > [vm_2]gateway-ssl-keystore-type= > [vm_2]gateway-ssl-protocols=any > [vm_2]gateway-ssl-require-authentication=true > [vm_2]gateway-ssl-truststore= > [vm_2]gateway-ssl-truststore-password= > [vm_2]groups= > [vm_2]http-service-bind-address= > [vm_2]http-service-port=7070 > [vm_2]http-service-ssl-ciphers=any > [vm_2]http-service-ssl-enabled=false > [vm_2]http-service-ssl-keystore= > [vm_2]http-service-ssl-keystore-password= > [vm_2]http-service-ssl-keystore-type= > [vm_2]http-service-ssl-protocols=any > [vm_2]http-service-ssl-require-authentication=false > [vm_2]http-service-ssl-truststore= > [vm_2]http-service-ssl-truststore-password= > [vm_2]jmx-manager=false > [vm_2]jmx-manager-access-file= > [vm_2]jmx-manager-bind-address= > [vm_2]jmx-manager-hostname-for-clients= > [vm_2]jmx-manager-http-port=7070 > [vm_2]jmx-manager-password-file= > [vm_2]jmx-manager-port=1099 > [vm_2]jmx-manager-ssl=false > [vm_2]jmx-manager-ssl-ciphers=any > [vm_2]jmx-manager-ssl-enabled=false > [vm_2]jmx-manager-ssl-keystore= > [vm_2]jmx-manager-ssl-keystore-password= > [vm_2]jmx-manager-ssl-keystore-type= > [vm_2]jmx-manager-ssl-protocols=any > [vm_2]jmx-manager-ssl-require-authentication=true > [vm_2]jmx-manager-ssl-truststore= > [vm_2]jmx-manager-ssl-truststore-password= > [vm_2]jmx-manager-start=false > [vm_2]jmx-manager-update-rate=2000 > [vm_2]load-cluster-configuration-from-dir=false > [vm_2]locator-wait-time=0 > [vm_2]lock-memory=false > [vm_2]log-disk-space-limit=0 > [vm_2]log-file= > [vm_2]log-file-size-limit=0 > [vm_2]max-num-reconnect-tries=3 > [vm_2]max-wait-time-reconnect=60000 > [vm_2]mcast-address=239.192.81.1 > [vm_2]mcast-flow-control=1048576, 0.25, 5000 > [vm_2]mcast-recv-buffer-size=1048576 > [vm_2]mcast-send-buffer-size=65535 > [vm_2]mcast-ttl=32 > [vm_2]member-timeout=5000 > [vm_2]membership-port-range=1024-65535 > [vm_2]memcached-bind-address= > [vm_2]memcached-port=0 > [vm_2]memcached-protocol=ASCII > [vm_2]name= > [vm_2]off-heap-memory-size= > [vm_2]redis-bind-address= > [vm_2]redis-password= > [vm_2]redis-port=0 > [vm_2]redundancy-zone= > [vm_2]remote-locators= > [vm_2]remove-unresponsive-client=false > [vm_2]roles= > [vm_2]security-client-accessor= > [vm_2]security-client-accessor-pp= > [vm_2]security-client-auth-init= > [vm_2]security-client-authenticator= > [vm_2]security-client-dhalgo= > [vm_2]security-log-file= > [vm_2]security-log-level=config > [vm_2]security-manager= > [vm_2]security-peer-auth-init= > [vm_2]security-peer-authenticator= > [vm_2]security-peer-verifymember-timeout=1000 > [vm_2]security-post-processor= > [vm_2]server-bind-address= > [vm_2]server-ssl-ciphers=any > [vm_2]server-ssl-enabled=false > [vm_2]server-ssl-keystore= > [vm_2]server-ssl-keystore-password= > [vm_2]server-ssl-keystore-type= > [vm_2]server-ssl-protocols=any > [vm_2]server-ssl-require-authentication=true > [vm_2]server-ssl-truststore= > [vm_2]server-ssl-truststore-password= > [vm_2]socket-buffer-size=32768 > [vm_2]socket-lease-time=60000 > [vm_2]ssl-ciphers=any > [vm_2]ssl-enabled=false > [vm_2]ssl-protocols=any > [vm_2]ssl-require-authentication=true > [vm_2]start-dev-rest-api=false > [vm_2]start-locator= > [vm_2]statistic-archive-file= > [vm_2]statistic-sample-rate=1000 > [vm_2]statistic-sampling-enabled=true > [vm_2]tcp-port=0 > [vm_2]udp-fragment-size=60000 > [vm_2]udp-recv-buffer-size=1048576 > [vm_2]udp-send-buffer-size=65535 > [vm_2]user-command-packages= > [vm_2][info 2016/07/25 12:43:17.739 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Starting membership services > [vm_2][info 2016/07/25 12:43:17.747 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] JGroups channel created (took 8ms) > [vm_2][info 2016/07/25 12:43:17.748 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] GemFire P2P Listener started on null > [vm_2][info 2016/07/25 12:43:17.748 PDT <Geode Failure Detection Server > thread 0> tid=0xd9c] Started failure detection server thread on > kuwait.gemstone.com/10.118.32.93:3452. > [vm_2][info 2016/07/25 12:43:17.750 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Attempting to join the distributed system through coordinator > kuwait(10426:locator)<ec><v0>:1024 using address kuwait(10513)<ec>:1027 > [locator][info 2016/07/25 12:43:17.751 PDT <unicast receiver,kuwait-22220> > tid=0x2a] received join request from kuwait(10513)<ec>:1027 > [locator][info 2016/07/25 12:43:18.051 PDT <Geode Membership View Creator> > tid=0x30] View Creator is processing 1 requests for the next membership view > [locator][info 2016/07/25 12:43:18.051 PDT <Geode Membership View Creator> > tid=0x30] preparing new view View[kuwait(10426:locator)<ec><v0>:1024|195] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027] > [locator]failure detection ports: 26403 51006 56242 3452 > [vm_2][info 2016/07/25 12:43:18.052 PDT <unicast receiver,kuwait-57287> > tid=0xd98] received new view: View[kuwait(10426:locator)<ec><v0>:1024|195] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027] > [vm_2]old view is: null > [locator][info 2016/07/25 12:43:18.052 PDT <Geode Membership View Creator> > tid=0x30] finished waiting for responses to view preparation > [locator][info 2016/07/25 12:43:18.052 PDT <Geode Membership View Creator> > tid=0x30] received new view: View[kuwait(10426:locator)<ec><v0>:1024|195] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027] > [locator]old view is: View[kuwait(10426:locator)<ec><v0>:1024|194] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}, > kuwait(10508)<ec><v194>:1026] > [locator][info 2016/07/25 12:43:18.052 PDT <Geode Membership View Creator> > tid=0x30] Peer locator received new membership view: > View[kuwait(10426:locator)<ec><v0>:1024|195] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}, > kuwait(10508)<ec><v194>:1026, kuwait(10513)<ec><v195>:1027] > [vm_2][info 2016/07/25 12:43:18.052 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Finished joining (took 304ms). > [vm_2][info 2016/07/25 12:43:18.052 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Starting DistributionManager kuwait(10513)<ec><v195>:1027. (took > 314 ms) > [locator][info 2016/07/25 12:43:18.052 PDT <Geode Membership View Creator> > tid=0x30] sending new view View[kuwait(10426:locator)<ec><v0>:1024|195] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027] > [locator]failure detection ports: 26403 51006 56242 3452 > [vm_2][info 2016/07/25 12:43:18.053 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initial (distribution manager) view = > View[kuwait(10426:locator)<ec><v0>:1024|195] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}, > kuwait(10508)<ec><v194>:1026, kuwait(10513)<ec><v195>:1027] > [locator][info 2016/07/25 12:43:18.053 PDT <View Message Processor> tid=0x3c] > Membership: Processing addition < kuwait(10513)<ec><v195>:1027 > > [vm_2][info 2016/07/25 12:43:18.053 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10426:locator)<ec><v0>:1024>. Now there > are 1 non-admin member(s). > [vm_0][info 2016/07/25 12:43:18.053 PDT <unicast receiver,kuwait-52318> > tid=0xc1d] received new view: View[kuwait(10426:locator)<ec><v0>:1024|195] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027] > [vm_0]old view is: View[kuwait(10426:locator)<ec><v0>:1024|194] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}, > kuwait(10508)<ec><v194>:1026] > [vm_2][info 2016/07/25 12:43:18.053 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10504)<ec><v193>:1025>. Now there are 2 > non-admin member(s). > [locator][info 2016/07/25 12:43:18.053 PDT <View Message Processor> tid=0x3c] > Admitting member <kuwait(10513)<ec><v195>:1027>. Now there are 4 non-admin > member(s). > [vm_1][info 2016/07/25 12:43:18.053 PDT <unicast receiver,kuwait-28418> > tid=0xcbd] received new view: View[kuwait(10426:locator)<ec><v0>:1024|195] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027] > [vm_1]old view is: View[kuwait(10426:locator)<ec><v0>:1024|194] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}, > kuwait(10508)<ec><v194>:1026] > [vm_2][info 2016/07/25 12:43:18.053 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10508)<ec><v194>:1026>. Now there are 3 > non-admin member(s). > [vm_0][info 2016/07/25 12:43:18.053 PDT <View Message Processor> tid=0xc34] > Membership: Processing addition < kuwait(10513)<ec><v195>:1027 > > [vm_2][info 2016/07/25 12:43:18.053 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Admitting member <kuwait(10513)<ec><v195>:1027>. Now there are 4 > non-admin member(s). > [vm_0][info 2016/07/25 12:43:18.053 PDT <View Message Processor> tid=0xc34] > Admitting member <kuwait(10513)<ec><v195>:1027>. Now there are 4 non-admin > member(s). > [vm_1][info 2016/07/25 12:43:18.054 PDT <View Message Processor> tid=0xcd9] > Membership: Processing addition < kuwait(10513)<ec><v195>:1027 > > [vm_1][info 2016/07/25 12:43:18.054 PDT <View Message Processor> tid=0xcd9] > Admitting member <kuwait(10513)<ec><v195>:1027>. Now there are 4 non-admin > member(s). > [locator][info 2016/07/25 12:43:18.057 PDT <Pooled High Priority Message > Processor 1> tid=0x40] Member kuwait(10513)<ec><v195>:1027 is equivalent or > in the same redundancy zone. > [vm_0][info 2016/07/25 12:43:18.057 PDT <Pooled High Priority Message > Processor 1> tid=0xc31] Member kuwait(10513)<ec><v195>:1027 is equivalent or > in the same redundancy zone. > [vm_1][info 2016/07/25 12:43:18.057 PDT <Pooled High Priority Message > Processor 1> tid=0xcd5] Member kuwait(10513)<ec><v195>:1027 is equivalent or > in the same redundancy zone. > [vm_2][info 2016/07/25 12:43:18.059 PDT <P2P message reader for > kuwait(10426:locator)<ec><v0>:1024 shared unordered uid=182 port=59472> > tid=0xda7] Member kuwait(10426:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [vm_2][info 2016/07/25 12:43:18.059 PDT <P2P message reader for > kuwait(10504)<ec><v193>:1025 shared unordered uid=268 port=59471> tid=0xda5] > Member kuwait(10504)<ec><v193>:1025 is equivalent or in the same redundancy > zone. > [vm_2][info 2016/07/25 12:43:18.059 PDT <P2P message reader for > kuwait(10508)<ec><v194>:1026 shared unordered uid=268 port=59473> tid=0xda8] > Member kuwait(10508)<ec><v194>:1026 is equivalent or in the same redundancy > zone. > [vm_2][info 2016/07/25 12:43:18.071 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initializing region _monitoringRegion_10.118.32.93<v195>1027 > [vm_2][info 2016/07/25 12:43:18.072 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initialization of region _monitoringRegion_10.118.32.93<v195>1027 > completed > [vm_2][info 2016/07/25 12:43:18.076 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] The cache has been created with "use-cluster-configuration=false". > It will not receive any cluster configuration > [vm_2][info 2016/07/25 12:43:18.076 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initializing region PdxTypes > [vm_2][info 2016/07/25 12:43:18.080 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Region PdxTypes requesting initial image from > kuwait(10508)<ec><v194>:1026 > [vm_2][info 2016/07/25 12:43:18.080 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] PdxTypes is done getting image from kuwait(10508)<ec><v194>:1026. > isDeltaGII is false > [vm_2][info 2016/07/25 12:43:18.080 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Initialization of region PdxTypes completed > [vm_2][info 2016/07/25 12:43:18.081 PDT <RMI TCP Connection(5)-10.118.32.93> > tid=0x1b] Got result: null > [vm_2] from > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$26/288578415.run > with 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$26/288578415@33bf154a > (took 346 ms) > [vm_3][info 2016/07/25 12:43:18.090 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] Received method: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$49/861240409.run > with 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$$Lambda$49/861240409@370428ee > [vm_3]distributed system properties: {locators=localhost[50213], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [vm_3][info 2016/07/25 12:43:18.093 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] Startup Configuration: > [vm_3] ### GemFire Properties defined with api ### > [vm_3]disable-auto-reconnect=true > [vm_3]enable-cluster-configuration=false > [vm_3]locators=localhost[50213] > [vm_3]log-level=info > [vm_3]mcast-port=0 > [vm_3]use-cluster-configuration=false > [vm_3]### GemFire Properties using default values ### > [vm_3]ack-severe-alert-threshold=0 > [vm_3]ack-wait-threshold=15 > [vm_3]archive-disk-space-limit=0 > [vm_3]archive-file-size-limit=0 > [vm_3]async-distribution-timeout=0 > [vm_3]async-max-queue-size=8 > [vm_3]async-queue-timeout=60000 > [vm_3]bind-address= > [vm_3]cache-xml-file=cache.xml > [vm_3]cluster-configuration-dir= > [vm_3]cluster-ssl-ciphers=any > [vm_3]cluster-ssl-enabled=false > [vm_3]cluster-ssl-keystore= > [vm_3]cluster-ssl-keystore-password= > [vm_3]cluster-ssl-keystore-type= > [vm_3]cluster-ssl-protocols=any > [vm_3]cluster-ssl-require-authentication=true > [vm_3]cluster-ssl-truststore= > [vm_3]cluster-ssl-truststore-password= > [vm_3]conflate-events=server > [vm_3]conserve-sockets=true > [vm_3]delta-propagation=true > [vm_3]deploy-working-dir=. > [vm_3]disable-tcp=false > [vm_3]distributed-system-id=-1 > [vm_3]distributed-transactions=false > [vm_3]durable-client-id= > [vm_3]durable-client-timeout=300 > [vm_3]enable-network-partition-detection=false > [vm_3]enable-time-statistics=false > [vm_3]enforce-unique-host=false > [vm_3]gateway-ssl-ciphers=any > [vm_3]gateway-ssl-enabled=false > [vm_3]gateway-ssl-keystore= > [vm_3]gateway-ssl-keystore-password= > [vm_3]gateway-ssl-keystore-type= > [vm_3]gateway-ssl-protocols=any > [vm_3]gateway-ssl-require-authentication=true > [vm_3]gateway-ssl-truststore= > [vm_3]gateway-ssl-truststore-password= > [vm_3]groups= > [vm_3]http-service-bind-address= > [vm_3]http-service-port=7070 > [vm_3]http-service-ssl-ciphers=any > [vm_3]http-service-ssl-enabled=false > [vm_3]http-service-ssl-keystore= > [vm_3]http-service-ssl-keystore-password= > [vm_3]http-service-ssl-keystore-type= > [vm_3]http-service-ssl-protocols=any > [vm_3]http-service-ssl-require-authentication=false > [vm_3]http-service-ssl-truststore= > [vm_3]http-service-ssl-truststore-password= > [vm_3]jmx-manager=false > [vm_3]jmx-manager-access-file= > [vm_3]jmx-manager-bind-address= > [vm_3]jmx-manager-hostname-for-clients= > [vm_3]jmx-manager-http-port=7070 > [vm_3]jmx-manager-password-file= > [vm_3]jmx-manager-port=1099 > [vm_3]jmx-manager-ssl=false > [vm_3]jmx-manager-ssl-ciphers=any > [vm_3]jmx-manager-ssl-enabled=false > [vm_3]jmx-manager-ssl-keystore= > [vm_3]jmx-manager-ssl-keystore-password= > [vm_3]jmx-manager-ssl-keystore-type= > [vm_3]jmx-manager-ssl-protocols=any > [vm_3]jmx-manager-ssl-require-authentication=true > [vm_3]jmx-manager-ssl-truststore= > [vm_3]jmx-manager-ssl-truststore-password= > [vm_3]jmx-manager-start=false > [vm_3]jmx-manager-update-rate=2000 > [vm_3]load-cluster-configuration-from-dir=false > [vm_3]locator-wait-time=0 > [vm_3]lock-memory=false > [vm_3]log-disk-space-limit=0 > [vm_3]log-file= > [vm_3]log-file-size-limit=0 > [vm_3]max-num-reconnect-tries=3 > [vm_3]max-wait-time-reconnect=60000 > [vm_3]mcast-address=239.192.81.1 > [vm_3]mcast-flow-control=1048576, 0.25, 5000 > [vm_3]mcast-recv-buffer-size=1048576 > [vm_3]mcast-send-buffer-size=65535 > [vm_3]mcast-ttl=32 > [vm_3]member-timeout=5000 > [vm_3]membership-port-range=1024-65535 > [vm_3]memcached-bind-address= > [vm_3]memcached-port=0 > [vm_3]memcached-protocol=ASCII > [vm_3]name= > [vm_3]off-heap-memory-size= > [vm_3]redis-bind-address= > [vm_3]redis-password= > [vm_3]redis-port=0 > [vm_3]redundancy-zone= > [vm_3]remote-locators= > [vm_3]remove-unresponsive-client=false > [vm_3]roles= > [vm_3]security-client-accessor= > [vm_3]security-client-accessor-pp= > [vm_3]security-client-auth-init= > [vm_3]security-client-authenticator= > [vm_3]security-client-dhalgo= > [vm_3]security-log-file= > [vm_3]security-log-level=config > [vm_3]security-manager= > [vm_3]security-peer-auth-init= > [vm_3]security-peer-authenticator= > [vm_3]security-peer-verifymember-timeout=1000 > [vm_3]security-post-processor= > [vm_3]server-bind-address= > [vm_3]server-ssl-ciphers=any > [vm_3]server-ssl-enabled=false > [vm_3]server-ssl-keystore= > [vm_3]server-ssl-keystore-password= > [vm_3]server-ssl-keystore-type= > [vm_3]server-ssl-protocols=any > [vm_3]server-ssl-require-authentication=true > [vm_3]server-ssl-truststore= > [vm_3]server-ssl-truststore-password= > [vm_3]socket-buffer-size=32768 > [vm_3]socket-lease-time=60000 > [vm_3]ssl-ciphers=any > [vm_3]ssl-enabled=false > [vm_3]ssl-protocols=any > [vm_3]ssl-require-authentication=true > [vm_3]start-dev-rest-api=false > [vm_3]start-locator= > [vm_3]statistic-archive-file= > [vm_3]statistic-sample-rate=1000 > [vm_3]statistic-sampling-enabled=true > [vm_3]tcp-port=0 > [vm_3]udp-fragment-size=60000 > [vm_3]udp-recv-buffer-size=1048576 > [vm_3]udp-send-buffer-size=65535 > [vm_3]user-command-packages= > [vm_3][info 2016/07/25 12:43:18.095 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] Starting membership services > [vm_3][info 2016/07/25 12:43:18.106 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] JGroups channel created (took 11ms) > [vm_3][info 2016/07/25 12:43:18.107 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] GemFire P2P Listener started on null > [vm_3][info 2016/07/25 12:43:18.108 PDT <Geode Failure Detection Server > thread 0> tid=0x58b] Started failure detection server thread on > kuwait.gemstone.com/10.118.32.93:53201. > [vm_3][info 2016/07/25 12:43:18.109 PDT <RMI TCP Connection(1)-10.118.32.93> > tid=0x1b] Attempting to join the distributed system through coordinator > kuwait(10426:locator)<ec><v0>:1024 using address kuwait(10518)<ec>:1028 > [locator][info 2016/07/25 12:43:18.110 PDT <unicast receiver,kuwait-22220> > tid=0x2a] received join request from kuwait(10518)<ec>:1028 > [locator][info 2016/07/25 12:43:18.411 PDT <Geode Membership View Creator> > tid=0x30] View Creator is processing 1 requests for the next membership view > [locator][info 2016/07/25 12:43:18.411 PDT <Geode Membership View Creator> > tid=0x30] preparing new view View[kuwait(10426:locator)<ec><v0>:1024|196] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027, kuwait(10518)<ec><v196>:1028] > [locator]failure detection ports: 26403 51006 56242 3452 53201 > [vm_3][info 2016/07/25 12:43:18.412 PDT <unicast receiver,kuwait-33038> > tid=0x587] received new view: View[kuwait(10426:locator)<ec><v0>:1024|196] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027, kuwait(10518)<ec><v196>:1028] > [vm_3]old view is: null > [locator][info 2016/07/25 12:43:18.412 PDT <Geode Membership View Creator> > tid=0x30] finished waiting for responses to view preparation > [locator][info 2016/07/25 12:43:18.412 PDT <Geode Membership View Creator> > tid=0x30] received new view: View[kuwait(10426:locator)<ec><v0>:1024|196] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10504)<ec><v193>:1025{lead}, kuwait(10508)<ec><v194>:1026, > kuwait(10513)<ec><v195>:1027, kuwait(10518)<ec><v196>:1028] > [locator]old view is: View[kuwait(10426:locator)<ec><v0>:1024|195] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v193>:1025{lead}, > kuwait(10508)<ec><v194>:1026, kuwait(10513)<ec><v195>:1027] > [locator][info 2016/07/25 12:43:18.412 PDT <Geode Membership View Creator> > tid=0x30] Peer locator received new membership view: > View[kuwait(10426:locator)<ec><v0>:1024|196] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(1 > ...[truncated 3424450 chars]... > estCase$$Lambda$9/601811905@168dbc72 > [vm_0][info 2016/07/25 12:49:26.824 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootI/I with prId=116 closing. > [vm_1][warn 2016/07/25 12:49:26.826 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootI/I > [vm_2][warn 2016/07/25 12:49:26.826 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootI/I > [vm_3][warn 2016/07/25 12:49:26.826 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootI/I > [vm_0][warn 2016/07/25 12:49:26.827 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootI/I > [vm_0][info 2016/07/25 12:49:26.830 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootI/I with prId=116 closed. > [vm_0][info 2016/07/25 12:49:26.831 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootN/N with prId=121 closing. > [vm_3][warn 2016/07/25 12:49:26.832 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootN/N > [vm_2][warn 2016/07/25 12:49:26.832 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootN/N > [vm_1][warn 2016/07/25 12:49:26.832 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootN/N > [vm_0][warn 2016/07/25 12:49:26.833 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootN/N > [vm_0][info 2016/07/25 12:49:26.843 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootN/N with prId=121 closed. > [vm_0][info 2016/07/25 12:49:26.844 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootF/F with prId=113 closing. > [vm_1][warn 2016/07/25 12:49:26.845 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootF/F > [vm_2][warn 2016/07/25 12:49:26.845 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootF/F > [vm_3][warn 2016/07/25 12:49:26.845 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootF/F > [vm_0][warn 2016/07/25 12:49:26.845 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootF/F > [vm_0][info 2016/07/25 12:49:26.848 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootF/F with prId=113 closed. > [vm_0][info 2016/07/25 12:49:26.849 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootL/L with prId=119 closing. > [vm_2][warn 2016/07/25 12:49:26.850 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootL/L > [vm_1][warn 2016/07/25 12:49:26.850 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootL/L > [vm_3][warn 2016/07/25 12:49:26.850 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootL/L > [vm_0][warn 2016/07/25 12:49:26.850 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootL/L > [vm_0][info 2016/07/25 12:49:26.853 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootL/L with prId=119 closed. > [vm_0][info 2016/07/25 12:49:26.854 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootC/C with prId=110 closing. > [vm_2][warn 2016/07/25 12:49:26.855 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootC/C > [vm_1][warn 2016/07/25 12:49:26.855 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootC/C > [vm_3][warn 2016/07/25 12:49:26.855 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootC/C > [vm_0][warn 2016/07/25 12:49:26.855 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootC/C > [vm_0][info 2016/07/25 12:49:26.857 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootC/C with prId=110 closed. > [vm_0][info 2016/07/25 12:49:26.859 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootK/K with prId=118 closing. > [vm_2][warn 2016/07/25 12:49:26.860 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootK/K > [vm_1][warn 2016/07/25 12:49:26.860 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootK/K > [vm_3][warn 2016/07/25 12:49:26.860 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootK/K > [vm_0][warn 2016/07/25 12:49:26.860 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootK/K > [vm_0][info 2016/07/25 12:49:26.862 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootK/K with prId=118 closed. > [vm_0][info 2016/07/25 12:49:26.863 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootA/A with prId=108 closing. > [vm_1][warn 2016/07/25 12:49:26.865 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootA/A > [vm_2][warn 2016/07/25 12:49:26.865 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootA/A > [vm_3][warn 2016/07/25 12:49:26.865 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootA/A > [vm_0][warn 2016/07/25 12:49:26.865 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootA/A > [vm_0][info 2016/07/25 12:49:26.867 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootA/A with prId=108 closed. > [vm_0][info 2016/07/25 12:49:26.869 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootG/G with prId=114 closing. > [vm_2][warn 2016/07/25 12:49:26.870 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootG/G > [vm_3][warn 2016/07/25 12:49:26.870 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootG/G > [vm_1][warn 2016/07/25 12:49:26.870 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootG/G > [vm_0][warn 2016/07/25 12:49:26.870 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootG/G > [vm_0][info 2016/07/25 12:49:26.874 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootG/G with prId=114 closed. > [vm_0][info 2016/07/25 12:49:26.877 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootJ/J with prId=117 closing. > [vm_2][warn 2016/07/25 12:49:26.878 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootJ/J > [vm_1][warn 2016/07/25 12:49:26.878 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootJ/J > [vm_3][warn 2016/07/25 12:49:26.878 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootJ/J > [vm_0][warn 2016/07/25 12:49:26.879 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootJ/J > [vm_0][info 2016/07/25 12:49:26.881 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootJ/J with prId=117 closed. > [vm_0][info 2016/07/25 12:49:26.882 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootB/B with prId=109 closing. > [vm_2][warn 2016/07/25 12:49:26.883 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootB/B > [vm_1][warn 2016/07/25 12:49:26.884 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootB/B > [vm_3][warn 2016/07/25 12:49:26.884 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootB/B > [vm_0][warn 2016/07/25 12:49:26.884 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootB/B > [vm_0][info 2016/07/25 12:49:26.886 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootB/B with prId=109 closed. > [vm_0][info 2016/07/25 12:49:26.888 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootH/H with prId=115 closing. > [vm_2][warn 2016/07/25 12:49:26.888 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootH/H > [vm_3][warn 2016/07/25 12:49:26.888 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootH/H > [vm_1][warn 2016/07/25 12:49:26.888 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootH/H > [vm_0][warn 2016/07/25 12:49:26.889 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootH/H > [vm_0][info 2016/07/25 12:49:26.891 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootH/H with prId=115 closed. > [vm_0][info 2016/07/25 12:49:26.892 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootD/D with prId=111 closing. > [vm_1][warn 2016/07/25 12:49:26.893 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootD/D > [vm_2][warn 2016/07/25 12:49:26.893 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootD/D > [vm_3][warn 2016/07/25 12:49:26.893 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootD/D > [vm_0][warn 2016/07/25 12:49:26.894 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootD/D > [vm_0][info 2016/07/25 12:49:26.896 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootD/D with prId=111 closed. > [vm_0][info 2016/07/25 12:49:26.897 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootO/O with prId=122 closing. > [vm_1][warn 2016/07/25 12:49:26.898 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootO/O > [vm_2][warn 2016/07/25 12:49:26.898 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootO/O > [vm_3][warn 2016/07/25 12:49:26.898 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootO/O > [vm_0][warn 2016/07/25 12:49:26.898 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootO/O > [vm_0][info 2016/07/25 12:49:26.900 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootO/O with prId=122 closed. > [vm_0][info 2016/07/25 12:49:26.902 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootE/E with prId=112 closing. > [vm_2][warn 2016/07/25 12:49:26.903 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootE/E > [vm_1][warn 2016/07/25 12:49:26.903 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootE/E > [vm_3][warn 2016/07/25 12:49:26.903 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootE/E > [vm_0][warn 2016/07/25 12:49:26.904 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootE/E > [vm_0][info 2016/07/25 12:49:26.906 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootE/E with prId=112 closed. > [vm_0][info 2016/07/25 12:49:26.907 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootM/M with prId=120 closing. > [vm_2][warn 2016/07/25 12:49:26.909 PDT <PartitionedRegion Message > Processor1> tid=0x1367] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootM/M > [vm_1][warn 2016/07/25 12:49:26.909 PDT <PartitionedRegion Message > Processor1> tid=0x125e] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootM/M > [vm_3][warn 2016/07/25 12:49:26.909 PDT <PartitionedRegion Message > Processor1> tid=0xb93] Redundancy has dropped below 1 configured copies to 0 > actual copies for /rootM/M > [vm_0][warn 2016/07/25 12:49:26.909 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Redundancy has dropped below 1 configured copies to 0 actual > copies for /rootM/M > [vm_0][info 2016/07/25 12:49:26.911 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Partitioned Region /rootM/M with prId=120 closed. > [vm_0][info 2016/07/25 12:49:26.913 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] GemFireCache[id = 478477746; isClosing = true; isShutDownAll = > false; created = Mon Jul 25 12:49:24 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_0][info 2016/07/25 12:49:26.918 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/601811905.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/601811905@168dbc72 > (took 94 ms) > [vm_1][info 2016/07/25 12:49:26.919 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/2146990354.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/2146990354@8e19481 > [vm_1][info 2016/07/25 12:49:26.922 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootJ/J with prId=117 closing. > [vm_1][info 2016/07/25 12:49:26.926 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootJ/J with prId=117 closed. > [vm_1][info 2016/07/25 12:49:26.928 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootD/D with prId=111 closing. > [vm_1][info 2016/07/25 12:49:26.932 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootD/D with prId=111 closed. > [vm_1][info 2016/07/25 12:49:26.934 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootL/L with prId=119 closing. > [vm_1][info 2016/07/25 12:49:26.938 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootL/L with prId=119 closed. > [vm_1][info 2016/07/25 12:49:26.941 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootI/I with prId=116 closing. > [vm_1][info 2016/07/25 12:49:26.945 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootI/I with prId=116 closed. > [vm_1][info 2016/07/25 12:49:26.947 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootK/K with prId=118 closing. > [vm_1][info 2016/07/25 12:49:26.951 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootK/K with prId=118 closed. > [vm_1][info 2016/07/25 12:49:26.953 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootH/H with prId=115 closing. > [vm_1][info 2016/07/25 12:49:26.957 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootH/H with prId=115 closed. > [vm_1][info 2016/07/25 12:49:26.958 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootE/E with prId=112 closing. > [vm_1][info 2016/07/25 12:49:26.962 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootE/E with prId=112 closed. > [vm_1][info 2016/07/25 12:49:26.964 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootO/O with prId=122 closing. > [vm_1][info 2016/07/25 12:49:26.967 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootO/O with prId=122 closed. > [vm_1][info 2016/07/25 12:49:26.968 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootG/G with prId=114 closing. > [vm_1][info 2016/07/25 12:49:26.972 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootG/G with prId=114 closed. > [vm_1][info 2016/07/25 12:49:26.972 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootM/M with prId=120 closing. > [vm_1][info 2016/07/25 12:49:26.975 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootM/M with prId=120 closed. > [vm_1][info 2016/07/25 12:49:26.976 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootB/B with prId=109 closing. > [vm_1][info 2016/07/25 12:49:26.979 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootB/B with prId=109 closed. > [vm_1][info 2016/07/25 12:49:26.980 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootF/F with prId=113 closing. > [vm_1][info 2016/07/25 12:49:26.983 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootF/F with prId=113 closed. > [vm_1][info 2016/07/25 12:49:26.984 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootC/C with prId=110 closing. > [vm_1][info 2016/07/25 12:49:26.987 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootC/C with prId=110 closed. > [vm_1][info 2016/07/25 12:49:26.988 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootA/A with prId=108 closing. > [vm_1][info 2016/07/25 12:49:26.992 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootA/A with prId=108 closed. > [vm_1][info 2016/07/25 12:49:26.992 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootN/N with prId=121 closing. > [vm_1][info 2016/07/25 12:49:26.995 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Partitioned Region /rootN/N with prId=121 closed. > [vm_1][info 2016/07/25 12:49:26.997 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] GemFireCache[id = 1176676677; isClosing = true; isShutDownAll = > false; created = Mon Jul 25 12:49:24 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_1][info 2016/07/25 12:49:27.000 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/2146990354.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/2146990354@8e19481 > (took 81 ms) > [vm_2][info 2016/07/25 12:49:27.001 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1875724691.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1875724691@4d2c32e0 > [vm_2][info 2016/07/25 12:49:27.003 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootA/A with prId=108 closing. > [vm_2][info 2016/07/25 12:49:27.008 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootA/A with prId=108 closed. > [vm_2][info 2016/07/25 12:49:27.009 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootC/C with prId=110 closing. > [vm_2][info 2016/07/25 12:49:27.014 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootC/C with prId=110 closed. > [vm_2][info 2016/07/25 12:49:27.015 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootG/G with prId=114 closing. > [vm_2][info 2016/07/25 12:49:27.019 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootG/G with prId=114 closed. > [vm_2][info 2016/07/25 12:49:27.020 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootE/E with prId=112 closing. > [vm_2][info 2016/07/25 12:49:27.023 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootE/E with prId=112 closed. > [vm_2][info 2016/07/25 12:49:27.025 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootL/L with prId=119 closing. > [vm_2][info 2016/07/25 12:49:27.029 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootL/L with prId=119 closed. > [vm_2][info 2016/07/25 12:49:27.030 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootN/N with prId=121 closing. > [vm_2][info 2016/07/25 12:49:27.032 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootN/N with prId=121 closed. > [vm_2][info 2016/07/25 12:49:27.033 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootB/B with prId=109 closing. > [vm_2][info 2016/07/25 12:49:27.035 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootB/B with prId=109 closed. > [vm_2][info 2016/07/25 12:49:27.037 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootH/H with prId=115 closing. > [vm_2][info 2016/07/25 12:49:27.040 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootH/H with prId=115 closed. > [vm_2][info 2016/07/25 12:49:27.041 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootI/I with prId=116 closing. > [vm_2][info 2016/07/25 12:49:27.043 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootI/I with prId=116 closed. > [vm_2][info 2016/07/25 12:49:27.044 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootO/O with prId=122 closing. > [vm_2][info 2016/07/25 12:49:27.046 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootO/O with prId=122 closed. > [vm_2][info 2016/07/25 12:49:27.047 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootJ/J with prId=117 closing. > [vm_2][info 2016/07/25 12:49:27.049 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootJ/J with prId=117 closed. > [vm_2][info 2016/07/25 12:49:27.050 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootD/D with prId=111 closing. > [vm_2][info 2016/07/25 12:49:27.053 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootD/D with prId=111 closed. > [vm_2][info 2016/07/25 12:49:27.054 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootM/M with prId=120 closing. > [vm_2][info 2016/07/25 12:49:27.056 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootM/M with prId=120 closed. > [vm_2][info 2016/07/25 12:49:27.057 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootK/K with prId=118 closing. > [vm_2][info 2016/07/25 12:49:27.060 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootK/K with prId=118 closed. > [vm_2][info 2016/07/25 12:49:27.060 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootF/F with prId=113 closing. > [vm_2][info 2016/07/25 12:49:27.063 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Partitioned Region /rootF/F with prId=113 closed. > [vm_2][info 2016/07/25 12:49:27.064 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] GemFireCache[id = 2134521106; isClosing = true; isShutDownAll = > false; created = Mon Jul 25 12:49:25 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_2][info 2016/07/25 12:49:27.067 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1875724691.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1875724691@4d2c32e0 > (took 66 ms) > [vm_3][info 2016/07/25 12:49:27.068 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1737651794.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1737651794@2afef1a8 > [vm_3][info 2016/07/25 12:49:27.071 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootI/I with prId=116 closing. > [vm_3][info 2016/07/25 12:49:27.071 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootI/I with prId=116 closed. > [vm_3][info 2016/07/25 12:49:27.072 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootG/G with prId=114 closing. > [vm_3][info 2016/07/25 12:49:27.073 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootG/G with prId=114 closed. > [vm_3][info 2016/07/25 12:49:27.073 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootK/K with prId=118 closing. > [vm_3][info 2016/07/25 12:49:27.074 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootK/K with prId=118 closed. > [vm_3][info 2016/07/25 12:49:27.075 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootH/H with prId=115 closing. > [vm_3][info 2016/07/25 12:49:27.075 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootH/H with prId=115 closed. > [vm_3][info 2016/07/25 12:49:27.076 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootD/D with prId=111 closing. > [vm_3][info 2016/07/25 12:49:27.076 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootD/D with prId=111 closed. > [vm_3][info 2016/07/25 12:49:27.078 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootE/E with prId=112 closing. > [vm_3][info 2016/07/25 12:49:27.078 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootE/E with prId=112 closed. > [vm_3][info 2016/07/25 12:49:27.079 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootM/M with prId=120 closing. > [vm_3][info 2016/07/25 12:49:27.079 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootM/M with prId=120 closed. > [vm_3][info 2016/07/25 12:49:27.079 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootN/N with prId=121 closing. > [vm_3][info 2016/07/25 12:49:27.080 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootN/N with prId=121 closed. > [vm_3][info 2016/07/25 12:49:27.080 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootA/A with prId=108 closing. > [vm_3][info 2016/07/25 12:49:27.081 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootA/A with prId=108 closed. > [vm_3][info 2016/07/25 12:49:27.081 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootJ/J with prId=117 closing. > [vm_3][info 2016/07/25 12:49:27.082 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootJ/J with prId=117 closed. > [vm_3][info 2016/07/25 12:49:27.082 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootB/B with prId=109 closing. > [vm_3][info 2016/07/25 12:49:27.083 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootB/B with prId=109 closed. > [vm_3][info 2016/07/25 12:49:27.083 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootO/O with prId=122 closing. > [vm_3][info 2016/07/25 12:49:27.083 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootO/O with prId=122 closed. > [vm_3][info 2016/07/25 12:49:27.084 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootC/C with prId=110 closing. > [vm_3][info 2016/07/25 12:49:27.084 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootC/C with prId=110 closed. > [vm_3][info 2016/07/25 12:49:27.085 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootF/F with prId=113 closing. > [vm_3][info 2016/07/25 12:49:27.085 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootF/F with prId=113 closed. > [vm_3][info 2016/07/25 12:49:27.086 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootL/L with prId=119 closing. > [vm_3][info 2016/07/25 12:49:27.086 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Partitioned Region /rootL/L with prId=119 closed. > [vm_3][info 2016/07/25 12:49:27.087 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] GemFireCache[id = 2026606935; isClosing = true; isShutDownAll = > false; created = Mon Jul 25 12:49:25 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_3][info 2016/07/25 12:49:27.090 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1737651794.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1737651794@2afef1a8 > (took 21 ms) > [vm_0][info 2016/07/25 12:49:27.098 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Received method: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35.run with > 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35@5babcee8 > [vm_0][info 2016/07/25 12:49:27.098 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Got result: null > [vm_0] from > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35.run with > 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35@5babcee8 > (took 0 ms) > [vm_1][info 2016/07/25 12:49:27.108 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Received method: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35.run with > 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35@19fd140 > [vm_1][info 2016/07/25 12:49:27.108 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Got result: null > [vm_1] from > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35.run with > 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35@19fd140 > (took 0 ms) > [vm_2][info 2016/07/25 12:49:27.109 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Received method: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35.run with > 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35@2c7d9099 > [vm_2][info 2016/07/25 12:49:27.109 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Got result: null > [vm_2] from > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35.run with > 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35@2c7d9099 > (took 0 ms) > [vm_3][info 2016/07/25 12:49:27.110 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Received method: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35.run with > 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35@6c1af0f9 > [vm_3][info 2016/07/25 12:49:27.110 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Got result: null > [vm_3] from > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35.run with > 0 args on object: > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$35@6c1af0f9 > (took 0 ms) > [vm_0][info 2016/07/25 12:49:27.111 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(tearDownCreationStackGenerator) > [vm_0][info 2016/07/25 12:49:27.111 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Got result: null > [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(tearDownCreationStackGenerator) (took 0 ms) > [vm_1][info 2016/07/25 12:49:27.112 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(tearDownCreationStackGenerator) > [vm_1][info 2016/07/25 12:49:27.112 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Got result: null > [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(tearDownCreationStackGenerator) (took 0 ms) > [vm_2][info 2016/07/25 12:49:27.112 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(tearDownCreationStackGenerator) > [vm_2][info 2016/07/25 12:49:27.112 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(tearDownCreationStackGenerator) (took 0 ms) > [vm_3][info 2016/07/25 12:49:27.113 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(tearDownCreationStackGenerator) > [vm_3][info 2016/07/25 12:49:27.113 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Got result: null > [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(tearDownCreationStackGenerator) (took 0 ms) > [vm_0][info 2016/07/25 12:49:27.113 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(tearDownVM) > [vm_0][info 2016/07/25 12:49:27.114 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Shutting down DistributionManager kuwait(10504)<ec><v288>:1025. > [vm_3][info 2016/07/25 12:49:27.115 PDT <Pooled High Priority Message > Processor 3> tid=0xb88] received leave request from > kuwait(10504)<ec><v288>:1025 for kuwait(10504)<ec><v288>:1025 > [vm_1][info 2016/07/25 12:49:27.115 PDT <Pooled High Priority Message > Processor 3> tid=0x1260] received leave request from > kuwait(10504)<ec><v288>:1025 for kuwait(10504)<ec><v288>:1025 > [vm_3][info 2016/07/25 12:49:27.115 PDT <Pooled High Priority Message > Processor 3> tid=0xb88] Member at kuwait(10504)<ec><v288>:1025 gracefully > left the distributed cache: shutdown message received > [vm_2][info 2016/07/25 12:49:27.115 PDT <Pooled High Priority Message > Processor 2> tid=0x135a] received leave request from > kuwait(10504)<ec><v288>:1025 for kuwait(10504)<ec><v288>:1025 > [vm_1][info 2016/07/25 12:49:27.115 PDT <Pooled High Priority Message > Processor 3> tid=0x1260] Member at kuwait(10504)<ec><v288>:1025 gracefully > left the distributed cache: shutdown message received > [locator][info 2016/07/25 12:49:27.115 PDT <Pooled High Priority Message > Processor 2> tid=0x5ac] received leave request from > kuwait(10504)<ec><v288>:1025 for kuwait(10504)<ec><v288>:1025 > [vm_2][info 2016/07/25 12:49:27.115 PDT <Pooled High Priority Message > Processor 2> tid=0x135a] Member at kuwait(10504)<ec><v288>:1025 gracefully > left the distributed cache: shutdown message received > [locator][info 2016/07/25 12:49:27.115 PDT <Pooled High Priority Message > Processor 2> tid=0x5ac] Member at kuwait(10504)<ec><v288>:1025 gracefully > left the distributed cache: shutdown message received > [vm_0][info 2016/07/25 12:49:27.215 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Now closing distribution for kuwait(10504)<ec><v288>:1025 > [vm_0][info 2016/07/25 12:49:27.216 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Stopping membership services > [vm_0][info 2016/07/25 12:49:27.216 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] GMSHealthMonitor server socket is closed in stopServices(). > [locator][info 2016/07/25 12:49:27.216 PDT <unicast receiver,kuwait-22220> > tid=0x2a] received leave request from kuwait(10504)<ec><v288>:1025 for > kuwait(10504)<ec><v288>:1025 > [vm_3][info 2016/07/25 12:49:27.216 PDT <unicast receiver,kuwait-61394> > tid=0xb68] received leave request from kuwait(10504)<ec><v288>:1025 for > kuwait(10504)<ec><v288>:1025 > [vm_1][info 2016/07/25 12:49:27.216 PDT <unicast receiver,kuwait-4891> > tid=0x1236] received leave request from kuwait(10504)<ec><v288>:1025 for > kuwait(10504)<ec><v288>:1025 > [vm_0][info 2016/07/25 12:49:27.216 PDT <Geode Failure Detection Server > thread 0> tid=0x114d] GMSHealthMonitor server thread exiting > [vm_2][info 2016/07/25 12:49:27.216 PDT <unicast receiver,kuwait-42915> > tid=0x133f] received leave request from kuwait(10504)<ec><v288>:1025 for > kuwait(10504)<ec><v288>:1025 > [vm_0][info 2016/07/25 12:49:27.216 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] GMSHealthMonitor serverSocketExecutor is terminated > [vm_0][info 2016/07/25 12:49:27.221 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] DistributionManager stopped in 107ms. > [vm_0][info 2016/07/25 12:49:27.221 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Marking DistributionManager kuwait(10504)<ec><v288>:1025 as closed. > [vm_0][info 2016/07/25 12:49:27.222 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xc96] Got result: null > [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(tearDownVM) (took 108 ms) > [vm_1][info 2016/07/25 12:49:27.222 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(tearDownVM) > [vm_1][info 2016/07/25 12:49:27.223 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Shutting down DistributionManager kuwait(10508)<ec><v289>:1026. > [vm_2][info 2016/07/25 12:49:27.224 PDT <Pooled High Priority Message > Processor 2> tid=0x135a] received leave request from > kuwait(10508)<ec><v289>:1026 for kuwait(10508)<ec><v289>:1026 > [vm_2][info 2016/07/25 12:49:27.224 PDT <Pooled High Priority Message > Processor 2> tid=0x135a] Member at kuwait(10508)<ec><v289>:1026 gracefully > left the distributed cache: shutdown message received > [vm_3][info 2016/07/25 12:49:27.224 PDT <Pooled High Priority Message > Processor 3> tid=0xb88] received leave request from > kuwait(10508)<ec><v289>:1026 for kuwait(10508)<ec><v289>:1026 > [locator][info 2016/07/25 12:49:27.224 PDT <Pooled High Priority Message > Processor 2> tid=0x5ac] received leave request from > kuwait(10508)<ec><v289>:1026 for kuwait(10508)<ec><v289>:1026 > [vm_3][info 2016/07/25 12:49:27.224 PDT <Pooled High Priority Message > Processor 3> tid=0xb88] Member at kuwait(10508)<ec><v289>:1026 gracefully > left the distributed cache: shutdown message received > [locator][info 2016/07/25 12:49:27.224 PDT <Pooled High Priority Message > Processor 2> tid=0x5ac] Member at kuwait(10508)<ec><v289>:1026 gracefully > left the distributed cache: shutdown message received > [vm_1][info 2016/07/25 12:49:27.325 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Now closing distribution for kuwait(10508)<ec><v289>:1026 > [vm_1][info 2016/07/25 12:49:27.325 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Stopping membership services > [vm_1][info 2016/07/25 12:49:27.325 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] GMSHealthMonitor server socket is closed in stopServices(). > [vm_3][info 2016/07/25 12:49:27.326 PDT <unicast receiver,kuwait-61394> > tid=0xb68] received leave request from kuwait(10508)<ec><v289>:1026 for > kuwait(10508)<ec><v289>:1026 > [locator][info 2016/07/25 12:49:27.326 PDT <unicast receiver,kuwait-22220> > tid=0x2a] received leave request from kuwait(10508)<ec><v289>:1026 for > kuwait(10508)<ec><v289>:1026 > [vm_1][info 2016/07/25 12:49:27.326 PDT <Geode Failure Detection Server > thread 0> tid=0x123a] GMSHealthMonitor server thread exiting > [vm_1][info 2016/07/25 12:49:27.326 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] GMSHealthMonitor serverSocketExecutor is terminated > [vm_2][info 2016/07/25 12:49:27.326 PDT <unicast receiver,kuwait-42915> > tid=0x133f] received leave request from kuwait(10508)<ec><v289>:1026 for > kuwait(10508)<ec><v289>:1026 > [vm_1][info 2016/07/25 12:49:27.331 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] DistributionManager stopped in 108ms. > [vm_1][info 2016/07/25 12:49:27.331 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Marking DistributionManager kuwait(10508)<ec><v289>:1026 as closed. > [vm_1][info 2016/07/25 12:49:27.332 PDT <RMI TCP Connection(24)-10.118.32.93> > tid=0xe67] Got result: null > [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(tearDownVM) (took 109 ms) > [vm_2][info 2016/07/25 12:49:27.332 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(tearDownVM) > [vm_2][info 2016/07/25 12:49:27.333 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Shutting down DistributionManager kuwait(10513)<ec><v290>:1027. > [vm_3][info 2016/07/25 12:49:27.334 PDT <Pooled High Priority Message > Processor 3> tid=0xb88] received leave request from > kuwait(10513)<ec><v290>:1027 for kuwait(10513)<ec><v290>:1027 > [vm_3][info 2016/07/25 12:49:27.334 PDT <Pooled High Priority Message > Processor 3> tid=0xb88] Member at kuwait(10513)<ec><v290>:1027 gracefully > left the distributed cache: shutdown message received > [locator][info 2016/07/25 12:49:27.334 PDT <Pooled High Priority Message > Processor 2> tid=0x5ac] received leave request from > kuwait(10513)<ec><v290>:1027 for kuwait(10513)<ec><v290>:1027 > [locator][info 2016/07/25 12:49:27.334 PDT <Pooled High Priority Message > Processor 2> tid=0x5ac] Member at kuwait(10513)<ec><v290>:1027 gracefully > left the distributed cache: shutdown message received > [vm_2][info 2016/07/25 12:49:27.434 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Now closing distribution for kuwait(10513)<ec><v290>:1027 > [vm_2][info 2016/07/25 12:49:27.434 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Stopping membership services > [locator][info 2016/07/25 12:49:27.434 PDT <Geode Membership View Creator> > tid=0x30] View Creator is processing 5 requests for the next membership view > [locator][info 2016/07/25 12:49:27.434 PDT <Geode Membership View Creator> > tid=0x30] preparing new view View[kuwait(10426:locator)<ec><v0>:1024|292] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10518)<ec><v291>:1028{lead}] shutdown: [kuwait(10513)<ec><v290>:1027, > kuwait(10504)<ec><v288>:1025, kuwait(10508)<ec><v289>:1026] > [locator]failure detection ports: 26403 51023 > [vm_2][info 2016/07/25 12:49:27.435 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] GMSHealthMonitor server socket is closed in stopServices(). > [vm_2][info 2016/07/25 12:49:27.435 PDT <Geode Failure Detection Server > thread 0> tid=0x1343] GMSHealthMonitor server thread exiting > [locator][info 2016/07/25 12:49:27.435 PDT <unicast receiver,kuwait-22220> > tid=0x2a] received leave request from kuwait(10513)<ec><v290>:1027 for > kuwait(10513)<ec><v290>:1027 > [locator][info 2016/07/25 12:49:27.435 PDT <Geode Membership View Creator> > tid=0x30] finished waiting for responses to view preparation > [vm_3][info 2016/07/25 12:49:27.435 PDT <unicast receiver,kuwait-61394> > tid=0xb68] received leave request from kuwait(10513)<ec><v290>:1027 for > kuwait(10513)<ec><v290>:1027 > [locator][info 2016/07/25 12:49:27.435 PDT <Geode Membership View Creator> > tid=0x30] received new view: View[kuwait(10426:locator)<ec><v0>:1024|292] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10518)<ec><v291>:1028{lead}] shutdown: [kuwait(10513)<ec><v290>:1027, > kuwait(10504)<ec><v288>:1025, kuwait(10508)<ec><v289>:1026] > [locator]old view is: View[kuwait(10426:locator)<ec><v0>:1024|291] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v288>:1025{lead}, > kuwait(10508)<ec><v289>:1026, kuwait(10513)<ec><v290>:1027, > kuwait(10518)<ec><v291>:1028] > [vm_2][info 2016/07/25 12:49:27.435 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] GMSHealthMonitor serverSocketExecutor is terminated > [locator][info 2016/07/25 12:49:27.435 PDT <Geode Membership View Creator> > tid=0x30] Peer locator received new membership view: > View[kuwait(10426:locator)<ec><v0>:1024|292] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10518)<ec><v291>:1028{lead}] > shutdown: [kuwait(10513)<ec><v290>:1027, kuwait(10504)<ec><v288>:1025, > kuwait(10508)<ec><v289>:1026] > [locator][info 2016/07/25 12:49:27.436 PDT <Geode Membership View Creator> > tid=0x30] sending new view View[kuwait(10426:locator)<ec><v0>:1024|292] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10518)<ec><v291>:1028{lead}] shutdown: [kuwait(10513)<ec><v290>:1027, > kuwait(10504)<ec><v288>:1025, kuwait(10508)<ec><v289>:1026] > [locator]failure detection ports: 26403 51023 > [vm_3][info 2016/07/25 12:49:27.436 PDT <unicast receiver,kuwait-61394> > tid=0xb68] received new view: View[kuwait(10426:locator)<ec><v0>:1024|292] > members: [kuwait(10426:locator)<ec><v0>:1024, > kuwait(10518)<ec><v291>:1028{lead}] shutdown: [kuwait(10504)<ec><v288>:1025, > kuwait(10508)<ec><v289>:1026, kuwait(10513)<ec><v290>:1027] > [vm_3]old view is: View[kuwait(10426:locator)<ec><v0>:1024|291] members: > [kuwait(10426:locator)<ec><v0>:1024, kuwait(10504)<ec><v288>:1025{lead}, > kuwait(10508)<ec><v289>:1026, kuwait(10513)<ec><v290>:1027, > kuwait(10518)<ec><v291>:1028] > [vm_2][info 2016/07/25 12:49:27.439 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] DistributionManager stopped in 106ms. > [vm_2][info 2016/07/25 12:49:27.439 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Marking DistributionManager kuwait(10513)<ec><v290>:1027 as closed. > [vm_2][info 2016/07/25 12:49:27.439 PDT <RMI TCP Connection(25)-10.118.32.93> > tid=0xf56] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(tearDownVM) (took 106 ms) > [vm_3][info 2016/07/25 12:49:27.440 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(tearDownVM) > [vm_3][info 2016/07/25 12:49:27.441 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Shutting down DistributionManager kuwait(10518)<ec><v291>:1028. > [locator][info 2016/07/25 12:49:27.441 PDT <Pooled High Priority Message > Processor 2> tid=0x5ac] received leave request from > kuwait(10518)<ec><v291>:1028 for kuwait(10518)<ec><v291>:1028 > [locator][info 2016/07/25 12:49:27.441 PDT <Pooled High Priority Message > Processor 2> tid=0x5ac] Member at kuwait(10518)<ec><v291>:1028 gracefully > left the distributed cache: shutdown message received > [vm_3][info 2016/07/25 12:49:27.542 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Now closing distribution for kuwait(10518)<ec><v291>:1028 > [vm_3][info 2016/07/25 12:49:27.542 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Stopping membership services > [vm_3][info 2016/07/25 12:49:27.542 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] GMSHealthMonitor server socket is closed in stopServices(). > [locator][info 2016/07/25 12:49:27.542 PDT <unicast receiver,kuwait-22220> > tid=0x2a] received leave request from kuwait(10518)<ec><v291>:1028 for > kuwait(10518)<ec><v291>:1028 > [vm_3][info 2016/07/25 12:49:27.542 PDT <Geode Failure Detection Server > thread 0> tid=0xb6c] GMSHealthMonitor server thread exiting > [vm_3][info 2016/07/25 12:49:27.542 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] GMSHealthMonitor serverSocketExecutor is terminated > [vm_3][info 2016/07/25 12:49:27.549 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] DistributionManager stopped in 108ms. > [vm_3][info 2016/07/25 12:49:27.549 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Marking DistributionManager kuwait(10518)<ec><v291>:1028 as closed. > [vm_3][info 2016/07/25 12:49:27.550 PDT <RMI TCP Connection(26)-10.118.32.93> > tid=0x75a] Got result: null > [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(tearDownVM) (took 109 ms) > [locator][info 2016/07/25 12:49:27.550 PDT <RMI TCP > Connection(7)-10.118.32.93> tid=0x4bc] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/214457188.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/214457188@ab55e59 > [locator][info 2016/07/25 12:49:27.551 PDT <RMI TCP > Connection(7)-10.118.32.93> tid=0x4bc] Got result: null > [locator] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/214457188.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/214457188@ab55e59 > (took 0 ms) > Standard Error > [vm_0]java.lang.IllegalStateException: Colocated regions should have > accessors at the same node > [vm_0] at > com.gemstone.gemfire.internal.cache.PartitionRegionConfigValidator.validateColocation(PartitionRegionConfigValidator.java:334) > [vm_0] at > com.gemstone.gemfire.internal.cache.PartitionedRegion.initPRInternals(PartitionedRegion.java:810) > [vm_0] at > com.gemstone.gemfire.internal.cache.PartitionedRegion.initialize(PartitionedRegion.java:1007) > [vm_0] at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.createVMRegion(GemFireCacheImpl.java:3123) > [vm_0] at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.basicCreateRegion(GemFireCacheImpl.java:3017) > [vm_0] at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.createRegion(GemFireCacheImpl.java:3006) > [vm_0] at > com.gemstone.gemfire.internal.cache.execute.PRColocationDUnitTest$2.run2(PRColocationDUnitTest.java:725) > [vm_0] at > com.gemstone.gemfire.cache30.CacheSerializableRunnable.run(CacheSerializableRunnable.java:60) > [vm_0] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) > [vm_0] at > sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) > [vm_0] at > sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) > [vm_0] at java.lang.reflect.Method.invoke(Method.java:497) > [vm_0] at hydra.MethExecutor.executeObject(MethExecutor.java:268) > [vm_0] at > com.gemstone.gemfire.test.dunit.standalone.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:82) > [vm_0] at sun.reflect.GeneratedMethodAccessor7.invoke(Unknown Source) > [vm_0] at > sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) > [vm_0] at java.lang.reflect.Method.invoke(Method.java:497) > [vm_0] at > sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:323) > [vm_0] at sun.rmi.transport.Transport$1.run(Transport.java:200) > [vm_0] at sun.rmi.transport.Transport$1.run(Transport.java:197) > [vm_0] at java.security.AccessController.doPrivileged(Native Method) > [vm_0] at sun.rmi.transport.Transport.serviceCall(Transport.java:196) > [vm_0] at > sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:568) > [vm_0] at > sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:826) > [vm_0] at > sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$95(TCPTransport.java:683) > [vm_0] at java.security.AccessController.doPrivileged(Native Method) > [vm_0] at > sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:682) > [vm_0] at > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) > [vm_0] at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) > [vm_0] at java.lang.Thread.run(Thread.java:745) > Suspicious strings were written to the log during this run. > Fix the strings or use IgnoredException.addIgnoredException to ignore. > ----------------------------------------------------------------------- > Found suspect string in log4j at line 1289 > [fatal 2016/07/25 12:48:55.930 PDT <unicast receiver,kuwait-35881> tid=0x14d] > Membership service failure: Member isn't responding to heartbeat requests > com.gemstone.gemfire.ForcedDisconnectException: Member isn't responding to > heartbeat requests > at > com.gemstone.gemfire.distributed.internal.membership.gms.mgr.GMSMembershipManager.forceDisconnect(GMSMembershipManager.java:2606) > at > com.gemstone.gemfire.distributed.internal.membership.gms.membership.GMSJoinLeave.forceDisconnect(GMSJoinLeave.java:918) > at > com.gemstone.gemfire.distributed.internal.membership.gms.membership.GMSJoinLeave.processRemoveRequest(GMSJoinLeave.java:593) > at > com.gemstone.gemfire.distributed.internal.membership.gms.membership.GMSJoinLeave.processMessage(GMSJoinLeave.java:1555) > at > com.gemstone.gemfire.distributed.internal.membership.gms.messenger.JGroupsMessenger$JGroupsReceiver.receive(JGroupsMessenger.java:1065) > at org.jgroups.JChannel.invokeCallback(JChannel.java:816) > at org.jgroups.JChannel.up(JChannel.java:741) > at org.jgroups.stack.ProtocolStack.up(ProtocolStack.java:1030) > at org.jgroups.protocols.FRAG2.up(FRAG2.java:165) > at org.jgroups.protocols.FlowControl.up(FlowControl.java:390) > at org.jgroups.protocols.UNICAST3.deliverMessage(UNICAST3.java:1070) > at org.jgroups.protocols.UNICAST3.handleDataReceived(UNICAST3.java:785) > at org.jgroups.protocols.UNICAST3.up(UNICAST3.java:426) > at > com.gemstone.gemfire.distributed.internal.membership.gms.messenger.StatRecorder.up(StatRecorder.java:75) > at > com.gemstone.gemfire.distributed.internal.membership.gms.messenger.AddressManager.up(AddressManager.java:75) > at org.jgroups.protocols.TP.passMessageUp(TP.java:1601) > at org.jgroups.protocols.TP$SingleMessageHandler.run(TP.java:1817) > at org.jgroups.util.DirectExecutor.execute(DirectExecutor.java:10) > at org.jgroups.protocols.TP.handleSingleMessage(TP.java:1729) > at org.jgroups.protocols.TP.receive(TP.java:1654) > at > com.gemstone.gemfire.distributed.internal.membership.gms.messenger.Transport.receive(Transport.java:162) > at org.jgroups.protocols.UDP$PacketReceiver.run(UDP.java:701) > at java.lang.Thread.run(Thread.java:745) > ----------------------------------------------------------------------- > Found suspect string in log4j at line 1325 > [error 2016/07/25 12:48:57.938 PDT <Test worker> tid=0x13] > com.gemstone.gemfire.distributed.DistributedSystemDisconnectedException: This > connection to a distributed system has been disconnected., caused by > com.gemstone.gemfire.ForcedDisconnectException: Member isn't responding to > heartbeat requests > {noformat} -- This message was sent by Atlassian JIRA (v6.4.14#64029)