[ https://issues.apache.org/jira/browse/IGNITE-9749?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16637383#comment-16637383 ]
Vladimir Ozerov commented on IGNITE-9749: ----------------------------------------- First of all, we should not continue our enlist loop in exchange thread. Next, we observe that returned list of affintiy nodes doesn't have local node as primary. As exchange was in progress, most probably some node was added or removed, and TX topology version was not updated accordingly. > Assertion error in JdbcThinTransactionsServerAutoCommitComplexSelfTest > leading to JDBC MVCC suite hang > ------------------------------------------------------------------------------------------------------ > > Key: IGNITE-9749 > URL: https://issues.apache.org/jira/browse/IGNITE-9749 > Project: Ignite > Issue Type: Bug > Components: mvcc > Reporter: Alexey Goncharuk > Priority: Critical > Labels: MakeTeamcityGreenAgain > Fix For: 2.7 > > > The following assertion can be observed in master > {code} > [10:34:12]W: [org.apache.ignite:ignite-clients] [07:34:12] (err) > Failed to notify listener: > o.a.i.i.util.future.GridEmbeddedFuture$2...@4e56da7bjava.lang.AssertionError: > localNode = 14353600-ea43-42ae-bf7c-4b4678000000, dhtNodes = > [TcpDiscoveryNode [id=04134719-3eb1-4969-99dc-f520f9800002, addrs=ArrayList > [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=3, > intOrder=3, lastExchangeTime=1538379249752, loc=false, > ver=2.7.0#20181001-sha1:9ab8ebd7, isClient=false]] > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxAbstractEnlistFuture.backupNodes(GridDhtTxAbstractEnlistFuture.java:867) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxAbstractEnlistFuture.addToBatch(GridDhtTxAbstractEnlistFuture.java:627) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxAbstractEnlistFuture.processEntry(GridDhtTxAbstractEnlistFuture.java:614) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxAbstractEnlistFuture.continueLoop(GridDhtTxAbstractEnlistFuture.java:501) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxAbstractEnlistFuture.init(GridDhtTxAbstractEnlistFuture.java:363) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxQueryEnlistFuture.map(GridNearTxQueryEnlistFuture.java:212) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxAbstractEnlistFuture.mapOnTopology(GridNearTxAbstractEnlistFuture.java:332) > [10:34:12] : [Step 4/5] [2018-10-01 07:34:12,762][INFO > ][exchange-worker-#2510%thin.JdbcThinTransactionsServerAutoCommitComplexSelfTest2%][GridCachePartitionExchangeManager] > Skipping rebalancing (nothing scheduled) [top=AffinityTopologyVersion > [topVer=4, minorTopVer=16], force=false, evt=DISCOVERY_CUSTOM_EVT, > node=14353600-ea43-42ae-bf7c-4b4678000000] > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxAbstractEnlistFuture.access$000(GridNearTxAbstractEnlistFuture.java:56) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxAbstractEnlistFuture$2.apply(GridNearTxAbstractEnlistFuture.java:340) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxAbstractEnlistFuture$2.apply(GridNearTxAbstractEnlistFuture.java:335) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListener(GridFutureAdapter.java:385) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.util.future.GridFutureAdapter.unblock(GridFutureAdapter.java:349) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.util.future.GridFutureAdapter.unblockAll(GridFutureAdapter.java:337) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:497) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:476) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.onDone(GridDhtPartitionsExchangeFuture.java:1947) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.finishExchangeOnCoordinator(GridDhtPartitionsExchangeFuture.java:3168) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.onAllReceived(GridDhtPartitionsExchangeFuture.java:2934) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.processSingleMessage(GridDhtPartitionsExchangeFuture.java:2550) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.access$100(GridDhtPartitionsExchangeFuture.java:138) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture$2.apply(GridDhtPartitionsExchangeFuture.java:2355) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture$2.apply(GridDhtPartitionsExchangeFuture.java:2343) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListener(GridFutureAdapter.java:385) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.util.future.GridFutureAdapter.listen(GridFutureAdapter.java:355) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.onReceiveSingleMessage(GridDhtPartitionsExchangeFuture.java:2343) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager.processSinglePartitionUpdate(GridCachePartitionExchangeManager.java:1661) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager.access$1200(GridCachePartitionExchangeManager.java:141) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager$2.onMessage(GridCachePartitionExchangeManager.java:374) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager$2.onMessage(GridCachePartitionExchangeManager.java:332) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager$MessageHandler.apply(GridCachePartitionExchangeManager.java:3094) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager$MessageHandler.apply(GridCachePartitionExc[2018-10-01 > > 07:34:12,768][ERROR][jdbc-rehangeManager.javquesa:3073)t-handler-worker-#2719%thin.JdbcThinTransactionsServe > [10:34:12]W: [org.apache.ignite:ignite-clients] > rAutoCommitComplexSelfTest0%][J at > org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:1056) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:581) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:380) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > odbcRequestHandler] > Runtimrg.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:306)e > error caught during grid runnable execution: Grid > [10:34:12]W: [org.apache.ignite:ignite-clients] Worker [name > at > org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$100(GridCacheIoMa=jdbc-request-handler-workenager.java:101)r > [10:34:12]W: [org.apache.ignite:ignite-clients] , igniteInstanceNam > at > org.apace=thin.JdbcThinThe.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:295) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.managers.communication.GridIoManager.invokeListener(GridIoManager.java:1569) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:1197) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.managers.communication.GridIoManager.access$4200(GridIoManager.java:127) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > org.apache.ignite.internal.managers.communication.GridIoManager$9.run(GridIoManager.java:1093) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) > [10:34:12]W: [org.apache.ignite:ignite-clients] at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)ransactionsServerAutoCommitComplexSel > {code} > which leads to the suite hang. > https://ci.ignite.apache.org/viewLog.html?buildId=1978576&buildTypeId=IgniteTests24Java8_MvccCache&tab=buildResultsDiv -- This message was sent by Atlassian JIRA (v7.6.3#76005)