2015-08-14 01:46:19,428 INFO platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(187)) - found 1 test platforms from classpath
2015-08-14 01:46:19,495 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(237)) - installing platform: hadoop2-mr1
2015-08-14 01:46:19,495 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(238)) - running test: cascading.UnmodifiablePipesPlatformTest
2015-08-14 01:46:19,530 INFO hadoop2.Hadoop2MR1Platform (Hadoop2MR1Platform.java:setUp(105)) - not using cluster
2015-08-14 01:46:20,178 WARN util.NativeCodeLoader (NativeCodeLoader.java:<clinit>(62)) - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
2015-08-14 01:46:20,315 INFO platform.TestPlatform (TestPlatform.java:getGlobalProperties(72)) - platform property overrides:
2015-08-14 01:46:20,466 INFO util.HadoopUtil (HadoopUtil.java:findMainClass(336)) - using default application jar, may cause class not found exceptions on the cluster
2015-08-14 01:46:20,468 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(226)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/2.7.1/78a07fbd83388056abdb4b5e48f666735b06cf7c/cascading-hadoop2-mr1-2.7.1.jar
2015-08-14 01:46:20,482 INFO property.AppProps (AppProps.java:getAppID(169)) - using app.id: AAB8E448153F4CB08DAD179EFBF781EC
2015-08-14 01:46:20,806 INFO util.Version (Version.java:printBanner(85)) - Concurrent, Inc - Cascading 2.7.1
2015-08-14 01:46:20,808 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [test] starting
2015-08-14 01:46:20,809 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [test] source: Hfs["TextDelimited[['lhs', 'rhs']]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/classes/test/data/lhs.txt"]
2015-08-14 01:46:20,810 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [test] sink: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/output/hadoop2-mr1/unmodifiablepipesplatform/simple"]
2015-08-14 01:46:20,810 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [test] parallel execution is enabled: false
2015-08-14 01:46:20,811 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [test] starting jobs: 2
2015-08-14 01:46:20,811 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [test] allocating threads: 1
2015-08-14 01:46:20,815 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [test] starting step: (1/2)
2015-08-14 01:46:21,494 WARN conf.Configuration (Configuration.java:loadProperty(2172)) - file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/tmp/mapred/staging/teamcity1111697699/.staging/job_local1111697699_0001/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2015-08-14 01:46:21,511 WARN conf.Configuration (Configuration.java:loadProperty(2172)) - file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/tmp/mapred/staging/teamcity1111697699/.staging/job_local1111697699_0001/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2015-08-14 01:46:21,636 WARN conf.Configuration (Configuration.java:loadProperty(2172)) - file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local1111697699_0001/job_local1111697699_0001.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2015-08-14 01:46:21,637 WARN conf.Configuration (Configuration.java:loadProperty(2172)) - file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local1111697699_0001/job_local1111697699_0001.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2015-08-14 01:46:21,652 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [test] submitted hadoop job: job_local1111697699_0001
2015-08-14 01:46:21,653 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [test] tracking url: http://localhost:8080/
2015-08-14 01:46:21,743 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/classes/test/data/lhs.txt
2015-08-14 01:46:21,934 INFO hadoop.FlowMapper (FlowMapper.java:configure(71)) - cascading version: 2.7.1
2015-08-14 01:46:21,935 INFO hadoop.FlowMapper (FlowMapper.java:configure(72)) - child jvm opts: -Xmx200m
2015-08-14 01:46:21,997 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - sourcing from: Hfs["TextDelimited[['lhs', 'rhs']]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/classes/test/data/lhs.txt"]
2015-08-14 01:46:21,998 INFO hadoop.FlowMapper (FlowMapper.java:configure(90)) - sinking to: GroupBy(test)[by:[{1}:'lhs']]
2015-08-14 01:46:22,071 INFO hadoop.FlowReducer (FlowReducer.java:configure(78)) - cascading version: 2.7.1
2015-08-14 01:46:22,072 INFO hadoop.FlowReducer (FlowReducer.java:configure(79)) - child jvm opts: -Xmx200m
2015-08-14 01:46:22,091 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - sourcing from: GroupBy(test)[by:[{1}:'lhs']]
2015-08-14 01:46:22,092 INFO hadoop.FlowReducer (FlowReducer.java:configure(100)) - sinking to: TempHfs["SequenceFile[['lhs', 'rhs']]"][3439154542/test/]
2015-08-14 01:46:22,222 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [test] starting step: (2/2) ...iablepipesplatform/simple
2015-08-14 01:46:22,362 WARN conf.Configuration (Configuration.java:loadProperty(2172)) - file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/tmp/mapred/staging/teamcity487501388/.staging/job_local487501388_0002/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2015-08-14 01:46:22,368 WARN conf.Configuration (Configuration.java:loadProperty(2172)) - file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/tmp/mapred/staging/teamcity487501388/.staging/job_local487501388_0002/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2015-08-14 01:46:22,440 WARN conf.Configuration (Configuration.java:loadProperty(2172)) - file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local487501388_0002/job_local487501388_0002.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2015-08-14 01:46:22,441 WARN conf.Configuration (Configuration.java:loadProperty(2172)) - file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local487501388_0002/job_local487501388_0002.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2015-08-14 01:46:22,443 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [test] submitted hadoop job: job_local487501388_0002
2015-08-14 01:46:22,444 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [test] tracking url: http://localhost:8080/
2015-08-14 01:46:22,453 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/tmp/hadoop-teamcity/3439154542_test_E90732D1D97E4F7CBA76D46B2EAC1B8B/part-00000
2015-08-14 01:46:22,610 INFO hadoop.FlowMapper (FlowMapper.java:configure(71)) - cascading version: 2.7.1
2015-08-14 01:46:22,611 INFO hadoop.FlowMapper (FlowMapper.java:configure(72)) - child jvm opts: -Xmx200m
2015-08-14 01:46:22,624 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - sourcing from: TempHfs["SequenceFile[['lhs', 'rhs']]"][3439154542/test/]
2015-08-14 01:46:22,625 INFO hadoop.FlowMapper (FlowMapper.java:configure(90)) - sinking to: GroupBy(test)[by:[{1}:'lhs']]
2015-08-14 01:46:22,648 INFO hadoop.FlowReducer (FlowReducer.java:configure(78)) - cascading version: 2.7.1
2015-08-14 01:46:22,648 INFO hadoop.FlowReducer (FlowReducer.java:configure(79)) - child jvm opts: -Xmx200m
2015-08-14 01:46:22,661 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - sourcing from: GroupBy(test)[by:[{1}:'lhs']]
2015-08-14 01:46:22,661 INFO hadoop.FlowReducer (FlowReducer.java:configure(100)) - sinking to: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/output/hadoop2-mr1/unmodifiablepipesplatform/simple"]
2015-08-14 01:46:22,726 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(219)) - deleting temp path /opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/output/hadoop2-mr1/unmodifiablepipesplatform/simple/_temporary
2015-08-14 01:46:22,771 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(209)) - copying to local /opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-2.2.x/build/test/output//hadoop2-mr1/unmodifiablepipesplatform/simple