You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@ignite.apache.org by "Ivan Veselovsky (JIRA)" <ji...@apache.org> on 2015/03/27 16:47:53 UTC
[jira] [Created] (IGNITE-633) Test
HadoopMapReduceEmbeddedSelfTest.testWholeMapReduceExecution somatimes hangs
Ivan Veselovsky created IGNITE-633:
--------------------------------------
Summary: Test HadoopMapReduceEmbeddedSelfTest.testWholeMapReduceExecution somatimes hangs
Key: IGNITE-633
URL: https://issues.apache.org/jira/browse/IGNITE-633
Project: Ignite
Issue Type: Test
Components: hadoop
Affects Versions: sprint-2
Reporter: Ivan Veselovsky
Assignee: Ivan Veselovsky
Fix For: sprint-3
Test HadoopMapReduceEmbeddedSelfTest.testWholeMapReduceExecution
java.util.concurrent.TimeoutException: Test has been timed out [test=testWholeMapReduceExecution, timeout=300000]
at org.apache.ignite.testframework.junits.GridAbstractTest.runTest(GridAbstractTest.java:1317)
at junit.framework.TestCase.runBare(TestCase.java:141)
at junit.framework.TestResult$1.protect(TestResult.java:122)
at junit.framework.TestResult.runProtected(TestResult.java:142)
at junit.framework.TestResult.run(TestResult.java:125)
at junit.framework.TestCase.run(TestCase.java:129)
at junit.framework.TestSuite.runTest(TestSuite.java:255)
at junit.framework.TestSuite.run(TestSuite.java:250)
at junit.framework.TestSuite.runTest(TestSuite.java:255)
at junit.framework.TestSuite.run(TestSuite.java:250)
at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:84)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124)
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:606)
at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray2(ReflectionUtils.java:208)
at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:156)
at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:82)
at org.apache.maven.plugin.surefire.InPluginVMSurefireStarter.runSuitesInProcess(InPluginVMSurefireStarter.java:82)
at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeProvider(AbstractSurefireMojo.java:951)
at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeAfterPreconditionsChecked(AbstractSurefireMojo.java:831)
at org.apache.maven.plugin.surefire.AbstractSurefireMojo.execute(AbstractSurefireMojo.java:729)
at org.apache.maven.plugin.DefaultBuildPluginManager.executeMojo(DefaultBuildPluginManager.java:101)
at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:209)
at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:153)
at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:145)
at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:84)
at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:59)
at org.apache.maven.lifecycle.internal.LifecycleStarter.singleThreadedBuild(LifecycleStarter.java:183)
at org.apache.maven.lifecycle.internal.LifecycleStarter.execute(LifecycleStarter.java:161)
at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:320)
at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:156)
at org.apache.maven.cli.MavenCli.execute(MavenCli.java:537)
at org.apache.maven.cli.MavenCli.doMain(MavenCli.java:196)
at org.apache.maven.cli.MavenCli.main(MavenCli.java:141)
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:606)
at org.codehaus.plexus.classworlds.launcher.Launcher.launchEnhanced(Launcher.java:290)
at org.codehaus.plexus.classworlds.launcher.Launcher.launch(Launcher.java:230)
at org.codehaus.plexus.classworlds.launcher.Launcher.mainWithExitCode(Launcher.java:409)
at org.codehaus.plexus.classworlds.launcher.Launcher.main(Launcher.java:352)
------- Stdout: -------
[16:37:40,133][INFO ][main][root] >>> Starting test: testWholeMapReduceExecution <<<
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0]
>>> __________ ________________
>>> / _/ ___/ |/ / _/_ __/ __/
>>> _/ // (7 7 // / / / / _/
>>> /___/\___/_/|_/___/ /_/ /___/
>>>
>>> ver. 1.0.0#19700101-sha1:DEV
>>> 2015 Copyright(C) Apache Software Foundation
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Config URL: n/a
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Daemon mode: off
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] OS: Linux 2.6.32-38-generic amd64
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] OS user: teamcity
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Language runtime: Java Platform API Specification ver. 1.7
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] VM information: Java(TM) SE Runtime Environment 1.7.0_67-b01 Oracle Corporation Java HotSpot(TM) 64-Bit Server VM 24.65-b04
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] VM total memory: 2.9GB
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Remote Management [restart: off, REST: off, JMX (remote: off)]
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] IGNITE_HOME=/usr/local/TeamCityAgent/work/c326f6bf1927b309
[16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] VM arguments: [-DJAVA_HOME=/usr/lib/jvm/java-7-oracle, -DMCAST_GRP=229.17.1.2, -Dagent.home.dir=/usr/local/TeamCityAgent, -Dagent.name=teamcity-7, -Dagent.ownPort=9090, -Dagent.work.dir=/usr/local/TeamCityAgent/work, -Dbuild.number=1560, -Dbuild.vcs.number=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuild.vcs.number.1=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuild.vcs.number.IgniteApache=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -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, -Dhadoop.version=2.5.2, -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=663, -Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2, -Dteamcity.agent.dotnet.build_id=400410, -Dteamcity.auth.password=nu1IIi3SWEb8NNhLDhghzpZjQSPWkYV3, -Dteamcity.auth.userId=TeamCityBuildId=400410, -Dteamcity.build.changedFiles.file=/usr/local/TeamCityAgent/temp/buildTmp/changedFiles6192942218181221816.txt, -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.build.id=400410, -Dteamcity.build.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.build1936164090676629649.properties, -Dteamcity.build.tempDir=/usr/local/TeamCityAgent/temp/buildTmp, -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.buildConfName=Ignite Hadoop, -Dteamcity.buildType.id=Ignite_Hadoop, -Dteamcity.configuration.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.config1651692759705343482.properties, -Dteamcity.idea.home=/usr/local/TeamCityAgent/plugins/idea, -Dteamcity.maven.watcher.home=/usr/local/TeamCityAgent/plugins/mavenPlugin/maven-watcher, -Dteamcity.projectName=Ignite, -Dteamcity.runner.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.runner4645183226190514392.properties, -Dteamcity.tests.recentlyFailedTests.file=/usr/local/TeamCityAgent/temp/buildTmp/testsToRunFirst6297047454049666673.txt, -Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=2g, -Xms1g, -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, -XX:+AggressiveOpts, -DIGNITE_TEST_HOME=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true, -DIGNITE_QUIET=false, -XX:+PrintGC, -XX:+PrintGCDetails, -XX:+PrintGCTimeStamps]
[16:37:40,162][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Configured caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 'ignite-hadoop-mr-sys-cache', 'ignite-atomics-sys-cache', 'meta', 'data']
[16:37:40,162][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] 3-rd party licenses can be found at: /usr/local/TeamCityAgent/work/c326f6bf1927b309/libs/licenses
[16:37:40,174][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Non-loopback local IPs: 192.168.2.17, fe80:0:0:0:ca60:ff:fe68:5868%2
[16:37:40,174][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Enabled local MACs: C86000685868
[16:37:40,175][INFO ][main][IgnitePluginProcessor] Configured plugins:
[16:37:40,175][INFO ][main][IgnitePluginProcessor] ^-- None
[16:37:40,175][INFO ][main][IgnitePluginProcessor]
[16:37:40,189][INFO ][main][TcpCommunicationSpi] Successfully bound to TCP port [port=45190, locHost=/127.0.0.1]
[16:37:40,221][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Security status [authentication=off]
[16:37:40,241][INFO ][main][IpcSharedMemoryServerEndpoint] IPC shared memory server endpoint started [port=10500, tokDir=/usr/local/TeamCityAgent/work/c326f6bf1927b309/work/ipc/shmem/954f246d-c071-4378-b678-3d34f5e19eb0-21398]
[16:37:40,242][INFO ][main][IpcServerTcpEndpoint] IPC server loopback endpoint started [port=11400]
[16:37:40,242][INFO ][main][HadoopProcessor] HADOOP_HOME is set to /usr/local/TeamCityAgent/temp/buildTmp/__hadoop/hadoop-2.5.2
[16:37:40,263][INFO ][main][TcpDiscoverySpi] Successfully bound to TCP port [port=47500, localHost=/127.0.0.1]
[16:37:40,273][INFO ][main][GridCacheProcessor] Started cache [name=ignite-marshaller-sys-cache, mode=REPLICATED]
[16:37:40,278][INFO ][main][GridCacheProcessor] Started cache [name=meta, mode=REPLICATED]
[16:37:40,284][INFO ][main][GridCacheProcessor] Started cache [name=ignite-hadoop-mr-sys-cache, mode=REPLICATED]
[16:37:40,292][INFO ][main][GridCacheProcessor] Started cache [name=ignite-atomics-sys-cache, mode=PARTITIONED]
[16:37:40,299][INFO ][main][GridCacheProcessor] Started cache [name=data, mode=PARTITIONED]
[16:37:40,304][INFO ][main][GridCacheProcessor] Started cache [name=ignite-sys-cache, mode=REPLICATED]
[16:37:40,425][INFO ][main][GridDhtPreloader] <ignite-marshaller-sys-cache> Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache
[16:37:40,425][INFO ][main][GridDhtPreloader] <ignite-hadoop-mr-sys-cache> Starting rebalancing in SYNC mode: ignite-hadoop-mr-sys-cache
[16:37:40,425][INFO ][main][GridDhtPreloader] <meta> Starting rebalancing in ASYNC mode: meta
[16:37:40,425][INFO ][main][GridDhtPreloader] <ignite-atomics-sys-cache> Starting rebalancing in SYNC mode: ignite-atomics-sys-cache
[16:37:40,426][INFO ][main][GridDhtPreloader] <data> Starting rebalancing in ASYNC mode: data
[16:37:40,426][INFO ][main][GridDhtPreloader] <ignite-sys-cache> Starting rebalancing in SYNC mode: ignite-sys-cache
[16:37:40,465][INFO ][preloader-demand-worker-#19997%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDhtPreloader] <ignite-marshaller-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-marshaller-sys-cache, time=40 ms]
[16:37:40,465][INFO ][preloader-demand-worker-#20001%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDhtPreloader] <ignite-hadoop-mr-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-hadoop-mr-sys-cache, time=40 ms]
[16:37:40,465][INFO ][preloader-demand-worker-#20006%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDhtPreloader] <meta> Completed rebalancing in ASYNC mode [cache=meta, time=30 ms]
[16:37:40,465][INFO ][preloader-demand-worker-#20017%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDhtPreloader] <data> Completed rebalancing in ASYNC mode [cache=data, time=30 ms]
[16:37:40,465][INFO ][preloader-demand-worker-#20011%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDhtPreloader] <ignite-atomics-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-atomics-sys-cache, time=30 ms]
[16:37:40,465][INFO ][preloader-demand-worker-#20022%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDhtPreloader] <ignite-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-sys-cache, time=30 ms]
[16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Performance suggestions for grid 'hadoop.HadoopMapReduceEmbeddedSelfTest0' (fix if possible)
[16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] To disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
[16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] ^-- Disable checkpoints (remove 'checkpointSpi' from configuration)
[16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] ^-- Disable grid events (remove 'includeEventTypes' from configuration)
[16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0]
[16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] To start Console Management & Monitoring run ignitevisorcmd.{sh|bat}
[16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0]
[16:37:40,506][INFO ][main][HadoopMapReduceEmbeddedSelfTest0]
>>> +---------------------------------+
>>> Ignite ver. 1.0.0#19700101-sha1:DEV
>>> +---------------------------------+
>>> OS name: Linux 2.6.32-38-generic amd64
>>> CPU(s): 4
>>> Heap: 2.9GB
>>> VM name: 21398@gg-teamcity-7
>>> Grid name: hadoop.HadoopMapReduceEmbeddedSelfTest0
>>> Local node [ID=954F246D-C071-4378-B678-3D34F5E19EB0, order=1]
>>> Local node addresses: [/127.0.0.1]
>>> Local ports: TCP:10500 TCP:11400 TCP:45190 TCP:47500
>>> Ignite documentation: http://ignite.incubator.apache.org
[16:37:40,506][INFO ][main][GridDiscoveryManager] Topology snapshot [ver=1, nodes=1, CPUs=4, heap=2.9GB]
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1]
>>> __________ ________________
>>> / _/ ___/ |/ / _/_ __/ __/
>>> _/ // (7 7 // / / / / _/
>>> /___/\___/_/|_/___/ /_/ /___/
>>>
>>> ver. 1.0.0#19700101-sha1:DEV
>>> 2015 Copyright(C) Apache Software Foundation
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Config URL: n/a
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Daemon mode: off
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] OS: Linux 2.6.32-38-generic amd64
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] OS user: teamcity
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Language runtime: Java Platform API Specification ver. 1.7
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] VM information: Java(TM) SE Runtime Environment 1.7.0_67-b01 Oracle Corporation Java HotSpot(TM) 64-Bit Server VM 24.65-b04
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] VM total memory: 2.9GB
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Remote Management [restart: off, REST: off, JMX (remote: off)]
[16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] IGNITE_HOME=/usr/local/TeamCityAgent/work/c326f6bf1927b309
[16:37:40,523][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] VM arguments: [-DJAVA_HOME=/usr/lib/jvm/java-7-oracle, -DMCAST_GRP=229.17.1.2, -Dagent.home.dir=/usr/local/TeamCityAgent, -Dagent.name=teamcity-7, -Dagent.ownPort=9090, -Dagent.work.dir=/usr/local/TeamCityAgent/work, -Dbuild.number=1560, -Dbuild.vcs.number=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuild.vcs.number.1=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuild.vcs.number.IgniteApache=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -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, -Dhadoop.version=2.5.2, -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=663, -Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2, -Dteamcity.agent.dotnet.build_id=400410, -Dteamcity.auth.password=nu1IIi3SWEb8NNhLDhghzpZjQSPWkYV3, -Dteamcity.auth.userId=TeamCityBuildId=400410, -Dteamcity.build.changedFiles.file=/usr/local/TeamCityAgent/temp/buildTmp/changedFiles6192942218181221816.txt, -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.build.id=400410, -Dteamcity.build.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.build1936164090676629649.properties, -Dteamcity.build.tempDir=/usr/local/TeamCityAgent/temp/buildTmp, -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.buildConfName=Ignite Hadoop, -Dteamcity.buildType.id=Ignite_Hadoop, -Dteamcity.configuration.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.config1651692759705343482.properties, -Dteamcity.idea.home=/usr/local/TeamCityAgent/plugins/idea, -Dteamcity.maven.watcher.home=/usr/local/TeamCityAgent/plugins/mavenPlugin/maven-watcher, -Dteamcity.projectName=Ignite, -Dteamcity.runner.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.runner4645183226190514392.properties, -Dteamcity.tests.recentlyFailedTests.file=/usr/local/TeamCityAgent/temp/buildTmp/testsToRunFirst6297047454049666673.txt, -Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=2g, -Xms1g, -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, -XX:+AggressiveOpts, -DIGNITE_TEST_HOME=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true, -DIGNITE_QUIET=false, -XX:+PrintGC, -XX:+PrintGCDetails, -XX:+PrintGCTimeStamps]
[16:37:40,523][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Configured caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 'ignite-hadoop-mr-sys-cache', 'ignite-atomics-sys-cache', 'meta', 'data']
[16:37:40,523][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] 3-rd party licenses can be found at: /usr/local/TeamCityAgent/work/c326f6bf1927b309/libs/licenses
[16:37:40,535][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Non-loopback local IPs: 192.168.2.17, fe80:0:0:0:ca60:ff:fe68:5868%2
[16:37:40,535][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Enabled local MACs: C86000685868
[16:37:40,536][INFO ][main][IgnitePluginProcessor] Configured plugins:
[16:37:40,536][INFO ][main][IgnitePluginProcessor] ^-- None
[16:37:40,536][INFO ][main][IgnitePluginProcessor]
[16:37:40,551][INFO ][main][TcpCommunicationSpi] Successfully bound to TCP port [port=45191, locHost=/127.0.0.1]
[16:37:40,582][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Security status [authentication=off]
[16:37:40,602][INFO ][main][HadoopProcessor] HADOOP_HOME is set to /usr/local/TeamCityAgent/temp/buildTmp/__hadoop/hadoop-2.5.2
[16:37:40,624][INFO ][main][TcpDiscoverySpi] Successfully bound to TCP port [port=47501, localHost=/127.0.0.1]
[16:37:40,701][INFO ][disco-event-worker-#19989%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDiscoveryManager] Added new node to topology: TcpDiscoveryNode [id=7a924c9a-3284-476f-ad7c-6ddc7d6b3edd, 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:37:40,702][INFO ][disco-event-worker-#19989%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDiscoveryManager] Topology snapshot [ver=2, nodes=2, CPUs=4, heap=2.9GB]
[16:37:40,715][INFO ][main][GridCacheProcessor] Started cache [name=ignite-marshaller-sys-cache, mode=REPLICATED]
[16:37:40,721][INFO ][main][GridCacheProcessor] Started cache [name=meta, mode=REPLICATED]
[16:37:40,726][INFO ][main][GridCacheProcessor] Started cache [name=ignite-hadoop-mr-sys-cache, mode=REPLICATED]
[16:37:40,735][INFO ][main][GridCacheProcessor] Started cache [name=ignite-atomics-sys-cache, mode=PARTITIONED]
[16:37:40,741][INFO ][main][GridCacheProcessor] Started cache [name=data, mode=PARTITIONED]
[16:37:40,747][INFO ][main][GridCacheProcessor] Started cache [name=ignite-sys-cache, mode=REPLICATED]
[16:37:42,075][INFO ][main][GridDhtPreloader] <ignite-marshaller-sys-cache> Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache
[16:37:42,075][INFO ][main][GridDhtPreloader] <ignite-hadoop-mr-sys-cache> Starting rebalancing in SYNC mode: ignite-hadoop-mr-sys-cache
[16:37:42,076][INFO ][main][GridDhtPreloader] <meta> Starting rebalancing in ASYNC mode: meta
[16:37:42,076][INFO ][main][GridDhtPreloader] <ignite-atomics-sys-cache> Starting rebalancing in SYNC mode: ignite-atomics-sys-cache
[16:37:42,076][INFO ][main][GridDhtPreloader] <data> Starting rebalancing in ASYNC mode: data
[16:37:42,076][INFO ][main][GridDhtPreloader] <ignite-sys-cache> Starting rebalancing in SYNC mode: ignite-sys-cache
[16:37:42,237][INFO ][preloader-demand-worker-#20074%hadoop.HadoopMapReduceEmbeddedSelfTest1%][GridDhtPreloader] <ignite-marshaller-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-marshaller-sys-cache, time=171 ms]
[16:37:42,255][INFO ][preloader-demand-worker-#20102%hadoop.HadoopMapReduceEmbeddedSelfTest1%][GridDhtPreloader] <ignite-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-sys-cache, time=171 ms]
[16:37:42,298][INFO ][preloader-demand-worker-#20090%hadoop.HadoopMapReduceEmbeddedSelfTest1%][GridDhtPreloader] <ignite-atomics-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-atomics-sys-cache, time=231 ms]
[16:37:42,302][INFO ][preloader-demand-worker-#20087%hadoop.HadoopMapReduceEmbeddedSelfTest1%][GridDhtPreloader] <meta> Completed rebalancing in ASYNC mode [cache=meta, time=231 ms]
[16:37:42,305][INFO ][preloader-demand-worker-#20080%hadoop.HadoopMapReduceEmbeddedSelfTest1%][GridDhtPreloader] <ignite-hadoop-mr-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-hadoop-mr-sys-cache, time=231 ms]
[16:37:42,307][INFO ][preloader-demand-worker-#20097%hadoop.HadoopMapReduceEmbeddedSelfTest1%][GridDhtPreloader] <data> Completed rebalancing in ASYNC mode [cache=data, time=231 ms]
[16:37:42,331][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Performance suggestions for grid 'hadoop.HadoopMapReduceEmbeddedSelfTest1' (fix if possible)
[16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] To disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
[16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] ^-- Disable checkpoints (remove 'checkpointSpi' from configuration)
[16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] ^-- Disable grid events (remove 'includeEventTypes' from configuration)
[16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1]
[16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] To start Console Management & Monitoring run ignitevisorcmd.{sh|bat}
[16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1]
[16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1]
>>> +---------------------------------+
>>> Ignite ver. 1.0.0#19700101-sha1:DEV
>>> +---------------------------------+
>>> OS name: Linux 2.6.32-38-generic amd64
>>> CPU(s): 4
>>> Heap: 2.8GB
>>> VM name: 21398@gg-teamcity-7
>>> Grid name: hadoop.HadoopMapReduceEmbeddedSelfTest1
>>> Local node [ID=7A924C9A-3284-476F-AD7C-6DDC7D6B3EDD, order=2]
>>> Local node addresses: [/127.0.0.1]
>>> Local ports: TCP:45191 TCP:47501
>>> Ignite documentation: http://ignite.incubator.apache.org
[16:37:42,333][INFO ][main][GridDiscoveryManager] Topology snapshot [ver=2, nodes=2, CPUs=4, heap=2.8GB]
[16:37:42,348][INFO ][main][HadoopMapReduceEmbeddedSelfTest2]
>>> __________ ________________
>>> / _/ ___/ |/ / _/_ __/ __/
>>> _/ // (7 7 // / / / / _/
>>> /___/\___/_/|_/___/ /_/ /___/
>>>
>>> ver. 1.0.0#19700101-sha1:DEV
>>> 2015 Copyright(C) Apache Software Foundation
[16:37:42,348][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Config URL: n/a
[16:37:42,348][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Daemon mode: off
[16:37:42,349][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] OS: Linux 2.6.32-38-generic amd64
[16:37:42,349][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] OS user: teamcity
[16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Language runtime: Java Platform API Specification ver. 1.7
[16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] VM information: Java(TM) SE Runtime Environment 1.7.0_67-b01 Oracle Corporation Java HotSpot(TM) 64-Bit Server VM 24.65-b04
[16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] VM total memory: 2.8GB
[16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Remote Management [restart: off, REST: off, JMX (remote: off)]
[16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] IGNITE_HOME=/usr/local/TeamCityAgent/work/c326f6bf1927b309
[16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] VM arguments: [-DJAVA_HOME=/usr/lib/jvm/java-7-oracle, -DMCAST_GRP=229.17.1.2, -Dagent.home.dir=/usr/local/TeamCityAgent, -Dagent.name=teamcity-7, -Dagent.ownPort=9090, -Dagent.work.dir=/usr/local/TeamCityAgent/work, -Dbuild.number=1560, -Dbuild.vcs.number=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuild.vcs.number.1=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuild.vcs.number.IgniteApache=cb074fe98614907b0dd20fca71a44beb2dc5d8f4, -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, -Dhadoop.version=2.5.2, -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=663, -Dteamcity.agent.dotnet.agent_url=http://localhost:9090/RPC2, -Dteamcity.agent.dotnet.build_id=400410, -Dteamcity.auth.password=nu1IIi3SWEb8NNhLDhghzpZjQSPWkYV3, -Dteamcity.auth.userId=TeamCityBuildId=400410, -Dteamcity.build.changedFiles.file=/usr/local/TeamCityAgent/temp/buildTmp/changedFiles6192942218181221816.txt, -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.build.id=400410, -Dteamcity.build.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.build1936164090676629649.properties, -Dteamcity.build.tempDir=/usr/local/TeamCityAgent/temp/buildTmp, -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.buildConfName=Ignite Hadoop, -Dteamcity.buildType.id=Ignite_Hadoop, -Dteamcity.configuration.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.config1651692759705343482.properties, -Dteamcity.idea.home=/usr/local/TeamCityAgent/plugins/idea, -Dteamcity.maven.watcher.home=/usr/local/TeamCityAgent/plugins/mavenPlugin/maven-watcher, -Dteamcity.projectName=Ignite, -Dteamcity.runner.properties.file=/usr/local/TeamCityAgent/temp/buildTmp/teamcity.runner4645183226190514392.properties, -Dteamcity.tests.recentlyFailedTests.file=/usr/local/TeamCityAgent/temp/buildTmp/testsToRunFirst6297047454049666673.txt, -Dteamcity.version=8.1.4 (build 30168), -ea, -XX:MaxPermSize=2g, -Xms1g, -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, -XX:+AggressiveOpts, -DIGNITE_TEST_HOME=/usr/local/TeamCityAgent/work/c326f6bf1927b309, -DIGNITE_UPDATE_NOTIFIER=false, -DIGNITE_NO_DISCO_ORDER=true, -DIGNITE_QUIET=false, -XX:+PrintGC, -XX:+PrintGCDetails, -XX:+PrintGCTimeStamps]
[16:37:42,351][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Configured caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 'ignite-hadoop-mr-sys-cache', 'ignite-atomics-sys-cache', 'meta', 'data']
[16:37:42,351][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] 3-rd party licenses can be found at: /usr/local/TeamCityAgent/work/c326f6bf1927b309/libs/licenses
[16:37:42,363][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Non-loopback local IPs: 192.168.2.17, fe80:0:0:0:ca60:ff:fe68:5868%2
[16:37:42,363][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Enabled local MACs: C86000685868
[16:37:42,364][INFO ][main][IgnitePluginProcessor] Configured plugins:
[16:37:42,364][INFO ][main][IgnitePluginProcessor] ^-- None
[16:37:42,364][INFO ][main][IgnitePluginProcessor]
[16:37:42,379][INFO ][main][TcpCommunicationSpi] Successfully bound to TCP port [port=45192, locHost=/127.0.0.1]
[16:37:42,411][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Security status [authentication=off]
[16:37:42,432][INFO ][main][HadoopProcessor] HADOOP_HOME is set to /usr/local/TeamCityAgent/temp/buildTmp/__hadoop/hadoop-2.5.2
[16:37:42,453][INFO ][main][TcpDiscoverySpi] Successfully bound to TCP port [port=47502, localHost=/127.0.0.1]
[16:37:42,598][INFO ][disco-event-worker-#19989%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDiscoveryManager] Added new node to topology: TcpDiscoveryNode [id=d313c493-0cbc-4ada-a03e-e48802166818, addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, loc=false, ver=1.0.0#19700101-sha1:00000000, isClient=false]
[16:37:42,599][INFO ][disco-event-worker-#19989%hadoop.HadoopMapReduceEmbeddedSelfTest0%][GridDiscoveryManager] Topology snapshot [ver=3, nodes=3, CPUs=4, heap=2.8GB]
[16:37:42,600][INFO ][disco-event-worker-#20066%hadoop.HadoopMapReduceEmbeddedSelfTest1%][GridDiscoveryManager] Added new node to topology: TcpDiscoveryNode [id=d313c493-0cbc-4ada-a03e-e48802166818, addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, loc=false, ver=1.0.0#19700101-sha1:00000000, isClient=false]
[16:37:42,600][INFO ][disco-event-worker-#20066%hadoop.HadoopMapReduceEmbeddedSelfTest1%][GridDiscoveryManager] Topology snapshot [ver=3, nodes=3, CPUs=4, heap=2.8GB]
[16:37:42,612][INFO ][main][GridCacheProcessor] Started cache [name=ignite-marshaller-sys-cache, mode=REPLICATED]
[16:37:42,617][INFO ][main][GridCacheProcessor] Started cache [name=meta, mode=REPLICATED]
[16:37:42,623][INFO ][main][GridCacheProcessor] Started cache [name=ignite-hadoop-mr-sys-cache, mode=REPLICATED]
[16:37:42,632][INFO ][main][GridCacheProcessor] Started cache [name=ignite-atomics-sys-cache, mode=PARTITIONED]
[16:37:42,639][INFO ][main][GridCacheProcessor] Started cache [name=data, mode=PARTITIONED]
[16:37:42,644][INFO ][main][GridCacheProcessor] Started cache [name=ignite-sys-cache, mode=REPLICATED]
[16:37:43,306][INFO ][main][GridDhtPreloader] <ignite-marshaller-sys-cache> Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache
[16:37:43,306][INFO ][main][GridDhtPreloader] <ignite-hadoop-mr-sys-cache> Starting rebalancing in SYNC mode: ignite-hadoop-mr-sys-cache
[16:37:43,306][INFO ][main][GridDhtPreloader] <meta> Starting rebalancing in ASYNC mode: meta
[16:37:43,307][INFO ][main][GridDhtPreloader] <ignite-atomics-sys-cache> Starting rebalancing in SYNC mode: ignite-atomics-sys-cache
[16:37:43,308][INFO ][main][GridDhtPreloader] <data> Starting rebalancing in ASYNC mode: data
[16:37:43,308][INFO ][main][GridDhtPreloader] <ignite-sys-cache> Starting rebalancing in SYNC mode: ignite-sys-cache
[16:37:43,476][INFO ][preloader-demand-worker-#20167%hadoop.HadoopMapReduceEmbeddedSelfTest2%][GridDhtPreloader] <ignite-marshaller-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-marshaller-sys-cache, time=171 ms]
[16:37:43,496][INFO ][preloader-demand-worker-#20181%hadoop.HadoopMapReduceEmbeddedSelfTest2%][GridDhtPreloader] <ignite-atomics-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-atomics-sys-cache, time=193 ms]
[16:37:43,500][INFO ][preloader-demand-worker-#20193%hadoop.HadoopMapReduceEmbeddedSelfTest2%][GridDhtPreloader] <ignite-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-sys-cache, time=193 ms]
[16:37:43,505][INFO ][preloader-demand-worker-#20188%hadoop.HadoopMapReduceEmbeddedSelfTest2%][GridDhtPreloader] <data> Completed rebalancing in ASYNC mode [cache=data, time=193 ms]
[16:37:43,520][INFO ][preloader-demand-worker-#20173%hadoop.HadoopMapReduceEmbeddedSelfTest2%][GridDhtPreloader] <ignite-hadoop-mr-sys-cache> Completed rebalancing in SYNC mode [cache=ignite-hadoop-mr-sys-cache, time=213 ms]
[16:37:43,525][INFO ][preloader-demand-worker-#20178%hadoop.HadoopMapReduceEmbeddedSelfTest2%][GridDhtPreloader] <meta> Completed rebalancing in ASYNC mode [cache=meta, time=213 ms]
[16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Performance suggestions for grid 'hadoop.HadoopMapReduceEmbeddedSelfTest2' (fix if possible)
[16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] To disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
[16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] ^-- Disable checkpoints (remove 'checkpointSpi' from configuration)
[16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] ^-- Disable grid events (remove 'includeEventTypes' from configuration)
[16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2]
[16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] To start Console Management & Monitoring run ignitevisorcmd.{sh|bat}
[16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2]
[16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2]
>>> +---------------------------------+
>>> Ignite ver. 1.0.0#19700101-sha1:DEV
>>> +---------------------------------+
>>> OS name: Linux 2.6.32-38-generic amd64
>>> CPU(s): 4
>>> Heap: 2.8GB
>>> VM name: 21398@gg-teamcity-7
>>> Grid name: hadoop.HadoopMapReduceEmbeddedSelfTest2
>>> Local node [ID=D313C493-0CBC-4ADA-A03E-E48802166818, order=3]
>>> Local node addresses: [/127.0.0.1]
>>> Local ports: TCP:45192 TCP:47502
>>> Ignite documentation: http://ignite.incubator.apache.org
[16:37:43,549][INFO ][main][GridDiscoveryManager] Topology snapshot [ver=3, nodes=3, CPUs=4, heap=2.8GB]
[16:37:44,371][INFO ][test-runner][FileInputFormat] Total input paths to process : 1
[16:38:34,058][INFO ][Hadoop-task-3642bd08-a856-457f-b7de-1eaabc4de4da_1-REDUCE-0-0-#20618%hadoop.HadoopMapReduceEmbeddedSelfTest0%][FileOutputCommitter] Saved output of task 'attempt_3642bd08-a856-457f-b7de-1eaabc4de4da_0001_r_000000_0' to igfs://:hadoop.HadoopMapReduceEmbeddedSelfTest0@/output/_temporary/0/task_3642bd08-a856-457f-b7de-1eaabc4de4da_0001_r_000000
[16:38:35,397][INFO ][test-runner][FileInputFormat] Total input paths to process : 1
[16:39:25,057][INFO ][Hadoop-task-afecac89-ef45-4a3d-988c-c5c16f231d52_1-REDUCE-0-0-#20969%hadoop.HadoopMapReduceEmbeddedSelfTest0%][FileOutputCommitter] Saved output of task 'attempt_afecac89-ef45-4a3d-988c-c5c16f231d52_0001_r_000000_0' to igfs://:hadoop.HadoopMapReduceEmbeddedSelfTest0@/output/_temporary/0/task_afecac89-ef45-4a3d-988c-c5c16f231d52_0001_r_000000
[16:39:26,206][INFO ][test-runner][FileInputFormat] Total input paths to process : 1
[16:40:16,204][INFO ][Hadoop-task-5a132c34-b235-4468-8c4c-70e4bc047897_1-REDUCE-0-0-#21316%hadoop.HadoopMapReduceEmbeddedSelfTest0%][FileOutputCommitter] Saved output of task 'attempt_5a132c34-b235-4468-8c4c-70e4bc047897_0001_r_000000_0' to igfs://:hadoop.HadoopMapReduceEmbeddedSelfTest0@/output/_temporary/0/task_5a132c34-b235-4468-8c4c-70e4bc047897_0001_r_000000
[16:40:17,783][INFO ][test-runner][FileInputFormat] Total input paths to process : 1
[16:41:07,878][INFO ][Hadoop-task-37d89f9d-7bf4-4bfc-acfe-8bdf2dfec0c1_1-REDUCE-0-0-#21663%hadoop.HadoopMapReduceEmbeddedSelfTest0%][FileOutputCommitter] Saved output of task 'attempt_37d89f9d-7bf4-4bfc-acfe-8bdf2dfec0c1_0001_r_000000_0' to igfs://:hadoop.HadoopMapReduceEmbeddedSelfTest0@/output/_temporary/0/task_37d89f9d-7bf4-4bfc-acfe-8bdf2dfec0c1_0001_r_000000
[16:41:09,319][INFO ][test-runner][FileInputFormat] Total input paths to process : 1
[16:41:59,352][INFO ][Hadoop-task-e9089c34-7864-412e-9507-2038b6fb0d6e_1-REDUCE-0-0-#22010%hadoop.HadoopMapReduceEmbeddedSelfTest0%][FileOutputCommitter] Saved output of task 'attempt_e9089c34-7864-412e-9507-2038b6fb0d6e_0001_r_000000_0' to igfs://:hadoop.HadoopMapReduceEmbeddedSelfTest0@/output/_temporary/0/task_e9089c34-7864-412e-9507-2038b6fb0d6e_0001_r_000000
[16:42:01,014][INFO ][test-runner][FileInputFormat] Total input paths to process : 1
[16:42:39,194][INFO ][Hadoop-task-b42447f3-7f75-4639-864f-72854bb81982_1-REDUCE-0-0-#22357%hadoop.HadoopMapReduceEmbeddedSelfTest0%][FileOutputCommitter] Saved output of task 'attempt_b42447f3-7f75-4639-864f-72854bb81982_0001_r_000000_0' to igfs://:hadoop.HadoopMapReduceEmbeddedSelfTest0@/output/_temporary/0/task_b42447f3-7f75-4639-864f-72854bb81982_0001_r_000000
[16:42:40,250][INFO ][test-runner][FileInputFormat] Total input paths to process : 1
[16:42:43] (wrn) Thread dump at 2015/03/27 16:42:43 MSK
Thread [name="Hadoop-task-ef8347bb-a9de-454a-8823-60e3b3c513b7_1-MAP-232-0-#22374%hadoop.HadoopMapReduceEmbeddedSelfTest2%", id=30879, state=RUNNABLE, blockCnt=0, waitCnt=4]
at java.util.StringTokenizer.skipDelimiters(StringTokenizer.java:245)
at java.util.StringTokenizer.hasMoreTokens(StringTokenizer.java:323)
at o.a.i.i.processors.hadoop.examples.HadoopWordCount2Mapper.map(HadoopWordCount2Mapper.java:50)
at o.a.i.i.processors.hadoop.examples.HadoopWordCount2Mapper.map(HadoopWordCount2Mapper.java:30)
at org.apache.hadoop.mapreduce.Mapper.run(Mapper.java:145)
at o.a.i.i.processors.hadoop.v2.HadoopV2MapTask.run0(HadoopV2MapTask.java:84)
at o.a.i.i.processors.hadoop.v2.HadoopV2Task.run(HadoopV2Task.java:50)
at o.a.i.i.processors.hadoop.v2.HadoopV2TaskContext.run(HadoopV2TaskContext.java:193)
at o.a.i.i.processors.hadoop.taskexecutor.HadoopRunnableTask.runTask(HadoopRunnableTask.java:176)
at o.a.i.i.processors.hadoop.taskexecutor.HadoopRunnableTask.call(HadoopRunnableTask.java:120)
at o.a.i.i.processors.hadoop.taskexecutor.HadoopRunnableTask.call(HadoopRunnableTask.java:36)
at o.a.i.i.processors.hadoop.taskexecutor.HadoopExecutorService$2.body(HadoopExecutorService.java:183)
at o.a.i.i.util.worker.GridWorker.run(GridWorker.java:107)
at java.lang.Thread.run(Thread.java:745)
Thread [name="hadoop-shuffle-ef8347bb-a9de-454a-8823-60e3b3c513b7_1-#22373%hadoop.HadoopMapReduceEmbeddedSelfTest2%", id=30878, state=TIMED_WAITING, blockCnt=0, waitCnt=28]
at java.lang.Thread.sleep(Native Method)
at o.a.i.i.processors.hadoop.shuffle.HadoopShuffleJob$1.body(HadoopShuffleJob.java:159)
at o.a.i.i.util.worker.GridWorker.run(GridWorker.java:107)
at java.lang.Thread.run(Thread.java:745)
Thread [name="Hadoop-task-ef8347bb-a9de-454a-8823-60e3b3c513b7_1-MAP-5-0-#22372%hadoop.HadoopMapReduceEmbeddedSelfTest0%", id=30877, state=RUNNABLE, blockCnt=0, waitCnt=6]
at org.apache.hadoop.io.Text.readFields(Text.java:291)
at o.a.i.i.processors.hadoop.v2.HadoopWritableSerialization.read(HadoopWritableSerialization.java:61)
at o.a.i.i.processors.hadoop.shuffle.collections.HadoopMultimapBase$ReaderBase.read(HadoopMultimapBase.java:159)
at o.a.i.i.processors.hadoop.shuffle.collections.HadoopSkipList$Reader.readKey(HadoopSkipList.java:260)
at o.a.i.i.processors.hadoop.shuffle.collections.HadoopSkipList$AdderImpl.cmp(HadoopSkipList.java:471)
at o.a.i.i.processors.hadoop.shuffle.collections.HadoopSkipList$AdderImpl.add(HadoopSkipList.java:417)
at o.a.i.i.processors.hadoop.shuffle.collections.HadoopSkipList$AdderImpl.write(HadoopSkipList.java:300)
at o.a.i.i.processors.hadoop.v2.HadoopV2Context.write(HadoopV2Context.java:134)
at org.apache.hadoop.mapreduce.lib.map.WrappedMapper$Context.write(WrappedMapper.java:112)
at o.a.i.i.processors.hadoop.examples.HadoopWordCount2Mapper.map(HadoopWordCount2Mapper.java:53)
at o.a.i.i.processors.hadoop.examples.HadoopWordCount2Mapper.map(HadoopWordCount2Mapper.java:30)
at org.apache.hadoop.mapreduce.Mapper.run(Mapper.java:145)
at o.a.i.i.processors.hadoop.v2.HadoopV2MapTask.run0(HadoopV2MapTask.java:84)
at o.a.i.i.processors.hadoop.v2.HadoopV2Task.run(HadoopV2Task.java:50)
at o.a.i.i.processors.hadoop.v2.HadoopV2TaskContext.run(HadoopV2TaskContext.java:193)
at o.a.i.i.processors.hadoop.taskexecutor.HadoopRunnableTask.runTask(HadoopRunnableTask.java:176)
at o.a.i.i.processors.hadoop.taskexecutor.HadoopRunnableTask.call(HadoopRunnableTask.java:120)
at o.a.i.i.processors.hadoop.taskexecutor.HadoopRunnableTask.call(HadoopRunnableTask.java:36)
at o.a.i.i.processors.hadoop.taskexecutor.HadoopExecutorService$2.body(HadoopExecutorService.java:183)
at o.a.i.i.util.worker.GridWorker.run(GridWorker.java:107)
at java.lang.Thread.run(Thread.java:745)
......
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)