Class cascading.detail.EveryEveryPipeAssemblyPlatformTest

40

tests

0

failures

0

ignored

1m19.86s

duration

100%

successful

Tests

Test Duration Result
-1_'field'_RESULTS.-1_'field2'_'field'[hadoop] 3.185s passed
-1_'field'_RESULTS.-1_'field2'_'field2'[hadoop] 3.265s passed
-1_'field'_RESULTS.-1_'field2'_-1[hadoop] 4.119s passed
-1_'field'_RESULTS.-1_'field2'_ALL[hadoop] 3.167s passed
-1_'field'_RESULTS.-1_'field2'_RESULTS[hadoop] 3.152s passed
-1_'field'_RESULTS.-1_ARGS_'field2'[hadoop] 0.028s passed
-1_'field'_RESULTS.-1_ARGS_ALL[hadoop] 0.020s passed
-1_'field'_RESULTS.-1_ARGS_RESULTS[hadoop] 3.100s passed
-1_'field'_RESULTS.-1_UNKNOWN_'field'[hadoop] 3.131s passed
-1_'field'_RESULTS.-1_UNKNOWN_'field2'[hadoop] 0.030s passed
-1_'field'_RESULTS.-1_UNKNOWN_-1[hadoop] 3.149s passed
-1_'field'_RESULTS.-1_UNKNOWN_ALL[hadoop] 3.111s passed
-1_'field'_RESULTS.-1_UNKNOWN_RESULTS[hadoop] 3.157s passed
-1_'field'_RESULTS.-1_VALUES_'field2'[hadoop] 0.029s passed
-1_'field'_RESULTS.-1_VALUES_-1[hadoop] 0.126s passed
-1_'field'_RESULTS.-1_VALUES_ALL[hadoop] 0.124s passed
-1_'field'_RESULTS.-1_VALUES_RESULTS[hadoop] 0.115s passed
-1_'field'_RESULTS.0_'field2'_'field2'[hadoop] 3.110s passed
-1_'field'_RESULTS.0_'field2'_-1[hadoop] 3.127s passed
-1_'field'_RESULTS.0_'field2'_ALL[hadoop] 3.094s passed
-1_'field'_RESULTS.0_'field2'_RESULTS[hadoop] 3.120s passed
-1_'field'_RESULTS.0_ARGS_'field2'[hadoop] 0.020s passed
-1_'field'_RESULTS.0_ARGS_-1[hadoop] 3.091s passed
-1_'field'_RESULTS.0_ARGS_ALL[hadoop] 0.016s passed
-1_'field'_RESULTS.0_ARGS_RESULTS[hadoop] 3.101s passed
-1_'field'_RESULTS.0_UNKNOWN_'field2'[hadoop] 0.030s passed
-1_'field'_RESULTS.0_UNKNOWN_-1[hadoop] 3.120s passed
-1_'field'_RESULTS.0_UNKNOWN_ALL[hadoop] 3.102s passed
-1_'field'_RESULTS.0_UNKNOWN_RESULTS[hadoop] 3.089s passed
-1_'field'_RESULTS.0_VALUES_'field2'[hadoop] 0.018s passed
-1_'field'_RESULTS.0_VALUES_-1[hadoop] 0.096s passed
-1_'field'_RESULTS.0_VALUES_ALL[hadoop] 0.100s passed
-1_'field'_RESULTS.0_VALUES_RESULTS[hadoop] 0.097s passed
-1_'field'_RESULTS.ALL_'field2'_'field'[hadoop] 3.089s passed
-1_'field'_RESULTS.ALL_'field2'_'field2'[hadoop] 3.076s passed
-1_'field'_RESULTS.ALL_'field2'_-1[hadoop] 3.073s passed
-1_'field'_RESULTS.ALL_'field2'_ALL[hadoop] 3.081s passed
-1_'field'_RESULTS.ALL_'field2'_RESULTS[hadoop] 3.121s passed
-1_'field'_RESULTS.ALL_UNKNOWN_'field2'[hadoop] 0.015s passed
-1_'field'_RESULTS.ALL_UNKNOWN_-1[hadoop] 3.067s passed

Standard output

2016-05-17 23:22:35,601 INFO  platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(197)) - found 1 test platforms from classpath
2016-05-17 23:22:35,617 INFO  platform.PlatformRunner (PlatformRunner.java:addPlatform(246)) - adding test: cascading.detail.EveryEveryPipeAssemblyPlatformTest, with platform: hadoop
2016-05-17 23:22:36,099 INFO  hadoop.HadoopPlatform (HadoopPlatform.java:setUp(127)) - not using cluster
2016-05-17 23:22:36,321 INFO  platform.TestPlatform (TestPlatform.java:getGlobalProperties(75)) - platform property overrides: 
2016-05-17 23:22:36,387 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:36,388 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:36,496 INFO  property.AppProps (AppProps.java:getAppID(177)) - using app.id: 1350BC7A34E54A41B3C4FE93A48A8996
2016-05-17 23:22:36,629 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.092
2016-05-17 23:22:36,631 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:22:36,632 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:22:36,816 INFO  util.Version (Version.java:printBanner(82)) - Concurrent, Inc - Cascading 3.1.0
2016-05-17 23:22:36,820 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:22:36,821 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:36,821 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_-1"]
2016-05-17 23:22:36,822 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:22:36,823 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:22:36,825 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:22:36,826 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...d'_RESULTS.-1_'field2'_-1
2016-05-17 23:22:36,871 WARN  util.NativeCodeLoader (NativeCodeLoader.java:<clinit>(52)) - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
2016-05-17 23:22:37,122 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0001
2016-05-17 23:22:37,124 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:22:37,187 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:22:37,199 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:22:37,199 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:22:37,212 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B1A58475C0DC4B249131E6F7AACE317D, ordinal: 0
2016-05-17 23:22:37,253 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:37,253 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_-1"]
2016-05-17 23:22:37,254 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B1A58475C0DC4B249131E6F7AACE317D, mem on start (mb), free: 241, total: 281, max: 672
2016-05-17 23:22:37,264 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B1A58475C0DC4B249131E6F7AACE317D, mem on close (mb), free: 241, total: 281, max: 672
2016-05-17 23:22:40,170 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_-1/_temporary
2016-05-17 23:22:40,172 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.348
2016-05-17 23:22:40,216 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_'field2'_-1
2016-05-17 23:22:40,235 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:40,235 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:40,310 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.069
2016-05-17 23:22:40,312 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:22:40,312 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:22:40,333 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:22:40,333 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:40,334 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_'field2'"]
2016-05-17 23:22:40,335 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:22:40,335 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:22:40,336 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:22:40,337 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ULTS.-1_'field2'_'field2'
2016-05-17 23:22:40,424 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0002
2016-05-17 23:22:40,426 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:22:40,430 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:22:40,434 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:22:40,434 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:22:40,448 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: E25C13FF099B476FA8BDC0770E594CFF, ordinal: 0
2016-05-17 23:22:40,450 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:40,451 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_'field2'"]
2016-05-17 23:22:40,451 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E25C13FF099B476FA8BDC0770E594CFF, mem on start (mb), free: 229, total: 281, max: 672
2016-05-17 23:22:40,454 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E25C13FF099B476FA8BDC0770E594CFF, mem on close (mb), free: 229, total: 281, max: 672
2016-05-17 23:22:43,441 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_'field2'/_temporary
2016-05-17 23:22:43,442 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.108
2016-05-17 23:22:43,482 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_'field2'_'field2'
2016-05-17 23:22:43,499 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:43,499 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:43,543 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.039
2016-05-17 23:22:43,549 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:22:43,549 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:22:43,562 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:22:43,562 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:43,562 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_'field'"]
2016-05-17 23:22:43,563 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:22:43,563 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:22:43,563 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:22:43,564 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...SULTS.-1_'field2'_'field'
2016-05-17 23:22:43,628 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0003
2016-05-17 23:22:43,630 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:22:43,635 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:22:43,640 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:22:43,641 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:22:43,653 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: CE67AB0D9A0341FF937090810808E6E2, ordinal: 0
2016-05-17 23:22:43,654 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:43,654 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_'field'"]
2016-05-17 23:22:43,655 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: CE67AB0D9A0341FF937090810808E6E2, mem on start (mb), free: 217, total: 281, max: 672
2016-05-17 23:22:43,658 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: CE67AB0D9A0341FF937090810808E6E2, mem on close (mb), free: 217, total: 281, max: 672
2016-05-17 23:22:46,646 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_'field'/_temporary
2016-05-17 23:22:46,647 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.084
2016-05-17 23:22:46,667 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_'field2'_'field'
2016-05-17 23:22:46,675 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:46,676 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:46,717 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.037
2016-05-17 23:22:46,719 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:22:46,719 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:22:46,731 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:22:46,731 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:46,731 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_RESULTS"]
2016-05-17 23:22:46,732 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:22:46,732 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:22:46,732 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:22:46,733 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...SULTS.-1_'field2'_RESULTS
2016-05-17 23:22:46,779 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0004
2016-05-17 23:22:46,779 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:22:46,784 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:22:46,789 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:22:46,789 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:22:46,799 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: A1957A5859914DE89D7807BA326DEA0F, ordinal: 0
2016-05-17 23:22:46,800 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:46,800 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_RESULTS"]
2016-05-17 23:22:46,801 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A1957A5859914DE89D7807BA326DEA0F, mem on start (mb), free: 207, total: 281, max: 672
2016-05-17 23:22:46,804 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A1957A5859914DE89D7807BA326DEA0F, mem on close (mb), free: 207, total: 281, max: 672
2016-05-17 23:22:49,795 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_RESULTS/_temporary
2016-05-17 23:22:49,795 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.063
2016-05-17 23:22:49,820 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_'field2'_RESULTS
2016-05-17 23:22:49,831 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:49,831 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:49,875 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.040
2016-05-17 23:22:49,876 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:22:49,877 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:22:49,892 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:22:49,892 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:49,893 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_ALL"]
2016-05-17 23:22:49,894 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:22:49,894 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:22:49,894 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:22:49,896 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...'_RESULTS.-1_'field2'_ALL
2016-05-17 23:22:49,949 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0005
2016-05-17 23:22:49,949 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:22:49,956 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:22:49,962 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:22:49,962 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:22:49,977 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: E94CD2AFD8A74F3DA0DDAE3999427302, ordinal: 0
2016-05-17 23:22:49,977 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:49,978 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_ALL"]
2016-05-17 23:22:49,978 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E94CD2AFD8A74F3DA0DDAE3999427302, mem on start (mb), free: 196, total: 281, max: 672
2016-05-17 23:22:49,980 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E94CD2AFD8A74F3DA0DDAE3999427302, mem on close (mb), free: 196, total: 281, max: 672
2016-05-17 23:22:52,964 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_'field2'_ALL/_temporary
2016-05-17 23:22:52,965 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.072
2016-05-17 23:22:52,986 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_'field2'_ALL
2016-05-17 23:22:52,998 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:52,998 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:53,046 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.042
2016-05-17 23:22:53,049 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:22:53,049 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:22:53,062 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:22:53,063 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:53,063 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_-1"]
2016-05-17 23:22:53,063 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:22:53,063 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:22:53,064 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:22:53,064 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ld'_RESULTS.-1_UNKNOWN_-1
2016-05-17 23:22:53,102 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0006
2016-05-17 23:22:53,102 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:22:53,110 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:22:53,114 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:22:53,114 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:22:53,126 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: DE237F3B90B94AF0AE7AD7A3EF871CF6, ordinal: 0
2016-05-17 23:22:53,127 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:53,127 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_-1"]
2016-05-17 23:22:53,127 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DE237F3B90B94AF0AE7AD7A3EF871CF6, mem on start (mb), free: 184, total: 281, max: 672
2016-05-17 23:22:53,131 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DE237F3B90B94AF0AE7AD7A3EF871CF6, mem on close (mb), free: 184, total: 281, max: 672
2016-05-17 23:22:56,116 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_-1/_temporary
2016-05-17 23:22:56,117 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.054
2016-05-17 23:22:56,136 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_UNKNOWN_-1
2016-05-17 23:22:56,144 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:56,144 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:56,164 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.016
2016-05-17 23:22:56,165 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:22:56,165 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_UNKNOWN_'field2'
2016-05-17 23:22:56,173 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:56,173 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:56,209 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.032
2016-05-17 23:22:56,210 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:22:56,210 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:22:56,224 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:22:56,225 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:56,225 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_'field'"]
2016-05-17 23:22:56,226 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:22:56,227 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:22:56,227 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:22:56,228 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ESULTS.-1_UNKNOWN_'field'
2016-05-17 23:22:56,262 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0007
2016-05-17 23:22:56,263 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:22:56,267 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:22:56,271 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:22:56,271 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:22:56,281 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C0A0461AF91C474791C955550EDA7C60, ordinal: 0
2016-05-17 23:22:56,282 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:56,282 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_'field'"]
2016-05-17 23:22:56,282 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C0A0461AF91C474791C955550EDA7C60, mem on start (mb), free: 169, total: 281, max: 672
2016-05-17 23:22:56,285 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C0A0461AF91C474791C955550EDA7C60, mem on close (mb), free: 169, total: 281, max: 672
2016-05-17 23:22:59,277 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_'field'/_temporary
2016-05-17 23:22:59,278 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.053
2016-05-17 23:22:59,296 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_UNKNOWN_'field'
2016-05-17 23:22:59,305 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:22:59,305 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:22:59,339 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.030
2016-05-17 23:22:59,342 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:22:59,342 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:22:59,355 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:22:59,356 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:59,356 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_RESULTS"]
2016-05-17 23:22:59,357 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:22:59,357 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:22:59,357 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:22:59,358 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ESULTS.-1_UNKNOWN_RESULTS
2016-05-17 23:22:59,422 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0008
2016-05-17 23:22:59,423 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:22:59,427 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:22:59,431 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:22:59,431 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:22:59,441 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D82FF163B1A749D5A47EE4E69750E09D, ordinal: 0
2016-05-17 23:22:59,442 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:22:59,442 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_RESULTS"]
2016-05-17 23:22:59,442 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D82FF163B1A749D5A47EE4E69750E09D, mem on start (mb), free: 269, total: 281, max: 672
2016-05-17 23:22:59,445 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D82FF163B1A749D5A47EE4E69750E09D, mem on close (mb), free: 269, total: 281, max: 672
2016-05-17 23:23:02,438 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_RESULTS/_temporary
2016-05-17 23:23:02,439 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.082
2016-05-17 23:23:02,454 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_UNKNOWN_RESULTS
2016-05-17 23:23:02,460 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:02,460 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:02,492 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.027
2016-05-17 23:23:02,492 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:02,493 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:02,503 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:02,504 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:02,504 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_ALL"]
2016-05-17 23:23:02,504 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:02,504 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:02,504 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:02,505 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...d'_RESULTS.-1_UNKNOWN_ALL
2016-05-17 23:23:02,536 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0009
2016-05-17 23:23:02,536 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:02,540 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:02,543 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:02,543 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:02,552 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D786962EC5D94B4AB03B96D9BDFA52E4, ordinal: 0
2016-05-17 23:23:02,553 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:02,553 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_ALL"]
2016-05-17 23:23:02,553 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D786962EC5D94B4AB03B96D9BDFA52E4, mem on start (mb), free: 257, total: 281, max: 672
2016-05-17 23:23:02,556 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D786962EC5D94B4AB03B96D9BDFA52E4, mem on close (mb), free: 257, total: 281, max: 672
2016-05-17 23:23:05,550 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_UNKNOWN_ALL/_temporary
2016-05-17 23:23:05,551 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.047
2016-05-17 23:23:05,565 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_UNKNOWN_ALL
2016-05-17 23:23:05,573 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:05,573 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:05,613 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.035
2016-05-17 23:23:05,614 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:05,614 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:05,627 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:05,627 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:05,628 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_-1"]
2016-05-17 23:23:05,629 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:05,629 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:05,629 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:05,631 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...eld'_RESULTS.-1_VALUES_-1
2016-05-17 23:23:05,655 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0010
2016-05-17 23:23:05,657 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:05,661 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:05,664 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:05,664 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:05,673 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: AC6B1DC500D84FE28AEC13C1ACAFCDA8, ordinal: 0
2016-05-17 23:23:05,673 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:05,674 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_-1"]
2016-05-17 23:23:05,674 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AC6B1DC500D84FE28AEC13C1ACAFCDA8, mem on start (mb), free: 247, total: 281, max: 672
2016-05-17 23:23:05,675 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,678 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,680 ERROR element.SourceStage (SourceStage.java:map(118)) - caught throwable
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,681 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: AC6B1DC500D84FE28AEC13C1ACAFCDA8, mem on close (mb), free: 246, total: 281, max: 672
2016-05-17 23:23:05,682 WARN  mapred.LocalJobRunner (LocalJobRunner.java:run(298)) - job_local_0010
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,689 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] hadoop job job_local_0010 state at FAILED
2016-05-17 23:23:05,689 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] failure info: NA
2016-05-17 23:23:05,690 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events identify failed tasks
2016-05-17 23:23:05,690 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events count: 0
2016-05-17 23:23:05,690 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping all jobs
2016-05-17 23:23:05,691 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping: (1/1) ...eld'_RESULTS.-1_VALUES_-1
2016-05-17 23:23:05,691 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopped all jobs
2016-05-17 23:23:05,691 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_-1/_temporary
2016-05-17 23:23:05,692 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:00.064
2016-05-17 23:23:05,692 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_VALUES_-1
2016-05-17 23:23:05,699 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:05,699 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:05,721 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.018
2016-05-17 23:23:05,721 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:23:05,721 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_VALUES_'field2'
2016-05-17 23:23:05,730 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:05,731 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:05,762 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.027
2016-05-17 23:23:05,762 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:05,762 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:05,772 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:05,774 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:05,774 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_RESULTS"]
2016-05-17 23:23:05,775 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:05,775 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:05,776 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:05,776 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...RESULTS.-1_VALUES_RESULTS
2016-05-17 23:23:05,802 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0011
2016-05-17 23:23:05,803 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:05,807 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:05,810 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:05,810 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:05,820 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: A022A73CB64D40D5BA94ACE8B176EA9F, ordinal: 0
2016-05-17 23:23:05,821 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:05,821 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_RESULTS"]
2016-05-17 23:23:05,821 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A022A73CB64D40D5BA94ACE8B176EA9F, mem on start (mb), free: 236, total: 281, max: 672
2016-05-17 23:23:05,822 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,824 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,824 ERROR element.SourceStage (SourceStage.java:map(118)) - caught throwable
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,827 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A022A73CB64D40D5BA94ACE8B176EA9F, mem on close (mb), free: 236, total: 281, max: 672
2016-05-17 23:23:05,828 WARN  mapred.LocalJobRunner (LocalJobRunner.java:run(298)) - job_local_0011
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,834 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] hadoop job job_local_0011 state at FAILED
2016-05-17 23:23:05,834 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] failure info: NA
2016-05-17 23:23:05,834 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events identify failed tasks
2016-05-17 23:23:05,835 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events count: 0
2016-05-17 23:23:05,835 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping all jobs
2016-05-17 23:23:05,835 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping: (1/1) ...RESULTS.-1_VALUES_RESULTS
2016-05-17 23:23:05,835 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopped all jobs
2016-05-17 23:23:05,836 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_RESULTS/_temporary
2016-05-17 23:23:05,836 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:00.063
2016-05-17 23:23:05,836 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_VALUES_RESULTS
2016-05-17 23:23:05,842 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:05,843 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:05,871 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.026
2016-05-17 23:23:05,872 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:05,872 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:05,886 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:05,886 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:05,886 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_ALL"]
2016-05-17 23:23:05,886 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:05,886 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:05,886 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:05,887 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ld'_RESULTS.-1_VALUES_ALL
2016-05-17 23:23:05,913 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0012
2016-05-17 23:23:05,914 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:05,917 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:05,922 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:05,923 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:05,931 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: A1FB501EED2245148360BBBEC094BF62, ordinal: 0
2016-05-17 23:23:05,932 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:05,933 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_ALL"]
2016-05-17 23:23:05,933 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A1FB501EED2245148360BBBEC094BF62, mem on start (mb), free: 227, total: 281, max: 672
2016-05-17 23:23:05,935 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,936 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,942 ERROR element.SourceStage (SourceStage.java:map(118)) - caught throwable
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,947 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A1FB501EED2245148360BBBEC094BF62, mem on close (mb), free: 227, total: 281, max: 672
2016-05-17 23:23:05,948 WARN  mapred.LocalJobRunner (LocalJobRunner.java:run(298)) - job_local_0012
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:05,955 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] hadoop job job_local_0012 state at FAILED
2016-05-17 23:23:05,955 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] failure info: NA
2016-05-17 23:23:05,955 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events identify failed tasks
2016-05-17 23:23:05,955 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events count: 0
2016-05-17 23:23:05,956 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping all jobs
2016-05-17 23:23:05,959 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping: (1/1) ...ld'_RESULTS.-1_VALUES_ALL
2016-05-17 23:23:05,959 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopped all jobs
2016-05-17 23:23:05,959 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_VALUES_ALL/_temporary
2016-05-17 23:23:05,960 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:00.073
2016-05-17 23:23:05,960 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_VALUES_ALL
2016-05-17 23:23:05,970 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:05,971 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:05,987 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.012
2016-05-17 23:23:05,988 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:23:05,988 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_ARGS_'field2'
2016-05-17 23:23:05,996 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:05,996 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:06,021 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.022
2016-05-17 23:23:06,022 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:06,023 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:06,032 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:06,032 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:06,032 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_ARGS_RESULTS"]
2016-05-17 23:23:06,032 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:06,032 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:06,032 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:06,034 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...'_RESULTS.-1_ARGS_RESULTS
2016-05-17 23:23:06,057 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0013
2016-05-17 23:23:06,059 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:06,061 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:06,064 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:06,065 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:06,073 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B9E262FFAF4C4941B5E33FC1CA51D1D5, ordinal: 0
2016-05-17 23:23:06,073 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:06,073 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_ARGS_RESULTS"]
2016-05-17 23:23:06,073 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B9E262FFAF4C4941B5E33FC1CA51D1D5, mem on start (mb), free: 216, total: 281, max: 672
2016-05-17 23:23:06,075 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B9E262FFAF4C4941B5E33FC1CA51D1D5, mem on close (mb), free: 216, total: 281, max: 672
2016-05-17 23:23:09,073 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.-1_ARGS_RESULTS/_temporary
2016-05-17 23:23:09,074 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.041
2016-05-17 23:23:09,088 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_ARGS_RESULTS
2016-05-17 23:23:09,096 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:09,096 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:09,108 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.009
2016-05-17 23:23:09,109 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:23:09,109 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.-1_ARGS_ALL
2016-05-17 23:23:09,116 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:09,117 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:09,141 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.021
2016-05-17 23:23:09,142 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:09,142 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:09,151 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:09,152 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:09,152 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_-1"]
2016-05-17 23:23:09,153 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:09,154 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:09,154 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:09,155 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ld'_RESULTS.0_'field2'_-1
2016-05-17 23:23:09,208 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0014
2016-05-17 23:23:09,209 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:09,213 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:09,218 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:09,218 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:09,229 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: BA936462BACD4F1E901F58F35E8F916A, ordinal: 0
2016-05-17 23:23:09,230 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:09,230 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_-1"]
2016-05-17 23:23:09,230 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BA936462BACD4F1E901F58F35E8F916A, mem on start (mb), free: 201, total: 281, max: 672
2016-05-17 23:23:09,233 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: BA936462BACD4F1E901F58F35E8F916A, mem on close (mb), free: 201, total: 281, max: 672
2016-05-17 23:23:12,223 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_-1/_temporary
2016-05-17 23:23:12,224 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.072
2016-05-17 23:23:12,237 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_'field2'_-1
2016-05-17 23:23:12,243 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:12,243 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:12,277 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.031
2016-05-17 23:23:12,278 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:12,278 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:12,290 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:12,290 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:12,291 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_'field2'"]
2016-05-17 23:23:12,292 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:12,292 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:12,292 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:12,295 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...SULTS.0_'field2'_'field2'
2016-05-17 23:23:12,319 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0015
2016-05-17 23:23:12,319 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:12,325 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:12,329 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:12,329 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:12,340 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B95F3080D9B34B82B394BBFE17FE168B, ordinal: 0
2016-05-17 23:23:12,341 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:12,341 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_'field2'"]
2016-05-17 23:23:12,341 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B95F3080D9B34B82B394BBFE17FE168B, mem on start (mb), free: 189, total: 281, max: 672
2016-05-17 23:23:12,344 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B95F3080D9B34B82B394BBFE17FE168B, mem on close (mb), free: 189, total: 281, max: 672
2016-05-17 23:23:15,334 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_'field2'/_temporary
2016-05-17 23:23:15,335 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.044
2016-05-17 23:23:15,348 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_'field2'_'field2'
2016-05-17 23:23:15,354 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:15,354 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:15,382 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.025
2016-05-17 23:23:15,383 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:15,383 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:15,397 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:15,398 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:15,398 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_RESULTS"]
2016-05-17 23:23:15,399 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:15,399 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:15,399 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:15,401 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ESULTS.0_'field2'_RESULTS
2016-05-17 23:23:15,437 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0016
2016-05-17 23:23:15,438 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:15,446 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:15,451 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:15,451 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:15,463 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: E9E9E39A54134D399C7C9C00029A5F56, ordinal: 0
2016-05-17 23:23:15,464 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:15,465 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_RESULTS"]
2016-05-17 23:23:15,465 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E9E9E39A54134D399C7C9C00029A5F56, mem on start (mb), free: 177, total: 281, max: 672
2016-05-17 23:23:15,469 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: E9E9E39A54134D399C7C9C00029A5F56, mem on close (mb), free: 177, total: 281, max: 672
2016-05-17 23:23:18,455 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_RESULTS/_temporary
2016-05-17 23:23:18,456 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.058
2016-05-17 23:23:18,468 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_'field2'_RESULTS
2016-05-17 23:23:18,474 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:18,474 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:18,498 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.021
2016-05-17 23:23:18,499 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:18,499 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:18,506 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:18,507 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:18,507 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_ALL"]
2016-05-17 23:23:18,507 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:18,507 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:18,507 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:18,508 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...d'_RESULTS.0_'field2'_ALL
2016-05-17 23:23:18,534 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0017
2016-05-17 23:23:18,535 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:18,537 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:18,540 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:18,540 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:18,547 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: ADE58AB6F4E043EA900BF41790A52914, ordinal: 0
2016-05-17 23:23:18,548 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:18,548 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_ALL"]
2016-05-17 23:23:18,548 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: ADE58AB6F4E043EA900BF41790A52914, mem on start (mb), free: 167, total: 281, max: 672
2016-05-17 23:23:18,551 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: ADE58AB6F4E043EA900BF41790A52914, mem on close (mb), free: 167, total: 281, max: 672
2016-05-17 23:23:21,549 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_'field2'_ALL/_temporary
2016-05-17 23:23:21,550 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.043
2016-05-17 23:23:21,563 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_'field2'_ALL
2016-05-17 23:23:21,568 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:21,568 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:21,592 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.020
2016-05-17 23:23:21,592 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:21,593 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:21,604 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:21,605 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:21,605 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_-1"]
2016-05-17 23:23:21,605 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:21,606 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:21,606 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:21,607 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...eld'_RESULTS.0_UNKNOWN_-1
2016-05-17 23:23:21,634 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0018
2016-05-17 23:23:21,634 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:21,636 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:21,639 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:21,639 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:21,647 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F3F91C86CC2044F4AC9A0D3264278F22, ordinal: 0
2016-05-17 23:23:21,647 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:21,647 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_-1"]
2016-05-17 23:23:21,647 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F3F91C86CC2044F4AC9A0D3264278F22, mem on start (mb), free: 156, total: 281, max: 672
2016-05-17 23:23:21,649 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F3F91C86CC2044F4AC9A0D3264278F22, mem on close (mb), free: 156, total: 281, max: 672
2016-05-17 23:23:24,648 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_-1/_temporary
2016-05-17 23:23:24,649 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.043
2016-05-17 23:23:24,683 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_UNKNOWN_-1
2016-05-17 23:23:24,698 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:24,699 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:24,712 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.010
2016-05-17 23:23:24,712 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:23:24,713 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_UNKNOWN_'field2'
2016-05-17 23:23:24,719 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:24,719 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:24,739 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.018
2016-05-17 23:23:24,739 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:24,740 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:24,747 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:24,747 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:24,748 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_RESULTS"]
2016-05-17 23:23:24,748 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:24,748 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:24,748 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:24,750 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...RESULTS.0_UNKNOWN_RESULTS
2016-05-17 23:23:24,771 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0019
2016-05-17 23:23:24,771 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:24,778 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:24,781 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:24,781 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:24,790 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D9841F3A376947E28190DE9545BDBE85, ordinal: 0
2016-05-17 23:23:24,790 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:24,791 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_RESULTS"]
2016-05-17 23:23:24,791 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D9841F3A376947E28190DE9545BDBE85, mem on start (mb), free: 260, total: 280, max: 672
2016-05-17 23:23:24,794 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D9841F3A376947E28190DE9545BDBE85, mem on close (mb), free: 260, total: 280, max: 672
2016-05-17 23:23:27,789 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_RESULTS/_temporary
2016-05-17 23:23:27,789 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.042
2016-05-17 23:23:27,802 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_UNKNOWN_RESULTS
2016-05-17 23:23:27,808 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:27,808 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:27,829 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.018
2016-05-17 23:23:27,829 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:27,829 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:27,841 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:27,842 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:27,842 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_ALL"]
2016-05-17 23:23:27,843 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:27,843 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:27,845 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:27,845 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ld'_RESULTS.0_UNKNOWN_ALL
2016-05-17 23:23:27,875 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0020
2016-05-17 23:23:27,876 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:27,878 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:27,881 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:27,881 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:27,892 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C6D89FB0DC274B05BF732A98E016EB7B, ordinal: 0
2016-05-17 23:23:27,892 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:27,893 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_ALL"]
2016-05-17 23:23:27,893 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C6D89FB0DC274B05BF732A98E016EB7B, mem on start (mb), free: 249, total: 280, max: 672
2016-05-17 23:23:27,895 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C6D89FB0DC274B05BF732A98E016EB7B, mem on close (mb), free: 249, total: 280, max: 672
2016-05-17 23:23:30,890 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_UNKNOWN_ALL/_temporary
2016-05-17 23:23:30,891 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.049
2016-05-17 23:23:30,904 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_UNKNOWN_ALL
2016-05-17 23:23:30,911 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:30,911 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:30,932 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.018
2016-05-17 23:23:30,932 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:30,932 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:30,940 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:30,940 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:30,940 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_-1"]
2016-05-17 23:23:30,940 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:30,940 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:30,941 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:30,941 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ield'_RESULTS.0_VALUES_-1
2016-05-17 23:23:30,961 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0021
2016-05-17 23:23:30,963 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:30,967 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:30,971 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:30,971 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:30,983 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B817696AB809474391D1F1AAAB6EE80E, ordinal: 0
2016-05-17 23:23:30,984 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:30,984 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_-1"]
2016-05-17 23:23:30,986 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B817696AB809474391D1F1AAAB6EE80E, mem on start (mb), free: 238, total: 280, max: 672
2016-05-17 23:23:30,986 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:30,989 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:30,990 ERROR element.SourceStage (SourceStage.java:map(118)) - caught throwable
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:30,990 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B817696AB809474391D1F1AAAB6EE80E, mem on close (mb), free: 238, total: 280, max: 672
2016-05-17 23:23:30,991 WARN  mapred.LocalJobRunner (LocalJobRunner.java:run(298)) - job_local_0021
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:30,994 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] hadoop job job_local_0021 state at FAILED
2016-05-17 23:23:30,994 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] failure info: NA
2016-05-17 23:23:30,995 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events identify failed tasks
2016-05-17 23:23:30,995 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events count: 0
2016-05-17 23:23:30,995 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping all jobs
2016-05-17 23:23:30,998 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping: (1/1) ...ield'_RESULTS.0_VALUES_-1
2016-05-17 23:23:30,998 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopped all jobs
2016-05-17 23:23:30,999 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_-1/_temporary
2016-05-17 23:23:30,999 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:00.059
2016-05-17 23:23:30,999 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_VALUES_-1
2016-05-17 23:23:31,007 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:31,007 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:31,017 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.007
2016-05-17 23:23:31,017 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:23:31,017 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_VALUES_'field2'
2016-05-17 23:23:31,023 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:31,023 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:31,047 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.022
2016-05-17 23:23:31,048 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:31,048 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:31,058 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:31,058 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:31,058 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_RESULTS"]
2016-05-17 23:23:31,059 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:31,060 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:31,060 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:31,060 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ..._RESULTS.0_VALUES_RESULTS
2016-05-17 23:23:31,080 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0022
2016-05-17 23:23:31,080 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:31,083 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:31,085 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:31,085 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:31,091 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: F105E796D2EC44BCB1BA84754222B0D8, ordinal: 0
2016-05-17 23:23:31,092 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:31,092 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_RESULTS"]
2016-05-17 23:23:31,092 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F105E796D2EC44BCB1BA84754222B0D8, mem on start (mb), free: 228, total: 280, max: 672
2016-05-17 23:23:31,093 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:31,096 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:31,099 ERROR element.SourceStage (SourceStage.java:map(118)) - caught throwable
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:31,103 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: F105E796D2EC44BCB1BA84754222B0D8, mem on close (mb), free: 228, total: 280, max: 672
2016-05-17 23:23:31,104 WARN  mapred.LocalJobRunner (LocalJobRunner.java:run(298)) - job_local_0022
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:31,112 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] hadoop job job_local_0022 state at FAILED
2016-05-17 23:23:31,112 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] failure info: NA
2016-05-17 23:23:31,112 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events identify failed tasks
2016-05-17 23:23:31,112 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events count: 0
2016-05-17 23:23:31,112 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping all jobs
2016-05-17 23:23:31,113 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping: (1/1) ..._RESULTS.0_VALUES_RESULTS
2016-05-17 23:23:31,114 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopped all jobs
2016-05-17 23:23:31,114 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_RESULTS/_temporary
2016-05-17 23:23:31,114 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:00.056
2016-05-17 23:23:31,115 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_VALUES_RESULTS
2016-05-17 23:23:31,123 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:31,123 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:31,145 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.018
2016-05-17 23:23:31,146 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:31,146 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:31,156 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:31,157 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:31,157 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_ALL"]
2016-05-17 23:23:31,157 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:31,158 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:31,158 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:31,159 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...eld'_RESULTS.0_VALUES_ALL
2016-05-17 23:23:31,182 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0023
2016-05-17 23:23:31,182 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:31,185 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:31,188 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:31,188 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:31,194 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B9B0A6EF0FB04F7FA1AAFF79CBCBA70B, ordinal: 0
2016-05-17 23:23:31,195 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:31,195 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_ALL"]
2016-05-17 23:23:31,195 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B9B0A6EF0FB04F7FA1AAFF79CBCBA70B, mem on start (mb), free: 218, total: 280, max: 672
2016-05-17 23:23:31,196 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:31,200 ERROR element.TrapHandler (TrapHandler.java:handleReThrowableException(115)) - caught Throwable, no trap available, rethrowing
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:31,203 ERROR element.SourceStage (SourceStage.java:map(118)) - caught throwable
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:31,207 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B9B0A6EF0FB04F7FA1AAFF79CBCBA70B, mem on close (mb), free: 218, total: 280, max: 672
2016-05-17 23:23:31,208 WARN  mapred.LocalJobRunner (LocalJobRunner.java:run(298)) - job_local_0023
cascading.pipe.OperatorException: [every.every][cascading.detail.EachAssemblyFactory.createAssembly(EachAssemblyFactory.java:33)] operator Each failed executing operation
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:108)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.FunctionEachStage$1.collect(FunctionEachStage.java:81)
	at cascading.tuple.TupleEntryCollector.safeCollect(TupleEntryCollector.java:145)
	at cascading.tuple.TupleEntryCollector.add(TupleEntryCollector.java:95)
	at cascading.TestFunction.operate(TestFunction.java:104)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:40)
	at cascading.flow.stream.element.SourceStage.map(SourceStage.java:110)
	at cascading.flow.stream.element.SourceStage.run(SourceStage.java:66)
	at cascading.flow.hadoop.FlowMapper.run(FlowMapper.java:142)
	at org.apache.hadoop.mapred.MapTask.runOldMapper(MapTask.java:436)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:372)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:212)
Caused by: java.lang.IllegalArgumentException: current entry and given tuple must be same length
	at cascading.tuple.TupleEntry.setCanonicalTuple(TupleEntry.java:405)
	at cascading.TestFunction.operate(TestFunction.java:101)
	at cascading.flow.stream.element.FunctionEachStage.receive(FunctionEachStage.java:100)
	... 13 more
2016-05-17 23:23:31,213 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] hadoop job job_local_0023 state at FAILED
2016-05-17 23:23:31,213 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] failure info: NA
2016-05-17 23:23:31,213 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events identify failed tasks
2016-05-17 23:23:31,213 WARN  flow.Flow (BaseFlow.java:logWarn(1516)) - [every.every] task completion events count: 0
2016-05-17 23:23:31,214 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping all jobs
2016-05-17 23:23:31,214 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopping: (1/1) ...eld'_RESULTS.0_VALUES_ALL
2016-05-17 23:23:31,214 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] stopped all jobs
2016-05-17 23:23:31,214 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_VALUES_ALL/_temporary
2016-05-17 23:23:31,215 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:00.058
2016-05-17 23:23:31,215 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_VALUES_ALL
2016-05-17 23:23:31,224 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:31,224 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:31,251 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.024
2016-05-17 23:23:31,252 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:31,252 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:31,261 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:31,262 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:31,263 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_ARGS_-1"]
2016-05-17 23:23:31,263 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:31,263 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:31,264 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:31,265 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...'field'_RESULTS.0_ARGS_-1
2016-05-17 23:23:31,288 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0024
2016-05-17 23:23:31,289 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:31,292 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:31,294 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:31,294 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:31,301 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: EFA463BDCC614B86AD2BB3E86760AA01, ordinal: 0
2016-05-17 23:23:31,301 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:31,301 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_ARGS_-1"]
2016-05-17 23:23:31,302 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EFA463BDCC614B86AD2BB3E86760AA01, mem on start (mb), free: 210, total: 280, max: 672
2016-05-17 23:23:31,303 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EFA463BDCC614B86AD2BB3E86760AA01, mem on close (mb), free: 210, total: 280, max: 672
2016-05-17 23:23:34,294 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_ARGS_-1/_temporary
2016-05-17 23:23:34,295 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.033
2016-05-17 23:23:34,307 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_ARGS_-1
2016-05-17 23:23:34,313 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:34,313 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:34,328 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.011
2016-05-17 23:23:34,328 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:23:34,328 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_ARGS_'field2'
2016-05-17 23:23:34,334 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:34,335 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:34,363 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.025
2016-05-17 23:23:34,363 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:34,364 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:34,371 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:34,372 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:34,372 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_ARGS_RESULTS"]
2016-05-17 23:23:34,372 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:34,372 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:34,372 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:34,374 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...d'_RESULTS.0_ARGS_RESULTS
2016-05-17 23:23:34,401 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0025
2016-05-17 23:23:34,402 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:34,405 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:34,408 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:34,408 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:34,414 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B8CC5E23091245C5BC0CA7AD6EB845EA, ordinal: 0
2016-05-17 23:23:34,415 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:34,415 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_ARGS_RESULTS"]
2016-05-17 23:23:34,415 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B8CC5E23091245C5BC0CA7AD6EB845EA, mem on start (mb), free: 197, total: 280, max: 672
2016-05-17 23:23:34,417 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B8CC5E23091245C5BC0CA7AD6EB845EA, mem on close (mb), free: 197, total: 280, max: 672
2016-05-17 23:23:37,416 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.0_ARGS_RESULTS/_temporary
2016-05-17 23:23:37,417 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.045
2016-05-17 23:23:37,429 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_ARGS_RESULTS
2016-05-17 23:23:37,435 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:37,436 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:37,444 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.006
2016-05-17 23:23:37,445 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:23:37,445 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.0_ARGS_ALL
2016-05-17 23:23:37,451 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:37,452 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:37,472 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.016
2016-05-17 23:23:37,472 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:37,472 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:37,478 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:37,478 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:37,478 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_-1"]
2016-05-17 23:23:37,479 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:37,479 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:37,479 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:37,479 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...'_RESULTS.ALL_'field2'_-1
2016-05-17 23:23:37,499 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0026
2016-05-17 23:23:37,500 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:37,503 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:37,505 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:37,505 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:37,511 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: A798BE7062B0408CA4A1A8F296AC124F, ordinal: 0
2016-05-17 23:23:37,512 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:37,512 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_-1"]
2016-05-17 23:23:37,512 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A798BE7062B0408CA4A1A8F296AC124F, mem on start (mb), free: 181, total: 280, max: 672
2016-05-17 23:23:37,515 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: A798BE7062B0408CA4A1A8F296AC124F, mem on close (mb), free: 181, total: 280, max: 672
2016-05-17 23:23:40,505 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_-1/_temporary
2016-05-17 23:23:40,505 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.027
2016-05-17 23:23:40,517 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.ALL_'field2'_-1
2016-05-17 23:23:40,523 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:40,523 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:40,542 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.016
2016-05-17 23:23:40,543 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:40,543 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:40,550 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:40,550 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:40,552 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_'field2'"]
2016-05-17 23:23:40,552 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:40,554 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:40,554 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:40,556 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...LTS.ALL_'field2'_'field2'
2016-05-17 23:23:40,575 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0027
2016-05-17 23:23:40,577 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:40,580 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:40,583 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:40,583 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:40,591 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: C97341B682614998AA98F0EA7F2D3A5E, ordinal: 0
2016-05-17 23:23:40,592 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:40,592 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_'field2'"]
2016-05-17 23:23:40,593 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C97341B682614998AA98F0EA7F2D3A5E, mem on start (mb), free: 170, total: 280, max: 672
2016-05-17 23:23:40,595 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: C97341B682614998AA98F0EA7F2D3A5E, mem on close (mb), free: 170, total: 280, max: 672
2016-05-17 23:23:43,581 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_'field2'/_temporary
2016-05-17 23:23:43,582 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.031
2016-05-17 23:23:43,594 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.ALL_'field2'_'field2'
2016-05-17 23:23:43,600 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:43,600 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:43,619 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.017
2016-05-17 23:23:43,620 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:43,620 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:43,627 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:43,627 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:43,628 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_'field'"]
2016-05-17 23:23:43,629 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:43,629 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:43,629 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:43,630 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ULTS.ALL_'field2'_'field'
2016-05-17 23:23:43,655 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0028
2016-05-17 23:23:43,655 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:43,660 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:43,663 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:43,663 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:43,668 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: EDA39FE55C244A9EAA01A7E8544D96AC, ordinal: 0
2016-05-17 23:23:43,669 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:43,669 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_'field'"]
2016-05-17 23:23:43,669 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EDA39FE55C244A9EAA01A7E8544D96AC, mem on start (mb), free: 160, total: 280, max: 672
2016-05-17 23:23:43,671 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: EDA39FE55C244A9EAA01A7E8544D96AC, mem on close (mb), free: 160, total: 280, max: 672
2016-05-17 23:23:46,671 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_'field'/_temporary
2016-05-17 23:23:46,672 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.044
2016-05-17 23:23:46,684 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.ALL_'field2'_'field'
2016-05-17 23:23:46,689 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:46,689 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:46,741 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.049
2016-05-17 23:23:46,742 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:46,742 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:46,751 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:46,751 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:46,751 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_RESULTS"]
2016-05-17 23:23:46,752 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:46,752 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:46,752 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:46,754 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...ULTS.ALL_'field2'_RESULTS
2016-05-17 23:23:46,785 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0029
2016-05-17 23:23:46,786 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:46,790 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:46,793 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:46,794 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:46,803 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: DC0EC89C6D08488BBA60C8BCC947C442, ordinal: 0
2016-05-17 23:23:46,803 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:46,804 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_RESULTS"]
2016-05-17 23:23:46,804 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DC0EC89C6D08488BBA60C8BCC947C442, mem on start (mb), free: 262, total: 277, max: 672
2016-05-17 23:23:46,807 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: DC0EC89C6D08488BBA60C8BCC947C442, mem on close (mb), free: 262, total: 277, max: 672
2016-05-17 23:23:49,792 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_RESULTS/_temporary
2016-05-17 23:23:49,792 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.041
2016-05-17 23:23:49,804 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.ALL_'field2'_RESULTS
2016-05-17 23:23:49,811 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:49,811 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:49,828 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.015
2016-05-17 23:23:49,829 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:49,829 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:49,835 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:49,835 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:49,836 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_ALL"]
2016-05-17 23:23:49,836 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:49,837 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:49,837 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:49,839 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ..._RESULTS.ALL_'field2'_ALL
2016-05-17 23:23:49,860 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0030
2016-05-17 23:23:49,860 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:49,862 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:49,865 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:49,865 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:49,870 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: D28612A0C6B3470FA2CD3423BD7C8A8A, ordinal: 0
2016-05-17 23:23:49,871 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:49,871 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_ALL"]
2016-05-17 23:23:49,871 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D28612A0C6B3470FA2CD3423BD7C8A8A, mem on start (mb), free: 252, total: 277, max: 672
2016-05-17 23:23:49,874 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: D28612A0C6B3470FA2CD3423BD7C8A8A, mem on close (mb), free: 252, total: 277, max: 672
2016-05-17 23:23:52,874 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_'field2'_ALL/_temporary
2016-05-17 23:23:52,874 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.039
2016-05-17 23:23:52,886 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.ALL_'field2'_ALL
2016-05-17 23:23:52,893 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:52,893 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:52,909 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.014
2016-05-17 23:23:52,910 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 1, nodes: 1
2016-05-17 23:23:52,910 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-17 23:23:52,915 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting
2016-05-17 23:23:52,915 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  source: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:52,915 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_UNKNOWN_-1"]
2016-05-17 23:23:52,915 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  parallel execution of steps is enabled: false
2016-05-17 23:23:52,915 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  executing total steps: 1
2016-05-17 23:23:52,915 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  allocating management threads: 1
2016-05-17 23:23:52,916 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] starting step: (1/1) ...d'_RESULTS.ALL_UNKNOWN_-1
2016-05-17 23:23:52,935 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] submitted hadoop job: job_local_0031
2016-05-17 23:23:52,935 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] tracking url: http://localhost:8080/
2016-05-17 23:23:52,938 INFO  io.MultiInputSplit (MultiInputSplit.java:readFields(161)) - current split input path: file:/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt
2016-05-17 23:23:52,940 INFO  hadoop.FlowMapper (FlowMapper.java:configure(75)) - cascading version: 3.1.0
2016-05-17 23:23:52,940 INFO  hadoop.FlowMapper (FlowMapper.java:configure(76)) - child jvm opts: -Xmx200m
2016-05-17 23:23:52,945 INFO  hadoop.FlowMapper (FlowMapper.java:configure(87)) - flow node id: B06B686AF6364700A9740ABE65A58370, ordinal: 0
2016-05-17 23:23:52,945 INFO  hadoop.FlowMapper (FlowMapper.java:configure(94)) - sourcing from: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/classes/test/data/nums.20.txt"]
2016-05-17 23:23:52,945 INFO  hadoop.FlowMapper (FlowMapper.java:configure(97)) - sinking to: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_UNKNOWN_-1"]
2016-05-17 23:23:52,945 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B06B686AF6364700A9740ABE65A58370, mem on start (mb), free: 241, total: 277, max: 672
2016-05-17 23:23:52,947 INFO  hadoop.FlowMapper (LogUtil.java:logMemory(59)) - flow node id: B06B686AF6364700A9740ABE65A58370, mem on close (mb), free: 241, total: 277, max: 672
2016-05-17 23:23:55,939 INFO  util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output/hadoop/everyeverypipeassemblyplatform/-1_'field'_RESULTS.ALL_UNKNOWN_-1/_temporary
2016-05-17 23:23:55,940 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every]  completed in: 00:03.024
2016-05-17 23:23:55,953 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.ALL_UNKNOWN_-1
2016-05-17 23:23:55,958 INFO  util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-17 23:23:55,958 INFO  planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop/3.1.0/86eabf0febb15d07d5285b321b1f6b06e25aa664/cascading-hadoop-3.1.0.jar
2016-05-17 23:23:55,968 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.007
2016-05-17 23:23:55,968 INFO  flow.Flow (BaseFlow.java:logInfo(1504)) - [every.every] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-17 23:23:55,968 INFO  cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/ddea2c91addb6250/apache-0.20.205.0/build/test/output//hadoop/everyeverypipeassemblyplatform//-1_'field'_RESULTS.ALL_UNKNOWN_'field2'