Class cascading.SortedValuesPlatformTest

4

tests

0

failures

0

ignored

1m9.28s

duration

100%

successful

Tests

Test Duration Result
testCoGroupComparatorValues 19.481s passed
testCoGroupComparatorValuesReversed 24.679s passed
testComprehensiveGroupBy 25.076s passed
testSortFails 0.045s passed

Standard output

2016-01-15 04:27:23,588 INFO  platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(195)) - found 1 test platforms from classpath
2016-01-15 04:27:23,611 INFO  platform.PlatformRunner (PlatformRunner.java:addPlatform(244)) - adding test: cascading.SortedValuesPlatformTest, with platform: hadoop2-mr1
2016-01-15 04:27:23,653 INFO  hadoop2.Hadoop2MR1Platform (Hadoop2MR1Platform.java:setUp(119)) - not using cluster
2016-01-15 04:27:24,477 WARN  util.NativeCodeLoader (NativeCodeLoader.java:<clinit>(62)) - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
2016-01-15 04:27:24,678 INFO  platform.TestPlatform (TestPlatform.java:getGlobalProperties(73)) - platform property overrides: 
2016-01-15 04:27:24,818 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:27:24,820 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:27:24,898 INFO  property.AppProps (AppProps.java:getAppID(177)) - using app.id: 97AC50C5553E40A49A5955CF25564A3B
2016-01-15 04:27:25,114 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.159
2016-01-15 04:27:25,118 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:27:25,118 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-15 04:27:25,312 INFO  util.Version (Version.java:printBanner(82)) - Concurrent, Inc - Cascading 3.0.4
2016-01-15 04:27:25,314 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] starting
2016-01-15 04:27:25,315 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/apache.200.txt"]
2016-01-15 04:27:25,316 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/ips.20.txt"]
2016-01-15 04:27:25,317 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  sink: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testCoGroupComparatorValuesReversed/cogroupcomparereversed"]
2016-01-15 04:27:25,319 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  parallel execution of steps is enabled: false
2016-01-15 04:27:25,320 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  executing total steps: 1
2016-01-15 04:27:25,321 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  allocating management threads: 1
2016-01-15 04:27:25,322 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] starting step: (1/1) ...ed/cogroupcomparereversed
2016-01-15 04:27:25,965 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] submitted hadoop job: job_local1996676433_0001
2016-01-15 04:27:25,966 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] tracking url: http://localhost:8080/
2016-01-15 04:27:26,045 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/apache.200.txt
2016-01-15 04:27:26,185 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:27:26,186 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:27:26,204 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C66ED3EE8376447EB9ABA0B05E7320A4, ordinal: 0
2016-01-15 04:27:26,251 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/apache.200.txt"]
2016-01-15 04:27:26,251 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-15 04:27:26,252 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C66ED3EE8376447EB9ABA0B05E7320A4, mem on start (mb), free: 59, total: 223, max: 672
2016-01-15 04:27:26,298 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C66ED3EE8376447EB9ABA0B05E7320A4, mem on close (mb), free: 58, total: 223, max: 672
2016-01-15 04:27:42,992 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/ips.20.txt
2016-01-15 04:27:43,013 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:27:43,014 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:27:43,031 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C66ED3EE8376447EB9ABA0B05E7320A4, ordinal: 0
2016-01-15 04:27:43,032 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/ips.20.txt"]
2016-01-15 04:27:43,032 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-15 04:27:43,033 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C66ED3EE8376447EB9ABA0B05E7320A4, mem on start (mb), free: 156, total: 394, max: 672
2016-01-15 04:27:43,037 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C66ED3EE8376447EB9ABA0B05E7320A4, mem on close (mb), free: 156, total: 394, max: 672
2016-01-15 04:27:48,153 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:27:48,154 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:27:48,167 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: F38317BF426E472B8D8686FD3A7DE00A, ordinal: 1
2016-01-15 04:27:48,170 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-15 04:27:48,170 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testCoGroupComparatorValuesReversed/cogroupcomparereversed"]
2016-01-15 04:27:48,171 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F38317BF426E472B8D8686FD3A7DE00A, mem on start (mb), free: 221, total: 433, max: 672
2016-01-15 04:27:48,190 INFO  collect.SpillableTupleList (SpillableTupleList.java:getCodecClass(89)) - attempting to load codec: org.apache.hadoop.io.compress.GzipCodec
2016-01-15 04:27:48,190 INFO  collect.SpillableTupleList (SpillableTupleList.java:getCodecClass(94)) - found codec: org.apache.hadoop.io.compress.GzipCodec
2016-01-15 04:27:48,227 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F38317BF426E472B8D8686FD3A7DE00A, mem on close (mb), free: 216, total: 433, max: 672
2016-01-15 04:27:48,272 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testCoGroupComparatorValuesReversed/cogroupcomparereversed/_temporary
2016-01-15 04:27:48,273 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  completed in: 00:22.957
2016-01-15 04:27:48,329 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testCoGroupComparatorValuesReversed/cogroupcomparereversed
2016-01-15 04:27:48,355 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:27:48,356 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:27:48,473 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.105
2016-01-15 04:27:48,475 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:27:48,475 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-15 04:27:48,509 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] starting
2016-01-15 04:27:48,510 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/apache.200.txt"]
2016-01-15 04:27:48,512 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/ips.20.txt"]
2016-01-15 04:27:48,513 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  sink: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testCoGroupComparatorValues/cogroupcompareforward"]
2016-01-15 04:27:48,514 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  parallel execution of steps is enabled: false
2016-01-15 04:27:48,515 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  executing total steps: 1
2016-01-15 04:27:48,516 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  allocating management threads: 1
2016-01-15 04:27:48,517 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] starting step: (1/1) ...ues/cogroupcompareforward
2016-01-15 04:27:48,671 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] submitted hadoop job: job_local1407486557_0002
2016-01-15 04:27:48,671 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip] tracking url: http://localhost:8080/
2016-01-15 04:27:48,678 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/apache.200.txt
2016-01-15 04:27:48,712 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:27:48,712 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:27:48,727 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: AF02DC40A2424D47826BF20978E26669, ordinal: 0
2016-01-15 04:27:48,728 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/apache.200.txt"]
2016-01-15 04:27:48,728 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-15 04:27:48,729 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AF02DC40A2424D47826BF20978E26669, mem on start (mb), free: 109, total: 534, max: 672
2016-01-15 04:27:48,758 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AF02DC40A2424D47826BF20978E26669, mem on close (mb), free: 109, total: 534, max: 672
2016-01-15 04:28:03,084 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/ips.20.txt
2016-01-15 04:28:03,100 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:03,101 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:03,113 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: AF02DC40A2424D47826BF20978E26669, ordinal: 0
2016-01-15 04:28:03,113 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/ips.20.txt"]
2016-01-15 04:28:03,114 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-15 04:28:03,114 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AF02DC40A2424D47826BF20978E26669, mem on start (mb), free: 124, total: 534, max: 672
2016-01-15 04:28:03,117 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AF02DC40A2424D47826BF20978E26669, mem on close (mb), free: 124, total: 534, max: 672
2016-01-15 04:28:07,683 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:07,683 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:07,693 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: E4F359C2FB8148A1A232314CEDAC88F5, ordinal: 1
2016-01-15 04:28:07,694 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: CoGroup(apache*ip)[by: apache:[{1}:'octet'] ip:[{1}:'rawoctet']]
2016-01-15 04:28:07,694 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testCoGroupComparatorValues/cogroupcompareforward"]
2016-01-15 04:28:07,695 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: E4F359C2FB8148A1A232314CEDAC88F5, mem on start (mb), free: 198, total: 423, max: 672
2016-01-15 04:28:07,705 INFO  collect.SpillableTupleList (SpillableTupleList.java:getCodecClass(89)) - attempting to load codec: org.apache.hadoop.io.compress.GzipCodec
2016-01-15 04:28:07,705 INFO  collect.SpillableTupleList (SpillableTupleList.java:getCodecClass(94)) - found codec: org.apache.hadoop.io.compress.GzipCodec
2016-01-15 04:28:07,732 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: E4F359C2FB8148A1A232314CEDAC88F5, mem on close (mb), free: 194, total: 423, max: 672
2016-01-15 04:28:07,761 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testCoGroupComparatorValues/cogroupcompareforward/_temporary
2016-01-15 04:28:07,762 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache*ip]  completed in: 00:19.252
2016-01-15 04:28:07,813 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testCoGroupComparatorValues/cogroupcompareforward
2016-01-15 04:28:07,833 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:07,834 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:07,859 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.019
2016-01-15 04:28:07,860 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [apache] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-01-15 04:28:07,879 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:07,879 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:07,946 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.057
2016-01-15 04:28:07,948 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:07,948 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-15 04:28:07,973 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:07,973 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:07,973 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_false"]
2016-01-15 04:28:07,974 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:07,974 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:07,974 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:07,975 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/false_null_false_false
2016-01-15 04:28:08,141 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local2146238798_0003
2016-01-15 04:28:08,145 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:08,152 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:08,174 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:08,175 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:08,185 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: A13431CCA0744A51B813D3A4658BA604, ordinal: 0
2016-01-15 04:28:08,186 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:08,186 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:08,186 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A13431CCA0744A51B813D3A4658BA604, mem on start (mb), free: 194, total: 418, max: 672
2016-01-15 04:28:08,191 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A13431CCA0744A51B813D3A4658BA604, mem on close (mb), free: 194, total: 418, max: 672
2016-01-15 04:28:08,205 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:08,205 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:08,213 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: CCE8463859744671BC71D071AF78B6A7, ordinal: 1
2016-01-15 04:28:08,213 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:08,213 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_false"]
2016-01-15 04:28:08,214 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: CCE8463859744671BC71D071AF78B6A7, mem on start (mb), free: 182, total: 418, max: 672
2016-01-15 04:28:08,229 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: CCE8463859744671BC71D071AF78B6A7, mem on close (mb), free: 179, total: 418, max: 672
2016-01-15 04:28:08,251 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_false/_temporary
2016-01-15 04:28:08,252 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.278
2016-01-15 04:28:08,289 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:08,289 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:08,335 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.041
2016-01-15 04:28:08,336 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:08,337 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-15 04:28:08,358 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:08,358 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:08,358 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_false"]
2016-01-15 04:28:08,358 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:08,359 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:08,359 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:08,360 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/true_null_false_false
2016-01-15 04:28:08,465 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local2039255659_0004
2016-01-15 04:28:08,466 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:08,475 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:08,496 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:08,496 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:08,507 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: E77906CDC5754A8FA34A6DA251D9D17C, ordinal: 0
2016-01-15 04:28:08,508 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:08,508 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:08,509 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E77906CDC5754A8FA34A6DA251D9D17C, mem on start (mb), free: 199, total: 419, max: 672
2016-01-15 04:28:08,514 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E77906CDC5754A8FA34A6DA251D9D17C, mem on close (mb), free: 197, total: 419, max: 672
2016-01-15 04:28:10,291 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:10,291 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:10,299 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: F8DAF3A0F22B44858B09024BF95B10D1, ordinal: 1
2016-01-15 04:28:10,300 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:10,300 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_false"]
2016-01-15 04:28:10,301 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F8DAF3A0F22B44858B09024BF95B10D1, mem on start (mb), free: 202, total: 418, max: 672
2016-01-15 04:28:10,313 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F8DAF3A0F22B44858B09024BF95B10D1, mem on close (mb), free: 199, total: 418, max: 672
2016-01-15 04:28:10,335 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_false/_temporary
2016-01-15 04:28:10,336 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:01.977
2016-01-15 04:28:10,371 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:10,371 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:10,413 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.037
2016-01-15 04:28:10,414 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:10,415 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-15 04:28:10,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:10,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:10,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_false"]
2016-01-15 04:28:10,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:10,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:10,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:10,435 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_null_true_false
2016-01-15 04:28:10,542 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local649009244_0005
2016-01-15 04:28:10,544 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:10,548 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:10,568 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:10,569 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:10,581 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: AFB4159433F84C3AA7A6D0CAE4FB55EA, ordinal: 0
2016-01-15 04:28:10,582 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:10,582 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:10,583 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AFB4159433F84C3AA7A6D0CAE4FB55EA, mem on start (mb), free: 199, total: 419, max: 672
2016-01-15 04:28:10,589 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AFB4159433F84C3AA7A6D0CAE4FB55EA, mem on close (mb), free: 199, total: 419, max: 672
2016-01-15 04:28:10,605 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:10,605 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:10,615 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: F527257C888B4D18BE8B828D233FB809, ordinal: 1
2016-01-15 04:28:10,616 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:10,616 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_false"]
2016-01-15 04:28:10,616 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F527257C888B4D18BE8B828D233FB809, mem on start (mb), free: 190, total: 419, max: 672
2016-01-15 04:28:10,632 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F527257C888B4D18BE8B828D233FB809, mem on close (mb), free: 188, total: 419, max: 672
2016-01-15 04:28:10,656 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_false/_temporary
2016-01-15 04:28:10,657 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.222
2016-01-15 04:28:10,693 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:10,694 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:10,750 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.050
2016-01-15 04:28:10,752 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:10,752 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-15 04:28:10,777 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:10,778 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:10,778 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_false"]
2016-01-15 04:28:10,778 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:10,778 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:10,778 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:10,779 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_null_true_false
2016-01-15 04:28:10,874 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local905228617_0006
2016-01-15 04:28:10,875 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:10,880 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:10,898 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:10,898 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:10,905 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F6456C24E5D041F8BC5ED879D8592C1A, ordinal: 0
2016-01-15 04:28:10,906 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:10,906 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:10,906 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F6456C24E5D041F8BC5ED879D8592C1A, mem on start (mb), free: 200, total: 417, max: 672
2016-01-15 04:28:10,910 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F6456C24E5D041F8BC5ED879D8592C1A, mem on close (mb), free: 200, total: 417, max: 672
2016-01-15 04:28:12,656 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:12,656 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:12,662 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: DBD785F5D4CC403B826B634B3042110B, ordinal: 1
2016-01-15 04:28:12,663 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:12,663 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_false"]
2016-01-15 04:28:12,663 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: DBD785F5D4CC403B826B634B3042110B, mem on start (mb), free: 201, total: 421, max: 672
2016-01-15 04:28:12,676 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: DBD785F5D4CC403B826B634B3042110B, mem on close (mb), free: 198, total: 421, max: 672
2016-01-15 04:28:12,698 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_false/_temporary
2016-01-15 04:28:12,698 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:01.920
2016-01-15 04:28:12,732 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:12,733 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:12,775 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.037
2016-01-15 04:28:12,776 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:12,776 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-15 04:28:12,792 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:12,792 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:12,793 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_false"]
2016-01-15 04:28:12,793 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:12,793 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:12,793 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:12,794 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...e/false_false_false_false
2016-01-15 04:28:12,900 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1880198340_0007
2016-01-15 04:28:12,901 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:12,905 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:12,925 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:12,925 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:12,933 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C69B79B2D13441C3817CE394FB430392, ordinal: 0
2016-01-15 04:28:12,934 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:12,935 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:12,935 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C69B79B2D13441C3817CE394FB430392, mem on start (mb), free: 201, total: 421, max: 672
2016-01-15 04:28:12,940 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C69B79B2D13441C3817CE394FB430392, mem on close (mb), free: 201, total: 421, max: 672
2016-01-15 04:28:12,958 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:12,959 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:12,967 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: E423FE913E2C46768F6572C85EFBCA48, ordinal: 1
2016-01-15 04:28:12,967 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:12,968 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_false"]
2016-01-15 04:28:12,968 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: E423FE913E2C46768F6572C85EFBCA48, mem on start (mb), free: 193, total: 421, max: 672
2016-01-15 04:28:12,981 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: E423FE913E2C46768F6572C85EFBCA48, mem on close (mb), free: 190, total: 421, max: 672
2016-01-15 04:28:13,001 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_false/_temporary
2016-01-15 04:28:13,001 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.209
2016-01-15 04:28:13,036 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:13,037 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:13,074 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.033
2016-01-15 04:28:13,074 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:13,075 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-15 04:28:13,091 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:13,091 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:13,091 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_false"]
2016-01-15 04:28:13,091 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:13,092 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:13,092 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:13,092 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/true_false_false_false
2016-01-15 04:28:13,204 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local517528852_0008
2016-01-15 04:28:13,205 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:13,210 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:13,229 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:13,230 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:13,236 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C6E82E5F997849B5AB42AF292C5C4627, ordinal: 0
2016-01-15 04:28:13,237 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:13,237 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:13,237 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C6E82E5F997849B5AB42AF292C5C4627, mem on start (mb), free: 203, total: 420, max: 672
2016-01-15 04:28:13,242 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C6E82E5F997849B5AB42AF292C5C4627, mem on close (mb), free: 203, total: 420, max: 672
2016-01-15 04:28:15,787 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:15,787 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:15,796 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: F30B8ED6C4854241A9D95D06C9E7FAB9, ordinal: 1
2016-01-15 04:28:15,797 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:15,797 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_false"]
2016-01-15 04:28:15,797 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F30B8ED6C4854241A9D95D06C9E7FAB9, mem on start (mb), free: 266, total: 423, max: 672
2016-01-15 04:28:15,811 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F30B8ED6C4854241A9D95D06C9E7FAB9, mem on close (mb), free: 261, total: 423, max: 672
2016-01-15 04:28:15,836 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_false/_temporary
2016-01-15 04:28:15,837 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:02.745
2016-01-15 04:28:15,872 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:15,873 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:15,910 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.033
2016-01-15 04:28:15,911 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:15,911 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-15 04:28:15,926 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:15,926 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:15,926 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_false"]
2016-01-15 04:28:15,926 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:15,927 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:15,927 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:15,928 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/true_true_false_false
2016-01-15 04:28:16,020 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1491606639_0009
2016-01-15 04:28:16,021 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:16,025 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:16,044 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:16,044 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:16,050 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D2E04424C6E74F24BC2CBAB59E5798FD, ordinal: 0
2016-01-15 04:28:16,051 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:16,051 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:16,051 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D2E04424C6E74F24BC2CBAB59E5798FD, mem on start (mb), free: 205, total: 423, max: 672
2016-01-15 04:28:16,055 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D2E04424C6E74F24BC2CBAB59E5798FD, mem on close (mb), free: 205, total: 423, max: 672
2016-01-15 04:28:19,246 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:19,247 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:19,252 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: CA32CF8A7773430DB3FF9EF340B0D5A2, ordinal: 1
2016-01-15 04:28:19,253 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:19,253 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_false"]
2016-01-15 04:28:19,254 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: CA32CF8A7773430DB3FF9EF340B0D5A2, mem on start (mb), free: 178, total: 425, max: 672
2016-01-15 04:28:19,266 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: CA32CF8A7773430DB3FF9EF340B0D5A2, mem on close (mb), free: 174, total: 425, max: 672
2016-01-15 04:28:19,290 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_false/_temporary
2016-01-15 04:28:19,291 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:03.364
2016-01-15 04:28:19,325 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:19,325 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:19,359 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.028
2016-01-15 04:28:19,360 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:19,360 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-15 04:28:19,374 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:19,374 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:19,375 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_false"]
2016-01-15 04:28:19,375 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:19,375 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:19,375 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:19,376 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/false_true_false_false
2016-01-15 04:28:19,468 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local645020227_0010
2016-01-15 04:28:19,469 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:19,474 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:19,493 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:19,493 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:19,500 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D3990F0E05E647978A24B0CB4F223297, ordinal: 0
2016-01-15 04:28:19,501 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:19,501 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:19,501 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D3990F0E05E647978A24B0CB4F223297, mem on start (mb), free: 203, total: 425, max: 672
2016-01-15 04:28:19,505 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D3990F0E05E647978A24B0CB4F223297, mem on close (mb), free: 203, total: 425, max: 672
2016-01-15 04:28:21,136 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:21,137 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:21,143 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: C2B5F55041C242049229CC8DAC66DADA, ordinal: 1
2016-01-15 04:28:21,143 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:21,143 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_false"]
2016-01-15 04:28:21,143 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C2B5F55041C242049229CC8DAC66DADA, mem on start (mb), free: 245, total: 425, max: 672
2016-01-15 04:28:21,155 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C2B5F55041C242049229CC8DAC66DADA, mem on close (mb), free: 242, total: 425, max: 672
2016-01-15 04:28:21,170 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_false/_temporary
2016-01-15 04:28:21,171 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:01.796
2016-01-15 04:28:21,203 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:21,204 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:21,237 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.029
2016-01-15 04:28:21,238 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:21,238 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-15 04:28:21,252 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:21,253 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:21,253 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_false"]
2016-01-15 04:28:21,254 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:21,254 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:21,254 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:21,255 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/false_false_true_false
2016-01-15 04:28:21,395 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1668671973_0011
2016-01-15 04:28:21,396 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:21,404 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:21,425 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:21,425 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:21,435 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C891A5BA5C774B33B3C8A546204825D5, ordinal: 0
2016-01-15 04:28:21,435 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:21,436 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:21,436 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C891A5BA5C774B33B3C8A546204825D5, mem on start (mb), free: 209, total: 428, max: 672
2016-01-15 04:28:21,442 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C891A5BA5C774B33B3C8A546204825D5, mem on close (mb), free: 209, total: 428, max: 672
2016-01-15 04:28:21,461 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:21,461 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:21,470 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: D86036628F5948BD9313DD08DD95CEDD, ordinal: 1
2016-01-15 04:28:21,471 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:21,471 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_false"]
2016-01-15 04:28:21,471 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: D86036628F5948BD9313DD08DD95CEDD, mem on start (mb), free: 201, total: 428, max: 672
2016-01-15 04:28:21,488 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: D86036628F5948BD9313DD08DD95CEDD, mem on close (mb), free: 198, total: 428, max: 672
2016-01-15 04:28:21,512 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_false/_temporary
2016-01-15 04:28:21,513 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.260
2016-01-15 04:28:21,551 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:21,552 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:21,582 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.026
2016-01-15 04:28:21,582 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:21,583 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-15 04:28:21,596 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:21,596 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:21,597 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_false"]
2016-01-15 04:28:21,597 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:21,597 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:21,597 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:21,598 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/true_false_true_false
2016-01-15 04:28:21,689 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1593542811_0012
2016-01-15 04:28:21,689 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:21,693 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:21,711 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:21,712 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:21,718 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F0FE5913759048BEB915EEE22E7F4B13, ordinal: 0
2016-01-15 04:28:21,719 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:21,719 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:21,720 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F0FE5913759048BEB915EEE22E7F4B13, mem on start (mb), free: 211, total: 429, max: 672
2016-01-15 04:28:21,724 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F0FE5913759048BEB915EEE22E7F4B13, mem on close (mb), free: 211, total: 429, max: 672
2016-01-15 04:28:24,306 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:24,306 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:24,312 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: D2594D4DD97D40C081B763842C6ABDFD, ordinal: 1
2016-01-15 04:28:24,312 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:24,312 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_false"]
2016-01-15 04:28:24,313 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: D2594D4DD97D40C081B763842C6ABDFD, mem on start (mb), free: 273, total: 431, max: 672
2016-01-15 04:28:24,325 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: D2594D4DD97D40C081B763842C6ABDFD, mem on close (mb), free: 269, total: 431, max: 672
2016-01-15 04:28:24,348 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_false/_temporary
2016-01-15 04:28:24,348 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:02.752
2016-01-15 04:28:24,386 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:24,387 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:24,419 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.025
2016-01-15 04:28:24,420 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:24,421 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-15 04:28:24,440 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:24,440 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:24,441 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_false"]
2016-01-15 04:28:24,441 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:24,441 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:24,441 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:24,442 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_true_true_false
2016-01-15 04:28:24,541 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local616511996_0013
2016-01-15 04:28:24,541 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:24,545 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:24,564 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:24,564 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:24,571 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: BFF9168CDDE145AD9A95FFA91EF20400, ordinal: 0
2016-01-15 04:28:24,572 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:24,572 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:24,572 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BFF9168CDDE145AD9A95FFA91EF20400, mem on start (mb), free: 211, total: 430, max: 672
2016-01-15 04:28:24,577 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BFF9168CDDE145AD9A95FFA91EF20400, mem on close (mb), free: 211, total: 430, max: 672
2016-01-15 04:28:27,810 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:27,810 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:27,816 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: FC8556072275404598681E949650CE6D, ordinal: 1
2016-01-15 04:28:27,817 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:27,817 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_false"]
2016-01-15 04:28:27,817 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: FC8556072275404598681E949650CE6D, mem on start (mb), free: 183, total: 433, max: 672
2016-01-15 04:28:27,830 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: FC8556072275404598681E949650CE6D, mem on close (mb), free: 179, total: 433, max: 672
2016-01-15 04:28:27,851 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_false/_temporary
2016-01-15 04:28:27,852 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:03.411
2016-01-15 04:28:27,884 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:27,884 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:27,926 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.036
2016-01-15 04:28:27,927 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:27,927 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-15 04:28:27,942 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:27,942 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:27,943 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_false"]
2016-01-15 04:28:27,943 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:27,943 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:27,943 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:27,944 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_true_true_false
2016-01-15 04:28:28,037 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local639747357_0014
2016-01-15 04:28:28,043 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:28,047 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:28,063 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:28,063 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:28,071 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F1B9C92E2508492F8AAF5DE0D222F6DD, ordinal: 0
2016-01-15 04:28:28,072 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:28,072 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:28,072 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F1B9C92E2508492F8AAF5DE0D222F6DD, mem on start (mb), free: 208, total: 432, max: 672
2016-01-15 04:28:28,078 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F1B9C92E2508492F8AAF5DE0D222F6DD, mem on close (mb), free: 208, total: 432, max: 672
2016-01-15 04:28:29,732 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:29,732 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:29,739 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: A3C6581ACF044D4C84AF00712C69D91A, ordinal: 1
2016-01-15 04:28:29,739 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:29,739 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_false"]
2016-01-15 04:28:29,740 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A3C6581ACF044D4C84AF00712C69D91A, mem on start (mb), free: 253, total: 436, max: 672
2016-01-15 04:28:29,751 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A3C6581ACF044D4C84AF00712C69D91A, mem on close (mb), free: 250, total: 436, max: 672
2016-01-15 04:28:29,776 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_false/_temporary
2016-01-15 04:28:29,776 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:01.833
2016-01-15 04:28:29,807 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:29,807 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:29,834 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.024
2016-01-15 04:28:29,834 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:29,835 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-15 04:28:29,847 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:29,847 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:29,847 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_true"]
2016-01-15 04:28:29,848 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:29,848 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:29,850 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:29,850 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_null_false_true
2016-01-15 04:28:29,944 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local751392311_0015
2016-01-15 04:28:29,945 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:29,949 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:29,967 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:29,967 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:29,973 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C58F6F8710004534975642BA3A2E906F, ordinal: 0
2016-01-15 04:28:29,973 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:29,973 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:29,974 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C58F6F8710004534975642BA3A2E906F, mem on start (mb), free: 217, total: 436, max: 672
2016-01-15 04:28:29,977 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C58F6F8710004534975642BA3A2E906F, mem on close (mb), free: 217, total: 436, max: 672
2016-01-15 04:28:29,989 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:29,989 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:29,994 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: F795FBB3B42E437CACC97F668BDF3FC5, ordinal: 1
2016-01-15 04:28:29,995 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:29,995 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_true"]
2016-01-15 04:28:29,995 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F795FBB3B42E437CACC97F668BDF3FC5, mem on start (mb), free: 209, total: 436, max: 672
2016-01-15 04:28:30,007 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: F795FBB3B42E437CACC97F668BDF3FC5, mem on close (mb), free: 206, total: 436, max: 672
2016-01-15 04:28:30,031 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_true/_temporary
2016-01-15 04:28:30,031 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.184
2016-01-15 04:28:30,067 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:30,068 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:30,096 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.025
2016-01-15 04:28:30,097 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:30,098 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-15 04:28:30,110 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:30,110 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:30,110 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_true"]
2016-01-15 04:28:30,111 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:30,112 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:30,112 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:30,114 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_null_false_true
2016-01-15 04:28:30,209 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local663308762_0016
2016-01-15 04:28:30,210 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:30,215 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:30,234 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:30,234 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:30,239 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: BC2D694191F441D98535B77B73583E5E, ordinal: 0
2016-01-15 04:28:30,240 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:30,240 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:30,240 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BC2D694191F441D98535B77B73583E5E, mem on start (mb), free: 218, total: 435, max: 672
2016-01-15 04:28:30,246 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BC2D694191F441D98535B77B73583E5E, mem on close (mb), free: 218, total: 435, max: 672
2016-01-15 04:28:30,264 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:30,264 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:30,272 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B1303F67A9E34CB9965AD561AB5A9FC5, ordinal: 1
2016-01-15 04:28:30,273 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:30,273 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_true"]
2016-01-15 04:28:30,273 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B1303F67A9E34CB9965AD561AB5A9FC5, mem on start (mb), free: 211, total: 435, max: 672
2016-01-15 04:28:30,287 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B1303F67A9E34CB9965AD561AB5A9FC5, mem on close (mb), free: 209, total: 435, max: 672
2016-01-15 04:28:30,308 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_true/_temporary
2016-01-15 04:28:30,309 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.198
2016-01-15 04:28:30,341 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:30,341 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:30,367 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.023
2016-01-15 04:28:30,367 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:30,368 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-15 04:28:30,378 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:30,379 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:30,379 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_true"]
2016-01-15 04:28:30,379 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:30,379 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:30,380 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:30,380 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/false_null_true_true
2016-01-15 04:28:30,477 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local481655785_0017
2016-01-15 04:28:30,478 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:30,483 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:30,501 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:30,501 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:30,506 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C3FD700BDF864173ADF02AE3F1C2CC48, ordinal: 0
2016-01-15 04:28:30,506 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:30,507 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:30,507 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C3FD700BDF864173ADF02AE3F1C2CC48, mem on start (mb), free: 205, total: 423, max: 672
2016-01-15 04:28:30,510 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C3FD700BDF864173ADF02AE3F1C2CC48, mem on close (mb), free: 205, total: 423, max: 672
2016-01-15 04:28:30,523 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:30,523 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:30,527 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: E1CB896BE6DD4398B7C42C8132FC22D6, ordinal: 1
2016-01-15 04:28:30,528 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:30,528 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_true"]
2016-01-15 04:28:30,528 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: E1CB896BE6DD4398B7C42C8132FC22D6, mem on start (mb), free: 198, total: 423, max: 672
2016-01-15 04:28:30,539 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: E1CB896BE6DD4398B7C42C8132FC22D6, mem on close (mb), free: 196, total: 423, max: 672
2016-01-15 04:28:30,557 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_true/_temporary
2016-01-15 04:28:30,558 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.179
2016-01-15 04:28:30,592 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:30,592 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:30,617 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.022
2016-01-15 04:28:30,618 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:30,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-15 04:28:30,628 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:30,628 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:30,629 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_true"]
2016-01-15 04:28:30,629 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:30,629 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:30,629 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:30,630 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...nsive/true_null_true_true
2016-01-15 04:28:30,722 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1143676891_0018
2016-01-15 04:28:30,722 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:30,727 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:30,747 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:30,747 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:30,753 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: E09A1D175E64461EB9DDBCEE0CDCB43E, ordinal: 0
2016-01-15 04:28:30,753 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:30,754 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:30,754 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E09A1D175E64461EB9DDBCEE0CDCB43E, mem on start (mb), free: 217, total: 435, max: 672
2016-01-15 04:28:30,758 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E09A1D175E64461EB9DDBCEE0CDCB43E, mem on close (mb), free: 217, total: 435, max: 672
2016-01-15 04:28:30,772 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:30,772 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:30,777 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B5CCDE51EF0B41B784FC72688070F0ED, ordinal: 1
2016-01-15 04:28:30,778 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:30,778 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_true"]
2016-01-15 04:28:30,778 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B5CCDE51EF0B41B784FC72688070F0ED, mem on start (mb), free: 211, total: 435, max: 672
2016-01-15 04:28:30,790 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B5CCDE51EF0B41B784FC72688070F0ED, mem on close (mb), free: 209, total: 435, max: 672
2016-01-15 04:28:30,812 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_true/_temporary
2016-01-15 04:28:30,812 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.184
2016-01-15 04:28:30,844 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:30,844 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:30,871 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.022
2016-01-15 04:28:30,872 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:30,872 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-15 04:28:30,883 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:30,884 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:30,884 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_true"]
2016-01-15 04:28:30,884 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:30,884 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:30,885 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:30,885 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ve/false_false_false_true
2016-01-15 04:28:30,979 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1367076069_0019
2016-01-15 04:28:30,979 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:30,984 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:31,001 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:31,002 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:31,007 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C711AD505DE249749A32ADF2EC3A7EF1, ordinal: 0
2016-01-15 04:28:31,007 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:31,007 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:31,008 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C711AD505DE249749A32ADF2EC3A7EF1, mem on start (mb), free: 203, total: 422, max: 672
2016-01-15 04:28:31,012 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C711AD505DE249749A32ADF2EC3A7EF1, mem on close (mb), free: 203, total: 422, max: 672
2016-01-15 04:28:31,026 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:31,026 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:31,033 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: A84BB3EF229B46049126A6D81AA9FC1C, ordinal: 1
2016-01-15 04:28:31,033 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:31,033 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_true"]
2016-01-15 04:28:31,034 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A84BB3EF229B46049126A6D81AA9FC1C, mem on start (mb), free: 197, total: 422, max: 672
2016-01-15 04:28:31,045 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A84BB3EF229B46049126A6D81AA9FC1C, mem on close (mb), free: 195, total: 422, max: 672
2016-01-15 04:28:31,065 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_true/_temporary
2016-01-15 04:28:31,066 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.182
2016-01-15 04:28:31,097 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:31,098 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:31,123 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.022
2016-01-15 04:28:31,123 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:31,124 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-15 04:28:31,133 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:31,134 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:31,134 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_true"]
2016-01-15 04:28:31,134 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:31,134 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:31,134 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:31,135 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/true_false_false_true
2016-01-15 04:28:31,232 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1523795026_0020
2016-01-15 04:28:31,233 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:31,238 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:31,257 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:31,257 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:31,265 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C0275029FC6A46EDB9F59CF7CD4FDE57, ordinal: 0
2016-01-15 04:28:31,266 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:31,266 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:31,266 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C0275029FC6A46EDB9F59CF7CD4FDE57, mem on start (mb), free: 214, total: 435, max: 672
2016-01-15 04:28:31,270 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C0275029FC6A46EDB9F59CF7CD4FDE57, mem on close (mb), free: 214, total: 435, max: 672
2016-01-15 04:28:31,290 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:31,290 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:31,297 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: C65F73B746A143BE90453E815F9A0E57, ordinal: 1
2016-01-15 04:28:31,298 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:31,298 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_true"]
2016-01-15 04:28:31,298 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C65F73B746A143BE90453E815F9A0E57, mem on start (mb), free: 208, total: 435, max: 672
2016-01-15 04:28:31,313 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C65F73B746A143BE90453E815F9A0E57, mem on close (mb), free: 206, total: 435, max: 672
2016-01-15 04:28:31,331 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_true/_temporary
2016-01-15 04:28:31,332 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.198
2016-01-15 04:28:31,379 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:31,380 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:31,416 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.032
2016-01-15 04:28:31,417 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:31,417 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-15 04:28:31,432 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:31,432 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:31,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_true"]
2016-01-15 04:28:31,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:31,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:31,433 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:31,434 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_true_false_true
2016-01-15 04:28:31,541 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local337833481_0021
2016-01-15 04:28:31,542 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:31,546 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:31,567 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:31,574 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:31,585 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D1629A2FC15447529104999440486905, ordinal: 0
2016-01-15 04:28:31,586 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:31,587 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:31,587 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D1629A2FC15447529104999440486905, mem on start (mb), free: 214, total: 435, max: 672
2016-01-15 04:28:31,595 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D1629A2FC15447529104999440486905, mem on close (mb), free: 214, total: 435, max: 672
2016-01-15 04:28:31,617 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:31,618 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:31,622 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B3A374E13C104CCA9C08BECA6E76AF63, ordinal: 1
2016-01-15 04:28:31,622 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:31,622 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_true"]
2016-01-15 04:28:31,622 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B3A374E13C104CCA9C08BECA6E76AF63, mem on start (mb), free: 208, total: 435, max: 672
2016-01-15 04:28:31,634 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B3A374E13C104CCA9C08BECA6E76AF63, mem on close (mb), free: 205, total: 435, max: 672
2016-01-15 04:28:31,650 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_true/_temporary
2016-01-15 04:28:31,651 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.218
2016-01-15 04:28:31,691 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:31,691 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:31,715 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.021
2016-01-15 04:28:31,715 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:31,716 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-15 04:28:31,726 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:31,726 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:31,726 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_true"]
2016-01-15 04:28:31,727 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:31,727 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:31,727 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:31,727 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_true_false_true
2016-01-15 04:28:31,819 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1833907608_0022
2016-01-15 04:28:31,819 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:31,823 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:31,843 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:31,843 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:31,847 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: BF92DD2A71F44246905F2DDCDE3A4EBC, ordinal: 0
2016-01-15 04:28:31,848 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:31,848 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:31,848 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BF92DD2A71F44246905F2DDCDE3A4EBC, mem on start (mb), free: 214, total: 435, max: 672
2016-01-15 04:28:31,852 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BF92DD2A71F44246905F2DDCDE3A4EBC, mem on close (mb), free: 214, total: 435, max: 672
2016-01-15 04:28:31,864 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:31,865 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:31,869 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: C0ADD7D8E874443D9F3224004510F0F9, ordinal: 1
2016-01-15 04:28:31,869 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:31,870 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_true"]
2016-01-15 04:28:31,870 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C0ADD7D8E874443D9F3224004510F0F9, mem on start (mb), free: 208, total: 435, max: 672
2016-01-15 04:28:31,882 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: C0ADD7D8E874443D9F3224004510F0F9, mem on close (mb), free: 206, total: 435, max: 672
2016-01-15 04:28:31,898 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_true/_temporary
2016-01-15 04:28:31,899 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.171
2016-01-15 04:28:31,940 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:31,940 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:31,964 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.020
2016-01-15 04:28:31,965 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:31,965 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-15 04:28:31,974 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:31,975 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:31,975 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_true"]
2016-01-15 04:28:31,975 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:31,975 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:31,975 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:31,976 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...ive/false_false_true_true
2016-01-15 04:28:32,067 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local1606957077_0023
2016-01-15 04:28:32,067 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:32,071 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:32,089 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:32,089 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:32,094 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F02067F8AD11477B868C0E8ADC9D9A1B, ordinal: 0
2016-01-15 04:28:32,095 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:32,095 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:32,095 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F02067F8AD11477B868C0E8ADC9D9A1B, mem on start (mb), free: 213, total: 435, max: 672
2016-01-15 04:28:32,100 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F02067F8AD11477B868C0E8ADC9D9A1B, mem on close (mb), free: 213, total: 435, max: 672
2016-01-15 04:28:32,112 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:32,112 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:32,116 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: E960AB78938E4067B0F93B74B45F3230, ordinal: 1
2016-01-15 04:28:32,116 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:32,117 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_true"]
2016-01-15 04:28:32,117 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: E960AB78938E4067B0F93B74B45F3230, mem on start (mb), free: 208, total: 435, max: 672
2016-01-15 04:28:32,127 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: E960AB78938E4067B0F93B74B45F3230, mem on close (mb), free: 206, total: 435, max: 672
2016-01-15 04:28:32,144 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_true/_temporary
2016-01-15 04:28:32,144 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.169
2016-01-15 04:28:32,176 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:32,176 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:32,207 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.027
2016-01-15 04:28:32,208 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:32,208 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-15 04:28:32,216 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:32,216 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:32,217 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_true"]
2016-01-15 04:28:32,217 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:32,217 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:32,218 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:32,218 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/true_false_true_true
2016-01-15 04:28:32,313 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local148770619_0024
2016-01-15 04:28:32,313 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:32,316 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:32,335 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:32,335 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:32,340 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: A6D1E11F7B78468E9F636CC662239251, ordinal: 0
2016-01-15 04:28:32,341 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:32,341 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:32,342 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A6D1E11F7B78468E9F636CC662239251, mem on start (mb), free: 213, total: 436, max: 672
2016-01-15 04:28:32,346 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A6D1E11F7B78468E9F636CC662239251, mem on close (mb), free: 213, total: 436, max: 672
2016-01-15 04:28:32,364 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:32,364 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:32,371 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: BB0AAB1D5E0440E3AD1EDF2627634FDD, ordinal: 1
2016-01-15 04:28:32,372 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:32,372 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_true"]
2016-01-15 04:28:32,372 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: BB0AAB1D5E0440E3AD1EDF2627634FDD, mem on start (mb), free: 208, total: 436, max: 672
2016-01-15 04:28:32,386 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: BB0AAB1D5E0440E3AD1EDF2627634FDD, mem on close (mb), free: 206, total: 436, max: 672
2016-01-15 04:28:32,410 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_true/_temporary
2016-01-15 04:28:32,410 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.194
2016-01-15 04:28:32,442 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:32,442 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:32,467 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.022
2016-01-15 04:28:32,467 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:32,467 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-15 04:28:32,476 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:32,477 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:32,477 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_true"]
2016-01-15 04:28:32,477 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:32,477 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:32,477 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:32,479 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...nsive/true_true_true_true
2016-01-15 04:28:32,569 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local575921153_0025
2016-01-15 04:28:32,569 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:32,572 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:32,591 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:32,592 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:32,598 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C377FE2E6D3049938586D1D56994591C, ordinal: 0
2016-01-15 04:28:32,598 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:32,598 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:32,599 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C377FE2E6D3049938586D1D56994591C, mem on start (mb), free: 213, total: 436, max: 672
2016-01-15 04:28:32,603 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C377FE2E6D3049938586D1D56994591C, mem on close (mb), free: 213, total: 436, max: 672
2016-01-15 04:28:32,614 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:32,615 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:32,618 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: A9293ADF4A5848B1966D4C1133B104AF, ordinal: 1
2016-01-15 04:28:32,619 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:32,619 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_true"]
2016-01-15 04:28:32,619 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A9293ADF4A5848B1966D4C1133B104AF, mem on start (mb), free: 208, total: 436, max: 672
2016-01-15 04:28:32,634 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: A9293ADF4A5848B1966D4C1133B104AF, mem on close (mb), free: 206, total: 436, max: 672
2016-01-15 04:28:32,656 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_true/_temporary
2016-01-15 04:28:32,656 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.180
2016-01-15 04:28:32,686 INFO  util.Util (Util.java:findMainClass(1327)) - using default application jar, may cause class not found exceptions on the cluster
2016-01-15 04:28:32,687 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(174)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.0.4/6099926be810c2c62f4bd24f369d52cdd84cf31d/cascading-hadoop2-mr1-3.0.4.jar
2016-01-15 04:28:32,719 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.028
2016-01-15 04:28:32,719 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 2
2016-01-15 04:28:32,719 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-15 04:28:32,732 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting
2016-01-15 04:28:32,732 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  source: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:32,733 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  sink: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_true"]
2016-01-15 04:28:32,733 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  parallel execution of steps is enabled: false
2016-01-15 04:28:32,734 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  executing total steps: 1
2016-01-15 04:28:32,735 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  allocating management threads: 1
2016-01-15 04:28:32,736 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] starting step: (1/1) ...sive/false_true_true_true
2016-01-15 04:28:32,836 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] submitted hadoop job: job_local549518897_0026
2016-01-15 04:28:32,836 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort] tracking url: http://localhost:8080/
2016-01-15 04:28:32,839 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt
2016-01-15 04:28:32,858 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.0.4
2016-01-15 04:28:32,858 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-01-15 04:28:32,862 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C9C0AA46700D4E388C58BCA9337E93E9, ordinal: 0
2016-01-15 04:28:32,863 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/classes/test/data/lhs+rhs-cross.txt"]
2016-01-15 04:28:32,863 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:32,863 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C9C0AA46700D4E388C58BCA9337E93E9, mem on start (mb), free: 213, total: 437, max: 672
2016-01-15 04:28:32,867 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C9C0AA46700D4E388C58BCA9337E93E9, mem on close (mb), free: 213, total: 437, max: 672
2016-01-15 04:28:32,879 INFO  hadoop.FlowReducer (FlowReducer.java:configure(83)) - cascading version: 3.0.4
2016-01-15 04:28:32,879 INFO  hadoop.FlowReducer (FlowReducer.java:configure(84)) - child jvm opts: -Xmx200m
2016-01-15 04:28:32,883 INFO  hadoop.FlowReducer (FlowReducer.java:configure(97)) - flow node id: B636276AD1D14948BED10EDBD34F150F, ordinal: 1
2016-01-15 04:28:32,884 INFO  hadoop.FlowReducer (FlowReducer.java:configure(104)) - sourcing from: GroupBy(comprehensivesort)[by:[{1}:'num']]
2016-01-15 04:28:32,884 INFO  hadoop.FlowReducer (FlowReducer.java:configure(107)) - sinking to: Hfs["TextLine[['line']->['num', 'lower', 'upper']]"]["/opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_true"]
2016-01-15 04:28:32,884 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B636276AD1D14948BED10EDBD34F150F, mem on start (mb), free: 208, total: 437, max: 672
2016-01-15 04:28:32,895 INFO  hadoop.FlowReducer (LogUtil.java:logMemory(59)) - flow node id: B636276AD1D14948BED10EDBD34F150F, mem on close (mb), free: 206, total: 437, max: 672
2016-01-15 04:28:32,911 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output/hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_true/_temporary
2016-01-15 04:28:32,912 INFO  flow.Flow (BaseFlow.java:logInfo(1433)) - [comprehensivesort]  completed in: 00:00.178
2016-01-15 04:28:32,932 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_false
2016-01-15 04:28:32,932 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_false
2016-01-15 04:28:32,932 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_false
2016-01-15 04:28:32,932 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_false
2016-01-15 04:28:32,933 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_true
2016-01-15 04:28:32,933 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_true_true
2016-01-15 04:28:32,933 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_false
2016-01-15 04:28:32,933 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_true
2016-01-15 04:28:32,933 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_false
2016-01-15 04:28:32,934 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_true
2016-01-15 04:28:32,934 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_false
2016-01-15 04:28:32,934 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_false
2016-01-15 04:28:32,934 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_false_false_false
2016-01-15 04:28:32,934 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_false_true
2016-01-15 04:28:32,935 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_true_false
2016-01-15 04:28:32,935 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_false_true
2016-01-15 04:28:32,935 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_true_true
2016-01-15 04:28:32,935 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_true_true_true
2016-01-15 04:28:32,936 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_true_false_true
2016-01-15 04:28:32,936 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_true_true
2016-01-15 04:28:32,936 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_null_false_false
2016-01-15 04:28:32,936 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_false
2016-01-15 04:28:32,937 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/false_false_false_true
2016-01-15 04:28:32,937 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/aa7cf7440ab7c2d9/apache-2.7.x/build/test/output//hadoop2-mr1/sortedvaluesplatform/testComprehensiveGroupBy/comprehensive/true_null_true_true