[ https://issues.apache.org/jira/browse/GEODE-1580?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Bruce Schuchardt reassigned GEODE-1580: --------------------------------------- Assignee: Bruce Schuchardt > ci failure: GemFireDeadlockDetectorDUnitTest.testDistributedDeadlockWithDLock > ----------------------------------------------------------------------------- > > Key: GEODE-1580 > URL: https://issues.apache.org/jira/browse/GEODE-1580 > Project: Geode > Issue Type: Bug > Components: tests > Reporter: Hitesh Khamesra > Assignee: Bruce Schuchardt > Labels: CI, Flaky > > https://brazil.gemstone.com:8080/job/Geode_develop_DistributedTests/2969/testReport/com.gemstone.gemfire.distributed.internal.deadlock/GemFireDeadlockDetectorDUnitTest/testDistributedDeadlockWithDLock/ > Skip to content > titletitle log in > search > > ENABLE AUTO REFRESH > Jenkins > Geode_develop_DistributedTests > #2969 > Test Results > com.gemstone.gemfire.distributed.internal.deadlock > GemFireDeadlockDetectorDUnitTest > testDistributedDeadlockWithDLock > Back to Project > Status > Changes > Console Output > View Build Information > History > Parameters > Metadata > Environment Variables > Git Build Data > Test Result > Changes since last success > Compare environment > JS Widgets > Previous Build > Next Build > Regression > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest.testDistributedDeadlockWithDLock > Failing for the past 1 build (Since Failed#2969 ) > Took 1 min 4 sec. > Failed 2 times in the last 22 runs. Stability: 90 % > Error Message > java.lang.AssertionError > Stacktrace > java.lang.AssertionError > at org.junit.Assert.fail(Assert.java:86) > at org.junit.Assert.assertTrue(Assert.java:41) > at org.junit.Assert.assertTrue(Assert.java:52) > at > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest.testDistributedDeadlockWithDLock(GemFireDeadlockDetectorDUnitTest.java:177) > 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) > Standard Output > Previously run tests: [ProductUseLogDUnitTest, > GemFireDeadlockDetectorDUnitTest] > [vm_0][info 2016/06/19 15:27:25.529 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_0][info 2016/06/19 15:27:25.529 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] 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/06/19 15:27:25.532 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_1][info 2016/06/19 15:27:25.532 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] 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/06/19 15:27:25.544 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_2][info 2016/06/19 15:27:25.545 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] 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/06/19 15:27:25.549 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_3][info 2016/06/19 15:27:25.550 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] 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 > GemFireDeadlockDetectorDUnitTest.testDistributedDeadlockWithDLock > distributed system properties: {locators=localhost[21653], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [info 2016/06/19 15:27:25.581 PDT <Test worker> tid=0xa] Startup > Configuration: > ### GemFire Properties defined with api ### > disable-auto-reconnect=true > enable-cluster-configuration=false > locators=localhost[21653] > log-level=info > mcast-port=0 > use-cluster-configuration=false > ### GemFire Properties using default values ### > ack-severe-alert-threshold=0 > ack-wait-threshold=15 > archive-disk-space-limit=0 > archive-file-size-limit=0 > async-distribution-timeout=0 > async-max-queue-size=8 > async-queue-timeout=60000 > bind-address= > cache-xml-file=cache.xml > cluster-configuration-dir= > cluster-ssl-ciphers=any > cluster-ssl-enabled=false > cluster-ssl-keystore= > cluster-ssl-keystore-password= > cluster-ssl-keystore-type= > cluster-ssl-protocols=any > [vm_1][info 2016/06/19 15:27:25.585 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$3.run > with 0 args on object: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$3@65548edb > cluster-ssl-require-authentication=true > cluster-ssl-truststore= > cluster-ssl-truststore-password= > conflate-events=server > conserve-sockets=true > delta-propagation=true > deploy-working-dir=. > [vm_1]distributed system properties: {locators=localhost[21653], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > disable-tcp=false > distributed-system-id=-1 > distributed-transactions=false > durable-client-id= > durable-client-timeout=300 > enable-network-partition-detection=false > enable-time-statistics=false > enforce-unique-host=false > gateway-ssl-ciphers=any > gateway-ssl-enabled=false > gateway-ssl-keystore= > gateway-ssl-keystore-password= > gateway-ssl-keystore-type= > gateway-ssl-protocols=any > gateway-ssl-require-authentication=true > gateway-ssl-truststore= > gateway-ssl-truststore-password= > groups= > http-service-bind-address= > http-service-port=7070 > http-service-ssl-ciphers=any > http-service-ssl-enabled=false > http-service-ssl-keystore= > http-service-ssl-keystore-password= > http-service-ssl-keystore-type= > http-service-ssl-protocols=any > http-service-ssl-require-authentication=false > http-service-ssl-truststore= > http-service-ssl-truststore-password= > jmx-manager=false > jmx-manager-access-file= > jmx-manager-bind-address= > jmx-manager-hostname-for-clients= > jmx-manager-http-port=7070 > jmx-manager-password-file= > jmx-manager-port=1099 > jmx-manager-ssl=false > jmx-manager-ssl-ciphers=any > jmx-manager-ssl-enabled=false > jmx-manager-ssl-keystore= > jmx-manager-ssl-keystore-password= > jmx-manager-ssl-keystore-type= > jmx-manager-ssl-protocols=any > jmx-manager-ssl-require-authentication=true > jmx-manager-ssl-truststore= > jmx-manager-ssl-truststore-password= > jmx-manager-start=false > jmx-manager-update-rate=2000 > load-cluster-configuration-from-dir=false > locator-wait-time=0 > lock-memory=false > log-disk-space-limit=0 > log-file= > log-file-size-limit=0 > max-num-reconnect-tries=3 > max-wait-time-reconnect=60000 > mcast-address=239.192.81.1 > mcast-flow-control=1048576, 0.25, 5000 > mcast-recv-buffer-size=1048576 > mcast-send-buffer-size=65535 > mcast-ttl=32 > member-timeout=5000 > membership-port-range=1024-65535 > memcached-bind-address= > memcached-port=0 > memcached-protocol=ASCII > name= > off-heap-memory-size= > redis-bind-address= > redis-password= > redis-port=0 > redundancy-zone= > remote-locators= > remove-unresponsive-client=false > roles= > security-client-accessor= > security-client-accessor-pp= > security-client-auth-init= > security-client-authenticator= > security-client-dhalgo= > security-log-file= > security-log-level=config > security-peer-auth-init= > security-peer-authenticator= > security-peer-verifymember-timeout=1000 > server-bind-address= > server-ssl-ciphers=any > server-ssl-enabled=false > server-ssl-keystore= > server-ssl-keystore-password= > server-ssl-keystore-type= > server-ssl-protocols=any > server-ssl-require-authentication=true > server-ssl-truststore= > server-ssl-truststore-password= > socket-buffer-size=32768 > socket-lease-time=60000 > ssl-ciphers=any > ssl-enabled=false > ssl-protocols=any > ssl-require-authentication=true > start-dev-rest-api=false > start-locator= > statistic-archive-file= > statistic-sample-rate=1000 > statistic-sampling-enabled=true > tcp-port=0 > udp-fragment-size=60000 > udp-recv-buffer-size=1048576 > udp-send-buffer-size=65535 > user-command-packages= > [vm_0]23.088: [GC (Metadata GC Threshold) [PSYoungGen: > 20897K->5440K(112128K)] 26741K->11292K(214528K), 0.0284740 secs] [Times: > user=0.06 sys=0.00, real=0.02 secs] > [info 2016/06/19 15:27:25.600 PDT <Test worker> tid=0xa] Starting membership > services > [vm_1][info 2016/06/19 15:27:25.636 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] 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[21653] > [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-peer-auth-init= > [vm_1]security-peer-authenticator= > [vm_1]security-peer-verifymember-timeout=1000 > [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= > [info 2016/06/19 15:27:25.675 PDT <Test worker> tid=0xa] JGroups channel > created (took 75ms) > [info 2016/06/19 15:27:25.700 PDT <Test worker> tid=0xa] GemFire P2P Listener > started on null > [info 2016/06/19 15:27:25.709 PDT <Geode Failure Detection Server thread 0> > tid=0x6d] Started failure detection server thread on > cc2-rh6.gemstone.com/10.118.33.92:50081. > [info 2016/06/19 15:27:25.714 PDT <Test worker> tid=0xa] Attempting to join > the distributed system through coordinator cc2-rh6(5944:locator)<ec><v0>:1024 > using address cc2-rh6(5915)<ec>:1025 > [locator][info 2016/06/19 15:27:25.716 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received join request from cc2-rh6(5915)<ec>:1025 > [vm_0]23.117: [Full GC (Metadata GC Threshold) [PSYoungGen: > 5440K->0K(112128K)] [ParOldGen: 5851K->10424K(139776K)] > 11292K->10424K(251904K), [Metaspace: 34872K->34872K(1081344K)], 0.1695197 > secs] [Times: user=0.33 sys=0.01, real=0.17 secs] > [vm_0][info 2016/06/19 15:27:25.780 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$3.run > with 0 args on object: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$3@798cc11e > [vm_0]distributed system properties: {locators=localhost[21653], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [vm_0][info 2016/06/19 15:27:25.793 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] 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[21653] > [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-peer-auth-init= > [vm_0]security-peer-authenticator= > [vm_0]security-peer-verifymember-timeout=1000 > [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/06/19 15:27:25.814 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Starting membership services > [vm_0][info 2016/06/19 15:27:25.877 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] JGroups channel created (took 62ms) > [vm_0][info 2016/06/19 15:27:25.878 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] GemFire P2P Listener started on null > [vm_0][info 2016/06/19 15:27:25.880 PDT <Geode Failure Detection Server > thread 0> tid=0x66] Started failure detection server thread on > cc2-rh6.gemstone.com/10.118.33.92:55810. > [vm_0][info 2016/06/19 15:27:25.890 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Attempting to join the distributed system through coordinator > cc2-rh6(5944:locator)<ec><v0>:1024 using address cc2-rh6(5949)<ec>:1026 > [locator][info 2016/06/19 15:27:25.891 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received join request from cc2-rh6(5949)<ec>:1026 > [vm_1][info 2016/06/19 15:27:25.968 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Starting membership services > [locator][info 2016/06/19 15:27:26.092 PDT <Geode Membership View Creator> > tid=0x28] View Creator is processing 2 requests for the next membership view > [locator][info 2016/06/19 15:27:26.092 PDT <Geode Membership View Creator> > tid=0x28] preparing new view View[cc2-rh6(5944:locator)<ec><v0>:1024|5] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026] > [locator]failure detection ports: 28143 50081 55810 > [info 2016/06/19 15:27:26.094 PDT <unicast receiver,cc2-rh6-741> tid=0x69] > received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|5] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026] > old view is: null > [info 2016/06/19 15:27:26.095 PDT <Test worker> tid=0xa] Finished joining > (took 386ms). > [info 2016/06/19 15:27:26.096 PDT <Test worker> tid=0xa] Starting > DistributionManager cc2-rh6(5915)<ec><v5>:1025. (took 497 ms) > [vm_0][info 2016/06/19 15:27:26.094 PDT <unicast receiver,cc2-rh6-27170> > tid=0x62] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|5] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026] > [vm_0]old view is: null > [vm_0][info 2016/06/19 15:27:26.097 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Finished joining (took 215ms). > [vm_0][info 2016/06/19 15:27:26.097 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Starting DistributionManager cc2-rh6(5949)<ec><v5>:1026. (took 289 > ms) > [locator][info 2016/06/19 15:27:26.098 PDT <Geode Membership View Creator> > tid=0x28] finished waiting for responses to view preparation > [locator][info 2016/06/19 15:27:26.098 PDT <Geode Membership View Creator> > tid=0x28] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|5] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026] > [locator]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|4] members: > [cc2-rh6(5944:locator)<ec><v0>:1024] shutdown: [cc2-rh6(5949)<ec><v2>:1026] > [locator][info 2016/06/19 15:27:26.098 PDT <Geode Membership View Creator> > tid=0x28] Peer locator received new membership view: > View[cc2-rh6(5944:locator)<ec><v0>:1024|5] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026] > [locator][info 2016/06/19 15:27:26.099 PDT <Geode Membership View Creator> > tid=0x28] sending new view View[cc2-rh6(5944:locator)<ec><v0>:1024|5] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026] > [locator]failure detection ports: 28143 50081 55810 > [locator][info 2016/06/19 15:27:26.099 PDT <View Message Processor> tid=0x33] > Membership: Processing addition < cc2-rh6(5915)<ec><v5>:1025 > > [locator][info 2016/06/19 15:27:26.100 PDT <View Message Processor> tid=0x33] > Admitting member <cc2-rh6(5915)<ec><v5>:1025>. Now there are 2 non-admin > member(s). > [locator][info 2016/06/19 15:27:26.100 PDT <View Message Processor> tid=0x33] > Membership: Processing addition < cc2-rh6(5949)<ec><v5>:1026 > > [info 2016/06/19 15:27:26.100 PDT <Test worker> tid=0xa] Initial > (distribution manager) view = View[cc2-rh6(5944:locator)<ec><v0>:1024|5] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026] > [locator][info 2016/06/19 15:27:26.100 PDT <View Message Processor> tid=0x33] > Admitting member <cc2-rh6(5949)<ec><v5>:1026>. Now there are 3 non-admin > member(s). > [info 2016/06/19 15:27:26.101 PDT <Test worker> tid=0xa] Admitting member > <cc2-rh6(5944:locator)<ec><v0>:1024>. Now there are 1 non-admin member(s). > [info 2016/06/19 15:27:26.101 PDT <Test worker> tid=0xa] Admitting member > <cc2-rh6(5915)<ec><v5>:1025>. Now there are 2 non-admin member(s). > [info 2016/06/19 15:27:26.101 PDT <Test worker> tid=0xa] Admitting member > <cc2-rh6(5949)<ec><v5>:1026>. Now there are 3 non-admin member(s). > [vm_0][info 2016/06/19 15:27:26.108 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initial (distribution manager) view = > View[cc2-rh6(5944:locator)<ec><v0>:1024|5] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026] > [vm_0][info 2016/06/19 15:27:26.108 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5944:locator)<ec><v0>:1024>. Now there > are 1 non-admin member(s). > [vm_0][info 2016/06/19 15:27:26.109 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5915)<ec><v5>:1025>. Now there are 2 > non-admin member(s). > [vm_0][info 2016/06/19 15:27:26.109 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5949)<ec><v5>:1026>. Now there are 3 > non-admin member(s). > [locator][info 2016/06/19 15:27:26.162 PDT <Pooled High Priority Message > Processor 1> tid=0x37] Member cc2-rh6(5949)<ec><v5>:1026 is equivalent or in > the same redundancy zone. > [locator][info 2016/06/19 15:27:26.181 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member cc2-rh6(5915)<ec><v5>:1025 is equivalent or in > the same redundancy zone. > [vm_0][info 2016/06/19 15:27:26.183 PDT <P2P message reader for > cc2-rh6(5944:locator)<ec><v0>:1024 shared unordered uid=3 port=47077> > tid=0x6d] Member cc2-rh6(5944:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [info 2016/06/19 15:27:26.181 PDT <Pooled High Priority Message Processor 1> > tid=0x75] Member cc2-rh6(5949)<ec><v5>:1026 is equivalent or in the same > redundancy zone. > [vm_0][info 2016/06/19 15:27:26.184 PDT <Pooled High Priority Message > Processor 1> tid=0x6e] Member cc2-rh6(5915)<ec><v5>:1025 is equivalent or in > the same redundancy zone. > [info 2016/06/19 15:27:26.193 PDT <P2P message reader for > cc2-rh6(5949)<ec><v5>:1026 shared unordered uid=6 port=39442> tid=0x73] > Member cc2-rh6(5949)<ec><v5>:1026 is equivalent or in the same redundancy > zone. > [vm_0][info 2016/06/19 15:27:26.194 PDT <P2P message reader for > cc2-rh6(5915)<ec><v5>:1025 shared unordered uid=3 port=47073> tid=0x6c] > Member cc2-rh6(5915)<ec><v5>:1025 is equivalent or in the same redundancy > zone. > [info 2016/06/19 15:27:26.195 PDT <P2P message reader for > cc2-rh6(5944:locator)<ec><v0>:1024 shared unordered uid=4 port=39445> > tid=0x76] Member cc2-rh6(5944:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [vm_1][info 2016/06/19 15:27:26.300 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] JGroups channel created (took 330ms) > [vm_0][info 2016/06/19 15:27:26.303 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initializing region _monitoringRegion_10.118.33.92<v5>1026 > [vm_0][info 2016/06/19 15:27:26.314 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initialization of region _monitoringRegion_10.118.33.92<v5>1026 > completed > [vm_0][info 2016/06/19 15:27:26.345 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] The cache has been created with "use-cluster-configuration=false". > It will not receive any cluster configuration > [vm_0][info 2016/06/19 15:27:26.347 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initializing region PdxTypes > [vm_1][info 2016/06/19 15:27:26.351 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] GemFire P2P Listener started on null > [vm_0][info 2016/06/19 15:27:26.351 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initialization of region PdxTypes completed > [vm_1][info 2016/06/19 15:27:26.355 PDT <Geode Failure Detection Server > thread 0> tid=0x37] Started failure detection server thread on > cc2-rh6.gemstone.com/10.118.33.92:33479. > [vm_1][info 2016/06/19 15:27:26.378 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Attempting to join the distributed system through coordinator > cc2-rh6(5944:locator)<ec><v0>:1024 using address cc2-rh6(5954)<ec>:1027 > [locator][info 2016/06/19 15:27:26.392 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received join request from cc2-rh6(5954)<ec>:1027 > [locator][info 2016/06/19 15:27:26.699 PDT <Geode Membership View Creator> > tid=0x28] View Creator is processing 1 requests for the next membership view > [locator][info 2016/06/19 15:27:26.699 PDT <Geode Membership View Creator> > tid=0x28] preparing new view View[cc2-rh6(5944:locator)<ec><v0>:1024|6] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026, > cc2-rh6(5954)<ec><v6>:1027] > [locator]failure detection ports: 28143 50081 55810 33479 > [locator][info 2016/06/19 15:27:26.704 PDT <Geode Membership View Creator> > tid=0x28] finished waiting for responses to view preparation > [locator][info 2016/06/19 15:27:26.705 PDT <Geode Membership View Creator> > tid=0x28] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|6] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026, > cc2-rh6(5954)<ec><v6>:1027] > [locator]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|5] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026] > [locator][info 2016/06/19 15:27:26.705 PDT <Geode Membership View Creator> > tid=0x28] Peer locator received new membership view: > View[cc2-rh6(5944:locator)<ec><v0>:1024|6] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026, cc2-rh6(5954)<ec><v6>:1027] > [locator][info 2016/06/19 15:27:26.706 PDT <Geode Membership View Creator> > tid=0x28] sending new view View[cc2-rh6(5944:locator)<ec><v0>:1024|6] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026, > cc2-rh6(5954)<ec><v6>:1027] > [locator]failure detection ports: 28143 50081 55810 33479 > [locator][info 2016/06/19 15:27:26.706 PDT <View Message Processor> tid=0x33] > Membership: Processing addition < cc2-rh6(5954)<ec><v6>:1027 > > [locator][info 2016/06/19 15:27:26.706 PDT <View Message Processor> tid=0x33] > Admitting member <cc2-rh6(5954)<ec><v6>:1027>. Now there are 4 non-admin > member(s). > [info 2016/06/19 15:27:26.708 PDT <unicast receiver,cc2-rh6-741> tid=0x69] > received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|6] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026, cc2-rh6(5954)<ec><v6>:1027] > old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|5] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026] > [vm_0][info 2016/06/19 15:27:26.708 PDT <unicast receiver,cc2-rh6-27170> > tid=0x62] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|6] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026, > cc2-rh6(5954)<ec><v6>:1027] > [vm_0]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|5] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026] > [vm_1][info 2016/06/19 15:27:26.710 PDT <unicast receiver,cc2-rh6-23965> > tid=0x33] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|6] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5915)<ec><v5>:1025{lead}, cc2-rh6(5949)<ec><v5>:1026, > cc2-rh6(5954)<ec><v6>:1027] > [vm_1]old view is: null > [vm_1][info 2016/06/19 15:27:26.713 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Finished joining (took 352ms). > [vm_1][info 2016/06/19 15:27:26.714 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Starting DistributionManager cc2-rh6(5954)<ec><v6>:1027. (took > 1004 ms) > [info 2016/06/19 15:27:26.715 PDT <View Message Processor> tid=0x7c] > Membership: Processing addition < cc2-rh6(5954)<ec><v6>:1027 > > [info 2016/06/19 15:27:26.715 PDT <View Message Processor> tid=0x7c] > Admitting member <cc2-rh6(5954)<ec><v6>:1027>. Now there are 4 non-admin > member(s). > [vm_0][info 2016/06/19 15:27:26.714 PDT <View Message Processor> tid=0x7e] > Membership: Processing addition < cc2-rh6(5954)<ec><v6>:1027 > > [vm_0][info 2016/06/19 15:27:26.718 PDT <View Message Processor> tid=0x7e] > Admitting member <cc2-rh6(5954)<ec><v6>:1027>. Now there are 4 non-admin > member(s). > [vm_1][info 2016/06/19 15:27:26.718 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initial (distribution manager) view = > View[cc2-rh6(5944:locator)<ec><v0>:1024|6] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026, cc2-rh6(5954)<ec><v6>:1027] > [vm_1][info 2016/06/19 15:27:26.719 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5944:locator)<ec><v0>:1024>. Now there > are 1 non-admin member(s). > [vm_1][info 2016/06/19 15:27:26.719 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5915)<ec><v5>:1025>. Now there are 2 > non-admin member(s). > [vm_1][info 2016/06/19 15:27:26.720 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5949)<ec><v5>:1026>. Now there are 3 > non-admin member(s). > [vm_1][info 2016/06/19 15:27:26.720 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5954)<ec><v6>:1027>. Now there are 4 > non-admin member(s). > [vm_0][info 2016/06/19 15:27:26.753 PDT <Pooled High Priority Message > Processor 2> tid=0x7a] Member cc2-rh6(5954)<ec><v6>:1027 is equivalent or in > the same redundancy zone. > [info 2016/06/19 15:27:26.754 PDT <Pooled High Priority Message Processor 1> > tid=0x75] Member cc2-rh6(5954)<ec><v6>:1027 is equivalent or in the same > redundancy zone. > [locator][info 2016/06/19 15:27:26.755 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member cc2-rh6(5954)<ec><v6>:1027 is equivalent or in > the same redundancy zone. > [vm_1][info 2016/06/19 15:27:26.770 PDT <P2P message reader for > cc2-rh6(5949)<ec><v5>:1026 shared unordered uid=7 port=35835> tid=0x40] > Member cc2-rh6(5949)<ec><v5>:1026 is equivalent or in the same redundancy > zone. > [vm_1][info 2016/06/19 15:27:26.773 PDT <P2P message reader for > cc2-rh6(5915)<ec><v5>:1025 shared unordered uid=5 port=35834> tid=0x3f] > Member cc2-rh6(5915)<ec><v5>:1025 is equivalent or in the same redundancy > zone. > [vm_1][info 2016/06/19 15:27:26.775 PDT <P2P message reader for > cc2-rh6(5944:locator)<ec><v0>:1024 shared unordered uid=5 port=35836> > tid=0x42] Member cc2-rh6(5944:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [vm_1][info 2016/06/19 15:27:26.926 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initializing region _monitoringRegion_10.118.33.92<v6>1027 > [vm_1][info 2016/06/19 15:27:26.943 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initialization of region _monitoringRegion_10.118.33.92<v6>1027 > completed > [vm_0][info 2016/06/19 15:27:27.418 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Got result: null > [vm_0] from > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$3.run > with 0 args on object: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$3@798cc11e > (took 1637 ms) > [vm_1][info 2016/06/19 15:27:27.447 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] The cache has been created with "use-cluster-configuration=false". > It will not receive any cluster configuration > [vm_1]24.962: [GC (Allocation Failure) [PSYoungGen: 96256K->8755K(112128K)] > 102135K->14643K(214528K), 0.0165064 secs] [Times: user=0.05 sys=0.00, > real=0.02 secs] > [vm_1][info 2016/06/19 15:27:27.495 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initializing region PdxTypes > [vm_1][info 2016/06/19 15:27:27.527 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Region PdxTypes requesting initial image from > cc2-rh6(5949)<ec><v5>:1026 > [vm_1][info 2016/06/19 15:27:27.550 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] PdxTypes is done getting image from cc2-rh6(5949)<ec><v5>:1026. > isDeltaGII is false > [vm_1][info 2016/06/19 15:27:27.551 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Initialization of region PdxTypes completed > [vm_1][info 2016/06/19 15:27:48.566 PDT <RMI TCP Connection(1)-10.118.33.92> > tid=0x12] Got result: null > [vm_1] from > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$3.run > with 0 args on object: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$3@65548edb > (took 22980 ms) > [vm_1]54.483: [GC (Metadata GC Threshold) [PSYoungGen: > 74086K->5873K(112128K)] 79974K->11768K(214528K), 0.0075295 secs] [Times: > user=0.02 sys=0.01, real=0.01 secs] > [vm_1]54.490: [Full GC (Metadata GC Threshold) [PSYoungGen: > 5873K->0K(112128K)] [ParOldGen: 5895K->10796K(107520K)] > 11768K->10796K(219648K), [Metaspace: 34685K->34685K(1081344K)], 0.0955188 > secs] [Times: user=0.24 sys=0.00, real=0.10 secs] > [locator]67.442: [GC (Allocation Failure) [PSYoungGen: > 96256K->7402K(112128K)] 102835K->13989K(296448K), 0.0095254 secs] [Times: > user=0.02 sys=0.00, real=0.01 secs] > [vm_0]72.859: [GC (Allocation Failure) [PSYoungGen: 96256K->1261K(112128K)] > 106680K->11693K(251904K), 0.0066837 secs] [Times: user=0.01 sys=0.00, > real=0.00 secs] > [info 2016/06/19 15:28:30.047 PDT <Test worker> tid=0xa] Shutting down > DistributionManager cc2-rh6(5915)<ec><v5>:1025. > [vm_1][info 2016/06/19 15:28:30.049 PDT <Pooled High Priority Message > Processor 2> tid=0x50] received leave request from cc2-rh6(5915)<ec><v5>:1025 > for cc2-rh6(5915)<ec><v5>:1025 > [vm_0][info 2016/06/19 15:28:30.049 PDT <Pooled High Priority Message > Processor 2> tid=0x7a] received leave request from cc2-rh6(5915)<ec><v5>:1025 > for cc2-rh6(5915)<ec><v5>:1025 > [locator][info 2016/06/19 15:28:30.049 PDT <Pooled High Priority Message > Processor 2> tid=0x48] received leave request from cc2-rh6(5915)<ec><v5>:1025 > for cc2-rh6(5915)<ec><v5>:1025 > [locator][info 2016/06/19 15:28:30.050 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member at cc2-rh6(5915)<ec><v5>:1025 gracefully left > the distributed cache: shutdown message received > [vm_0][info 2016/06/19 15:28:30.051 PDT <Pooled High Priority Message > Processor 2> tid=0x7a] Member at cc2-rh6(5915)<ec><v5>:1025 gracefully left > the distributed cache: shutdown message received > [vm_1][info 2016/06/19 15:28:30.052 PDT <Pooled High Priority Message > Processor 2> tid=0x50] Member at cc2-rh6(5915)<ec><v5>:1025 gracefully left > the distributed cache: shutdown message received > [info 2016/06/19 15:28:30.150 PDT <Test worker> tid=0xa] Now closing > distribution for cc2-rh6(5915)<ec><v5>:1025 > [info 2016/06/19 15:28:30.150 PDT <Test worker> tid=0xa] Stopping membership > services > [info 2016/06/19 15:28:30.151 PDT <Test worker> tid=0xa] GMSHealthMonitor > server socket is closed in stopServices(). > [info 2016/06/19 15:28:30.152 PDT <Geode Failure Detection Server thread 0> > tid=0x6d] GMSHealthMonitor server thread exiting > [locator][info 2016/06/19 15:28:30.151 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received leave request from cc2-rh6(5915)<ec><v5>:1025 for > cc2-rh6(5915)<ec><v5>:1025 > [vm_0][info 2016/06/19 15:28:30.152 PDT <unicast receiver,cc2-rh6-27170> > tid=0x62] received leave request from cc2-rh6(5915)<ec><v5>:1025 for > cc2-rh6(5915)<ec><v5>:1025 > [info 2016/06/19 15:28:30.153 PDT <Test worker> tid=0xa] GMSHealthMonitor > serverSocketExecutor is terminated > [vm_1][info 2016/06/19 15:28:30.155 PDT <unicast receiver,cc2-rh6-23965> > tid=0x33] received leave request from cc2-rh6(5915)<ec><v5>:1025 for > cc2-rh6(5915)<ec><v5>:1025 > [info 2016/06/19 15:28:30.160 PDT <Test worker> tid=0xa] DistributionManager > stopped in 113ms. > [info 2016/06/19 15:28:30.160 PDT <Test worker> tid=0xa] Marking > DistributionManager cc2-rh6(5915)<ec><v5>:1025 as closed. > [vm_0][info 2016/06/19 15:28:30.163 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/65950789.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/65950789@614dfae7 > [vm_0][info 2016/06/19 15:28:30.168 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GemFireCache[id = 956673761; isClosing = true; isShutDownAll = > false; created = Sun Jun 19 15:27:26 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_0][info 2016/06/19 15:28:30.183 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Shutting down DistributionManager cc2-rh6(5949)<ec><v5>:1026. > [vm_1][info 2016/06/19 15:28:30.184 PDT <Pooled High Priority Message > Processor 2> tid=0x50] received leave request from cc2-rh6(5949)<ec><v5>:1026 > for cc2-rh6(5949)<ec><v5>:1026 > [vm_1][info 2016/06/19 15:28:30.185 PDT <Pooled High Priority Message > Processor 2> tid=0x50] Member at cc2-rh6(5949)<ec><v5>:1026 gracefully left > the distributed cache: shutdown message received > [locator][info 2016/06/19 15:28:30.185 PDT <Pooled High Priority Message > Processor 2> tid=0x48] received leave request from cc2-rh6(5949)<ec><v5>:1026 > for cc2-rh6(5949)<ec><v5>:1026 > [locator][info 2016/06/19 15:28:30.185 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member at cc2-rh6(5949)<ec><v5>:1026 gracefully left > the distributed cache: shutdown message received > [vm_0][info 2016/06/19 15:28:30.288 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Now closing distribution for cc2-rh6(5949)<ec><v5>:1026 > [vm_0][info 2016/06/19 15:28:30.289 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Stopping membership services > [vm_1][info 2016/06/19 15:28:30.291 PDT <unicast receiver,cc2-rh6-23965> > tid=0x33] received leave request from cc2-rh6(5949)<ec><v5>:1026 for > cc2-rh6(5949)<ec><v5>:1026 > [locator][info 2016/06/19 15:28:30.292 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received leave request from cc2-rh6(5949)<ec><v5>:1026 for > cc2-rh6(5949)<ec><v5>:1026 > [vm_0][info 2016/06/19 15:28:30.293 PDT <Geode Failure Detection Server > thread 0> tid=0x66] GMSHealthMonitor server thread exiting > [vm_0][info 2016/06/19 15:28:30.294 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GMSHealthMonitor server socket is closed in stopServices(). > [vm_0][info 2016/06/19 15:28:30.294 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GMSHealthMonitor serverSocketExecutor is terminated > [vm_0][info 2016/06/19 15:28:30.300 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] DistributionManager stopped in 116ms. > [vm_0][info 2016/06/19 15:28:30.301 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Marking DistributionManager cc2-rh6(5949)<ec><v5>:1026 as closed. > [vm_0][info 2016/06/19 15:28:30.301 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/65950789.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/65950789@614dfae7 > (took 137 ms) > [vm_1][info 2016/06/19 15:28:30.304 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1264152676.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1264152676@5298f111 > [vm_1][info 2016/06/19 15:28:30.333 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GemFireCache[id = 268148852; isClosing = true; isShutDownAll = > false; created = Sun Jun 19 15:27:26 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_1][info 2016/06/19 15:28:30.340 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Shutting down DistributionManager cc2-rh6(5954)<ec><v6>:1027. > [locator][info 2016/06/19 15:28:30.342 PDT <Pooled High Priority Message > Processor 2> tid=0x48] received leave request from cc2-rh6(5954)<ec><v6>:1027 > for cc2-rh6(5954)<ec><v6>:1027 > [locator][info 2016/06/19 15:28:30.343 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member at cc2-rh6(5954)<ec><v6>:1027 gracefully left > the distributed cache: shutdown message received > [locator][info 2016/06/19 15:28:30.444 PDT <Geode Membership View Creator> > tid=0x28] View Creator is processing 5 requests for the next membership view > [locator][info 2016/06/19 15:28:30.445 PDT <Geode Membership View Creator> > tid=0x28] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|7] > members: [cc2-rh6(5944:locator)<ec><v0>:1024] shutdown: > [cc2-rh6(5949)<ec><v5>:1026, cc2-rh6(5954)<ec><v6>:1027, > cc2-rh6(5915)<ec><v5>:1025] > [locator]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|6] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5915)<ec><v5>:1025{lead}, > cc2-rh6(5949)<ec><v5>:1026, cc2-rh6(5954)<ec><v6>:1027] > [locator][info 2016/06/19 15:28:30.445 PDT <Geode Membership View Creator> > tid=0x28] Peer locator received new membership view: > View[cc2-rh6(5944:locator)<ec><v0>:1024|7] members: > [cc2-rh6(5944:locator)<ec><v0>:1024] shutdown: [cc2-rh6(5949)<ec><v5>:1026, > cc2-rh6(5954)<ec><v6>:1027, cc2-rh6(5915)<ec><v5>:1025] > [vm_1][info 2016/06/19 15:28:30.446 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Now closing distribution for cc2-rh6(5954)<ec><v6>:1027 > [locator][info 2016/06/19 15:28:30.446 PDT <Geode Membership View Creator> > tid=0x28] no recipients for new view aside from myself > [vm_1][info 2016/06/19 15:28:30.447 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Stopping membership services > [locator][info 2016/06/19 15:28:30.450 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received leave request from cc2-rh6(5954)<ec><v6>:1027 for > cc2-rh6(5954)<ec><v6>:1027 > [vm_1][info 2016/06/19 15:28:30.452 PDT <Geode Failure Detection Server > thread 0> tid=0x37] GMSHealthMonitor server thread exiting > [vm_1][info 2016/06/19 15:28:30.453 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GMSHealthMonitor server socket is closed in stopServices(). > [vm_1][info 2016/06/19 15:28:30.454 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GMSHealthMonitor serverSocketExecutor is terminated > [vm_1][info 2016/06/19 15:28:30.461 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] DistributionManager stopped in 121ms. > [vm_1][info 2016/06/19 15:28:30.462 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Marking DistributionManager cc2-rh6(5954)<ec><v6>:1027 as closed. > [vm_1][info 2016/06/19 15:28:30.463 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1264152676.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1264152676@5298f111 > (took 158 ms) > [vm_2][info 2016/06/19 15:28:30.465 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1317959256.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1317959256@da54c24 > [vm_2][info 2016/06/19 15:28:30.466 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1317959256.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1317959256@da54c24 > (took 0 ms) > [vm_3][info 2016/06/19 15:28:30.468 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/993388654.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/993388654@34dceb0c > [vm_3][info 2016/06/19 15:28:30.470 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/993388654.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/993388654@34dceb0c > (took 0 ms) > [vm_0][info 2016/06/19 15:28:30.472 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$8/643656740.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$8/643656740@3730e75c > [vm_0][info 2016/06/19 15:28:30.473 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$8/643656740.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$8/643656740@3730e75c > (took 0 ms) > [vm_1][info 2016/06/19 15:28:30.475 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$7/969364915.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$7/969364915@3edc5b31 > [vm_1][info 2016/06/19 15:28:30.476 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$7/969364915.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$7/969364915@3edc5b31 > (took 0 ms) > [vm_2][info 2016/06/19 15:28:30.477 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1571414319.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1571414319@5cc0375f > [vm_2][info 2016/06/19 15:28:30.478 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1571414319.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1571414319@5cc0375f > (took 0 ms) > [vm_3][info 2016/06/19 15:28:30.480 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1408350782.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1408350782@78c65099 > [vm_3][info 2016/06/19 15:28:30.481 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1408350782.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1408350782@78c65099 > (took 0 ms) > [vm_0][info 2016/06/19 15:28:30.482 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1788873322.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1788873322@3889a83f > [vm_0][info 2016/06/19 15:28:30.482 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1788873322.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1788873322@3889a83f > (took 0 ms) > [vm_1][info 2016/06/19 15:28:30.484 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$9/1329139869.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$9/1329139869@4db5910e > [vm_1][info 2016/06/19 15:28:30.484 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$9/1329139869.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$9/1329139869@4db5910e > (took 0 ms) > [vm_2][info 2016/06/19 15:28:30.486 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4Distr > ...[truncated 11743 chars]... > 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-peer-auth-init= > [vm_0]security-peer-authenticator= > [vm_0]security-peer-verifymember-timeout=1000 > [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/06/19 15:28:30.564 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Starting membership services > [vm_0][info 2016/06/19 15:28:30.625 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] JGroups channel created (took 60ms) > [vm_0][info 2016/06/19 15:28:30.627 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GemFire P2P Listener started on null > [vm_0][info 2016/06/19 15:28:30.628 PDT <Geode Failure Detection Server > thread 0> tid=0xa0] Started failure detection server thread on > cc2-rh6.gemstone.com/10.118.33.92:55219. > [vm_0][info 2016/06/19 15:28:30.636 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Attempting to join the distributed system through coordinator > cc2-rh6(5944:locator)<ec><v0>:1024 using address cc2-rh6(5949)<ec>:1025 > [locator][info 2016/06/19 15:28:30.637 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received join request from cc2-rh6(5949)<ec>:1025 > [locator][info 2016/06/19 15:28:30.938 PDT <Geode Membership View Creator> > tid=0x28] View Creator is processing 1 requests for the next membership view > [locator][info 2016/06/19 15:28:30.938 PDT <Geode Membership View Creator> > tid=0x28] preparing new view View[cc2-rh6(5944:locator)<ec><v0>:1024|8] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}] > [locator]failure detection ports: 28143 55219 > [vm_0][info 2016/06/19 15:28:30.940 PDT <unicast receiver,cc2-rh6-38705> > tid=0x9c] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|8] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}] > [vm_0]old view is: null > [vm_0][info 2016/06/19 15:28:30.941 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Finished joining (took 312ms). > [locator][info 2016/06/19 15:28:30.941 PDT <Geode Membership View Creator> > tid=0x28] finished waiting for responses to view preparation > [vm_0][info 2016/06/19 15:28:30.942 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Starting DistributionManager cc2-rh6(5949)<ec><v8>:1025. (took 379 > ms) > [locator][info 2016/06/19 15:28:30.942 PDT <Geode Membership View Creator> > tid=0x28] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|8] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}] > [locator]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|7] members: > [cc2-rh6(5944:locator)<ec><v0>:1024] shutdown: [cc2-rh6(5949)<ec><v5>:1026, > cc2-rh6(5954)<ec><v6>:1027, cc2-rh6(5915)<ec><v5>:1025] > [locator][info 2016/06/19 15:28:30.942 PDT <Geode Membership View Creator> > tid=0x28] Peer locator received new membership view: > View[cc2-rh6(5944:locator)<ec><v0>:1024|8] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}] > [vm_0][info 2016/06/19 15:28:30.943 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initial (distribution manager) view = > View[cc2-rh6(5944:locator)<ec><v0>:1024|8] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}] > [vm_0][info 2016/06/19 15:28:30.943 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5944:locator)<ec><v0>:1024>. Now there > are 1 non-admin member(s). > [locator][info 2016/06/19 15:28:30.943 PDT <View Message Processor> tid=0x33] > Membership: Processing addition < cc2-rh6(5949)<ec><v8>:1025 > > [vm_0][info 2016/06/19 15:28:30.944 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5949)<ec><v8>:1025>. Now there are 2 > non-admin member(s). > [locator][info 2016/06/19 15:28:30.944 PDT <View Message Processor> tid=0x33] > Admitting member <cc2-rh6(5949)<ec><v8>:1025>. Now there are 2 non-admin > member(s). > [locator][info 2016/06/19 15:28:30.944 PDT <Geode Membership View Creator> > tid=0x28] sending new view View[cc2-rh6(5944:locator)<ec><v0>:1024|8] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}] > [locator]failure detection ports: 28143 55219 > [locator][info 2016/06/19 15:28:30.950 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member cc2-rh6(5949)<ec><v8>:1025 is equivalent or in > the same redundancy zone. > [vm_0][info 2016/06/19 15:28:30.954 PDT <P2P message reader for > cc2-rh6(5944:locator)<ec><v0>:1024 shared unordered uid=6 port=51774> > tid=0xa6] Member cc2-rh6(5944:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [vm_0][info 2016/06/19 15:28:30.968 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initializing region _monitoringRegion_10.118.33.92<v8>1025 > [vm_0][info 2016/06/19 15:28:30.971 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initialization of region _monitoringRegion_10.118.33.92<v8>1025 > completed > [vm_0][info 2016/06/19 15:28:31.011 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] The cache has been created with "use-cluster-configuration=false". > It will not receive any cluster configuration > [vm_0][info 2016/06/19 15:28:31.012 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initializing region PdxTypes > [vm_0][info 2016/06/19 15:28:31.014 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initialization of region PdxTypes completed > [vm_0][info 2016/06/19 15:28:31.017 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: cc2-rh6(5949)<ec><v8>:1025 > [vm_0] from > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$4.call > with 0 args on object: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$4@4ca880ee > (took 486 ms) > [vm_1][info 2016/06/19 15:28:31.021 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$4.call > with 0 args on object: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$4@5479ca13 > [vm_1]distributed system properties: {locators=localhost[21653], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [vm_1][info 2016/06/19 15:28:31.027 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] 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[21653] > [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-peer-auth-init= > [vm_1]security-peer-authenticator= > [vm_1]security-peer-verifymember-timeout=1000 > [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/06/19 15:28:31.031 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Starting membership services > [vm_1][info 2016/06/19 15:28:31.051 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] JGroups channel created (took 20ms) > [vm_1][info 2016/06/19 15:28:31.058 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GemFire P2P Listener started on null > [vm_1][info 2016/06/19 15:28:31.059 PDT <Geode Failure Detection Server > thread 0> tid=0x70] Started failure detection server thread on > cc2-rh6.gemstone.com/10.118.33.92:7055. > [vm_1][info 2016/06/19 15:28:31.062 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Attempting to join the distributed system through coordinator > cc2-rh6(5944:locator)<ec><v0>:1024 using address cc2-rh6(5954)<ec>:1026 > [locator][info 2016/06/19 15:28:31.063 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received join request from cc2-rh6(5954)<ec>:1026 > [locator][info 2016/06/19 15:28:31.364 PDT <Geode Membership View Creator> > tid=0x28] View Creator is processing 1 requests for the next membership view > [locator][info 2016/06/19 15:28:31.365 PDT <Geode Membership View Creator> > tid=0x28] preparing new view View[cc2-rh6(5944:locator)<ec><v0>:1024|9] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026] > [locator]failure detection ports: 28143 55219 7055 > [vm_1][info 2016/06/19 15:28:31.367 PDT <unicast receiver,cc2-rh6-46843> > tid=0x6c] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|9] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026] > [vm_1]old view is: null > [locator][info 2016/06/19 15:28:31.367 PDT <Geode Membership View Creator> > tid=0x28] finished waiting for responses to view preparation > [vm_1][info 2016/06/19 15:28:31.368 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Finished joining (took 309ms). > [vm_1][info 2016/06/19 15:28:31.368 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Starting DistributionManager cc2-rh6(5954)<ec><v9>:1026. (took 338 > ms) > [locator][info 2016/06/19 15:28:31.367 PDT <Geode Membership View Creator> > tid=0x28] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|9] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026] > [locator]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|8] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}] > [vm_1][info 2016/06/19 15:28:31.368 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initial (distribution manager) view = > View[cc2-rh6(5944:locator)<ec><v0>:1024|9] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}, > cc2-rh6(5954)<ec><v9>:1026] > [vm_1][info 2016/06/19 15:28:31.369 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5944:locator)<ec><v0>:1024>. Now there > are 1 non-admin member(s). > [vm_1][info 2016/06/19 15:28:31.369 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5949)<ec><v8>:1025>. Now there are 2 > non-admin member(s). > [vm_1][info 2016/06/19 15:28:31.369 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Admitting member <cc2-rh6(5954)<ec><v9>:1026>. Now there are 3 > non-admin member(s). > [vm_0][info 2016/06/19 15:28:31.370 PDT <unicast receiver,cc2-rh6-38705> > tid=0x9c] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|9] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026] > [vm_0]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|8] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}] > [locator][info 2016/06/19 15:28:31.367 PDT <Geode Membership View Creator> > tid=0x28] Peer locator received new membership view: > View[cc2-rh6(5944:locator)<ec><v0>:1024|9] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}, > cc2-rh6(5954)<ec><v9>:1026] > [locator][info 2016/06/19 15:28:31.368 PDT <Geode Membership View Creator> > tid=0x28] sending new view View[cc2-rh6(5944:locator)<ec><v0>:1024|9] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026] > [locator]failure detection ports: 28143 55219 7055 > [locator][info 2016/06/19 15:28:31.368 PDT <View Message Processor> tid=0x33] > Membership: Processing addition < cc2-rh6(5954)<ec><v9>:1026 > > [locator][info 2016/06/19 15:28:31.369 PDT <View Message Processor> tid=0x33] > Admitting member <cc2-rh6(5954)<ec><v9>:1026>. Now there are 3 non-admin > member(s). > [vm_0][info 2016/06/19 15:28:31.373 PDT <View Message Processor> tid=0xb4] > Membership: Processing addition < cc2-rh6(5954)<ec><v9>:1026 > > [vm_0][info 2016/06/19 15:28:31.373 PDT <View Message Processor> tid=0xb4] > Admitting member <cc2-rh6(5954)<ec><v9>:1026>. Now there are 3 non-admin > member(s). > [locator][info 2016/06/19 15:28:31.379 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member cc2-rh6(5954)<ec><v9>:1026 is equivalent or in > the same redundancy zone. > [vm_0][info 2016/06/19 15:28:31.381 PDT <Pooled High Priority Message > Processor 1> tid=0xb1] Member cc2-rh6(5954)<ec><v9>:1026 is equivalent or in > the same redundancy zone. > [vm_1][info 2016/06/19 15:28:31.384 PDT <P2P message reader for > cc2-rh6(5944:locator)<ec><v0>:1024 shared unordered uid=7 port=44582> > tid=0x77] Member cc2-rh6(5944:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [vm_1][info 2016/06/19 15:28:31.385 PDT <P2P message reader for > cc2-rh6(5949)<ec><v8>:1025 shared unordered uid=10 port=44583> tid=0x78] > Member cc2-rh6(5949)<ec><v8>:1025 is equivalent or in the same redundancy > zone. > [vm_1][info 2016/06/19 15:28:31.402 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initializing region _monitoringRegion_10.118.33.92<v9>1026 > [vm_1][info 2016/06/19 15:28:31.405 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initialization of region _monitoringRegion_10.118.33.92<v9>1026 > completed > [vm_1][info 2016/06/19 15:28:31.412 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] The cache has been created with "use-cluster-configuration=false". > It will not receive any cluster configuration > [vm_1][info 2016/06/19 15:28:31.413 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initializing region PdxTypes > [vm_1][info 2016/06/19 15:28:31.419 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Region PdxTypes requesting initial image from > cc2-rh6(5949)<ec><v8>:1025 > [vm_1][info 2016/06/19 15:28:31.424 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] PdxTypes is done getting image from cc2-rh6(5949)<ec><v8>:1025. > isDeltaGII is false > [vm_1][info 2016/06/19 15:28:31.425 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Initialization of region PdxTypes completed > [vm_1][info 2016/06/19 15:28:31.472 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: cc2-rh6(5954)<ec><v9>:1026 > [vm_1] from > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$4.call > with 0 args on object: > com.gemstone.gemfire.distributed.internal.deadlock.GemFireDeadlockDetectorDUnitTest$4@5479ca13 > (took 450 ms) > distributed system properties: {locators=localhost[21653], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [info 2016/06/19 15:28:31.480 PDT <Test worker> tid=0xa] Startup > Configuration: > ### GemFire Properties defined with api ### > disable-auto-reconnect=true > enable-cluster-configuration=false > locators=localhost[21653] > log-level=info > mcast-port=0 > use-cluster-configuration=false > ### GemFire Properties using default values ### > ack-severe-alert-threshold=0 > ack-wait-threshold=15 > archive-disk-space-limit=0 > archive-file-size-limit=0 > async-distribution-timeout=0 > async-max-queue-size=8 > async-queue-timeout=60000 > bind-address= > cache-xml-file=cache.xml > cluster-configuration-dir= > cluster-ssl-ciphers=any > cluster-ssl-enabled=false > cluster-ssl-keystore= > cluster-ssl-keystore-password= > cluster-ssl-keystore-type= > cluster-ssl-protocols=any > cluster-ssl-require-authentication=true > cluster-ssl-truststore= > cluster-ssl-truststore-password= > conflate-events=server > conserve-sockets=true > delta-propagation=true > deploy-working-dir=. > disable-tcp=false > distributed-system-id=-1 > distributed-transactions=false > durable-client-id= > durable-client-timeout=300 > enable-network-partition-detection=false > enable-time-statistics=false > enforce-unique-host=false > gateway-ssl-ciphers=any > gateway-ssl-enabled=false > gateway-ssl-keystore= > gateway-ssl-keystore-password= > gateway-ssl-keystore-type= > gateway-ssl-protocols=any > gateway-ssl-require-authentication=true > gateway-ssl-truststore= > gateway-ssl-truststore-password= > groups= > http-service-bind-address= > http-service-port=7070 > http-service-ssl-ciphers=any > http-service-ssl-enabled=false > http-service-ssl-keystore= > http-service-ssl-keystore-password= > http-service-ssl-keystore-type= > http-service-ssl-protocols=any > http-service-ssl-require-authentication=false > http-service-ssl-truststore= > http-service-ssl-truststore-password= > jmx-manager=false > jmx-manager-access-file= > jmx-manager-bind-address= > jmx-manager-hostname-for-clients= > jmx-manager-http-port=7070 > jmx-manager-password-file= > jmx-manager-port=1099 > jmx-manager-ssl=false > jmx-manager-ssl-ciphers=any > jmx-manager-ssl-enabled=false > jmx-manager-ssl-keystore= > jmx-manager-ssl-keystore-password= > jmx-manager-ssl-keystore-type= > jmx-manager-ssl-protocols=any > jmx-manager-ssl-require-authentication=true > jmx-manager-ssl-truststore= > jmx-manager-ssl-truststore-password= > jmx-manager-start=false > jmx-manager-update-rate=2000 > load-cluster-configuration-from-dir=false > locator-wait-time=0 > lock-memory=false > log-disk-space-limit=0 > log-file= > log-file-size-limit=0 > max-num-reconnect-tries=3 > max-wait-time-reconnect=60000 > mcast-address=239.192.81.1 > mcast-flow-control=1048576, 0.25, 5000 > mcast-recv-buffer-size=1048576 > mcast-send-buffer-size=65535 > mcast-ttl=32 > member-timeout=5000 > membership-port-range=1024-65535 > memcached-bind-address= > memcached-port=0 > memcached-protocol=ASCII > name= > off-heap-memory-size= > redis-bind-address= > redis-password= > redis-port=0 > redundancy-zone= > remote-locators= > remove-unresponsive-client=false > roles= > security-client-accessor= > security-client-accessor-pp= > security-client-auth-init= > security-client-authenticator= > security-client-dhalgo= > security-log-file= > security-log-level=config > security-peer-auth-init= > security-peer-authenticator= > security-peer-verifymember-timeout=1000 > server-bind-address= > server-ssl-ciphers=any > server-ssl-enabled=false > server-ssl-keystore= > server-ssl-keystore-password= > server-ssl-keystore-type= > server-ssl-protocols=any > server-ssl-require-authentication=true > server-ssl-truststore= > server-ssl-truststore-password= > socket-buffer-size=32768 > socket-lease-time=60000 > ssl-ciphers=any > ssl-enabled=false > ssl-protocols=any > ssl-require-authentication=true > start-dev-rest-api=false > start-locator= > statistic-archive-file= > statistic-sample-rate=1000 > statistic-sampling-enabled=true > tcp-port=0 > udp-fragment-size=60000 > udp-recv-buffer-size=1048576 > udp-send-buffer-size=65535 > user-command-packages= > [info 2016/06/19 15:28:31.483 PDT <Test worker> tid=0xa] Starting membership > services > [info 2016/06/19 15:28:31.510 PDT <Test worker> tid=0xa] JGroups channel > created (took 26ms) > [info 2016/06/19 15:28:31.512 PDT <Test worker> tid=0xa] GemFire P2P Listener > started on null > [info 2016/06/19 15:28:31.512 PDT <Geode Failure Detection Server thread 0> > tid=0x99] Started failure detection server thread on > cc2-rh6.gemstone.com/10.118.33.92:12556. > [info 2016/06/19 15:28:31.516 PDT <Test worker> tid=0xa] Attempting to join > the distributed system through coordinator cc2-rh6(5944:locator)<ec><v0>:1024 > using address cc2-rh6(5915)<ec>:1027 > [locator][info 2016/06/19 15:28:31.517 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received join request from cc2-rh6(5915)<ec>:1027 > [locator][info 2016/06/19 15:28:31.818 PDT <Geode Membership View Creator> > tid=0x28] View Creator is processing 1 requests for the next membership view > [locator][info 2016/06/19 15:28:31.819 PDT <Geode Membership View Creator> > tid=0x28] preparing new view View[cc2-rh6(5944:locator)<ec><v0>:1024|10] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026, > cc2-rh6(5915)<ec><v10>:1027] > [locator]failure detection ports: 28143 55219 7055 12556 > [info 2016/06/19 15:28:31.821 PDT <unicast receiver,cc2-rh6-3587> tid=0x95] > received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|10] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}, > cc2-rh6(5954)<ec><v9>:1026, cc2-rh6(5915)<ec><v10>:1027] > old view is: null > [info 2016/06/19 15:28:31.822 PDT <Test worker> tid=0xa] Finished joining > (took 310ms). > [info 2016/06/19 15:28:31.822 PDT <Test worker> tid=0xa] Starting > DistributionManager cc2-rh6(5915)<ec><v10>:1027. (took 340 ms) > [info 2016/06/19 15:28:31.822 PDT <Test worker> tid=0xa] Initial > (distribution manager) view = View[cc2-rh6(5944:locator)<ec><v0>:1024|10] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026, > cc2-rh6(5915)<ec><v10>:1027] > [info 2016/06/19 15:28:31.822 PDT <Test worker> tid=0xa] Admitting member > <cc2-rh6(5944:locator)<ec><v0>:1024>. Now there are 1 non-admin member(s). > [info 2016/06/19 15:28:31.822 PDT <Test worker> tid=0xa] Admitting member > <cc2-rh6(5949)<ec><v8>:1025>. Now there are 2 non-admin member(s). > [info 2016/06/19 15:28:31.823 PDT <Test worker> tid=0xa] Admitting member > <cc2-rh6(5954)<ec><v9>:1026>. Now there are 3 non-admin member(s). > [info 2016/06/19 15:28:31.823 PDT <Test worker> tid=0xa] Admitting member > <cc2-rh6(5915)<ec><v10>:1027>. Now there are 4 non-admin member(s). > [vm_0][info 2016/06/19 15:28:31.824 PDT <unicast receiver,cc2-rh6-38705> > tid=0x9c] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|10] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026, > cc2-rh6(5915)<ec><v10>:1027] > [vm_0]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|9] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}, > cc2-rh6(5954)<ec><v9>:1026] > [locator][info 2016/06/19 15:28:31.821 PDT <Geode Membership View Creator> > tid=0x28] finished waiting for responses to view preparation > [locator][info 2016/06/19 15:28:31.822 PDT <Geode Membership View Creator> > tid=0x28] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|10] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026, > cc2-rh6(5915)<ec><v10>:1027] > [locator]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|9] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}, > cc2-rh6(5954)<ec><v9>:1026] > [locator][info 2016/06/19 15:28:31.822 PDT <Geode Membership View Creator> > tid=0x28] Peer locator received new membership view: > View[cc2-rh6(5944:locator)<ec><v0>:1024|10] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}, > cc2-rh6(5954)<ec><v9>:1026, cc2-rh6(5915)<ec><v10>:1027] > [locator][info 2016/06/19 15:28:31.823 PDT <Geode Membership View Creator> > tid=0x28] sending new view View[cc2-rh6(5944:locator)<ec><v0>:1024|10] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026, > cc2-rh6(5915)<ec><v10>:1027] > [locator]failure detection ports: 28143 55219 7055 12556 > [locator][info 2016/06/19 15:28:31.823 PDT <View Message Processor> tid=0x33] > Membership: Processing addition < cc2-rh6(5915)<ec><v10>:1027 > > [locator][info 2016/06/19 15:28:31.823 PDT <View Message Processor> tid=0x33] > Admitting member <cc2-rh6(5915)<ec><v10>:1027>. Now there are 4 non-admin > member(s). > [vm_0][info 2016/06/19 15:28:31.825 PDT <View Message Processor> tid=0xb4] > Membership: Processing addition < cc2-rh6(5915)<ec><v10>:1027 > > [vm_0][info 2016/06/19 15:28:31.825 PDT <View Message Processor> tid=0xb4] > Admitting member <cc2-rh6(5915)<ec><v10>:1027>. Now there are 4 non-admin > member(s). > [vm_1][info 2016/06/19 15:28:31.829 PDT <unicast receiver,cc2-rh6-46843> > tid=0x6c] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|10] > members: [cc2-rh6(5944:locator)<ec><v0>:1024, > cc2-rh6(5949)<ec><v8>:1025{lead}, cc2-rh6(5954)<ec><v9>:1026, > cc2-rh6(5915)<ec><v10>:1027] > [vm_1]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|9] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}, > cc2-rh6(5954)<ec><v9>:1026] > [vm_1][info 2016/06/19 15:28:31.833 PDT <P2P message reader@4662b634> > tid=0x86] Admitting member <cc2-rh6(5915)<ec><v10>:1027>. Now there are 4 > non-admin member(s). > [vm_1][info 2016/06/19 15:28:31.840 PDT <Pooled High Priority Message > Processor 1> tid=0x83] Member cc2-rh6(5915)<ec><v10>:1027 is equivalent or in > the same redundancy zone. > [locator][info 2016/06/19 15:28:31.839 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member cc2-rh6(5915)<ec><v10>:1027 is equivalent or in > the same redundancy zone. > [vm_0][info 2016/06/19 15:28:31.841 PDT <Pooled High Priority Message > Processor 1> tid=0xb1] Member cc2-rh6(5915)<ec><v10>:1027 is equivalent or in > the same redundancy zone. > [info 2016/06/19 15:28:31.851 PDT <P2P message reader for > cc2-rh6(5944:locator)<ec><v0>:1024 shared unordered uid=8 port=56292> > tid=0xa1] Member cc2-rh6(5944:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [info 2016/06/19 15:28:31.855 PDT <P2P message reader for > cc2-rh6(5954)<ec><v9>:1026 shared unordered uid=6 port=56294> tid=0xa4] > Member cc2-rh6(5954)<ec><v9>:1026 is equivalent or in the same redundancy > zone. > [info 2016/06/19 15:28:31.856 PDT <P2P message reader for > cc2-rh6(5949)<ec><v8>:1025 shared unordered uid=11 port=56293> tid=0xa5] > Member cc2-rh6(5949)<ec><v8>:1025 is equivalent or in the same redundancy > zone. > [info 2016/06/19 15:28:31.953 PDT <Test worker> tid=0xa] Shutting down > DistributionManager cc2-rh6(5915)<ec><v10>:1027. > [locator][info 2016/06/19 15:28:31.960 PDT <Pooled High Priority Message > Processor 2> tid=0x48] received leave request from > cc2-rh6(5915)<ec><v10>:1027 for cc2-rh6(5915)<ec><v10>:1027 > [vm_0][info 2016/06/19 15:28:31.960 PDT <Pooled High Priority Message > Processor 1> tid=0xb1] received leave request from > cc2-rh6(5915)<ec><v10>:1027 for cc2-rh6(5915)<ec><v10>:1027 > [locator][info 2016/06/19 15:28:31.960 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member at cc2-rh6(5915)<ec><v10>:1027 gracefully left > the distributed cache: shutdown message received > [vm_1][info 2016/06/19 15:28:31.960 PDT <Pooled High Priority Message > Processor 1> tid=0x83] received leave request from > cc2-rh6(5915)<ec><v10>:1027 for cc2-rh6(5915)<ec><v10>:1027 > [vm_1][info 2016/06/19 15:28:31.963 PDT <Pooled High Priority Message > Processor 1> tid=0x83] Member at cc2-rh6(5915)<ec><v10>:1027 gracefully left > the distributed cache: shutdown message received > [vm_0][info 2016/06/19 15:28:31.966 PDT <Pooled High Priority Message > Processor 1> tid=0xb1] Member at cc2-rh6(5915)<ec><v10>:1027 gracefully left > the distributed cache: shutdown message received > [info 2016/06/19 15:28:32.067 PDT <Test worker> tid=0xa] Now closing > distribution for cc2-rh6(5915)<ec><v10>:1027 > [info 2016/06/19 15:28:32.068 PDT <Test worker> tid=0xa] Stopping membership > services > [info 2016/06/19 15:28:32.069 PDT <Test worker> tid=0xa] GMSHealthMonitor > server socket is closed in stopServices(). > [vm_0][info 2016/06/19 15:28:32.070 PDT <unicast receiver,cc2-rh6-38705> > tid=0x9c] received leave request from cc2-rh6(5915)<ec><v10>:1027 for > cc2-rh6(5915)<ec><v10>:1027 > [vm_1][info 2016/06/19 15:28:32.070 PDT <unicast receiver,cc2-rh6-46843> > tid=0x6c] received leave request from cc2-rh6(5915)<ec><v10>:1027 for > cc2-rh6(5915)<ec><v10>:1027 > [info 2016/06/19 15:28:32.070 PDT <Geode Failure Detection Server thread 0> > tid=0x99] GMSHealthMonitor server thread exiting > [info 2016/06/19 15:28:32.071 PDT <Test worker> tid=0xa] GMSHealthMonitor > serverSocketExecutor is terminated > [locator][info 2016/06/19 15:28:32.071 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received leave request from cc2-rh6(5915)<ec><v10>:1027 for > cc2-rh6(5915)<ec><v10>:1027 > [info 2016/06/19 15:28:32.077 PDT <Test worker> tid=0xa] DistributionManager > stopped in 124ms. > [info 2016/06/19 15:28:32.078 PDT <Test worker> tid=0xa] Marking > DistributionManager cc2-rh6(5915)<ec><v10>:1027 as closed. > [vm_0][info 2016/06/19 15:28:32.080 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/65950789.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/65950789@614dfae7 > [vm_0][info 2016/06/19 15:28:32.081 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GemFireCache[id = 1961912102; isClosing = true; isShutDownAll = > false; created = Sun Jun 19 15:28:30 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_0][info 2016/06/19 15:28:32.093 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Shutting down DistributionManager cc2-rh6(5949)<ec><v8>:1025. > [vm_1][info 2016/06/19 15:28:32.095 PDT <Pooled High Priority Message > Processor 1> tid=0x83] received leave request from cc2-rh6(5949)<ec><v8>:1025 > for cc2-rh6(5949)<ec><v8>:1025 > [locator][info 2016/06/19 15:28:32.095 PDT <Pooled High Priority Message > Processor 2> tid=0x48] received leave request from cc2-rh6(5949)<ec><v8>:1025 > for cc2-rh6(5949)<ec><v8>:1025 > [locator][info 2016/06/19 15:28:32.095 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member at cc2-rh6(5949)<ec><v8>:1025 gracefully left > the distributed cache: shutdown message received > [vm_1][info 2016/06/19 15:28:32.095 PDT <Pooled High Priority Message > Processor 1> tid=0x83] Member at cc2-rh6(5949)<ec><v8>:1025 gracefully left > the distributed cache: shutdown message received > [vm_0][info 2016/06/19 15:28:32.197 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Now closing distribution for cc2-rh6(5949)<ec><v8>:1025 > [vm_0][info 2016/06/19 15:28:32.197 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Stopping membership services > [locator][info 2016/06/19 15:28:32.198 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received leave request from cc2-rh6(5949)<ec><v8>:1025 for > cc2-rh6(5949)<ec><v8>:1025 > [vm_1][info 2016/06/19 15:28:32.200 PDT <unicast receiver,cc2-rh6-46843> > tid=0x6c] received leave request from cc2-rh6(5949)<ec><v8>:1025 for > cc2-rh6(5949)<ec><v8>:1025 > [vm_0][info 2016/06/19 15:28:32.200 PDT <Geode Failure Detection Server > thread 0> tid=0xa0] GMSHealthMonitor server thread exiting > [vm_0][info 2016/06/19 15:28:32.200 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GMSHealthMonitor server socket is closed in stopServices(). > [vm_0][info 2016/06/19 15:28:32.201 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GMSHealthMonitor serverSocketExecutor is terminated > [vm_0][info 2016/06/19 15:28:32.207 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] DistributionManager stopped in 114ms. > [vm_0][info 2016/06/19 15:28:32.207 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Marking DistributionManager cc2-rh6(5949)<ec><v8>:1025 as closed. > [vm_0][info 2016/06/19 15:28:32.208 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/65950789.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/65950789@614dfae7 > (took 127 ms) > [vm_1][info 2016/06/19 15:28:32.210 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1264152676.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1264152676@5298f111 > [vm_1][info 2016/06/19 15:28:32.212 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GemFireCache[id = 944893543; isClosing = true; isShutDownAll = > false; created = Sun Jun 19 15:28:31 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_1][info 2016/06/19 15:28:32.224 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Shutting down DistributionManager cc2-rh6(5954)<ec><v9>:1026. > [locator][info 2016/06/19 15:28:32.226 PDT <Pooled High Priority Message > Processor 2> tid=0x48] received leave request from cc2-rh6(5954)<ec><v9>:1026 > for cc2-rh6(5954)<ec><v9>:1026 > [locator][info 2016/06/19 15:28:32.226 PDT <Pooled High Priority Message > Processor 2> tid=0x48] Member at cc2-rh6(5954)<ec><v9>:1026 gracefully left > the distributed cache: shutdown message received > [locator][info 2016/06/19 15:28:32.327 PDT <Geode Membership View Creator> > tid=0x28] View Creator is processing 5 requests for the next membership view > [locator][info 2016/06/19 15:28:32.328 PDT <Geode Membership View Creator> > tid=0x28] received new view: View[cc2-rh6(5944:locator)<ec><v0>:1024|11] > members: [cc2-rh6(5944:locator)<ec><v0>:1024] shutdown: > [cc2-rh6(5954)<ec><v9>:1026, cc2-rh6(5915)<ec><v10>:1027, > cc2-rh6(5949)<ec><v8>:1025] > [locator]old view is: View[cc2-rh6(5944:locator)<ec><v0>:1024|10] members: > [cc2-rh6(5944:locator)<ec><v0>:1024, cc2-rh6(5949)<ec><v8>:1025{lead}, > cc2-rh6(5954)<ec><v9>:1026, cc2-rh6(5915)<ec><v10>:1027] > [locator][info 2016/06/19 15:28:32.328 PDT <Geode Membership View Creator> > tid=0x28] Peer locator received new membership view: > View[cc2-rh6(5944:locator)<ec><v0>:1024|11] members: > [cc2-rh6(5944:locator)<ec><v0>:1024] shutdown: [cc2-rh6(5954)<ec><v9>:1026, > cc2-rh6(5915)<ec><v10>:1027, cc2-rh6(5949)<ec><v8>:1025] > [locator][info 2016/06/19 15:28:32.329 PDT <Geode Membership View Creator> > tid=0x28] no recipients for new view aside from myself > [vm_1][info 2016/06/19 15:28:32.332 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Now closing distribution for cc2-rh6(5954)<ec><v9>:1026 > [vm_1][info 2016/06/19 15:28:32.333 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Stopping membership services > [locator][info 2016/06/19 15:28:32.337 PDT <unicast receiver,cc2-rh6-52901> > tid=0x22] received leave request from cc2-rh6(5954)<ec><v9>:1026 for > cc2-rh6(5954)<ec><v9>:1026 > [vm_1][info 2016/06/19 15:28:32.339 PDT <Geode Failure Detection Server > thread 0> tid=0x70] GMSHealthMonitor server thread exiting > [vm_1][info 2016/06/19 15:28:32.339 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GMSHealthMonitor server socket is closed in stopServices(). > [vm_1][info 2016/06/19 15:28:32.339 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] GMSHealthMonitor serverSocketExecutor is terminated > [vm_1][info 2016/06/19 15:28:32.346 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] DistributionManager stopped in 120ms. > [vm_1][info 2016/06/19 15:28:32.346 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Marking DistributionManager cc2-rh6(5954)<ec><v9>:1026 as closed. > [vm_1][info 2016/06/19 15:28:32.348 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1264152676.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1264152676@5298f111 > (took 136 ms) > [vm_2][info 2016/06/19 15:28:32.350 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1317959256.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1317959256@da54c24 > [vm_2][info 2016/06/19 15:28:32.350 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1317959256.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/1317959256@da54c24 > (took 0 ms) > [vm_3][info 2016/06/19 15:28:32.352 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/993388654.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/993388654@34dceb0c > [vm_3][info 2016/06/19 15:28:32.353 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/993388654.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$3/993388654@34dceb0c > (took 0 ms) > [vm_0][info 2016/06/19 15:28:32.356 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$8/643656740.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$8/643656740@3730e75c > [vm_0][info 2016/06/19 15:28:32.357 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$8/643656740.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$8/643656740@3730e75c > (took 0 ms) > [vm_1][info 2016/06/19 15:28:32.359 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$7/969364915.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$7/969364915@3edc5b31 > [vm_1][info 2016/06/19 15:28:32.360 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$7/969364915.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$7/969364915@3edc5b31 > (took 0 ms) > [vm_2][info 2016/06/19 15:28:32.362 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1571414319.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1571414319@5cc0375f > [vm_2][info 2016/06/19 15:28:32.364 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1571414319.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1571414319@5cc0375f > (took 0 ms) > [vm_3][info 2016/06/19 15:28:32.367 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1408350782.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1408350782@78c65099 > [vm_3][info 2016/06/19 15:28:32.368 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1408350782.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1408350782@78c65099 > (took 0 ms) > [vm_0][info 2016/06/19 15:28:32.371 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1788873322.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1788873322@3889a83f > [vm_0][info 2016/06/19 15:28:32.372 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1788873322.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1788873322@3889a83f > (took 0 ms) > [vm_1][info 2016/06/19 15:28:32.375 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$9/1329139869.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$9/1329139869@4db5910e > [vm_1][info 2016/06/19 15:28:32.376 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$9/1329139869.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$9/1329139869@4db5910e > (took 0 ms) > [vm_2][info 2016/06/19 15:28:32.380 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/544434877.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/544434877@83e6c7c > [vm_2][info 2016/06/19 15:28:32.381 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/544434877.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/544434877@83e6c7c > (took 0 ms) > [vm_3][info 2016/06/19 15:28:32.385 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1581372020.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1581372020@7796a230 > [vm_3][info 2016/06/19 15:28:32.385 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1581372020.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1581372020@7796a230 > (took 0 ms) > [vm_0][info 2016/06/19 15:28:32.388 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$11/792422692.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$11/792422692@45a2d5f3 > [vm_0][info 2016/06/19 15:28:32.388 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$11/792422692.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$11/792422692@45a2d5f3 > (took 0 ms) > [vm_1][info 2016/06/19 15:28:32.390 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1297870790.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1297870790@4ae1b308 > [vm_1][info 2016/06/19 15:28:32.391 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1297870790.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$10/1297870790@4ae1b308 > (took 0 ms) > [vm_2][info 2016/06/19 15:28:32.393 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/619475100.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/619475100@1ff1c03e > [vm_2][info 2016/06/19 15:28:32.394 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/619475100.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/619475100@1ff1c03e > (took 0 ms) > [vm_3][info 2016/06/19 15:28:32.396 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1563933675.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1563933675@db5104b > [vm_3][info 2016/06/19 15:28:32.396 PDT <RMI TCP Connection(2)-10.118.33.92> > tid=0x12] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1563933675.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1563933675@db5104b > (took 0 ms) > [locator][info 2016/06/19 15:28:32.399 PDT <RMI TCP > Connection(2)-10.118.33.92> tid=0x12] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/425457915.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/425457915@19153415 > [locator][info 2016/06/19 15:28:32.399 PDT <RMI TCP > Connection(2)-10.118.33.92> tid=0x12] Got result: null > [locator] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/425457915.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/425457915@19153415 > (took 0 ms) > Eclipse integration is not enabled. Help us localize this page Page > generated: Jun 22, 2016 9:40:19 AM PDTREST APIJenkins ver. 1.646 > Enable Notifications -- This message was sent by Atlassian JIRA (v6.3.4#6332)