Artem Shutak created IGNITE-1738:
------------------------------------
Summary: [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: Blocker
Fix For: 1.5
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)
