You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@geode.apache.org by "Dan Smith (JIRA)" <ji...@apache.org> on 2015/09/14 17:59:46 UTC

[jira] [Updated] (GEODE-314) Failure from PartitionManagerDUnitTest.testConcurrent in CI

     [ https://issues.apache.org/jira/browse/GEODE-314?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Dan Smith updated GEODE-314:
----------------------------
    Labels: CI  (was: )

> Failure from PartitionManagerDUnitTest.testConcurrent in CI
> -----------------------------------------------------------
>
>                 Key: GEODE-314
>                 URL: https://issues.apache.org/jira/browse/GEODE-314
>             Project: Geode
>          Issue Type: Bug
>            Reporter: Dan Smith
>            Assignee: Bruce Schuchardt
>              Labels: CI
>
> This test failed in CI
> https://builds.apache.org/job/Geode-nightly/208/testReport/junit/com.gemstone.gemfire.cache.partition/PartitionManagerDUnitTest/testConcurrent/
> {noformat}
> java.lang.Exception: An exception occured during async invocation
> 	at dunit.AsyncInvocation.getResult(AsyncInvocation.java:186)
> 	at com.gemstone.gemfire.cache.partition.PartitionManagerDUnitTest.testConcurrent(PartitionManagerDUnitTest.java:414)
> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 	at java.lang.reflect.Method.invoke(Method.java:606)
> 	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:86)
> 	at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:49)
> 	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.GeneratedMethodAccessor14.invoke(Unknown Source)
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 	at java.lang.reflect.Method.invoke(Method.java:606)
> 	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.GeneratedMethodAccessor13.invoke(Unknown Source)
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 	at java.lang.reflect.Method.invoke(Method.java:606)
> 	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.DefaultExecutorFactory$StoppableExecutorImpl$1.run(DefaultExecutorFactory.java:64)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> 	at java.lang.Thread.run(Thread.java:745)
> Caused by: dunit.RMIException: While invoking com.gemstone.gemfire.cache.partition.PartitionManagerDUnitTest$17.run in VM 1 running on Host asf902.gq1.ygridcore.net with 4 VMs
> 	at dunit.VM.invoke(VM.java:359)
> 	at dunit.VM$2.run(VM.java:211)
> 	at java.lang.Thread.run(Thread.java:745)
> 	at dunit.AsyncInvocation.run(AsyncInvocation.java:200)
> Caused by: com.gemstone.gemfire.InternalGemFireError: recordVersion invoked for a local version tag that is higher than our local version. rvv=RegionVersionVector{rv0 gc0}@1277419153, tag={v1; rv1; mbr=asf902<v1300>:34949; time=1441600063882; remote} region /__PR/_B__region1_5
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.internal.Assert.throwError(Assert.java:82)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.internal.Assert.fail(Assert.java:57)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.internal.cache.versions.RegionVersionVector.recordVersion(RegionVersionVector.java:586)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.internal.cache.InitialImageOperation.processChunk(InitialImageOperation.java:1005)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.internal.cache.InitialImageOperation$ImageProcessor.process(InitialImageOperation.java:1314)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.distributed.internal.ReplyMessage.process(ReplyMessage.java:222)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.internal.cache.InitialImageOperation$ImageReplyMessage.process(InitialImageOperation.java:2808)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.distributed.internal.ReplyMessage.dmProcess(ReplyMessage.java:203)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.distributed.internal.ReplyMessage.process(ReplyMessage.java:192)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.distributed.internal.DistributionMessage.scheduleAction(DistributionMessage.java:371)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.distributed.internal.DistributionMessage$1.run(DistributionMessage.java:442)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.distributed.internal.DistributionManager.runUntilShutdown(DistributionManager.java:692)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in com.gemstone.gemfire.distributed.internal.DistributionManager$5$1.run(DistributionManager.java:1000)
> 	at Remote Member 'asf902(19609)<v1300>:34949' in java.lang.Thread.run(Thread.java:745)
> 	at com.gemstone.gemfire.distributed.internal.ReplyException.handleAsUnexpected(ReplyException.java:79)
> 	at com.gemstone.gemfire.internal.cache.InitialImageOperation.getFromOne(InitialImageOperation.java:530)
> 	at com.gemstone.gemfire.internal.cache.DistributedRegion.getInitialImageAndRecovery(DistributedRegion.java:1429)
> 	at com.gemstone.gemfire.internal.cache.DistributedRegion.initialize(DistributedRegion.java:1215)
> 	at com.gemstone.gemfire.internal.cache.BucketRegion.initialize(BucketRegion.java:290)
> 	at com.gemstone.gemfire.internal.cache.LocalRegion.createSubregion(LocalRegion.java:1059)
> 	at com.gemstone.gemfire.internal.cache.PartitionedRegionDataStore.createBucketRegion(PartitionedRegionDataStore.java:800)
> 	at com.gemstone.gemfire.internal.cache.PartitionedRegionDataStore.grabFreeBucket(PartitionedRegionDataStore.java:477)
> 	at com.gemstone.gemfire.internal.cache.PartitionedRegionDataStore.grabBucket(PartitionedRegionDataStore.java:3013)
> 	at com.gemstone.gemfire.internal.cache.PRHARedundancyProvider.createBackupBucketOnMember(PRHARedundancyProvider.java:1140)
> 	at com.gemstone.gemfire.cache.partition.PartitionManager.createBucket(PartitionManager.java:249)
> 	at com.gemstone.gemfire.cache.partition.PartitionManager.createPrimaryBucket(PartitionManager.java:200)
> 	at com.gemstone.gemfire.cache.partition.PartitionManagerDUnitTest$17.run(PartitionManagerDUnitTest.java:372)
> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 	at java.lang.reflect.Method.invoke(Method.java:606)
> 	at hydra.MethExecutor.executeObject(MethExecutor.java:258)
> 	at dunit.standalone.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:67)
> 	at sun.reflect.GeneratedMethodAccessor8.invoke(Unknown Source)
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 	at java.lang.reflect.Method.invoke(Method.java:606)
> 	at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:322)
> 	at sun.rmi.transport.Transport$1.run(Transport.java:177)
> 	at sun.rmi.transport.Transport$1.run(Transport.java:174)
> 	at java.security.AccessController.doPrivileged(Native Method)
> 	at sun.rmi.transport.Transport.serviceCall(Transport.java:173)
> 	at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:556)
> 	at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:811)
> 	at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:670)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> 	at java.lang.Thread.run(Thread.java:745)
> [setup] START TEST PartitionManagerDUnitTest.testConcurrent
> [vm_2][info 2015/09/07 04:27:52.264 UTC <RMI TCP Connection(90)-67.195.81.146> tid=0x29e4] Received method: com.gemstone.gemfire.cache30.CacheTestCase.remoteTearDown with 0 args
> [vm_2]
> [vm_2][info 2015/09/07 04:27:52.265 UTC <RMI TCP Connection(90)-67.195.81.146> tid=0x29e4] Got result: null
> [vm_2] from com.gemstone.gemfire.cache30.CacheTestCase.remoteTearDown with 0 args (took 1 ms)
> [vm_2]
> [vm_2][info 2015/09/07 04:27:52.269 UTC <RMI TCP Connection(90)-67.195.81.146> tid=0x29e4] Received method: dunit.DistributedTestCase.cleanupThisVM with 0 args
> [vm_2]
> [vm_2][info 2015/09/07 04:27:52.269 UTC <RMI TCP Connection(90)-67.195.81.146> tid=0x29e4] Got result: null
> [vm_2] from dunit.DistributedTestCase.cleanupThisVM with 0 args (took 0 ms)
> [vm_2]
> [locator][info 2015/09/07 04:27:52.271 UTC <RMI TCP Connection(22)-67.195.81.146> tid=0x11] Received method: dunit.DistributedTestCase$5.run with 0 args on object: dunit.DistributedTestCase$5@57f08a50
> [locator]
> [locator][info 2015/09/07 04:27:52.271 UTC <RMI TCP Connection(22)-67.195.81.146> tid=0x11] Got result: null
> [locator] from dunit.DistributedTestCase$5.run with 0 args on object: dunit.DistributedTestCase$5@57f08a50 (took 0 ms)
> [locator]
> {noformat}
> There was an old GemFire bug that looked similar that is now closed - 50566



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)