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

Vladimir Ozerov updated IGNITE-1738:
------------------------------------
    Fix Version/s:     (was: 1.8)
                   2.0

> [Test Failed] IgniteClientReconnectCacheTest.testReconnect
> ----------------------------------------------------------
>
>                 Key: IGNITE-1738
>                 URL: https://issues.apache.org/jira/browse/IGNITE-1738
>             Project: Ignite
>          Issue Type: Test
>            Reporter: Artem Shutak
>            Priority: Critical
>              Labels: Muted_test
>             Fix For: 2.0
>
>
> Test fails on TC sometime. Could not reproduce locally.
> Test log
> {noformat}
> junit.framework.AssertionFailedError: expected:<21> but was:<20>
>     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:86)
>     at junit.framework.TestCase.assertEquals(TestCase.java:253)
>     at 
> org.apache.ignite.internal.IgniteClientReconnectCacheTest.testReconnect(IgniteClientReconnectCacheTest.java:280)
> ------- Stdout: -------
> [20:07:22,890][INFO ][main][root] >>> Starting test: testReconnect <<<
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] 
> >>>    __________  ________________  
> >>>   /  _/ ___/ |/ /  _/_  __/ __/  
> >>>  _/ // (7 7    // /  / / / _/    
> >>> /___/\___/_/|_/___/ /_/ /___/   
> >>> 
> >>> ver. 1.5.0-SNAPSHOT#20151019-sha1:10ef06a1
> >>> 2015 Copyright(C) Apache Software Foundation
> >>> 
> >>> Ignite documentation: http://ignite.apache.org
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] Config URL: n/a
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] Daemon mode: off
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] OS: Linux 
> 2.6.32-74-generic amd64
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] OS user: teamcity
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] Language 
> runtime: Java Platform API Specification ver. 1.7
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] VM information: 
> Java(TM) SE Runtime Environment 1.7.0_21-b11 Oracle Corporation Java 
> HotSpot(TM) 64-Bit Server VM 23.21-b01
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] VM total memory: 
> 2.7GB
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] Remote 
> Management [restart: off, REST: off, JMX (remote: off)]
> [20:07:22,896][INFO ][main][IgniteClientReconnectCacheTest0] 
> IGNITE_HOME=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2
> [20:07:22,897][INFO ][main][IgniteClientReconnectCacheTest0] VM arguments: 
> [-DJAVA_HOME=/home/teamcity/jdk1.7.0_21, -DMCAST_GRP=229.15.1.2, 
> -Dagent.home.dir=/usr/local/TeamCityAgent, -Dagent.name=teamcity-5, 
> -Dagent.ownPort=9090, -Dagent.work.dir=/usr/local/TeamCityAgent/work, 
> -Dbuild.number=560, 
> -Dbuild.vcs.number=10ef06a14245c73cbfe66b744406a0391c4a9c08, 
> -Dbuild.vcs.number.1=10ef06a14245c73cbfe66b744406a0391c4a9c08, 
> -Dbuild.vcs.number.ApacheIgniteMirrorOnGitHub=10ef06a14245c73cbfe66b744406a0391c4a9c08,
>  -Dclassworlds.conf=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.m2.conf, 
> -Dcom.jetbrains.maven.watcher.report.file=/usr/local/TeamCityAgent/temp/buildTmp/maven-build-info.xml,
>  -Djava.io.tmpdir=/usr/local/TeamCityAgent/temp/buildTmp, 
> -Dmaven.home=/usr/local/TeamCityAgent/tools/maven3, 
> -Dmaven.repo.local=/home/teamcity/.m2/repository, 
> -Dteamcity.agent.cpuBenchmark=665, 
> -Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2, 
> -Dteamcity.agent.dotnet.build_id=554010, 
> -Dteamcity.auth.password=NZJLF36rtgBzyZan9Rlqx1nibYhaTdzk, 
> -Dteamcity.auth.userId=TeamCityBuildId=554010, 
> -Dteamcity.build.changedFiles.file=/usr/local/TeamCityAgent/temp/buildTmp/changedFiles2364753307910338165.txt,
>  -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -Dteamcity.build.id=554010, 
> -Dteamcity.build.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.build7009344645725909149.properties,
>  -Dteamcity.build.tempDir=/usr/local/TeamCityAgent/temp/buildTmp, 
> -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -Dteamcity.buildConfName=Ignite Client Nodes, 
> -Dteamcity.buildType.id=Ignite_IgniteClients, 
> -Dteamcity.configuration.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.config8423242305191431229.properties,
>  -Dteamcity.idea.home=/usr/local/TeamCityAgent/plugins/idea, 
> -Dteamcity.maven.watcher.home=/usr/local/TeamCityAgent/plugins/mavenPlugin/maven-watcher,
>  -Dteamcity.projectName=Ignite Tests, 
> -Dteamcity.runner.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.runner2097693476768347057.properties,
>  
> -Dteamcity.tests.recentlyFailedTests.file=/usr/local/TeamCityAgent/temp/buildTmp/testsToRunFirst6738565233989795504.txt,
>  -Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=1024m, -Xms1g, 
> -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, 
> -XX:HeapDumpPath=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -XX:+AggressiveOpts, 
> -DIGNITE_TEST_HOME=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true, 
> -DIGNITE_QUIET=false]
> [20:07:22,897][INFO ][main][IgniteClientReconnectCacheTest0] Configured 
> caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 
> 'ignite-atomics-sys-cache', 'static-cache']
> [20:07:22,897][INFO ][main][IgniteClientReconnectCacheTest0] 3-rd party 
> licenses can be found at: 
> /usr/local/TeamCityAgent/work/f87ae3766fbb88e2/libs/licenses
> [20:07:22,899][INFO ][main][IgniteClientReconnectCacheTest0] Non-loopback 
> local IPs: 192.168.2.15, fe80:0:0:0:ca60:ff:fe68:582f%2
> [20:07:22,899][INFO ][main][IgniteClientReconnectCacheTest0] Enabled local 
> MACs: C8600068582F
> [20:07:22,899][INFO ][main][IgnitePluginProcessor] Configured plugins:
> [20:07:22,899][INFO ][main][IgnitePluginProcessor]   ^-- None
> [20:07:22,899][INFO ][main][IgnitePluginProcessor] 
> [20:07:22,900][INFO 
> ][main][IgniteClientReconnectCacheTest$TestCommunicationSpi] Successfully 
> bound to TCP port [port=47100, locHost=/127.0.0.1]
> [20:07:22,903][INFO ][main][IgniteClientReconnectCacheTest0] Security status 
> [authentication=off, tls/ssl=off]
> [20:07:22,906][INFO 
> ][main][IgniteClientReconnectAbstractTest$TestTcpDiscoverySpi] Successfully 
> bound to TCP port [port=47500, localHost=/127.0.0.1]
> [20:07:24,916][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-marshaller-sys-cache, mode=REPLICATED]
> [20:07:24,919][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-atomics-sys-cache, mode=PARTITIONED]
> [20:07:24,922][INFO ][main][GridCacheProcessor] Started cache 
> [name=static-cache, mode=PARTITIONED]
> [20:07:24,924][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-sys-cache, mode=REPLICATED]
> [20:07:24,931][INFO ][main][GridDhtPreloader] <ignite-marshaller-sys-cache> 
> Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache
> [20:07:24,931][INFO ][main][GridDhtPreloader] <ignite-atomics-sys-cache> 
> Starting rebalancing in SYNC mode: ignite-atomics-sys-cache
> [20:07:24,931][INFO ][main][GridDhtPreloader] <static-cache> Starting 
> rebalancing in ASYNC mode: static-cache
> [20:07:24,931][INFO ][main][GridDhtPreloader] <ignite-sys-cache> Starting 
> rebalancing in SYNC mode: ignite-sys-cache
> [20:07:24,932][INFO 
> ][preloader-demand-worker-#4824%internal.IgniteClientReconnectCacheTest0%][GridDhtPreloader]
>  <ignite-marshaller-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-marshaller-sys-cache, time=0 ms]
> [20:07:24,934][INFO 
> ][preloader-demand-worker-#4828%internal.IgniteClientReconnectCacheTest0%][GridDhtPreloader]
>  <ignite-atomics-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-atomics-sys-cache, time=0 ms]
> [20:07:24,935][INFO 
> ][preloader-demand-worker-#4833%internal.IgniteClientReconnectCacheTest0%][GridDhtPreloader]
>  <static-cache> Completed rebalancing in ASYNC mode [cache=static-cache, 
> time=0 ms]
> [20:07:24,935][INFO 
> ][preloader-demand-worker-#4837%internal.IgniteClientReconnectCacheTest0%][GridDhtPreloader]
>  <ignite-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-sys-cache, time=0 ms]
> [20:07:24,941][INFO ][main][IgniteClientReconnectCacheTest0] Performance 
> suggestions for grid 'internal.IgniteClientReconnectCacheTest0' (fix if 
> possible)
> [20:07:24,941][INFO ][main][IgniteClientReconnectCacheTest0] To disable, set 
> -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
> [20:07:24,941][INFO ][main][IgniteClientReconnectCacheTest0]   ^-- Disable 
> checkpoints (remove 'checkpointSpi' from configuration)
> [20:07:24,941][INFO ][main][IgniteClientReconnectCacheTest0]   ^-- Disable 
> grid events (remove 'includeEventTypes' from configuration)
> [20:07:24,941][INFO ][main][IgniteClientReconnectCacheTest0] 
> [20:07:24,941][INFO ][main][IgniteClientReconnectCacheTest0] To start Console 
> Management & Monitoring run ignitevisorcmd.{sh|bat}
> [20:07:24,941][INFO ][main][IgniteClientReconnectCacheTest0] 
> [20:07:24,942][INFO ][main][IgniteClientReconnectCacheTest0] 
> >>> +-------------------------------------------------------------------------------+
> >>> Ignite ver. 
> >>> 1.5.0-SNAPSHOT#20151019-sha1:10ef06a14245c73cbfe66b744406a0391c4a9c08
> >>> +-------------------------------------------------------------------------------+
> >>> OS name: Linux 2.6.32-74-generic amd64
> >>> CPU(s): 4
> >>> Heap: 2.7GB
> >>> VM name: 20794@gg-teamcity-5
> >>> Grid name: internal.IgniteClientReconnectCacheTest0
> >>> Local node [ID=009C5A78-BAED-4ACA-B211-B2A634C93000, order=1, 
> >>> clientMode=false]
> >>> Local node addresses: [127.0.0.1]
> >>> Local ports: TCP:47100 TCP:47500 
> [20:07:24,943][INFO ][main][GridDiscoveryManager] Topology snapshot [ver=1, 
> servers=1, clients=0, CPUs=4, heap=2.7GB]
> [20:07:24,951][INFO ][main][IgniteClientReconnectCacheTest1] 
> >>>    __________  ________________  
> >>>   /  _/ ___/ |/ /  _/_  __/ __/  
> >>>  _/ // (7 7    // /  / / / _/    
> >>> /___/\___/_/|_/___/ /_/ /___/   
> >>> 
> >>> ver. 1.5.0-SNAPSHOT#20151019-sha1:10ef06a1
> >>> 2015 Copyright(C) Apache Software Foundation
> >>> 
> >>> Ignite documentation: http://ignite.apache.org
> [20:07:24,951][INFO ][main][IgniteClientReconnectCacheTest1] Config URL: n/a
> [20:07:24,951][INFO ][main][IgniteClientReconnectCacheTest1] Daemon mode: off
> [20:07:24,951][INFO ][main][IgniteClientReconnectCacheTest1] OS: Linux 
> 2.6.32-74-generic amd64
> [20:07:24,951][INFO ][main][IgniteClientReconnectCacheTest1] OS user: teamcity
> [20:07:24,952][INFO ][main][IgniteClientReconnectCacheTest1] Language 
> runtime: Java Platform API Specification ver. 1.7
> [20:07:24,952][INFO ][main][IgniteClientReconnectCacheTest1] VM information: 
> Java(TM) SE Runtime Environment 1.7.0_21-b11 Oracle Corporation Java 
> HotSpot(TM) 64-Bit Server VM 23.21-b01
> [20:07:24,952][INFO ][main][IgniteClientReconnectCacheTest1] VM total memory: 
> 2.7GB
> [20:07:24,952][INFO ][main][IgniteClientReconnectCacheTest1] Remote 
> Management [restart: off, REST: off, JMX (remote: off)]
> [20:07:24,952][INFO ][main][IgniteClientReconnectCacheTest1] 
> IGNITE_HOME=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2
> [20:07:24,952][INFO ][main][IgniteClientReconnectCacheTest1] VM arguments: 
> [-DJAVA_HOME=/home/teamcity/jdk1.7.0_21, -DMCAST_GRP=229.15.1.2, 
> -Dagent.home.dir=/usr/local/TeamCityAgent, -Dagent.name=teamcity-5, 
> -Dagent.ownPort=9090, -Dagent.work.dir=/usr/local/TeamCityAgent/work, 
> -Dbuild.number=560, 
> -Dbuild.vcs.number=10ef06a14245c73cbfe66b744406a0391c4a9c08, 
> -Dbuild.vcs.number.1=10ef06a14245c73cbfe66b744406a0391c4a9c08, 
> -Dbuild.vcs.number.ApacheIgniteMirrorOnGitHub=10ef06a14245c73cbfe66b744406a0391c4a9c08,
>  -Dclassworlds.conf=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.m2.conf, 
> -Dcom.jetbrains.maven.watcher.report.file=/usr/local/TeamCityAgent/temp/buildTmp/maven-build-info.xml,
>  -Djava.io.tmpdir=/usr/local/TeamCityAgent/temp/buildTmp, 
> -Dmaven.home=/usr/local/TeamCityAgent/tools/maven3, 
> -Dmaven.repo.local=/home/teamcity/.m2/repository, 
> -Dteamcity.agent.cpuBenchmark=665, 
> -Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2, 
> -Dteamcity.agent.dotnet.build_id=554010, 
> -Dteamcity.auth.password=NZJLF36rtgBzyZan9Rlqx1nibYhaTdzk, 
> -Dteamcity.auth.userId=TeamCityBuildId=554010, 
> -Dteamcity.build.changedFiles.file=/usr/local/TeamCityAgent/temp/buildTmp/changedFiles2364753307910338165.txt,
>  -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -Dteamcity.build.id=554010, 
> -Dteamcity.build.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.build7009344645725909149.properties,
>  -Dteamcity.build.tempDir=/usr/local/TeamCityAgent/temp/buildTmp, 
> -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -Dteamcity.buildConfName=Ignite Client Nodes, 
> -Dteamcity.buildType.id=Ignite_IgniteClients, 
> -Dteamcity.configuration.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.config8423242305191431229.properties,
>  -Dteamcity.idea.home=/usr/local/TeamCityAgent/plugins/idea, 
> -Dteamcity.maven.watcher.home=/usr/local/TeamCityAgent/plugins/mavenPlugin/maven-watcher,
>  -Dteamcity.projectName=Ignite Tests, 
> -Dteamcity.runner.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.runner2097693476768347057.properties,
>  
> -Dteamcity.tests.recentlyFailedTests.file=/usr/local/TeamCityAgent/temp/buildTmp/testsToRunFirst6738565233989795504.txt,
>  -Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=1024m, -Xms1g, 
> -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, 
> -XX:HeapDumpPath=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -XX:+AggressiveOpts, 
> -DIGNITE_TEST_HOME=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true, 
> -DIGNITE_QUIET=false]
> [20:07:24,952][INFO ][main][IgniteClientReconnectCacheTest1] Configured 
> caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 
> 'ignite-atomics-sys-cache', 'static-cache']
> [20:07:24,952][INFO ][main][IgniteClientReconnectCacheTest1] 3-rd party 
> licenses can be found at: 
> /usr/local/TeamCityAgent/work/f87ae3766fbb88e2/libs/licenses
> [20:07:24,955][INFO ][main][IgniteClientReconnectCacheTest1] Non-loopback 
> local IPs: 192.168.2.15, fe80:0:0:0:ca60:ff:fe68:582f%2
> [20:07:24,956][INFO ][main][IgniteClientReconnectCacheTest1] Enabled local 
> MACs: C8600068582F
> [20:07:24,956][INFO ][main][IgnitePluginProcessor] Configured plugins:
> [20:07:24,956][INFO ][main][IgnitePluginProcessor]   ^-- None
> [20:07:24,956][INFO ][main][IgnitePluginProcessor] 
> [20:07:24,958][INFO 
> ][main][IgniteClientReconnectCacheTest$TestCommunicationSpi] Successfully 
> bound to TCP port [port=47101, locHost=/127.0.0.1]
> [20:07:24,964][INFO ][main][IgniteClientReconnectCacheTest1] Security status 
> [authentication=off, tls/ssl=off]
> [20:07:24,970][INFO 
> ][main][IgniteClientReconnectAbstractTest$TestTcpDiscoverySpi] Successfully 
> bound to TCP port [port=47501, localHost=/127.0.0.1]
> [20:07:24,983][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=1014f5ac-19c1-482c-be6c-337755519001, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:47501], discPort=47501, order=2, intOrder=2, 
> lastExchangeTime=1445274444969, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=false]
> [20:07:24,984][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Topology snapshot [ver=2, servers=2, clients=0, CPUs=4, heap=2.7GB]
> [20:07:24,986][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-marshaller-sys-cache, mode=REPLICATED]
> [20:07:24,988][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-atomics-sys-cache, mode=PARTITIONED]
> [20:07:24,992][INFO ][main][GridCacheProcessor] Started cache 
> [name=static-cache, mode=PARTITIONED]
> [20:07:24,994][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-sys-cache, mode=REPLICATED]
> [20:07:25,011][INFO ][main][GridDhtPreloader] <ignite-marshaller-sys-cache> 
> Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache
> [20:07:25,011][INFO ][main][GridDhtPreloader] <ignite-atomics-sys-cache> 
> Starting rebalancing in SYNC mode: ignite-atomics-sys-cache
> [20:07:25,011][INFO ][main][GridDhtPreloader] <static-cache> Starting 
> rebalancing in ASYNC mode: static-cache
> [20:07:25,011][INFO ][main][GridDhtPreloader] <ignite-sys-cache> Starting 
> rebalancing in SYNC mode: ignite-sys-cache
> [20:07:25,016][INFO 
> ][preloader-demand-worker-#4885%internal.IgniteClientReconnectCacheTest1%][GridDhtPreloader]
>  <ignite-marshaller-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-marshaller-sys-cache, time=0 ms]
> [20:07:25,018][INFO 
> ][preloader-demand-worker-#4901%internal.IgniteClientReconnectCacheTest1%][GridDhtPreloader]
>  <ignite-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-sys-cache, time=0 ms]
> [20:07:25,018][INFO 
> ][preloader-demand-worker-#4890%internal.IgniteClientReconnectCacheTest1%][GridDhtPreloader]
>  <ignite-atomics-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-atomics-sys-cache, time=0 ms]
> [20:07:25,019][INFO 
> ][preloader-demand-worker-#4896%internal.IgniteClientReconnectCacheTest1%][GridDhtPreloader]
>  <static-cache> Completed rebalancing in ASYNC mode [cache=static-cache, 
> time=0 ms]
> [20:07:25,027][INFO ][main][IgniteClientReconnectCacheTest1] Performance 
> suggestions for grid 'internal.IgniteClientReconnectCacheTest1' (fix if 
> possible)
> [20:07:25,027][INFO ][main][IgniteClientReconnectCacheTest1] To disable, set 
> -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
> [20:07:25,027][INFO ][main][IgniteClientReconnectCacheTest1]   ^-- Disable 
> checkpoints (remove 'checkpointSpi' from configuration)
> [20:07:25,027][INFO ][main][IgniteClientReconnectCacheTest1]   ^-- Disable 
> grid events (remove 'includeEventTypes' from configuration)
> [20:07:25,027][INFO ][main][IgniteClientReconnectCacheTest1] 
> [20:07:25,027][INFO ][main][IgniteClientReconnectCacheTest1] To start Console 
> Management & Monitoring run ignitevisorcmd.{sh|bat}
> [20:07:25,027][INFO ][main][IgniteClientReconnectCacheTest1] 
> [20:07:25,028][INFO ][main][IgniteClientReconnectCacheTest1] 
> >>> +-------------------------------------------------------------------------------+
> >>> Ignite ver. 
> >>> 1.5.0-SNAPSHOT#20151019-sha1:10ef06a14245c73cbfe66b744406a0391c4a9c08
> >>> +-------------------------------------------------------------------------------+
> >>> OS name: Linux 2.6.32-74-generic amd64
> >>> CPU(s): 4
> >>> Heap: 2.7GB
> >>> VM name: 20794@gg-teamcity-5
> >>> Grid name: internal.IgniteClientReconnectCacheTest1
> >>> Local node [ID=1014F5AC-19C1-482C-BE6C-337755519001, order=2, 
> >>> clientMode=false]
> >>> Local node addresses: [127.0.0.1]
> >>> Local ports: TCP:47101 TCP:47501 
> [20:07:25,028][INFO ][main][GridDiscoveryManager] Topology snapshot [ver=2, 
> servers=2, clients=0, CPUs=4, heap=2.7GB]
> [20:07:25,036][INFO ][main][IgniteClientReconnectCacheTest2] 
> >>>    __________  ________________  
> >>>   /  _/ ___/ |/ /  _/_  __/ __/  
> >>>  _/ // (7 7    // /  / / / _/    
> >>> /___/\___/_/|_/___/ /_/ /___/   
> >>> 
> >>> ver. 1.5.0-SNAPSHOT#20151019-sha1:10ef06a1
> >>> 2015 Copyright(C) Apache Software Foundation
> >>> 
> >>> Ignite documentation: http://ignite.apache.org
> [20:07:25,036][INFO ][main][IgniteClientReconnectCacheTest2] Config URL: n/a
> [20:07:25,036][INFO ][main][IgniteClientReconnectCacheTest2] Daemon mode: off
> [20:07:25,036][INFO ][main][IgniteClientReconnectCacheTest2] OS: Linux 
> 2.6.32-74-generic amd64
> [20:07:25,036][INFO ][main][IgniteClientReconnectCacheTest2] OS user: teamcity
> [20:07:25,037][INFO ][main][IgniteClientReconnectCacheTest2] Language 
> runtime: Java Platform API Specification ver. 1.7
> [20:07:25,037][INFO ][main][IgniteClientReconnectCacheTest2] VM information: 
> Java(TM) SE Runtime Environment 1.7.0_21-b11 Oracle Corporation Java 
> HotSpot(TM) 64-Bit Server VM 23.21-b01
> [20:07:25,037][INFO ][main][IgniteClientReconnectCacheTest2] VM total memory: 
> 2.7GB
> [20:07:25,037][INFO ][main][IgniteClientReconnectCacheTest2] Remote 
> Management [restart: off, REST: off, JMX (remote: off)]
> [20:07:25,037][INFO ][main][IgniteClientReconnectCacheTest2] 
> IGNITE_HOME=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2
> [20:07:25,037][INFO ][main][IgniteClientReconnectCacheTest2] VM arguments: 
> [-DJAVA_HOME=/home/teamcity/jdk1.7.0_21, -DMCAST_GRP=229.15.1.2, 
> -Dagent.home.dir=/usr/local/TeamCityAgent, -Dagent.name=teamcity-5, 
> -Dagent.ownPort=9090, -Dagent.work.dir=/usr/local/TeamCityAgent/work, 
> -Dbuild.number=560, 
> -Dbuild.vcs.number=10ef06a14245c73cbfe66b744406a0391c4a9c08, 
> -Dbuild.vcs.number.1=10ef06a14245c73cbfe66b744406a0391c4a9c08, 
> -Dbuild.vcs.number.ApacheIgniteMirrorOnGitHub=10ef06a14245c73cbfe66b744406a0391c4a9c08,
>  -Dclassworlds.conf=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.m2.conf, 
> -Dcom.jetbrains.maven.watcher.report.file=/usr/local/TeamCityAgent/temp/buildTmp/maven-build-info.xml,
>  -Djava.io.tmpdir=/usr/local/TeamCityAgent/temp/buildTmp, 
> -Dmaven.home=/usr/local/TeamCityAgent/tools/maven3, 
> -Dmaven.repo.local=/home/teamcity/.m2/repository, 
> -Dteamcity.agent.cpuBenchmark=665, 
> -Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2, 
> -Dteamcity.agent.dotnet.build_id=554010, 
> -Dteamcity.auth.password=NZJLF36rtgBzyZan9Rlqx1nibYhaTdzk, 
> -Dteamcity.auth.userId=TeamCityBuildId=554010, 
> -Dteamcity.build.changedFiles.file=/usr/local/TeamCityAgent/temp/buildTmp/changedFiles2364753307910338165.txt,
>  -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -Dteamcity.build.id=554010, 
> -Dteamcity.build.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.build7009344645725909149.properties,
>  -Dteamcity.build.tempDir=/usr/local/TeamCityAgent/temp/buildTmp, 
> -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -Dteamcity.buildConfName=Ignite Client Nodes, 
> -Dteamcity.buildType.id=Ignite_IgniteClients, 
> -Dteamcity.configuration.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.config8423242305191431229.properties,
>  -Dteamcity.idea.home=/usr/local/TeamCityAgent/plugins/idea, 
> -Dteamcity.maven.watcher.home=/usr/local/TeamCityAgent/plugins/mavenPlugin/maven-watcher,
>  -Dteamcity.projectName=Ignite Tests, 
> -Dteamcity.runner.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.runner2097693476768347057.properties,
>  
> -Dteamcity.tests.recentlyFailedTests.file=/usr/local/TeamCityAgent/temp/buildTmp/testsToRunFirst6738565233989795504.txt,
>  -Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=1024m, -Xms1g, 
> -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, 
> -XX:HeapDumpPath=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -XX:+AggressiveOpts, 
> -DIGNITE_TEST_HOME=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true, 
> -DIGNITE_QUIET=false]
> [20:07:25,037][INFO ][main][IgniteClientReconnectCacheTest2] Configured 
> caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 
> 'ignite-atomics-sys-cache', 'static-cache']
> [20:07:25,037][INFO ][main][IgniteClientReconnectCacheTest2] 3-rd party 
> licenses can be found at: 
> /usr/local/TeamCityAgent/work/f87ae3766fbb88e2/libs/licenses
> [20:07:25,040][INFO ][main][IgniteClientReconnectCacheTest2] Non-loopback 
> local IPs: 192.168.2.15, fe80:0:0:0:ca60:ff:fe68:582f%2
> [20:07:25,040][INFO ][main][IgniteClientReconnectCacheTest2] Enabled local 
> MACs: C8600068582F
> [20:07:25,041][INFO ][main][IgnitePluginProcessor] Configured plugins:
> [20:07:25,041][INFO ][main][IgnitePluginProcessor]   ^-- None
> [20:07:25,041][INFO ][main][IgnitePluginProcessor] 
> [20:07:25,043][INFO 
> ][main][IgniteClientReconnectCacheTest$TestCommunicationSpi] Successfully 
> bound to TCP port [port=47102, locHost=/127.0.0.1]
> [20:07:25,047][INFO ][main][IgniteClientReconnectCacheTest2] Security status 
> [authentication=off, tls/ssl=off]
> [20:07:25,051][INFO 
> ][main][IgniteClientReconnectAbstractTest$TestTcpDiscoverySpi] Successfully 
> bound to TCP port [port=47502, localHost=/127.0.0.1]
> [20:07:25,062][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=20397987-c902-4000-9a54-fd39da1ac002, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, 
> lastExchangeTime=1445274445050, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=false]
> [20:07:25,063][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=20397987-c902-4000-9a54-fd39da1ac002, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, 
> lastExchangeTime=1445274445050, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=false]
> [20:07:25,063][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Topology snapshot [ver=3, servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:25,063][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Topology snapshot [ver=3, servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:25,066][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-marshaller-sys-cache, mode=REPLICATED]
> [20:07:25,068][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-atomics-sys-cache, mode=PARTITIONED]
> [20:07:25,070][INFO ][main][GridCacheProcessor] Started cache 
> [name=static-cache, mode=PARTITIONED]
> [20:07:25,072][INFO ][main][GridCacheProcessor] Started cache 
> [name=ignite-sys-cache, mode=REPLICATED]
> [20:07:25,084][INFO ][main][GridDhtPreloader] <ignite-marshaller-sys-cache> 
> Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache
> [20:07:25,354][INFO ][main][GridDhtPreloader] <ignite-atomics-sys-cache> 
> Starting rebalancing in SYNC mode: ignite-atomics-sys-cache
> [20:07:25,354][INFO ][main][GridDhtPreloader] <static-cache> Starting 
> rebalancing in ASYNC mode: static-cache
> [20:07:25,354][INFO ][main][GridDhtPreloader] <ignite-sys-cache> Starting 
> rebalancing in SYNC mode: ignite-sys-cache
> [20:07:25,357][INFO 
> ][preloader-demand-worker-#4951%internal.IgniteClientReconnectCacheTest2%][GridDhtPreloader]
>  <ignite-marshaller-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-marshaller-sys-cache, time=273 ms]
> [20:07:25,358][INFO 
> ][preloader-demand-worker-#4960%internal.IgniteClientReconnectCacheTest2%][GridDhtPreloader]
>  <static-cache> Completed rebalancing in ASYNC mode [cache=static-cache, 
> time=0 ms]
> [20:07:25,359][INFO 
> ][preloader-demand-worker-#4955%internal.IgniteClientReconnectCacheTest2%][GridDhtPreloader]
>  <ignite-atomics-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-atomics-sys-cache, time=273 ms]
> [20:07:25,359][INFO 
> ][preloader-demand-worker-#4965%internal.IgniteClientReconnectCacheTest2%][GridDhtPreloader]
>  <ignite-sys-cache> Completed rebalancing in SYNC mode 
> [cache=ignite-sys-cache, time=0 ms]
> [20:07:25,368][INFO ][main][IgniteClientReconnectCacheTest2] Performance 
> suggestions for grid 'internal.IgniteClientReconnectCacheTest2' (fix if 
> possible)
> [20:07:25,368][INFO ][main][IgniteClientReconnectCacheTest2] To disable, set 
> -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
> [20:07:25,368][INFO ][main][IgniteClientReconnectCacheTest2]   ^-- Disable 
> checkpoints (remove 'checkpointSpi' from configuration)
> [20:07:25,368][INFO ][main][IgniteClientReconnectCacheTest2]   ^-- Disable 
> grid events (remove 'includeEventTypes' from configuration)
> [20:07:25,368][INFO ][main][IgniteClientReconnectCacheTest2] 
> [20:07:25,368][INFO ][main][IgniteClientReconnectCacheTest2] To start Console 
> Management & Monitoring run ignitevisorcmd.{sh|bat}
> [20:07:25,368][INFO ][main][IgniteClientReconnectCacheTest2] 
> [20:07:25,368][INFO ][main][IgniteClientReconnectCacheTest2] 
> >>> +-------------------------------------------------------------------------------+
> >>> Ignite ver. 
> >>> 1.5.0-SNAPSHOT#20151019-sha1:10ef06a14245c73cbfe66b744406a0391c4a9c08
> >>> +-------------------------------------------------------------------------------+
> >>> OS name: Linux 2.6.32-74-generic amd64
> >>> CPU(s): 4
> >>> Heap: 2.7GB
> >>> VM name: 20794@gg-teamcity-5
> >>> Grid name: internal.IgniteClientReconnectCacheTest2
> >>> Local node [ID=20397987-C902-4000-9A54-FD39DA1AC002, order=3, 
> >>> clientMode=false]
> >>> Local node addresses: [127.0.0.1]
> >>> Local ports: TCP:47102 TCP:47502 
> [20:07:25,368][INFO ][main][GridDiscoveryManager] Topology snapshot [ver=3, 
> servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:25,374][INFO ][test-runner][IgniteClientReconnectCacheTest3] 
> >>>    __________  ________________  
> >>>   /  _/ ___/ |/ /  _/_  __/ __/  
> >>>  _/ // (7 7    // /  / / / _/    
> >>> /___/\___/_/|_/___/ /_/ /___/   
> >>> 
> >>> ver. 1.5.0-SNAPSHOT#20151019-sha1:10ef06a1
> >>> 2015 Copyright(C) Apache Software Foundation
> >>> 
> >>> Ignite documentation: http://ignite.apache.org
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] Config 
> URL: n/a
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] Daemon 
> mode: off
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] OS: Linux 
> 2.6.32-74-generic amd64
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] OS user: 
> teamcity
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] Language 
> runtime: Java Platform API Specification ver. 1.7
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] VM 
> information: Java(TM) SE Runtime Environment 1.7.0_21-b11 Oracle Corporation 
> Java HotSpot(TM) 64-Bit Server VM 23.21-b01
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] VM total 
> memory: 2.7GB
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] Remote 
> Management [restart: off, REST: off, JMX (remote: off)]
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] 
> IGNITE_HOME=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] VM 
> arguments: [-DJAVA_HOME=/home/teamcity/jdk1.7.0_21, -DMCAST_GRP=229.15.1.2, 
> -Dagent.home.dir=/usr/local/TeamCityAgent, -Dagent.name=teamcity-5, 
> -Dagent.ownPort=9090, -Dagent.work.dir=/usr/local/TeamCityAgent/work, 
> -Dbuild.number=560, 
> -Dbuild.vcs.number=10ef06a14245c73cbfe66b744406a0391c4a9c08, 
> -Dbuild.vcs.number.1=10ef06a14245c73cbfe66b744406a0391c4a9c08, 
> -Dbuild.vcs.number.ApacheIgniteMirrorOnGitHub=10ef06a14245c73cbfe66b744406a0391c4a9c08,
>  -Dclassworlds.conf=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.m2.conf, 
> -Dcom.jetbrains.maven.watcher.report.file=/usr/local/TeamCityAgent/temp/buildTmp/maven-build-info.xml,
>  -Djava.io.tmpdir=/usr/local/TeamCityAgent/temp/buildTmp, 
> -Dmaven.home=/usr/local/TeamCityAgent/tools/maven3, 
> -Dmaven.repo.local=/home/teamcity/.m2/repository, 
> -Dteamcity.agent.cpuBenchmark=665, 
> -Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2, 
> -Dteamcity.agent.dotnet.build_id=554010, 
> -Dteamcity.auth.password=NZJLF36rtgBzyZan9Rlqx1nibYhaTdzk, 
> -Dteamcity.auth.userId=TeamCityBuildId=554010, 
> -Dteamcity.build.changedFiles.file=/usr/local/TeamCityAgent/temp/buildTmp/changedFiles2364753307910338165.txt,
>  -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -Dteamcity.build.id=554010, 
> -Dteamcity.build.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.build7009344645725909149.properties,
>  -Dteamcity.build.tempDir=/usr/local/TeamCityAgent/temp/buildTmp, 
> -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -Dteamcity.buildConfName=Ignite Client Nodes, 
> -Dteamcity.buildType.id=Ignite_IgniteClients, 
> -Dteamcity.configuration.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.config8423242305191431229.properties,
>  -Dteamcity.idea.home=/usr/local/TeamCityAgent/plugins/idea, 
> -Dteamcity.maven.watcher.home=/usr/local/TeamCityAgent/plugins/mavenPlugin/maven-watcher,
>  -Dteamcity.projectName=Ignite Tests, 
> -Dteamcity.runner.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.runner2097693476768347057.properties,
>  
> -Dteamcity.tests.recentlyFailedTests.file=/usr/local/TeamCityAgent/temp/buildTmp/testsToRunFirst6738565233989795504.txt,
>  -Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=1024m, -Xms1g, 
> -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, 
> -XX:HeapDumpPath=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -XX:+AggressiveOpts, 
> -DIGNITE_TEST_HOME=/usr/local/TeamCityAgent/work/f87ae3766fbb88e2, 
> -DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true, 
> -DIGNITE_QUIET=false]
> [20:07:25,375][INFO ][test-runner][IgniteClientReconnectCacheTest3] 
> Configured caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 
> 'ignite-atomics-sys-cache', 'static-cache']
> [20:07:25,377][INFO ][test-runner][IgniteClientReconnectCacheTest3] 3-rd 
> party licenses can be found at: 
> /usr/local/TeamCityAgent/work/f87ae3766fbb88e2/libs/licenses
> [20:07:25,380][INFO ][test-runner][IgniteClientReconnectCacheTest3] 
> Non-loopback local IPs: 192.168.2.15, fe80:0:0:0:ca60:ff:fe68:582f%2
> [20:07:25,380][INFO ][test-runner][IgniteClientReconnectCacheTest3] Enabled 
> local MACs: C8600068582F
> [20:07:25,381][INFO ][test-runner][IgnitePluginProcessor] Configured plugins:
> [20:07:25,381][INFO ][test-runner][IgnitePluginProcessor]   ^-- None
> [20:07:25,381][INFO ][test-runner][IgnitePluginProcessor] 
> [20:07:25,383][INFO 
> ][test-runner][IgniteClientReconnectCacheTest$TestCommunicationSpi] 
> Successfully bound to TCP port [port=47103, locHost=/127.0.0.1]
> [20:07:25,389][INFO ][test-runner][IgniteClientReconnectCacheTest3] Security 
> status [authentication=off, tls/ssl=off]
> [20:07:25,408][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=30ff918b-a495-42a3-a953-c71291e41003, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=4, 
> lastExchangeTime=1445274445393, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:25,409][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Topology snapshot [ver=4, servers=3, clients=1, CPUs=4, heap=2.7GB]
> [20:07:25,410][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=30ff918b-a495-42a3-a953-c71291e41003, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=4, 
> lastExchangeTime=1445274445393, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:25,410][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Topology snapshot [ver=4, servers=3, clients=1, CPUs=4, heap=2.7GB]
> [20:07:25,412][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=30ff918b-a495-42a3-a953-c71291e41003, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=4, 
> lastExchangeTime=1445274445404, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:25,412][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Topology snapshot [ver=4, servers=3, clients=1, CPUs=4, heap=2.7GB]
> [20:07:25,416][INFO ][test-runner][GridCacheProcessor] Started cache 
> [name=ignite-marshaller-sys-cache, mode=REPLICATED]
> [20:07:25,417][INFO ][test-runner][GridCacheProcessor] Started cache 
> [name=ignite-atomics-sys-cache, mode=PARTITIONED]
> [20:07:25,419][INFO ][test-runner][GridCacheProcessor] Started cache 
> [name=static-cache, mode=PARTITIONED]
> [20:07:25,419][INFO ][test-runner][GridCacheProcessor] Started cache 
> [name=ignite-sys-cache, mode=REPLICATED]
> [20:07:25,454][INFO ][test-runner][IgniteClientReconnectCacheTest3] 
> Performance suggestions for grid 'internal.IgniteClientReconnectCacheTest3' 
> (fix if possible)
> [20:07:25,454][INFO ][test-runner][IgniteClientReconnectCacheTest3] To 
> disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
> [20:07:25,454][INFO ][test-runner][IgniteClientReconnectCacheTest3]   ^-- 
> Disable checkpoints (remove 'checkpointSpi' from configuration)
> [20:07:25,454][INFO ][test-runner][IgniteClientReconnectCacheTest3]   ^-- 
> Disable grid events (remove 'includeEventTypes' from configuration)
> [20:07:25,454][INFO ][test-runner][IgniteClientReconnectCacheTest3] 
> [20:07:25,454][INFO ][test-runner][IgniteClientReconnectCacheTest3] To start 
> Console Management & Monitoring run ignitevisorcmd.{sh|bat}
> [20:07:25,454][INFO ][test-runner][IgniteClientReconnectCacheTest3] 
> [20:07:25,455][INFO ][test-runner][IgniteClientReconnectCacheTest3] 
> >>> +-------------------------------------------------------------------------------+
> >>> Ignite ver. 
> >>> 1.5.0-SNAPSHOT#20151019-sha1:10ef06a14245c73cbfe66b744406a0391c4a9c08
> >>> +-------------------------------------------------------------------------------+
> >>> OS name: Linux 2.6.32-74-generic amd64
> >>> CPU(s): 4
> >>> Heap: 2.7GB
> >>> VM name: 20794@gg-teamcity-5
> >>> Grid name: internal.IgniteClientReconnectCacheTest3
> >>> Local node [ID=30FF918B-A495-42A3-A953-C71291E41003, order=4, 
> >>> clientMode=true]
> >>> Local node addresses: [127.0.0.1]
> >>> Local ports: TCP:47103 
> [20:07:25,455][INFO ][test-runner][GridDiscoveryManager] Topology snapshot 
> [ver=4, servers=3, clients=1, CPUs=4, heap=2.7GB]
> [20:07:25,462][INFO 
> ][exchange-worker-#4821%internal.IgniteClientReconnectCacheTest0%][GridCacheProcessor]
>  Started cache [name=default, mode=PARTITIONED]
> [20:07:25,462][INFO 
> ][exchange-worker-#4882%internal.IgniteClientReconnectCacheTest1%][GridCacheProcessor]
>  Started cache [name=default, mode=PARTITIONED]
> [20:07:25,463][INFO 
> ][exchange-worker-#4947%internal.IgniteClientReconnectCacheTest2%][GridCacheProcessor]
>  Started cache [name=default, mode=PARTITIONED]
> [20:07:25,464][INFO 
> ][exchange-worker-#5002%internal.IgniteClientReconnectCacheTest3%][GridCacheProcessor]
>  Started cache [name=default, mode=PARTITIONED]
> [20:07:25,481][INFO 
> ][ignite-#4804%sys-internal.IgniteClientReconnectCacheTest0%][GridDhtPreloader]
>  <default> Starting rebalancing in ASYNC mode: null
> [20:07:25,482][INFO 
> ][ignite-#4929%sys-internal.IgniteClientReconnectCacheTest2%][GridDhtPreloader]
>  <default> Starting rebalancing in ASYNC mode: null
> [20:07:25,483][INFO 
> ][ignite-#4866%sys-internal.IgniteClientReconnectCacheTest1%][GridDhtPreloader]
>  <default> Starting rebalancing in ASYNC mode: null
> [20:07:25,485][INFO 
> ][preloader-demand-worker-#5013%internal.IgniteClientReconnectCacheTest0%][GridDhtPreloader]
>  <default> Completed rebalancing in ASYNC mode [cache=null, time=10 ms]
> [20:07:25,486][INFO 
> ][preloader-demand-worker-#5017%internal.IgniteClientReconnectCacheTest2%][GridDhtPreloader]
>  <default> Completed rebalancing in ASYNC mode [cache=null, time=10 ms]
> [20:07:25,486][INFO 
> ][preloader-demand-worker-#5019%internal.IgniteClientReconnectCacheTest1%][GridDhtPreloader]
>  <default> Completed rebalancing in ASYNC mode [cache=null, time=10 ms]
> [20:07:25,492][INFO 
> ][exchange-worker-#4882%internal.IgniteClientReconnectCacheTest1%][GridCacheProcessor]
>  Started cache [name=nearCache, mode=PARTITIONED]
> [20:07:25,492][INFO 
> ][exchange-worker-#4947%internal.IgniteClientReconnectCacheTest2%][GridCacheProcessor]
>  Started cache [name=nearCache, mode=PARTITIONED]
> [20:07:25,493][INFO 
> ][exchange-worker-#4821%internal.IgniteClientReconnectCacheTest0%][GridCacheProcessor]
>  Started cache [name=nearCache, mode=PARTITIONED]
> [20:07:25,494][INFO 
> ][exchange-worker-#5002%internal.IgniteClientReconnectCacheTest3%][GridCacheProcessor]
>  Started cache [name=nearCache, mode=PARTITIONED]
> [20:07:25,515][INFO 
> ][ignite-#4794%sys-internal.IgniteClientReconnectCacheTest0%][GridDhtPreloader]
>  <nearCache> Starting rebalancing in ASYNC mode: nearCache
> [20:07:25,516][INFO 
> ][preloader-demand-worker-#5034%internal.IgniteClientReconnectCacheTest0%][GridDhtPreloader]
>  <nearCache> Completed rebalancing in ASYNC mode [cache=nearCache, time=0 ms]
> [20:07:25,516][INFO 
> ][ignite-#4931%sys-internal.IgniteClientReconnectCacheTest2%][GridDhtPreloader]
>  <nearCache> Starting rebalancing in ASYNC mode: nearCache
> [20:07:25,517][INFO 
> ][ignite-#4868%sys-internal.IgniteClientReconnectCacheTest1%][GridDhtPreloader]
>  <nearCache> Starting rebalancing in ASYNC mode: nearCache
> [20:07:25,521][INFO ][test-runner][root] Block reconnect.
> [20:07:25,521][INFO 
> ][preloader-demand-worker-#5036%internal.IgniteClientReconnectCacheTest2%][GridDhtPreloader]
>  <nearCache> Completed rebalancing in ASYNC mode [cache=nearCache, time=0 ms]
> [20:07:25,522][INFO ][test-runner][root] Fail client.
> [20:07:25,523][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Topology snapshot [ver=5, servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:25,523][INFO 
> ][preloader-demand-worker-#5026%internal.IgniteClientReconnectCacheTest1%][GridDhtPreloader]
>  <nearCache> Completed rebalancing in ASYNC mode [cache=nearCache, time=0 ms]
> [20:07:25,523][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Topology snapshot [ver=5, servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:25,524][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Topology snapshot [ver=5, servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:25,528][INFO 
> ][tcp-client-disco-msg-worker-#1262%internal.IgniteClientReconnectCacheTest3][IgniteClientReconnectAbstractTest$TestTcpDiscoverySpi]
>  Client node disconnected from cluster, will try to reconnect with new id 
> [newId=9af84855-5704-4680-9681-24f30dd12d22, 
> prevId=30ff918b-a495-42a3-a953-c71291e41003, locNode=TcpDiscoveryNode 
> [id=30ff918b-a495-42a3-a953-c71291e41003, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=0, 
> lastExchangeTime=1445274445393, loc=true, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]]
> [20:07:25,528][INFO 
> ][disco-event-worker-#5000%internal.IgniteClientReconnectCacheTest3%][root] 
> Disconnected: DiscoveryEvent [evtNode=TcpDiscoveryNode 
> [id=30ff918b-a495-42a3-a953-c71291e41003, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=0, 
> lastExchangeTime=1445274445393, loc=true, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true], topVer=4, nodeId8=30ff918b, msg=Client node disconnected: 
> TcpDiscoveryNode [id=30ff918b-a495-42a3-a953-c71291e41003, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=0, 
> lastExchangeTime=1445274445393, loc=true, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true], type=CLIENT_NODE_DISCONNECTED, tstamp=1445274445524]
> [20:07:25,529][INFO ][async-runner-1][root] Start put.
> [20:07:25,529][INFO ][async-runner-1][root] Expected exception: 
> javax.cache.CacheException: class 
> org.apache.ignite.IgniteClientDisconnectedException: Client node 
> disconnected: internal.IgniteClientReconnectCacheTest3
> [20:07:25,530][INFO 
> ][tcp-client-disco-msg-worker-#1262%internal.IgniteClientReconnectCacheTest3][IgniteClientReconnectAbstractTest$TestTcpDiscoverySpi]
>  Block join request send: TcpDiscoveryJoinRequestMessage 
> [node=TcpDiscoveryNode [id=9af84855-5704-4680-9681-24f30dd12d22, 
> addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:0], discPort=0, order=0, intOrder=0, 
> lastExchangeTime=1445274445524, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true], super=TcpDiscoveryAbstractMessage [sndNodeId=null, 
> id=fa032118051-9af84855-5704-4680-9681-24f30dd12d22, verifierNodeId=null, 
> topVer=0, pendingIdx=0, isClient=true]]
> [20:07:30,529][INFO ][test-runner][root] Allow reconnect.
> [20:07:30,541][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=5, 
> lastExchangeTime=1445274450531, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:30,542][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Topology snapshot [ver=6, servers=3, clients=1, CPUs=4, heap=2.7GB]
> [20:07:30,543][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=5, 
> lastExchangeTime=1445274450531, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:30,543][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Topology snapshot [ver=6, servers=3, clients=1, CPUs=4, heap=2.7GB]
> [20:07:30,546][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Added new node to topology: TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=5, 
> lastExchangeTime=1445274450531, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:30,546][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Topology snapshot [ver=6, servers=3, clients=1, CPUs=4, heap=2.7GB]
> [20:07:30,558][INFO 
> ][disco-event-worker-#5000%internal.IgniteClientReconnectCacheTest3%][GridDiscoveryManager]
>  Client node reconnected to topology: TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=0, 
> lastExchangeTime=1445274445393, loc=true, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:30,558][INFO 
> ][disco-event-worker-#5000%internal.IgniteClientReconnectCacheTest3%][GridDiscoveryManager]
>  Topology snapshot [ver=6, servers=3, clients=1, CPUs=4, heap=2.7GB]
> [20:07:30,559][INFO 
> ][disco-event-worker-#5000%internal.IgniteClientReconnectCacheTest3%][root] 
> Reconnected: DiscoveryEvent [evtNode=TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=0, 
> lastExchangeTime=1445274445393, loc=true, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true], topVer=6, nodeId8=9af84855, msg=Client node reconnected: 
> TcpDiscoveryNode [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=0, 
> lastExchangeTime=1445274445393, loc=true, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true], type=CLIENT_NODE_RECONNECTED, tstamp=1445274450551]
> [20:07:30,560][INFO ][async-runner-1][root] Finish put.
> [20:07:30,566][INFO ][main][root] >>> Stopping test: testReconnect in 5198 ms 
> <<<
> [20:07:30,566][INFO ][main][root] >>> Stopping grid 
> [name=internal.IgniteClientReconnectCacheTest3, 
> id=9af84855-5704-4680-9681-24f30dd12d22]
> [20:07:30,571][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Node left topology: TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=5, 
> lastExchangeTime=1445274450531, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:30,571][INFO 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Topology snapshot [ver=7, servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:30,574][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Node left topology: TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=5, 
> lastExchangeTime=1445274450531, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:30,574][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Topology snapshot [ver=7, servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:30,574][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Node left topology: TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=5, 
> lastExchangeTime=1445274450531, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:30,574][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Topology snapshot [ver=7, servers=3, clients=0, CPUs=4, heap=2.7GB]
> [20:07:30,575][INFO ][main][GridCacheProcessor] Stopped cache: static-cache
> [20:07:30,575][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-marshaller-sys-cache
> [20:07:30,576][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-sys-cache
> [20:07:30,576][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-atomics-sys-cache
> [20:07:30,576][INFO ][main][GridCacheProcessor] Stopped cache: nearCache
> [20:07:30,576][INFO ][main][GridCacheProcessor] Stopped cache: null
> [20:07:30,577][INFO ][main][IgniteClientReconnectCacheTest3] 
> >>> +------------------------------------------------------------------------------------------+
> >>> Ignite ver. 
> >>> 1.5.0-SNAPSHOT#20151019-sha1:10ef06a14245c73cbfe66b744406a0391c4a9c08 
> >>> stopped OK
> >>> +------------------------------------------------------------------------------------------+
> >>> Grid name: internal.IgniteClientReconnectCacheTest3
> >>> Grid uptime: 00:00:05:128
> [20:07:30,577][INFO ][main][root] >>> Stopping grid 
> [name=internal.IgniteClientReconnectCacheTest0, 
> id=009c5a78-baed-4aca-b211-b2a634c93000]
> [20:07:30,581][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Node left topology: TcpDiscoveryNode 
> [id=009c5a78-baed-4aca-b211-b2a634c93000, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:47500], discPort=47500, order=1, intOrder=1, 
> lastExchangeTime=1445274444979, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=false]
> [20:07:30,581][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Node left topology: TcpDiscoveryNode 
> [id=009c5a78-baed-4aca-b211-b2a634c93000, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:47500], discPort=47500, order=1, intOrder=1, 
> lastExchangeTime=1445274445050, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=false]
> [20:07:30,581][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Topology snapshot [ver=8, servers=2, clients=0, CPUs=4, heap=2.7GB]
> [20:07:30,581][INFO 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Topology snapshot [ver=8, servers=2, clients=0, CPUs=4, heap=2.7GB]
> [20:07:30,589][INFO ][main][GridCacheProcessor] Stopped cache: static-cache
> [20:07:30,590][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-marshaller-sys-cache
> [20:07:30,590][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-sys-cache
> [20:07:30,590][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-atomics-sys-cache
> [20:07:30,590][INFO ][main][GridCacheProcessor] Stopped cache: nearCache
> [20:07:30,590][INFO ][main][GridCacheProcessor] Stopped cache: null
> [20:07:30,591][INFO ][main][IgniteClientReconnectCacheTest0] 
> >>> +------------------------------------------------------------------------------------------+
> >>> Ignite ver. 
> >>> 1.5.0-SNAPSHOT#20151019-sha1:10ef06a14245c73cbfe66b744406a0391c4a9c08 
> >>> stopped OK
> >>> +------------------------------------------------------------------------------------------+
> >>> Grid name: internal.IgniteClientReconnectCacheTest0
> >>> Grid uptime: 00:00:05:643
> [20:07:30,599][INFO ][main][root] >>> Stopping grid 
> [name=internal.IgniteClientReconnectCacheTest2, 
> id=20397987-c902-4000-9a54-fd39da1ac002]
> [20:07:30,609][INFO ][main][GridCacheProcessor] Stopped cache: static-cache
> [20:07:30,609][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Node left topology: TcpDiscoveryNode 
> [id=20397987-c902-4000-9a54-fd39da1ac002, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, 
> lastExchangeTime=1445274445050, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=false]
> [20:07:30,609][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-marshaller-sys-cache
> [20:07:30,609][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-sys-cache
> [20:07:30,610][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-atomics-sys-cache
> [20:07:30,610][INFO ][main][GridCacheProcessor] Stopped cache: nearCache
> [20:07:30,610][INFO 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Topology snapshot [ver=9, servers=1, clients=0, CPUs=4, heap=2.7GB]
> [20:07:30,610][INFO ][main][GridCacheProcessor] Stopped cache: null
> [20:07:30,611][INFO ][main][IgniteClientReconnectCacheTest2] 
> >>> +------------------------------------------------------------------------------------------+
> >>> Ignite ver. 
> >>> 1.5.0-SNAPSHOT#20151019-sha1:10ef06a14245c73cbfe66b744406a0391c4a9c08 
> >>> stopped OK
> >>> +------------------------------------------------------------------------------------------+
> >>> Grid name: internal.IgniteClientReconnectCacheTest2
> >>> Grid uptime: 00:00:05:242
> [20:07:30,611][INFO ][main][root] >>> Stopping grid 
> [name=internal.IgniteClientReconnectCacheTest1, 
> id=1014f5ac-19c1-482c-be6c-337755519001]
> [20:07:30,615][INFO ][main][GridCacheProcessor] Stopped cache: static-cache
> [20:07:30,615][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-marshaller-sys-cache
> [20:07:30,616][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-sys-cache
> [20:07:30,616][INFO ][main][GridCacheProcessor] Stopped cache: 
> ignite-atomics-sys-cache
> [20:07:30,616][INFO ][main][GridCacheProcessor] Stopped cache: nearCache
> [20:07:30,616][INFO ][main][GridCacheProcessor] Stopped cache: null
> [20:07:30,617][INFO ][main][IgniteClientReconnectCacheTest1] 
> >>> +------------------------------------------------------------------------------------------+
> >>> Ignite ver. 
> >>> 1.5.0-SNAPSHOT#20151019-sha1:10ef06a14245c73cbfe66b744406a0391c4a9c08 
> >>> stopped OK
> >>> +------------------------------------------------------------------------------------------+
> >>> Grid name: internal.IgniteClientReconnectCacheTest1
> >>> Grid uptime: 00:00:05:595
> [20:07:30,618][INFO ][main][root] >>> Stopping test class: 
> IgniteClientReconnectCacheTest <<<
> ------- Stderr: -------
> [20:07:22,903][WARN ][main][GridCollisionManager] Collision resolution is 
> disabled (all jobs will be activated upon arrival).
> [20:07:22,903][WARN ][main][NoopSwapSpaceSpi] Swap space is disabled. To 
> enable use FileSwapSpaceSpi.
> [20:07:24,964][WARN ][main][GridCollisionManager] Collision resolution is 
> disabled (all jobs will be activated upon arrival).
> [20:07:24,964][WARN ][main][NoopSwapSpaceSpi] Swap space is disabled. To 
> enable use FileSwapSpaceSpi.
> [20:07:25,047][WARN ][main][GridCollisionManager] Collision resolution is 
> disabled (all jobs will be activated upon arrival).
> [20:07:25,047][WARN ][main][NoopSwapSpaceSpi] Swap space is disabled. To 
> enable use FileSwapSpaceSpi.
> [20:07:25,065][WARN ][main][IgniteClientReconnectCacheTest2] Attempting to 
> start more nodes than physical RAM available on current host (this can cause 
> significant slowdown)
> [20:07:25,389][WARN ][test-runner][GridCollisionManager] Collision resolution 
> is disabled (all jobs will be activated upon arrival).
> [20:07:25,389][WARN ][test-runner][NoopSwapSpaceSpi] Swap space is disabled. 
> To enable use FileSwapSpaceSpi.
> [20:07:25,415][WARN ][test-runner][IgniteClientReconnectCacheTest3] 
> Attempting to start more nodes than physical RAM available on current host 
> (this can cause significant slowdown)
> [20:07:25,522][WARN 
> ][disco-event-worker-#4818%internal.IgniteClientReconnectCacheTest0%][GridDiscoveryManager]
>  Node FAILED: TcpDiscoveryNode [id=30ff918b-a495-42a3-a953-c71291e41003, 
> addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=4, 
> lastExchangeTime=1445274445393, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:25,523][WARN 
> ][disco-event-worker-#4880%internal.IgniteClientReconnectCacheTest1%][GridDiscoveryManager]
>  Node FAILED: TcpDiscoveryNode [id=30ff918b-a495-42a3-a953-c71291e41003, 
> addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=4, 
> lastExchangeTime=1445274445393, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:25,524][WARN 
> ][disco-event-worker-#4945%internal.IgniteClientReconnectCacheTest2%][GridDiscoveryManager]
>  Node FAILED: TcpDiscoveryNode [id=30ff918b-a495-42a3-a953-c71291e41003, 
> addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:0], discPort=0, order=4, intOrder=4, 
> lastExchangeTime=1445274445404, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true]
> [20:07:30,550][ERROR][grid-time-coordinator-#4820%internal.IgniteClientReconnectCacheTest0%][GridClockSyncProcessor]
>  Failed to send time sync snapshot to remote node (did not leave grid?) 
> [nodeId=9af84855-5704-4680-9681-24f30dd12d22, 
> msg=GridClockDeltaSnapshotMessage [snapVer=GridClockDeltaVersion [ver=6, 
> topVer=6], deltas={1014f5ac-19c1-482c-be6c-337755519001=0, 
> 9af84855-5704-4680-9681-24f30dd12d22=0, 
> 20397987-c902-4000-9a54-fd39da1ac002=0}], err=Failed to send message (node 
> may have left the grid or TCP connection cannot be established due to 
> firewall issues) [node=TcpDiscoveryNode 
> [id=9af84855-5704-4680-9681-24f30dd12d22, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:0], discPort=0, order=6, intOrder=5, 
> lastExchangeTime=1445274450531, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=true], topic=TOPIC_TIME_SYNC, msg=GridClockDeltaSnapshotMessage 
> [snapVer=GridClockDeltaVersion [ver=6, topVer=6], 
> deltas={1014f5ac-19c1-482c-be6c-337755519001=0, 
> 9af84855-5704-4680-9681-24f30dd12d22=0, 
> 20397987-c902-4000-9a54-fd39da1ac002=0}], policy=2]]
> [20:07:30,565][ERROR][main][root] Test failed.
> junit.framework.AssertionFailedError: expected:<21> but was:<20>
>     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:86)
>     at junit.framework.TestCase.assertEquals(TestCase.java:253)
>     at 
> org.apache.ignite.internal.IgniteClientReconnectCacheTest.testReconnect(IgniteClientReconnectCacheTest.java:280)
>     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:601)
>     at junit.framework.TestCase.runTest(TestCase.java:176)
>     at 
> org.apache.ignite.testframework.junits.GridAbstractTest.runTestInternal(GridAbstractTest.java:1658)
>     at 
> org.apache.ignite.testframework.junits.GridAbstractTest.access$000(GridAbstractTest.java:112)
>     at 
> org.apache.ignite.testframework.junits.GridAbstractTest$4.run(GridAbstractTest.java:1596)
> [20:07:30,607][WARN 
> ][exchange-worker-#4882%internal.IgniteClientReconnectCacheTest1%][GridCachePartitionExchangeManager]
>  Failed to send partitions full message [node=TcpDiscoveryNode 
> [id=20397987-c902-4000-9a54-fd39da1ac002, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, 
> lastExchangeTime=1445274445050, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=false], err=class o.a.i.IgniteCheckedException: Failed to send 
> message (node may have left the grid or TCP connection cannot be established 
> due to firewall issues) [node=TcpDiscoveryNode 
> [id=20397987-c902-4000-9a54-fd39da1ac002, addrs=[127.0.0.1], 
> sockAddrs=[/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, 
> lastExchangeTime=1445274445050, loc=false, ver=1.5.0#20151019-sha1:10ef06a1, 
> isClient=false], topic=TOPIC_CACHE, msg=GridDhtPartitionsFullMessage 
> [parts={1=GridDhtPartitionFullMap 
> [nodeId=1014f5ac-19c1-482c-be6c-337755519001, nodeOrder=2, updateSeq=17, 
> size=2], -2100569601=GridDhtPartitionFullMap 
> [nodeId=1014f5ac-19c1-482c-be6c-337755519001, nodeOrder=2, updateSeq=121, 
> size=2], 689859866=GridDhtPartitionFullMap 
> [nodeId=1014f5ac-19c1-482c-be6c-337755519001, nodeOrder=2, updateSeq=522, 
> size=2], -2099179462=GridDhtPartitionFullMap 
> [nodeId=1014f5ac-19c1-482c-be6c-337755519001, nodeOrder=2, updateSeq=12, 
> size=2], 236160867=GridDhtPartitionFullMap 
> [nodeId=1014f5ac-19c1-482c-be6c-337755519001, nodeOrder=2, updateSeq=522, 
> size=2], 1325947219=GridDhtPartitionFullMap 
> [nodeId=1014f5ac-19c1-482c-be6c-337755519001, nodeOrder=2, updateSeq=41, 
> size=2]}, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], 
> partCnt=6, super=GridDhtPartitionsAbstractMessage [exchId=null, lastVer=null, 
> super=GridCacheMessage [msgId=1828, depInfo=null, err=null, 
> skipPrepare=false]]], policy=2]]
> [20:07:30,608][WARN 
> ][tcp-comm-worker-#1242%internal.IgniteClientReconnectCacheTest1][IgniteClientReconnectAbstractTest$TestTcpDiscoverySpi]
>  Failed to ping node (status check will be initiated): 
> 20397987-c902-4000-9a54-fd39da1ac002
> {noformat}



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

Reply via email to