2016-05-18 05:52:49,280 INFO platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(197)) - found 1 test platforms from classpath
2016-05-18 05:52:49,301 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(246)) - adding test: cascading.tap.TapPlatformTest, with platform: hadoop2-mr1
2016-05-18 05:52:49,324 INFO hadoop2.Hadoop2MR1Platform (Hadoop2MR1Platform.java:setUp(136)) - using cluster
2016-05-18 05:52:50,060 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 05:52:50,691 WARN impl.MetricsConfig (MetricsConfig.java:loadFirst(124)) - Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
2016-05-18 05:52:51,334 WARN server.AuthenticationFilter (AuthenticationFilter.java:init(166)) - 'signature.secret' configuration not set, using a random value as secret
2016-05-18 05:52:54,440 WARN containermanager.AuxServices (AuxServices.java:serviceInit(130)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class 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 05:52:54,585 WARN containermanager.AuxServices (AuxServices.java:serviceInit(130)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class 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 05:52:54,700 WARN containermanager.AuxServices (AuxServices.java:serviceInit(130)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class 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 05:52:54,815 WARN containermanager.AuxServices (AuxServices.java:serviceInit(130)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class 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 05:53:06,686 WARN server.AuthenticationFilter (AuthenticationFilter.java:init(166)) - 'signature.secret' configuration not set, using a random value as secret
2016-05-18 05:53:07,679 WARN server.AuthenticationFilter (AuthenticationFilter.java:init(166)) - 'signature.secret' configuration not set, using a random value as secret
2016-05-18 05:53:07,680 WARN server.AuthenticationFilter (AuthenticationFilter.java:init(166)) - 'signature.secret' configuration not set, using a random value as secret
2016-05-18 05:53:11,892 INFO platform.TestPlatform (TestPlatform.java:getGlobalProperties(75)) - platform property overrides:
2016-05-18 05:53:11,994 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 05:53:11,996 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 05:53:12,068 INFO property.AppProps (AppProps.java:getAppID(177)) - using app.id: 7D5319C6F8AB4B1BB8ADD6B1CEE951BE
2016-05-18 05:53:12,176 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.068
2016-05-18 05:53:12,179 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 05:53:12,180 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 05:53:12,298 INFO util.Version (Version.java:printBanner(82)) - Concurrent, Inc - Cascading 3.1.0
2016-05-18 05:53:12,300 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] starting
2016-05-18 05:53:12,300 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] source: Hfs["TextDelimited[['number', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/classes/test/data/lhs+rhs-cross-x2.txt"]
2016-05-18 05:53:12,301 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] sink: PartitionTap["Hfs["TextDelimited[['upper']]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testPartitionTapTextDelimited/partitioned"]"]["cascading.tap.partition.DelimitedPartition@cffa3bd"]["[]"]
2016-05-18 05:53:12,303 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] parallel execution of steps is enabled: true
2016-05-18 05:53:12,303 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] executing total steps: 1
2016-05-18 05:53:12,303 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] allocating management threads: 1
2016-05-18 05:53:12,304 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] starting step: (1/1) ...TextDelimited/partitioned
2016-05-18 05:53:13,241 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] submitted hadoop job: job_1463550786390_0001
2016-05-18 05:53:13,241 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] tracking url: http://ip-10-158-37-203:47355/proxy/application_1463550786390_0001/
2016-05-18 05:53:30,033 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0001_01_000003 is : 143
2016-05-18 05:53:30,380 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0001_01_000005 is : 143
2016-05-18 05:53:30,577 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0001_01_000002 is : 143
2016-05-18 05:53:30,726 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0001_01_000004 is : 143
2016-05-18 05:53:32,012 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testPartitionTapTextDelimited/partitioned/_temporary
2016-05-18 05:53:32,015 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [partition] completed in: 00:19.704, using cpu time: 00:05.310
2016-05-18 05:53:32,033 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 05:53:32,034 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 05:53:32,075 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.035
2016-05-18 05:53:32,077 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 05:53:32,077 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 05:53:32,115 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] starting
2016-05-18 05:53:32,115 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] source: PartitionTap["Hfs["TextDelimited[['upper']]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testPartitionTapTextDelimited/partitioned"]"]["cascading.tap.partition.DelimitedPartition@cffa3bd"]["[]"]
2016-05-18 05:53:32,115 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] sink: Hfs["TextDelimited[['number', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testPartitionTapTextDelimited/final"]
2016-05-18 05:53:32,116 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] parallel execution of steps is enabled: true
2016-05-18 05:53:32,116 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] executing total steps: 1
2016-05-18 05:53:32,116 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] allocating management threads: 1
2016-05-18 05:53:32,117 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] starting step: (1/1) ...ionTapTextDelimited/final
2016-05-18 05:53:32,375 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] submitted hadoop job: job_1463550786390_0002
2016-05-18 05:53:32,375 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] tracking url: http://ip-10-158-37-203:47355/proxy/application_1463550786390_0002/
2016-05-18 05:54:08,607 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000002 is : 143
2016-05-18 05:54:14,449 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000006 is : 143
2016-05-18 05:54:15,019 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000011 is : 143
2016-05-18 05:54:15,131 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000015 is : 143
2016-05-18 05:54:15,357 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000009 is : 143
2016-05-18 05:54:15,409 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000014 is : 143
2016-05-18 05:54:15,494 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000007 is : 143
2016-05-18 05:54:15,681 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000012 is : 143
2016-05-18 05:54:19,456 WARN containermanager.ContainerManagerImpl (ContainerManagerImpl.java:handle(842)) - Event EventType: KILL_CONTAINER sent to absent container container_1463550786390_0002_01_000028
2016-05-18 05:54:37,892 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000017 is : 143
2016-05-18 05:54:43,444 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000019 is : 143
2016-05-18 05:54:43,479 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000018 is : 143
2016-05-18 05:54:43,620 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000025 is : 143
2016-05-18 05:54:43,676 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000022 is : 143
2016-05-18 05:54:43,723 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000021 is : 143
2016-05-18 05:54:43,843 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000024 is : 143
2016-05-18 05:54:43,877 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000026 is : 143
2016-05-18 05:54:44,009 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0002_01_000027 is : 143
2016-05-18 05:54:45,342 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testPartitionTapTextDelimited/final/_temporary
2016-05-18 05:54:45,345 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [copy] completed in: 01:13.226, using cpu time: 00:30.560
2016-05-18 05:54:45,829 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testPartitionTapTextDelimited/final
2016-05-18 05:54:45,889 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testPartitionTapTextDelimited/partitioned
2016-05-18 05:54:46,058 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 05:54:46,058 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 05:54:46,118 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.055
2016-05-18 05:54:46,119 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 05:54:46,120 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 05:54:46,153 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting
2016-05-18 05:54:46,153 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/classes/test/data/lhs.txt"]
2016-05-18 05:54:46,153 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] sink: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testSideFileCollector/sidefile/direct"]
2016-05-18 05:54:46,154 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] parallel execution of steps is enabled: true
2016-05-18 05:54:46,154 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executing total steps: 1
2016-05-18 05:54:46,154 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] allocating management threads: 1
2016-05-18 05:54:46,155 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (1/1) ...Collector/sidefile/direct
2016-05-18 05:54:46,299 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463550786390_0003
2016-05-18 05:54:46,299 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203:47355/proxy/application_1463550786390_0003/
2016-05-18 05:55:02,450 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0003_01_000002 is : 143
2016-05-18 05:55:02,707 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0003_01_000003 is : 143
2016-05-18 05:55:02,762 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0003_01_000005 is : 143
2016-05-18 05:55:02,937 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0003_01_000004 is : 143
2016-05-18 05:55:09,428 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0003_01_000006 is : 143
2016-05-18 05:55:10,674 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testSideFileCollector/sidefile/direct/_temporary
2016-05-18 05:55:10,676 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] completed in: 00:24.518, using cpu time: 00:05.630
2016-05-18 05:55:10,726 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testSideFileCollector/sidefile/direct
2016-05-18 05:55:10,731 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testSideFileCollector/sidefile/indirect
2016-05-18 05:55:10,766 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 05:55:10,767 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 05:55:10,800 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.028
2016-05-18 05:55:10,802 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 05:55:10,802 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 05:55:10,813 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting
2016-05-18 05:55:10,814 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/classes/test/data/unexpectedEndOfFile.gz"]
2016-05-18 05:55:10,814 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testTupleEntrySchemeIteratorExceptionHandling/testTupleEntrySchemeIteratorExceptionHandling"]
2016-05-18 05:55:10,814 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] parallel execution of steps is enabled: true
2016-05-18 05:55:10,814 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executing total steps: 1
2016-05-18 05:55:10,814 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] allocating management threads: 1
2016-05-18 05:55:10,815 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting step: (1/1) ...IteratorExceptionHandling
2016-05-18 05:55:10,976 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] submitted hadoop job: job_1463550786390_0004
2016-05-18 05:55:10,976 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] tracking url: http://ip-10-158-37-203:47355/proxy/application_1463550786390_0004/
2016-05-18 05:55:21,680 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0004_01_000002 is : 143
2016-05-18 05:55:22,918 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testTupleEntrySchemeIteratorExceptionHandling/testTupleEntrySchemeIteratorExceptionHandling/_temporary
2016-05-18 05:55:22,920 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] completed in: 00:12.098, using cpu time: 00:00.850
2016-05-18 05:55:22,942 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testTupleEntrySchemeIteratorExceptionHandling/testTupleEntrySchemeIteratorExceptionHandling
2016-05-18 05:55:22,974 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 05:55:22,975 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 05:55:23,008 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.030
2016-05-18 05:55:23,009 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 05:55:23,010 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 05:55:23,020 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting
2016-05-18 05:55:23,021 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-05-18 05:55:23,021 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] sink: Hfs["TextLine[['line']->['second', 'first', 'third']]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testSinkDeclaredFields/declaredsinks"]
2016-05-18 05:55:23,021 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] parallel execution of steps is enabled: true
2016-05-18 05:55:23,022 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executing total steps: 1
2016-05-18 05:55:23,022 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] allocating management threads: 1
2016-05-18 05:55:23,023 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (1/1) ...laredFields/declaredsinks
2016-05-18 05:55:23,212 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463550786390_0005
2016-05-18 05:55:23,213 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203:47355/proxy/application_1463550786390_0005/
2016-05-18 05:55:38,925 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0005_01_000003 is : 143
2016-05-18 05:55:39,196 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0005_01_000002 is : 143
2016-05-18 05:55:39,441 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0005_01_000004 is : 143
2016-05-18 05:55:39,660 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0005_01_000005 is : 143
2016-05-18 05:55:40,882 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testSinkDeclaredFields/declaredsinks/_temporary
2016-05-18 05:55:40,883 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] completed in: 00:17.860, using cpu time: 00:04.110
2016-05-18 05:55:40,936 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testSinkDeclaredFields/declaredsinks
2016-05-18 05:55:40,979 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 05:55:40,979 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 05:55:41,020 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.037
2016-05-18 05:55:41,022 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 05:55:41,022 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 05:55:41,037 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting
2016-05-18 05:55:41,038 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/classes/test/data/lower+upper.txt"]
2016-05-18 05:55:41,039 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] sink: MultiSinkTap[[Hfs["TextLine[['offset', 'line']->['number', 'lower']]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testMultiSinkTap/multisink/lhs"], Hfs["TextLine[['offset', 'line']->['number', 'upper']]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testMultiSinkTap/multisink/rhs"]]]
2016-05-18 05:55:41,039 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] parallel execution of steps is enabled: true
2016-05-18 05:55:41,040 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executing total steps: 1
2016-05-18 05:55:41,040 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] allocating management threads: 1
2016-05-18 05:55:41,041 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (1/1) ...954CE4DB4A60AEC8C25C71846
2016-05-18 05:55:41,181 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463550786390_0006
2016-05-18 05:55:41,181 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203:47355/proxy/application_1463550786390_0006/
2016-05-18 05:55:59,461 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0006_01_000005 is : 143
2016-05-18 05:55:59,897 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0006_01_000006 is : 143
2016-05-18 05:56:00,011 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0006_01_000002 is : 143
2016-05-18 05:56:00,193 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0006_01_000003 is : 143
2016-05-18 05:56:00,315 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0006_01_000004 is : 143
2016-05-18 05:56:01,543 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] completed in: 00:20.502, using cpu time: 00:05.750
2016-05-18 05:56:01,588 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testMultiSinkTap/multisink/rhs
2016-05-18 05:56:01,600 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testMultiSinkTap/multisink/lhs
2016-05-18 05:56:01,623 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 05:56:01,624 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 05:56:01,652 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.025
2016-05-18 05:56:01,653 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 05:56:01,653 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 05:56:01,664 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting
2016-05-18 05:56:01,664 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-05-18 05:56:01,664 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] sink: Hfs["TextDelimited[['first', 'second', 'third']]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testSinkUnknown/unknownsinks"]
2016-05-18 05:56:01,665 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] parallel execution of steps is enabled: true
2016-05-18 05:56:01,665 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executing total steps: 1
2016-05-18 05:56:01,665 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] allocating management threads: 1
2016-05-18 05:56:01,666 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (1/1) ...tSinkUnknown/unknownsinks
2016-05-18 05:56:01,807 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463550786390_0007
2016-05-18 05:56:01,807 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203:47355/proxy/application_1463550786390_0007/
2016-05-18 05:56:17,674 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0007_01_000003 is : 143
2016-05-18 05:56:17,904 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0007_01_000002 is : 143
2016-05-18 05:56:18,082 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0007_01_000004 is : 143
2016-05-18 05:56:18,845 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0007_01_000005 is : 143
2016-05-18 05:56:20,065 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testSinkUnknown/unknownsinks/_temporary
2016-05-18 05:56:20,066 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] completed in: 00:18.399, using cpu time: 00:04.280
2016-05-18 05:56:20,106 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testSinkUnknown/unknownsinks
2016-05-18 05:56:20,133 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 05:56:20,134 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 05:56:20,161 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.024
2016-05-18 05:56:20,162 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 05:56:20,162 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 05:56:20,171 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting
2016-05-18 05:56:20,172 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/classes/test/data/unexpectedEndOfFile.gz"]
2016-05-18 05:56:20,172 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testTupleEntrySchemeIteratorEOFException/testTupleEntrySchemeIteratorEOFException"]
2016-05-18 05:56:20,172 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] parallel execution of steps is enabled: true
2016-05-18 05:56:20,172 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executing total steps: 1
2016-05-18 05:56:20,173 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] allocating management threads: 1
2016-05-18 05:56:20,174 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting step: (1/1) ...chemeIteratorEOFException
2016-05-18 05:56:20,306 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] submitted hadoop job: job_1463550786390_0008
2016-05-18 05:56:20,306 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] tracking url: http://ip-10-158-37-203:47355/proxy/application_1463550786390_0008/
2016-05-18 05:56:30,737 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0008_01_000002 is : 143
2016-05-18 05:56:35,719 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0008_01_000003 is : 143
2016-05-18 05:56:40,793 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0008_01_000004 is : 143
2016-05-18 05:56:45,701 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463550786390_0008_01_000005 is : 143
2016-05-18 05:56:46,817 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [] hadoop job job_1463550786390_0008 state at FAILED
2016-05-18 05:56:46,818 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [] failure info: Task failed task_1463550786390_0008_m_000000
Job failed as tasks failed. failedMaps:1 failedReduces:0
2016-05-18 05:56:46,842 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [] task completion events identify failed tasks
2016-05-18 05:56:46,842 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [] task completion events count: 4
2016-05-18 05:56:46,842 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [] event = Task Id : attempt_1463550786390_0008_m_000000_0, Status : FAILED
2016-05-18 05:56:46,842 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [] event = Task Id : attempt_1463550786390_0008_m_000000_1, Status : FAILED
2016-05-18 05:56:46,843 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [] event = Task Id : attempt_1463550786390_0008_m_000000_2, Status : FAILED
2016-05-18 05:56:46,843 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [] event = Task Id : attempt_1463550786390_0008_m_000000_3, Status : TIPFAILED
2016-05-18 05:56:46,870 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] stopping all jobs
2016-05-18 05:56:46,871 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] stopping: (1/1) ...chemeIteratorEOFException
2016-05-18 05:56:46,873 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] stopped all jobs
2016-05-18 05:56:46,875 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output/hadoop2-mr1/tapplatform/testTupleEntrySchemeIteratorEOFException/testTupleEntrySchemeIteratorEOFException/_temporary
2016-05-18 05:56:46,877 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] completed in: 00:26.702
2016-05-18 05:56:46,877 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.5.x/build/test/output//hadoop2-mr1/tapplatform/testTupleEntrySchemeIteratorEOFException/testTupleEntrySchemeIteratorEOFException