You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@geode.apache.org by "Swapnil Bawaskar (JIRA)" <ji...@apache.org> on 2016/10/01 22:23:29 UTC
[jira] [Updated] (GEODE-1710)
CompiledInDUnitTest.whenMultipleTypeBindParameterIsUsedWithInQueryAndMapIndexIsPresentReturnCorrectResults
[ https://issues.apache.org/jira/browse/GEODE-1710?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Swapnil Bawaskar updated GEODE-1710:
------------------------------------
Fix Version/s: 1.0.0-incubating
> CompiledInDUnitTest.whenMultipleTypeBindParameterIsUsedWithInQueryAndMapIndexIsPresentReturnCorrectResults
> ----------------------------------------------------------------------------------------------------------
>
> Key: GEODE-1710
> URL: https://issues.apache.org/jira/browse/GEODE-1710
> Project: Geode
> Issue Type: Bug
> Reporter: Kevin Duling
> Labels: CI
> Fix For: 1.0.0-incubating
>
>
> In Geode_develop_DistributedTests/3430:
> {noformat}
> Error Message
> com.gemstone.gemfire.test.dunit.RMIException: While invoking com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$25.run in VM 1 running on Host kuwait.gemstone.com with 4 VMs
> Stacktrace
> com.gemstone.gemfire.test.dunit.RMIException: While invoking com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$25.run in VM 1 running on Host kuwait.gemstone.com with 4 VMs
> at com.gemstone.gemfire.test.dunit.VM.invoke(VM.java:389)
> at com.gemstone.gemfire.test.dunit.VM.invoke(VM.java:355)
> at com.gemstone.gemfire.test.dunit.VM.invoke(VM.java:293)
> at com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest.whenMultipleTypeBindParameterIsUsedWithInQueryAndMapIndexIsPresentReturnCorrectResults(CompiledInDUnitTest.java:236)
> 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.GeneratedMethodAccessor15.invoke(Unknown Source)
> 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.GeneratedMethodAccessor14.invoke(Unknown Source)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:497)
> at org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
> at org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
> at org.gradle.messaging.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:360)
> at org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54)
> at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.AssertionError: expected:<5> but was:<0>
> at org.junit.Assert.fail(Assert.java:88)
> at org.junit.Assert.failNotEquals(Assert.java:834)
> at org.junit.Assert.assertEquals(Assert.java:645)
> at org.junit.Assert.assertEquals(Assert.java:631)
> at com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest.verifyQuery(CompiledInDUnitTest.java:653)
> at com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$25.run2(CompiledInDUnitTest.java:607)
> at com.gemstone.gemfire.cache30.CacheSerializableRunnable.run(CacheSerializableRunnable.java:60)
> at sun.reflect.GeneratedMethodAccessor158.invoke(Unknown Source)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:497)
> at hydra.MethExecutor.executeObject(MethExecutor.java:268)
> at com.gemstone.gemfire.test.dunit.standalone.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:82)
> at sun.reflect.GeneratedMethodAccessor8.invoke(Unknown Source)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:497)
> at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:323)
> at sun.rmi.transport.Transport$1.run(Transport.java:200)
> at sun.rmi.transport.Transport$1.run(Transport.java:197)
> at java.security.AccessController.doPrivileged(Native Method)
> at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
> at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:568)
> at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:826)
> at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$95(TCPTransport.java:683)
> at java.security.AccessController.doPrivileged(Native Method)
> at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:682)
> ... 3 more
> Standard Output
> Previously run tests: [PRBasicQueryDUnitTest, PRBasicMultiIndexCreationDUnitTest, PRColocatedEquiJoinDUnitTest, PRBasicIndexCreationDUnitTest, PRQueryRegionCloseDUnitTest, PRQueryDUnitTest, PRBasicRemoveIndexDUnitTest, PRQueryRegionDestroyedDUnitTest, PRQueryRemoteNodeExceptionDUnitTest, PRInvalidQueryDUnitTest, PRQueryCacheCloseDUnitTest, CompiledInDUnitTest]
> [vm_0][info 2016/07/28 02:50:23.303 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_0][info 2016/07/28 02:50:23.303 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:23.304 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_1][info 2016/07/28 02:50:23.304 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:23.304 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_2][info 2016/07/28 02:50:23.304 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:23.305 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_3][info 2016/07/28 02:50:23.305 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [setup] START TEST CompiledInDUnitTest.whenUsingAccessorMultipleEnumBindParametersAreUsedWithInQueryInPartitionRegionReturnCorrectResults
> [vm_0][info 2016/07/28 02:50:23.328 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$20.run with 0 args on object: "Create Bridge Server"
> [vm_0]distributed system properties: {locators=localhost[59948], enable-cluster-configuration=false, use-cluster-configuration=false, mcast-port=0, disable-auto-reconnect=true, log-level=info}
> [vm_0][info 2016/07/28 02:50:23.331 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Startup Configuration:
> [vm_0] ### GemFire Properties defined with api ###
> [vm_0]disable-auto-reconnect=true
> [vm_0]enable-cluster-configuration=false
> [vm_0]locators=localhost[59948]
> [vm_0]log-level=info
> [vm_0]mcast-port=0
> [vm_0]use-cluster-configuration=false
> [vm_0]### GemFire Properties using default values ###
> [vm_0]ack-severe-alert-threshold=0
> [vm_0]ack-wait-threshold=15
> [vm_0]archive-disk-space-limit=0
> [vm_0]archive-file-size-limit=0
> [vm_0]async-distribution-timeout=0
> [vm_0]async-max-queue-size=8
> [vm_0]async-queue-timeout=60000
> [vm_0]bind-address=
> [vm_0]cache-xml-file=cache.xml
> [vm_0]cluster-configuration-dir=
> [vm_0]cluster-ssl-ciphers=any
> [vm_0]cluster-ssl-enabled=false
> [vm_0]cluster-ssl-keystore=
> [vm_0]cluster-ssl-keystore-password=
> [vm_0]cluster-ssl-keystore-type=
> [vm_0]cluster-ssl-protocols=any
> [vm_0]cluster-ssl-require-authentication=true
> [vm_0]cluster-ssl-truststore=
> [vm_0]cluster-ssl-truststore-password=
> [vm_0]conflate-events=server
> [vm_0]conserve-sockets=true
> [vm_0]delta-propagation=true
> [vm_0]deploy-working-dir=.
> [vm_0]disable-tcp=false
> [vm_0]distributed-system-id=-1
> [vm_0]distributed-transactions=false
> [vm_0]durable-client-id=
> [vm_0]durable-client-timeout=300
> [vm_0]enable-network-partition-detection=false
> [vm_0]enable-time-statistics=false
> [vm_0]enforce-unique-host=false
> [vm_0]gateway-ssl-ciphers=any
> [vm_0]gateway-ssl-enabled=false
> [vm_0]gateway-ssl-keystore=
> [vm_0]gateway-ssl-keystore-password=
> [vm_0]gateway-ssl-keystore-type=
> [vm_0]gateway-ssl-protocols=any
> [vm_0]gateway-ssl-require-authentication=true
> [vm_0]gateway-ssl-truststore=
> [vm_0]gateway-ssl-truststore-password=
> [vm_0]groups=
> [vm_0]http-service-bind-address=
> [vm_0]http-service-port=7070
> [vm_0]http-service-ssl-ciphers=any
> [vm_0]http-service-ssl-enabled=false
> [vm_0]http-service-ssl-keystore=
> [vm_0]http-service-ssl-keystore-password=
> [vm_0]http-service-ssl-keystore-type=
> [vm_0]http-service-ssl-protocols=any
> [vm_0]http-service-ssl-require-authentication=false
> [vm_0]http-service-ssl-truststore=
> [vm_0]http-service-ssl-truststore-password=
> [vm_0]jmx-manager=false
> [vm_0]jmx-manager-access-file=
> [vm_0]jmx-manager-bind-address=
> [vm_0]jmx-manager-hostname-for-clients=
> [vm_0]jmx-manager-http-port=7070
> [vm_0]jmx-manager-password-file=
> [vm_0]jmx-manager-port=1099
> [vm_0]jmx-manager-ssl=false
> [vm_0]jmx-manager-ssl-ciphers=any
> [vm_0]jmx-manager-ssl-enabled=false
> [vm_0]jmx-manager-ssl-keystore=
> [vm_0]jmx-manager-ssl-keystore-password=
> [vm_0]jmx-manager-ssl-keystore-type=
> [vm_0]jmx-manager-ssl-protocols=any
> [vm_0]jmx-manager-ssl-require-authentication=true
> [vm_0]jmx-manager-ssl-truststore=
> [vm_0]jmx-manager-ssl-truststore-password=
> [vm_0]jmx-manager-start=false
> [vm_0]jmx-manager-update-rate=2000
> [vm_0]load-cluster-configuration-from-dir=false
> [vm_0]locator-wait-time=0
> [vm_0]lock-memory=false
> [vm_0]log-disk-space-limit=0
> [vm_0]log-file=
> [vm_0]log-file-size-limit=0
> [vm_0]max-num-reconnect-tries=3
> [vm_0]max-wait-time-reconnect=60000
> [vm_0]mcast-address=239.192.81.1
> [vm_0]mcast-flow-control=1048576, 0.25, 5000
> [vm_0]mcast-recv-buffer-size=1048576
> [vm_0]mcast-send-buffer-size=65535
> [vm_0]mcast-ttl=32
> [vm_0]member-timeout=5000
> [vm_0]membership-port-range=1024-65535
> [vm_0]memcached-bind-address=
> [vm_0]memcached-port=0
> [vm_0]memcached-protocol=ASCII
> [vm_0]name=
> [vm_0]off-heap-memory-size=
> [vm_0]redis-bind-address=
> [vm_0]redis-password=
> [vm_0]redis-port=0
> [vm_0]redundancy-zone=
> [vm_0]remote-locators=
> [vm_0]remove-unresponsive-client=false
> [vm_0]roles=
> [vm_0]security-client-accessor=
> [vm_0]security-client-accessor-pp=
> [vm_0]security-client-auth-init=
> [vm_0]security-client-authenticator=
> [vm_0]security-client-dhalgo=
> [vm_0]security-log-file=
> [vm_0]security-log-level=config
> [vm_0]security-manager=
> [vm_0]security-peer-auth-init=
> [vm_0]security-peer-authenticator=
> [vm_0]security-peer-verifymember-timeout=1000
> [vm_0]security-post-processor=
> [vm_0]server-bind-address=
> [vm_0]server-ssl-ciphers=any
> [vm_0]server-ssl-enabled=false
> [vm_0]server-ssl-keystore=
> [vm_0]server-ssl-keystore-password=
> [vm_0]server-ssl-keystore-type=
> [vm_0]server-ssl-protocols=any
> [vm_0]server-ssl-require-authentication=true
> [vm_0]server-ssl-truststore=
> [vm_0]server-ssl-truststore-password=
> [vm_0]socket-buffer-size=32768
> [vm_0]socket-lease-time=60000
> [vm_0]ssl-ciphers=any
> [vm_0]ssl-enabled=false
> [vm_0]ssl-protocols=any
> [vm_0]ssl-require-authentication=true
> [vm_0]start-dev-rest-api=false
> [vm_0]start-locator=
> [vm_0]statistic-archive-file=
> [vm_0]statistic-sample-rate=1000
> [vm_0]statistic-sampling-enabled=true
> [vm_0]tcp-port=0
> [vm_0]udp-fragment-size=60000
> [vm_0]udp-recv-buffer-size=1048576
> [vm_0]udp-send-buffer-size=65535
> [vm_0]user-command-packages=
> [vm_0][info 2016/07/28 02:50:23.333 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Starting membership services
> [vm_0][info 2016/07/28 02:50:23.340 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] JGroups channel created (took 7ms)
> [vm_0][info 2016/07/28 02:50:23.341 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GemFire P2P Listener started on null
> [vm_0][info 2016/07/28 02:50:23.342 PDT <Geode Failure Detection Server thread 0> tid=0x11f6] Started failure detection server thread on kuwait.gemstone.com/10.118.32.93:23162.
> [vm_0][info 2016/07/28 02:50:23.343 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Attempting to join the distributed system through coordinator kuwait(9316:locator)<ec><v0>:1024 using address kuwait(9394)<ec>:1025
> [locator][info 2016/07/28 02:50:23.343 PDT <unicast receiver,kuwait-49731> tid=0x2a] received join request from kuwait(9394)<ec>:1025
> [locator][info 2016/07/28 02:50:23.644 PDT <Geode Membership View Creator> tid=0x30] View Creator is processing 1 requests for the next membership view
> [locator][info 2016/07/28 02:50:23.644 PDT <Geode Membership View Creator> tid=0x30] preparing new view View[kuwait(9316:locator)<ec><v0>:1024|265] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}]
> [locator]failure detection ports: 29523 23162
> [vm_0][info 2016/07/28 02:50:23.645 PDT <unicast receiver,kuwait-61886> tid=0x11f2] received new view: View[kuwait(9316:locator)<ec><v0>:1024|265] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}]
> [vm_0]old view is: null
> [locator][info 2016/07/28 02:50:23.645 PDT <Geode Membership View Creator> tid=0x30] finished waiting for responses to view preparation
> [locator][info 2016/07/28 02:50:23.645 PDT <Geode Membership View Creator> tid=0x30] received new view: View[kuwait(9316:locator)<ec><v0>:1024|265] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}]
> [locator]old view is: View[kuwait(9316:locator)<ec><v0>:1024|264] members: [kuwait(9316:locator)<ec><v0>:1024] shutdown: [kuwait(9403)<ec><v263>:1027, kuwait(9394)<ec><v261>:1025, kuwait(9398)<ec><v262>:1026]
> [locator][info 2016/07/28 02:50:23.645 PDT <Geode Membership View Creator> tid=0x30] Peer locator received new membership view: View[kuwait(9316:locator)<ec><v0>:1024|265] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}]
> [vm_0][info 2016/07/28 02:50:23.645 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Finished joining (took 303ms).
> [vm_0][info 2016/07/28 02:50:23.645 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Starting DistributionManager kuwait(9394)<ec><v265>:1025. (took 313 ms)
> [locator][info 2016/07/28 02:50:23.645 PDT <Geode Membership View Creator> tid=0x30] sending new view View[kuwait(9316:locator)<ec><v0>:1024|265] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}]
> [locator]failure detection ports: 29523 23162
> [locator][info 2016/07/28 02:50:23.645 PDT <View Message Processor> tid=0x3c] Membership: Processing addition < kuwait(9394)<ec><v265>:1025 >
> [vm_0][info 2016/07/28 02:50:23.645 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initial (distribution manager) view = View[kuwait(9316:locator)<ec><v0>:1024|265] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}]
> [vm_0][info 2016/07/28 02:50:23.645 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9316:locator)<ec><v0>:1024>. Now there are 1 non-admin member(s).
> [locator][info 2016/07/28 02:50:23.645 PDT <View Message Processor> tid=0x3c] Admitting member <kuwait(9394)<ec><v265>:1025>. Now there are 2 non-admin member(s).
> [vm_0][info 2016/07/28 02:50:23.646 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9394)<ec><v265>:1025>. Now there are 2 non-admin member(s).
> [locator][info 2016/07/28 02:50:23.648 PDT <Pooled High Priority Message Processor 1> tid=0x40] Member kuwait(9394)<ec><v265>:1025 is equivalent or in the same redundancy zone.
> [vm_0][info 2016/07/28 02:50:23.650 PDT <P2P message reader for kuwait(9316:locator)<ec><v0>:1024 shared unordered uid=218 port=45562> tid=0x11fc] Member kuwait(9316:locator)<ec><v0>:1024 is equivalent or in the same redundancy zone.
> [vm_0][info 2016/07/28 02:50:23.659 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _monitoringRegion_10.118.32.93<v265>1025
> [vm_0][info 2016/07/28 02:50:23.659 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _monitoringRegion_10.118.32.93<v265>1025 completed
> [vm_0][info 2016/07/28 02:50:23.662 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] The cache has been created with "use-cluster-configuration=false". It will not receive any cluster configuration
> [vm_0][info 2016/07/28 02:50:23.663 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region PdxTypes
> [vm_0][info 2016/07/28 02:50:23.663 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region PdxTypes completed
> [vm_0][info 2016/07/28 02:50:23.677 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Cache server connection listener bound to address 0.0.0.0/0.0.0.0:57192 with backlog 1,000.
> [vm_0][info 2016/07/28 02:50:23.686 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ClientHealthMonitorThread maximum allowed time between pings: 60,000
> [vm_0][info 2016/07/28 02:50:23.693 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] CacheServer Configuration: port=57192 max-connections=800 max-threads=0 notify-by-subscription=true socket-buffer-size=32768 maximum-time-between-pings=60000 maximum-message-count=230000 message-time-to-live=180 eviction-policy=none capacity=1 overflow directory=. groups=[] loadProbe=ConnectionCountProbe loadPollInterval=5000 tcpNoDelay=true
> [vm_0][info 2016/07/28 02:50:23.702 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region __PR
> [vm_0][info 2016/07/28 02:50:23.703 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region __PR completed
> [vm_0][info 2016/07/28 02:50:23.705 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Partitioned Region /root/PdxTest is born with prId=80 ident:#root#PdxTest
> [vm_0][info 2016/07/28 02:50:23.708 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_17
> [vm_0][info 2016/07/28 02:50:23.708 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_17 completed
> [vm_0][info 2016/07/28 02:50:23.712 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_18
> [vm_0][info 2016/07/28 02:50:23.712 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_18 completed
> [vm_0][info 2016/07/28 02:50:23.713 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_19
> [vm_0][info 2016/07/28 02:50:23.713 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_19 completed
> [vm_0][info 2016/07/28 02:50:23.714 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_0
> [vm_0][info 2016/07/28 02:50:23.714 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_0 completed
> [vm_0][info 2016/07/28 02:50:23.714 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_1
> [vm_0][info 2016/07/28 02:50:23.714 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_1 completed
> [vm_0][info 2016/07/28 02:50:23.715 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_2
> [vm_0][info 2016/07/28 02:50:23.715 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_2 completed
> [vm_0][info 2016/07/28 02:50:23.716 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_3
> [vm_0][info 2016/07/28 02:50:23.716 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_3 completed
> [vm_0][info 2016/07/28 02:50:23.716 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_4
> [vm_0][info 2016/07/28 02:50:23.716 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_4 completed
> [vm_0][info 2016/07/28 02:50:23.717 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_5
> [vm_0][info 2016/07/28 02:50:23.717 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_5 completed
> [vm_0][info 2016/07/28 02:50:23.717 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _B__root_PdxTest_6
> [vm_0][info 2016/07/28 02:50:23.717 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _B__root_PdxTest_6 completed
> [vm_0][info 2016/07/28 02:50:23.718 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$20.run with 0 args on object: "Create Bridge Server" (took 389 ms)
> [vm_1][info 2016/07/28 02:50:23.739 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$27.run with 0 args on object: "Execute Query with Accessor"
> [vm_1]distributed system properties: {locators=localhost[59948], enable-cluster-configuration=false, use-cluster-configuration=false, mcast-port=0, disable-auto-reconnect=true, log-level=info}
> [vm_1][info 2016/07/28 02:50:23.743 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Startup Configuration:
> [vm_1] ### GemFire Properties defined with api ###
> [vm_1]disable-auto-reconnect=true
> [vm_1]enable-cluster-configuration=false
> [vm_1]locators=localhost[59948]
> [vm_1]log-level=info
> [vm_1]mcast-port=0
> [vm_1]use-cluster-configuration=false
> [vm_1]### GemFire Properties using default values ###
> [vm_1]ack-severe-alert-threshold=0
> [vm_1]ack-wait-threshold=15
> [vm_1]archive-disk-space-limit=0
> [vm_1]archive-file-size-limit=0
> [vm_1]async-distribution-timeout=0
> [vm_1]async-max-queue-size=8
> [vm_1]async-queue-timeout=60000
> [vm_1]bind-address=
> [vm_1]cache-xml-file=cache.xml
> [vm_1]cluster-configuration-dir=
> [vm_1]cluster-ssl-ciphers=any
> [vm_1]cluster-ssl-enabled=false
> [vm_1]cluster-ssl-keystore=
> [vm_1]cluster-ssl-keystore-password=
> [vm_1]cluster-ssl-keystore-type=
> [vm_1]cluster-ssl-protocols=any
> [vm_1]cluster-ssl-require-authentication=true
> [vm_1]cluster-ssl-truststore=
> [vm_1]cluster-ssl-truststore-password=
> [vm_1]conflate-events=server
> [vm_1]conserve-sockets=true
> [vm_1]delta-propagation=true
> [vm_1]deploy-working-dir=.
> [vm_1]disable-tcp=false
> [vm_1]distributed-system-id=-1
> [vm_1]distributed-transactions=false
> [vm_1]durable-client-id=
> [vm_1]durable-client-timeout=300
> [vm_1]enable-network-partition-detection=false
> [vm_1]enable-time-statistics=false
> [vm_1]enforce-unique-host=false
> [vm_1]gateway-ssl-ciphers=any
> [vm_1]gateway-ssl-enabled=false
> [vm_1]gateway-ssl-keystore=
> [vm_1]gateway-ssl-keystore-password=
> [vm_1]gateway-ssl-keystore-type=
> [vm_1]gateway-ssl-protocols=any
> [vm_1]gateway-ssl-require-authentication=true
> [vm_1]gateway-ssl-truststore=
> [vm_1]gateway-ssl-truststore-password=
> [vm_1]groups=
> [vm_1]http-service-bind-address=
> [vm_1]http-service-port=7070
> [vm_1]http-service-ssl-ciphers=any
> [vm_1]http-service-ssl-enabled=false
> [vm_1]http-service-ssl-keystore=
> [vm_1]http-service-ssl-keystore-password=
> [vm_1]http-service-ssl-keystore-type=
> [vm_1]http-service-ssl-protocols=any
> [vm_1]http-service-ssl-require-authentication=false
> [vm_1]http-service-ssl-truststore=
> [vm_1]http-service-ssl-truststore-password=
> [vm_1]jmx-manager=false
> [vm_1]jmx-manager-access-file=
> [vm_1]jmx-manager-bind-address=
> [vm_1]jmx-manager-hostname-for-clients=
> [vm_1]jmx-manager-http-port=7070
> [vm_1]jmx-manager-password-file=
> [vm_1]jmx-manager-port=1099
> [vm_1]jmx-manager-ssl=false
> [vm_1]jmx-manager-ssl-ciphers=any
> [vm_1]jmx-manager-ssl-enabled=false
> [vm_1]jmx-manager-ssl-keystore=
> [vm_1]jmx-manager-ssl-keystore-password=
> [vm_1]jmx-manager-ssl-keystore-type=
> [vm_1]jmx-manager-ssl-protocols=any
> [vm_1]jmx-manager-ssl-require-authentication=true
> [vm_1]jmx-manager-ssl-truststore=
> [vm_1]jmx-manager-ssl-truststore-password=
> [vm_1]jmx-manager-start=false
> [vm_1]jmx-manager-update-rate=2000
> [vm_1]load-cluster-configuration-from-dir=false
> [vm_1]locator-wait-time=0
> [vm_1]lock-memory=false
> [vm_1]log-disk-space-limit=0
> [vm_1]log-file=
> [vm_1]log-file-size-limit=0
> [vm_1]max-num-reconnect-tries=3
> [vm_1]max-wait-time-reconnect=60000
> [vm_1]mcast-address=239.192.81.1
> [vm_1]mcast-flow-control=1048576, 0.25, 5000
> [vm_1]mcast-recv-buffer-size=1048576
> [vm_1]mcast-send-buffer-size=65535
> [vm_1]mcast-ttl=32
> [vm_1]member-timeout=5000
> [vm_1]membership-port-range=1024-65535
> [vm_1]memcached-bind-address=
> [vm_1]memcached-port=0
> [vm_1]memcached-protocol=ASCII
> [vm_1]name=
> [vm_1]off-heap-memory-size=
> [vm_1]redis-bind-address=
> [vm_1]redis-password=
> [vm_1]redis-port=0
> [vm_1]redundancy-zone=
> [vm_1]remote-locators=
> [vm_1]remove-unresponsive-client=false
> [vm_1]roles=
> [vm_1]security-client-accessor=
> [vm_1]security-client-accessor-pp=
> [vm_1]security-client-auth-init=
> [vm_1]security-client-authenticator=
> [vm_1]security-client-dhalgo=
> [vm_1]security-log-file=
> [vm_1]security-log-level=config
> [vm_1]security-manager=
> [vm_1]security-peer-auth-init=
> [vm_1]security-peer-authenticator=
> [vm_1]security-peer-verifymember-timeout=1000
> [vm_1]security-post-processor=
> [vm_1]server-bind-address=
> [vm_1]server-ssl-ciphers=any
> [vm_1]server-ssl-enabled=false
> [vm_1]server-ssl-keystore=
> [vm_1]server-ssl-keystore-password=
> [vm_1]server-ssl-keystore-type=
> [vm_1]server-ssl-protocols=any
> [vm_1]server-ssl-require-authentication=true
> [vm_1]server-ssl-truststore=
> [vm_1]server-ssl-truststore-password=
> [vm_1]socket-buffer-size=32768
> [vm_1]socket-lease-time=60000
> [vm_1]ssl-ciphers=any
> [vm_1]ssl-enabled=false
> [vm_1]ssl-protocols=any
> [vm_1]ssl-require-authentication=true
> [vm_1]start-dev-rest-api=false
> [vm_1]start-locator=
> [vm_1]statistic-archive-file=
> [vm_1]statistic-sample-rate=1000
> [vm_1]statistic-sampling-enabled=true
> [vm_1]tcp-port=0
> [vm_1]udp-fragment-size=60000
> [vm_1]udp-recv-buffer-size=1048576
> [vm_1]udp-send-buffer-size=65535
> [vm_1]user-command-packages=
> [vm_1][info 2016/07/28 02:50:23.745 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Starting membership services
> [vm_1][info 2016/07/28 02:50:23.756 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] JGroups channel created (took 11ms)
> [vm_1][info 2016/07/28 02:50:23.757 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GemFire P2P Listener started on null
> [vm_1][info 2016/07/28 02:50:23.758 PDT <Geode Failure Detection Server thread 0> tid=0x1032] Started failure detection server thread on kuwait.gemstone.com/10.118.32.93:64446.
> [vm_1][info 2016/07/28 02:50:23.759 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Attempting to join the distributed system through coordinator kuwait(9316:locator)<ec><v0>:1024 using address kuwait(9398)<ec>:1026
> [locator][info 2016/07/28 02:50:23.759 PDT <unicast receiver,kuwait-49731> tid=0x2a] received join request from kuwait(9398)<ec>:1026
> [locator][info 2016/07/28 02:50:24.060 PDT <Geode Membership View Creator> tid=0x30] View Creator is processing 1 requests for the next membership view
> [locator][info 2016/07/28 02:50:24.060 PDT <Geode Membership View Creator> tid=0x30] preparing new view View[kuwait(9316:locator)<ec><v0>:1024|266] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}, kuwait(9398)<ec><v266>:1026]
> [locator]failure detection ports: 29523 23162 64446
> [vm_1][info 2016/07/28 02:50:24.061 PDT <unicast receiver,kuwait-53260> tid=0x102e] received new view: View[kuwait(9316:locator)<ec><v0>:1024|266] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}, kuwait(9398)<ec><v266>:1026]
> [vm_1]old view is: null
> [locator][info 2016/07/28 02:50:24.061 PDT <Geode Membership View Creator> tid=0x30] finished waiting for responses to view preparation
> [locator][info 2016/07/28 02:50:24.061 PDT <Geode Membership View Creator> tid=0x30] received new view: View[kuwait(9316:locator)<ec><v0>:1024|266] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}, kuwait(9398)<ec><v266>:1026]
> [locator]old view is: View[kuwait(9316:locator)<ec><v0>:1024|265] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}]
> [locator][info 2016/07/28 02:50:24.061 PDT <Geode Membership View Creator> tid=0x30] Peer locator received new membership view: View[kuwait(9316:locator)<ec><v0>:1024|266] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}, kuwait(9398)<ec><v266>:1026]
> [vm_1][info 2016/07/28 02:50:24.061 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Finished joining (took 303ms).
> [vm_1][info 2016/07/28 02:50:24.061 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Starting DistributionManager kuwait(9398)<ec><v266>:1026. (took 317 ms)
> [locator][info 2016/07/28 02:50:24.061 PDT <Geode Membership View Creator> tid=0x30] sending new view View[kuwait(9316:locator)<ec><v0>:1024|266] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}, kuwait(9398)<ec><v266>:1026]
> [locator]failure detection ports: 29523 23162 64446
> [vm_1][info 2016/07/28 02:50:24.061 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initial (distribution manager) view = View[kuwait(9316:locator)<ec><v0>:1024|266] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}, kuwait(9398)<ec><v266>:1026]
> [vm_1][info 2016/07/28 02:50:24.062 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9316:locator)<ec><v0>:1024>. Now there are 1 non-admin member(s).
> [locator][info 2016/07/28 02:50:24.062 PDT <View Message Processor> tid=0x3c] Membership: Processing addition < kuwait(9398)<ec><v266>:1026 >
> [vm_1][info 2016/07/28 02:50:24.062 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9394)<ec><v265>:1025>. Now there are 2 non-admin member(s).
> [vm_1][info 2016/07/28 02:50:24.062 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9398)<ec><v266>:1026>. Now there are 3 non-admin member(s).
> [vm_0][info 2016/07/28 02:50:24.062 PDT <unicast receiver,kuwait-61886> tid=0x11f2] received new view: View[kuwait(9316:locator)<ec><v0>:1024|266] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}, kuwait(9398)<ec><v266>:1026]
> [vm_0]old view is: View[kuwait(9316:locator)<ec><v0>:1024|265] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v265>:1025{lead}]
> [locator][info 2016/07/28 02:50:24.062 PDT <View Message Processor> tid=0x3c] Admitting member <kuwait(9398)<ec><v266>:1026>. Now there are 3 non-admin member(s).
> [vm_0][info 2016/07/28 02:50:24.062 PDT <View Message Processor> tid=0x1210] Membership: Processing addition < kuwait(9398)<ec><v266>:1026 >
> [vm_0][info 2016/07/28 02:50:24.062 PDT <View Message Processor> tid=0x1210] Admitting member <kuwait(9398)<ec><v266>:1026>. Now there are 3 non-admin member(s).
> [vm_0][info 2016/07/28 02:50:24.065 PDT <Pooled High Priority Message Processor 1> tid=0x1207] Member kuwait(9398)<ec><v266>:1026 is equivalent or in the same redundancy zone.
> [locator][info 2016/07/28 02:50:24.065 PDT <Pooled High Priority Message Processor 1> tid=0x40] Member kuwait(9398)<ec><v266>:1026 is equivalent or in the same redundancy zone.
> [vm_1][info 2016/07/28 02:50:24.067 PDT <P2P message reader for kuwait(9394)<ec><v265>:1025 shared unordered uid=339 port=55947> tid=0x103a] Member kuwait(9394)<ec><v265>:1025 is equivalent or in the same redundancy zone.
> [vm_1][info 2016/07/28 02:50:24.068 PDT <P2P message reader for kuwait(9316:locator)<ec><v0>:1024 shared unordered uid=219 port=55948> tid=0x103b] Member kuwait(9316:locator)<ec><v0>:1024 is equivalent or in the same redundancy zone.
> [vm_1][info 2016/07/28 02:50:24.077 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _monitoringRegion_10.118.32.93<v266>1026
> [vm_1][info 2016/07/28 02:50:24.078 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _monitoringRegion_10.118.32.93<v266>1026 completed
> [vm_1][info 2016/07/28 02:50:24.081 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] The cache has been created with "use-cluster-configuration=false". It will not receive any cluster configuration
> [vm_1][info 2016/07/28 02:50:24.081 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region PdxTypes
> [vm_1][info 2016/07/28 02:50:24.083 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Region PdxTypes requesting initial image from kuwait(9394)<ec><v265>:1025
> [vm_1][info 2016/07/28 02:50:24.083 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] PdxTypes is done getting image from kuwait(9394)<ec><v265>:1025. isDeltaGII is false
> [vm_1][info 2016/07/28 02:50:24.083 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region PdxTypes completed
> [vm_1][info 2016/07/28 02:50:24.098 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Cache server connection listener bound to address 0.0.0.0/0.0.0.0:33410 with backlog 1,000.
> [vm_1][info 2016/07/28 02:50:24.107 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ClientHealthMonitorThread maximum allowed time between pings: 60,000
> [vm_1][info 2016/07/28 02:50:24.113 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] CacheServer Configuration: port=33410 max-connections=800 max-threads=0 notify-by-subscription=true socket-buffer-size=32768 maximum-time-between-pings=60000 maximum-message-count=230000 message-time-to-live=180 eviction-policy=none capacity=1 overflow directory=. groups=[] loadProbe=ConnectionCountProbe loadPollInterval=5000 tcpNoDelay=true
> [vm_1][info 2016/07/28 02:50:24.123 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region __PR
> [vm_1][info 2016/07/28 02:50:24.124 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Region __PR requesting initial image from kuwait(9394)<ec><v265>:1025
> [vm_1][info 2016/07/28 02:50:24.126 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] __PR is done getting image from kuwait(9394)<ec><v265>:1025. isDeltaGII is false
> [vm_1][info 2016/07/28 02:50:24.126 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region __PR completed
> [vm_1][info 2016/07/28 02:50:24.128 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Partitioned Region /root/PdxTest is created with prId=80
> [vm_0][info 2016/07/28 02:50:24.136 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_7
> [vm_0][info 2016/07/28 02:50:24.136 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_7 completed
> [vm_0][info 2016/07/28 02:50:24.139 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_8
> [vm_0][info 2016/07/28 02:50:24.139 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_8 completed
> [vm_0][info 2016/07/28 02:50:24.140 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_9
> [vm_0][info 2016/07/28 02:50:24.140 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_9 completed
> [vm_0][info 2016/07/28 02:50:24.141 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_10
> [vm_0][info 2016/07/28 02:50:24.141 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_10 completed
> [vm_0][info 2016/07/28 02:50:24.142 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_11
> [vm_0][info 2016/07/28 02:50:24.142 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_11 completed
> [vm_0][info 2016/07/28 02:50:24.143 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_12
> [vm_0][info 2016/07/28 02:50:24.143 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_12 completed
> [vm_0][info 2016/07/28 02:50:24.144 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_13
> [vm_0][info 2016/07/28 02:50:24.144 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_13 completed
> [vm_0][info 2016/07/28 02:50:24.145 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_14
> [vm_0][info 2016/07/28 02:50:24.145 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_14 completed
> [vm_0][info 2016/07/28 02:50:24.146 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_15
> [vm_0][info 2016/07/28 02:50:24.146 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_15 completed
> [vm_0][info 2016/07/28 02:50:24.147 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initializing region _B__root_PdxTest_16
> [vm_0][info 2016/07/28 02:50:24.147 PDT <Pooled Waiting Message Processor 0> tid=0x11f9] Initialization of region _B__root_PdxTest_16 completed
> [vm_1][info 2016/07/28 02:50:24.161 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$27.run with 0 args on object: "Execute Query with Accessor" (took 421 ms)
> [vm_0][info 2016/07/28 02:50:24.166 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client"
> [vm_0][info 2016/07/28 02:50:24.166 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ### Close Client. ###
> [vm_0][info 2016/07/28 02:50:24.166 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GemFireCache[id = 803231187; isClosing = true; isShutDownAll = false; created = Thu Jul 28 02:50:23 PDT 2016; server = false; copyOnRead = false; lockLease = 120; lockTimeout = 60]: Now closing.
> [vm_0][info 2016/07/28 02:50:24.169 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Cache server on port 57,192 is shutting down.
> [vm_0]238.327: [GC (Allocation Failure) [PSYoungGen: 145279K->4463K(148480K)] 237168K->96360K(498176K), 0.0075062 secs] [Times: user=0.03 sys=0.00, real=0.01 secs]
> [vm_0][info 2016/07/28 02:50:24.188 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Shutting down DistributionManager kuwait(9394)<ec><v265>:1025.
> [vm_1][info 2016/07/28 02:50:24.189 PDT <Pooled High Priority Message Processor 1> tid=0x1046] received leave request from kuwait(9394)<ec><v265>:1025 for kuwait(9394)<ec><v265>:1025
> [locator][info 2016/07/28 02:50:24.189 PDT <Pooled High Priority Message Processor 1> tid=0x40] received leave request from kuwait(9394)<ec><v265>:1025 for kuwait(9394)<ec><v265>:1025
> [vm_1][info 2016/07/28 02:50:24.189 PDT <Pooled High Priority Message Processor 1> tid=0x1046] Member at kuwait(9394)<ec><v265>:1025 gracefully left the distributed cache: shutdown message received
> [locator][info 2016/07/28 02:50:24.189 PDT <Pooled High Priority Message Processor 1> tid=0x40] Member at kuwait(9394)<ec><v265>:1025 gracefully left the distributed cache: shutdown message received
> [vm_0][info 2016/07/28 02:50:24.289 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Now closing distribution for kuwait(9394)<ec><v265>:1025
> [vm_0][info 2016/07/28 02:50:24.290 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Stopping membership services
> [locator][info 2016/07/28 02:50:24.290 PDT <unicast receiver,kuwait-49731> tid=0x2a] received leave request from kuwait(9394)<ec><v265>:1025 for kuwait(9394)<ec><v265>:1025
> [vm_1][info 2016/07/28 02:50:24.290 PDT <unicast receiver,kuwait-53260> tid=0x102e] received leave request from kuwait(9394)<ec><v265>:1025 for kuwait(9394)<ec><v265>:1025
> [vm_0][info 2016/07/28 02:50:24.290 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GMSHealthMonitor server socket is closed in stopServices().
> [vm_0][info 2016/07/28 02:50:24.291 PDT <Geode Failure Detection Server thread 0> tid=0x11f6] GMSHealthMonitor server thread exiting
> [vm_0][info 2016/07/28 02:50:24.291 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GMSHealthMonitor serverSocketExecutor is terminated
> [vm_0][info 2016/07/28 02:50:24.295 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] DistributionManager stopped in 106ms.
> [vm_0][info 2016/07/28 02:50:24.295 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Marking DistributionManager kuwait(9394)<ec><v265>:1025 as closed.
> [vm_0][info 2016/07/28 02:50:24.295 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client" (took 129 ms)
> [vm_1][info 2016/07/28 02:50:24.299 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client"
> [vm_1][info 2016/07/28 02:50:24.299 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ### Close Client. ###
> [vm_1][info 2016/07/28 02:50:24.300 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GemFireCache[id = 1247209337; isClosing = true; isShutDownAll = false; created = Thu Jul 28 02:50:24 PDT 2016; server = false; copyOnRead = false; lockLease = 120; lockTimeout = 60]: Now closing.
> [vm_1][info 2016/07/28 02:50:24.301 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Cache server on port 33,410 is shutting down.
> [vm_1][info 2016/07/28 02:50:24.306 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Shutting down DistributionManager kuwait(9398)<ec><v266>:1026.
> [locator][info 2016/07/28 02:50:24.307 PDT <Pooled High Priority Message Processor 1> tid=0x40] received leave request from kuwait(9398)<ec><v266>:1026 for kuwait(9398)<ec><v266>:1026
> [locator][info 2016/07/28 02:50:24.307 PDT <Pooled High Priority Message Processor 1> tid=0x40] Member at kuwait(9398)<ec><v266>:1026 gracefully left the distributed cache: shutdown message received
> [vm_1][info 2016/07/28 02:50:24.407 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Now closing distribution for kuwait(9398)<ec><v266>:1026
> [vm_1][info 2016/07/28 02:50:24.407 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Stopping membership services
> [locator][info 2016/07/28 02:50:24.408 PDT <unicast receiver,kuwait-49731> tid=0x2a] received leave request from kuwait(9398)<ec><v266>:1026 for kuwait(9398)<ec><v266>:1026
> [vm_1][info 2016/07/28 02:50:24.408 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GMSHealthMonitor server socket is closed in stopServices().
> [vm_1][info 2016/07/28 02:50:24.408 PDT <Geode Failure Detection Server thread 0> tid=0x1032] GMSHealthMonitor server thread exiting
> [vm_1][info 2016/07/28 02:50:24.408 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GMSHealthMonitor serverSocketExecutor is terminated
> [vm_1][info 2016/07/28 02:50:24.411 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] DistributionManager stopped in 105ms.
> [vm_1][info 2016/07/28 02:50:24.411 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Marking DistributionManager kuwait(9398)<ec><v266>:1026 as closed.
> [vm_1][info 2016/07/28 02:50:24.412 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client" (took 113 ms)
> [vm_3][info 2016/07/28 02:50:24.431 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client"
> [vm_3][info 2016/07/28 02:50:24.432 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ### Close Client. ###
> [vm_3][info 2016/07/28 02:50:24.432 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client" (took 0 ms)
> [vm_0][info 2016/07/28 02:50:24.433 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657@15e89968
> [vm_0][info 2016/07/28 02:50:24.433 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657@15e89968 (took 0 ms)
> [vm_1][info 2016/07/28 02:50:24.434 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645@7359ff91
> [vm_1][info 2016/07/28 02:50:24.434 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645@7359ff91 (took 0 ms)
> [vm_2][info 2016/07/28 02:50:24.435 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274@10e1b131
> [vm_2][info 2016/07/28 02:50:24.435 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274@10e1b131 (took 0 ms)
> [vm_3][info 2016/07/28 02:50:24.435 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395@5f79c56b
> [vm_3][info 2016/07/28 02:50:24.436 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395@5f79c56b (took 0 ms)
> [vm_0][info 2016/07/28 02:50:24.436 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_0][info 2016/07/28 02:50:24.436 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:24.437 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_1][info 2016/07/28 02:50:24.437 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:24.437 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_2][info 2016/07/28 02:50:24.437 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:24.438 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_3][info 2016/07/28 02:50:24.438 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_0][info 2016/07/28 02:50:24.438 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_0][info 2016/07/28 02:50:24.438 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:24.439 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_1][info 2016/07/28 02:50:24.439 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:24.439 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_2][info 2016/07/28 02:50:24.440 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:24.440 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_3][info 2016/07/28 02:50:24.440 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [locator][info 2016/07/28 02:50:24.441 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608.run with 0 args on object: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608@fe46a45
> [locator][info 2016/07/28 02:50:24.441 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [locator] from com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608.run with 0 args on object: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608@fe46a45 (took 0 ms)
> Previously run tests: [PRBasicQueryDUnitTest, PRBasicMultiIndexCreationDUnitTest, PRColocatedEquiJoinDUnitTest, PRBasicIndexCreationDUnitTest, PRQueryRegionCloseDUnitTest, PRQueryDUnitTest, PRBasicRemoveIndexDUnitTest, PRQueryRegionDestroyedDUnitTest, PRQueryRemoteNodeExceptionDUnitTest, PRInvalidQueryDUnitTest, PRQueryCacheCloseDUnitTest, CompiledInDUnitTest]
> [vm_0][info 2016/07/28 02:50:24.442 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_0][info 2016/07/28 02:50:24.443 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:24.443 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_1][info 2016/07/28 02:50:24.443 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:24.443 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_2][info 2016/07/28 02:50:24.443 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:24.444 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_3][info 2016/07/28 02:50:24.444 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [setup] START TEST CompiledInDUnitTest.whenMultipleTypeBindParameterIsUsedWithInQueryAndMapIndexIsPresentReturnCorrectResults
> [vm_0][info 2016/07/28 02:50:24.447 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$6.run with 0 args on object: "Create Bridge Server"
> [vm_0]distributed system properties: {locators=localhost[59948], enable-cluster-configuration=false, use-cluster-configuration=false, mcast-port=0, disable-auto-reconnect=true, log-level=info}
> [vm_0][info 2016/07/28 02:50:24.450 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Startup Configuration:
> [vm_0] ### GemFire Properties defined with api ###
> [vm_0]disable-auto-reconnect=true
> [vm_0]enable-cluster-configuration=false
> [vm_0]locators=localhost[59948]
> [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]distri
> ...[truncated 916333 chars]...
> tionManager kuwait(9398)<ec><v307>:1026 as closed.
> [vm_1][info 2016/07/28 02:50:40.141 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client" (took 110 ms)
> [vm_3][info 2016/07/28 02:50:40.142 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client"
> [vm_3][info 2016/07/28 02:50:40.142 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ### Close Client. ###
> [vm_3][info 2016/07/28 02:50:40.142 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client" (took 0 ms)
> [vm_0][info 2016/07/28 02:50:40.143 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657@15e89968
> [vm_0][info 2016/07/28 02:50:40.143 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657@15e89968 (took 0 ms)
> [vm_1][info 2016/07/28 02:50:40.144 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645@7359ff91
> [vm_1][info 2016/07/28 02:50:40.144 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645@7359ff91 (took 0 ms)
> [vm_2][info 2016/07/28 02:50:40.145 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274@10e1b131
> [vm_2][info 2016/07/28 02:50:40.145 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274@10e1b131 (took 0 ms)
> [vm_3][info 2016/07/28 02:50:40.146 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395@5f79c56b
> [vm_3][info 2016/07/28 02:50:40.146 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395@5f79c56b (took 0 ms)
> [vm_0][info 2016/07/28 02:50:40.146 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_0][info 2016/07/28 02:50:40.146 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:40.147 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_1][info 2016/07/28 02:50:40.147 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:40.147 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_2][info 2016/07/28 02:50:40.147 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:40.147 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_3][info 2016/07/28 02:50:40.147 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_0][info 2016/07/28 02:50:40.148 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_0][info 2016/07/28 02:50:40.148 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:40.148 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_1][info 2016/07/28 02:50:40.148 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:40.149 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_2][info 2016/07/28 02:50:40.149 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:40.149 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_3][info 2016/07/28 02:50:40.149 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [locator][info 2016/07/28 02:50:40.150 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608.run with 0 args on object: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608@fe46a45
> [locator][info 2016/07/28 02:50:40.150 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [locator] from com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608.run with 0 args on object: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608@fe46a45 (took 0 ms)
> Previously run tests: [PRBasicQueryDUnitTest, PRBasicMultiIndexCreationDUnitTest, PRColocatedEquiJoinDUnitTest, PRBasicIndexCreationDUnitTest, PRQueryRegionCloseDUnitTest, PRQueryDUnitTest, PRBasicRemoveIndexDUnitTest, PRQueryRegionDestroyedDUnitTest, PRQueryRemoteNodeExceptionDUnitTest, PRInvalidQueryDUnitTest, PRQueryCacheCloseDUnitTest, CompiledInDUnitTest]
> [vm_0][info 2016/07/28 02:50:40.151 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_0][info 2016/07/28 02:50:40.151 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:40.152 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_1][info 2016/07/28 02:50:40.152 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:40.152 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_2][info 2016/07/28 02:50:40.152 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:40.152 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM)
> [vm_3][info 2016/07/28 02:50:40.152 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(setupVM) (took 0 ms)
> [setup] START TEST CompiledInDUnitTest.whenEnumBindArgumentIsMatchedInSetWithIteratingFieldShouldReturnResults
> [vm_0][info 2016/07/28 02:50:40.156 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$12.run with 0 args on object: "Create Bridge Server"
> [vm_0]distributed system properties: {locators=localhost[59948], enable-cluster-configuration=false, use-cluster-configuration=false, mcast-port=0, disable-auto-reconnect=true, log-level=info}
> [vm_0][info 2016/07/28 02:50:40.158 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Startup Configuration:
> [vm_0] ### GemFire Properties defined with api ###
> [vm_0]disable-auto-reconnect=true
> [vm_0]enable-cluster-configuration=false
> [vm_0]locators=localhost[59948]
> [vm_0]log-level=info
> [vm_0]mcast-port=0
> [vm_0]use-cluster-configuration=false
> [vm_0]### GemFire Properties using default values ###
> [vm_0]ack-severe-alert-threshold=0
> [vm_0]ack-wait-threshold=15
> [vm_0]archive-disk-space-limit=0
> [vm_0]archive-file-size-limit=0
> [vm_0]async-distribution-timeout=0
> [vm_0]async-max-queue-size=8
> [vm_0]async-queue-timeout=60000
> [vm_0]bind-address=
> [vm_0]cache-xml-file=cache.xml
> [vm_0]cluster-configuration-dir=
> [vm_0]cluster-ssl-ciphers=any
> [vm_0]cluster-ssl-enabled=false
> [vm_0]cluster-ssl-keystore=
> [vm_0]cluster-ssl-keystore-password=
> [vm_0]cluster-ssl-keystore-type=
> [vm_0]cluster-ssl-protocols=any
> [vm_0]cluster-ssl-require-authentication=true
> [vm_0]cluster-ssl-truststore=
> [vm_0]cluster-ssl-truststore-password=
> [vm_0]conflate-events=server
> [vm_0]conserve-sockets=true
> [vm_0]delta-propagation=true
> [vm_0]deploy-working-dir=.
> [vm_0]disable-tcp=false
> [vm_0]distributed-system-id=-1
> [vm_0]distributed-transactions=false
> [vm_0]durable-client-id=
> [vm_0]durable-client-timeout=300
> [vm_0]enable-network-partition-detection=false
> [vm_0]enable-time-statistics=false
> [vm_0]enforce-unique-host=false
> [vm_0]gateway-ssl-ciphers=any
> [vm_0]gateway-ssl-enabled=false
> [vm_0]gateway-ssl-keystore=
> [vm_0]gateway-ssl-keystore-password=
> [vm_0]gateway-ssl-keystore-type=
> [vm_0]gateway-ssl-protocols=any
> [vm_0]gateway-ssl-require-authentication=true
> [vm_0]gateway-ssl-truststore=
> [vm_0]gateway-ssl-truststore-password=
> [vm_0]groups=
> [vm_0]http-service-bind-address=
> [vm_0]http-service-port=7070
> [vm_0]http-service-ssl-ciphers=any
> [vm_0]http-service-ssl-enabled=false
> [vm_0]http-service-ssl-keystore=
> [vm_0]http-service-ssl-keystore-password=
> [vm_0]http-service-ssl-keystore-type=
> [vm_0]http-service-ssl-protocols=any
> [vm_0]http-service-ssl-require-authentication=false
> [vm_0]http-service-ssl-truststore=
> [vm_0]http-service-ssl-truststore-password=
> [vm_0]jmx-manager=false
> [vm_0]jmx-manager-access-file=
> [vm_0]jmx-manager-bind-address=
> [vm_0]jmx-manager-hostname-for-clients=
> [vm_0]jmx-manager-http-port=7070
> [vm_0]jmx-manager-password-file=
> [vm_0]jmx-manager-port=1099
> [vm_0]jmx-manager-ssl=false
> [vm_0]jmx-manager-ssl-ciphers=any
> [vm_0]jmx-manager-ssl-enabled=false
> [vm_0]jmx-manager-ssl-keystore=
> [vm_0]jmx-manager-ssl-keystore-password=
> [vm_0]jmx-manager-ssl-keystore-type=
> [vm_0]jmx-manager-ssl-protocols=any
> [vm_0]jmx-manager-ssl-require-authentication=true
> [vm_0]jmx-manager-ssl-truststore=
> [vm_0]jmx-manager-ssl-truststore-password=
> [vm_0]jmx-manager-start=false
> [vm_0]jmx-manager-update-rate=2000
> [vm_0]load-cluster-configuration-from-dir=false
> [vm_0]locator-wait-time=0
> [vm_0]lock-memory=false
> [vm_0]log-disk-space-limit=0
> [vm_0]log-file=
> [vm_0]log-file-size-limit=0
> [vm_0]max-num-reconnect-tries=3
> [vm_0]max-wait-time-reconnect=60000
> [vm_0]mcast-address=239.192.81.1
> [vm_0]mcast-flow-control=1048576, 0.25, 5000
> [vm_0]mcast-recv-buffer-size=1048576
> [vm_0]mcast-send-buffer-size=65535
> [vm_0]mcast-ttl=32
> [vm_0]member-timeout=5000
> [vm_0]membership-port-range=1024-65535
> [vm_0]memcached-bind-address=
> [vm_0]memcached-port=0
> [vm_0]memcached-protocol=ASCII
> [vm_0]name=
> [vm_0]off-heap-memory-size=
> [vm_0]redis-bind-address=
> [vm_0]redis-password=
> [vm_0]redis-port=0
> [vm_0]redundancy-zone=
> [vm_0]remote-locators=
> [vm_0]remove-unresponsive-client=false
> [vm_0]roles=
> [vm_0]security-client-accessor=
> [vm_0]security-client-accessor-pp=
> [vm_0]security-client-auth-init=
> [vm_0]security-client-authenticator=
> [vm_0]security-client-dhalgo=
> [vm_0]security-log-file=
> [vm_0]security-log-level=config
> [vm_0]security-manager=
> [vm_0]security-peer-auth-init=
> [vm_0]security-peer-authenticator=
> [vm_0]security-peer-verifymember-timeout=1000
> [vm_0]security-post-processor=
> [vm_0]server-bind-address=
> [vm_0]server-ssl-ciphers=any
> [vm_0]server-ssl-enabled=false
> [vm_0]server-ssl-keystore=
> [vm_0]server-ssl-keystore-password=
> [vm_0]server-ssl-keystore-type=
> [vm_0]server-ssl-protocols=any
> [vm_0]server-ssl-require-authentication=true
> [vm_0]server-ssl-truststore=
> [vm_0]server-ssl-truststore-password=
> [vm_0]socket-buffer-size=32768
> [vm_0]socket-lease-time=60000
> [vm_0]ssl-ciphers=any
> [vm_0]ssl-enabled=false
> [vm_0]ssl-protocols=any
> [vm_0]ssl-require-authentication=true
> [vm_0]start-dev-rest-api=false
> [vm_0]start-locator=
> [vm_0]statistic-archive-file=
> [vm_0]statistic-sample-rate=1000
> [vm_0]statistic-sampling-enabled=true
> [vm_0]tcp-port=0
> [vm_0]udp-fragment-size=60000
> [vm_0]udp-recv-buffer-size=1048576
> [vm_0]udp-send-buffer-size=65535
> [vm_0]user-command-packages=
> [vm_0][info 2016/07/28 02:50:40.160 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Starting membership services
> [vm_0][info 2016/07/28 02:50:40.167 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] JGroups channel created (took 7ms)
> [vm_0][info 2016/07/28 02:50:40.169 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GemFire P2P Listener started on null
> [vm_0][info 2016/07/28 02:50:40.169 PDT <Geode Failure Detection Server thread 0> tid=0x16a3] Started failure detection server thread on kuwait.gemstone.com/10.118.32.93:29082.
> [vm_0][info 2016/07/28 02:50:40.170 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Attempting to join the distributed system through coordinator kuwait(9316:locator)<ec><v0>:1024 using address kuwait(9394)<ec>:1025
> [locator][info 2016/07/28 02:50:40.171 PDT <unicast receiver,kuwait-49731> tid=0x2a] received join request from kuwait(9394)<ec>:1025
> [locator][info 2016/07/28 02:50:40.271 PDT <Geode Membership View Creator> tid=0x30] View Creator is processing 5 requests for the next membership view
> [locator][info 2016/07/28 02:50:40.271 PDT <Geode Membership View Creator> tid=0x30] preparing new view View[kuwait(9316:locator)<ec><v0>:1024|308] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}] shutdown: [kuwait(9394)<ec><v306>:1025, kuwait(9398)<ec><v307>:1026]
> [locator]failure detection ports: 29523 29082
> [vm_0][info 2016/07/28 02:50:40.272 PDT <unicast receiver,kuwait-6440> tid=0x169f] received new view: View[kuwait(9316:locator)<ec><v0>:1024|308] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}] shutdown: [kuwait(9394)<ec><v306>:1025, kuwait(9398)<ec><v307>:1026]
> [vm_0]old view is: null
> [locator][info 2016/07/28 02:50:40.272 PDT <Geode Membership View Creator> tid=0x30] finished waiting for responses to view preparation
> [locator][info 2016/07/28 02:50:40.272 PDT <Geode Membership View Creator> tid=0x30] received new view: View[kuwait(9316:locator)<ec><v0>:1024|308] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}] shutdown: [kuwait(9394)<ec><v306>:1025, kuwait(9398)<ec><v307>:1026]
> [locator]old view is: View[kuwait(9316:locator)<ec><v0>:1024|307] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v306>:1025{lead}, kuwait(9398)<ec><v307>:1026]
> [locator][info 2016/07/28 02:50:40.272 PDT <Geode Membership View Creator> tid=0x30] Peer locator received new membership view: View[kuwait(9316:locator)<ec><v0>:1024|308] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}] shutdown: [kuwait(9394)<ec><v306>:1025, kuwait(9398)<ec><v307>:1026]
> [vm_0][info 2016/07/28 02:50:40.272 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Finished joining (took 103ms).
> [vm_0][info 2016/07/28 02:50:40.272 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Starting DistributionManager kuwait(9394)<ec><v308>:1025. (took 113 ms)
> [vm_0][info 2016/07/28 02:50:40.272 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initial (distribution manager) view = View[kuwait(9316:locator)<ec><v0>:1024|308] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}] shutdown: [kuwait(9394)<ec><v306>:1025, kuwait(9398)<ec><v307>:1026]
> [locator][info 2016/07/28 02:50:40.272 PDT <Geode Membership View Creator> tid=0x30] sending new view View[kuwait(9316:locator)<ec><v0>:1024|308] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}] shutdown: [kuwait(9394)<ec><v306>:1025, kuwait(9398)<ec><v307>:1026]
> [locator]failure detection ports: 29523 29082
> [locator][info 2016/07/28 02:50:40.272 PDT <View Message Processor> tid=0x3c] Membership: Processing addition < kuwait(9394)<ec><v308>:1025 >
> [vm_0][info 2016/07/28 02:50:40.272 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9316:locator)<ec><v0>:1024>. Now there are 1 non-admin member(s).
> [vm_0][info 2016/07/28 02:50:40.272 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9394)<ec><v308>:1025>. Now there are 2 non-admin member(s).
> [locator][info 2016/07/28 02:50:40.272 PDT <View Message Processor> tid=0x3c] Admitting member <kuwait(9394)<ec><v308>:1025>. Now there are 2 non-admin member(s).
> [locator][info 2016/07/28 02:50:40.274 PDT <Pooled High Priority Message Processor 2> tid=0x11a] Member kuwait(9394)<ec><v308>:1025 is equivalent or in the same redundancy zone.
> [vm_0][info 2016/07/28 02:50:40.276 PDT <P2P message reader for kuwait(9316:locator)<ec><v0>:1024 shared unordered uid=260 port=45099> tid=0x16a8] Member kuwait(9316:locator)<ec><v0>:1024 is equivalent or in the same redundancy zone.
> [vm_0][info 2016/07/28 02:50:40.284 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _monitoringRegion_10.118.32.93<v308>1025
> [vm_0][info 2016/07/28 02:50:40.285 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _monitoringRegion_10.118.32.93<v308>1025 completed
> [vm_0][info 2016/07/28 02:50:40.288 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] The cache has been created with "use-cluster-configuration=false". It will not receive any cluster configuration
> [vm_0][info 2016/07/28 02:50:40.289 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region PdxTypes
> [vm_0][info 2016/07/28 02:50:40.289 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region PdxTypes completed
> [vm_0][info 2016/07/28 02:50:40.291 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Cache server connection listener bound to address 0.0.0.0/0.0.0.0:58560 with backlog 1,000.
> [vm_0][info 2016/07/28 02:50:40.291 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ClientHealthMonitorThread maximum allowed time between pings: 60,000
> [vm_0][info 2016/07/28 02:50:40.292 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] CacheServer Configuration: port=58560 max-connections=800 max-threads=0 notify-by-subscription=true socket-buffer-size=32768 maximum-time-between-pings=60000 maximum-message-count=230000 message-time-to-live=180 eviction-policy=none capacity=1 overflow directory=. groups=[] loadProbe=ConnectionCountProbe loadPollInterval=5000 tcpNoDelay=true
> [vm_0][info 2016/07/28 02:50:40.293 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region root
> [vm_0][info 2016/07/28 02:50:40.293 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region root completed
> [vm_0][info 2016/07/28 02:50:40.294 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region PdxTest
> [vm_0][info 2016/07/28 02:50:40.294 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region PdxTest completed
> [vm_0][info 2016/07/28 02:50:40.295 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Using Compact Map Range index implementation for 'myIndex' on region /root/PdxTest
> [vm_0][info 2016/07/28 02:50:40.295 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialized and loaded entries into the index
> [vm_0][info 2016/07/28 02:50:40.296 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$12.run with 0 args on object: "Create Bridge Server" (took 139 ms)
> [vm_1][info 2016/07/28 02:50:40.297 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$25.run with 0 args on object: "Execute Query with Index in Replicated Region"
> [vm_1]distributed system properties: {locators=localhost[59948], enable-cluster-configuration=false, use-cluster-configuration=false, mcast-port=0, disable-auto-reconnect=true, log-level=info}
> [vm_1][info 2016/07/28 02:50:40.300 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Startup Configuration:
> [vm_1] ### GemFire Properties defined with api ###
> [vm_1]disable-auto-reconnect=true
> [vm_1]enable-cluster-configuration=false
> [vm_1]locators=localhost[59948]
> [vm_1]log-level=info
> [vm_1]mcast-port=0
> [vm_1]use-cluster-configuration=false
> [vm_1]### GemFire Properties using default values ###
> [vm_1]ack-severe-alert-threshold=0
> [vm_1]ack-wait-threshold=15
> [vm_1]archive-disk-space-limit=0
> [vm_1]archive-file-size-limit=0
> [vm_1]async-distribution-timeout=0
> [vm_1]async-max-queue-size=8
> [vm_1]async-queue-timeout=60000
> [vm_1]bind-address=
> [vm_1]cache-xml-file=cache.xml
> [vm_1]cluster-configuration-dir=
> [vm_1]cluster-ssl-ciphers=any
> [vm_1]cluster-ssl-enabled=false
> [vm_1]cluster-ssl-keystore=
> [vm_1]cluster-ssl-keystore-password=
> [vm_1]cluster-ssl-keystore-type=
> [vm_1]cluster-ssl-protocols=any
> [vm_1]cluster-ssl-require-authentication=true
> [vm_1]cluster-ssl-truststore=
> [vm_1]cluster-ssl-truststore-password=
> [vm_1]conflate-events=server
> [vm_1]conserve-sockets=true
> [vm_1]delta-propagation=true
> [vm_1]deploy-working-dir=.
> [vm_1]disable-tcp=false
> [vm_1]distributed-system-id=-1
> [vm_1]distributed-transactions=false
> [vm_1]durable-client-id=
> [vm_1]durable-client-timeout=300
> [vm_1]enable-network-partition-detection=false
> [vm_1]enable-time-statistics=false
> [vm_1]enforce-unique-host=false
> [vm_1]gateway-ssl-ciphers=any
> [vm_1]gateway-ssl-enabled=false
> [vm_1]gateway-ssl-keystore=
> [vm_1]gateway-ssl-keystore-password=
> [vm_1]gateway-ssl-keystore-type=
> [vm_1]gateway-ssl-protocols=any
> [vm_1]gateway-ssl-require-authentication=true
> [vm_1]gateway-ssl-truststore=
> [vm_1]gateway-ssl-truststore-password=
> [vm_1]groups=
> [vm_1]http-service-bind-address=
> [vm_1]http-service-port=7070
> [vm_1]http-service-ssl-ciphers=any
> [vm_1]http-service-ssl-enabled=false
> [vm_1]http-service-ssl-keystore=
> [vm_1]http-service-ssl-keystore-password=
> [vm_1]http-service-ssl-keystore-type=
> [vm_1]http-service-ssl-protocols=any
> [vm_1]http-service-ssl-require-authentication=false
> [vm_1]http-service-ssl-truststore=
> [vm_1]http-service-ssl-truststore-password=
> [vm_1]jmx-manager=false
> [vm_1]jmx-manager-access-file=
> [vm_1]jmx-manager-bind-address=
> [vm_1]jmx-manager-hostname-for-clients=
> [vm_1]jmx-manager-http-port=7070
> [vm_1]jmx-manager-password-file=
> [vm_1]jmx-manager-port=1099
> [vm_1]jmx-manager-ssl=false
> [vm_1]jmx-manager-ssl-ciphers=any
> [vm_1]jmx-manager-ssl-enabled=false
> [vm_1]jmx-manager-ssl-keystore=
> [vm_1]jmx-manager-ssl-keystore-password=
> [vm_1]jmx-manager-ssl-keystore-type=
> [vm_1]jmx-manager-ssl-protocols=any
> [vm_1]jmx-manager-ssl-require-authentication=true
> [vm_1]jmx-manager-ssl-truststore=
> [vm_1]jmx-manager-ssl-truststore-password=
> [vm_1]jmx-manager-start=false
> [vm_1]jmx-manager-update-rate=2000
> [vm_1]load-cluster-configuration-from-dir=false
> [vm_1]locator-wait-time=0
> [vm_1]lock-memory=false
> [vm_1]log-disk-space-limit=0
> [vm_1]log-file=
> [vm_1]log-file-size-limit=0
> [vm_1]max-num-reconnect-tries=3
> [vm_1]max-wait-time-reconnect=60000
> [vm_1]mcast-address=239.192.81.1
> [vm_1]mcast-flow-control=1048576, 0.25, 5000
> [vm_1]mcast-recv-buffer-size=1048576
> [vm_1]mcast-send-buffer-size=65535
> [vm_1]mcast-ttl=32
> [vm_1]member-timeout=5000
> [vm_1]membership-port-range=1024-65535
> [vm_1]memcached-bind-address=
> [vm_1]memcached-port=0
> [vm_1]memcached-protocol=ASCII
> [vm_1]name=
> [vm_1]off-heap-memory-size=
> [vm_1]redis-bind-address=
> [vm_1]redis-password=
> [vm_1]redis-port=0
> [vm_1]redundancy-zone=
> [vm_1]remote-locators=
> [vm_1]remove-unresponsive-client=false
> [vm_1]roles=
> [vm_1]security-client-accessor=
> [vm_1]security-client-accessor-pp=
> [vm_1]security-client-auth-init=
> [vm_1]security-client-authenticator=
> [vm_1]security-client-dhalgo=
> [vm_1]security-log-file=
> [vm_1]security-log-level=config
> [vm_1]security-manager=
> [vm_1]security-peer-auth-init=
> [vm_1]security-peer-authenticator=
> [vm_1]security-peer-verifymember-timeout=1000
> [vm_1]security-post-processor=
> [vm_1]server-bind-address=
> [vm_1]server-ssl-ciphers=any
> [vm_1]server-ssl-enabled=false
> [vm_1]server-ssl-keystore=
> [vm_1]server-ssl-keystore-password=
> [vm_1]server-ssl-keystore-type=
> [vm_1]server-ssl-protocols=any
> [vm_1]server-ssl-require-authentication=true
> [vm_1]server-ssl-truststore=
> [vm_1]server-ssl-truststore-password=
> [vm_1]socket-buffer-size=32768
> [vm_1]socket-lease-time=60000
> [vm_1]ssl-ciphers=any
> [vm_1]ssl-enabled=false
> [vm_1]ssl-protocols=any
> [vm_1]ssl-require-authentication=true
> [vm_1]start-dev-rest-api=false
> [vm_1]start-locator=
> [vm_1]statistic-archive-file=
> [vm_1]statistic-sample-rate=1000
> [vm_1]statistic-sampling-enabled=true
> [vm_1]tcp-port=0
> [vm_1]udp-fragment-size=60000
> [vm_1]udp-recv-buffer-size=1048576
> [vm_1]udp-send-buffer-size=65535
> [vm_1]user-command-packages=
> [vm_1][info 2016/07/28 02:50:40.301 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Starting membership services
> [vm_1][info 2016/07/28 02:50:40.309 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] JGroups channel created (took 8ms)
> [vm_1][info 2016/07/28 02:50:40.310 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GemFire P2P Listener started on null
> [vm_1][info 2016/07/28 02:50:40.311 PDT <Geode Failure Detection Server thread 0> tid=0x1520] Started failure detection server thread on kuwait.gemstone.com/10.118.32.93:50073.
> [vm_1][info 2016/07/28 02:50:40.312 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Attempting to join the distributed system through coordinator kuwait(9316:locator)<ec><v0>:1024 using address kuwait(9398)<ec>:1026
> [locator][info 2016/07/28 02:50:40.312 PDT <unicast receiver,kuwait-49731> tid=0x2a] received join request from kuwait(9398)<ec>:1026
> [locator][info 2016/07/28 02:50:40.613 PDT <Geode Membership View Creator> tid=0x30] View Creator is processing 1 requests for the next membership view
> [locator][info 2016/07/28 02:50:40.613 PDT <Geode Membership View Creator> tid=0x30] preparing new view View[kuwait(9316:locator)<ec><v0>:1024|309] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}, kuwait(9398)<ec><v309>:1026]
> [locator]failure detection ports: 29523 29082 50073
> [locator][info 2016/07/28 02:50:40.614 PDT <Geode Membership View Creator> tid=0x30] finished waiting for responses to view preparation
> [vm_1][info 2016/07/28 02:50:40.614 PDT <unicast receiver,kuwait-64167> tid=0x151c] received new view: View[kuwait(9316:locator)<ec><v0>:1024|309] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}, kuwait(9398)<ec><v309>:1026]
> [vm_1]old view is: null
> [vm_1][info 2016/07/28 02:50:40.614 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Finished joining (took 303ms).
> [vm_1][info 2016/07/28 02:50:40.614 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Starting DistributionManager kuwait(9398)<ec><v309>:1026. (took 313 ms)
> [locator][info 2016/07/28 02:50:40.614 PDT <Geode Membership View Creator> tid=0x30] received new view: View[kuwait(9316:locator)<ec><v0>:1024|309] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}, kuwait(9398)<ec><v309>:1026]
> [locator]old view is: View[kuwait(9316:locator)<ec><v0>:1024|308] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}] shutdown: [kuwait(9394)<ec><v306>:1025, kuwait(9398)<ec><v307>:1026]
> [locator][info 2016/07/28 02:50:40.614 PDT <Geode Membership View Creator> tid=0x30] Peer locator received new membership view: View[kuwait(9316:locator)<ec><v0>:1024|309] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}, kuwait(9398)<ec><v309>:1026]
> [locator][info 2016/07/28 02:50:40.614 PDT <Geode Membership View Creator> tid=0x30] sending new view View[kuwait(9316:locator)<ec><v0>:1024|309] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}, kuwait(9398)<ec><v309>:1026]
> [locator]failure detection ports: 29523 29082 50073
> [locator][info 2016/07/28 02:50:40.614 PDT <View Message Processor> tid=0x3c] Membership: Processing addition < kuwait(9398)<ec><v309>:1026 >
> [vm_1][info 2016/07/28 02:50:40.615 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initial (distribution manager) view = View[kuwait(9316:locator)<ec><v0>:1024|309] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}, kuwait(9398)<ec><v309>:1026]
> [locator][info 2016/07/28 02:50:40.615 PDT <View Message Processor> tid=0x3c] Admitting member <kuwait(9398)<ec><v309>:1026>. Now there are 3 non-admin member(s).
> [vm_0][info 2016/07/28 02:50:40.615 PDT <unicast receiver,kuwait-6440> tid=0x169f] received new view: View[kuwait(9316:locator)<ec><v0>:1024|309] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}, kuwait(9398)<ec><v309>:1026]
> [vm_0]old view is: View[kuwait(9316:locator)<ec><v0>:1024|308] members: [kuwait(9316:locator)<ec><v0>:1024, kuwait(9394)<ec><v308>:1025{lead}] shutdown: [kuwait(9394)<ec><v306>:1025, kuwait(9398)<ec><v307>:1026]
> [vm_1][info 2016/07/28 02:50:40.615 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9316:locator)<ec><v0>:1024>. Now there are 1 non-admin member(s).
> [vm_1][info 2016/07/28 02:50:40.615 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9394)<ec><v308>:1025>. Now there are 2 non-admin member(s).
> [vm_1][info 2016/07/28 02:50:40.615 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Admitting member <kuwait(9398)<ec><v309>:1026>. Now there are 3 non-admin member(s).
> [vm_0][info 2016/07/28 02:50:40.615 PDT <View Message Processor> tid=0x16ba] Membership: Processing addition < kuwait(9398)<ec><v309>:1026 >
> [vm_0][info 2016/07/28 02:50:40.615 PDT <View Message Processor> tid=0x16ba] Admitting member <kuwait(9398)<ec><v309>:1026>. Now there are 3 non-admin member(s).
> [vm_0][info 2016/07/28 02:50:40.617 PDT <Pooled High Priority Message Processor 1> tid=0x16b3] Member kuwait(9398)<ec><v309>:1026 is equivalent or in the same redundancy zone.
> [locator][info 2016/07/28 02:50:40.617 PDT <Pooled High Priority Message Processor 2> tid=0x11a] Member kuwait(9398)<ec><v309>:1026 is equivalent or in the same redundancy zone.
> [vm_1][info 2016/07/28 02:50:40.618 PDT <P2P message reader for kuwait(9394)<ec><v308>:1025 shared unordered uid=423 port=57958> tid=0x1528] Member kuwait(9394)<ec><v308>:1025 is equivalent or in the same redundancy zone.
> [vm_1][info 2016/07/28 02:50:40.619 PDT <P2P message reader for kuwait(9316:locator)<ec><v0>:1024 shared unordered uid=261 port=57959> tid=0x1529] Member kuwait(9316:locator)<ec><v0>:1024 is equivalent or in the same redundancy zone.
> [vm_1][info 2016/07/28 02:50:40.627 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region _monitoringRegion_10.118.32.93<v309>1026
> [vm_1][info 2016/07/28 02:50:40.628 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region _monitoringRegion_10.118.32.93<v309>1026 completed
> [vm_1][info 2016/07/28 02:50:40.631 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] The cache has been created with "use-cluster-configuration=false". It will not receive any cluster configuration
> [vm_1][info 2016/07/28 02:50:40.632 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region PdxTypes
> [vm_1][info 2016/07/28 02:50:40.633 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Region PdxTypes requesting initial image from kuwait(9394)<ec><v308>:1025
> [vm_1][info 2016/07/28 02:50:40.634 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] PdxTypes is done getting image from kuwait(9394)<ec><v308>:1025. isDeltaGII is false
> [vm_1][info 2016/07/28 02:50:40.634 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region PdxTypes completed
> [vm_1][info 2016/07/28 02:50:40.636 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Cache server connection listener bound to address 0.0.0.0/0.0.0.0:42027 with backlog 1,000.
> [vm_1][info 2016/07/28 02:50:40.637 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ClientHealthMonitorThread maximum allowed time between pings: 60,000
> [vm_1][info 2016/07/28 02:50:40.638 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] CacheServer Configuration: port=42027 max-connections=800 max-threads=0 notify-by-subscription=true socket-buffer-size=32768 maximum-time-between-pings=60000 maximum-message-count=230000 message-time-to-live=180 eviction-policy=none capacity=1 overflow directory=. groups=[] loadProbe=ConnectionCountProbe loadPollInterval=5000 tcpNoDelay=true
> [vm_1][info 2016/07/28 02:50:40.639 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region root
> [vm_1][info 2016/07/28 02:50:40.640 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Region root requesting initial image from kuwait(9394)<ec><v308>:1025
> [vm_1][info 2016/07/28 02:50:40.641 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] root is done getting image from kuwait(9394)<ec><v308>:1025. isDeltaGII is false
> [vm_1][info 2016/07/28 02:50:40.641 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region root completed
> [vm_1][info 2016/07/28 02:50:40.641 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initializing region PdxTest
> [vm_1][info 2016/07/28 02:50:40.642 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Region PdxTest requesting initial image from kuwait(9394)<ec><v308>:1025
> [vm_1][info 2016/07/28 02:50:40.643 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] PdxTest is done getting image from kuwait(9394)<ec><v308>:1025. isDeltaGII is false
> [vm_1][info 2016/07/28 02:50:40.643 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialization of region PdxTest completed
> [vm_1][info 2016/07/28 02:50:40.644 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Using Compact Map Range index implementation for 'myIndex' on region /root/PdxTest
> [vm_1][info 2016/07/28 02:50:40.645 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Initialized and loaded entries into the index
> [vm_1][info 2016/07/28 02:50:40.646 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$25.run with 0 args on object: "Execute Query with Index in Replicated Region" (took 348 ms)
> [vm_0][info 2016/07/28 02:50:40.647 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client"
> [vm_0][info 2016/07/28 02:50:40.647 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ### Close Client. ###
> [vm_0][info 2016/07/28 02:50:40.648 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GemFireCache[id = 1412466484; isClosing = true; isShutDownAll = false; created = Thu Jul 28 02:50:40 PDT 2016; server = false; copyOnRead = false; lockLease = 120; lockTimeout = 60]: Now closing.
> [vm_0][info 2016/07/28 02:50:40.649 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Cache server on port 58,560 is shutting down.
> [vm_0][info 2016/07/28 02:50:40.653 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Shutting down DistributionManager kuwait(9394)<ec><v308>:1025.
> [vm_1][info 2016/07/28 02:50:40.654 PDT <Pooled High Priority Message Processor 2> tid=0x1535] received leave request from kuwait(9394)<ec><v308>:1025 for kuwait(9394)<ec><v308>:1025
> [locator][info 2016/07/28 02:50:40.654 PDT <Pooled High Priority Message Processor 2> tid=0x11a] received leave request from kuwait(9394)<ec><v308>:1025 for kuwait(9394)<ec><v308>:1025
> [vm_1][info 2016/07/28 02:50:40.654 PDT <Pooled High Priority Message Processor 2> tid=0x1535] Member at kuwait(9394)<ec><v308>:1025 gracefully left the distributed cache: shutdown message received
> [locator][info 2016/07/28 02:50:40.654 PDT <Pooled High Priority Message Processor 2> tid=0x11a] Member at kuwait(9394)<ec><v308>:1025 gracefully left the distributed cache: shutdown message received
> [vm_0][info 2016/07/28 02:50:40.754 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Now closing distribution for kuwait(9394)<ec><v308>:1025
> [vm_0][info 2016/07/28 02:50:40.754 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Stopping membership services
> [vm_0][info 2016/07/28 02:50:40.754 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GMSHealthMonitor server socket is closed in stopServices().
> [locator][info 2016/07/28 02:50:40.754 PDT <unicast receiver,kuwait-49731> tid=0x2a] received leave request from kuwait(9394)<ec><v308>:1025 for kuwait(9394)<ec><v308>:1025
> [vm_0][info 2016/07/28 02:50:40.754 PDT <Geode Failure Detection Server thread 0> tid=0x16a3] GMSHealthMonitor server thread exiting
> [vm_0][info 2016/07/28 02:50:40.755 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GMSHealthMonitor serverSocketExecutor is terminated
> [vm_1][info 2016/07/28 02:50:40.755 PDT <unicast receiver,kuwait-64167> tid=0x151c] received leave request from kuwait(9394)<ec><v308>:1025 for kuwait(9394)<ec><v308>:1025
> [vm_0][info 2016/07/28 02:50:40.758 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] DistributionManager stopped in 105ms.
> [vm_0][info 2016/07/28 02:50:40.758 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Marking DistributionManager kuwait(9394)<ec><v308>:1025 as closed.
> [vm_0][info 2016/07/28 02:50:40.759 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client" (took 111 ms)
> [vm_1][info 2016/07/28 02:50:40.760 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client"
> [vm_1][info 2016/07/28 02:50:40.760 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ### Close Client. ###
> [vm_1][info 2016/07/28 02:50:40.761 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GemFireCache[id = 2046044872; isClosing = true; isShutDownAll = false; created = Thu Jul 28 02:50:40 PDT 2016; server = false; copyOnRead = false; lockLease = 120; lockTimeout = 60]: Now closing.
> [vm_1][info 2016/07/28 02:50:40.762 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Cache server on port 42,027 is shutting down.
> [vm_1][info 2016/07/28 02:50:40.765 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Shutting down DistributionManager kuwait(9398)<ec><v309>:1026.
> [locator][info 2016/07/28 02:50:40.766 PDT <Pooled High Priority Message Processor 2> tid=0x11a] received leave request from kuwait(9398)<ec><v309>:1026 for kuwait(9398)<ec><v309>:1026
> [locator][info 2016/07/28 02:50:40.766 PDT <Pooled High Priority Message Processor 2> tid=0x11a] Member at kuwait(9398)<ec><v309>:1026 gracefully left the distributed cache: shutdown message received
> [vm_1][info 2016/07/28 02:50:40.866 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Now closing distribution for kuwait(9398)<ec><v309>:1026
> [vm_1][info 2016/07/28 02:50:40.866 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Stopping membership services
> [vm_1][info 2016/07/28 02:50:40.867 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GMSHealthMonitor server socket is closed in stopServices().
> [vm_1][info 2016/07/28 02:50:40.867 PDT <Geode Failure Detection Server thread 0> tid=0x1520] GMSHealthMonitor server thread exiting
> [locator][info 2016/07/28 02:50:40.867 PDT <unicast receiver,kuwait-49731> tid=0x2a] received leave request from kuwait(9398)<ec><v309>:1026 for kuwait(9398)<ec><v309>:1026
> [vm_1][info 2016/07/28 02:50:40.867 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] GMSHealthMonitor serverSocketExecutor is terminated
> [vm_1][info 2016/07/28 02:50:40.870 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] DistributionManager stopped in 105ms.
> [vm_1][info 2016/07/28 02:50:40.870 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Marking DistributionManager kuwait(9398)<ec><v309>:1026 as closed.
> [vm_1][info 2016/07/28 02:50:40.871 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client" (took 110 ms)
> [vm_3][info 2016/07/28 02:50:40.872 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client"
> [vm_3][info 2016/07/28 02:50:40.872 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] ### Close Client. ###
> [vm_3][info 2016/07/28 02:50:40.872 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.cache.query.dunit.CompiledInDUnitTest$1.run with 0 args on object: "Close Client" (took 0 ms)
> [vm_0][info 2016/07/28 02:50:40.881 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657@15e89968
> [vm_0][info 2016/07/28 02:50:40.882 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$9/1993756657@15e89968 (took 0 ms)
> [vm_1][info 2016/07/28 02:50:40.882 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645@7359ff91
> [vm_1][info 2016/07/28 02:50:40.882 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/9633645@7359ff91 (took 0 ms)
> [vm_2][info 2016/07/28 02:50:40.883 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274@10e1b131
> [vm_2][info 2016/07/28 02:50:40.883 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$10/1327170274@10e1b131 (took 0 ms)
> [vm_3][info 2016/07/28 02:50:40.884 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395@5f79c56b
> [vm_3][info 2016/07/28 02:50:40.884 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395.run with 0 args on object: com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1477154395@5f79c56b (took 0 ms)
> [vm_0][info 2016/07/28 02:50:40.884 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_0][info 2016/07/28 02:50:40.885 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:40.885 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_1][info 2016/07/28 02:50:40.885 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:40.885 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_2][info 2016/07/28 02:50:40.885 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:40.886 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator)
> [vm_3][info 2016/07/28 02:50:40.886 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownCreationStackGenerator) (took 0 ms)
> [vm_0][info 2016/07/28 02:50:40.886 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_0][info 2016/07/28 02:50:40.886 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_0] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_1][info 2016/07/28 02:50:40.886 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_1][info 2016/07/28 02:50:40.887 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_1] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_2][info 2016/07/28 02:50:40.887 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_2][info 2016/07/28 02:50:40.887 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [vm_3][info 2016/07/28 02:50:40.887 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM)
> [vm_3][info 2016/07/28 02:50:40.887 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: runnable(tearDownVM) (took 0 ms)
> [locator][info 2016/07/28 02:50:40.888 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Received method: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608.run with 0 args on object: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608@fe46a45
> [locator][info 2016/07/28 02:50:40.888 PDT <RMI TCP Connection(1)-10.118.32.93> tid=0x1b] Got result: null
> [locator] from com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608.run with 0 args on object: com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1814869608@fe46a45 (took 0 ms)
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)