2015-08-13 19:20:07,522 INFO platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(187)) - found 1 test platforms from classpath
2015-08-13 19:20:07,575 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(237)) - installing platform: hadoop
2015-08-13 19:20:07,576 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(238)) - running test: cascading.function.FunctionPlatformTest
2015-08-13 19:20:07,611 INFO hadoop.HadoopPlatform (HadoopPlatform.java:setUp(112)) - not using cluster
2015-08-13 19:20:07,907 INFO platform.TestPlatform (TestPlatform.java:getGlobalProperties(72)) - platform property overrides:
2015-08-13 19:20:07,966 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(105)) - flushed keys num times: 1, with capacity: 2
2015-08-13 19:20:07,967 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(106)) - mem on flush (mb), free: 94, total: 102, max: 672
2015-08-13 19:20:07,967 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(111)) - total mem is 15% of max mem, to better utilize unused memory consider increasing the cache size
2015-08-13 19:20:07,968 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(105)) - flushed keys num times: 3, with capacity: 2
2015-08-13 19:20:07,969 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(106)) - mem on flush (mb), free: 94, total: 102, max: 672
2015-08-13 19:20:07,969 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(111)) - total mem is 15% of max mem, to better utilize unused memory consider increasing the cache size
2015-08-13 19:20:08,063 INFO util.HadoopUtil (HadoopUtil.java:findMainClass(336)) - using default application jar, may cause class not found exceptions on the cluster
2015-08-13 19:20:08,065 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(226)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/2.7.1/e28a477e50cd8946adea60fa2bb90b57eaf07ef3/cascading-hadoop-2.7.1.jar
2015-08-13 19:20:08,078 INFO property.AppProps (AppProps.java:getAppID(169)) - using app.id: 15868D971CA24B27AE7C15CE36CB1808
2015-08-13 19:20:08,290 INFO util.Version (Version.java:printBanner(85)) - Concurrent, Inc - Cascading 2.7.1
2015-08-13 19:20:08,291 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [formatter] starting
2015-08-13 19:20:08,293 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [formatter] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/upper.txt"]
2015-08-13 19:20:08,294 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [formatter] sink: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/formatter"]
2015-08-13 19:20:08,294 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [formatter] parallel execution is enabled: false
2015-08-13 19:20:08,294 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [formatter] starting jobs: 1
2015-08-13 19:20:08,295 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [formatter] allocating threads: 1
2015-08-13 19:20:08,297 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [formatter] starting step: (1/1) ...unctionplatform/formatter
2015-08-13 19:20:08,339 WARN util.NativeCodeLoader (NativeCodeLoader.java:<clinit>(52)) - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
2015-08-13 19:20:08,591 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [formatter] submitted hadoop job: job_local_0001
2015-08-13 19:20:08,592 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [formatter] tracking url: http://localhost:8080/
2015-08-13 19:20:08,671 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/upper.txt
2015-08-13 19:20:08,689 INFO hadoop.FlowMapper (FlowMapper.java:configure(71)) - cascading version: 2.7.1
2015-08-13 19:20:08,689 INFO hadoop.FlowMapper (FlowMapper.java:configure(72)) - child jvm opts: -Xmx200m
2015-08-13 19:20:08,732 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/upper.txt"]
2015-08-13 19:20:08,732 INFO hadoop.FlowMapper (FlowMapper.java:configure(90)) - sinking to: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/formatter"]
2015-08-13 19:20:11,651 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(219)) - deleting temp path /opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/formatter/_temporary
2015-08-13 19:20:11,704 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(209)) - copying to local /opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output//hadoop/functionplatform/formatter
2015-08-13 19:20:11,707 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(105)) - flushed keys num times: 1, with capacity: 2
2015-08-13 19:20:11,708 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(106)) - mem on flush (mb), free: 96, total: 102, max: 672
2015-08-13 19:20:11,708 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(111)) - total mem is 15% of max mem, to better utilize unused memory consider increasing the cache size
2015-08-13 19:20:11,709 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(105)) - flushed keys num times: 3, with capacity: 2
2015-08-13 19:20:11,709 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(106)) - mem on flush (mb), free: 96, total: 102, max: 672
2015-08-13 19:20:11,709 INFO cache.LRUHashMapCache (LRUHashMapCache.java:removeEldestEntry(111)) - total mem is 15% of max mem, to better utilize unused memory consider increasing the cache size
2015-08-13 19:20:11,739 INFO util.HadoopUtil (HadoopUtil.java:findMainClass(336)) - using default application jar, may cause class not found exceptions on the cluster
2015-08-13 19:20:11,740 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(226)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/2.7.1/e28a477e50cd8946adea60fa2bb90b57eaf07ef3/cascading-hadoop-2.7.1.jar
2015-08-13 19:20:11,781 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [apache] starting
2015-08-13 19:20:11,782 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [apache] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/apache.200.txt"]
2015-08-13 19:20:11,782 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [apache] sink: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/insert"]
2015-08-13 19:20:11,783 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [apache] parallel execution is enabled: false
2015-08-13 19:20:11,783 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [apache] starting jobs: 1
2015-08-13 19:20:11,783 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [apache] allocating threads: 1
2015-08-13 19:20:11,785 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [apache] starting step: (1/1) ...p/functionplatform/insert
2015-08-13 19:20:11,888 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [apache] submitted hadoop job: job_local_0002
2015-08-13 19:20:11,890 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [apache] tracking url: http://localhost:8080/
2015-08-13 19:20:11,895 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/apache.200.txt
2015-08-13 19:20:12,060 INFO hadoop.FlowMapper (FlowMapper.java:configure(71)) - cascading version: 2.7.1
2015-08-13 19:20:12,061 INFO hadoop.FlowMapper (FlowMapper.java:configure(72)) - child jvm opts: -Xmx200m
2015-08-13 19:20:12,083 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/apache.200.txt"]
2015-08-13 19:20:12,083 INFO hadoop.FlowMapper (FlowMapper.java:configure(90)) - sinking to: GroupBy(apache)[by:[{1}:'A']]
2015-08-13 19:20:14,917 INFO hadoop.FlowReducer (FlowReducer.java:configure(78)) - cascading version: 2.7.1
2015-08-13 19:20:14,918 INFO hadoop.FlowReducer (FlowReducer.java:configure(79)) - child jvm opts: -Xmx200m
2015-08-13 19:20:14,933 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - sourcing from: GroupBy(apache)[by:[{1}:'A']]
2015-08-13 19:20:14,933 INFO hadoop.FlowReducer (FlowReducer.java:configure(100)) - sinking to: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/insert"]
2015-08-13 19:20:17,914 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(219)) - deleting temp path /opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/insert/_temporary
2015-08-13 19:20:17,969 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(209)) - copying to local /opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output//hadoop/functionplatform/insert
2015-08-13 19:20:17,995 INFO util.HadoopUtil (HadoopUtil.java:findMainClass(336)) - using default application jar, may cause class not found exceptions on the cluster
2015-08-13 19:20:17,996 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(226)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/2.7.1/e28a477e50cd8946adea60fa2bb90b57eaf07ef3/cascading-hadoop-2.7.1.jar
2015-08-13 19:20:18,026 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [setvalue] starting
2015-08-13 19:20:18,026 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [setvalue] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/upper.txt"]
2015-08-13 19:20:18,026 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [setvalue] sink: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/setvalue"]
2015-08-13 19:20:18,027 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [setvalue] parallel execution is enabled: false
2015-08-13 19:20:18,027 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [setvalue] starting jobs: 1
2015-08-13 19:20:18,027 INFO flow.Flow (BaseFlow.java:logInfo(1370)) - [setvalue] allocating threads: 1
2015-08-13 19:20:18,028 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [setvalue] starting step: (1/1) ...functionplatform/setvalue
2015-08-13 19:20:18,107 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [setvalue] submitted hadoop job: job_local_0003
2015-08-13 19:20:18,108 INFO flow.FlowStep (BaseFlowStep.java:logInfo(895)) - [setvalue] tracking url: http://localhost:8080/
2015-08-13 19:20:18,114 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/upper.txt
2015-08-13 19:20:18,121 INFO hadoop.FlowMapper (FlowMapper.java:configure(71)) - cascading version: 2.7.1
2015-08-13 19:20:18,121 INFO hadoop.FlowMapper (FlowMapper.java:configure(72)) - child jvm opts: -Xmx200m
2015-08-13 19:20:18,131 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/classes/test/data/upper.txt"]
2015-08-13 19:20:18,132 INFO hadoop.FlowMapper (FlowMapper.java:configure(90)) - sinking to: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/setvalue"]
2015-08-13 19:20:21,125 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(219)) - deleting temp path /opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output/hadoop/functionplatform/setvalue/_temporary
2015-08-13 19:20:21,163 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(209)) - copying to local /opt/buildAgent-8.0.3/work/8c57748d0461e126/apache-0.20.205.0/build/test/output//hadoop/functionplatform/setvalue