2016-05-18 01:17:17,679 INFO platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(197)) - found 1 test platforms from classpath
2016-05-18 01:17:17,710 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(246)) - adding test: cascading.TrapPlatformTest, with platform: hadoop2-tez
2016-05-18 01:17:17,746 INFO tez.Hadoop2TezPlatform (Hadoop2TezPlatform.java:setUp(164)) - using cluster
2016-05-18 01:17:18,632 WARN util.NativeCodeLoader (NativeCodeLoader.java:<clinit>(62)) - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
Formatting using clusterid: testClusterID
2016-05-18 01:17:19,582 WARN impl.MetricsConfig (MetricsConfig.java:loadFirst(125)) - Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
2016-05-18 01:17:24,239 INFO test.MiniTezCluster (MiniTezCluster.java:serviceInit(119)) - Using Tez AppJar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-dag/0.8.2/bb35daf757685063ef9951dc0724f99c70f2742b/tez-dag-0.8.2.jar
2016-05-18 01:17:24,893 INFO test.MiniTezCluster (MiniTezCluster.java:serviceInit(131)) - Set TEZ-LIB-URI to: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:17:24,899 INFO test.MiniTezCluster (MiniTezCluster.java:serviceInit(162)) - mkdir: hdfs://localhost:35099/apps_staging_dir
2016-05-18 01:17:25,317 WARN containermanager.AuxServices (AuxServices.java:serviceInit(130)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class org.apache.hadoop.mapred.ShuffleHandler which has a name of 'httpshuffle'. Because these are not the same tools trying to send ServiceData and read Service Meta Data may have issues unless the refer to the name in the config.
2016-05-18 01:17:25,427 WARN containermanager.AuxServices (AuxServices.java:serviceInit(130)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class org.apache.hadoop.mapred.ShuffleHandler which has a name of 'httpshuffle'. Because these are not the same tools trying to send ServiceData and read Service Meta Data may have issues unless the refer to the name in the config.
2016-05-18 01:17:25,493 WARN containermanager.AuxServices (AuxServices.java:serviceInit(130)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class org.apache.hadoop.mapred.ShuffleHandler which has a name of 'httpshuffle'. Because these are not the same tools trying to send ServiceData and read Service Meta Data may have issues unless the refer to the name in the config.
2016-05-18 01:17:25,556 WARN containermanager.AuxServices (AuxServices.java:serviceInit(130)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class org.apache.hadoop.mapred.ShuffleHandler which has a name of 'httpshuffle'. Because these are not the same tools trying to send ServiceData and read Service Meta Data may have issues unless the refer to the name in the config.
2016-05-18 01:17:25,561 INFO test.MiniTezCluster (MiniTezCluster.java:serviceStart(196)) - Starting MiniTezCluster
2016-05-18 01:17:31,212 INFO test.MiniTezCluster (MiniTezCluster.java:serviceStart(215)) - Setting yarn-site.xml via YARN-APP-CP at: /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/target/cascading.platform.tez.Hadoop2TezPlatform,/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test:/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/resources/test:/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/main:/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/resources/main:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-core/3.1.0/9f41bc3c02048b244161c34aab73acda810c2389/cascading-core-3.1.0-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-platform/3.1.0/38cd2eba8dbbc1efc3f097f196965a60c99cbf2f/cascading-platform-3.1.0-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/11d23daa35c4c17d09d6a8d13b7964dbabd56bf6/cascading-hadoop2-tez-3.1.0-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez-stats/3.1.0/2b8a4fba885da289dd195ea1f6840a76b16f77a6/cascading-hadoop2-tez-stats-3.1.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-io/3.1.0/32191afb3963b6ad8992408fd1432cd213fd8de6/cascading-hadoop2-io-3.1.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-mapreduce-client-core/2.7.2/accf0f40de77a6d8cece5e3bd6bbc2a579102a4f/hadoop-mapreduce-client-core-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-common/2.7.2/422eb48913fa6f81835b3192c97a576505b6c192/hadoop-common-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-minicluster/2.7.2/ea4e0a5464106af39441f380bf33792a71bb5638/hadoop-minicluster-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-tests/0.8.2/112a1aad7d4380d9e254adb4eaffb8d494446f1e/tez-tests-0.8.2-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-api/0.8.2/bb64787749c15ab156f1975d77e47f18d4291c59/tez-api-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-dag/0.8.2/bb35daf757685063ef9951dc0724f99c70f2742b/tez-dag-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-aws/2.7.2/92824675692f69a5cd1aed21584090eb4b87ad4a/hadoop-aws-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-yarn-timeline-history-with-acls/0.8.2/ae32d0fdc09027bb300818f11cc10bfe34e0f69/tez-yarn-timeline-history-with-acls-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/junit/junit/4.12/2973d150c0dc1fefe998f834810d68f278ea58ec/junit-4.12.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/riffle/riffle/1.0.0/d991264d10c1e80f8588d2480e3f6e536e30fcb2/riffle-1.0.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.jgrapht/jgrapht-core/0.9.2/2597c1f9aa80fcfdd1f2e8ad0f0655bd768d95ca/jgrapht-core-0.9.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-core/3.1.0/ba7756e455a94ae4c9cf9a2debeb7085e46f05e5/cascading-core-3.1.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-expression/3.1.0/47daa0fd74a26bfe727c2e6c06f8b9c7e9cb91c3/cascading-expression-3.1.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-common/2.7.2/ab16767c5c34cfee6ac2780c7fea56207762d2c7/hadoop-yarn-common-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.google.protobuf/protobuf-java/2.5.0/a10732c76bfacdbd633a7eb0f7968b1059a65dfa/protobuf-java-2.5.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.avro/avro/1.7.4/416e7030879814f52845b97f04bb50ecd1cef372/avro-1.7.4.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-annotations/2.7.2/80693ef2884927ee3c5464a7539fcfa4af382e14/hadoop-annotations-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.google.inject.extensions/guice-servlet/3.0/610cde0e8da5a8b7d8efb8f0b8987466ffebaaf9/guice-servlet-3.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.google.guava/guava/11.0.2/35a3c69e19d72743cac83778aecbee68680f63eb/guava-11.0.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-cli/commons-cli/1.2/2bf96b7aa8b611c177d329452af1dc933e14501c/commons-cli-1.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.commons/commons-math3/3.1.1/6719d757a98ff24a83d9d727bef9cec83f59b6e1/commons-math3-3.1.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/xmlenc/xmlenc/0.52/d82554efbe65906d83b3d97bd7509289e9db561a/xmlenc-0.52.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-httpclient/commons-httpclient/3.1/964cd74171f427720480efdec40a7c7f6e58426a/commons-httpclient-3.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-io/commons-io/2.4/b1b6ea3b7e4aa4f492509a4952029cd8e48019ad/commons-io-2.4.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-net/commons-net/3.1/2298164a7c2484406f2aa5ac85b205d39019896f/commons-net-3.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-collections/commons-collections/3.2.2/8ad72fe39fa8c91eaaf12aadb21e0c3661fe26d5/commons-collections-3.2.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/javax.servlet/servlet-api/2.5/5959582d97d8b61f4d154ca9e495aafd16726e34/servlet-api-2.5.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.mortbay.jetty/jetty/6.1.26/2f546e289fddd5b1fab1d4199fbb6e9ef43ee4b0/jetty-6.1.26.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.mortbay.jetty/jetty-util/6.1.26/e5642fe0399814e1687d55a3862aa5a3417226a9/jetty-util-6.1.26.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/javax.servlet.jsp/jsp-api/2.1/63f943103f250ef1f3a4d5e94d145a0f961f5316/jsp-api-2.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.sun.jersey/jersey-core/1.9/8341846f18187013bb9e27e46b7ee00a6395daf4/jersey-core-1.9.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.sun.jersey/jersey-json/1.9/1aa73e1896bcc7013fed247157d7f676226eb432/jersey-json-1.9.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.sun.jersey/jersey-server/1.9/3a6ea7cc5e15c824953f9f3ece2201b634d90d18/jersey-server-1.9.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-logging/commons-logging/1.1.3/f6f66e966c70a83ffbdb6f17a0919eaf7c8aca7f/commons-logging-1.1.3.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/log4j/log4j/1.2.17/5af35056b4d257e4b64b9e8069c0746e8b08629f/log4j-1.2.17.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/net.java.dev.jets3t/jets3t/0.9.0/792bc96ee7e57b89f472aa0cb5a31015b9f59c96/jets3t-0.9.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-lang/commons-lang/2.6/ce1edb914c94ebc388f086c6827e8bdeec71ac2/commons-lang-2.6.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-configuration/commons-configuration/1.6/32cadde23955d7681b0d94a2715846d20b425235/commons-configuration-1.6.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.codehaus.jackson/jackson-core-asl/1.9.13/3c304d70f42f832e0a86d45bd437f692129299a4/jackson-core-asl-1.9.13.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.codehaus.jackson/jackson-mapper-asl/1.9.13/1ee2f2bed0e5dd29d1cb155a166e6f8d50bbddb7/jackson-mapper-asl-1.9.13.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.google.code.gson/gson/2.2.4/a60a5e993c98c864010053cb901b7eab25306568/gson-2.2.4.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-auth/2.7.2/bf613cfec06a1f3d3a91d7f82f9e4af75bc01f72/hadoop-auth-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.jcraft/jsch/0.1.42/a86104b0f2e0c0bab5b0df836065823a99b5e334/jsch-0.1.42.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.curator/curator-client/2.7.1/a591dfc085db3e9d4d480381cc7e6ae8a26b34af/curator-client-2.7.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.curator/curator-recipes/2.7.1/a2c180efc6a38a4f8c9197eb35bb4eb5716cd2fa/curator-recipes-2.7.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.google.code.findbugs/jsr305/3.0.0/5871fb60dc68d67da54a663c3fd636a10a532948/jsr305-3.0.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.htrace/htrace-core/3.1.0-incubating/f73606e7c9ede5802335c290bf47490ad6d51df3/htrace-core-3.1.0-incubating.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.zookeeper/zookeeper/3.4.6/1b2502e29da1ebaade2357cd1de35a855fa3755/zookeeper-3.4.6.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.zookeeper/zookeeper/3.4.6/abeecacad507fcc43cc1a2e71b8a5cc3264d70b0/zookeeper-3.4.6-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.commons/commons-compress/1.4.1/b02e84a993d88568417536240e970c4b809126fd/commons-compress-1.4.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-common/2.7.2/482b3051dc384c1e15182a6ad1402649ef24be02/hadoop-common-2.7.2-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-hdfs/2.7.2/dfb6840b97211044e87a0345f7edad51b942fd2a/hadoop-hdfs-2.7.2-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-hdfs/2.7.2/3c304b3d9227fbf8af8bc1cab013271538c3cf0a/hadoop-hdfs-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-server-tests/2.7.2/60de24530087690d0e15444f2c2538bcd384c5cf/hadoop-yarn-server-tests-2.7.2-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-mapreduce-client-jobclient/2.7.2/c686047090283e21bd1d4659e6eabb73d726a4fe/hadoop-mapreduce-client-jobclient-2.7.2-tests.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-mapreduce-client-jobclient/2.7.2/cb2ca1e41075d55ad6dacf2f54cc0f0f97d623b6/hadoop-mapreduce-client-jobclient-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-mapreduce-client-app/2.7.2/6e4a1d1754c68b5ce3821cea96da77d0fc2067b5/hadoop-mapreduce-client-app-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-api/2.7.2/373d35254d9e292a36c35f48f8a797359b86e1f7/hadoop-yarn-api-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-mapreduce-client-hs/2.7.2/57ccdecef8a4d9075e5f37dc254776e410cc6230/hadoop-mapreduce-client-hs-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-common/0.8.2/4427ae19d3905803d37c76dcb7e2f17f8c6338ab/tez-common-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-runtime-library/0.8.2/6e00309eb781f9c08ccae39a91d9406f1aa384b7/tez-runtime-library-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-mapreduce/0.8.2/17fe71f2996ed752836c62df22fc4db2da9df174/tez-mapreduce-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-examples/0.8.2/dbbdf119d6c510e79b16cbfa1b5c5a717e40f842/tez-examples-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-client/2.7.2/6a626356170511385bac2ef4bd60eeea880dec46/hadoop-yarn-client-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-mapreduce-client-common/2.7.2/8021f146b10053f29c2085d0972b115395da1a33/hadoop-mapreduce-client-common-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.codehaus.jettison/jettison/1.3.4/3c08d8f699432e23023080cdc8b4073132473dc8/jettison-1.3.4.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.commons/commons-collections4/4.1/a4cf4688fe1c7e3a63aa636cc96d013af537768e/commons-collections4-4.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.sun.jersey/jersey-client/1.9/d3c4b2b5f89db32c96ceddcb863684821910a7bb/jersey-client-1.9.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/hadoop-shim/0.8.2/a4a7eabc59821a681beed7f1b821a9a79d355b1c/hadoop-shim-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-runtime-internals/0.8.2/349ceca61655d54f721c0a2373352a78d9f6c280/tez-runtime-internals-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-server-web-proxy/2.7.2/430c3b53dcf1901f37a92d703bb4ce343298561b/hadoop-yarn-server-web-proxy-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.fasterxml.jackson.core/jackson-databind/2.2.3/3ae380888029daefb91d3ecdca3a37d8cb92bc9/jackson-databind-2.2.3.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.fasterxml.jackson.core/jackson-annotations/2.2.3/527fece4f23a457070a36c371a26d6c0208e1c3/jackson-annotations-2.2.3.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.amazonaws/aws-java-sdk/1.7.4/2c24ccb6f1ab845a7df971951d4b41c709a6517d/aws-java-sdk-1.7.4.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.tez/tez-yarn-timeline-history/0.8.2/2e80cf54a517a6f44ca6a358ccda42527be18ac6/tez-yarn-timeline-history-0.8.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.hamcrest/hamcrest-core/1.3/42a25dc3219429f0e5d060061f71acb49bf010a0/hamcrest-core-1.3.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.codehaus.janino/janino/2.7.6/37fde5de7edd5d7ebe075f03f4c083df2ac73dd8/janino-2.7.6.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/javax.xml.bind/jaxb-api/2.2.2/aeb3021ca93dde265796d82015beecdcff95bf09/jaxb-api-2.2.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.codehaus.jackson/jackson-jaxrs/1.9.13/534d72d2b9d6199dd531dfb27083dd4844082bba/jackson-jaxrs-1.9.13.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.codehaus.jackson/jackson-xc/1.9.13/e3480072bc95c202476ffa1de99ff7ee9149f29c/jackson-xc-1.9.13.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.google.inject/guice/3.0/9d84f15fe35e2c716a02979fb62f50a29f38aefa/guice-3.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.sun.jersey.contribs/jersey-guice/1.9/5963c28c47df7e5d6ad34cec80c071c368777f7b/jersey-guice-1.9.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.thoughtworks.paranamer/paranamer/2.3/4a85963a752c0a2f715c3924bfc686865e7e1bc6/paranamer-2.3.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.xerial.snappy/snappy-java/1.0.4.1/f88b89a5a21a466aeb0ecf0c063605bd584b4947/snappy-java-1.0.4.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.mortbay.jetty/servlet-api/2.5-20081211/22bff70037e1e6fa7e6413149489552ee2064702/servlet-api-2.5-20081211.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.sun.xml.bind/jaxb-impl/2.2.3-1/56baae106392040a45a06d4a41099173425da1e6/jaxb-impl-2.2.3-1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/asm/asm/3.1/c157def142714c544bdea2e6144645702adf7097/asm-3.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.jamesmurty.utils/java-xmlbuilder/0.4/ac5962e48cdee3a0a6e1f8e00fcb594747ac5aaf/java-xmlbuilder-0.4.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-digester/commons-digester/1.8/dc6a73fdbd1fa3f0944e8497c6c872fa21dca37e/commons-digester-1.8.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-beanutils/commons-beanutils-core/1.8.0/175dc721f87e4bc5cc0573f990e28c3cf9117508/commons-beanutils-core-1.8.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.directory.server/apacheds-kerberos-codec/2.0.0-M15/1c16e4e477183641c5f0dd5cdecd27ec331bacb5/apacheds-kerberos-codec-2.0.0-M15.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.curator/curator-framework/2.7.1/8c7b1eeb78e43bb91ea737111ba3dec0512be876/curator-framework-2.7.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/jline/jline/0.9.94/99a18e9a44834afdebc467294e1138364c207402/jline-0.9.94.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.tukaani/xz/1.0/ecff5cb8b1189514c9d1d8d68eb77ac372e000c9/xz-1.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-daemon/commons-daemon/1.0.13/750856a1fdb3ddf721ccf73c3518e4211cffc3a3/commons-daemon-1.0.13.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/io.netty/netty-all/4.0.23.Final/294104aaf1781d6a56a07d561e792c5d0c95f45/netty-all-4.0.23.Final.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/xerces/xercesImpl/2.9.1/7bc7e49ddfe4fb5f193ed37ecc96c12292c8ceb6/xercesImpl-2.9.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.fusesource.leveldbjni/leveldbjni-all/1.8/707350a2eeb1fa2ed77a32ddb3893ed308e941db/leveldbjni-all-1.8.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-server-common/2.7.2/514ebf83b773352e9e662a7b5011c8d947162c5f/hadoop-yarn-server-common-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-server-nodemanager/2.7.2/521e0fb188ef3c6b239eb6dcca69e39cc788690b/hadoop-yarn-server-nodemanager-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-server-resourcemanager/2.7.2/6444a32767712596c11767943ba10070a82b34da/hadoop-yarn-server-resourcemanager-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-mapreduce-client-shuffle/2.7.2/edaf659eaf16effa6c7f759c603ab3e2c0f976f3/hadoop-mapreduce-client-shuffle-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.roaringbitmap/RoaringBitmap/0.4.9/b6127ce7af078f0a215e12f36e549f74b6088f02/RoaringBitmap-0.4.9.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.ning/async-http-client/1.8.16/4eb67ee9494e1a649b27d8cc78c3bd3404ec2748/async-http-client-1.8.16.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/com.fasterxml.jackson.core/jackson-core/2.2.3/1a0113da2cab5f4c216b4e5e7c1dbfaa67087e14/jackson-core-2.2.3.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/joda-time/joda-time/2.9.3/9e46be514a4ed60bcfbaaba88a3c668cf30476ab/joda-time-2.9.3.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.codehaus.janino/commons-compiler/2.7.6/b71e76d942b33dfa26e4e3047ff2a774d1f917b4/commons-compiler-2.7.6.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/javax.xml.stream/stax-api/1.0-2/d6337b0de8b25e53e81b922352fbea9f9f57ba0b/stax-api-1.0-2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/javax.activation/activation/1.1/e6cb541461c2834bdea3eb920f1884d1eb508b50/activation-1.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/javax.inject/javax.inject/1/6975da39a7040257bd51d21a231b76c915872d38/javax.inject-1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/aopalliance/aopalliance/1.0/235ba8b489512805ac13a8f9ea77a1ca5ebe3e8/aopalliance-1.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.sonatype.sisu.inject/cglib/2.2.1-v20090111/7ce5e983fd0e6c78346f4c9cbfa39d83049dda2/cglib-2.2.1-v20090111.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-beanutils/commons-beanutils/1.7.0/5675fd96b29656504b86029551973d60fb41339b/commons-beanutils-1.7.0.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.directory.server/apacheds-i18n/2.0.0-M15/71c61c84683152ec2a6a65f3f96fe534e304fa22/apacheds-i18n-2.0.0-M15.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.directory.api/api-asn1-api/1.0.0-M20/5e6486ffa3125ba44dc410ead166e1d6ba8ac76d/api-asn1-api-1.0.0-M20.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.directory.api/api-util/1.0.0-M20/a871abf060b3cf83fc6dc4d7e3d151fce50ac3cb/api-util-1.0.0-M20.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/xml-apis/xml-apis/1.3.04/90b215f48fe42776c8c7f6e3509ec54e84fd65ef/xml-apis-1.3.04.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.hadoop/hadoop-yarn-server-applicationhistoryservice/2.7.2/5ecdbd3bcc77826e4f4491ce12df722252f04f68/hadoop-yarn-server-applicationhistoryservice-2.7.2.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.slf4j/slf4j-api/1.7.10/5b338f206827d88acd890739f400a9b7664e5984/slf4j-api-1.7.10.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.slf4j/slf4j-log4j12/1.7.10/b3eeae7d1765f988a1f45ea81517191315c69c9e/slf4j-log4j12-1.7.10.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/stax/stax-api/1.0.1/49c100caf72d658aca8e58bd74a4ba90fa2b0d70/stax-api-1.0.1.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.httpcomponents/httpclient/4.2.5/666e26e76f2e87d84e4f16acb546481ae1b8e9a6/httpclient-4.2.5.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/io.netty/netty/3.9.2.Final/c8c67fb7c05e8ea847461ca972bfb08d69c520ad/netty-3.9.2.Final.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/org.apache.httpcomponents/httpcore/4.2.4/3b7f38df6de5dd8b500e602ae8c2dd5ee446f883/httpcore-4.2.4.jar:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/commons-codec/commons-codec/1.6/b7f0fc8f61ecadeb3695f0b9464755eee44374d4/commons-codec-1.6.jar
2016-05-18 01:17:31,620 INFO platform.TestPlatform (TestPlatform.java:getGlobalProperties(75)) - platform property overrides:
2016-05-18 01:17:31,767 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:17:31,769 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:17:31,844 INFO property.AppProps (AppProps.java:getAppID(177)) - using app.id: DA96431FF19742D2A11560F482473D23
2016-05-18 01:17:32,022 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.099
2016-05-18 01:17:32,057 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.135
2016-05-18 01:17:32,061 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 3
2016-05-18 01:17:32,062 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 3
2016-05-18 01:17:32,062 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:17:32,681 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/9BA7BA2C4E4040BD9071894F6F5EE5A0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:17:32,740 INFO util.Version (Version.java:printBanner(82)) - Concurrent, Inc - Cascading 3.1.0
2016-05-18 01:17:32,743 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:17:32,745 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:17:32,746 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachEveryAllChained/eacheverychain/tap"]
2016-05-18 01:17:32,747 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:17:32,747 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:17:32,748 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:17:32,749 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...hained/eacheverychain/tap
2016-05-18 01:17:32,768 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:17:32,789 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:17:33,221 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:17:33,358 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0001
2016-05-18 01:17:33,360 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:17:33,378 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/9BA7BA2C4E4040BD9071894F6F5EE5A0/EED6EBB221104F5AA9F247715AD419C9/.tez/application_1463534245563_0001 doesn't exist and is created
2016-05-18 01:17:33,483 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0001
2016-05-18 01:17:33,649 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0001, dagName=[9BA7BA2C4E4040BD9071894F6F5EE5A0/EED6EBB221104F5AA9F247715AD419C9] trap test/(1/1) ...hained/eacheverychain/tap
2016-05-18 01:17:33,936 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0001/
2016-05-18 01:17:40,922 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0001, with dag id: dag_1463534245563_0001_1
2016-05-18 01:17:50,880 INFO counters.Limits (Limits.java:ensureInitialized(60)) - Counter limits initialized with parameters: GROUP_NAME_MAX=256, MAX_GROUPS=500, COUNTER_NAME_MAX=64, MAX_COUNTERS=1200
2016-05-18 01:17:50,886 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachEveryAllChained/eacheverychain/tap/_temporary
2016-05-18 01:17:50,889 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachEveryAllChained/eacheverychain/trap/_temporary
2016-05-18 01:17:50,897 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:18.140, using cpu time: 00:05.270
2016-05-18 01:17:51,085 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEachEveryAllChained/eacheverychain/trap
2016-05-18 01:17:51,108 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEachEveryAllChained/eacheverychain/tap
2016-05-18 01:17:51,187 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:17:51,187 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:17:51,276 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.034
2016-05-18 01:17:51,300 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.058
2016-05-18 01:17:51,301 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:17:51,302 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:17:51,304 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:17:51,447 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/36A9D6103D41430BBAAD6648CF1DDC65/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:17:51,472 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:17:51,473 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:17:51,473 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtAggregate/everyaggregate/tap"]
2016-05-18 01:17:51,473 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:17:51,473 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:17:51,473 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:17:51,474 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...regate/everyaggregate/tap
2016-05-18 01:17:51,495 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:17:51,498 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:17:51,619 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:17:51,732 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0002
2016-05-18 01:17:51,732 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:17:51,749 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/36A9D6103D41430BBAAD6648CF1DDC65/EAC2F1A6557F4578878715DF3A7BA771/.tez/application_1463534245563_0002 doesn't exist and is created
2016-05-18 01:17:51,815 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0002
2016-05-18 01:17:51,881 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0002, dagName=[36A9D6103D41430BBAAD6648CF1DDC65/EAC2F1A6557F4578878715DF3A7BA771] trap test/(1/1) ...regate/everyaggregate/tap
2016-05-18 01:17:51,890 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0002/
2016-05-18 01:17:52,418 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0001_01_000003
2016-05-18 01:17:52,436 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0001_01_000004
2016-05-18 01:17:52,448 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0001_01_000005
2016-05-18 01:17:52,822 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0001_01_000006
2016-05-18 01:17:55,958 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0001_01_000002 is : 143
2016-05-18 01:17:56,897 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0001_01_000002
2016-05-18 01:17:57,440 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0001
2016-05-18 01:17:57,450 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0001
2016-05-18 01:17:59,255 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0002, with dag id: dag_1463534245563_0002_1
2016-05-18 01:18:07,405 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtAggregate/everyaggregate/tap/_temporary
2016-05-18 01:18:07,408 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtAggregate/everyaggregate/trap/_temporary
2016-05-18 01:18:07,412 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:15.932, using cpu time: 00:04.480
2016-05-18 01:18:07,523 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEveryAllAtAggregate/everyaggregate/tap
2016-05-18 01:18:07,535 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEveryAllAtAggregate/everyaggregate/trap
2016-05-18 01:18:07,583 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:18:07,583 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:18:07,644 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.029
2016-05-18 01:18:07,662 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.047
2016-05-18 01:18:07,663 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:18:07,663 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:18:07,663 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:18:07,758 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/6EB554C4F52348C39EC06389DC11F4DE/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:18:07,780 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:18:07,780 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:18:07,780 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAll/all/tap"]
2016-05-18 01:18:07,781 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:18:07,781 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:18:07,782 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:18:07,782 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...m/testTrapEachAll/all/tap
2016-05-18 01:18:07,798 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:18:07,800 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:18:07,887 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:18:07,959 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0003
2016-05-18 01:18:07,959 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:18:07,973 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/6EB554C4F52348C39EC06389DC11F4DE/E438F224079B4E23AC59B2B31F81AD9F/.tez/application_1463534245563_0003 doesn't exist and is created
2016-05-18 01:18:08,024 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0003
2016-05-18 01:18:08,077 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0003, dagName=[6EB554C4F52348C39EC06389DC11F4DE/E438F224079B4E23AC59B2B31F81AD9F] trap test/(1/1) ...m/testTrapEachAll/all/tap
2016-05-18 01:18:08,087 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0003/
2016-05-18 01:18:08,445 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0002_01_000003
2016-05-18 01:18:08,453 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0002_01_000004
2016-05-18 01:18:08,849 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0002_01_000005
2016-05-18 01:18:12,501 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0002_01_000002 is : 143
2016-05-18 01:18:13,455 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0002
2016-05-18 01:18:13,851 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0002
2016-05-18 01:18:15,328 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0003, with dag id: dag_1463534245563_0003_1
2016-05-18 01:18:21,794 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAll/all/tap/_temporary
2016-05-18 01:18:21,796 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAll/all/trap/_temporary
2016-05-18 01:18:21,799 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:14.010, using cpu time: 00:04.460
2016-05-18 01:18:21,889 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEachAll/all/trap
2016-05-18 01:18:21,896 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEachAll/all/tap
2016-05-18 01:18:21,936 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:18:21,936 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:18:21,991 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.023
2016-05-18 01:18:22,008 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.040
2016-05-18 01:18:22,009 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:18:22,010 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:18:22,010 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:18:22,097 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/5DDE64DC3CE444EBA13F717CDDFDC20E/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:18:22,118 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:18:22,118 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["HadoopFailScheme[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:18:22,118 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["HadoopFailScheme[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapTapSourceSink/trapsourcesink/sink"]
2016-05-18 01:18:22,118 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:18:22,118 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:18:22,118 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:18:22,120 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...eSink/trapsourcesink/sink
2016-05-18 01:18:22,135 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:18:22,138 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:18:22,232 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:18:22,303 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0004
2016-05-18 01:18:22,303 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:18:22,316 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/5DDE64DC3CE444EBA13F717CDDFDC20E/B8312844794A40BAA9D3CE50C7DE1D23/.tez/application_1463534245563_0004 doesn't exist and is created
2016-05-18 01:18:22,364 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0004
2016-05-18 01:18:22,417 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0004, dagName=[5DDE64DC3CE444EBA13F717CDDFDC20E/B8312844794A40BAA9D3CE50C7DE1D23] trap test/(1/1) ...eSink/trapsourcesink/sink
2016-05-18 01:18:22,423 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0004/
2016-05-18 01:18:23,442 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0003_01_000003
2016-05-18 01:18:23,458 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0003_01_000004
2016-05-18 01:18:26,821 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0003_01_000002 is : 143
2016-05-18 01:18:28,460 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0003
2016-05-18 01:18:29,187 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0004, with dag id: dag_1463534245563_0004_1
2016-05-18 01:18:36,471 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapTapSourceSink/trapsourcesink/sink/_temporary
2016-05-18 01:18:36,473 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapTapSourceSink/trapsourcesink/trap/_temporary
2016-05-18 01:18:36,476 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:14.351, using cpu time: 00:03.820
2016-05-18 01:18:36,582 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapTapSourceSink/trapsourcesink/sink
2016-05-18 01:18:36,589 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapTapSourceSink/trapsourcesink/trap
2016-05-18 01:18:36,626 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:18:36,626 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:18:36,675 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.019
2016-05-18 01:18:36,691 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.035
2016-05-18 01:18:36,692 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 01:18:36,692 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 01:18:36,692 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:18:36,723 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/89DDF1DA91384F7290EC2C0142F4AD7E/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:18:36,747 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting
2016-05-18 01:18:36,748 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:18:36,748 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapFailure/trapFailure/tap"]
2016-05-18 01:18:36,748 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] parallel execution of steps is enabled: true
2016-05-18 01:18:36,749 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executing total steps: 1
2016-05-18 01:18:36,749 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] allocating management threads: 1
2016-05-18 01:18:36,750 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting step: (1/1) ...apFailure/trapFailure/tap
2016-05-18 01:18:36,765 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] tez session mode enabled: false
2016-05-18 01:18:36,768 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:18:36,851 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:18:36,920 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0005
2016-05-18 01:18:36,921 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:18:36,934 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/89DDF1DA91384F7290EC2C0142F4AD7E/BBAEBBE1E4D74C458E0ED6F763D78F60/.tez/application_1463534245563_0005 doesn't exist and is created
2016-05-18 01:18:36,979 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0005
2016-05-18 01:18:37,033 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0005, dagName=[89DDF1DA91384F7290EC2C0142F4AD7E/BBAEBBE1E4D74C458E0ED6F763D78F60] null/(1/1) ...apFailure/trapFailure/tap
2016-05-18 01:18:37,039 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0005/
2016-05-18 01:18:41,524 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0004_01_000002 is : 143
2016-05-18 01:18:41,827 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0004_01_000001
2016-05-18 01:18:43,848 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] submitted tez dag to app master: application_1463534245563_0005, with dag id: dag_1463534245563_0005_1
2016-05-18 01:18:49,135 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] stopping all jobs
2016-05-18 01:18:49,136 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] stopping: (1/1) ...apFailure/trapFailure/tap
2016-05-18 01:18:49,137 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] stopped all jobs
2016-05-18 01:18:49,142 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapFailure/trapFailure/tap/_temporary
2016-05-18 01:18:49,145 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapFailure/trapFailure/badTrap/_temporary
2016-05-18 01:18:49,160 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] completed in: 00:12.391
2016-05-18 01:18:49,161 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapFailure/trapFailure/tap
2016-05-18 01:18:49,166 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapFailure/trapFailure/badTrap
2016-05-18 01:18:49,174 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapFailure/trapFailure/firstTrap
2016-05-18 01:18:49,190 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0005_01_000002 is : 143
2016-05-18 01:18:49,222 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:18:49,223 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:18:49,284 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.034
2016-05-18 01:18:49,290 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.039
2016-05-18 01:18:49,291 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:18:49,291 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:18:49,292 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:18:49,374 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/AFC9EF78A057437195F5CAE8E1F3A41C/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:18:49,395 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:18:49,395 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:18:49,395 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtComplete/everycomplete/tap"]
2016-05-18 01:18:49,395 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:18:49,395 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:18:49,395 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:18:49,397 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...omplete/everycomplete/tap
2016-05-18 01:18:49,411 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:18:49,414 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:18:49,501 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:18:49,580 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0006
2016-05-18 01:18:49,580 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:18:49,592 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/AFC9EF78A057437195F5CAE8E1F3A41C/D5EBBE61A5DD4B98AA35558A64A1C761/.tez/application_1463534245563_0006 doesn't exist and is created
2016-05-18 01:18:49,645 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0006
2016-05-18 01:18:49,695 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0006, dagName=[AFC9EF78A057437195F5CAE8E1F3A41C/D5EBBE61A5DD4B98AA35558A64A1C761] trap test/(1/1) ...omplete/everycomplete/tap
2016-05-18 01:18:49,700 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0006/
2016-05-18 01:18:56,440 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0006, with dag id: dag_1463534245563_0006_1
2016-05-18 01:19:02,984 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtComplete/everycomplete/tap/_temporary
2016-05-18 01:19:02,986 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtComplete/everycomplete/trap/_temporary
2016-05-18 01:19:02,989 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:13.587, using cpu time: 00:04.490
2016-05-18 01:19:03,060 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEveryAllAtComplete/everycomplete/tap
2016-05-18 01:19:03,069 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEveryAllAtComplete/everycomplete/trap
2016-05-18 01:19:03,132 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:19:03,132 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:19:03,180 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.019
2016-05-18 01:19:03,196 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.034
2016-05-18 01:19:03,196 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:19:03,197 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:19:03,197 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:19:03,308 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/7E59251BAE8E479BA212EDA5CEA9A01E/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:19:03,329 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:19:03,329 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:19:03,330 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapDiagnosticsLocalConfig/diagconfigdef/tap-nondeterministic"]
2016-05-18 01:19:03,330 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:19:03,330 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:19:03,330 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:19:03,331 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...gdef/tap-nondeterministic
2016-05-18 01:19:03,346 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:19:03,348 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:19:03,430 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:19:03,497 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0007
2016-05-18 01:19:03,498 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:19:03,510 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/7E59251BAE8E479BA212EDA5CEA9A01E/F609545CA2D14DA7AC111340801BE74A/.tez/application_1463534245563_0007 doesn't exist and is created
2016-05-18 01:19:03,552 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0007
2016-05-18 01:19:03,602 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0007, dagName=[7E59251BAE8E479BA212EDA5CEA9A01E/F609545CA2D14DA7AC111340801BE74A] trap test/(1/1) ...gdef/tap-nondeterministic
2016-05-18 01:19:03,608 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0007/
2016-05-18 01:19:04,835 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0006_01_000003
2016-05-18 01:19:04,869 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0006_01_000004
2016-05-18 01:19:08,071 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0006_01_000002 is : 143
2016-05-18 01:19:09,871 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0006
2016-05-18 01:19:10,851 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0007, with dag id: dag_1463534245563_0007_1
2016-05-18 01:19:18,510 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapDiagnosticsLocalConfig/diagconfigdef/tap-nondeterministic/_temporary
2016-05-18 01:19:18,512 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapDiagnosticsLocalConfig/diagconfigdef/trap-nondeterministic/_temporary
2016-05-18 01:19:18,516 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:15.179, using cpu time: 00:04.380
2016-05-18 01:19:18,587 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapDiagnosticsLocalConfig/diagconfigdef/trap-nondeterministic
2016-05-18 01:19:18,594 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapDiagnosticsLocalConfig/diagconfigdef/tap-nondeterministic
2016-05-18 01:19:18,631 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:19:18,631 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:19:18,673 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.015
2016-05-18 01:19:18,686 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.027
2016-05-18 01:19:18,686 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 01:19:18,687 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 01:19:18,687 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:19:18,718 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/E1020B440C0643D48EAB9875AA0CC83B/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:19:18,752 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:19:18,752 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:19:18,752 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAllChained/allchain/tap-nondeterministic"]
2016-05-18 01:19:18,753 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:19:18,753 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:19:18,753 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:19:18,754 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...hain/tap-nondeterministic
2016-05-18 01:19:18,768 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:19:18,770 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:19:18,847 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:19:18,919 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0008
2016-05-18 01:19:18,919 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:19:18,930 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/E1020B440C0643D48EAB9875AA0CC83B/C5D5E5DA593A42AE98268D3822CD83B9/.tez/application_1463534245563_0008 doesn't exist and is created
2016-05-18 01:19:18,969 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0008
2016-05-18 01:19:19,015 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0008, dagName=[E1020B440C0643D48EAB9875AA0CC83B/C5D5E5DA593A42AE98268D3822CD83B9] trap test/(1/1) ...hain/tap-nondeterministic
2016-05-18 01:19:19,020 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0008/
2016-05-18 01:19:19,876 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0007_01_000003
2016-05-18 01:19:19,938 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0007_01_000004
2016-05-18 01:19:20,028 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0007_01_000005
2016-05-18 01:19:23,539 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0007_01_000002 is : 143
2016-05-18 01:19:24,940 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0007
2016-05-18 01:19:25,808 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0008, with dag id: dag_1463534245563_0008_1
2016-05-18 01:19:32,423 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAllChained/allchain/tap-nondeterministic/_temporary
2016-05-18 01:19:32,425 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAllChained/allchain/trap-nondeterministic/_temporary
2016-05-18 01:19:32,427 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:13.666, using cpu time: 00:03.270
2016-05-18 01:19:32,506 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEachAllChained/allchain/tap-nondeterministic
2016-05-18 01:19:32,512 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEachAllChained/allchain/trap-nondeterministic
2016-05-18 01:19:32,545 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:19:32,545 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:19:32,590 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.014
2016-05-18 01:19:32,611 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.036
2016-05-18 01:19:32,612 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:19:32,613 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:19:32,613 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:19:32,712 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/5B1E4486898F468A8B0807B23D9C568D/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:19:32,731 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:19:32,731 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:19:32,731 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapToSequenceFile/seq/tap"]
2016-05-18 01:19:32,731 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:19:32,731 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:19:32,731 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:19:32,732 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...rapToSequenceFile/seq/tap
2016-05-18 01:19:32,747 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:19:32,749 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:19:32,832 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:19:32,897 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0009
2016-05-18 01:19:32,897 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:19:32,908 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/5B1E4486898F468A8B0807B23D9C568D/C08DCA44A2C74D6D902FB37DC91D1564/.tez/application_1463534245563_0009 doesn't exist and is created
2016-05-18 01:19:32,947 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0009
2016-05-18 01:19:33,001 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0009, dagName=[5B1E4486898F468A8B0807B23D9C568D/C08DCA44A2C74D6D902FB37DC91D1564] trap test/(1/1) ...rapToSequenceFile/seq/tap
2016-05-18 01:19:33,206 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0009/
2016-05-18 01:19:37,513 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0008_01_000002 is : 143
2016-05-18 01:19:39,946 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0009, with dag id: dag_1463534245563_0009_1
2016-05-18 01:19:46,306 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapToSequenceFile/seq/tap/_temporary
2016-05-18 01:19:46,308 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapToSequenceFile/seq/trap/_temporary
2016-05-18 01:19:46,310 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:13.572, using cpu time: 00:04.110
2016-05-18 01:19:46,418 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapToSequenceFile/seq/tap
2016-05-18 01:19:46,427 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapToSequenceFile/seq/trap
2016-05-18 01:19:46,475 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:19:46,475 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:19:46,515 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.009
2016-05-18 01:19:46,530 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.024
2016-05-18 01:19:46,531 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 01:19:46,531 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 01:19:46,531 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:19:46,572 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/9B4114A405514B0F8E9341D658B9C54A/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:19:46,590 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting
2016-05-18 01:19:46,590 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] source: Hfs["TextDelimited[['id', 'name' | int, String]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/delimited-problematic.txt"]
2016-05-18 01:19:46,590 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] sink: Hfs["TextDelimited[['id', 'name' | int, String]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapNoOperation/testTrapNoOperation"]
2016-05-18 01:19:46,590 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] parallel execution of steps is enabled: true
2016-05-18 01:19:46,591 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executing total steps: 1
2016-05-18 01:19:46,591 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] allocating management threads: 1
2016-05-18 01:19:46,592 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting step: (1/1) ...ation/testTrapNoOperation
2016-05-18 01:19:46,607 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] tez session mode enabled: false
2016-05-18 01:19:46,609 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:19:46,690 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:19:46,761 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0010
2016-05-18 01:19:46,762 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:19:46,773 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/9B4114A405514B0F8E9341D658B9C54A/B1BDBC8BAB314FEFB85F56CF4044BB80/.tez/application_1463534245563_0010 doesn't exist and is created
2016-05-18 01:19:46,813 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0010
2016-05-18 01:19:46,857 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0010, dagName=[9B4114A405514B0F8E9341D658B9C54A/B1BDBC8BAB314FEFB85F56CF4044BB80] null/(1/1) ...ation/testTrapNoOperation
2016-05-18 01:19:47,062 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0010/
2016-05-18 01:19:48,070 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0009_01_000003
2016-05-18 01:19:51,403 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0009_01_000002 is : 143
2016-05-18 01:19:53,786 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] submitted tez dag to app master: application_1463534245563_0010, with dag id: dag_1463534245563_0010_1
2016-05-18 01:20:00,230 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapNoOperation/testTrapNoOperation/_temporary
2016-05-18 01:20:00,232 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapNoOperation/testTrapNoOperation_trap/_temporary
2016-05-18 01:20:00,234 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] completed in: 00:13.638, using cpu time: 00:03.240
2016-05-18 01:20:00,266 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapNoOperation/testTrapNoOperation_trap
2016-05-18 01:20:00,272 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapNoOperation/testTrapNoOperation
2016-05-18 01:20:00,326 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:20:00,326 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:20:00,379 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.024
2016-05-18 01:20:00,384 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.029
2016-05-18 01:20:00,385 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:20:00,385 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:20:00,385 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:20:00,471 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/99C6D46AD70C410FA2A2E1CAA74AC076/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:20:00,493 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:20:00,493 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:20:00,493 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapDiagnostics/diag/tap-nondeterministic"]
2016-05-18 01:20:00,494 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:20:00,494 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:20:00,494 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:20:00,495 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...diag/tap-nondeterministic
2016-05-18 01:20:00,509 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:20:00,511 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:20:00,593 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:20:00,664 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0011
2016-05-18 01:20:00,665 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:20:00,675 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/99C6D46AD70C410FA2A2E1CAA74AC076/FF2E83A1DC3B4C9DB83E092A4033C769/.tez/application_1463534245563_0011 doesn't exist and is created
2016-05-18 01:20:00,715 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0011
2016-05-18 01:20:00,761 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0011, dagName=[99C6D46AD70C410FA2A2E1CAA74AC076/FF2E83A1DC3B4C9DB83E092A4033C769] trap test/(1/1) ...diag/tap-nondeterministic
2016-05-18 01:20:00,966 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0011/
2016-05-18 01:20:05,279 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0010_01_000002 is : 143
2016-05-18 01:20:07,782 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0011, with dag id: dag_1463534245563_0011_1
2016-05-18 01:20:14,420 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapDiagnostics/diag/tap-nondeterministic/_temporary
2016-05-18 01:20:14,422 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapDiagnostics/diag/trap-nondeterministic/_temporary
2016-05-18 01:20:14,426 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:13.925, using cpu time: 00:04.570
2016-05-18 01:20:14,511 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapDiagnostics/diag/tap-nondeterministic
2016-05-18 01:20:14,518 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapDiagnostics/diag/trap-nondeterministic
2016-05-18 01:20:14,552 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:20:14,553 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:20:14,612 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.019
2016-05-18 01:20:14,624 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.032
2016-05-18 01:20:14,625 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:20:14,625 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:20:14,626 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:20:14,705 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/4E81565AEA5E4E4CBC0BDF9BC637F573/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:20:14,723 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:20:14,723 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:20:14,724 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtStart/everystart/tap"]
2016-05-18 01:20:14,724 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:20:14,724 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:20:14,724 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:20:14,725 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...AllAtStart/everystart/tap
2016-05-18 01:20:14,739 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:20:14,741 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:20:14,820 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:20:14,891 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0012
2016-05-18 01:20:14,891 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:20:14,904 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/4E81565AEA5E4E4CBC0BDF9BC637F573/C97FFA3CBCAE443CB511966A9AA9D84C/.tez/application_1463534245563_0012 doesn't exist and is created
2016-05-18 01:20:14,943 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0012
2016-05-18 01:20:14,987 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0012, dagName=[4E81565AEA5E4E4CBC0BDF9BC637F573/C97FFA3CBCAE443CB511966A9AA9D84C] trap test/(1/1) ...AllAtStart/everystart/tap
2016-05-18 01:20:15,193 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0012/
2016-05-18 01:20:16,254 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0011_01_000003
2016-05-18 01:20:16,363 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0011_01_000004
2016-05-18 01:20:19,508 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0011_01_000002 is : 143
2016-05-18 01:20:21,366 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0011
2016-05-18 01:20:21,922 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0012, with dag id: dag_1463534245563_0012_1
2016-05-18 01:20:29,878 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtStart/everystart/tap/_temporary
2016-05-18 01:20:29,880 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEveryAllAtStart/everystart/trap/_temporary
2016-05-18 01:20:29,883 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:15.153, using cpu time: 00:04.520
2016-05-18 01:20:29,964 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEveryAllAtStart/everystart/tap
2016-05-18 01:20:29,972 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEveryAllAtStart/everystart/trap
2016-05-18 01:20:30,026 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:20:30,026 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:20:30,073 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.013
2016-05-18 01:20:30,087 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.027
2016-05-18 01:20:30,088 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:20:30,088 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:20:30,089 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:20:30,165 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/3F29A8C850C34EC8AB62F3F8FFEF8B9B/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:20:30,187 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:20:30,188 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:20:30,188 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapNone/none/tap"]
2016-05-18 01:20:30,188 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:20:30,188 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:20:30,188 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:20:30,191 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...orm/testTrapNone/none/tap
2016-05-18 01:20:30,213 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:20:30,216 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:20:30,301 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:20:30,363 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0013
2016-05-18 01:20:30,363 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:20:30,374 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/3F29A8C850C34EC8AB62F3F8FFEF8B9B/A891BEB01D7641CA94DFBB07D0FBAE2B/.tez/application_1463534245563_0013 doesn't exist and is created
2016-05-18 01:20:30,411 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0013
2016-05-18 01:20:30,454 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0013, dagName=[3F29A8C850C34EC8AB62F3F8FFEF8B9B/A891BEB01D7641CA94DFBB07D0FBAE2B] trap test/(1/1) ...orm/testTrapNone/none/tap
2016-05-18 01:20:30,459 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0013/
2016-05-18 01:20:31,373 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0012_01_000003
2016-05-18 01:20:31,454 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0012_01_000004
2016-05-18 01:20:31,463 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0012_01_000005
2016-05-18 01:20:34,922 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0012_01_000002 is : 143
2016-05-18 01:20:35,464 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1096)) - Event EventType: FINISH_APPLICATION sent to absent application application_1463534245563_0012
2016-05-18 01:20:37,192 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0013, with dag id: dag_1463534245563_0013_1
2016-05-18 01:20:44,706 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapNone/none/tap/_temporary
2016-05-18 01:20:44,709 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:14.517, using cpu time: 00:04.340
2016-05-18 01:20:44,774 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapNone/none/trap
2016-05-18 01:20:44,774 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapNone/none/tap
2016-05-18 01:20:44,813 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 01:20:44,813 INFO planner.Hadoop2TezPlanner (Hadoop2TezPlanner.java:initialize(151)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:20:44,875 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: NoHashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.023
2016-05-18 01:20:44,883 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executed rule registry: HashJoinHadoop2TezRuleRegistry, completed as: SUCCESS, in: 00:00.031
2016-05-18 01:20:44,883 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:20:44,884 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: HashJoinHadoop2TezRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 01:20:44,884 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] rule registry: NoHashJoinHadoop2TezRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 01:20:44,964 INFO util.HadoopUtil (HadoopUtil.java:syncPaths(556)) - copying from: file:/opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-tez/3.1.0/226af02e24d5195c60e4ebe911d0c7c9780f59f0/cascading-hadoop2-tez-3.1.0.jar, to: hdfs://localhost:35099/user/teamcity/.staging/507A02CC7E5848768109960F510E8010/cascading-hadoop2-tez-3.1.0.jar
2016-05-18 01:20:44,987 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting
2016-05-18 01:20:44,988 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/classes/test/data/apache.10.txt"]
2016-05-18 01:20:44,988 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] sink: Hfs["TextDelimited[['ip', 'count']]"]["/opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAllSequence/allseq/tap"]
2016-05-18 01:20:44,988 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] parallel execution of steps is enabled: true
2016-05-18 01:20:44,988 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] executing total steps: 1
2016-05-18 01:20:44,988 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] allocating management threads: 1
2016-05-18 01:20:44,989 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] starting step: (1/1) ...achAllSequence/allseq/tap
2016-05-18 01:20:45,005 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] tez session mode enabled: false
2016-05-18 01:20:45,008 INFO client.TezClient (TezClient.java:<init>(174)) - Tez Client Version: [ component=tez-api, version=0.8.2, revision=2d46dcefa492a6957cfa972007039f7e188760ce, SCM-URL=scm:git:https://git-wip-us.apache.org/repos/asf/tez.git, buildTime=20160112-1834 ]
2016-05-18 01:20:45,089 INFO client.TezClient (TezClient.java:start(354)) - Using org.apache.tez.dag.history.ats.acls.ATSHistoryACLPolicyManager to manage Timeline ACLs
2016-05-18 01:20:45,158 INFO client.TezClient (TezClient.java:submitDAGApplication(861)) - Submitting DAG application with id: application_1463534245563_0014
2016-05-18 01:20:45,158 INFO client.TezClientUtils (TezClientUtils.java:setupTezJarsLocalResources(176)) - Using tez.lib.uris value from configuration: hdfs://localhost:35099/user/teamcity/target/cascading.platform.tez.Hadoop2TezPlatform-tmpDir/TezAppJar.jar
2016-05-18 01:20:45,168 INFO client.TezClient (TezCommonUtils.java:createTezSystemStagingPath(122)) - Tez system stage directory hdfs://localhost:35099/user/teamcity/.staging/507A02CC7E5848768109960F510E8010/DEB416649A54467687AE69733D63A47E/.tez/application_1463534245563_0014 doesn't exist and is created
2016-05-18 01:20:45,218 INFO acls.ATSHistoryACLPolicyManager (ATSHistoryACLPolicyManager.java:createSessionDomain(166)) - Created Timeline Domain for History ACLs, domainId=Tez_ATS_application_1463534245563_0014
2016-05-18 01:20:45,269 INFO client.TezClient (TezClient.java:submitDAGApplication(887)) - Submitting DAG to YARN, applicationId=application_1463534245563_0014, dagName=[507A02CC7E5848768109960F510E8010/DEB416649A54467687AE69733D63A47E] trap test/(1/1) ...achAllSequence/allseq/tap
2016-05-18 01:20:45,274 INFO client.TezClient (TezClient.java:submitDAGApplication(894)) - The url to track the Tez AM: http://ip-10-123-148-208:47047/proxy/application_1463534245563_0014/
2016-05-18 01:20:46,467 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0013_01_000003
2016-05-18 01:20:46,468 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(1080)) - Event EventType: KILL_CONTAINER sent to absent container container_1463534245563_0013_01_000004
2016-05-18 01:20:49,741 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(224)) - Exit code from container container_1463534245563_0013_01_000002 is : 143
2016-05-18 01:20:51,981 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] submitted tez dag to app master: application_1463534245563_0014, with dag id: dag_1463534245563_0014_1
2016-05-18 01:20:59,934 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAllSequence/allseq/tap/_temporary
2016-05-18 01:20:59,937 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output/hadoop2-tez/trapplatform/testTrapEachAllSequence/allseq/trap/_temporary
2016-05-18 01:20:59,939 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [trap test] completed in: 00:14.945, using cpu time: 00:04.370
2016-05-18 01:21:00,011 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEachAllSequence/allseq/trap
2016-05-18 01:21:00,016 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/2f4c45215847827d/apache-2.7.x-tez-0.8.x/build/test/output//hadoop2-tez/trapplatform/testTrapEachAllSequence/allseq/tap