ignite-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Ivan Veselovsky (JIRA)" <j...@apache.org>
Subject [jira] [Closed] (IGNITE-633) Test HadoopMapReduceEmbeddedSelfTest.testWholeMapReduceExecution sometimes hangs
Date Wed, 10 Jun 2015 12:42:00 GMT

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

Ivan Veselovsky closed IGNITE-633.
----------------------------------

Patch "a" applied to ignite-sprint-6.

> Test HadoopMapReduceEmbeddedSelfTest.testWholeMapReduceExecution sometimes 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-6
>
>         Attachments: IGNITE-633--a.patch
>
>
> 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)

Mime
View raw message