Return-Path: X-Original-To: apmail-ignite-issues-archive@minotaur.apache.org Delivered-To: apmail-ignite-issues-archive@minotaur.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id 3573D173EC for ; Wed, 10 Jun 2015 12:42:31 +0000 (UTC) Received: (qmail 94948 invoked by uid 500); 10 Jun 2015 12:42:30 -0000 Delivered-To: apmail-ignite-issues-archive@ignite.apache.org Received: (qmail 94922 invoked by uid 500); 10 Jun 2015 12:42:30 -0000 Mailing-List: contact issues-help@ignite.incubator.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@ignite.incubator.apache.org Delivered-To: mailing list issues@ignite.incubator.apache.org Received: (qmail 94913 invoked by uid 99); 10 Jun 2015 12:42:30 -0000 Received: from nike.apache.org (HELO nike.apache.org) (192.87.106.230) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 10 Jun 2015 12:42:30 +0000 X-ASF-Spam-Status: No, hits=-2000.0 required=5.0 tests=ALL_TRUSTED,T_RP_MATCHES_RCVD X-Spam-Check-By: apache.org Received: from [140.211.11.3] (HELO mail.apache.org) (140.211.11.3) by apache.org (qpsmtpd/0.29) with SMTP; Wed, 10 Jun 2015 12:40:15 +0000 Received: (qmail 94518 invoked by uid 99); 10 Jun 2015 12:42:01 -0000 Received: from arcas.apache.org (HELO arcas.apache.org) (140.211.11.28) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 10 Jun 2015 12:42:01 +0000 Date: Wed, 10 Jun 2015 12:42:00 +0000 (UTC) From: "Ivan Veselovsky (JIRA)" To: issues@ignite.incubator.apache.org Message-ID: In-Reply-To: References: Subject: [jira] [Closed] (IGNITE-633) Test HadoopMapReduceEmbeddedSelfTest.testWholeMapReduceExecution sometimes hangs MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: quoted-printable X-JIRA-FingerPrint: 30527f35849b9dde25b450d4833f0394 X-Virus-Checked: Checked by ClamAV on apache.org [ https://issues.apache.org/jira/browse/IGNITE-633?page=3Dcom.atlassia= n.jira.plugin.system.issuetabpanels:all-tabpanel ] Ivan Veselovsky closed IGNITE-633. ---------------------------------- Patch "a" applied to ignite-sprint-6. > Test HadoopMapReduceEmbeddedSelfTest.testWholeMapReduceExecution sometime= s 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 =09 > java.util.concurrent.TimeoutException: Test has been timed out [test=3Dte= stWholeMapReduceExecution, timeout=3D300000] > at org.apache.ignite.testframework.junits.GridAbstractTest.runTest(Gr= idAbstractTest.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(JUnit38ClassRunn= er.java:84) > at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Prov= ider.java:264) > at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUn= it4Provider.java:153) > at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provi= der.java:124) > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) > at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorIm= pl.java:57) > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAc= cessorImpl.java:43) > at java.lang.reflect.Method.invoke(Method.java:606) > at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArr= ay2(ReflectionUtils.java:208) > at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.inv= oke(ProviderFactory.java:156) > at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(Pr= oviderFactory.java:82) > at org.apache.maven.plugin.surefire.InPluginVMSurefireStarter.runSuit= esInProcess(InPluginVMSurefireStarter.java:82) > at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeProvi= der(AbstractSurefireMojo.java:951) > at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeAfter= PreconditionsChecked(AbstractSurefireMojo.java:831) > at org.apache.maven.plugin.surefire.AbstractSurefireMojo.execute(Abst= ractSurefireMojo.java:729) > at org.apache.maven.plugin.DefaultBuildPluginManager.executeMojo(Defa= ultBuildPluginManager.java:101) > at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecu= tor.java:209) > at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecu= tor.java:153) > at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecu= tor.java:145) > at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildPr= oject(LifecycleModuleBuilder.java:84) > at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildPr= oject(LifecycleModuleBuilder.java:59) > at org.apache.maven.lifecycle.internal.LifecycleStarter.singleThreade= dBuild(LifecycleStarter.java:183) > at org.apache.maven.lifecycle.internal.LifecycleStarter.execute(Lifec= ycleStarter.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(NativeMethodAccessorIm= pl.java:57) > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAc= cessorImpl.java:43) > at java.lang.reflect.Method.invoke(Method.java:606) > at org.codehaus.plexus.classworlds.launcher.Launcher.launchEnhanced(L= auncher.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.ja= va:352) > ------- Stdout: ------- > [16:37:40,133][INFO ][main][root] >>> Starting test: testWholeMapReduceEx= ecution <<< > [16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0]=20 > >>> __________ ________________ =20 > >>> / _/ ___/ |/ / _/_ __/ __/ =20 > >>> _/ // (7 7 // / / / / _/ =20 > >>> /___/\___/_/|_/___/ /_/ /___/ =20 > >>>=20 > >>> 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: te= amcity > [16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Language ru= ntime: Java Platform API Specification ver. 1.7 > [16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] VM informat= ion: Java(TM) SE Runtime Environment 1.7.0_67-b01 Oracle Corporation Java H= otSpot(TM) 64-Bit Server VM 24.65-b04 > [16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] VM total me= mory: 2.9GB > [16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Remote Mana= gement [restart: off, REST: off, JMX (remote: off)] > [16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] IGNITE_HOME= =3D/usr/local/TeamCityAgent/work/c326f6bf1927b309 > [16:37:40,161][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] VM argument= s: [-DJAVA_HOME=3D/usr/lib/jvm/java-7-oracle, -DMCAST_GRP=3D229.17.1.2, -Da= gent.home.dir=3D/usr/local/TeamCityAgent, -Dagent.name=3Dteamcity-7, -Dagen= t.ownPort=3D9090, -Dagent.work.dir=3D/usr/local/TeamCityAgent/work, -Dbuild= .number=3D1560, -Dbuild.vcs.number=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8= f4, -Dbuild.vcs.number.1=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuil= d.vcs.number.IgniteApache=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dcla= ssworlds.conf=3D/usr/local/TeamCityAgent/temp/buildTmp/teamcity.m2.conf, -D= com.jetbrains.maven.watcher.report.file=3D/usr/local/TeamCityAgent/temp/bui= ldTmp/maven-build-info.xml, -Dhadoop.version=3D2.5.2, -Djava.io.tmpdir=3D/u= sr/local/TeamCityAgent/temp/buildTmp, -Dmaven.home=3D/usr/local/TeamCityAge= nt/tools/maven3, -Dmaven.repo.local=3D/home/teamcity/.m2/repository, -Dteam= city.agent.cpuBenchmark=3D663, -Dteamcity.agent.dotnet.agent_url=3Dhttp://l= ocalhost:9090/RPC2, -Dteamcity.agent.dotnet.build_id=3D400410, -Dteamcity.a= uth.password=3Dnu1IIi3SWEb8NNhLDhghzpZjQSPWkYV3, -Dteamcity.auth.userId=3DT= eamCityBuildId=3D400410, -Dteamcity.build.changedFiles.file=3D/usr/local/Te= amCityAgent/temp/buildTmp/changedFiles6192942218181221816.txt, -Dteamcity.b= uild.checkoutDir=3D/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamci= ty.build.id=3D400410, -Dteamcity.build.properties.file=3D/usr/local/TeamCit= yAgent/temp/buildTmp/teamcity.build1936164090676629649.properties, -Dteamci= ty.build.tempDir=3D/usr/local/TeamCityAgent/temp/buildTmp, -Dteamcity.build= .workingDir=3D/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.bu= ildConfName=3DIgnite Hadoop, -Dteamcity.buildType.id=3DIgnite_Hadoop, -Dtea= mcity.configuration.properties.file=3D/usr/local/TeamCityAgent/temp/buildTm= p/teamcity.config1651692759705343482.properties, -Dteamcity.idea.home=3D/us= r/local/TeamCityAgent/plugins/idea, -Dteamcity.maven.watcher.home=3D/usr/lo= cal/TeamCityAgent/plugins/mavenPlugin/maven-watcher, -Dteamcity.projectName= =3DIgnite, -Dteamcity.runner.properties.file=3D/usr/local/TeamCityAgent/tem= p/buildTmp/teamcity.runner4645183226190514392.properties, -Dteamcity.tests.= recentlyFailedTests.file=3D/usr/local/TeamCityAgent/temp/buildTmp/testsToRu= nFirst6297047454049666673.txt, -Dteamcity.version=3D8.1.4 (build 30168), -e= a, -XX:MaxPermSize=3D2g, -Xms1g, -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, -= XX:+AggressiveOpts, -DIGNITE_TEST_HOME=3D/usr/local/TeamCityAgent/work/c326= f6bf1927b309, -DIGNITE_UPDATE_NOTIFIER=3Dfalse, -DIGNITE_NO_DISCO_ORDER=3Dt= rue, -DIGNITE_QUIET=3Dfalse, -XX:+PrintGC, -XX:+PrintGCDetails, -XX:+PrintG= CTimeStamps] > [16:37:40,162][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Configured = caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 'ignite-hadoop-m= r-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/li= bs/licenses > [16:37:40,174][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Non-loopbac= k local IPs: 192.168.2.17, fe80:0:0:0:ca60:ff:fe68:5868%2 > [16:37:40,174][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Enabled loc= al 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]=20 > [16:37:40,189][INFO ][main][TcpCommunicationSpi] Successfully bound to TC= P port [port=3D45190, locHost=3D/127.0.0.1] > [16:37:40,221][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Security st= atus [authentication=3Doff] > [16:37:40,241][INFO ][main][IpcSharedMemoryServerEndpoint] IPC shared mem= ory server endpoint started [port=3D10500, tokDir=3D/usr/local/TeamCityAgen= t/work/c326f6bf1927b309/work/ipc/shmem/954f246d-c071-4378-b678-3d34f5e19eb0= -21398] > [16:37:40,242][INFO ][main][IpcServerTcpEndpoint] IPC server loopback end= point started [port=3D11400] > [16:37:40,242][INFO ][main][HadoopProcessor] HADOOP_HOME is set to /usr/l= ocal/TeamCityAgent/temp/buildTmp/__hadoop/hadoop-2.5.2 > [16:37:40,263][INFO ][main][TcpDiscoverySpi] Successfully bound to TCP po= rt [port=3D47500, localHost=3D/127.0.0.1] > [16:37:40,273][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-marshaller-sys-cache, mode=3DREPLICATED] > [16:37:40,278][INFO ][main][GridCacheProcessor] Started cache [name=3Dmet= a, mode=3DREPLICATED] > [16:37:40,284][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-hadoop-mr-sys-cache, mode=3DREPLICATED] > [16:37:40,292][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-atomics-sys-cache, mode=3DPARTITIONED] > [16:37:40,299][INFO ][main][GridCacheProcessor] Started cache [name=3Ddat= a, mode=3DPARTITIONED] > [16:37:40,304][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-sys-cache, mode=3DREPLICATED] > [16:37:40,425][INFO ][main][GridDhtPreloader] Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache > [16:37:40,425][INFO ][main][GridDhtPreloader] Starting rebalancing in SYNC mode: ignite-hadoop-mr-sys-cache > [16:37:40,425][INFO ][main][GridDhtPreloader] Starting rebalancing= in ASYNC mode: meta > [16:37:40,425][INFO ][main][GridDhtPreloader] = Starting rebalancing in SYNC mode: ignite-atomics-sys-cache > [16:37:40,426][INFO ][main][GridDhtPreloader] Starting rebalancing= in ASYNC mode: data > [16:37:40,426][INFO ][main][GridDhtPreloader] Starting= rebalancing in SYNC mode: ignite-sys-cache > [16:37:40,465][INFO ][preloader-demand-worker-#19997%hadoop.HadoopMapRedu= ceEmbeddedSelfTest0%][GridDhtPreloader] Compl= eted rebalancing in SYNC mode [cache=3Dignite-marshaller-sys-cache, time=3D= 40 ms] > [16:37:40,465][INFO ][preloader-demand-worker-#20001%hadoop.HadoopMapRedu= ceEmbeddedSelfTest0%][GridDhtPreloader] Comple= ted rebalancing in SYNC mode [cache=3Dignite-hadoop-mr-sys-cache, time=3D40= ms] > [16:37:40,465][INFO ][preloader-demand-worker-#20006%hadoop.HadoopMapRedu= ceEmbeddedSelfTest0%][GridDhtPreloader] Completed rebalancing in ASY= NC mode [cache=3Dmeta, time=3D30 ms] > [16:37:40,465][INFO ][preloader-demand-worker-#20017%hadoop.HadoopMapRedu= ceEmbeddedSelfTest0%][GridDhtPreloader] Completed rebalancing in ASY= NC mode [cache=3Ddata, time=3D30 ms] > [16:37:40,465][INFO ][preloader-demand-worker-#20011%hadoop.HadoopMapRedu= ceEmbeddedSelfTest0%][GridDhtPreloader] Complete= d rebalancing in SYNC mode [cache=3Dignite-atomics-sys-cache, time=3D30 ms] > [16:37:40,465][INFO ][preloader-demand-worker-#20022%hadoop.HadoopMapRedu= ceEmbeddedSelfTest0%][GridDhtPreloader] Completed rebala= ncing in SYNC mode [cache=3Dignite-sys-cache, time=3D30 ms] > [16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] Performance= suggestions for grid 'hadoop.HadoopMapReduceEmbeddedSelfTest0' (fix if pos= sible) > [16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] To disable,= set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=3Dtrue > [16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] ^-- Disab= le checkpoints (remove 'checkpointSpi' from configuration) > [16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] ^-- Disab= le grid events (remove 'includeEventTypes' from configuration) > [16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0]=20 > [16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0] To start Co= nsole Management & Monitoring run ignitevisorcmd.{sh|bat} > [16:37:40,505][INFO ][main][HadoopMapReduceEmbeddedSelfTest0]=20 > [16:37:40,506][INFO ][main][HadoopMapReduceEmbeddedSelfTest0]=20 > >>> +---------------------------------+ > >>> 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=3D954F246D-C071-4378-B678-3D34F5E19EB0, order=3D1] > >>> Local node addresses: [/127.0.0.1] > >>> Local ports: TCP:10500 TCP:11400 TCP:45190 TCP:47500=20 > >>> Ignite documentation: http://ignite.incubator.apache.org > [16:37:40,506][INFO ][main][GridDiscoveryManager] Topology snapshot [ver= =3D1, nodes=3D1, CPUs=3D4, heap=3D2.9GB] > [16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1]=20 > >>> __________ ________________ =20 > >>> / _/ ___/ |/ / _/_ __/ __/ =20 > >>> _/ // (7 7 // / / / / _/ =20 > >>> /___/\___/_/|_/___/ /_/ /___/ =20 > >>>=20 > >>> 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: te= amcity > [16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Language ru= ntime: Java Platform API Specification ver. 1.7 > [16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] VM informat= ion: Java(TM) SE Runtime Environment 1.7.0_67-b01 Oracle Corporation Java H= otSpot(TM) 64-Bit Server VM 24.65-b04 > [16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] VM total me= mory: 2.9GB > [16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Remote Mana= gement [restart: off, REST: off, JMX (remote: off)] > [16:37:40,522][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] IGNITE_HOME= =3D/usr/local/TeamCityAgent/work/c326f6bf1927b309 > [16:37:40,523][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] VM argument= s: [-DJAVA_HOME=3D/usr/lib/jvm/java-7-oracle, -DMCAST_GRP=3D229.17.1.2, -Da= gent.home.dir=3D/usr/local/TeamCityAgent, -Dagent.name=3Dteamcity-7, -Dagen= t.ownPort=3D9090, -Dagent.work.dir=3D/usr/local/TeamCityAgent/work, -Dbuild= .number=3D1560, -Dbuild.vcs.number=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8= f4, -Dbuild.vcs.number.1=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuil= d.vcs.number.IgniteApache=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dcla= ssworlds.conf=3D/usr/local/TeamCityAgent/temp/buildTmp/teamcity.m2.conf, -D= com.jetbrains.maven.watcher.report.file=3D/usr/local/TeamCityAgent/temp/bui= ldTmp/maven-build-info.xml, -Dhadoop.version=3D2.5.2, -Djava.io.tmpdir=3D/u= sr/local/TeamCityAgent/temp/buildTmp, -Dmaven.home=3D/usr/local/TeamCityAge= nt/tools/maven3, -Dmaven.repo.local=3D/home/teamcity/.m2/repository, -Dteam= city.agent.cpuBenchmark=3D663, -Dteamcity.agent.dotnet.agent_url=3Dhttp://l= ocalhost:9090/RPC2, -Dteamcity.agent.dotnet.build_id=3D400410, -Dteamcity.a= uth.password=3Dnu1IIi3SWEb8NNhLDhghzpZjQSPWkYV3, -Dteamcity.auth.userId=3DT= eamCityBuildId=3D400410, -Dteamcity.build.changedFiles.file=3D/usr/local/Te= amCityAgent/temp/buildTmp/changedFiles6192942218181221816.txt, -Dteamcity.b= uild.checkoutDir=3D/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamci= ty.build.id=3D400410, -Dteamcity.build.properties.file=3D/usr/local/TeamCit= yAgent/temp/buildTmp/teamcity.build1936164090676629649.properties, -Dteamci= ty.build.tempDir=3D/usr/local/TeamCityAgent/temp/buildTmp, -Dteamcity.build= .workingDir=3D/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.bu= ildConfName=3DIgnite Hadoop, -Dteamcity.buildType.id=3DIgnite_Hadoop, -Dtea= mcity.configuration.properties.file=3D/usr/local/TeamCityAgent/temp/buildTm= p/teamcity.config1651692759705343482.properties, -Dteamcity.idea.home=3D/us= r/local/TeamCityAgent/plugins/idea, -Dteamcity.maven.watcher.home=3D/usr/lo= cal/TeamCityAgent/plugins/mavenPlugin/maven-watcher, -Dteamcity.projectName= =3DIgnite, -Dteamcity.runner.properties.file=3D/usr/local/TeamCityAgent/tem= p/buildTmp/teamcity.runner4645183226190514392.properties, -Dteamcity.tests.= recentlyFailedTests.file=3D/usr/local/TeamCityAgent/temp/buildTmp/testsToRu= nFirst6297047454049666673.txt, -Dteamcity.version=3D8.1.4 (build 30168), -e= a, -XX:MaxPermSize=3D2g, -Xms1g, -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, -= XX:+AggressiveOpts, -DIGNITE_TEST_HOME=3D/usr/local/TeamCityAgent/work/c326= f6bf1927b309, -DIGNITE_UPDATE_NOTIFIER=3Dfalse, -DIGNITE_NO_DISCO_ORDER=3Dt= rue, -DIGNITE_QUIET=3Dfalse, -XX:+PrintGC, -XX:+PrintGCDetails, -XX:+PrintG= CTimeStamps] > [16:37:40,523][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Configured = caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 'ignite-hadoop-m= r-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/li= bs/licenses > [16:37:40,535][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Non-loopbac= k local IPs: 192.168.2.17, fe80:0:0:0:ca60:ff:fe68:5868%2 > [16:37:40,535][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Enabled loc= al 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]=20 > [16:37:40,551][INFO ][main][TcpCommunicationSpi] Successfully bound to TC= P port [port=3D45191, locHost=3D/127.0.0.1] > [16:37:40,582][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Security st= atus [authentication=3Doff] > [16:37:40,602][INFO ][main][HadoopProcessor] HADOOP_HOME is set to /usr/l= ocal/TeamCityAgent/temp/buildTmp/__hadoop/hadoop-2.5.2 > [16:37:40,624][INFO ][main][TcpDiscoverySpi] Successfully bound to TCP po= rt [port=3D47501, localHost=3D/127.0.0.1] > [16:37:40,701][INFO ][disco-event-worker-#19989%hadoop.HadoopMapReduceEmb= eddedSelfTest0%][GridDiscoveryManager] Added new node to topology: TcpDisco= veryNode [id=3D7a924c9a-3284-476f-ad7c-6ddc7d6b3edd, addrs=3D[127.0.0.1], s= ockAddrs=3D[/127.0.0.1:47501], discPort=3D47501, order=3D2, intOrder=3D2, l= oc=3Dfalse, ver=3D1.0.0#19700101-sha1:00000000, isClient=3Dfalse] > [16:37:40,702][INFO ][disco-event-worker-#19989%hadoop.HadoopMapReduceEmb= eddedSelfTest0%][GridDiscoveryManager] Topology snapshot [ver=3D2, nodes=3D= 2, CPUs=3D4, heap=3D2.9GB] > [16:37:40,715][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-marshaller-sys-cache, mode=3DREPLICATED] > [16:37:40,721][INFO ][main][GridCacheProcessor] Started cache [name=3Dmet= a, mode=3DREPLICATED] > [16:37:40,726][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-hadoop-mr-sys-cache, mode=3DREPLICATED] > [16:37:40,735][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-atomics-sys-cache, mode=3DPARTITIONED] > [16:37:40,741][INFO ][main][GridCacheProcessor] Started cache [name=3Ddat= a, mode=3DPARTITIONED] > [16:37:40,747][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-sys-cache, mode=3DREPLICATED] > [16:37:42,075][INFO ][main][GridDhtPreloader] Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache > [16:37:42,075][INFO ][main][GridDhtPreloader] Starting rebalancing in SYNC mode: ignite-hadoop-mr-sys-cache > [16:37:42,076][INFO ][main][GridDhtPreloader] Starting rebalancing= in ASYNC mode: meta > [16:37:42,076][INFO ][main][GridDhtPreloader] = Starting rebalancing in SYNC mode: ignite-atomics-sys-cache > [16:37:42,076][INFO ][main][GridDhtPreloader] Starting rebalancing= in ASYNC mode: data > [16:37:42,076][INFO ][main][GridDhtPreloader] Starting= rebalancing in SYNC mode: ignite-sys-cache > [16:37:42,237][INFO ][preloader-demand-worker-#20074%hadoop.HadoopMapRedu= ceEmbeddedSelfTest1%][GridDhtPreloader] Compl= eted rebalancing in SYNC mode [cache=3Dignite-marshaller-sys-cache, time=3D= 171 ms] > [16:37:42,255][INFO ][preloader-demand-worker-#20102%hadoop.HadoopMapRedu= ceEmbeddedSelfTest1%][GridDhtPreloader] Completed rebala= ncing in SYNC mode [cache=3Dignite-sys-cache, time=3D171 ms] > [16:37:42,298][INFO ][preloader-demand-worker-#20090%hadoop.HadoopMapRedu= ceEmbeddedSelfTest1%][GridDhtPreloader] Complete= d rebalancing in SYNC mode [cache=3Dignite-atomics-sys-cache, time=3D231 ms= ] > [16:37:42,302][INFO ][preloader-demand-worker-#20087%hadoop.HadoopMapRedu= ceEmbeddedSelfTest1%][GridDhtPreloader] Completed rebalancing in ASY= NC mode [cache=3Dmeta, time=3D231 ms] > [16:37:42,305][INFO ][preloader-demand-worker-#20080%hadoop.HadoopMapRedu= ceEmbeddedSelfTest1%][GridDhtPreloader] Comple= ted rebalancing in SYNC mode [cache=3Dignite-hadoop-mr-sys-cache, time=3D23= 1 ms] > [16:37:42,307][INFO ][preloader-demand-worker-#20097%hadoop.HadoopMapRedu= ceEmbeddedSelfTest1%][GridDhtPreloader] Completed rebalancing in ASY= NC mode [cache=3Ddata, time=3D231 ms] > [16:37:42,331][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] Performance= suggestions for grid 'hadoop.HadoopMapReduceEmbeddedSelfTest1' (fix if pos= sible) > [16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] To disable,= set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=3Dtrue > [16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] ^-- Disab= le checkpoints (remove 'checkpointSpi' from configuration) > [16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] ^-- Disab= le grid events (remove 'includeEventTypes' from configuration) > [16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1]=20 > [16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1] To start Co= nsole Management & Monitoring run ignitevisorcmd.{sh|bat} > [16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1]=20 > [16:37:42,332][INFO ][main][HadoopMapReduceEmbeddedSelfTest1]=20 > >>> +---------------------------------+ > >>> 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=3D7A924C9A-3284-476F-AD7C-6DDC7D6B3EDD, order=3D2] > >>> Local node addresses: [/127.0.0.1] > >>> Local ports: TCP:45191 TCP:47501=20 > >>> Ignite documentation: http://ignite.incubator.apache.org > [16:37:42,333][INFO ][main][GridDiscoveryManager] Topology snapshot [ver= =3D2, nodes=3D2, CPUs=3D4, heap=3D2.8GB] > [16:37:42,348][INFO ][main][HadoopMapReduceEmbeddedSelfTest2]=20 > >>> __________ ________________ =20 > >>> / _/ ___/ |/ / _/_ __/ __/ =20 > >>> _/ // (7 7 // / / / / _/ =20 > >>> /___/\___/_/|_/___/ /_/ /___/ =20 > >>>=20 > >>> 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: te= amcity > [16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Language ru= ntime: Java Platform API Specification ver. 1.7 > [16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] VM informat= ion: Java(TM) SE Runtime Environment 1.7.0_67-b01 Oracle Corporation Java H= otSpot(TM) 64-Bit Server VM 24.65-b04 > [16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] VM total me= mory: 2.8GB > [16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Remote Mana= gement [restart: off, REST: off, JMX (remote: off)] > [16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] IGNITE_HOME= =3D/usr/local/TeamCityAgent/work/c326f6bf1927b309 > [16:37:42,350][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] VM argument= s: [-DJAVA_HOME=3D/usr/lib/jvm/java-7-oracle, -DMCAST_GRP=3D229.17.1.2, -Da= gent.home.dir=3D/usr/local/TeamCityAgent, -Dagent.name=3Dteamcity-7, -Dagen= t.ownPort=3D9090, -Dagent.work.dir=3D/usr/local/TeamCityAgent/work, -Dbuild= .number=3D1560, -Dbuild.vcs.number=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8= f4, -Dbuild.vcs.number.1=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dbuil= d.vcs.number.IgniteApache=3Dcb074fe98614907b0dd20fca71a44beb2dc5d8f4, -Dcla= ssworlds.conf=3D/usr/local/TeamCityAgent/temp/buildTmp/teamcity.m2.conf, -D= com.jetbrains.maven.watcher.report.file=3D/usr/local/TeamCityAgent/temp/bui= ldTmp/maven-build-info.xml, -Dhadoop.version=3D2.5.2, -Djava.io.tmpdir=3D/u= sr/local/TeamCityAgent/temp/buildTmp, -Dmaven.home=3D/usr/local/TeamCityAge= nt/tools/maven3, -Dmaven.repo.local=3D/home/teamcity/.m2/repository, -Dteam= city.agent.cpuBenchmark=3D663, -Dteamcity.agent.dotnet.agent_url=3Dhttp://l= ocalhost:9090/RPC2, -Dteamcity.agent.dotnet.build_id=3D400410, -Dteamcity.a= uth.password=3Dnu1IIi3SWEb8NNhLDhghzpZjQSPWkYV3, -Dteamcity.auth.userId=3DT= eamCityBuildId=3D400410, -Dteamcity.build.changedFiles.file=3D/usr/local/Te= amCityAgent/temp/buildTmp/changedFiles6192942218181221816.txt, -Dteamcity.b= uild.checkoutDir=3D/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamci= ty.build.id=3D400410, -Dteamcity.build.properties.file=3D/usr/local/TeamCit= yAgent/temp/buildTmp/teamcity.build1936164090676629649.properties, -Dteamci= ty.build.tempDir=3D/usr/local/TeamCityAgent/temp/buildTmp, -Dteamcity.build= .workingDir=3D/usr/local/TeamCityAgent/work/c326f6bf1927b309, -Dteamcity.bu= ildConfName=3DIgnite Hadoop, -Dteamcity.buildType.id=3DIgnite_Hadoop, -Dtea= mcity.configuration.properties.file=3D/usr/local/TeamCityAgent/temp/buildTm= p/teamcity.config1651692759705343482.properties, -Dteamcity.idea.home=3D/us= r/local/TeamCityAgent/plugins/idea, -Dteamcity.maven.watcher.home=3D/usr/lo= cal/TeamCityAgent/plugins/mavenPlugin/maven-watcher, -Dteamcity.projectName= =3DIgnite, -Dteamcity.runner.properties.file=3D/usr/local/TeamCityAgent/tem= p/buildTmp/teamcity.runner4645183226190514392.properties, -Dteamcity.tests.= recentlyFailedTests.file=3D/usr/local/TeamCityAgent/temp/buildTmp/testsToRu= nFirst6297047454049666673.txt, -Dteamcity.version=3D8.1.4 (build 30168), -e= a, -XX:MaxPermSize=3D2g, -Xms1g, -Xmx3g, -XX:+HeapDumpOnOutOfMemoryError, -= XX:+AggressiveOpts, -DIGNITE_TEST_HOME=3D/usr/local/TeamCityAgent/work/c326= f6bf1927b309, -DIGNITE_UPDATE_NOTIFIER=3Dfalse, -DIGNITE_NO_DISCO_ORDER=3Dt= rue, -DIGNITE_QUIET=3Dfalse, -XX:+PrintGC, -XX:+PrintGCDetails, -XX:+PrintG= CTimeStamps] > [16:37:42,351][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Configured = caches ['ignite-marshaller-sys-cache', 'ignite-sys-cache', 'ignite-hadoop-m= r-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/li= bs/licenses > [16:37:42,363][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Non-loopbac= k local IPs: 192.168.2.17, fe80:0:0:0:ca60:ff:fe68:5868%2 > [16:37:42,363][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Enabled loc= al 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]=20 > [16:37:42,379][INFO ][main][TcpCommunicationSpi] Successfully bound to TC= P port [port=3D45192, locHost=3D/127.0.0.1] > [16:37:42,411][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Security st= atus [authentication=3Doff] > [16:37:42,432][INFO ][main][HadoopProcessor] HADOOP_HOME is set to /usr/l= ocal/TeamCityAgent/temp/buildTmp/__hadoop/hadoop-2.5.2 > [16:37:42,453][INFO ][main][TcpDiscoverySpi] Successfully bound to TCP po= rt [port=3D47502, localHost=3D/127.0.0.1] > [16:37:42,598][INFO ][disco-event-worker-#19989%hadoop.HadoopMapReduceEmb= eddedSelfTest0%][GridDiscoveryManager] Added new node to topology: TcpDisco= veryNode [id=3Dd313c493-0cbc-4ada-a03e-e48802166818, addrs=3D[127.0.0.1], s= ockAddrs=3D[/127.0.0.1:47502], discPort=3D47502, order=3D3, intOrder=3D3, l= oc=3Dfalse, ver=3D1.0.0#19700101-sha1:00000000, isClient=3Dfalse] > [16:37:42,599][INFO ][disco-event-worker-#19989%hadoop.HadoopMapReduceEmb= eddedSelfTest0%][GridDiscoveryManager] Topology snapshot [ver=3D3, nodes=3D= 3, CPUs=3D4, heap=3D2.8GB] > [16:37:42,600][INFO ][disco-event-worker-#20066%hadoop.HadoopMapReduceEmb= eddedSelfTest1%][GridDiscoveryManager] Added new node to topology: TcpDisco= veryNode [id=3Dd313c493-0cbc-4ada-a03e-e48802166818, addrs=3D[127.0.0.1], s= ockAddrs=3D[/127.0.0.1:47502], discPort=3D47502, order=3D3, intOrder=3D3, l= oc=3Dfalse, ver=3D1.0.0#19700101-sha1:00000000, isClient=3Dfalse] > [16:37:42,600][INFO ][disco-event-worker-#20066%hadoop.HadoopMapReduceEmb= eddedSelfTest1%][GridDiscoveryManager] Topology snapshot [ver=3D3, nodes=3D= 3, CPUs=3D4, heap=3D2.8GB] > [16:37:42,612][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-marshaller-sys-cache, mode=3DREPLICATED] > [16:37:42,617][INFO ][main][GridCacheProcessor] Started cache [name=3Dmet= a, mode=3DREPLICATED] > [16:37:42,623][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-hadoop-mr-sys-cache, mode=3DREPLICATED] > [16:37:42,632][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-atomics-sys-cache, mode=3DPARTITIONED] > [16:37:42,639][INFO ][main][GridCacheProcessor] Started cache [name=3Ddat= a, mode=3DPARTITIONED] > [16:37:42,644][INFO ][main][GridCacheProcessor] Started cache [name=3Dign= ite-sys-cache, mode=3DREPLICATED] > [16:37:43,306][INFO ][main][GridDhtPreloader] Starting rebalancing in SYNC mode: ignite-marshaller-sys-cache > [16:37:43,306][INFO ][main][GridDhtPreloader] Starting rebalancing in SYNC mode: ignite-hadoop-mr-sys-cache > [16:37:43,306][INFO ][main][GridDhtPreloader] Starting rebalancing= in ASYNC mode: meta > [16:37:43,307][INFO ][main][GridDhtPreloader] = Starting rebalancing in SYNC mode: ignite-atomics-sys-cache > [16:37:43,308][INFO ][main][GridDhtPreloader] Starting rebalancing= in ASYNC mode: data > [16:37:43,308][INFO ][main][GridDhtPreloader] Starting= rebalancing in SYNC mode: ignite-sys-cache > [16:37:43,476][INFO ][preloader-demand-worker-#20167%hadoop.HadoopMapRedu= ceEmbeddedSelfTest2%][GridDhtPreloader] Compl= eted rebalancing in SYNC mode [cache=3Dignite-marshaller-sys-cache, time=3D= 171 ms] > [16:37:43,496][INFO ][preloader-demand-worker-#20181%hadoop.HadoopMapRedu= ceEmbeddedSelfTest2%][GridDhtPreloader] Complete= d rebalancing in SYNC mode [cache=3Dignite-atomics-sys-cache, time=3D193 ms= ] > [16:37:43,500][INFO ][preloader-demand-worker-#20193%hadoop.HadoopMapRedu= ceEmbeddedSelfTest2%][GridDhtPreloader] Completed rebala= ncing in SYNC mode [cache=3Dignite-sys-cache, time=3D193 ms] > [16:37:43,505][INFO ][preloader-demand-worker-#20188%hadoop.HadoopMapRedu= ceEmbeddedSelfTest2%][GridDhtPreloader] Completed rebalancing in ASY= NC mode [cache=3Ddata, time=3D193 ms] > [16:37:43,520][INFO ][preloader-demand-worker-#20173%hadoop.HadoopMapRedu= ceEmbeddedSelfTest2%][GridDhtPreloader] Comple= ted rebalancing in SYNC mode [cache=3Dignite-hadoop-mr-sys-cache, time=3D21= 3 ms] > [16:37:43,525][INFO ][preloader-demand-worker-#20178%hadoop.HadoopMapRedu= ceEmbeddedSelfTest2%][GridDhtPreloader] Completed rebalancing in ASY= NC mode [cache=3Dmeta, time=3D213 ms] > [16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] Performance= suggestions for grid 'hadoop.HadoopMapReduceEmbeddedSelfTest2' (fix if pos= sible) > [16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] To disable,= set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=3Dtrue > [16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] ^-- Disab= le checkpoints (remove 'checkpointSpi' from configuration) > [16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] ^-- Disab= le grid events (remove 'includeEventTypes' from configuration) > [16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2]=20 > [16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2] To start Co= nsole Management & Monitoring run ignitevisorcmd.{sh|bat} > [16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2]=20 > [16:37:43,548][INFO ][main][HadoopMapReduceEmbeddedSelfTest2]=20 > >>> +---------------------------------+ > >>> 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=3DD313C493-0CBC-4ADA-A03E-E48802166818, order=3D3] > >>> Local node addresses: [/127.0.0.1] > >>> Local ports: TCP:45192 TCP:47502=20 > >>> Ignite documentation: http://ignite.incubator.apache.org > [16:37:43,549][INFO ][main][GridDiscoveryManager] Topology snapshot [ver= =3D3, nodes=3D3, CPUs=3D4, heap=3D2.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%][FileOutputCommi= tter] Saved output of task 'attempt_3642bd08-a856-457f-b7de-1eaabc4de4da_00= 01_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%][FileOutputCommi= tter] Saved output of task 'attempt_afecac89-ef45-4a3d-988c-c5c16f231d52_00= 01_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%][FileOutputCommi= tter] Saved output of task 'attempt_5a132c34-b235-4468-8c4c-70e4bc047897_00= 01_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%][FileOutputCommi= tter] Saved output of task 'attempt_37d89f9d-7bf4-4bfc-acfe-8bdf2dfec0c1_00= 01_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%][FileOutputCommi= tter] Saved output of task 'attempt_e9089c34-7864-412e-9507-2038b6fb0d6e_00= 01_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%][FileOutputCommi= tter] Saved output of task 'attempt_b42447f3-7f75-4639-864f-72854bb81982_00= 01_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=3D"Hadoop-task-ef8347bb-a9de-454a-8823-60e3b3c513b7_1-MAP-23= 2-0-#22374%hadoop.HadoopMapReduceEmbeddedSelfTest2%", id=3D30879, state=3DR= UNNABLE, blockCnt=3D0, waitCnt=3D4] > at java.util.StringTokenizer.skipDelimiters(StringTokenizer.java:= 245) > at java.util.StringTokenizer.hasMoreTokens(StringTokenizer.java:3= 23) > 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(HadoopV2MapT= ask.java:84) > at o.a.i.i.processors.hadoop.v2.HadoopV2Task.run(HadoopV2Task.jav= a:50) > at o.a.i.i.processors.hadoop.v2.HadoopV2TaskContext.run(HadoopV2T= askContext.java:193) > at o.a.i.i.processors.hadoop.taskexecutor.HadoopRunnableTask.runT= ask(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=3D"hadoop-shuffle-ef8347bb-a9de-454a-8823-60e3b3c513b7_1-#22= 373%hadoop.HadoopMapReduceEmbeddedSelfTest2%", id=3D30878, state=3DTIMED_WA= ITING, blockCnt=3D0, waitCnt=3D28] > at java.lang.Thread.sleep(Native Method) > at o.a.i.i.processors.hadoop.shuffle.HadoopShuffleJob$1.body(Hado= opShuffleJob.java:159) > at o.a.i.i.util.worker.GridWorker.run(GridWorker.java:107) > at java.lang.Thread.run(Thread.java:745) > Thread [name=3D"Hadoop-task-ef8347bb-a9de-454a-8823-60e3b3c513b7_1-MAP-5-= 0-#22372%hadoop.HadoopMapReduceEmbeddedSelfTest0%", id=3D30877, state=3DRUN= NABLE, blockCnt=3D0, waitCnt=3D6] > 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.HadoopMultimapBa= se$ReaderBase.read(HadoopMultimapBase.java:159) > at o.a.i.i.processors.hadoop.shuffle.collections.HadoopSkipList$R= eader.readKey(HadoopSkipList.java:260) > at o.a.i.i.processors.hadoop.shuffle.collections.HadoopSkipList$A= dderImpl.cmp(HadoopSkipList.java:471) > at o.a.i.i.processors.hadoop.shuffle.collections.HadoopSkipList$A= dderImpl.add(HadoopSkipList.java:417) > at o.a.i.i.processors.hadoop.shuffle.collections.HadoopSkipList$A= dderImpl.write(HadoopSkipList.java:300) > at o.a.i.i.processors.hadoop.v2.HadoopV2Context.write(HadoopV2Con= text.java:134) > at org.apache.hadoop.mapreduce.lib.map.WrappedMapper$Context.writ= e(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(HadoopV2MapT= ask.java:84) > at o.a.i.i.processors.hadoop.v2.HadoopV2Task.run(HadoopV2Task.jav= a:50) > at o.a.i.i.processors.hadoop.v2.HadoopV2TaskContext.run(HadoopV2T= askContext.java:193) > at o.a.i.i.processors.hadoop.taskexecutor.HadoopRunnableTask.runT= ask(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)