2016-01-14 17:19:37,848 INFO platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(195)) - found 1 test platforms from classpath
2016-01-14 17:19:37,864 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(244)) - adding test: cascading.flow.FlowStrategiesPlatformTest, with platform: hadoop
2016-01-14 17:19:37,887 INFO hadoop.HadoopPlatform (HadoopPlatform.java:setUp(127)) - not using cluster
2016-01-14 17:19:38,116 INFO platform.TestPlatform (TestPlatform.java:getGlobalProperties(73)) - platform property overrides:
2016-01-14 17:19:38,208 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 17:19:38,210 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.0.4/ab50b225eb80fe7b8e59368476a4bfb0fa1a0ef5/cascading-hadoop-3.0.4.jar
2016-01-14 17:19:38,310 INFO property.AppProps (AppProps.java:getAppID(177)) - using app.id: 81085082FA274CAEBD5107DA6CAD2603
2016-01-14 17:19:38,441 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.090
2016-01-14 17:19:38,444 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-01-14 17:19:38,445 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 17:19:38,586 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] at least one sink is marked for delete
2016-01-14 17:19:38,592 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink oldest modified date: Wed Dec 31 23:59:59 UTC 1969
2016-01-14 17:19:38,594 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] at least one sink is marked for delete
2016-01-14 17:19:38,595 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink oldest modified date: Wed Dec 31 23:59:59 UTC 1969
2016-01-14 17:19:38,651 INFO util.Version (Version.java:printBanner(82)) - Concurrent, Inc - Cascading 3.0.4
2016-01-14 17:19:38,653 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] starting
2016-01-14 17:19:38,656 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt"]
2016-01-14 17:19:38,657 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testSkipStrategiesReplace/replace"]
2016-01-14 17:19:38,657 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] parallel execution of steps is enabled: false
2016-01-14 17:19:38,658 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] executing total steps: 1
2016-01-14 17:19:38,658 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] allocating management threads: 1
2016-01-14 17:19:38,660 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] starting step: (1/1) ...StrategiesReplace/replace
2016-01-14 17:19:38,690 WARN util.NativeCodeLoader (NativeCodeLoader.java:<clinit>(52)) - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
2016-01-14 17:19:38,943 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] submitted hadoop job: job_local_0001
2016-01-14 17:19:38,944 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] tracking url: http://localhost:8080/
2016-01-14 17:19:39,006 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt
2016-01-14 17:19:39,022 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 17:19:39,022 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 17:19:39,035 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C0287C5B03D343C9ADE5BE4B68DD6743, ordinal: 0
2016-01-14 17:19:39,079 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt"]
2016-01-14 17:19:39,079 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testSkipStrategiesReplace/replace"]
2016-01-14 17:19:39,080 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C0287C5B03D343C9ADE5BE4B68DD6743, mem on start (mb), free: 190, total: 223, max: 672
2016-01-14 17:19:39,090 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C0287C5B03D343C9ADE5BE4B68DD6743, mem on close (mb), free: 189, total: 223, max: 672
2016-01-14 17:19:41,996 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testSkipStrategiesReplace/replace/_temporary
2016-01-14 17:19:41,999 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] completed in: 00:03.341
2016-01-14 17:19:41,999 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] at least one sink is marked for delete
2016-01-14 17:19:42,000 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink oldest modified date: Wed Dec 31 23:59:59 UTC 1969
2016-01-14 17:19:42,000 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] at least one sink is marked for delete
2016-01-14 17:19:42,000 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink oldest modified date: Wed Dec 31 23:59:59 UTC 1969
2016-01-14 17:19:42,052 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output//hadoop/flowstrategiesplatform/testSkipStrategiesReplace/replace
2016-01-14 17:19:42,083 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 17:19:42,084 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.0.4/ab50b225eb80fe7b8e59368476a4bfb0fa1a0ef5/cascading-hadoop-3.0.4.jar
2016-01-14 17:19:42,155 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.064
2016-01-14 17:19:42,157 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-01-14 17:19:42,157 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 17:19:42,175 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] at least one sink does not exist
2016-01-14 17:19:42,177 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] at least one sink does not exist
2016-01-14 17:19:42,178 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] starting
2016-01-14 17:19:42,179 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt"]
2016-01-14 17:19:42,180 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testSkipStrategiesKeep/keep"]
2016-01-14 17:19:42,181 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] parallel execution of steps is enabled: false
2016-01-14 17:19:42,181 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] executing total steps: 1
2016-01-14 17:19:42,181 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] allocating management threads: 1
2016-01-14 17:19:42,183 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] starting step: (1/1) ...stSkipStrategiesKeep/keep
2016-01-14 17:19:42,264 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] submitted hadoop job: job_local_0002
2016-01-14 17:19:42,266 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] tracking url: http://localhost:8080/
2016-01-14 17:19:42,271 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt
2016-01-14 17:19:42,275 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 17:19:42,275 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 17:19:42,287 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: EB3C47384D5C413793A1A60D3D73E4C2, ordinal: 0
2016-01-14 17:19:42,288 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt"]
2016-01-14 17:19:42,288 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testSkipStrategiesKeep/keep"]
2016-01-14 17:19:42,288 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EB3C47384D5C413793A1A60D3D73E4C2, mem on start (mb), free: 179, total: 223, max: 672
2016-01-14 17:19:42,291 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EB3C47384D5C413793A1A60D3D73E4C2, mem on close (mb), free: 179, total: 223, max: 672
2016-01-14 17:19:45,280 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testSkipStrategiesKeep/keep/_temporary
2016-01-14 17:19:45,281 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] completed in: 00:03.102
2016-01-14 17:19:45,285 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink oldest modified date: Thu Jan 14 17:19:45 UTC 2016
2016-01-14 17:19:45,289 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] source modification date at: Thu Jan 14 15:07:18 UTC 2016
2016-01-14 17:19:45,291 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink oldest modified date: Thu Jan 14 17:19:45 UTC 2016
2016-01-14 17:19:45,331 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output//hadoop/flowstrategiesplatform/testSkipStrategiesKeep/keep
2016-01-14 17:19:45,350 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 17:19:45,351 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.0.4/ab50b225eb80fe7b8e59368476a4bfb0fa1a0ef5/cascading-hadoop-3.0.4.jar
2016-01-14 17:19:45,418 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.062
2016-01-14 17:19:45,420 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 17:19:45,420 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 17:19:45,450 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] starting
2016-01-14 17:19:45,450 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt"]
2016-01-14 17:19:45,451 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] sink: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testFlowStepStrategy/simple"]
2016-01-14 17:19:45,451 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] parallel execution of steps is enabled: false
2016-01-14 17:19:45,452 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] executing total steps: 1
2016-01-14 17:19:45,452 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] allocating management threads: 1
2016-01-14 17:19:45,454 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] starting step: (1/1) ...stFlowStepStrategy/simple
2016-01-14 17:19:45,545 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] submitted hadoop job: job_local_0003
2016-01-14 17:19:45,545 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] tracking url: http://localhost:8080/
2016-01-14 17:19:45,552 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt
2016-01-14 17:19:45,683 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 17:19:45,683 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 17:19:45,700 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: BF4B8AA1CE2041F5BE2159D111A9635A, ordinal: 0
2016-01-14 17:19:45,706 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/classes/test/data/apache.10.txt"]
2016-01-14 17:19:45,706 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(test)[by:[{1}:'ip']]
2016-01-14 17:19:45,707 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BF4B8AA1CE2041F5BE2159D111A9635A, mem on start (mb), free: 66, total: 223, max: 672
2016-01-14 17:19:45,713 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BF4B8AA1CE2041F5BE2159D111A9635A, mem on close (mb), free: 66, total: 223, max: 672
2016-01-14 17:19:48,566 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 17:19:48,567 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 17:19:48,579 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: BF09F23B27B0404588AD9C488745F76F, ordinal: 1
2016-01-14 17:19:48,585 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(test)[by:[{1}:'ip']]
2016-01-14 17:19:48,586 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testFlowStepStrategy/simple"]
2016-01-14 17:19:48,586 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: BF09F23B27B0404588AD9C488745F76F, mem on start (mb), free: 64, total: 223, max: 672
2016-01-14 17:19:48,599 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: BF09F23B27B0404588AD9C488745F76F, mem on close (mb), free: 63, total: 223, max: 672
2016-01-14 17:19:51,568 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output/hadoop/flowstrategiesplatform/testFlowStepStrategy/simple/_temporary
2016-01-14 17:19:51,569 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [test] completed in: 00:06.115
2016-01-14 17:19:51,580 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-0.20.205.0/build/test/output//hadoop/flowstrategiesplatform/testFlowStepStrategy/simple