[ https://issues.apache.org/jira/browse/GEODE-1314?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Darrel Schneider resolved GEODE-1314. ------------------------------------- Resolution: Duplicate > CI failure: PersistentPartitionedRegionOldConfigDUnitTest.testBug42226 > ---------------------------------------------------------------------- > > Key: GEODE-1314 > URL: https://issues.apache.org/jira/browse/GEODE-1314 > Project: Geode > Issue Type: Bug > Components: persistence > Reporter: Eric Shu > Labels: ci, flaky > > {noformat} > Error Message > java.lang.AssertionError: An exception occurred during asynchronous > invocation. > Stacktrace > java.lang.AssertionError: An exception occurred during asynchronous > invocation. > at > com.gemstone.gemfire.test.dunit.AsyncInvocation.checkException(AsyncInvocation.java:155) > at > com.gemstone.gemfire.test.dunit.AsyncInvocation.get(AsyncInvocation.java:391) > at > com.gemstone.gemfire.test.dunit.AsyncInvocation.getResult(AsyncInvocation.java:204) > at > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionDUnitTest.testBug42226(PersistentPartitionedRegionDUnitTest.java:1706) > 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 junit.framework.TestCase.runTest(TestCase.java:176) > at junit.framework.TestCase.runBare(TestCase.java:141) > at junit.framework.TestResult$1.protect(TestResult.java:122) > at junit.framework.TestResult.runProtected(TestResult.java:142) > at junit.framework.TestResult.run(TestResult.java:125) > at junit.framework.TestCase.run(TestCase.java:129) > at junit.framework.TestSuite.runTest(TestSuite.java:252) > at junit.framework.TestSuite.run(TestSuite.java:247) > at > org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) > at > org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:105) > 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:64) > at > org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:50) > at sun.reflect.GeneratedMethodAccessor7.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:106) > at sun.reflect.GeneratedMethodAccessor6.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: > com.gemstone.gemfire.distributed.DistributedSystemDisconnectedException: This > connection to a distributed system has been disconnected. > at > com.gemstone.gemfire.distributed.internal.InternalDistributedSystem.checkConnected(InternalDistributedSystem.java:827) > at > com.gemstone.gemfire.distributed.internal.InternalDistributedSystem.getDistributionManager(InternalDistributedSystem.java:1421) > at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.<init>(GemFireCacheImpl.java:839) > at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.basicCreate(GemFireCacheImpl.java:794) > at > com.gemstone.gemfire.internal.cache.GemFireCacheImpl.create(GemFireCacheImpl.java:783) > at com.gemstone.gemfire.cache.CacheFactory.create(CacheFactory.java:178) > at com.gemstone.gemfire.cache.CacheFactory.create(CacheFactory.java:169) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase.createCache(JUnit4CacheTestCase.java:115) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase.getCache(JUnit4CacheTestCase.java:256) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase.getCache(JUnit4CacheTestCase.java:235) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase.getCache(JUnit4CacheTestCase.java:227) > at > com.gemstone.gemfire.test.dunit.cache.internal.JUnit3CacheTestCase.getCache(JUnit3CacheTestCase.java:84) > at > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$14.run(PersistentPartitionedRegionTestBase.java:411) > at sun.reflect.GeneratedMethodAccessor378.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.GeneratedMethodAccessor4.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: [StreamingPartitionOperationOneDUnitTest, > StreamingPartitionOperationManyDUnitTest, ElidedPutAllDUnitTest, > PartitionResolverDUnitTest, Bug43684DUnitTest, Bug51400DUnitTest, > PersistentColocatedPartitionedRegionDUnitTest, Bug39356DUnitTest, > PartitionedRegionMetaDataCleanupDUnitTest, > PersistentPartitionedRegionDUnitTest, > PersistentPartitionedRegionWithTransactionDUnitTest, ShutdownAllDUnitTest, > PartitionedRegionLoaderWriterDUnitTest, Bug47388DUnitTest, > PersistentPartitionedRegionOldConfigDUnitTest] > [vm_0][info 2016/04/23 13:16:34.455 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: > runnable(setupVM) > [vm_0][info 2016/04/23 13:16:34.455 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] 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/04/23 13:16:34.456 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_1][info 2016/04/23 13:16:34.456 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] 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/04/23 13:16:34.456 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on object: > runnable(setupVM) > [vm_2][info 2016/04/23 13:16:34.456 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(setupVM) (took 0 ms) > [setup] START TEST > PersistentPartitionedRegionOldConfigDUnitTest.testRegisterInterestNoDataStores > [vm_0][info 2016/04/23 13:16:34.457 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1244815714.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1244815714@4513e5 > [vm_0][info 2016/04/23 13:16:34.457 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1244815714.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$15/1244815714@4513e5 > (took 0 ms) > [vm_3][info 2016/04/23 13:16:34.456 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Received method: com.gemstone.gemfire.test.dunit.NamedRunnable.run > with 0 args on object: runnable(setupVM) > [vm_3][info 2016/04/23 13:16:34.457 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from com.gemstone.gemfire.test.dunit.NamedRunnable.run with 0 args on > object: runnable(setupVM) (took 0 ms) > [vm_1][info 2016/04/23 13:16:34.457 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$13/513527391.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$13/513527391@58c68535 > [vm_1][info 2016/04/23 13:16:34.457 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$13/513527391.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$13/513527391@58c68535 > (took 0 ms) > [vm_2][info 2016/04/23 13:16:34.458 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$13/1273729228.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$13/1273729228@5d5c73ea > [vm_2][info 2016/04/23 13:16:34.458 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$13/1273729228.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$13/1273729228@5d5c73ea > (took 0 ms) > [vm_3][info 2016/04/23 13:16:34.458 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$17/1270473708.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$17/1270473708@4890c17e > [vm_3][info 2016/04/23 13:16:34.458 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$17/1270473708.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$17/1270473708@4890c17e > (took 0 ms) > [vm_0][info 2016/04/23 13:16:34.458 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase.setRegionName > with 1 args > [vm_0][info 2016/04/23 13:16:34.458 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Got result: null > [vm_0] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase.setRegionName > with 1 args (took 0 ms) > [vm_1][info 2016/04/23 13:16:34.458 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase.setRegionName > with 1 args > [vm_1][info 2016/04/23 13:16:34.458 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase.setRegionName > with 1 args (took 0 ms) > [vm_2][info 2016/04/23 13:16:34.459 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase.setRegionName > with 1 args > [vm_2][info 2016/04/23 13:16:34.459 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase.setRegionName > with 1 args (took 0 ms) > [info 2016/04/23 13:16:34.459 PDT <Test worker> tid=0xa] <ExpectedException > action=add>Connection reset</ExpectedException> > [info 2016/04/23 13:16:34.459 PDT <Test worker> tid=0xa] <ExpectedException > action=add>Connection reset</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.459 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase.setRegionName > with 1 args > [vm_3][info 2016/04/23 13:16:34.459 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase.setRegionName > with 1 args (took 0 ms) > [vm_0][info 2016/04/23 13:16:34.459 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_0][info 2016/04/23 13:16:34.459 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException action=add>Connection reset</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.459 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException action=add>Connection reset</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.459 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Got result: null > [vm_0] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_1][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_1][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException action=add>Connection reset</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException action=add>Connection reset</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_2][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_2][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException action=add>Connection reset</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException action=add>Connection reset</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [info 2016/04/23 13:16:34.460 PDT <Test worker> tid=0xa] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [info 2016/04/23 13:16:34.460 PDT <Test worker> tid=0xa] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_3][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException action=add>Connection reset</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException action=add>Connection reset</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.460 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_0][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_0][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Got result: null > [vm_0] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_1][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_1][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_2][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_2][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.461 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_3][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_3][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException > action=add>SocketTimeoutException</ExpectedException> > [info 2016/04/23 13:16:34.462 PDT <Test worker> tid=0xa] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [info 2016/04/23 13:16:34.462 PDT <Test worker> tid=0xa] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_0][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Got result: null > [vm_0] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_1][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_1][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_2][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_2][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.462 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_3][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_3][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException > action=add>ServerConnectivityException</ExpectedException> > [info 2016/04/23 13:16:34.463 PDT <Test worker> tid=0xa] <ExpectedException > action=add>Socket Closed</ExpectedException> > [info 2016/04/23 13:16:34.463 PDT <Test worker> tid=0xa] <ExpectedException > action=add>Socket Closed</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_0][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_0][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException action=add>Socket Closed</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException action=add>Socket Closed</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Got result: null > [vm_0] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_1][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_1][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException action=add>Socket Closed</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.463 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException action=add>Socket Closed</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_2][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_2][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException action=add>Socket Closed</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException action=add>Socket Closed</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_3][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_3][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException action=add>Socket Closed</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException action=add>Socket Closed</ExpectedException> > [info 2016/04/23 13:16:34.464 PDT <Test worker> tid=0xa] <ExpectedException > action=add>Unexpected IOException</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.464 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Got result: null > [info 2016/04/23 13:16:34.465 PDT <Test worker> tid=0xa] <ExpectedException > action=add>Unexpected IOException</ExpectedException> > [vm_3] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_0][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_0][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException action=add>Unexpected > IOException</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] <ExpectedException action=add>Unexpected > IOException</ExpectedException> > [vm_0][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Got result: null > [vm_0] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_1][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_1][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException action=add>Unexpected > IOException</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] <ExpectedException action=add>Unexpected > IOException</ExpectedException> > [vm_1][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(19)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_2][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_2][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException action=add>Unexpected > IOException</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] <ExpectedException action=add>Unexpected > IOException</ExpectedException> > [vm_2][info 2016/04/23 13:16:34.465 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_3][info 2016/04/23 13:16:34.466 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 args on object: > "IgnoredException addIgnoredException" > [vm_3][info 2016/04/23 13:16:34.466 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException action=add>Unexpected > IOException</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.466 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] <ExpectedException action=add>Unexpected > IOException</ExpectedException> > [vm_3][info 2016/04/23 13:16:34.466 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from com.gemstone.gemfire.test.dunit.IgnoredException$2.run with 0 > args on object: "IgnoredException addIgnoredException" (took 0 ms) > [vm_0][info 2016/04/23 13:16:34.469 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionDUnitTest$8.call > with 0 args on object: "create per" > [vm_0]distributed system properties: {locators=localhost[29641], > enable-cluster-configuration=false, use-cluster-configuration=false, > mcast-port=0, disable-auto-reconnect=true, log-level=info} > [vm_0][info 2016/04/23 13:16:34.472 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] > [vm_0]--------------------------------------------------------------------------- > [vm_0] > [vm_0] Licensed to the Apache Software Foundation (ASF) under one or more > [vm_0] contributor license agreements. See the NOTICE file distributed with > this > [vm_0] work for additional information regarding copyright ownership. > [vm_0] > [vm_0] The ASF licenses this file to You under the Apache License, Version > 2.0 > [vm_0] (the "License"); you may not use this file except in compliance with > the > [vm_0] License. You may obtain a copy of the License at > [vm_0] > [vm_0] http://www.apache.org/licenses/LICENSE-2.0 > [vm_0] > [vm_0] Unless required by applicable law or agreed to in writing, software > [vm_0] distributed under the License is distributed on an "AS IS" BASIS, > WITHOUT > [vm_0] WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. See > the > [vm_0] License for the specific language governing permissions and > limitations > [vm_0] under the License. > [vm_0] > [vm_0]--------------------------------------------------------------------------- > [vm_0]Java version: 1.0.0-incubating.M3-SNAPSHOT build 042316 2016-04-23 > 11:11:37 -0700 javac 1.8.0_66 > [vm_0]Native version: native code unavailable > [vm_0]Source revision: 3c5a2e85a0c23b3733c1721ee0ea7286a7b4fd3f > [vm_0]Source repository: develop > [vm_0]Running on: timor.gemstone.com/10.118.32.89, 4 cpu(s), amd64 Linux > 2.6.18-262.el5 > [vm_0]Process ID: 28559 > [vm_0]User: build > [vm_0]Current dir: > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm0 > [vm_0]Home dir: /home/build > [vm_0]Command Line Parameters: > [vm_0] -Dgemfire.DUnitLauncher.RMI_PORT=22126 > [vm_0] -Dgemfire.DUnitLauncher.VM_NUM=0 > [vm_0] > -DWORKSPACE_DIR=/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/. > [vm_0] -DlogLevel=info > [vm_0] > -Djava.library.path=/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib > [vm_0] -Xrunjdwp:transport=dt_socket,server=y,suspend=n > [vm_0] -XX:+HeapDumpOnOutOfMemoryError > [vm_0] -Xmx512m > [vm_0] -Dgemfire.DEFAULT_MAX_OPLOG_SIZE=10 > [vm_0] -Dgemfire.disallowMcastDefaults=true > [vm_0] -ea > [vm_0] -XX:+PrintGC > [vm_0] -XX:+PrintGCDetails > [vm_0] -XX:+PrintGCTimeStamps > [vm_0] -DdummyArg=true > [vm_0]Class Path: > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/classes/test > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/resources/test > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/classes/main > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/resources/main > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/generated-resources/main > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.github.stephenc.findbugs/findbugs-annotations/1.3.9-1/a6b11447635d80757d64b355bed3c00786d86801/findbugs-annotations-1.3.9-1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.jgroups/jgroups/3.6.8.Final/9cc380b3a82a786addd06dc04d1470d1c44a51cb/jgroups-3.6.8.Final.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/antlr/antlr/2.7.7/83cd2cd674a217ade95a4bb83a8a14f351f48bd0/antlr-2.7.7.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.fasterxml.jackson.core/jackson-databind/2.2.0/3a63aacffcc0f91f0920ddfa33a3833018c21f72/jackson-databind-2.2.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-io/commons-io/2.3/cd8d6ffc833cc63c30d712a180f4663d8f55799b/commons-io-2.3.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-lang/commons-lang/2.5/b0236b252e86419eef20c31a44579d2aee2f0a69/commons-lang-2.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-modeler/commons-modeler/2.0/177f22811ed71980e5cda66de05bd070e4da3ee3/commons-modeler-2.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/io.netty/netty-all/4.0.4.Final/925914146e37041255ea18ae2d5982f9589c784d/netty-all-4.0.4.Final.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/it.unimi.dsi/fastutil/7.0.2/20876232e2cd12563507e4c9e85bd7948bc0656f/fastutil-7.0.2.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/javax.mail/javax.mail-api/1.4.5/42af3cb44d5ec658adc8a4c7354ac0d19547c4ca/javax.mail-api-1.4.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/javax.resource/javax.resource-api/1.7/ae40e0864eb1e92c48bf82a2a3399cbbf523fb79/javax.resource-api-1.7.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/mx4j/mx4j/3.0.1/991089e21fce990b84d9e06e9ed9cc00d518ae56/mx4j-3.0.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/mx4j/mx4j-remote/3.0.1/f491951e754c24e7487efdd9f36d0677bfeb4184/mx4j-remote-3.0.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/mx4j/mx4j-tools/3.0.1/df853af9fe34d4eb6f849a1b5936fddfcbe67751/mx4j-tools-3.0.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/net.java.dev.jna/jna/4.0.0/9b3a11c613ec3fd3440af4103b12c3de82d38b6e/jna-4.0.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.google.guava/guava/15.0/ed727a8d9f247e2050281cb083f1c77b09dcb5cd/guava-15.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.logging.log4j/log4j-api/2.5/e7fd981408caba8a0c0fb276413562468d260160/log4j-api-2.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.logging.log4j/log4j-core/2.5/7ed845de1dfe070d43511fab321784e6c4118398/log4j-core-2.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.eclipse.jetty/jetty-webapp/9.3.6.v20151106/9cf00a3b7b2c1b6e024bb687e3719e1b0ff9e899/jetty-webapp-9.3.6.v20151106.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.springframework.shell/spring-shell/1.1.0.RELEASE/32fcf5aacf7bd5d997dbf2f8f95ed9369d81d9c0/spring-shell-1.1.0.RELEASE.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.xerial.snappy/snappy-java/1.1.1.6/e3f12835a135c0d253bee4dbbe74d37ce35d7269/snappy-java-1.1.1.6.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-common/build/libs/geode-common-1.0.0-incubating.M3-SNAPSHOT.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-joptsimple/build/libs/geode-joptsimple-1.0.0-incubating.M3-SNAPSHOT.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-json/build/libs/geode-json-1.0.0-incubating.M3-SNAPSHOT.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.fusesource.jansi/jansi/1.8/81da0c3980e30744184bec4706cf6f4508d3d7ea/jansi-1.8.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.logging.log4j/log4j-slf4j-impl/2.5/d1e34a4525e08873703fdaad6c6284f944f8ca8f/log4j-slf4j-impl-2.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.logging.log4j/log4j-jcl/2.5/4d14933326d067ac1f16790325ac2eb997003bd2/log4j-jcl-2.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.logging.log4j/log4j-jul/2.5/2c679bb8b6ec7e204615045c9943e6b4dbfd45ab/log4j-jul-2.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.github.stefanbirkner/system-rules/1.15.0/355adc877e54a2eb6b42a3d2801cdf8329f215d8/system-rules-1.15.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.google.code.tempus-fugit/tempus-fugit/1.1/4f47af53091985a3e3581af60e432a556a69e2cd/tempus-fugit-1.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.jayway.awaitility/awaitility/1.7.0/e4fa7955cab67d880e4868a0795cce3498ea7bf2/awaitility-1.7.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/edu.umd.cs.mtc/multithreadedtc/1.01/43fbc1110d7e43cf79e415ef32036975ad85944c/multithreadedtc-1.01.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/eu.codearte.catch-exception/catch-exception/1.4.4/c54da7072e0ccaf1fb92118e5e6e24335039006e/catch-exception-1.4.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/eu.codearte.catch-exception/catch-throwable/1.4.4/e152e6679c9e57934cbf4126214e324c55603f82/catch-throwable-1.4.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/junit/junit/4.12/2973d150c0dc1fefe998f834810d68f278ea58ec/junit-4.12.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.assertj/assertj-core/3.2.0/eded8ad93bf57af8eff233c1751550bd40349ebb/assertj-core-3.2.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.mockito/mockito-core/1.10.19/e8546f5bef4e061d8dd73895b4e8f40e3fe6effe/mockito-core-1.10.19.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.hamcrest/hamcrest-all/1.3/63a21ebc981131004ad02e0434e799fd7f3a8d5a/hamcrest-all-1.3.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.jmock/jmock-junit4/2.8.1/f32f596560c90e68aa2ef6d3fae8022475dbb9d0/jmock-junit4-2.8.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.jmock/jmock-legacy/2.8.1/ec286ef0c3f662a2260a864c89ebfbb5da3bd4de/jmock-legacy-2.8.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/pl.pragmatists/JUnitParams/1.0.4/e311bbf8fe3f0d837d6d38fbd0a3cf00dc909704/JUnitParams-1.0.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-junit/build/libs/geode-junit-1.0.0-incubating.M3-SNAPSHOT.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.bcel/bcel/5.2/96b2cefeb067c08c31225d48e2a689f814baae25/bcel-5.2.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/net.spy/spymemcached/2.9.0/5af20b7abf49d0b49b7eaf92baa036620f3e4591/spymemcached-2.9.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/redis.clients/jedis/2.7.2/f2f47f1025ea5090263820e8598e56eb47f5c88a/jedis-2.7.2.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.powermock/powermock-core/1.6.4/85fb32e9ccba748d569fc36aef92e0b9e7f40b87/powermock-core-1.6.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.powermock/powermock-module-junit4/1.6.4/8692eb1d9bb8eb1310ffe8a20c2da7ee6d1b5994/powermock-module-junit4-1.6.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.powermock/powermock-api-mockito/1.6.4/fe12509b7e9e49d25131f4155145748a31e42e40/powermock-api-mockito-1.6.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/cglib/cglib/3.1/1f1cb6c7a7479e0c7fd7987109e503914bebe84a/cglib-3.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.ow2.asm/asm/5.0.3/dcc2193db20e19e1feca8b1240dbbc4e190824fa/asm-5.0.3.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.derby/derby/10.2.2.0/f787c9b484cd7526f866c21d8925c4dace467f8a/derby-10.2.2.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-auth/2.4.1/96af98a34a335c5a8f2c9e40c6df57308060b1b1/hadoop-auth-2.4.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-collections/commons-collections/3.2.2/8ad72fe39fa8c91eaaf12aadb21e0c3661fe26d5/commons-collections-3.2.2.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-configuration/commons-configuration/1.6/32cadde23955d7681b0d94a2715846d20b425235/commons-configuration-1.6.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.fasterxml.jackson.core/jackson-annotations/2.2.0/3539928f64ce8c37340a012e974990ba1478109a/jackson-annotations-2.2.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.fasterxml.jackson.core/jackson-core/2.2.0/45b1e51668ad002d47a0e88dfab6a0b4416246eb/jackson-core-2.2.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/javax.activation/activation/1.1/e6cb541461c2834bdea3eb920f1884d1eb508b50/activation-1.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/javax.transaction/javax.transaction-api/1.2/d81aff979d603edd90dcd8db2abc1f4ce6479e3e/javax.transaction-api-1.2.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.eclipse.jetty/jetty-xml/9.3.6.v20151106/b22e22977ea6c08751f8c945bb0785c35f9db28a/jetty-xml-9.3.6.v20151106.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.eclipse.jetty/jetty-servlet/9.3.6.v20151106/62c03d6c7203735d4e28e4e78e22df38152f01ef/jetty-servlet-9.3.6.v20151106.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/jline/jline/2.12/ce9062c6a125e0f9ad766032573c041ae8ecc986/jline-2.12.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.springframework/spring-core/4.2.4.RELEASE/160ccd89230753d4f49477a967f5876b034d9745/spring-core-4.2.4.RELEASE.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.slf4j/slf4j-api/1.7.12/8e20852d05222dc286bf1c71d78d0531e177c317/slf4j-api-1.7.12.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-logging/commons-logging/1.2/4bfc12adfe4842bf07b657f0369c4cb522955686/commons-logging-1.2.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.hamcrest/hamcrest-library/1.3/4785a3c21320980282f9f33d0d1264a69040538f/hamcrest-library-1.3.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/cglib/cglib-nodep/3.1/aa83efbd1aedc4f26bdf00e7ea78191483f2c9b3/cglib-nodep-3.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.objenesis/objenesis/2.1/87c0ea803b69252868d09308b4618f766f135a96/objenesis-2.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.jmock/jmock/2.8.1/aba0ed5962f5238421a2fee706d98133714590d0/jmock-2.8.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/jakarta-regexp/jakarta-regexp/1.4/ea514a179ac1dd7e81c7e6594468b9b9910d298/jakarta-regexp-1.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.commons/commons-pool2/2.3/62a559a025fd890c30364296ece14643ba9c8c5b/commons-pool2-2.3.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.powermock/powermock-reflect/1.6.4/5532f4e7c42db4bca4778bc9f1afcd4b0ee0b893/powermock-reflect-1.6.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.javassist/javassist/3.20.0-GA/a9cbcdfb7e9f86fbc74d3afae65f2248bfbf82a0/javassist-3.20.0-GA.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.powermock/powermock-module-junit4-common/1.6.4/b0b578da443794ceb8224bd5f5f852aaf40f1b81/powermock-module-junit4-common-1.6.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.powermock/powermock-api-support/1.6.4/314daafb761541293595630e10a3699ebc07881d/powermock-api-support-1.6.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/log4j/log4j/1.2.17/5af35056b4d257e4b64b9e8069c0746e8b08629f/log4j-1.2.17.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.slf4j/slf4j-log4j12/1.7.5/6edffc576ce104ec769d954618764f39f0f0f10d/slf4j-log4j12-1.7.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.httpcomponents/httpclient/4.2.5/666e26e76f2e87d84e4f16acb546481ae1b8e9a6/httpclient-4.2.5.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-digester/commons-digester/1.8/dc6a73fdbd1fa3f0944e8497c6c872fa21dca37e/commons-digester-1.8.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-beanutils/commons-beanutils-core/1.8.0/175dc721f87e4bc5cc0573f990e28c3cf9117508/commons-beanutils-core-1.8.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.eclipse.jetty/jetty-util/9.3.6.v20151106/8721c8e670c11ea19005c567733453956b6243fc/jetty-util-9.3.6.v20151106.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.eclipse.jetty/jetty-security/9.3.6.v20151106/e44ffc80834a7f78a5b0ed15c54b875956772242/jetty-security-9.3.6.v20151106.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.jmock/jmock-testjar/2.8.1/f70febf8ef161533adb2ef4cca0adbd3cc56f125/jmock-testjar-2.8.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.beanshell/bsh/1.3.0/1fed35193d56470f46c0fb33917e3e82c0c42358/bsh-1.3.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.httpcomponents/httpcore/4.2.4/3b7f38df6de5dd8b500e602ae8c2dd5ee446f883/httpcore-4.2.4.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-beanutils/commons-beanutils/1.7.0/5675fd96b29656504b86029551973d60fb41339b/commons-beanutils-1.7.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.eclipse.jetty/jetty-server/9.3.6.v20151106/d9c43a1b20ede7e3c456237d71b4cce1dff5457a/jetty-server-9.3.6.v20151106.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/javax.servlet/javax.servlet-api/3.1.0/3cd63d075497751784b2fa84be59432f4905bf7c/javax.servlet-api-3.1.0.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.eclipse.jetty/jetty-http/9.3.6.v20151106/c2bba60bc1f9fe5779ac20ab30232bf9a89d3e52/jetty-http-9.3.6.v20151106.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.eclipse.jetty/jetty-io/9.3.6.v20151106/9e59bde867e55d8c93cdd682d12317733ef5339/jetty-io-9.3.6.v20151106.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.hamcrest/hamcrest-core/1.3/42a25dc3219429f0e5d060061f71acb49bf010a0/hamcrest-core-1.3.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/commons-codec/commons-codec/1.6/b7f0fc8f61ecadeb3695f0b9464755eee44374d4/commons-codec-1.6.jar > [vm_0] /export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/lib/tools.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-common/2.4.1/5e9d624fb9eeab4b1a940f5e9b1c9ff644ec1d65/hadoop-common-2.4.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-annotations/2.4.1/80434aa40184be711d1c41568852fee625925ab0/hadoop-annotations-2.4.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-hdfs/2.4.1/e1a4a1d3554a1779cf69332f7aa04963237d74fb/hadoop-hdfs-2.4.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-mapreduce-client-core/2.4.1/4b563f928dc108bfc9974e2c643e275bbb407625/hadoop-mapreduce-client-core-2.4.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.apache.hbase/hbase/0.94.27/d0e1f44e59e9d64f31b40621ae7bd53a6d0a13b1/hbase-0.94.27.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/com.google.code.findbugs/jsr305/3.0.1/f7be08ec23c21485b9b5a1cf1654c2ec8c58168d/jsr305-3.0.1.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.springframework/spring-webmvc/4.2.4.RELEASE/cf4317be9c83b4c1c65ce2d3bb96673ac546030a/spring-webmvc-4.2.4.RELEASE.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.springframework/spring-beans/4.2.4.RELEASE/dc8e0874b53435f3e277d9da5aebd8b93cc7cf64/spring-beans-4.2.4.RELEASE.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.springframework/spring-context/4.2.4.RELEASE/23cd0109e4eafc5629547e3680b0c4031e82efdd/spring-context-4.2.4.RELEASE.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.springframework/spring-expression/4.2.4.RELEASE/15b6f6d61bc68fe2cc6cbd63e2329601afb8b39/spring-expression-4.2.4.RELEASE.jar > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/caches/modules-2/files-2.1/org.springframework/spring-web/4.2.4.RELEASE/d4bcc6f4d8b64d7af9b67bc17f0d5106dce97926/spring-web-4.2.4.RELEASE.jar > [vm_0]Library Path: > [vm_0] /usr/java/packages/lib/amd64 > [vm_0] /usr/lib64 > [vm_0] /lib64 > [vm_0] /lib > [vm_0] /usr/lib > [vm_0]System Properties: > [vm_0] TestInternalGemFireError = false > [vm_0] WORKSPACE_DIR = > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/. > [vm_0] awt.toolkit = sun.awt.X11.XToolkit > [vm_0] dummyArg = true > [vm_0] file.encoding = ANSI_X3.4-1968 > [vm_0] file.encoding.pkg = sun.io > [vm_0] file.separator = / > [vm_0] gemfire.DEFAULT_MAX_OPLOG_SIZE = 10 > [vm_0] gemfire.DISABLE_DISCONNECT_DS_ON_CACHE_CLOSE = true > [vm_0] gemfire.DUnitLauncher.LAUNCHED = true > [vm_0] gemfire.DUnitLauncher.RMI_PORT = 22126 > [vm_0] gemfire.DUnitLauncher.VM_NUM = 0 > [vm_0] gemfire.disallowMcastDefaults = true > [vm_0] gemfire.disk.recoverValuesSync = false > [vm_0] gemfire.free-off-heap-memory = true > [vm_0] hoplog.ALLOW_LOCAL_HDFS = true > [vm_0] java.awt.graphicsenv = sun.awt.X11GraphicsEnvironment > [vm_0] java.awt.printerjob = sun.print.PSPrinterJob > [vm_0] java.class.version = 52.0 > [vm_0] java.endorsed.dirs = > /export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/endorsed > [vm_0] java.ext.dirs = /export/java/users/java_sha > ...[truncated 8347234 chars]... > er VM > [vm_0] java.vm.specification.name = Java Virtual Machine Specification > [vm_0] java.vm.specification.vendor = Oracle Corporation > [vm_0] java.vm.specification.version = 1.8 > [vm_0] java.vm.vendor = Oracle Corporation > [vm_0] java.vm.version = 25.66-b17 > [vm_0] jgroups.resolve_dns = true > [vm_0] jna.platform.library.path = /usr/lib64:/lib64:/usr/lib:/lib > [vm_0] jnidispatch.path = /tmp/jna-94094958/jna7716619472948163876.tmp > [vm_0] line.separator = > [vm_0] logLevel = info > [vm_0] membership_port_range_end = 65535 > [vm_0] membership_port_range_start = 1024 > [vm_0] os.version = 2.6.18-262.el5 > [vm_0] p2p.idleConnectionTimeout = 60000 > [vm_0] p2p.shareSockets = true > [vm_0] p2p.useSSL = false > [vm_0] path.separator = : > [vm_0] sun.arch.data.model = 64 > [vm_0] sun.boot.class.path = > /export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/resources.jar:/export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/rt.jar:/export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/sunrsasign.jar:/export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/jsse.jar:/export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/jce.jar:/export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/charsets.jar:/export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/jfr.jar:/export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/classes > [vm_0] sun.boot.library.path = > /export/java/users/java_share/jdk/1.8.0_66/x86_64.linux/jre/lib/amd64 > [vm_0] sun.cpu.endian = little > [vm_0] sun.cpu.isalist = > [vm_0] sun.io.unicode.encoding = UnicodeLittle > [vm_0] sun.java.command = > com.gemstone.gemfire.test.dunit.standalone.ChildVM > [vm_0] sun.java.launcher = SUN_STANDARD > [vm_0] sun.jnu.encoding = ANSI_X3.4-1968 > [vm_0] sun.management.compiler = HotSpot 64-Bit Tiered Compilers > [vm_0] sun.nio.ch.bugLevel = > [vm_0] sun.os.patch.level = unknown > [vm_0] user.country = US > [vm_0] user.language = en > [vm_0] user.timezone = America/Los_Angeles > [vm_0]Log4J 2 Configuration: > [vm_0] > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/resources/main/log4j2.xml > [vm_0]--------------------------------------------------------------------------- > [vm_0][info 2016/04/23 13:18:06.821 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] 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[29641] > [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=/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm0 > [vm_0]cluster-ssl-ciphers=any > [vm_0]cluster-ssl-enabled=false > [vm_0]cluster-ssl-keystore= > [vm_0]cluster-ssl-keystore-password= > [vm_0]cluster-ssl-keystore-type= > [vm_0]cluster-ssl-protocols=any > [vm_0]cluster-ssl-require-authentication=true > [vm_0]cluster-ssl-truststore= > [vm_0]cluster-ssl-truststore-password= > [vm_0]conflate-events=server > [vm_0]conserve-sockets=true > [vm_0]delta-propagation=true > [vm_0]deploy-working-dir=. > [vm_0]disable-tcp=false > [vm_0]distributed-system-id=-1 > [vm_0]distributed-transactions=false > [vm_0]durable-client-id= > [vm_0]durable-client-timeout=300 > [vm_0]enable-network-partition-detection=false > [vm_0]enable-time-statistics=false > [vm_0]enforce-unique-host=false > [vm_0]gateway-ssl-ciphers=any > [vm_0]gateway-ssl-enabled=false > [vm_0]gateway-ssl-keystore= > [vm_0]gateway-ssl-keystore-password= > [vm_0]gateway-ssl-keystore-type= > [vm_0]gateway-ssl-protocols=any > [vm_0]gateway-ssl-require-authentication=true > [vm_0]gateway-ssl-truststore= > [vm_0]gateway-ssl-truststore-password= > [vm_0]groups= > [vm_0]http-service-bind-address= > [vm_0]http-service-port=7070 > [vm_0]http-service-ssl-ciphers=any > [vm_0]http-service-ssl-enabled=false > [vm_0]http-service-ssl-keystore= > [vm_0]http-service-ssl-keystore-password= > [vm_0]http-service-ssl-keystore-type= > [vm_0]http-service-ssl-protocols=any > [vm_0]http-service-ssl-require-authentication=false > [vm_0]http-service-ssl-truststore= > [vm_0]http-service-ssl-truststore-password= > [vm_0]jmx-manager=false > [vm_0]jmx-manager-access-file= > [vm_0]jmx-manager-bind-address= > [vm_0]jmx-manager-hostname-for-clients= > [vm_0]jmx-manager-http-port=7070 > [vm_0]jmx-manager-password-file= > [vm_0]jmx-manager-port=1099 > [vm_0]jmx-manager-ssl=false > [vm_0]jmx-manager-ssl-ciphers=any > [vm_0]jmx-manager-ssl-enabled=false > [vm_0]jmx-manager-ssl-keystore= > [vm_0]jmx-manager-ssl-keystore-password= > [vm_0]jmx-manager-ssl-keystore-type= > [vm_0]jmx-manager-ssl-protocols=any > [vm_0]jmx-manager-ssl-require-authentication=true > [vm_0]jmx-manager-ssl-truststore= > [vm_0]jmx-manager-ssl-truststore-password= > [vm_0]jmx-manager-start=false > [vm_0]jmx-manager-update-rate=2000 > [vm_0]load-cluster-configuration-from-dir=false > [vm_0]locator-wait-time=0 > [vm_0]lock-memory=false > [vm_0]log-disk-space-limit=0 > [vm_0]log-file= > [vm_0]log-file-size-limit=0 > [vm_0]max-num-reconnect-tries=3 > [vm_0]max-wait-time-reconnect=60000 > [vm_0]mcast-address=239.192.81.1 > [vm_0]mcast-flow-control=1048576, 0.25, 5000 > [vm_0]mcast-recv-buffer-size=1048576 > [vm_0]mcast-send-buffer-size=65535 > [vm_0]mcast-ttl=32 > [vm_0]member-timeout=5000 > [vm_0]membership-port-range=1024-65535 > [vm_0]memcached-bind-address= > [vm_0]memcached-port=0 > [vm_0]memcached-protocol=ASCII > [vm_0]name= > [vm_0]off-heap-memory-size= > [vm_0]redis-bind-address= > [vm_0]redis-password= > [vm_0]redis-port=0 > [vm_0]redundancy-zone= > [vm_0]remote-locators= > [vm_0]remove-unresponsive-client=false > [vm_0]roles= > [vm_0]security-client-accessor= > [vm_0]security-client-accessor-pp= > [vm_0]security-client-auth-init= > [vm_0]security-client-authenticator= > [vm_0]security-client-dhalgo= > [vm_0]security-log-file= > [vm_0]security-log-level=config > [vm_0]security-peer-auth-init= > [vm_0]security-peer-authenticator= > [vm_0]security-peer-verifymember-timeout=1000 > [vm_0]server-bind-address= > [vm_0]server-ssl-ciphers=any > [vm_0]server-ssl-enabled=false > [vm_0]server-ssl-keystore= > [vm_0]server-ssl-keystore-password= > [vm_0]server-ssl-keystore-type= > [vm_0]server-ssl-protocols=any > [vm_0]server-ssl-require-authentication=true > [vm_0]server-ssl-truststore= > [vm_0]server-ssl-truststore-password= > [vm_0]socket-buffer-size=32768 > [vm_0]socket-lease-time=60000 > [vm_0]ssl-ciphers=any > [vm_0]ssl-enabled=false > [vm_0]ssl-protocols=any > [vm_0]ssl-require-authentication=true > [vm_0]start-dev-rest-api=false > [vm_0]start-locator= > [vm_0]statistic-archive-file= > [vm_0]statistic-sample-rate=1000 > [vm_0]statistic-sampling-enabled=true > [vm_0]tcp-port=0 > [vm_0]udp-fragment-size=60000 > [vm_0]udp-recv-buffer-size=1048576 > [vm_0]udp-send-buffer-size=65535 > [vm_0]user-command-packages= > [vm_0][info 2016/04/23 13:18:06.823 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Starting membership services > [vm_0][info 2016/04/23 13:18:06.828 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] JGroups channel created (took 5ms) > [vm_0][info 2016/04/23 13:18:06.829 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] GemFire P2P Listener started on null > [vm_0][info 2016/04/23 13:18:06.830 PDT <Geode Failure Detection Server > thread 0> tid=0x2be7] Started failure detection server thread on > /10.118.32.89:11292. > [vm_0][info 2016/04/23 13:18:06.831 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Attempting to join the distributed system through coordinator > timor(28554:locator)<ec><v0>:1024 using address timor(28559)<ec>:1025 > [locator][info 2016/04/23 13:18:06.833 PDT <unicast receiver,timor-50263> > tid=0x21] received join request from timor(28559)<ec>:1025 > [vm_0][info 2016/04/23 13:18:06.901 PDT <Pooled Waiting Message Processor 0> > tid=0x2bac] Cache is confirmed closed > [locator][info 2016/04/23 13:18:07.139 PDT <Geode Membership View Creator> > tid=0x27] View Creator is processing 1 requests for the next membership view > [locator][info 2016/04/23 13:18:07.139 PDT <Geode Membership View Creator> > tid=0x27] preparing new view View[timor(28554:locator)<ec><v0>:1024|508] > members: [timor(28554:locator)<ec><v0>:1024, > timor(28567)<ec><v506>:1026{lead}, timor(28559)<ec><v508>:1025] > [locator]failure detection ports: 45480 54017 11292 > [vm_0][info 2016/04/23 13:18:07.139 PDT <unicast receiver,timor-40064> > tid=0x2be3] received new view: View[timor(28554:locator)<ec><v0>:1024|508] > members: [timor(28554:locator)<ec><v0>:1024, > timor(28567)<ec><v506>:1026{lead}, timor(28559)<ec><v508>:1025] > [vm_0]old view is: null > [locator][info 2016/04/23 13:18:07.139 PDT <Geode Membership View Creator> > tid=0x27] finished waiting for responses to view preparation > [locator][info 2016/04/23 13:18:07.139 PDT <Geode Membership View Creator> > tid=0x27] received new view: View[timor(28554:locator)<ec><v0>:1024|508] > members: [timor(28554:locator)<ec><v0>:1024, > timor(28567)<ec><v506>:1026{lead}, timor(28559)<ec><v508>:1025] > [locator]old view is: View[timor(28554:locator)<ec><v0>:1024|507] members: > [timor(28554:locator)<ec><v0>:1024, timor(28567)<ec><v506>:1026{lead}] > shutdown: [timor(28559)<ec><v505>:1025] > [locator][info 2016/04/23 13:18:07.139 PDT <Geode Membership View Creator> > tid=0x27] Peer locator received new membership view: > View[timor(28554:locator)<ec><v0>:1024|508] members: > [timor(28554:locator)<ec><v0>:1024, timor(28567)<ec><v506>:1026{lead}, > timor(28559)<ec><v508>:1025] > [vm_0][info 2016/04/23 13:18:07.139 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Finished joining (took 309ms). > [vm_0][info 2016/04/23 13:18:07.140 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Starting DistributionManager timor(28559)<ec><v508>:1025. (took > 317 ms) > [vm_0][info 2016/04/23 13:18:07.140 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initial (distribution manager) view = > View[timor(28554:locator)<ec><v0>:1024|508] members: > [timor(28554:locator)<ec><v0>:1024, timor(28567)<ec><v506>:1026{lead}, > timor(28559)<ec><v508>:1025] > [locator][info 2016/04/23 13:18:07.140 PDT <Geode Membership View Creator> > tid=0x27] sending new view View[timor(28554:locator)<ec><v0>:1024|508] > members: [timor(28554:locator)<ec><v0>:1024, > timor(28567)<ec><v506>:1026{lead}, timor(28559)<ec><v508>:1025] > [locator]failure detection ports: 45480 54017 11292 > [vm_0][info 2016/04/23 13:18:07.140 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Admitting member <timor(28554:locator)<ec><v0>:1024>. Now there > are 1 non-admin member(s). > [vm_0][info 2016/04/23 13:18:07.140 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Admitting member <timor(28567)<ec><v506>:1026>. Now there are 2 > non-admin member(s). > [vm_0][info 2016/04/23 13:18:07.140 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Admitting member <timor(28559)<ec><v508>:1025>. Now there are 3 > non-admin member(s). > [vm_1][info 2016/04/23 13:18:07.140 PDT <unicast receiver,timor-60465> > tid=0x2b18] received new view: View[timor(28554:locator)<ec><v0>:1024|508] > members: [timor(28554:locator)<ec><v0>:1024, > timor(28567)<ec><v506>:1026{lead}, timor(28559)<ec><v508>:1025] > [vm_1]old view is: View[timor(28554:locator)<ec><v0>:1024|507] members: > [timor(28554:locator)<ec><v0>:1024, timor(28567)<ec><v506>:1026{lead}] > shutdown: [timor(28559)<ec><v505>:1025] > [vm_1][info 2016/04/23 13:18:07.140 PDT <View Message Processor> tid=0x2b3a] > Membership: Processing addition < timor(28559)<ec><v508>:1025 > > [vm_1][info 2016/04/23 13:18:07.140 PDT <View Message Processor> tid=0x2b3a] > Admitting member <timor(28559)<ec><v508>:1025>. Now there are 3 non-admin > member(s). > [locator][info 2016/04/23 13:18:07.142 PDT <P2P message reader@b181f8e> > tid=0x88d] Admitting member <timor(28559)<ec><v508>:1025>. Now there are 3 > non-admin member(s). > [locator][info 2016/04/23 13:18:07.142 PDT <Pooled High Priority Message > Processor 1> tid=0x37] Member timor(28559)<ec><v508>:1025 is equivalent or in > the same redundancy zone. > [vm_1][info 2016/04/23 13:18:07.142 PDT <Pooled High Priority Message > Processor 1> tid=0x2b2e] Member timor(28559)<ec><v508>:1025 is equivalent or > in the same redundancy zone. > [vm_0][info 2016/04/23 13:18:07.143 PDT <P2P message reader for > timor(28567)<ec><v506>:1026 shared unordered uid=627 port=36571> tid=0x2bf0] > Member timor(28567)<ec><v506>:1026 is equivalent or in the same redundancy > zone. > [vm_0][info 2016/04/23 13:18:07.144 PDT <P2P message reader for > timor(28554:locator)<ec><v0>:1024 shared unordered uid=406 port=36572> > tid=0x2bef] Member timor(28554:locator)<ec><v0>:1024 is equivalent or in the > same redundancy zone. > [vm_0][info 2016/04/23 13:18:07.149 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initializing region _monitoringRegion_10.118.32.89<v508>1025 > [vm_0][info 2016/04/23 13:18:07.150 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initialization of region _monitoringRegion_10.118.32.89<v508>1025 > completed > [vm_0][info 2016/04/23 13:18:07.153 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] The cache has been created with > "use-cluster-configuration=false". It will not receive any cluster > configuration > [vm_0][info 2016/04/23 13:18:07.153 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initializing region PdxTypes > [vm_0][info 2016/04/23 13:18:07.155 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Region PdxTypes requesting initial image from > timor(28567)<ec><v506>:1026 > [vm_0][info 2016/04/23 13:18:07.155 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] PdxTypes is done getting image from timor(28567)<ec><v506>:1026. > isDeltaGII is false > [vm_0][info 2016/04/23 13:18:07.155 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initialization of region PdxTypes completed > [vm_0][info 2016/04/23 13:18:07.156 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Recovered disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion > with unique id 205bcb2352334cc8-a46d07de0e8dcc88 > [vm_0][info 2016/04/23 13:18:07.156 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Recovering oplog#1 > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm0/diskDir/disk0/BACKUP_PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion_1.drf > for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.156 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Recovering oplog#1 > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm0/diskDir/disk0/BACKUP_PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion_1.crf > for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.157 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] recovery oplog load took 1 ms > [vm_0][info 2016/04/23 13:18:07.157 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Created oplog#2 drf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.158 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Created oplog#2 crf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.158 PDT <Oplog Delete Task> tid=0x2bfe] > Deleted oplog#1 crf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.159 PDT <Oplog Delete Task> tid=0x2bfe] > Deleted oplog#1 drf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.159 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] recovery region initialization took 2 ms > [vm_0][info 2016/04/23 13:18:07.159 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initializing region __PR > [vm_0][info 2016/04/23 13:18:07.160 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Region __PR requesting initial image from > timor(28567)<ec><v506>:1026 > [vm_0][info 2016/04/23 13:18:07.160 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] __PR is done getting image from timor(28567)<ec><v506>:1026. > isDeltaGII is false > [vm_0][info 2016/04/23 13:18:07.160 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initialization of region __PR completed > [vm_0][info 2016/04/23 13:18:07.161 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Partitioned Region > /PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion > is created with prId=252 > [vm_0][info 2016/04/23 13:18:07.178 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: null > [vm_0] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$14.run > with 0 args on object: "create pr" (took 21420 ms) > [vm_0][info 2016/04/23 13:18:07.179 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$5.run > with 0 args on object: "CheckData" > [vm_0][info 2016/04/23 13:18:07.180 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: null > [vm_0] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$5.run > with 0 args on object: "CheckData" (took 0 ms) > [vm_1][info 2016/04/23 13:18:07.181 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$15.call > with 0 args on object: "get buckets" > [vm_1][info 2016/04/23 13:18:07.181 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Got result: [0, 1, 2, 3] > [vm_1] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$15.call > with 0 args on object: "get buckets" (took 0 ms) > [vm_0][info 2016/04/23 13:18:07.181 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$15.call > with 0 args on object: "get buckets" > [vm_0][info 2016/04/23 13:18:07.181 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: [] > [vm_0] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$15.call > with 0 args on object: "get buckets" (took 0 ms) > [vm_0][info 2016/04/23 13:18:07.182 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$8.run > with 0 args on object: "Close Cache" > [vm_0][info 2016/04/23 13:18:07.182 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] GemFireCache[id = 586988338; isClosing = true; isShutDownAll = > false; created = Sat Apr 23 13:18:07 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_1][info 2016/04/23 13:18:07.185 PDT <PartitionedRegion Message > Processor1> tid=0x2b35] The following persistent member has gone offline for > region > PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion: > [vm_1] DiskStore ID: 205bcb23-5233-4cc8-a46d-07de0e8dcc88 > [vm_1] Name: > [vm_1] Location: > /10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm0/diskDir/disk0 > [vm_1]Remaining participating members for the region include: > [vm_1][] > [vm_0][info 2016/04/23 13:18:07.187 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: null > [vm_0] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$8.run > with 0 args on object: "Close Cache" (took 5 ms) > [vm_1][info 2016/04/23 13:18:07.188 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$8.run > with 0 args on object: "Close Cache" > [vm_1][info 2016/04/23 13:18:07.189 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] GemFireCache[id = 556604746; isClosing = true; isShutDownAll = > false; created = Sat Apr 23 13:17:45 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_1][info 2016/04/23 13:18:07.194 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$8.run > with 0 args on object: "Close Cache" (took 6 ms) > [vm_0][info 2016/04/23 13:18:07.195 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$14.run > with 0 args on object: "create pr" > [vm_1][info 2016/04/23 13:18:07.195 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$14.run > with 0 args on object: "create pr" > [vm_1][info 2016/04/23 13:18:07.198 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Initializing region _monitoringRegion_10.118.32.89<v506>1026 > [vm_1][info 2016/04/23 13:18:07.199 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Initialization of region _monitoringRegion_10.118.32.89<v506>1026 > completed > [vm_0][info 2016/04/23 13:18:07.200 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initializing region _monitoringRegion_10.118.32.89<v508>1025 > [vm_0][info 2016/04/23 13:18:07.200 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initialization of region _monitoringRegion_10.118.32.89<v508>1025 > completed > [vm_1][info 2016/04/23 13:18:07.201 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] The cache has been created with "use-cluster-configuration=false". > It will not receive any cluster configuration > [vm_1][info 2016/04/23 13:18:07.201 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Initializing region PdxTypes > [vm_1][info 2016/04/23 13:18:07.202 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Initialization of region PdxTypes completed > [vm_0][info 2016/04/23 13:18:07.203 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] The cache has been created with > "use-cluster-configuration=false". It will not receive any cluster > configuration > [vm_0][info 2016/04/23 13:18:07.204 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initializing region PdxTypes > [vm_0][info 2016/04/23 13:18:07.205 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Region PdxTypes requesting initial image from > timor(28567)<ec><v506>:1026 > [vm_0][info 2016/04/23 13:18:07.205 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] PdxTypes is done getting image from timor(28567)<ec><v506>:1026. > isDeltaGII is false > [vm_0][info 2016/04/23 13:18:07.205 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initialization of region PdxTypes completed > [vm_1][info 2016/04/23 13:18:07.203 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Recovered disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion > with unique id 56d765a6ea3c4e45-8f4fae9ba9a410ed > [vm_1][info 2016/04/23 13:18:07.203 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Recovering oplog#1 > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1/BACKUP_PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion_1.drf > for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_1][info 2016/04/23 13:18:07.203 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Recovering oplog#1 > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1/BACKUP_PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion_1.crf > for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_1][info 2016/04/23 13:18:07.204 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] recovery oplog load took 1 ms > [vm_1][info 2016/04/23 13:18:07.204 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Created oplog#2 drf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_1][info 2016/04/23 13:18:07.205 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Created oplog#2 crf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_1][info 2016/04/23 13:18:07.205 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] recovery region initialization took 1 ms > [vm_1][info 2016/04/23 13:18:07.205 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Initializing region __PR > [vm_0][info 2016/04/23 13:18:07.207 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Recovered disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion > with unique id 205bcb2352334cc8-a46d07de0e8dcc88 > [vm_0][info 2016/04/23 13:18:07.207 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Recovering oplog#2 > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm0/diskDir/disk0/BACKUP_PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion_2.drf > for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.207 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Recovering oplog#2 > /timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm0/diskDir/disk0/BACKUP_PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion_2.crf > for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.207 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] recovery oplog load took 0 ms > [vm_0][info 2016/04/23 13:18:07.208 PDT <Oplog Delete Task> tid=0x2c0e] > Deleted oplog#2 crf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.208 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Created oplog#3 drf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.208 PDT <Oplog Delete Task> tid=0x2c0e] > Deleted oplog#2 drf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.208 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Created oplog#3 crf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.209 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] recovery region initialization took 2 ms > [vm_1][info 2016/04/23 13:18:07.209 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Initialization of region __PR completed > [vm_0][info 2016/04/23 13:18:07.209 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initializing region __PR > [vm_0][info 2016/04/23 13:18:07.211 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Region __PR requesting initial image from > timor(28567)<ec><v506>:1026 > [vm_0][info 2016/04/23 13:18:07.211 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] __PR is done getting image from timor(28567)<ec><v506>:1026. > isDeltaGII is false > [vm_0][info 2016/04/23 13:18:07.212 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Initialization of region __PR completed > [vm_1][info 2016/04/23 13:18:07.212 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Partitioned Region > /PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion > is born with prId=253 > ident:#PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion > [vm_1][info 2016/04/23 13:18:07.217 PDT <Idle OplogCompactor> tid=0x2b4f] > Created oplog#1 krf for disk store > _PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion. > [vm_0][info 2016/04/23 13:18:07.221 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Partitioned Region > /PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion > is created with prId=253 > [vm_1][info 2016/04/23 13:18:07.225 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_0> > tid=0x2b53] Initializing region > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_0 > [vm_1][info 2016/04/23 13:18:07.225 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_0> > tid=0x2b53] Region > /__PR/_B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_0 > recovered from the local disk. Old persistent ID: > /10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1 > created at timestamp 1461442665716 version 0 diskStoreId > 56d765a6ea3c4e45-8f4fae9ba9a410ed name null, new persistent ID > timor.gemstone.com/10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1 > created at timestamp 1461442687205 version 0 diskStoreId > 56d765a6ea3c4e45-8f4fae9ba9a410ed name null > [vm_1][info 2016/04/23 13:18:07.225 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_0> > tid=0x2b53] Initialization of region > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_0 > completed > [vm_1][info 2016/04/23 13:18:07.228 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_1> > tid=0x2b54] Initializing region > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_1 > [vm_1][info 2016/04/23 13:18:07.228 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_2> > tid=0x2b55] Initializing region > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_2 > [vm_1][info 2016/04/23 13:18:07.228 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_1> > tid=0x2b54] Region > /__PR/_B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_1 > recovered from the local disk. Old persistent ID: > /10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1 > created at timestamp 1461442665716 version 0 diskStoreId > 56d765a6ea3c4e45-8f4fae9ba9a410ed name null, new persistent ID > timor.gemstone.com/10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1 > created at timestamp 1461442687205 version 0 diskStoreId > 56d765a6ea3c4e45-8f4fae9ba9a410ed name null > [vm_1][info 2016/04/23 13:18:07.228 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_2> > tid=0x2b55] Region > /__PR/_B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_2 > recovered from the local disk. Old persistent ID: > /10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1 > created at timestamp 1461442665716 version 0 diskStoreId > 56d765a6ea3c4e45-8f4fae9ba9a410ed name null, new persistent ID > timor.gemstone.com/10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1 > created at timestamp 1461442687205 version 0 diskStoreId > 56d765a6ea3c4e45-8f4fae9ba9a410ed name null > [vm_1][info 2016/04/23 13:18:07.228 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_1> > tid=0x2b54] Initialization of region > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_1 > completed > [vm_1][info 2016/04/23 13:18:07.230 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_3> > tid=0x2b56] Initializing region > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_3 > [vm_1][info 2016/04/23 13:18:07.230 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_2> > tid=0x2b55] Initialization of region > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_2 > completed > [vm_1][info 2016/04/23 13:18:07.230 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_3> > tid=0x2b56] Region > /__PR/_B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_3 > recovered from the local disk. Old persistent ID: > /10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1 > created at timestamp 1461442665716 version 0 diskStoreId > 56d765a6ea3c4e45-8f4fae9ba9a410ed name null, new persistent ID > timor.gemstone.com/10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm1/diskDir/disk1 > created at timestamp 1461442687205 version 0 diskStoreId > 56d765a6ea3c4e45-8f4fae9ba9a410ed name null > [vm_1][info 2016/04/23 13:18:07.230 PDT <Recovery thread for bucket > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_3> > tid=0x2b56] Initialization of region > _B__PersistentPartitionedRegionOldConfigDUnitTest__testCrashDuringBucketCreationRegion_3 > completed > [vm_1][info 2016/04/23 13:18:07.232 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$14.run > with 0 args on object: "create pr" (took 36 ms) > [vm_0][info 2016/04/23 13:18:07.244 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: null > [vm_0] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$14.run > with 0 args on object: "create pr" (took 48 ms) > [vm_0][info 2016/04/23 13:18:07.244 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$5.run > with 0 args on object: "CheckData" > [vm_0][info 2016/04/23 13:18:07.245 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: null > [vm_0] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$5.run > with 0 args on object: "CheckData" (took 0 ms) > [vm_1][info 2016/04/23 13:18:07.245 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$15.call > with 0 args on object: "get buckets" > [vm_1][info 2016/04/23 13:18:07.246 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Got result: [0, 1, 2, 3] > [vm_1] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$15.call > with 0 args on object: "get buckets" (took 0 ms) > [vm_0][info 2016/04/23 13:18:07.246 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$15.call > with 0 args on object: "get buckets" > [vm_0][info 2016/04/23 13:18:07.246 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: [] > [vm_0] from > com.gemstone.gemfire.internal.cache.partitioned.PersistentPartitionedRegionTestBase$15.call > with 0 args on object: "get buckets" (took 0 ms) > [vm_0][info 2016/04/23 13:18:07.246 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1484318769.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1484318769@5b0c0540 > [vm_0][info 2016/04/23 13:18:07.247 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] GemFireCache[id = 1890620817; isClosing = true; isShutDownAll = > false; created = Sat Apr 23 13:18:07 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_1][info 2016/04/23 13:18:07.250 PDT <PartitionedRegion Message > Processor1> tid=0x2b35] The following persistent member has gone offline for > region > PersistentPartitionedRegionOldConfigDUnitTest_testCrashDuringBucketCreationRegion: > [vm_1] DiskStore ID: 205bcb23-5233-4cc8-a46d-07de0e8dcc88 > [vm_1] Name: > [vm_1] Location: > /10.118.32.89:/timor1/users/build/jenkins/blds/workspace/Geode_develop_DistributedTests/geode-core/build/distributedTest/dunit/vm0/diskDir/disk0 > [vm_1]Remaining participating members for the region include: > [vm_1][] > [vm_0][info 2016/04/23 13:18:07.256 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1484318769.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$5/1484318769@5b0c0540 > (took 9 ms) > [vm_1][info 2016/04/23 13:18:07.257 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/1077169608.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/1077169608@14e31231 > [vm_1][info 2016/04/23 13:18:07.258 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] GemFireCache[id = 2069372475; isClosing = true; isShutDownAll = > false; created = Sat Apr 23 13:18:07 PDT 2016; server = false; copyOnRead = > false; lockLease = 120; lockTimeout = 60]: Now closing. > [vm_1][info 2016/04/23 13:18:07.266 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/1077169608.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/1077169608@14e31231 > (took 8 ms) > [vm_2][info 2016/04/23 13:18:07.267 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/452343289.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/452343289@f27a19b > [vm_2][info 2016/04/23 13:18:07.267 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/452343289.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/452343289@f27a19b > (took 0 ms) > [vm_3][info 2016/04/23 13:18:07.268 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/1304034004.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/1304034004@3c5ffa21 > [vm_3][info 2016/04/23 13:18:07.269 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/1304034004.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.cache.internal.JUnit4CacheTestCase$$Lambda$4/1304034004@3c5ffa21 > (took 0 ms) > [vm_0][info 2016/04/23 13:18:07.269 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/753797051.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/753797051@95016b6 > [vm_0][info 2016/04/23 13:18:07.269 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/753797051.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/753797051@95016b6 > (took 0 ms) > [vm_1][info 2016/04/23 13:18:07.270 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/56469050.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/56469050@6097bea > [vm_1][info 2016/04/23 13:18:07.270 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/56469050.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/56469050@6097bea > (took 0 ms) > [vm_2][info 2016/04/23 13:18:07.270 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1129001861.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1129001861@5d6ea6c6 > [vm_2][info 2016/04/23 13:18:07.270 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1129001861.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/1129001861@5d6ea6c6 > (took 0 ms) > [vm_3][info 2016/04/23 13:18:07.271 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/2055484428.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/2055484428@26f0b1c9 > [vm_3][info 2016/04/23 13:18:07.271 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/2055484428.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$6/2055484428@26f0b1c9 > (took 0 ms) > [vm_0][info 2016/04/23 13:18:07.271 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1000958706.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1000958706@67a671e3 > [vm_0][info 2016/04/23 13:18:07.272 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Shutting down DistributionManager timor(28559)<ec><v508>:1025. > [locator][info 2016/04/23 13:18:07.272 PDT <Pooled High Priority Message > Processor 1> tid=0x37] received leave request from > timor(28559)<ec><v508>:1025 for timor(28559)<ec><v508>:1025 > [locator][info 2016/04/23 13:18:07.272 PDT <Pooled High Priority Message > Processor 1> tid=0x37] Member at timor(28559)<ec><v508>:1025 gracefully left > the distributed cache: shutdown message received > [vm_1][info 2016/04/23 13:18:07.272 PDT <Pooled High Priority Message > Processor 1> tid=0x2b2e] received leave request from > timor(28559)<ec><v508>:1025 for timor(28559)<ec><v508>:1025 > [vm_1][info 2016/04/23 13:18:07.272 PDT <Pooled High Priority Message > Processor 1> tid=0x2b2e] Member at timor(28559)<ec><v508>:1025 gracefully > left the distributed cache: shutdown message received > [locator][info 2016/04/23 13:18:07.375 PDT <unicast receiver,timor-50263> > tid=0x21] received leave request from timor(28559)<ec><v508>:1025 for > timor(28559)<ec><v508>:1025 > [vm_0][info 2016/04/23 13:18:07.375 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Now closing distribution for timor(28559)<ec><v508>:1025 > [vm_0][info 2016/04/23 13:18:07.375 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Stopping membership services > [vm_0][info 2016/04/23 13:18:07.375 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] GMSHealthMonitor server socket is closed in stopServices(). > [vm_0][info 2016/04/23 13:18:07.375 PDT <Geode Failure Detection Server > thread 0> tid=0x2be7] GMSHealthMonitor server thread exiting > [vm_0][info 2016/04/23 13:18:07.375 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] GMSHealthMonitor serverSocketExecutor is terminated > [vm_1][info 2016/04/23 13:18:07.376 PDT <unicast receiver,timor-60465> > tid=0x2b18] received leave request from timor(28559)<ec><v508>:1025 for > timor(28559)<ec><v508>:1025 > [vm_0][info 2016/04/23 13:18:07.378 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] DistributionManager stopped in 106ms. > [vm_0][info 2016/04/23 13:18:07.378 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Marking DistributionManager timor(28559)<ec><v508>:1025 as closed. > [vm_0][info 2016/04/23 13:18:07.379 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x26bc] Got result: null > [vm_0] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1000958706.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$8/1000958706@67a671e3 > (took 107 ms) > [vm_1][info 2016/04/23 13:18:07.379 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/489173932.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/489173932@73aa2a45 > [vm_1][info 2016/04/23 13:18:07.379 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Shutting down DistributionManager timor(28567)<ec><v506>:1026. > [locator][info 2016/04/23 13:18:07.381 PDT <Pooled High Priority Message > Processor 1> tid=0x37] received leave request from > timor(28567)<ec><v506>:1026 for timor(28567)<ec><v506>:1026 > [locator][info 2016/04/23 13:18:07.381 PDT <Pooled High Priority Message > Processor 1> tid=0x37] Member at timor(28567)<ec><v506>:1026 gracefully left > the distributed cache: shutdown message received > [vm_1][info 2016/04/23 13:18:07.483 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Now closing distribution for timor(28567)<ec><v506>:1026 > [vm_1][info 2016/04/23 13:18:07.483 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Stopping membership services > [vm_1][info 2016/04/23 13:18:07.483 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] GMSHealthMonitor server socket is closed in stopServices(). > [locator][info 2016/04/23 13:18:07.483 PDT <unicast receiver,timor-50263> > tid=0x21] received leave request from timor(28567)<ec><v506>:1026 for > timor(28567)<ec><v506>:1026 > [vm_1][info 2016/04/23 13:18:07.483 PDT <Geode Failure Detection Server > thread 0> tid=0x2b1c] GMSHealthMonitor server thread exiting > [vm_1][info 2016/04/23 13:18:07.483 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] GMSHealthMonitor serverSocketExecutor is terminated > [vm_1][info 2016/04/23 13:18:07.486 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] DistributionManager stopped in 106ms. > [vm_1][info 2016/04/23 13:18:07.486 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Marking DistributionManager timor(28567)<ec><v506>:1026 as closed. > [vm_1][info 2016/04/23 13:18:07.486 PDT <RMI TCP Connection(25)-10.118.32.89> > tid=0xba1] Got result: null > [vm_1] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/489173932.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/489173932@73aa2a45 > (took 107 ms) > [vm_3][info 2016/04/23 13:18:07.487 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x21c] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1150153427.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1150153427@1ff29a1a > [vm_2][info 2016/04/23 13:18:07.487 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x16ca] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1346000825.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1346000825@4a778120 > [vm_2][info 2016/04/23 13:18:07.487 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x16ca] Got result: null > [vm_2] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1346000825.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1346000825@4a778120 > (took 0 ms) > [vm_3][info 2016/04/23 13:18:07.487 PDT <RMI TCP Connection(27)-10.118.32.89> > tid=0x21c] Got result: null > [vm_3] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1150153427.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$7/1150153427@1ff29a1a > (took 0 ms) > [locator][info 2016/04/23 13:18:07.489 PDT <RMI TCP > Connection(12)-10.118.32.89> tid=0x624] Received method: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/41126736.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/41126736@80fa8fa > [locator][info 2016/04/23 13:18:07.489 PDT <RMI TCP > Connection(12)-10.118.32.89> tid=0x624] Got result: null > [locator] from > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/41126736.run > with 0 args on object: > com.gemstone.gemfire.test.dunit.internal.JUnit4DistributedTestCase$$Lambda$4/41126736@80fa8fa > (took 0 ms) > Standard Error > Suspicious strings were written to the log during this run. > Fix the strings or use IgnoredException.addIgnoredException to ignore. > ----------------------------------------------------------------------- > Found suspect string in log4j at line 1727 > [error 2016/04/23 13:17:18.147 PDT <RMI TCP Connection(26)-10.118.32.89> > tid=0x2053] > com.gemstone.gemfire.distributed.DistributedSystemDisconnectedException: This > connection to a distributed system has been disconnected. > Cache was closed on integer 287 > {noformat} -- This message was sent by Atlassian JIRA (v6.3.4#6332)