Vladimir Ozerov created IGNITE-686:
--------------------------------------
Summary: HadoopClientProtocolEmbeddedSelfTest.testJobCounters
failed.
Key: IGNITE-686
URL: https://issues.apache.org/jira/browse/IGNITE-686
Project: Ignite
Issue Type: Bug
Components: hadoop
Affects Versions: sprint-2
Reporter: Vladimir Ozerov
Assignee: Vladimir Ozerov
Fix For: sprint-3
java.io.IOException: Failed to get new job ID.
at
org.apache.ignite.internal.processors.hadoop.proto.HadoopClientProtocol.getNewJobID(HadoopClientProtocol.java:90)
at
org.apache.hadoop.mapreduce.JobSubmitter.submitJobInternal(JobSubmitter.java:357)
at org.apache.hadoop.mapreduce.Job$10.run(Job.java:1285)
at org.apache.hadoop.mapreduce.Job$10.run(Job.java:1282)
at java.security.AccessController.doPrivileged(Native Method)
at javax.security.auth.Subject.doAs(Subject.java:415)
at
org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1614)
at org.apache.hadoop.mapreduce.Job.submit(Job.java:1282)
at
org.apache.ignite.client.hadoop.HadoopClientProtocolSelfTest.testJobCounters(HadoopClientProtocolSelfTest.java:189)
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:1346)
at
org.apache.ignite.testframework.junits.GridAbstractTest.access$000(GridAbstractTest.java:67)
at
org.apache.ignite.testframework.junits.GridAbstractTest$2.run(GridAbstractTest.java:1289)
Caused by: org.apache.ignite.internal.client.GridClientDisconnectedException:
Latest topology update failed.
at
org.apache.ignite.internal.client.impl.connection.GridClientTopology.nodes(GridClientTopology.java:318)
at
org.apache.ignite.internal.client.impl.GridClientAbstractProjection.projectionNodes(GridClientAbstractProjection.java:299)
at
org.apache.ignite.internal.client.impl.GridClientAbstractProjection.balancedNode(GridClientAbstractProjection.java:339)
at
org.apache.ignite.internal.client.impl.GridClientAbstractProjection.withReconnectHandling(GridClientAbstractProjection.java:96)
at
org.apache.ignite.internal.client.impl.GridClientComputeImpl.executeAsync(GridClientComputeImpl.java:124)
at
org.apache.ignite.internal.client.impl.GridClientComputeImpl.execute(GridClientComputeImpl.java:113)
at
org.apache.ignite.internal.processors.hadoop.proto.HadoopClientProtocol.getNewJobID(HadoopClientProtocol.java:83)
at
org.apache.hadoop.mapreduce.JobSubmitter.submitJobInternal(JobSubmitter.java:357)
at org.apache.hadoop.mapreduce.Job$10.run(Job.java:1285)
at org.apache.hadoop.mapreduce.Job$10.run(Job.java:1282)
at java.security.AccessController.doPrivileged(Native Method)
at javax.security.auth.Subject.doAs(Subject.java:415)
at
org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1614)
at org.apache.hadoop.mapreduce.Job.submit(Job.java:1282)
at
org.apache.ignite.client.hadoop.HadoopClientProtocolSelfTest.testJobCounters(HadoopClientProtocolSelfTest.java:189)
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:1346)
at
org.apache.ignite.testframework.junits.GridAbstractTest.access$000(GridAbstractTest.java:67)
at
org.apache.ignite.testframework.junits.GridAbstractTest$2.run(GridAbstractTest.java:1289)
Caused by: org.apache.ignite.internal.client.GridServerUnreachableException:
Failed to connect to any of the servers in list: [/127.0.0.1:11212]
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.connect(GridClientConnectionManagerAdapter.java:387)
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.init(GridClientConnectionManagerAdapter.java:199)
at
org.apache.ignite.internal.client.impl.GridClientImpl.tryInitTopology(GridClientImpl.java:470)
at
org.apache.ignite.internal.client.impl.GridClientImpl.access$200(GridClientImpl.java:42)
at
org.apache.ignite.internal.client.impl.GridClientImpl$TopologyUpdaterThread.run(GridClientImpl.java:506)
Caused by: java.net.ConnectException: Connection refused
at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:692)
at sun.nio.ch.SocketAdaptor.connect(SocketAdaptor.java:115)
at
org.apache.ignite.internal.client.impl.connection.GridClientNioTcpConnection.<init>(GridClientNioTcpConnection.java:167)
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.connect(GridClientConnectionManagerAdapter.java:436)
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.connect(GridClientConnectionManagerAdapter.java:372)
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.init(GridClientConnectionManagerAdapter.java:199)
at
org.apache.ignite.internal.client.impl.GridClientImpl.tryInitTopology(GridClientImpl.java:470)
at
org.apache.ignite.internal.client.impl.GridClientImpl.access$200(GridClientImpl.java:42)
at
org.apache.ignite.internal.client.impl.GridClientImpl$TopologyUpdaterThread.run(GridClientImpl.java:506)
------- Stdout: -------
[16:35:11,048][INFO ][main][root] >>> Starting test class:
HadoopClientProtocolEmbeddedSelfTest <<<
[16:35:11,057][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0]
>>> __________ ________________
>>> / _/ ___/ |/ / _/_ __/ __/
>>> _/ // (7 7 // / / / / _/
>>> /___/\___/_/|_/___/ /_/ /___/
>>>
>>> ver. 1.0.0#19700101-sha1:DEV
>>> 2015 Copyright(C) Apache Software Foundation
[16:35:11,057][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Config URL:
n/a
[16:35:11,057][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Daemon mode:
off
[16:35:11,057][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] OS: Linux
2.6.38-16-generic amd64
[16:35:11,057][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] OS user:
teamcity
[16:35:11,058][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Language
runtime: Java Platform API Specification ver. 1.7
[16:35:11,058][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] VM
information: Java(TM) SE Runtime Environment 1.7.0_21-b11 Oracle Corporation
Java HotSpot(TM) 64-Bit Server VM 23.21-b01
[16:35:11,058][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] VM total
memory: 2.7GB
[16:35:11,058][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Remote
Management [restart: off, REST: on, JMX (remote: off)]
[16:35:11,058][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0]
IGNITE_HOME=/home/teamcity/TeamCityAgent/work/c326f6bf1927b309
[16:35:11,058][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] VM
arguments: [-DJAVA_HOME=/home/teamcity/jdk1.7.0_21, -DMCAST_GRP=229.11.1.2,
-Dagent.home.dir=/home/teamcity/TeamCityAgent, -Dagent.name=teamcity-1,
-Dagent.ownPort=9090, -Dagent.work.dir=/home/teamcity/TeamCityAgent/work,
-Dbuild.number=1726,
-Dbuild.vcs.number=af5c9d3c9ab1b5d56ab4903a010a038a26443613,
-Dbuild.vcs.number.1=af5c9d3c9ab1b5d56ab4903a010a038a26443613,
-Dbuild.vcs.number.IgniteApache=af5c9d3c9ab1b5d56ab4903a010a038a26443613,
-Dclassworlds.conf=/home/teamcity/TeamCityAgent/temp/buildTmp/teamcity.m2.conf,
-Dcom.jetbrains.maven.watcher.report.file=/home/teamcity/TeamCityAgent/temp/buildTmp/maven-build-info.xml,
-Dhadoop.version=2.5.2,
-Djava.io.tmpdir=/home/teamcity/TeamCityAgent/temp/buildTmp,
-Dmaven.home=/home/teamcity/TeamCityAgent/tools/maven3,
-Dmaven.repo.local=/home/teamcity/.m2/repository,
-Dteamcity.agent.cpuBenchmark=654,
-Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2,
-Dteamcity.agent.dotnet.build_id=412611,
-Dteamcity.auth.password=FNsmPwlmAOxBoPXgR25b8HCOjnhHDqBJ,
-Dteamcity.auth.userId=TeamCityBuildId=412611,
-Dteamcity.build.changedFiles.file=/home/teamcity/TeamCityAgent/temp/buildTmp/changedFiles353322571781968159.txt,
-Dteamcity.build.checkoutDir=/home/teamcity/TeamCityAgent/work/c326f6bf1927b309,
-Dteamcity.build.id=412611,
-Dteamcity.build.properties.file=/home/teamcity/TeamCityAgent/temp/buildTmp/teamcity.build543335480770253159.properties,
-Dteamcity.build.tempDir=/home/teamcity/TeamCityAgent/temp/buildTmp,
-Dteamcity.build.workingDir=/home/teamcity/TeamCityAgent/work/c326f6bf1927b309,
-Dteamcity.buildConfName=Ignite Hadoop, -Dteamcity.buildType.id=Ignite_Hadoop,
-Dteamcity.configuration.properties.file=/home/teamcity/TeamCityAgent/temp/buildTmp/teamcity.config4313047004623220906.properties,
-Dteamcity.idea.home=/home/teamcity/TeamCityAgent/plugins/idea,
-Dteamcity.maven.watcher.home=/home/teamcity/TeamCityAgent/plugins/mavenPlugin/maven-watcher,
-Dteamcity.projectName=Ignite,
-Dteamcity.runner.properties.file=/home/teamcity/TeamCityAgent/temp/buildTmp/teamcity.runner1856864711574287420.properties,
-Dteamcity.tests.recentlyFailedTests.file=/home/teamcity/TeamCityAgent/temp/buildTmp/testsToRunFirst8729913223067394186.txt,
-Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=2g, -Xms1g,
-Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, -XX:+AggressiveOpts,
-DIGNITE_TEST_HOME=/home/teamcity/TeamCityAgent/work/c326f6bf1927b309,
-DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true,
-DIGNITE_QUIET=false, -XX:+PrintGC, -XX:+PrintGCDetails, -XX:+PrintGCTimeStamps]
[16:35:11,058][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Configured
caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache',
'ignite-hadoop-mr-sys-cache', 'ignite-atomics-sys-cache', 'meta', 'data']
[16:35:11,059][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] 3-rd party
licenses can be found at:
/home/teamcity/TeamCityAgent/work/c326f6bf1927b309/libs/licenses
[16:35:11,061][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Non-loopback
local IPs: 192.168.2.11, fe80:0:0:0:5604:a6ff:fe62:1fa7%2
[16:35:11,061][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Enabled
local MACs: 5404A6621FA7
[16:35:11,062][INFO ][main][IgnitePluginProcessor] Configured plugins:
[16:35:11,062][INFO ][main][IgnitePluginProcessor] ^-- None
[16:35:11,062][INFO ][main][IgnitePluginProcessor]
[16:35:11,065][INFO ][main][TcpCommunicationSpi] Successfully bound to TCP port
[port=45240, locHost=/127.0.0.1]
[16:35:11,072][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Security
status [authentication=off]
[16:35:11,080][INFO ][main][GridTcpRestProtocol] Command protocol successfully
started [name=TCP binary, host=/127.0.0.1, port=11212]
[16:35:11,081][INFO ][main][IpcSharedMemoryServerEndpoint] IPC shared memory
server endpoint started [port=10500,
tokDir=/home/teamcity/TeamCityAgent/temp/buildTmp/ignite/work/ipc/shmem/9f489d9d-809a-4595-b64a-ebd21bacb90d-14523]
[16:35:11,081][INFO ][main][IpcServerTcpEndpoint] IPC server loopback endpoint
started [port=11400]
[16:35:11,081][INFO ][main][HadoopProcessor] HADOOP_HOME is set to
/home/teamcity/TeamCityAgent/temp/buildTmp/__hadoop/hadoop-2.5.2
[16:35:11,085][INFO ][main][TcpDiscoverySpi] Successfully bound to TCP port
[port=47500, localHost=/127.0.0.1]
[16:35:11,087][INFO ][main][GridCacheProcessor] Started cache
[name=ignite-marshaller-sys-cache, mode=REPLICATED]
[16:35:11,088][INFO ][main][GridCacheProcessor] Started cache [name=meta,
mode=REPLICATED]
[16:35:11,090][INFO ][main][GridCacheProcessor] Started cache
[name=ignite-hadoop-mr-sys-cache, mode=REPLICATED]
[16:35:11,091][INFO ][main][GridCacheProcessor] Started cache
[name=ignite-atomics-sys-cache, mode=PARTITIONED]
[16:35:11,093][INFO ][main][GridCacheProcessor] Started cache [name=data,
mode=PARTITIONED]
[16:35:11,095][INFO ][main][GridCacheProcessor] Started cache
[name=ignite-sys-cache, mode=REPLICATED]
[16:35:11,110][INFO ][main][GridDhtPreloader] <ignite-marshaller-sys-cache>
Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache
[16:35:11,110][INFO ][main][GridDhtPreloader] <ignite-hadoop-mr-sys-cache>
Starting rebalancing in SYNC mode: ignite-hadoop-mr-sys-cache
[16:35:11,111][INFO ][main][GridDhtPreloader] <meta> Starting rebalancing in
ASYNC mode: meta
[16:35:11,111][INFO ][main][GridDhtPreloader] <ignite-atomics-sys-cache>
Starting rebalancing in SYNC mode: ignite-atomics-sys-cache
[16:35:11,111][INFO ][main][GridDhtPreloader] <data> Starting rebalancing in
ASYNC mode: data
[16:35:11,111][INFO ][main][GridDhtPreloader] <ignite-sys-cache> Starting
rebalancing in SYNC mode: ignite-sys-cache
[16:35:11,113][INFO
][preloader-demand-worker-#22689%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][GridDhtPreloader]
<ignite-marshaller-sys-cache> Completed rebalancing in SYNC mode
[cache=ignite-marshaller-sys-cache, time=0 ms]
[16:35:11,113][INFO
][preloader-demand-worker-#22693%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][GridDhtPreloader]
<ignite-hadoop-mr-sys-cache> Completed rebalancing in SYNC mode
[cache=ignite-hadoop-mr-sys-cache, time=0 ms]
[16:35:11,114][INFO
][preloader-demand-worker-#22698%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][GridDhtPreloader]
<meta> Completed rebalancing in ASYNC mode [cache=meta, time=0 ms]
[16:35:11,114][INFO
][preloader-demand-worker-#22702%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][GridDhtPreloader]
<ignite-atomics-sys-cache> Completed rebalancing in SYNC mode
[cache=ignite-atomics-sys-cache, time=10 ms]
[16:35:11,115][INFO
][preloader-demand-worker-#22708%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][GridDhtPreloader]
<data> Completed rebalancing in ASYNC mode [cache=data, time=10 ms]
[16:35:11,116][INFO
][preloader-demand-worker-#22713%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][GridDhtPreloader]
<ignite-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-sys-cache,
time=10 ms]
[16:35:11,128][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] Performance
suggestions for grid 'hadoop.HadoopClientProtocolEmbeddedSelfTest0' (fix if
possible)
[16:35:11,128][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] To disable,
set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
[16:35:11,128][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] ^--
Disable checkpoints (remove 'checkpointSpi' from configuration)
[16:35:11,128][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] ^--
Disable grid events (remove 'includeEventTypes' from configuration)
[16:35:11,128][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0]
[16:35:11,128][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0] To start
Console Management & Monitoring run ignitevisorcmd.{sh|bat}
[16:35:11,129][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0]
[16:35:11,129][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0]
>>> +---------------------------------+
>>> Ignite ver. 1.0.0#19700101-sha1:DEV
>>> +---------------------------------+
>>> OS name: Linux 2.6.38-16-generic amd64
>>> CPU(s): 4
>>> Heap: 2.7GB
>>> VM name: 14523@gg-teamcity-1
>>> Grid name: hadoop.HadoopClientProtocolEmbeddedSelfTest0
>>> Local node [ID=9F489D9D-809A-4595-B64A-EBD21BACB90D, order=1]
>>> Local node addresses: [/127.0.0.1]
>>> Local ports: TCP:10500 TCP:11212 TCP:11400 TCP:45240 TCP:47500
>>> Ignite documentation: http://ignite.incubator.apache.org
[16:35:11,130][INFO ][main][GridDiscoveryManager] Topology snapshot [ver=1,
nodes=1, CPUs=4, heap=2.7GB]
[16:35:11,135][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1]
>>> __________ ________________
>>> / _/ ___/ |/ / _/_ __/ __/
>>> _/ // (7 7 // / / / / _/
>>> /___/\___/_/|_/___/ /_/ /___/
>>>
>>> ver. 1.0.0#19700101-sha1:DEV
>>> 2015 Copyright(C) Apache Software Foundation
[16:35:11,135][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Config URL:
n/a
[16:35:11,135][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Daemon mode:
off
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] OS: Linux
2.6.38-16-generic amd64
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] OS user:
teamcity
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Language
runtime: Java Platform API Specification ver. 1.7
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] VM
information: Java(TM) SE Runtime Environment 1.7.0_21-b11 Oracle Corporation
Java HotSpot(TM) 64-Bit Server VM 23.21-b01
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] VM total
memory: 2.7GB
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Remote
Management [restart: off, REST: on, JMX (remote: off)]
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1]
IGNITE_HOME=/home/teamcity/TeamCityAgent/work/c326f6bf1927b309
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] VM
arguments: [-DJAVA_HOME=/home/teamcity/jdk1.7.0_21, -DMCAST_GRP=229.11.1.2,
-Dagent.home.dir=/home/teamcity/TeamCityAgent, -Dagent.name=teamcity-1,
-Dagent.ownPort=9090, -Dagent.work.dir=/home/teamcity/TeamCityAgent/work,
-Dbuild.number=1726,
-Dbuild.vcs.number=af5c9d3c9ab1b5d56ab4903a010a038a26443613,
-Dbuild.vcs.number.1=af5c9d3c9ab1b5d56ab4903a010a038a26443613,
-Dbuild.vcs.number.IgniteApache=af5c9d3c9ab1b5d56ab4903a010a038a26443613,
-Dclassworlds.conf=/home/teamcity/TeamCityAgent/temp/buildTmp/teamcity.m2.conf,
-Dcom.jetbrains.maven.watcher.report.file=/home/teamcity/TeamCityAgent/temp/buildTmp/maven-build-info.xml,
-Dhadoop.version=2.5.2,
-Djava.io.tmpdir=/home/teamcity/TeamCityAgent/temp/buildTmp,
-Dmaven.home=/home/teamcity/TeamCityAgent/tools/maven3,
-Dmaven.repo.local=/home/teamcity/.m2/repository,
-Dteamcity.agent.cpuBenchmark=654,
-Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2,
-Dteamcity.agent.dotnet.build_id=412611,
-Dteamcity.auth.password=FNsmPwlmAOxBoPXgR25b8HCOjnhHDqBJ,
-Dteamcity.auth.userId=TeamCityBuildId=412611,
-Dteamcity.build.changedFiles.file=/home/teamcity/TeamCityAgent/temp/buildTmp/changedFiles353322571781968159.txt,
-Dteamcity.build.checkoutDir=/home/teamcity/TeamCityAgent/work/c326f6bf1927b309,
-Dteamcity.build.id=412611,
-Dteamcity.build.properties.file=/home/teamcity/TeamCityAgent/temp/buildTmp/teamcity.build543335480770253159.properties,
-Dteamcity.build.tempDir=/home/teamcity/TeamCityAgent/temp/buildTmp,
-Dteamcity.build.workingDir=/home/teamcity/TeamCityAgent/work/c326f6bf1927b309,
-Dteamcity.buildConfName=Ignite Hadoop, -Dteamcity.buildType.id=Ignite_Hadoop,
-Dteamcity.configuration.properties.file=/home/teamcity/TeamCityAgent/temp/buildTmp/teamcity.config4313047004623220906.properties,
-Dteamcity.idea.home=/home/teamcity/TeamCityAgent/plugins/idea,
-Dteamcity.maven.watcher.home=/home/teamcity/TeamCityAgent/plugins/mavenPlugin/maven-watcher,
-Dteamcity.projectName=Ignite,
-Dteamcity.runner.properties.file=/home/teamcity/TeamCityAgent/temp/buildTmp/teamcity.runner1856864711574287420.properties,
-Dteamcity.tests.recentlyFailedTests.file=/home/teamcity/TeamCityAgent/temp/buildTmp/testsToRunFirst8729913223067394186.txt,
-Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=2g, -Xms1g,
-Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, -XX:+AggressiveOpts,
-DIGNITE_TEST_HOME=/home/teamcity/TeamCityAgent/work/c326f6bf1927b309,
-DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true,
-DIGNITE_QUIET=false, -XX:+PrintGC, -XX:+PrintGCDetails, -XX:+PrintGCTimeStamps]
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Configured
caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache',
'ignite-hadoop-mr-sys-cache', 'ignite-atomics-sys-cache', 'meta', 'data']
[16:35:11,136][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] 3-rd party
licenses can be found at:
/home/teamcity/TeamCityAgent/work/c326f6bf1927b309/libs/licenses
[16:35:11,138][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Non-loopback
local IPs: 192.168.2.11, fe80:0:0:0:5604:a6ff:fe62:1fa7%2
[16:35:11,139][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Enabled
local MACs: 5404A6621FA7
[16:35:11,139][INFO ][main][IgnitePluginProcessor] Configured plugins:
[16:35:11,139][INFO ][main][IgnitePluginProcessor] ^-- None
[16:35:11,139][INFO ][main][IgnitePluginProcessor]
[16:35:11,141][INFO ][main][TcpCommunicationSpi] Successfully bound to TCP port
[port=45241, locHost=/127.0.0.1]
[16:35:11,147][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Security
status [authentication=off]
[16:35:11,155][INFO ][main][GridTcpRestProtocol] Command protocol successfully
started [name=TCP binary, host=/127.0.0.1, port=11213]
[16:35:11,156][INFO ][main][HadoopProcessor] HADOOP_HOME is set to
/home/teamcity/TeamCityAgent/temp/buildTmp/__hadoop/hadoop-2.5.2
[16:35:11,160][INFO ][main][TcpDiscoverySpi] Successfully bound to TCP port
[port=47501, localHost=/127.0.0.1]
[16:35:11,198][INFO
][disco-event-worker-#22681%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][GridDiscoveryManager]
Added new node to topology: TcpDiscoveryNode
[id=eebe00a7-c7d5-40f6-a84c-b1bfcd537c78, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:47501], discPort=47501, order=2, intOrder=2, loc=false,
ver=1.0.0#19700101-sha1:00000000, isClient=false]
[16:35:11,198][INFO
][disco-event-worker-#22681%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][GridDiscoveryManager]
Topology snapshot [ver=2, nodes=2, CPUs=4, heap=2.7GB]
[16:35:11,202][INFO ][main][GridCacheProcessor] Started cache
[name=ignite-marshaller-sys-cache, mode=REPLICATED]
[16:35:11,204][INFO ][main][GridCacheProcessor] Started cache [name=meta,
mode=REPLICATED]
[16:35:11,207][INFO ][main][GridCacheProcessor] Started cache
[name=ignite-hadoop-mr-sys-cache, mode=REPLICATED]
[16:35:11,210][INFO ][main][GridCacheProcessor] Started cache
[name=ignite-atomics-sys-cache, mode=PARTITIONED]
[16:35:11,213][INFO ][main][GridCacheProcessor] Started cache [name=data,
mode=PARTITIONED]
[16:35:11,215][INFO ][main][GridCacheProcessor] Started cache
[name=ignite-sys-cache, mode=REPLICATED]
[16:35:11,269][INFO ][main][GridDhtPreloader] <ignite-marshaller-sys-cache>
Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache
[16:35:11,269][INFO ][main][GridDhtPreloader] <ignite-hadoop-mr-sys-cache>
Starting rebalancing in SYNC mode: ignite-hadoop-mr-sys-cache
[16:35:11,269][INFO ][main][GridDhtPreloader] <meta> Starting rebalancing in
ASYNC mode: meta
[16:35:11,269][INFO ][main][GridDhtPreloader] <ignite-atomics-sys-cache>
Starting rebalancing in SYNC mode: ignite-atomics-sys-cache
[16:35:11,270][INFO ][main][GridDhtPreloader] <data> Starting rebalancing in
ASYNC mode: data
[16:35:11,270][INFO ][main][GridDhtPreloader] <ignite-sys-cache> Starting
rebalancing in SYNC mode: ignite-sys-cache
[16:35:11,275][INFO
][preloader-demand-worker-#22769%hadoop.HadoopClientProtocolEmbeddedSelfTest1%][GridDhtPreloader]
<ignite-marshaller-sys-cache> Completed rebalancing in SYNC mode
[cache=ignite-marshaller-sys-cache, time=0 ms]
[16:35:11,280][INFO
][preloader-demand-worker-#22795%hadoop.HadoopClientProtocolEmbeddedSelfTest1%][GridDhtPreloader]
<ignite-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-sys-cache,
time=10 ms]
[16:35:11,282][INFO
][preloader-demand-worker-#22790%hadoop.HadoopClientProtocolEmbeddedSelfTest1%][GridDhtPreloader]
<data> Completed rebalancing in ASYNC mode [cache=data, time=10 ms]
[16:35:11,282][INFO
][preloader-demand-worker-#22784%hadoop.HadoopClientProtocolEmbeddedSelfTest1%][GridDhtPreloader]
<ignite-atomics-sys-cache> Completed rebalancing in SYNC mode
[cache=ignite-atomics-sys-cache, time=10 ms]
[16:35:11,284][INFO
][preloader-demand-worker-#22775%hadoop.HadoopClientProtocolEmbeddedSelfTest1%][GridDhtPreloader]
<ignite-hadoop-mr-sys-cache> Completed rebalancing in SYNC mode
[cache=ignite-hadoop-mr-sys-cache, time=10 ms]
[16:35:11,284][INFO
][preloader-demand-worker-#22780%hadoop.HadoopClientProtocolEmbeddedSelfTest1%][GridDhtPreloader]
<meta> Completed rebalancing in ASYNC mode [cache=meta, time=10 ms]
[16:35:11,290][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] Performance
suggestions for grid 'hadoop.HadoopClientProtocolEmbeddedSelfTest1' (fix if
possible)
[16:35:11,290][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] To disable,
set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
[16:35:11,290][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] ^--
Disable checkpoints (remove 'checkpointSpi' from configuration)
[16:35:11,290][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] ^--
Disable grid events (remove 'includeEventTypes' from configuration)
[16:35:11,290][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1]
[16:35:11,290][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1] To start
Console Management & Monitoring run ignitevisorcmd.{sh|bat}
[16:35:11,290][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1]
[16:35:11,291][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1]
>>> +---------------------------------+
>>> Ignite ver. 1.0.0#19700101-sha1:DEV
>>> +---------------------------------+
>>> OS name: Linux 2.6.38-16-generic amd64
>>> CPU(s): 4
>>> Heap: 2.7GB
>>> VM name: 14523@gg-teamcity-1
>>> Grid name: hadoop.HadoopClientProtocolEmbeddedSelfTest1
>>> Local node [ID=EEBE00A7-C7D5-40F6-A84C-B1BFCD537C78, order=2]
>>> Local node addresses: [/127.0.0.1]
>>> Local ports: TCP:11213 TCP:45241 TCP:47501
>>> Ignite documentation: http://ignite.incubator.apache.org
[16:35:11,291][INFO ][main][GridDiscoveryManager] Topology snapshot [ver=2,
nodes=2, CPUs=4, heap=2.7GB]
[16:35:11,291][INFO ][main][root] >>> Starting test: testJobCounters <<<
[16:35:11,365][INFO ][main][root] >>> Stopping test: testJobCounters in 73 ms
<<<
[16:35:11,402][INFO ][main][root] >>> Stopping test class:
HadoopClientProtocolEmbeddedSelfTest <<<
[16:35:11,402][INFO ][main][root] >>> Stopping grid
[name=hadoop.HadoopClientProtocolEmbeddedSelfTest0,
id=9f489d9d-809a-4595-b64a-ebd21bacb90d]
[16:35:11,403][INFO ][main][GridTcpRestProtocol] Command protocol successfully
stopped: TCP binary
[16:35:11,410][INFO
][disco-event-worker-#22763%hadoop.HadoopClientProtocolEmbeddedSelfTest1%][GridDiscoveryManager]
Node left topology: TcpDiscoveryNode [id=9f489d9d-809a-4595-b64a-ebd21bacb90d,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:47500], discPort=47500, order=1,
intOrder=1, loc=false, ver=1.0.0#19700101-sha1:00000000, isClient=false]
[16:35:11,411][INFO
][disco-event-worker-#22763%hadoop.HadoopClientProtocolEmbeddedSelfTest1%][GridDiscoveryManager]
Topology snapshot [ver=3, nodes=1, CPUs=4, heap=2.7GB]
[16:35:11,422][INFO ][main][GridCacheProcessor] Stopped cache:
ignite-marshaller-sys-cache
[16:35:11,422][INFO ][main][GridCacheProcessor] Stopped cache: ignite-sys-cache
[16:35:11,422][INFO ][main][GridCacheProcessor] Stopped cache:
ignite-hadoop-mr-sys-cache
[16:35:11,422][INFO ][main][GridCacheProcessor] Stopped cache:
ignite-atomics-sys-cache
[16:35:11,423][INFO ][main][GridCacheProcessor] Stopped cache: meta
[16:35:11,423][INFO ][main][GridCacheProcessor] Stopped cache: data
[16:35:11,425][INFO ][main][HadoopClientProtocolEmbeddedSelfTest0]
>>> +--------------------------------------------+
>>> Ignite ver. 1.0.0#19700101-sha1:DEV stopped OK
>>> +--------------------------------------------+
>>> Grid name: hadoop.HadoopClientProtocolEmbeddedSelfTest0
>>> Grid uptime: 00:00:00:292
[16:35:11,426][INFO ][main][root] >>> Stopping grid
[name=hadoop.HadoopClientProtocolEmbeddedSelfTest1,
id=eebe00a7-c7d5-40f6-a84c-b1bfcd537c78]
[16:35:11,427][INFO ][main][GridTcpRestProtocol] Command protocol successfully
stopped: TCP binary
[16:35:11,432][INFO ][main][GridCacheProcessor] Stopped cache:
ignite-marshaller-sys-cache
[16:35:11,432][INFO ][main][GridCacheProcessor] Stopped cache: ignite-sys-cache
[16:35:11,432][INFO ][main][GridCacheProcessor] Stopped cache:
ignite-hadoop-mr-sys-cache
[16:35:11,432][INFO ][main][GridCacheProcessor] Stopped cache:
ignite-atomics-sys-cache
[16:35:11,432][INFO ][main][GridCacheProcessor] Stopped cache: meta
[16:35:11,433][INFO ][main][GridCacheProcessor] Stopped cache: data
[16:35:11,436][INFO ][main][HadoopClientProtocolEmbeddedSelfTest1]
>>> +--------------------------------------------+
>>> Ignite ver. 1.0.0#19700101-sha1:DEV stopped OK
>>> +--------------------------------------------+
>>> Grid name: hadoop.HadoopClientProtocolEmbeddedSelfTest1
>>> Grid uptime: 00:00:00:141
------- Stderr: -------
[16:35:11,071][WARN ][main][GridCollisionManager] Collision resolution is
disabled (all jobs will be activated upon arrival).
[16:35:11,071][WARN ][main][NoopSwapSpaceSpi] Swap space is disabled. To enable
use FileSwapSpaceSpi.
[16:35:11,071][WARN ][main][GridIndexingManager] Indexing is disabled (to
enable please configure GridIndexingSpi).
[16:35:11,083][WARN ][main][TcpDiscoverySpi] Heartbeat frequency is too high
(at least 2000 ms recommended): 1000
[16:35:11,146][WARN ][main][GridCollisionManager] Collision resolution is
disabled (all jobs will be activated upon arrival).
[16:35:11,146][WARN ][main][NoopSwapSpaceSpi] Swap space is disabled. To enable
use FileSwapSpaceSpi.
[16:35:11,146][WARN ][main][GridIndexingManager] Indexing is disabled (to
enable please configure GridIndexingSpi).
[16:35:11,156][WARN ][main][IgfsServerManager] Failed to start IGFS endpoint
(will retry every 3s). Failed to bind to port (is port already in use?): 10500
[16:35:11,156][WARN ][main][IgfsServerManager] Failed to start IGFS management
endpoint (will retry every 3s). Failed to bind to port (is port already in
use?): 11400
[16:35:11,158][WARN ][main][TcpDiscoverySpi] Heartbeat frequency is too high
(at least 2000 ms recommended): 1000
[16:35:11,362][ERROR][main][root] Test failed.
java.io.IOException: Failed to get new job ID.
at
org.apache.ignite.internal.processors.hadoop.proto.HadoopClientProtocol.getNewJobID(HadoopClientProtocol.java:90)
at
org.apache.hadoop.mapreduce.JobSubmitter.submitJobInternal(JobSubmitter.java:357)
at org.apache.hadoop.mapreduce.Job$10.run(Job.java:1285)
at org.apache.hadoop.mapreduce.Job$10.run(Job.java:1282)
at java.security.AccessController.doPrivileged(Native Method)
at javax.security.auth.Subject.doAs(Subject.java:415)
at
org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1614)
at org.apache.hadoop.mapreduce.Job.submit(Job.java:1282)
at
org.apache.ignite.client.hadoop.HadoopClientProtocolSelfTest.testJobCounters(HadoopClientProtocolSelfTest.java:189)
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:1346)
at
org.apache.ignite.testframework.junits.GridAbstractTest.access$000(GridAbstractTest.java:67)
at
org.apache.ignite.testframework.junits.GridAbstractTest$2.run(GridAbstractTest.java:1289)
Caused by: class
org.apache.ignite.internal.client.GridClientDisconnectedException: Latest
topology update failed.
at
org.apache.ignite.internal.client.impl.connection.GridClientTopology.nodes(GridClientTopology.java:318)
at
org.apache.ignite.internal.client.impl.GridClientAbstractProjection.projectionNodes(GridClientAbstractProjection.java:299)
at
org.apache.ignite.internal.client.impl.GridClientAbstractProjection.balancedNode(GridClientAbstractProjection.java:339)
at
org.apache.ignite.internal.client.impl.GridClientAbstractProjection.withReconnectHandling(GridClientAbstractProjection.java:96)
at
org.apache.ignite.internal.client.impl.GridClientComputeImpl.executeAsync(GridClientComputeImpl.java:124)
at
org.apache.ignite.internal.client.impl.GridClientComputeImpl.execute(GridClientComputeImpl.java:113)
at
org.apache.ignite.internal.processors.hadoop.proto.HadoopClientProtocol.getNewJobID(HadoopClientProtocol.java:83)
... 16 more
Caused by: class
org.apache.ignite.internal.client.GridServerUnreachableException: Failed to
connect to any of the servers in list: [/127.0.0.1:11212]
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.connect(GridClientConnectionManagerAdapter.java:387)
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.init(GridClientConnectionManagerAdapter.java:199)
at
org.apache.ignite.internal.client.impl.GridClientImpl.tryInitTopology(GridClientImpl.java:470)
at
org.apache.ignite.internal.client.impl.GridClientImpl.access$200(GridClientImpl.java:42)
at
org.apache.ignite.internal.client.impl.GridClientImpl$TopologyUpdaterThread.run(GridClientImpl.java:506)
Caused by: java.net.ConnectException: Connection refused
at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:692)
at sun.nio.ch.SocketAdaptor.connect(SocketAdaptor.java:115)
at
org.apache.ignite.internal.client.impl.connection.GridClientNioTcpConnection.<init>(GridClientNioTcpConnection.java:167)
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.connect(GridClientConnectionManagerAdapter.java:436)
at
org.apache.ignite.internal.client.impl.connection.GridClientConnectionManagerAdapter.connect(GridClientConnectionManagerAdapter.java:372)
... 4 more
[16:35:11,419][ERROR][ipc-shmem-gc-#22679%hadoop.HadoopClientProtocolEmbeddedSelfTest0%][IpcSharedMemoryServerEndpoint]
Failed to process directory:
/home/teamcity/TeamCityAgent/temp/buildTmp/ignite/work/ipc/shmem
java.nio.channels.FileLockInterruptionException
at sun.nio.ch.FileChannelImpl.lock(FileChannelImpl.java:1001)
at java.nio.channels.FileChannel.lock(FileChannel.java:1052)
at
org.apache.ignite.internal.util.ipc.shmem.IpcSharedMemoryServerEndpoint$GcWorker.cleanupResources(IpcSharedMemoryServerEndpoint.java:584)
at
org.apache.ignite.internal.util.ipc.shmem.IpcSharedMemoryServerEndpoint$GcWorker.body(IpcSharedMemoryServerEndpoint.java:543)
at
org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:107)
at java.lang.Thread.run(Thread.java:722)
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
