2016-01-14 23:26:11,020 INFO platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(195)) - found 1 test platforms from classpath
2016-01-14 23:26:11,044 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(244)) - adding test: cascading.SortedValuesPlatformTest, with platform: hadoop
2016-01-14 23:26:11,086 INFO hadoop.HadoopPlatform (HadoopPlatform.java:setUp(127)) - not using cluster
2016-01-14 23:26:11,348 INFO platform.TestPlatform (TestPlatform.java:getGlobalProperties(73)) - platform property overrides:
2016-01-14 23:26:11,462 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:11,465 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 23:26:11,593 INFO property.AppProps (AppProps.java:getAppID(177)) - using app.id: 910886E5F6284102ACBCFA1B51077642
2016-01-14 23:26:11,854 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.216
2016-01-14 23:26:11,858 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:11,858 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:12,066 INFO util.Version (Version.java:printBanner(82)) - Concurrent, Inc - Cascading 3.0.4
2016-01-14 23:26:12,068 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] starting
2016-01-14 23:26:12,068 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/apache.200.txt"]
2016-01-14 23:26:12,069 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/ips.20.txt"]
2016-01-14 23:26:12,069 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] sink: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testCoGroupComparatorValuesReversed/cogroupcomparereversed"]
2016-01-14 23:26:12,070 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] parallel execution of steps is enabled: false
2016-01-14 23:26:12,071 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] executing total steps: 1
2016-01-14 23:26:12,071 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] allocating management threads: 1
2016-01-14 23:26:12,072 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] starting step: (1/1) ...ed/cogroupcomparereversed
2016-01-14 23:26:12,107 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 23:26:12,158 WARN snappy.LoadSnappy (LoadSnappy.java:<clinit>(46)) - Snappy native library not loaded
2016-01-14 23:26:12,370 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] submitted hadoop job: job_local629513956_0001
2016-01-14 23:26:12,372 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] tracking url: http://localhost:8080/
2016-01-14 23:26:12,457 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/apache.200.txt
2016-01-14 23:26:12,589 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:12,589 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:12,611 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F11AFEA8C3E74036ACCBCE2D0317FDCB, ordinal: 0
2016-01-14 23:26:12,659 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/apache.200.txt"]
2016-01-14 23:26:12,659 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-14 23:26:12,660 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F11AFEA8C3E74036ACCBCE2D0317FDCB, mem on start (mb), free: 80, total: 223, max: 672
2016-01-14 23:26:12,727 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F11AFEA8C3E74036ACCBCE2D0317FDCB, mem on close (mb), free: 80, total: 223, max: 672
2016-01-14 23:26:18,900 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/ips.20.txt
2016-01-14 23:26:18,916 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:18,916 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:18,933 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F11AFEA8C3E74036ACCBCE2D0317FDCB, ordinal: 0
2016-01-14 23:26:18,934 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/ips.20.txt"]
2016-01-14 23:26:18,934 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-14 23:26:18,935 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F11AFEA8C3E74036ACCBCE2D0317FDCB, mem on start (mb), free: 42, total: 386, max: 672
2016-01-14 23:26:18,939 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F11AFEA8C3E74036ACCBCE2D0317FDCB, mem on close (mb), free: 42, total: 386, max: 672
2016-01-14 23:26:19,748 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:19,748 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:19,760 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B4BCAE0E5E1B45409A9298303D4BEB5D, ordinal: 1
2016-01-14 23:26:19,763 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-14 23:26:19,763 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testCoGroupComparatorValuesReversed/cogroupcomparereversed"]
2016-01-14 23:26:19,763 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B4BCAE0E5E1B45409A9298303D4BEB5D, mem on start (mb), free: 183, total: 433, max: 672
2016-01-14 23:26:19,776 INFO collect.SpillableTupleList (SpillableTupleList.java:getCodecClass(89)) - attempting to load codec: org.apache.hadoop.io.compress.GzipCodec
2016-01-14 23:26:19,776 INFO collect.SpillableTupleList (SpillableTupleList.java:getCodecClass(94)) - found codec: org.apache.hadoop.io.compress.GzipCodec
2016-01-14 23:26:21,022 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B4BCAE0E5E1B45409A9298303D4BEB5D, mem on close (mb), free: 198, total: 430, max: 672
2016-01-14 23:26:21,039 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testCoGroupComparatorValuesReversed/cogroupcomparereversed/_temporary
2016-01-14 23:26:21,040 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] completed in: 00:08.970
2016-01-14 23:26:21,071 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testCoGroupComparatorValuesReversed/cogroupcomparereversed
2016-01-14 23:26:21,084 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:21,085 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 23:26:21,196 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.104
2016-01-14 23:26:21,199 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:21,200 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:21,242 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] starting
2016-01-14 23:26:21,243 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/apache.200.txt"]
2016-01-14 23:26:21,243 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/ips.20.txt"]
2016-01-14 23:26:21,243 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] sink: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testCoGroupComparatorValues/cogroupcompareforward"]
2016-01-14 23:26:21,246 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] parallel execution of steps is enabled: false
2016-01-14 23:26:21,246 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] executing total steps: 1
2016-01-14 23:26:21,247 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] allocating management threads: 1
2016-01-14 23:26:21,247 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] starting step: (1/1) ...ues/cogroupcompareforward
2016-01-14 23:26:21,313 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] submitted hadoop job: job_local2098322039_0002
2016-01-14 23:26:21,317 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] tracking url: http://localhost:8080/
2016-01-14 23:26:21,323 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/apache.200.txt
2016-01-14 23:26:21,348 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:21,348 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:21,372 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B1F80655843E4503A47404F9C22BB7FD, ordinal: 0
2016-01-14 23:26:21,374 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/apache.200.txt"]
2016-01-14 23:26:21,374 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-14 23:26:21,375 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B1F80655843E4503A47404F9C22BB7FD, mem on start (mb), free: 209, total: 433, max: 672
2016-01-14 23:26:21,425 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B1F80655843E4503A47404F9C22BB7FD, mem on close (mb), free: 209, total: 433, max: 672
2016-01-14 23:26:26,402 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/ips.20.txt
2016-01-14 23:26:26,426 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:26,426 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:26,439 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B1F80655843E4503A47404F9C22BB7FD, ordinal: 0
2016-01-14 23:26:26,440 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/ips.20.txt"]
2016-01-14 23:26:26,440 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-14 23:26:26,440 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B1F80655843E4503A47404F9C22BB7FD, mem on start (mb), free: 349, total: 580, max: 672
2016-01-14 23:26:26,444 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B1F80655843E4503A47404F9C22BB7FD, mem on close (mb), free: 349, total: 580, max: 672
2016-01-14 23:26:27,045 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:27,046 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:27,060 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: EC30E005085444838E8ABEDF3870B431, ordinal: 1
2016-01-14 23:26:27,061 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-14 23:26:27,061 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testCoGroupComparatorValues/cogroupcompareforward"]
2016-01-14 23:26:27,062 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: EC30E005085444838E8ABEDF3870B431, mem on start (mb), free: 529, total: 665, max: 672
2016-01-14 23:26:27,067 INFO collect.SpillableTupleList (SpillableTupleList.java:getCodecClass(89)) - attempting to load codec: org.apache.hadoop.io.compress.GzipCodec
2016-01-14 23:26:27,067 INFO collect.SpillableTupleList (SpillableTupleList.java:getCodecClass(94)) - found codec: org.apache.hadoop.io.compress.GzipCodec
2016-01-14 23:26:28,148 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: EC30E005085444838E8ABEDF3870B431, mem on close (mb), free: 356, total: 671, max: 672
2016-01-14 23:26:28,170 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testCoGroupComparatorValues/cogroupcompareforward/_temporary
2016-01-14 23:26:28,171 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] completed in: 00:06.928
2016-01-14 23:26:28,201 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testCoGroupComparatorValues/cogroupcompareforward
2016-01-14 23:26:28,214 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:28,215 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 23:26:28,243 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.023
2016-01-14 23:26:28,243 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [apache] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-01-14 23:26:28,252 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:28,253 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 23:26:28,299 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.042
2016-01-14 23:26:28,300 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:28,300 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:28,326 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:28,326 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:28,326 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_false"]
2016-01-14 23:26:28,327 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:28,327 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:28,327 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:28,328 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/false_null_false_false
2016-01-14 23:26:28,365 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local393890670_0003
2016-01-14 23:26:28,365 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:28,371 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:28,394 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:28,394 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:28,402 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B68F913D027749028F1868EE2962104C, ordinal: 0
2016-01-14 23:26:28,403 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:28,403 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:28,403 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B68F913D027749028F1868EE2962104C, mem on start (mb), free: 441, total: 671, max: 672
2016-01-14 23:26:28,408 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B68F913D027749028F1868EE2962104C, mem on close (mb), free: 441, total: 671, max: 672
2016-01-14 23:26:28,418 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:28,419 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:28,425 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: F88C7B784AB94BC9BCB10818490732A1, ordinal: 1
2016-01-14 23:26:28,426 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:28,426 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_false"]
2016-01-14 23:26:28,426 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F88C7B784AB94BC9BCB10818490732A1, mem on start (mb), free: 438, total: 671, max: 672
2016-01-14 23:26:28,433 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F88C7B784AB94BC9BCB10818490732A1, mem on close (mb), free: 438, total: 671, max: 672
2016-01-14 23:26:28,443 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_false/_temporary
2016-01-14 23:26:28,443 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.116
2016-01-14 23:26:28,457 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:28,458 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 23:26:28,508 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.047
2016-01-14 23:26:28,509 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:28,510 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:28,528 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:28,529 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:28,529 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_false"]
2016-01-14 23:26:28,529 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:28,529 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:28,529 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:28,530 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/true_null_false_false
2016-01-14 23:26:28,561 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1434914863_0004
2016-01-14 23:26:28,561 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:28,567 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:28,585 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:28,585 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:28,594 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D005C755D9C04334A679C70C3973D279, ordinal: 0
2016-01-14 23:26:28,595 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:28,595 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:28,596 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D005C755D9C04334A679C70C3973D279, mem on start (mb), free: 452, total: 668, max: 672
2016-01-14 23:26:28,603 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D005C755D9C04334A679C70C3973D279, mem on close (mb), free: 452, total: 668, max: 672
2016-01-14 23:26:29,240 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:29,240 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:29,247 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: C70F90D1DC714AB99BFCBDA6D82FD46F, ordinal: 1
2016-01-14 23:26:29,247 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:29,247 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_false"]
2016-01-14 23:26:29,248 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C70F90D1DC714AB99BFCBDA6D82FD46F, mem on start (mb), free: 558, total: 735, max: 735
2016-01-14 23:26:29,256 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C70F90D1DC714AB99BFCBDA6D82FD46F, mem on close (mb), free: 558, total: 735, max: 735
2016-01-14 23:26:29,276 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_false/_temporary
2016-01-14 23:26:29,277 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.748
2016-01-14 23:26:29,290 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:29,290 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 23:26:29,334 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.040
2016-01-14 23:26:29,335 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:29,335 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:29,353 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:29,353 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:29,353 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_false"]
2016-01-14 23:26:29,354 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:29,354 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:29,354 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:29,355 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_null_true_false
2016-01-14 23:26:29,386 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1910651480_0005
2016-01-14 23:26:29,387 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:29,391 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:29,405 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:29,405 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:29,414 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B25A79B28B7F4F59B03105D0E9259FA8, ordinal: 0
2016-01-14 23:26:29,415 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:29,416 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:29,416 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B25A79B28B7F4F59B03105D0E9259FA8, mem on start (mb), free: 443, total: 735, max: 735
2016-01-14 23:26:29,422 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B25A79B28B7F4F59B03105D0E9259FA8, mem on close (mb), free: 443, total: 735, max: 735
2016-01-14 23:26:29,432 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:29,432 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:29,439 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: A87F0208AB4B4D578D56112A35DAFA75, ordinal: 1
2016-01-14 23:26:29,440 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:29,440 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_false"]
2016-01-14 23:26:29,440 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A87F0208AB4B4D578D56112A35DAFA75, mem on start (mb), free: 442, total: 735, max: 735
2016-01-14 23:26:29,447 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A87F0208AB4B4D578D56112A35DAFA75, mem on close (mb), free: 442, total: 735, max: 735
2016-01-14 23:26:29,461 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_false/_temporary
2016-01-14 23:26:29,461 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.108
2016-01-14 23:26:29,474 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:29,474 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 23:26:29,524 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.046
2016-01-14 23:26:29,526 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:29,526 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:29,542 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:29,542 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:29,543 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_false"]
2016-01-14 23:26:29,543 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:29,544 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:29,544 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:29,545 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_null_true_false
2016-01-14 23:26:29,571 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local335710128_0006
2016-01-14 23:26:29,573 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:29,577 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:29,596 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:29,596 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:29,603 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: DABCC0CDE0EB4AE1B30BEBB7D394614E, ordinal: 0
2016-01-14 23:26:29,604 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:29,604 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:29,604 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DABCC0CDE0EB4AE1B30BEBB7D394614E, mem on start (mb), free: 514, total: 734, max: 734
2016-01-14 23:26:29,609 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DABCC0CDE0EB4AE1B30BEBB7D394614E, mem on close (mb), free: 514, total: 734, max: 734
2016-01-14 23:26:30,192 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:30,192 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:30,202 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: FD3659DC33FD4178BB7BBC42A1051C30, ordinal: 1
2016-01-14 23:26:30,202 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:30,203 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_false"]
2016-01-14 23:26:30,203 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: FD3659DC33FD4178BB7BBC42A1051C30, mem on start (mb), free: 558, total: 735, max: 735
2016-01-14 23:26:30,209 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: FD3659DC33FD4178BB7BBC42A1051C30, mem on close (mb), free: 558, total: 735, max: 735
2016-01-14 23:26:30,221 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_false/_temporary
2016-01-14 23:26:30,222 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.679
2016-01-14 23:26:30,241 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:30,241 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 23:26:30,284 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.038
2016-01-14 23:26:30,284 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:30,285 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:30,301 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:30,301 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:30,301 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_false"]
2016-01-14 23:26:30,301 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:30,302 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:30,302 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:30,302 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...e/false_false_false_false
2016-01-14 23:26:30,332 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local206645632_0007
2016-01-14 23:26:30,333 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:30,339 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:30,357 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:30,358 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:30,369 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: DC872387C01444998CD9CAA55A620F86, ordinal: 0
2016-01-14 23:26:30,371 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:30,371 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:30,371 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DC872387C01444998CD9CAA55A620F86, mem on start (mb), free: 443, total: 735, max: 735
2016-01-14 23:26:30,377 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DC872387C01444998CD9CAA55A620F86, mem on close (mb), free: 443, total: 735, max: 735
2016-01-14 23:26:30,392 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:30,392 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:30,401 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: EFB41705230647E48589995EFC9E7596, ordinal: 1
2016-01-14 23:26:30,402 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:30,402 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_false"]
2016-01-14 23:26:30,402 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: EFB41705230647E48589995EFC9E7596, mem on start (mb), free: 442, total: 735, max: 735
2016-01-14 23:26:30,409 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: EFB41705230647E48589995EFC9E7596, mem on close (mb), free: 442, total: 735, max: 735
2016-01-14 23:26:30,427 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_false/_temporary
2016-01-14 23:26:30,428 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.126
2016-01-14 23:26:30,441 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:30,442 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 23:26:30,476 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.031
2016-01-14 23:26:30,477 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:30,478 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:30,493 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:30,493 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:30,494 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_false"]
2016-01-14 23:26:30,494 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:30,494 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:30,494 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:30,496 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/true_false_false_false
2016-01-14 23:26:30,523 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1777118221_0008
2016-01-14 23:26:30,524 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:30,533 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:30,590 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:30,590 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:30,601 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: EB6245274EB14306A56F4E51D539AAD2, ordinal: 0
2016-01-14 23:26:30,602 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:30,602 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:30,603 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EB6245274EB14306A56F4E51D539AAD2, mem on start (mb), free: 624, total: 734, max: 734
2016-01-14 23:26:30,609 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EB6245274EB14306A56F4E51D539AAD2, mem on close (mb), free: 624, total: 734, max: 734
2016-01-14 23:26:31,531 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:31,532 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:31,538 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B2E979D7A2824CA1AD02DBC74B119962, ordinal: 1
2016-01-14 23:26:31,539 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:31,539 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_false"]
2016-01-14 23:26:31,539 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B2E979D7A2824CA1AD02DBC74B119962, mem on start (mb), free: 462, total: 735, max: 735
2016-01-14 23:26:31,546 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B2E979D7A2824CA1AD02DBC74B119962, mem on close (mb), free: 462, total: 735, max: 735
2016-01-14 23:26:31,555 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_false/_temporary
2016-01-14 23:26:31,555 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:01.062
2016-01-14 23:26:31,569 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:31,569 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 23:26:31,602 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.029
2016-01-14 23:26:31,603 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:31,603 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:31,619 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:31,620 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:31,620 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_false"]
2016-01-14 23:26:31,620 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:31,621 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:31,622 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:31,623 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/true_true_false_false
2016-01-14 23:26:31,650 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local2040643546_0009
2016-01-14 23:26:31,651 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:31,655 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:31,710 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:31,710 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:31,716 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C154EB9511534734AA3C0D2223BA16C5, ordinal: 0
2016-01-14 23:26:31,717 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:31,717 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:31,717 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C154EB9511534734AA3C0D2223BA16C5, mem on start (mb), free: 617, total: 734, max: 734
2016-01-14 23:26:31,722 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C154EB9511534734AA3C0D2223BA16C5, mem on close (mb), free: 617, total: 734, max: 734
2016-01-14 23:26:32,764 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:32,764 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:32,770 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: A36E3441BE7241B092FE75478DFDAD30, ordinal: 1
2016-01-14 23:26:32,771 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:32,771 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_false"]
2016-01-14 23:26:32,771 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A36E3441BE7241B092FE75478DFDAD30, mem on start (mb), free: 589, total: 735, max: 735
2016-01-14 23:26:32,778 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A36E3441BE7241B092FE75478DFDAD30, mem on close (mb), free: 589, total: 735, max: 735
2016-01-14 23:26:32,793 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_false/_temporary
2016-01-14 23:26:32,793 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:01.174
2016-01-14 23:26:32,806 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:32,807 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 23:26:32,839 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.029
2016-01-14 23:26:32,840 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:32,840 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:32,854 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:32,855 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:32,855 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_false"]
2016-01-14 23:26:32,855 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:32,855 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:32,855 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:32,856 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/false_true_false_false
2016-01-14 23:26:32,882 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local343180595_0010
2016-01-14 23:26:32,882 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:32,887 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:32,902 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:32,902 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:32,909 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: A200FB015DA84F4189F93BEC8FCC5DB6, ordinal: 0
2016-01-14 23:26:32,909 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:32,909 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:32,910 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A200FB015DA84F4189F93BEC8FCC5DB6, mem on start (mb), free: 471, total: 735, max: 735
2016-01-14 23:26:32,914 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A200FB015DA84F4189F93BEC8FCC5DB6, mem on close (mb), free: 471, total: 735, max: 735
2016-01-14 23:26:33,434 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:33,435 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:33,440 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: D469C147DAD1475498A7574AEEE4C95D, ordinal: 1
2016-01-14 23:26:33,441 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:33,441 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_false"]
2016-01-14 23:26:33,441 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: D469C147DAD1475498A7574AEEE4C95D, mem on start (mb), free: 533, total: 736, max: 736
2016-01-14 23:26:33,447 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: D469C147DAD1475498A7574AEEE4C95D, mem on close (mb), free: 532, total: 736, max: 736
2016-01-14 23:26:33,457 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_false/_temporary
2016-01-14 23:26:33,458 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.603
2016-01-14 23:26:33,470 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:33,470 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 23:26:33,498 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.025
2016-01-14 23:26:33,499 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:33,499 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:33,512 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:33,512 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:33,512 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_false"]
2016-01-14 23:26:33,512 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:33,512 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:33,512 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:33,513 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/false_false_true_false
2016-01-14 23:26:33,540 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local380663163_0011
2016-01-14 23:26:33,540 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:33,545 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:33,559 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:33,560 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:33,566 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: E4917FB7F9AF42678A73998102D76323, ordinal: 0
2016-01-14 23:26:33,566 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:33,566 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:33,567 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E4917FB7F9AF42678A73998102D76323, mem on start (mb), free: 417, total: 736, max: 736
2016-01-14 23:26:33,571 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E4917FB7F9AF42678A73998102D76323, mem on close (mb), free: 417, total: 736, max: 736
2016-01-14 23:26:33,580 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:33,580 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:33,585 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: AEAEFFFAEEEE49E1A21E63C84D3E58DF, ordinal: 1
2016-01-14 23:26:33,585 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:33,586 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_false"]
2016-01-14 23:26:33,586 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: AEAEFFFAEEEE49E1A21E63C84D3E58DF, mem on start (mb), free: 416, total: 736, max: 736
2016-01-14 23:26:33,592 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: AEAEFFFAEEEE49E1A21E63C84D3E58DF, mem on close (mb), free: 416, total: 736, max: 736
2016-01-14 23:26:33,603 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_false/_temporary
2016-01-14 23:26:33,604 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.091
2016-01-14 23:26:33,616 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:33,616 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 23:26:33,679 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.060
2016-01-14 23:26:33,680 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:33,681 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:33,693 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:33,694 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:33,694 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_false"]
2016-01-14 23:26:33,694 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:33,694 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:33,695 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:33,695 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/true_false_true_false
2016-01-14 23:26:33,713 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local599579266_0012
2016-01-14 23:26:33,713 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:33,718 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:33,733 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:33,733 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:33,738 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D215A593D22646C2960D2103A02821CB, ordinal: 0
2016-01-14 23:26:33,739 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:33,739 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:33,739 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D215A593D22646C2960D2103A02821CB, mem on start (mb), free: 612, total: 735, max: 735
2016-01-14 23:26:33,743 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D215A593D22646C2960D2103A02821CB, mem on close (mb), free: 612, total: 735, max: 735
2016-01-14 23:26:34,535 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:34,535 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:34,540 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: A4BCA627B50B4FB69957880B0403B389, ordinal: 1
2016-01-14 23:26:34,541 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:34,541 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_false"]
2016-01-14 23:26:34,541 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A4BCA627B50B4FB69957880B0403B389, mem on start (mb), free: 454, total: 736, max: 736
2016-01-14 23:26:34,546 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A4BCA627B50B4FB69957880B0403B389, mem on close (mb), free: 454, total: 736, max: 736
2016-01-14 23:26:34,558 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_false/_temporary
2016-01-14 23:26:34,559 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.865
2016-01-14 23:26:34,572 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:34,573 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 23:26:34,616 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.040
2016-01-14 23:26:34,618 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:34,618 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:34,634 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:34,634 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:34,635 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_false"]
2016-01-14 23:26:34,636 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:34,637 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:34,637 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:34,639 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_true_true_false
2016-01-14 23:26:34,667 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local357247200_0013
2016-01-14 23:26:34,668 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:34,674 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:34,733 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:34,733 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:34,741 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: A5357BE4C4704D6EB822FC171618A8D6, ordinal: 0
2016-01-14 23:26:34,742 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:34,742 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:34,742 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A5357BE4C4704D6EB822FC171618A8D6, mem on start (mb), free: 616, total: 735, max: 735
2016-01-14 23:26:34,747 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A5357BE4C4704D6EB822FC171618A8D6, mem on close (mb), free: 616, total: 735, max: 735
2016-01-14 23:26:35,778 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:35,778 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:35,784 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B9F1D716B2A54D5D97696EEE93CC4E99, ordinal: 1
2016-01-14 23:26:35,784 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:35,784 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_false"]
2016-01-14 23:26:35,785 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B9F1D716B2A54D5D97696EEE93CC4E99, mem on start (mb), free: 591, total: 736, max: 736
2016-01-14 23:26:35,794 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B9F1D716B2A54D5D97696EEE93CC4E99, mem on close (mb), free: 590, total: 736, max: 736
2016-01-14 23:26:35,805 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_false/_temporary
2016-01-14 23:26:35,805 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:01.170
2016-01-14 23:26:35,821 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:35,821 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 23:26:35,849 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.024
2016-01-14 23:26:35,849 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:35,850 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:35,859 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:35,860 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:35,860 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_false"]
2016-01-14 23:26:35,860 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:35,861 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:35,861 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:35,861 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_true_true_false
2016-01-14 23:26:35,880 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local837412171_0014
2016-01-14 23:26:35,880 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:35,884 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:35,900 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:35,900 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:35,906 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: EC78338B61A940E1889D4C46CCE46419, ordinal: 0
2016-01-14 23:26:35,907 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:35,907 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:35,907 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EC78338B61A940E1889D4C46CCE46419, mem on start (mb), free: 475, total: 736, max: 736
2016-01-14 23:26:35,913 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EC78338B61A940E1889D4C46CCE46419, mem on close (mb), free: 475, total: 736, max: 736
2016-01-14 23:26:36,437 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:36,438 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:36,443 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: CA156FC05F1A4484845B1D90E8C961A1, ordinal: 1
2016-01-14 23:26:36,443 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:36,444 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_false"]
2016-01-14 23:26:36,444 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: CA156FC05F1A4484845B1D90E8C961A1, mem on start (mb), free: 537, total: 736, max: 736
2016-01-14 23:26:36,450 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: CA156FC05F1A4484845B1D90E8C961A1, mem on close (mb), free: 536, total: 736, max: 736
2016-01-14 23:26:36,466 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_false/_temporary
2016-01-14 23:26:36,467 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.607
2016-01-14 23:26:36,482 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:36,483 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 23:26:36,510 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.024
2016-01-14 23:26:36,511 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:36,511 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:36,520 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:36,521 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:36,521 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_true"]
2016-01-14 23:26:36,521 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:36,521 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:36,521 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:36,522 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_null_false_true
2016-01-14 23:26:36,540 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1212491725_0015
2016-01-14 23:26:36,540 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:36,547 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:36,561 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:36,562 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:36,569 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F8372B99A87241AF9E6A7D6605C47358, ordinal: 0
2016-01-14 23:26:36,569 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:36,570 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:36,570 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F8372B99A87241AF9E6A7D6605C47358, mem on start (mb), free: 422, total: 736, max: 736
2016-01-14 23:26:36,574 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F8372B99A87241AF9E6A7D6605C47358, mem on close (mb), free: 422, total: 736, max: 736
2016-01-14 23:26:36,582 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:36,582 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:36,587 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B44B13E3903247F6BAD9E8BAB5FE6075, ordinal: 1
2016-01-14 23:26:36,588 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:36,588 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_true"]
2016-01-14 23:26:36,588 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B44B13E3903247F6BAD9E8BAB5FE6075, mem on start (mb), free: 421, total: 736, max: 736
2016-01-14 23:26:36,594 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B44B13E3903247F6BAD9E8BAB5FE6075, mem on close (mb), free: 420, total: 736, max: 736
2016-01-14 23:26:36,606 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_true/_temporary
2016-01-14 23:26:36,607 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.086
2016-01-14 23:26:36,617 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:36,617 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 23:26:36,645 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.025
2016-01-14 23:26:36,645 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:36,646 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:36,658 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:36,658 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:36,658 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_true"]
2016-01-14 23:26:36,658 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:36,658 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:36,658 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:36,659 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_null_false_true
2016-01-14 23:26:36,724 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local301661484_0016
2016-01-14 23:26:36,724 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:36,728 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:36,743 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:36,743 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:36,748 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C3120A73B7034D048FEF8BFF9C162DF0, ordinal: 0
2016-01-14 23:26:36,748 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:36,748 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:36,749 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C3120A73B7034D048FEF8BFF9C162DF0, mem on start (mb), free: 621, total: 736, max: 736
2016-01-14 23:26:36,752 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C3120A73B7034D048FEF8BFF9C162DF0, mem on close (mb), free: 621, total: 736, max: 736
2016-01-14 23:26:36,761 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:36,761 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:36,766 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B9BDF15A5FDB470DB4A57DDAFE6D70F0, ordinal: 1
2016-01-14 23:26:36,767 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:36,768 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_true"]
2016-01-14 23:26:36,768 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B9BDF15A5FDB470DB4A57DDAFE6D70F0, mem on start (mb), free: 620, total: 736, max: 736
2016-01-14 23:26:36,774 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B9BDF15A5FDB470DB4A57DDAFE6D70F0, mem on close (mb), free: 619, total: 736, max: 736
2016-01-14 23:26:36,787 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_true/_temporary
2016-01-14 23:26:36,787 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.129
2016-01-14 23:26:36,798 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:36,798 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 23:26:36,824 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.023
2016-01-14 23:26:36,825 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:36,825 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:36,834 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:36,835 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:36,835 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_true"]
2016-01-14 23:26:36,835 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:36,835 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:36,836 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:36,837 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/false_null_true_true
2016-01-14 23:26:36,855 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local454234741_0017
2016-01-14 23:26:36,855 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:36,859 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:36,905 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:36,906 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:36,911 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: AFE442AFCBC941BA9145E27E714EA7B2, ordinal: 0
2016-01-14 23:26:36,912 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:36,913 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:36,913 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AFE442AFCBC941BA9145E27E714EA7B2, mem on start (mb), free: 612, total: 718, max: 718
2016-01-14 23:26:36,917 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AFE442AFCBC941BA9145E27E714EA7B2, mem on close (mb), free: 612, total: 718, max: 718
2016-01-14 23:26:36,926 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:36,926 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:36,930 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: C8882143399C4E7BBF8C2767C6C94C07, ordinal: 1
2016-01-14 23:26:36,931 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:36,931 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_true"]
2016-01-14 23:26:36,931 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C8882143399C4E7BBF8C2767C6C94C07, mem on start (mb), free: 610, total: 718, max: 718
2016-01-14 23:26:36,936 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C8882143399C4E7BBF8C2767C6C94C07, mem on close (mb), free: 610, total: 718, max: 718
2016-01-14 23:26:36,943 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_true/_temporary
2016-01-14 23:26:36,944 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.109
2016-01-14 23:26:36,954 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:36,954 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 23:26:36,983 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.025
2016-01-14 23:26:36,984 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:36,984 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:36,993 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:36,993 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:36,993 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_true"]
2016-01-14 23:26:36,993 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:36,993 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:36,993 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:36,994 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...nsive/true_null_true_true
2016-01-14 23:26:37,012 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1124822461_0018
2016-01-14 23:26:37,012 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:37,016 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:37,138 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:37,138 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,142 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F5EDB761F43A40539A1734CF9D245B8D, ordinal: 0
2016-01-14 23:26:37,143 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,143 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,143 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F5EDB761F43A40539A1734CF9D245B8D, mem on start (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:37,147 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F5EDB761F43A40539A1734CF9D245B8D, mem on close (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:37,155 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:37,155 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,161 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: A810AEF77A564E9DAB7B559D01646D06, ordinal: 1
2016-01-14 23:26:37,161 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,161 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_true"]
2016-01-14 23:26:37,161 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A810AEF77A564E9DAB7B559D01646D06, mem on start (mb), free: 627, total: 735, max: 735
2016-01-14 23:26:37,169 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A810AEF77A564E9DAB7B559D01646D06, mem on close (mb), free: 627, total: 735, max: 735
2016-01-14 23:26:37,177 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_true/_temporary
2016-01-14 23:26:37,178 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.184
2016-01-14 23:26:37,189 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:37,189 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 23:26:37,214 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.022
2016-01-14 23:26:37,214 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:37,215 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:37,224 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:37,224 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,225 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_true"]
2016-01-14 23:26:37,225 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:37,225 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:37,225 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:37,226 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/false_false_false_true
2016-01-14 23:26:37,244 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1124288027_0019
2016-01-14 23:26:37,244 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:37,248 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:37,263 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:37,263 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,268 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: BD7AD118D89544C4BE0327CBB7761505, ordinal: 0
2016-01-14 23:26:37,269 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,269 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,269 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BD7AD118D89544C4BE0327CBB7761505, mem on start (mb), free: 513, total: 735, max: 735
2016-01-14 23:26:37,273 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BD7AD118D89544C4BE0327CBB7761505, mem on close (mb), free: 513, total: 735, max: 735
2016-01-14 23:26:37,281 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:37,281 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,286 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: ED628EBDEFDE495C8F06C0B8276C2DB5, ordinal: 1
2016-01-14 23:26:37,286 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,286 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_true"]
2016-01-14 23:26:37,287 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: ED628EBDEFDE495C8F06C0B8276C2DB5, mem on start (mb), free: 512, total: 735, max: 735
2016-01-14 23:26:37,292 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: ED628EBDEFDE495C8F06C0B8276C2DB5, mem on close (mb), free: 511, total: 735, max: 735
2016-01-14 23:26:37,307 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_true/_temporary
2016-01-14 23:26:37,307 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.083
2016-01-14 23:26:37,318 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:37,318 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 23:26:37,342 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.021
2016-01-14 23:26:37,343 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:37,343 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:37,355 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:37,356 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,356 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_true"]
2016-01-14 23:26:37,356 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:37,356 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:37,356 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:37,357 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/true_false_false_true
2016-01-14 23:26:37,384 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local185635433_0020
2016-01-14 23:26:37,384 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:37,389 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:37,445 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:37,445 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,452 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B4630CCB376D4C27AAF4737625FA25EA, ordinal: 0
2016-01-14 23:26:37,453 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,453 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,453 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B4630CCB376D4C27AAF4737625FA25EA, mem on start (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:37,459 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B4630CCB376D4C27AAF4737625FA25EA, mem on close (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:37,471 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:37,472 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,479 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: A1AF74AC4B81495C8D8DE88C95DC393F, ordinal: 1
2016-01-14 23:26:37,481 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,481 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_true"]
2016-01-14 23:26:37,482 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A1AF74AC4B81495C8D8DE88C95DC393F, mem on start (mb), free: 627, total: 735, max: 735
2016-01-14 23:26:37,491 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A1AF74AC4B81495C8D8DE88C95DC393F, mem on close (mb), free: 627, total: 735, max: 735
2016-01-14 23:26:37,501 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_true/_temporary
2016-01-14 23:26:37,502 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.146
2016-01-14 23:26:37,518 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:37,518 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 23:26:37,554 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.031
2016-01-14 23:26:37,555 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:37,555 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:37,568 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:37,568 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,569 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_true"]
2016-01-14 23:26:37,570 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:37,570 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:37,570 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:37,571 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_true_false_true
2016-01-14 23:26:37,600 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local389310689_0021
2016-01-14 23:26:37,602 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:37,606 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:37,659 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:37,659 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,664 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: AA9834CEE9934EA3A478610DD70C9B6D, ordinal: 0
2016-01-14 23:26:37,665 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,665 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,665 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AA9834CEE9934EA3A478610DD70C9B6D, mem on start (mb), free: 628, total: 734, max: 734
2016-01-14 23:26:37,670 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AA9834CEE9934EA3A478610DD70C9B6D, mem on close (mb), free: 628, total: 734, max: 734
2016-01-14 23:26:37,679 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:37,679 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,684 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: D87E630386B042C1B998D810EDDC9CE1, ordinal: 1
2016-01-14 23:26:37,684 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,685 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_true"]
2016-01-14 23:26:37,685 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: D87E630386B042C1B998D810EDDC9CE1, mem on start (mb), free: 626, total: 734, max: 734
2016-01-14 23:26:37,691 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: D87E630386B042C1B998D810EDDC9CE1, mem on close (mb), free: 626, total: 734, max: 734
2016-01-14 23:26:37,700 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_true/_temporary
2016-01-14 23:26:37,701 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.132
2016-01-14 23:26:37,711 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:37,711 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 23:26:37,735 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.021
2016-01-14 23:26:37,736 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:37,736 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:37,745 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:37,745 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,745 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_true"]
2016-01-14 23:26:37,745 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:37,745 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:37,746 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:37,747 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_true_false_true
2016-01-14 23:26:37,765 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1185534969_0022
2016-01-14 23:26:37,765 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:37,769 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:37,861 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:37,862 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,866 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C3F3D007BDC44B75AE44423AE3D2B32F, ordinal: 0
2016-01-14 23:26:37,866 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,866 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,866 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C3F3D007BDC44B75AE44423AE3D2B32F, mem on start (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:37,871 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C3F3D007BDC44B75AE44423AE3D2B32F, mem on close (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:37,880 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:37,880 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,884 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B89AFCEB1A7A42C9B90036A20403EAAA, ordinal: 1
2016-01-14 23:26:37,884 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,884 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_true"]
2016-01-14 23:26:37,885 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B89AFCEB1A7A42C9B90036A20403EAAA, mem on start (mb), free: 627, total: 735, max: 735
2016-01-14 23:26:37,890 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B89AFCEB1A7A42C9B90036A20403EAAA, mem on close (mb), free: 627, total: 735, max: 735
2016-01-14 23:26:37,900 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_true/_temporary
2016-01-14 23:26:37,900 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.155
2016-01-14 23:26:37,911 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:37,911 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 23:26:37,934 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.021
2016-01-14 23:26:37,935 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:37,935 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:37,942 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:37,943 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,943 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_true"]
2016-01-14 23:26:37,943 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:37,944 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:37,944 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:37,945 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_false_true_true
2016-01-14 23:26:37,962 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1727659762_0023
2016-01-14 23:26:37,962 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:37,965 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:37,980 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:37,980 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:37,985 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: EEA045842681412E91B3022B1DE0F1D6, ordinal: 0
2016-01-14 23:26:37,985 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:37,985 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:37,986 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EEA045842681412E91B3022B1DE0F1D6, mem on start (mb), free: 514, total: 735, max: 735
2016-01-14 23:26:37,990 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EEA045842681412E91B3022B1DE0F1D6, mem on close (mb), free: 514, total: 735, max: 735
2016-01-14 23:26:37,998 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:37,998 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:38,003 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B1FB43E4A87C423FBA759F379C39994C, ordinal: 1
2016-01-14 23:26:38,003 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:38,003 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_true"]
2016-01-14 23:26:38,004 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B1FB43E4A87C423FBA759F379C39994C, mem on start (mb), free: 512, total: 735, max: 735
2016-01-14 23:26:38,010 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B1FB43E4A87C423FBA759F379C39994C, mem on close (mb), free: 512, total: 735, max: 735
2016-01-14 23:26:38,024 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_true/_temporary
2016-01-14 23:26:38,024 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.082
2016-01-14 23:26:38,035 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:38,035 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 23:26:38,056 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.017
2016-01-14 23:26:38,056 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:38,057 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:38,064 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:38,064 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:38,065 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_true"]
2016-01-14 23:26:38,065 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:38,065 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:38,065 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:38,066 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_false_true_true
2016-01-14 23:26:38,083 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1528561831_0024
2016-01-14 23:26:38,084 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:38,088 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:38,141 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:38,141 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:38,146 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: E500731F7C70493BBC7CF59592A1B113, ordinal: 0
2016-01-14 23:26:38,146 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:38,146 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:38,147 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E500731F7C70493BBC7CF59592A1B113, mem on start (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:38,151 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E500731F7C70493BBC7CF59592A1B113, mem on close (mb), free: 628, total: 735, max: 735
2016-01-14 23:26:38,160 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:38,160 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:38,164 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: F327EFC736F74D5BA7936F0B317A9F02, ordinal: 1
2016-01-14 23:26:38,164 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:38,164 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_true"]
2016-01-14 23:26:38,165 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F327EFC736F74D5BA7936F0B317A9F02, mem on start (mb), free: 627, total: 735, max: 735
2016-01-14 23:26:38,170 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F327EFC736F74D5BA7936F0B317A9F02, mem on close (mb), free: 626, total: 735, max: 735
2016-01-14 23:26:38,179 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_true/_temporary
2016-01-14 23:26:38,180 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.115
2016-01-14 23:26:38,190 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:38,191 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 23:26:38,209 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.016
2016-01-14 23:26:38,210 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:38,210 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:38,217 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:38,217 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:38,218 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_true"]
2016-01-14 23:26:38,218 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:38,218 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:38,218 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:38,219 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...nsive/true_true_true_true
2016-01-14 23:26:38,235 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local962698418_0025
2016-01-14 23:26:38,236 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:38,240 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:38,329 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:38,329 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:38,333 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B897807D62A04313A800766027F6CE5D, ordinal: 0
2016-01-14 23:26:38,333 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:38,333 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:38,334 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B897807D62A04313A800766027F6CE5D, mem on start (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:38,337 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B897807D62A04313A800766027F6CE5D, mem on close (mb), free: 629, total: 735, max: 735
2016-01-14 23:26:38,344 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:38,345 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:38,350 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: C8D15D17F2C34E4EBDD4509E4DBFF34E, ordinal: 1
2016-01-14 23:26:38,350 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:38,350 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_true"]
2016-01-14 23:26:38,351 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C8D15D17F2C34E4EBDD4509E4DBFF34E, mem on start (mb), free: 628, total: 735, max: 735
2016-01-14 23:26:38,356 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C8D15D17F2C34E4EBDD4509E4DBFF34E, mem on close (mb), free: 627, total: 735, max: 735
2016-01-14 23:26:38,368 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_true/_temporary
2016-01-14 23:26:38,369 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.151
2016-01-14 23:26:38,378 INFO util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-14 23:26:38,379 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 23:26:38,399 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.018
2016-01-14 23:26:38,400 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-14 23:26:38,400 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-01-14 23:26:38,407 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-14 23:26:38,407 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:38,407 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_true"]
2016-01-14 23:26:38,407 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] parallel execution of steps is enabled: false
2016-01-14 23:26:38,407 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executing total steps: 1
2016-01-14 23:26:38,408 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] allocating management threads: 1
2016-01-14 23:26:38,409 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/false_true_true_true
2016-01-14 23:26:38,426 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local222003048_0026
2016-01-14 23:26:38,426 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-14 23:26:38,429 INFO io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-14 23:26:38,443 INFO hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-14 23:26:38,443 INFO hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-14 23:26:38,447 INFO hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: DB4C0E195FF74FFEAA76A4EACDD5C632, ordinal: 0
2016-01-14 23:26:38,448 INFO hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-14 23:26:38,448 INFO hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:38,448 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DB4C0E195FF74FFEAA76A4EACDD5C632, mem on start (mb), free: 514, total: 735, max: 735
2016-01-14 23:26:38,452 INFO hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DB4C0E195FF74FFEAA76A4EACDD5C632, mem on close (mb), free: 514, total: 735, max: 735
2016-01-14 23:26:38,460 INFO hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-14 23:26:38,460 INFO hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-14 23:26:38,464 INFO hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: C48DA1C73B3641408ED79F8217147017, ordinal: 1
2016-01-14 23:26:38,464 INFO hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-14 23:26:38,465 INFO hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_true"]
2016-01-14 23:26:38,465 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C48DA1C73B3641408ED79F8217147017, mem on start (mb), free: 513, total: 735, max: 735
2016-01-14 23:26:38,470 INFO hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C48DA1C73B3641408ED79F8217147017, mem on close (mb), free: 513, total: 735, max: 735
2016-01-14 23:26:38,478 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output/hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_true/_temporary
2016-01-14 23:26:38,478 INFO flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] completed in: 00:00.071
2016-01-14 23:26:38,484 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_true
2016-01-14 23:26:38,484 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_true
2016-01-14 23:26:38,485 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_false
2016-01-14 23:26:38,485 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_false
2016-01-14 23:26:38,485 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_false
2016-01-14 23:26:38,485 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_false
2016-01-14 23:26:38,485 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_false
2016-01-14 23:26:38,486 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_true
2016-01-14 23:26:38,486 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_true
2016-01-14 23:26:38,486 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_false
2016-01-14 23:26:38,486 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_true
2016-01-14 23:26:38,487 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_true
2016-01-14 23:26:38,487 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_false
2016-01-14 23:26:38,487 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_true
2016-01-14 23:26:38,487 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_true
2016-01-14 23:26:38,487 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_true
2016-01-14 23:26:38,488 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_true
2016-01-14 23:26:38,488 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_false
2016-01-14 23:26:38,488 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_false
2016-01-14 23:26:38,488 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_false
2016-01-14 23:26:38,489 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_false
2016-01-14 23:26:38,489 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_true
2016-01-14 23:26:38,489 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_false
2016-01-14 23:26:38,489 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/d1e2e77517c04a30/apache-1.2.x/build/test/output//hadoop/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_true