[
https://issues.apache.org/jira/browse/IGNITE-1600?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Anton Vinogradov updated IGNITE-1600:
-------------------------------------
Labels: Muted_test (was: )
> [Test Failed] IgniteCacheEntryListenerTxTest.testEvents
> -------------------------------------------------------
>
> Key: IGNITE-1600
> URL: https://issues.apache.org/jira/browse/IGNITE-1600
> Project: Ignite
> Issue Type: Test
> Affects Versions: ignite-1.5
> Reporter: Anton Vinogradov
> Priority: Blocker
> Labels: Muted_test
> Fix For: ignite-1.5
>
>
> There is no guarantee that test failure will be produced each test run,
> please analyze logs in case of reproduction problem:
> junit.framework.AssertionFailedError: expected:<11> but was:<12>
> at junit.framework.Assert.fail(Assert.java:57)
> at junit.framework.Assert.failNotEquals(Assert.java:329)
> at junit.framework.Assert.assertEquals(Assert.java:78)
> at junit.framework.Assert.assertEquals(Assert.java:234)
> at junit.framework.Assert.assertEquals(Assert.java:241)
> at junit.framework.TestCase.assertEquals(TestCase.java:409)
> at
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest.checkEvents(IgniteCacheEntryListenerAbstractTest.java:804)
> at
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest.checkEvents(IgniteCacheEntryListenerAbstractTest.java:590)
> at
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest.testEvents(IgniteCacheEntryListenerAbstractTest.java:459)
> 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
> org.apache.ignite.testframework.junits.GridAbstractTest.runTestInternal(GridAbstractTest.java:1665)
> at
> org.apache.ignite.testframework.junits.GridAbstractTest.access$000(GridAbstractTest.java:111)
> at
> org.apache.ignite.testframework.junits.GridAbstractTest$6.run(GridAbstractTest.java:1603)
> ------- Stdout: -------
> [12:53:31,916][INFO ][main][root] >>> Starting test: testEvents <<<
> [12:53:31,949][INFO ][test-runner][root] Check create event [key=0]
> [12:53:31,951][INFO ][test-runner][root] Caught expected exception: Listener
> is already registered for configuration:
> javax.cache.configuration.MutableCacheEntryListenerConfiguration@23983b48
> [12:53:32,869][INFO ][test-runner][root] Remove listener.
> [12:53:33,374][INFO ][test-runner][root] Check update event [key=0]
> [12:53:33,375][INFO ][test-runner][root] Caught expected exception: Listener
> is already registered for configuration:
> javax.cache.configuration.MutableCacheEntryListenerConfiguration@44a48433
> [12:53:34,296][INFO ][main][root] >>> Stopping test: testEvents in 2380 ms <<<
> [12:53:34,296][INFO ][main][root] >>> Stopping test class:
> IgniteCacheEntryListenerTxTest <<<
> [12:53:34,296][INFO ][main][root] >>> Stopping grid
> [name=cache.IgniteCacheEntryListenerTxTest2,
> id=203e1517-5451-4f52-96ec-273e6eb88002]
> [12:53:34,300][INFO
> ][disco-event-worker-#1150%cache.IgniteCacheEntryListenerTxTest0%][GridDiscoveryManager]
> Node left topology: TcpDiscoveryNode
> [id=203e1517-5451-4f52-96ec-273e6eb88002, addrs=[127.0.0.1],
> sockAddrs=[/127.0.0.1:47500], discPort=47500, order=3, intOrder=3,
> lastExchangeTime=1443693189197, loc=false, ver=1.5.0#19700101-sha1:00000000,
> isClient=false]
> [12:53:34,301][INFO
> ][disco-event-worker-#1150%cache.IgniteCacheEntryListenerTxTest0%][GridDiscoveryManager]
> Topology snapshot [ver=8, servers=2, clients=0, CPUs=8, heap=2.7GB]
> [12:53:34,301][INFO
> ][disco-event-worker-#1153%cache.IgniteCacheEntryListenerTxTest1%][GridDiscoveryManager]
> Node left topology: TcpDiscoveryNode
> [id=203e1517-5451-4f52-96ec-273e6eb88002, addrs=[127.0.0.1],
> sockAddrs=[/127.0.0.1:47500], discPort=47500, order=3, intOrder=3,
> lastExchangeTime=1443693189197, loc=false, ver=1.5.0#19700101-sha1:00000000,
> isClient=false]
> [12:53:34,301][INFO
> ][disco-event-worker-#1153%cache.IgniteCacheEntryListenerTxTest1%][GridDiscoveryManager]
> Topology snapshot [ver=8, servers=2, clients=0, CPUs=8, heap=2.7GB]
> [12:53:34,303][INFO ][main][GridCacheProcessor] Stopped cache: null
> [12:53:34,303][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-marshaller-sys-cache
> [12:53:34,304][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-sys-cache
> [12:53:34,304][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-atomics-sys-cache
> [12:53:34,304][INFO ][main][GridDeploymentLocalStore] Removed undeployed
> class: GridDeployment [ts=1443693189217, depMode=SHARED,
> clsLdr=IsolatedClassLoader{roleName='test'},
> clsLdrId=929d0d22051-203e1517-5451-4f52-96ec-273e6eb88002, userVer=0,
> loc=true,
> sampleClsName=org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionFullMap,
> pendingUndeploy=false, undeployed=true, usage=0]
> [12:53:34,304][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionFullMap
> [12:53:34,304][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class java.lang.Integer
> [12:53:34,304][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.CacheEntryPredicateNoValue
> [12:53:34,304][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionMap
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager$ResendTimeoutObject$1
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.GridTopic$T7
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.distributed.IgniteExternalizableExpiryPolicy
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.typedef.T2
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.GridLeanMap
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.GridLeanMap$Map3
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest$EntrySetValueProcessor
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.task.GridTaskProcessor$TaskDiscoveryListener$1
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class java.lang.Object
> [12:53:34,305][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest$EntryToStringProcessor
> [12:53:34,309][INFO ][main][IgniteCacheEntryListenerTxTest2]
> >>> +-----------------------------------------------------+
> >>> Ignite ver. 1.5.0-SNAPSHOT#19700101-sha1:DEV stopped OK
> >>> +-----------------------------------------------------+
> >>> Grid name: cache.IgniteCacheEntryListenerTxTest2
> >>> Grid uptime: 00:00:25:63
> [12:53:34,315][INFO ][main][root] >>> Stopping grid
> [name=cache.IgniteCacheEntryListenerTxTest0,
> id=00d21a85-3fa7-4ecd-bc4b-9e5f4295c000]
> [12:53:34,334][INFO
> ][disco-event-worker-#1153%cache.IgniteCacheEntryListenerTxTest1%][GridDiscoveryManager]
> Node left topology: TcpDiscoveryNode
> [id=00d21a85-3fa7-4ecd-bc4b-9e5f4295c000, addrs=[127.0.0.1],
> sockAddrs=[/127.0.0.1:47501], discPort=47501, order=1, intOrder=1,
> lastExchangeTime=1443693188722, loc=false, ver=1.5.0#19700101-sha1:00000000,
> isClient=false]
> [12:53:34,334][INFO
> ][disco-event-worker-#1153%cache.IgniteCacheEntryListenerTxTest1%][GridDiscoveryManager]
> Topology snapshot [ver=9, servers=1, clients=0, CPUs=8, heap=2.7GB]
> [12:53:34,346][INFO ][main][GridCacheProcessor] Stopped cache: null
> [12:53:34,346][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-marshaller-sys-cache
> [12:53:34,346][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-sys-cache
> [12:53:34,346][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-atomics-sys-cache
> [12:53:34,346][INFO ][main][GridDeploymentLocalStore] Removed undeployed
> class: GridDeployment [ts=1443693188742, depMode=SHARED,
> clsLdr=IsolatedClassLoader{roleName='test'},
> clsLdrId=f64d0d22051-00d21a85-3fa7-4ecd-bc4b-9e5f4295c000, userVer=0,
> loc=true,
> sampleClsName=org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionMap,
> pendingUndeploy=false, undeployed=true, usage=0]
> [12:53:34,346][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.typedef.T2
> [12:53:34,346][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class java.lang.Integer
> [12:53:34,346][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.GridLeanMap
> [12:53:34,346][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.GridLeanMap$Map3
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.CacheEntryPredicateNoValue
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionMap
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager$ResendTimeoutObject$1
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.GridTopic$T7
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest$EntrySetValueProcessor
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.task.GridTaskProcessor$TaskDiscoveryListener$1
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.distributed.IgniteExternalizableExpiryPolicy
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class java.lang.Object
> [12:53:34,347][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest$EntryToStringProcessor
> [12:53:34,348][INFO ][main][IgniteCacheEntryListenerTxTest0]
> >>> +-----------------------------------------------------+
> >>> Ignite ver. 1.5.0-SNAPSHOT#19700101-sha1:DEV stopped OK
> >>> +-----------------------------------------------------+
> >>> Grid name: cache.IgniteCacheEntryListenerTxTest0
> >>> Grid uptime: 00:00:25:601
> [12:53:34,350][INFO ][main][root] >>> Stopping grid
> [name=cache.IgniteCacheEntryListenerTxTest1,
> id=10bbbc56-8ef1-4efd-946d-a7d574260001]
> [12:53:34,353][INFO ][main][GridCacheProcessor] Stopped cache: null
> [12:53:34,353][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-marshaller-sys-cache
> [12:53:34,353][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-sys-cache
> [12:53:34,353][INFO ][main][GridCacheProcessor] Stopped cache:
> ignite-atomics-sys-cache
> [12:53:34,353][INFO ][main][GridDeploymentLocalStore] Removed undeployed
> class: GridDeployment [ts=1443693188742, depMode=SHARED,
> clsLdr=IsolatedClassLoader{roleName='test'},
> clsLdrId=174d0d22051-10bbbc56-8ef1-4efd-946d-a7d574260001, userVer=0,
> loc=true,
> sampleClsName=org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionFullMap,
> pendingUndeploy=false, undeployed=true, usage=0]
> [12:53:34,353][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionFullMap
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class java.lang.Integer
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.CacheEntryPredicateNoValue
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionMap
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager$ResendTimeoutObject$1
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.GridTopic$T7
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.distributed.IgniteExternalizableExpiryPolicy
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.typedef.T2
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.GridLeanMap
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class org.apache.ignite.internal.util.GridLeanMap$Map3
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest$EntrySetValueProcessor
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.task.GridTaskProcessor$TaskDiscoveryListener$1
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class java.lang.Object
> [12:53:34,354][INFO ][main][GridDeploymentLocalStore] Class locally
> undeployed: class
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest$EntryToStringProcessor
> [12:53:34,355][INFO ][main][IgniteCacheEntryListenerTxTest1]
> >>> +-----------------------------------------------------+
> >>> Ignite ver. 1.5.0-SNAPSHOT#19700101-sha1:DEV stopped OK
> >>> +-----------------------------------------------------+
> >>> Grid name: cache.IgniteCacheEntryListenerTxTest1
> >>> Grid uptime: 00:00:25:594
> ------- Stderr: -------
> [12:53:34,295][ERROR][main][root] Test failed.
> junit.framework.AssertionFailedError: expected:<11> but was:<12>
> at junit.framework.Assert.fail(Assert.java:57)
> at junit.framework.Assert.failNotEquals(Assert.java:329)
> at junit.framework.Assert.assertEquals(Assert.java:78)
> at junit.framework.Assert.assertEquals(Assert.java:234)
> at junit.framework.Assert.assertEquals(Assert.java:241)
> at junit.framework.TestCase.assertEquals(TestCase.java:409)
> at
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest.checkEvents(IgniteCacheEntryListenerAbstractTest.java:804)
> at
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest.checkEvents(IgniteCacheEntryListenerAbstractTest.java:590)
> at
> org.apache.ignite.internal.processors.cache.IgniteCacheEntryListenerAbstractTest.testEvents(IgniteCacheEntryListenerAbstractTest.java:459)
> 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
> org.apache.ignite.testframework.junits.GridAbstractTest.runTestInternal(GridAbstractTest.java:1665)
> at
> org.apache.ignite.testframework.junits.GridAbstractTest.access$000(GridAbstractTest.java:111)
> at
> org.apache.ignite.testframework.junits.GridAbstractTest$6.run(GridAbstractTest.java:1603)
> [12:53:34,300][WARN
> ][tcp-disco-sock-reader-#729%cache.IgniteCacheEntryListenerTxTest2][TcpDiscoverySpi]
> Failed to read magic header (too few bytes received)
> [rmtAddr=/127.0.0.1:64732, locAddr=/127.0.0.1:47500]
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
