You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@ignite.apache.org by "Denis Magda (JIRA)" <ji...@apache.org> on 2015/07/15 13:12:04 UTC

[jira] [Created] (IGNITE-1124) IgniteCacheAtomicReplicatedNodeRestartSelfTest hangs because of an assertion

Denis Magda created IGNITE-1124:
-----------------------------------

             Summary: IgniteCacheAtomicReplicatedNodeRestartSelfTest hangs because of an assertion
                 Key: IGNITE-1124
                 URL: https://issues.apache.org/jira/browse/IGNITE-1124
             Project: Ignite
          Issue Type: Bug
          Components: cache
    Affects Versions: sprint-7
            Reporter: Denis Magda
            Priority: Critical


This test hangs almost always causing the execution timeout of the whole Ignite Cache Restarts suite.

The test start hanging after the following error appears in the log:

{noformat}
java.lang.AssertionError: null
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridNearAtomicUpdateFuture$2.apply(GridNearAtomicUpdateFuture.java:1011)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridNearAtomicUpdateFuture$2.apply(GridNearAtomicUpdateFuture.java:1008)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onDone(GridDhtAtomicUpdateFuture.java:309)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onDone(GridDhtAtomicUpdateFuture.java:47)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:291)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.checkComplete(GridDhtAtomicUpdateFuture.java:407)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,298][INFO ][disco-event-worker-#166979%replicated.IgniteCacheAtomicReplicatedNodeRestartSelfTest5%][GridDiscoveryManager] Node left topology: TcpDiscoveryNode [id=3028cca9-7f58-4355-81b1-017e948ba003, addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:47504], discPort=47504, order=326, intOrder=166, loc=false, ver=1.4.1#19700101-sha1:00000000, isClient=false]
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onNodeLeft(GridDhtAtomicUpdateFuture.java:152)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,298][INFO ][disco-event-worker-#166979%replicated.IgniteCacheAtomicReplicatedNodeRestartSelfTest5%][GridDiscoveryManager] Topology snapshot [ver=330, server nodes=4, client nodes=0, CPUs=4, heap=2.8GB]
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.GridCacheMvccManager$3.onEvent(GridCacheMvccManager.java:197)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,299][INFO ][restart-worker-1][TcpDiscoverySpi] Successfully bound to TCP port [port=47504, localHost=/127.0.0.1]
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:745)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:730)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.record(GridEventStorageManager.java:270)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.recordEvent(GridDiscoveryManager.java:1740)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body0(GridDiscoveryManager.java:1931)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body(GridDiscoveryManager.java:1779)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:108)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at java.lang.Thread.run(Thread.java:745)
[13:22:38]W:		 [org.apache.ignite:ignite-core] [13:22:38,298][ERROR][disco-event-worker-#155953%replicated.IgniteCacheAtomicReplicatedNodeRestartSelfTest1%][GridDiscoveryManager] Unexpected exception in discovery worker thread (ignored).
[13:22:38]W:		 [org.apache.ignite:ignite-core] java.lang.AssertionError: null
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridNearAtomicUpdateFuture$2.apply(GridNearAtomicUpdateFuture.java:1011)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridNearAtomicUpdateFuture$2.apply(GridNearAtomicUpdateFuture.java:1008)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onDone(GridDhtAtomicUpdateFuture.java:309)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onDone(GridDhtAtomicUpdateFuture.java:47)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:291)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.checkComplete(GridDhtAtomicUpdateFuture.java:407)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onNodeLeft(GridDhtAtomicUpdateFuture.java:152)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.GridCacheMvccManager$3.onEvent(GridCacheMvccManager.java:197)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:745)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:730)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.record(GridEventStorageManager.java:270)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.recordEvent(GridDiscoveryManager.java:1740)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body0(GridDiscoveryManager.java:1931)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,299][INFO ][restart-worker-0][GridCacheProcessor] Stopped cache: TEST_CACHE
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body(GridDiscoveryManager.java:1779)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,299][INFO ][restart-worker-0][GridCacheProcessor] Stopped cache: ignite-marshaller-sys-cache
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:108)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,299][INFO ][restart-worker-0][GridCacheProcessor] Stopped cache: ignite-sys-cache
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at java.lang.Thread.run(Thread.java:745)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,299][INFO ][restart-worker-0][GridCacheProcessor] Stopped cache: ignite-atomics-sys-cache
[13:22:38]W:		 [org.apache.ignite:ignite-core] [13:22:38,298][ERROR][disco-event-worker-#155953%replicated.IgniteCacheAtomicReplicatedNodeRestartSelfTest1%][GridDiscoveryManager] Runtime error caught during grid runnable execution: DiscoveryWorker [nodeSegFired=false]
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,300][INFO ][restart-worker-0][GridDeploymentLocalStore] Removed undeployed class: GridDeployment [ts=1436955758178, depMode=SHARED, clsLdr=IsolatedClassLoader{roleName='test'}, clsLdrId=7680a819e41-3028cca9-7f58-4355-81b1-017e948ba003, userVer=0, loc=true, sampleClsName=org.apache.ignite.internal.processors.task.GridTaskProcessor$TaskDiscoveryListener$1, pendingUndeploy=false, undeployed=true, usage=0]
[13:22:38]W:		 [org.apache.ignite:ignite-core] java.lang.AssertionError: null
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridNearAtomicUpdateFuture$2.apply(GridNearAtomicUpdateFuture.java:1011)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,300][INFO ][restart-worker-0][GridDeploymentLocalStore] Class locally undeployed: class org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionFullMap
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridNearAtomicUpdateFuture$2.apply(GridNearAtomicUpdateFuture.java:1008)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,300][INFO ][restart-worker-0][GridDeploymentLocalStore] Class locally undeployed: class org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionMap
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onDone(GridDhtAtomicUpdateFuture.java:309)
[13:22:38] :		 [org.apache.ignite:ignite-core] [13:22:38,300][INFO ][restart-worker-0][GridDeploymentLocalStore] Class locally undeployed: class org.apache.ignite.internal.processors.task.GridTaskProcessor$TaskDiscoveryListener$1
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onDone(GridDhtAtomicUpdateFuture.java:47)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:291)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.checkComplete(GridDhtAtomicUpdateFuture.java:407)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onNodeLeft(GridDhtAtomicUpdateFuture.java:152)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.GridCacheMvccManager$3.onEvent(GridCacheMvccManager.java:197)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:745)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:730)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.record(GridEventStorageManager.java:270)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.recordEvent(GridDiscoveryManager.java:1740)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body0(GridDiscoveryManager.java:1931)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body(GridDiscoveryManager.java:1779)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:108)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at java.lang.Thread.run(Thread.java:745)
[13:22:38]W:		 [org.apache.ignite:ignite-core] Exception in thread "disco-event-worker-#155953%replicated.IgniteCacheAtomicReplicatedNodeRestartSelfTest1%" java.lang.AssertionError: null
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridNearAtomicUpdateFuture$2.apply(GridNearAtomicUpdateFuture.java:1011)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridNearAtomicUpdateFuture$2.apply(GridNearAtomicUpdateFuture.java:1008)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onDone(GridDhtAtomicUpdateFuture.java:309)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onDone(GridDhtAtomicUpdateFuture.java:47)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:291)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.checkComplete(GridDhtAtomicUpdateFuture.java:407)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.distributed.dht.atomic.GridDhtAtomicUpdateFuture.onNodeLeft(GridDhtAtomicUpdateFuture.java:152)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.processors.cache.GridCacheMvccManager$3.onEvent(GridCacheMvccManager.java:197)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:745)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:730)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.record(GridEventStorageManager.java:270)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.recordEvent(GridDiscoveryManager.java:1740)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body0(GridDiscoveryManager.java:1931)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body(GridDiscoveryManager.java:1779)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:108)
[13:22:38]W:		 [org.apache.ignite:ignite-core] 	at java.lang.Thread.run(Thread.java:745)
{noformat}



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