2016-05-18 00:56:53,358 INFO platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(197)) - found 1 test platforms from classpath
2016-05-18 00:56:53,387 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(246)) - adding test: cascading.function.FunctionPlatformTest, with platform: hadoop2-mr1
2016-05-18 00:56:53,419 INFO hadoop2.Hadoop2MR1Platform (Hadoop2MR1Platform.java:setUp(119)) - not using cluster
2016-05-18 00:56:53,968 WARN util.NativeCodeLoader (NativeCodeLoader.java:<clinit>(62)) - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
2016-05-18 00:56:54,143 INFO platform.TestPlatform (TestPlatform.java:getGlobalProperties(75)) - platform property overrides:
2016-05-18 00:56:54,184 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(105)) - flushed keys num times: 1, with capacity: 2
2016-05-18 00:56:54,185 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(106)) - mem on flush (mb), free: 203, total: 223, max: 672
2016-05-18 00:56:54,185 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(111)) - total mem is 33% of max mem, to better utilize unused memory consider increasing the cache size
2016-05-18 00:56:54,185 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(105)) - flushed keys num times: 3, with capacity: 2
2016-05-18 00:56:54,186 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(106)) - mem on flush (mb), free: 203, total: 223, max: 672
2016-05-18 00:56:54,186 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(111)) - total mem is 33% of max mem, to better utilize unused memory consider increasing the cache size
2016-05-18 00:56:54,284 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:56:54,286 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 00:56:54,395 INFO property.AppProps (AppProps.java:getAppID(177)) - using app.id: 3779E175FAF4400187A4CD831330528E
2016-05-18 00:56:54,582 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.126
2016-05-18 00:56:54,585 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 00:56:54,586 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 00:56:54,733 INFO util.Version (Version.java:printBanner(82)) - Concurrent, Inc - Cascading 3.1.0
2016-05-18 00:56:54,738 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] starting
2016-05-18 00:56:54,738 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/upper.txt"]
2016-05-18 00:56:54,739 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] sink: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testFieldFormatter/formatter"]
2016-05-18 00:56:54,739 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] parallel execution of steps is enabled: false
2016-05-18 00:56:54,740 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] executing total steps: 1
2016-05-18 00:56:54,741 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] allocating management threads: 1
2016-05-18 00:56:54,741 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] starting step: (1/1) ...tFieldFormatter/formatter
2016-05-18 00:56:55,267 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/tmp/cascading/staging/teamcity887703045/.staging/job_local887703045_0001/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2016-05-18 00:56:55,268 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/tmp/cascading/staging/teamcity887703045/.staging/job_local887703045_0001/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2016-05-18 00:56:55,475 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local887703045_0001/job_local887703045_0001.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2016-05-18 00:56:55,476 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local887703045_0001/job_local887703045_0001.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2016-05-18 00:56:55,486 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] submitted hadoop job: job_local887703045_0001
2016-05-18 00:56:55,486 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] tracking url: http://localhost:8080/
2016-05-18 00:56:55,587 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/upper.txt
2016-05-18 00:56:55,610 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-18 00:56:55,611 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-18 00:56:55,626 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B8C6722BB1E0472F8D33B3F75E445913, ordinal: 0
2016-05-18 00:56:55,659 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/upper.txt"]
2016-05-18 00:56:55,659 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testFieldFormatter/formatter"]
2016-05-18 00:56:55,661 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B8C6722BB1E0472F8D33B3F75E445913, mem on start (mb), free: 244, total: 281, max: 672
2016-05-18 00:56:55,673 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B8C6722BB1E0472F8D33B3F75E445913, mem on close (mb), free: 243, total: 281, max: 672
2016-05-18 00:56:55,735 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testFieldFormatter/formatter/_temporary
2016-05-18 00:56:55,736 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [formatter] completed in: 00:00.997
2016-05-18 00:56:55,794 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/functionplatform/testFieldFormatter/formatter
2016-05-18 00:56:55,797 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(105)) - flushed keys num times: 1, with capacity: 2
2016-05-18 00:56:55,797 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(106)) - mem on flush (mb), free: 230, total: 281, max: 672
2016-05-18 00:56:55,798 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(111)) - total mem is 41% of max mem, to better utilize unused memory consider increasing the cache size
2016-05-18 00:56:55,798 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(105)) - flushed keys num times: 3, with capacity: 2
2016-05-18 00:56:55,798 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(106)) - mem on flush (mb), free: 230, total: 281, max: 672
2016-05-18 00:56:55,799 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(111)) - total mem is 41% of max mem, to better utilize unused memory consider increasing the cache size
2016-05-18 00:56:55,823 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:56:55,824 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 00:56:55,907 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.071
2016-05-18 00:56:55,908 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-05-18 00:56:55,909 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 00:56:55,951 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] starting
2016-05-18 00:56:55,952 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/apache.200.txt"]
2016-05-18 00:56:55,952 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] sink: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testInsert/insert"]
2016-05-18 00:56:55,952 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] parallel execution of steps is enabled: false
2016-05-18 00:56:55,953 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] executing total steps: 1
2016-05-18 00:56:55,953 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] allocating management threads: 1
2016-05-18 00:56:55,954 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] starting step: (1/1) ...latform/testInsert/insert
2016-05-18 00:56:56,032 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/tmp/cascading/staging/teamcity1131686824/.staging/job_local1131686824_0002/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2016-05-18 00:56:56,033 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/tmp/cascading/staging/teamcity1131686824/.staging/job_local1131686824_0002/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2016-05-18 00:56:56,109 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local1131686824_0002/job_local1131686824_0002.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2016-05-18 00:56:56,110 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local1131686824_0002/job_local1131686824_0002.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2016-05-18 00:56:56,112 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] submitted hadoop job: job_local1131686824_0002
2016-05-18 00:56:56,112 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] tracking url: http://localhost:8080/
2016-05-18 00:56:56,120 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/apache.200.txt
2016-05-18 00:56:56,254 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-18 00:56:56,255 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-18 00:56:56,265 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: FC333C9CE1A141DDB9E18B503941D6DF, ordinal: 0
2016-05-18 00:56:56,271 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/apache.200.txt"]
2016-05-18 00:56:56,271 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(apache)[by:[{1}:'A']]
2016-05-18 00:56:56,272 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: FC333C9CE1A141DDB9E18B503941D6DF, mem on start (mb), free: 92, total: 281, max: 672
2016-05-18 00:56:56,295 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: FC333C9CE1A141DDB9E18B503941D6DF, mem on close (mb), free: 92, total: 281, max: 672
2016-05-18 00:56:56,444 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.1.0
2016-05-18 00:56:56,444 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-05-18 00:56:56,459 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: AA743EDF94444E15AA686F054AC75732, ordinal: 1
2016-05-18 00:56:56,462 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(apache)[by:[{1}:'A']]
2016-05-18 00:56:56,462 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testInsert/insert"]
2016-05-18 00:56:56,463 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: AA743EDF94444E15AA686F054AC75732, mem on start (mb), free: 83, total: 281, max: 672
2016-05-18 00:56:56,511 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: AA743EDF94444E15AA686F054AC75732, mem on close (mb), free: 81, total: 281, max: 672
2016-05-18 00:56:56,534 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testInsert/insert/_temporary
2016-05-18 00:56:56,535 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [apache] completed in: 00:00.583
2016-05-18 00:56:56,633 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/functionplatform/testInsert/insert
2016-05-18 00:56:56,661 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:56:56,662 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 00:56:56,726 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.052
2016-05-18 00:56:56,727 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-18 00:56:56,728 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 00:56:56,751 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] starting
2016-05-18 00:56:56,752 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/upper.txt"]
2016-05-18 00:56:56,753 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] sink: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testSetValue/setvalue"]
2016-05-18 00:56:56,755 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] parallel execution of steps is enabled: false
2016-05-18 00:56:56,755 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] executing total steps: 1
2016-05-18 00:56:56,756 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] allocating management threads: 1
2016-05-18 00:56:56,758 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] starting step: (1/1) ...orm/testSetValue/setvalue
2016-05-18 00:56:56,870 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/tmp/cascading/staging/teamcity346064537/.staging/job_local346064537_0003/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2016-05-18 00:56:56,871 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/tmp/cascading/staging/teamcity346064537/.staging/job_local346064537_0003/job.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2016-05-18 00:56:56,929 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local346064537_0003/job_local346064537_0003.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.retry.interval; Ignoring.
2016-05-18 00:56:56,930 WARN conf.Configuration (Configuration.java:loadProperty(2345)) - file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/tmp/mapred/local/localRunner/teamcity/job_local346064537_0003/job_local346064537_0003.xml:an attempt to override final parameter: mapreduce.job.end-notification.max.attempts; Ignoring.
2016-05-18 00:56:56,931 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] submitted hadoop job: job_local346064537_0003
2016-05-18 00:56:56,932 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] tracking url: http://localhost:8080/
2016-05-18 00:56:56,941 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/upper.txt
2016-05-18 00:56:56,953 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-18 00:56:56,953 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-18 00:56:56,969 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C1FA3DA0CEDE4E7D97ED502011F4C437, ordinal: 0
2016-05-18 00:56:56,971 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/upper.txt"]
2016-05-18 00:56:56,971 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testSetValue/setvalue"]
2016-05-18 00:56:56,972 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C1FA3DA0CEDE4E7D97ED502011F4C437, mem on start (mb), free: 146, total: 281, max: 672
2016-05-18 00:56:56,976 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C1FA3DA0CEDE4E7D97ED502011F4C437, mem on close (mb), free: 146, total: 281, max: 672
2016-05-18 00:56:56,999 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/functionplatform/testSetValue/setvalue/_temporary
2016-05-18 00:56:57,000 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [setvalue] completed in: 00:00.248
2016-05-18 00:56:57,067 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/functionplatform/testSetValue/setvalue