You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@ignite.apache.org by "Semen Boikov (JIRA)" <ji...@apache.org> on 2015/08/31 08:16:45 UTC

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

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

Semen Boikov closed IGNITE-1124.
--------------------------------
    Assignee:     (was: Alexey Goncharuk)

> 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
>             Fix For: ignite-1.4
>
>         Attachments: ignite-1124.patch
>
>
> 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)