2016-05-18 00:52:25,626 INFO platform.PlatformRunner (PlatformRunner.java:getPlatformClassesFromClasspath(197)) - found 1 test platforms from classpath
2016-05-18 00:52:25,650 INFO platform.PlatformRunner (PlatformRunner.java:addPlatform(246)) - adding test: cascading.pipe.checkpoint.CheckpointPlatformTest, with platform: hadoop2-mr1
2016-05-18 00:52:25,684 INFO hadoop2.Hadoop2MR1Platform (Hadoop2MR1Platform.java:setUp(136)) - using cluster
2016-05-18 00:52:26,492 WARN util.NativeCodeLoader (NativeCodeLoader.java:<clinit>(62)) - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
Formatting using clusterid: testClusterID
2016-05-18 00:52:27,042 WARN impl.MetricsConfig (MetricsConfig.java:loadFirst(124)) - Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
2016-05-18 00:52:27,569 WARN server.AuthenticationFilter (AuthenticationFilter.java:init(158)) - 'signature.secret' configuration not set, using a random value as secret
2016-05-18 00:52:30,404 WARN containermanager.AuxServices (AuxServices.java:serviceInit(114)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class class org.apache.hadoop.mapred.ShuffleHandler which has a name of 'httpshuffle'. Because these are not the same tools trying to send ServiceData and read Service Meta Data may have issues unless the refer to the name in the config.
2016-05-18 00:52:30,550 WARN containermanager.AuxServices (AuxServices.java:serviceInit(114)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class class org.apache.hadoop.mapred.ShuffleHandler which has a name of 'httpshuffle'. Because these are not the same tools trying to send ServiceData and read Service Meta Data may have issues unless the refer to the name in the config.
2016-05-18 00:52:30,658 WARN containermanager.AuxServices (AuxServices.java:serviceInit(114)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class class org.apache.hadoop.mapred.ShuffleHandler which has a name of 'httpshuffle'. Because these are not the same tools trying to send ServiceData and read Service Meta Data may have issues unless the refer to the name in the config.
2016-05-18 00:52:30,767 WARN containermanager.AuxServices (AuxServices.java:serviceInit(114)) - The Auxilurary Service named 'mapreduce_shuffle' in the configuration is for class class org.apache.hadoop.mapred.ShuffleHandler which has a name of 'httpshuffle'. Because these are not the same tools trying to send ServiceData and read Service Meta Data may have issues unless the refer to the name in the config.
2016-05-18 00:52:47,841 INFO platform.TestPlatform (TestPlatform.java:getGlobalProperties(75)) - platform property overrides:
2016-05-18 00:52:47,935 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:52:47,936 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:52:48,002 INFO property.AppProps (AppProps.java:getAppID(177)) - using app.id: 9DB2FD1FAC9747058ABF0BABB07C2220
2016-05-18 00:52:48,075 INFO planner.FlowPlanner (FlowPlanner.java:decorateTap(798)) - found decorator: cascading.flowconnector.checkpoint_tap.decorator.classname, wrapping tap: TempHfs["null"][3748575694/test/]
2016-05-18 00:52:48,180 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.141
2016-05-18 00:52:48,184 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 3, nodes: 4
2016-05-18 00:52:48,185 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 00:52:48,339 INFO util.Version (Version.java:printBanner(82)) - Concurrent, Inc - Cascading 3.1.0
2016-05-18 00:52:48,340 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting
2016-05-18 00:52:48,341 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/apache.10.txt"]
2016-05-18 00:52:48,341 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testManyCheckpoints/manycheckpoint"]
2016-05-18 00:52:48,342 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] parallel execution of steps is enabled: true
2016-05-18 00:52:48,342 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executing total steps: 3
2016-05-18 00:52:48,343 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] allocating management threads: 3
2016-05-18 00:52:48,346 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (1/3)
2016-05-18 00:52:49,151 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463532762339_0001
2016-05-18 00:52:49,152 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0001/
2016-05-18 00:53:05,143 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0001_01_000004 is : 143
2016-05-18 00:53:05,310 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0001_01_000003 is : 143
2016-05-18 00:53:05,352 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0001_01_000002 is : 143
2016-05-18 00:53:06,129 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0001_01_000005 is : 143
2016-05-18 00:53:07,343 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (2/3)
2016-05-18 00:53:07,571 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463532762339_0002
2016-05-18 00:53:07,571 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0002/
2016-05-18 00:53:23,050 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0002_01_000003 is : 143
2016-05-18 00:53:23,154 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0002_01_000002 is : 143
2016-05-18 00:53:23,455 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0002_01_000004 is : 143
2016-05-18 00:53:23,544 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0002_01_000005 is : 143
2016-05-18 00:53:29,399 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0002_01_000006 is : 143
2016-05-18 00:53:30,590 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (3/3) ...heckpoints/manycheckpoint
2016-05-18 00:53:30,781 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463532762339_0003
2016-05-18 00:53:30,781 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0003/
2016-05-18 00:53:41,191 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0003_01_000002 is : 143
2016-05-18 00:53:42,443 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testManyCheckpoints/manycheckpoint/_temporary
2016-05-18 00:53:42,445 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] completed in: 00:54.093, using cpu time: 00:10.240
2016-05-18 00:53:42,480 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testManyCheckpoints/manycheckpoint
2016-05-18 00:53:42,532 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:53:42,532 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:53:42,602 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.064
2016-05-18 00:53:42,604 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 2, nodes: 3
2016-05-18 00:53:42,604 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 00:53:42,633 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] starting
2016-05-18 00:53:42,634 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/apache.10.txt"]
2016-05-18 00:53:42,634 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testRestartCheckpoint/restartcheckpoint"]
2016-05-18 00:53:42,635 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] parallel execution of steps is enabled: true
2016-05-18 00:53:42,635 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] executing total steps: 2
2016-05-18 00:53:42,635 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] allocating management threads: 2
2016-05-18 00:53:42,644 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] at least one sink does not exist
2016-05-18 00:53:42,648 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] source modification date at: Wed May 18 00:52:47 UTC 2016
2016-05-18 00:53:42,648 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] starting step: (1/2)
2016-05-18 00:53:42,805 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] submitted hadoop job: job_1463532762339_0004
2016-05-18 00:53:42,806 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0004/
2016-05-18 00:53:58,230 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0004_01_000002 is : 143
2016-05-18 00:53:58,456 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0004_01_000003 is : 143
2016-05-18 00:53:58,537 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0004_01_000005 is : 143
2016-05-18 00:53:58,632 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0004_01_000004 is : 143
2016-05-18 00:53:59,845 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] starting step: (2/2) ...ckpoint/restartcheckpoint
2016-05-18 00:54:00,024 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] submitted hadoop job: job_1463532762339_0005
2016-05-18 00:54:00,024 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0005/
2016-05-18 00:54:15,419 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0005_01_000002 is : 143
2016-05-18 00:54:15,717 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0005_01_000005 is : 143
2016-05-18 00:54:15,828 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0005_01_000003 is : 143
2016-05-18 00:54:15,909 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0005_01_000004 is : 143
2016-05-18 00:54:22,064 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0005_01_000006 is : 143
2016-05-18 00:54:28,508 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0005_01_000007 is : 143
2016-05-18 00:54:34,707 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0005_01_000008 is : 143
2016-05-18 00:54:40,900 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0005_01_000009 is : 143
2016-05-18 00:54:42,027 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] hadoop job job_1463532762339_0005 state at FAILED
2016-05-18 00:54:42,028 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] failure info: Task failed task_1463532762339_0005_r_000000
Job failed as tasks failed. failedMaps:0 failedReduces:1
2016-05-18 00:54:42,052 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] task completion events identify failed tasks
2016-05-18 00:54:42,052 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] task completion events count: 8
2016-05-18 00:54:42,053 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] event = Task Id : attempt_1463532762339_0005_m_000000_0, Status : SUCCEEDED
2016-05-18 00:54:42,053 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] event = Task Id : attempt_1463532762339_0005_m_000003_0, Status : SUCCEEDED
2016-05-18 00:54:42,053 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] event = Task Id : attempt_1463532762339_0005_m_000001_0, Status : SUCCEEDED
2016-05-18 00:54:42,053 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] event = Task Id : attempt_1463532762339_0005_m_000002_0, Status : SUCCEEDED
2016-05-18 00:54:42,053 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] event = Task Id : attempt_1463532762339_0005_r_000000_0, Status : FAILED
2016-05-18 00:54:42,053 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] event = Task Id : attempt_1463532762339_0005_r_000000_1, Status : FAILED
2016-05-18 00:54:42,054 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] event = Task Id : attempt_1463532762339_0005_r_000000_2, Status : FAILED
2016-05-18 00:54:42,054 WARN flow.Flow (BaseFlow.java:logWarn(1516)) - [restartable] event = Task Id : attempt_1463532762339_0005_r_000000_3, Status : TIPFAILED
2016-05-18 00:54:42,083 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] stopping all jobs
2016-05-18 00:54:42,084 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] stopping: (2/2) ...ckpoint/restartcheckpoint
2016-05-18 00:54:42,087 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] stopping: (1/2)
2016-05-18 00:54:45,550 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] stopped all jobs
2016-05-18 00:54:45,551 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /tmp/hadoop-teamcity/restartable/restartable/test/_temporary
2016-05-18 00:54:45,553 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testRestartCheckpoint/restartcheckpoint/_temporary
2016-05-18 00:54:45,556 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] completed in: 01:02.917, using cpu time: 00:08.470
2016-05-18 00:54:45,581 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:54:45,581 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:54:45,656 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.069
2016-05-18 00:54:45,659 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 2, nodes: 3
2016-05-18 00:54:45,659 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 00:54:45,694 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] starting
2016-05-18 00:54:45,694 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/apache.10.txt"]
2016-05-18 00:54:45,695 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testRestartCheckpoint/restartcheckpoint"]
2016-05-18 00:54:45,695 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] parallel execution of steps is enabled: true
2016-05-18 00:54:45,696 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] executing total steps: 2
2016-05-18 00:54:45,696 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] allocating management threads: 2
2016-05-18 00:54:45,700 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] at least one sink is marked for delete
2016-05-18 00:54:45,701 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] sink oldest modified date: Wed Dec 31 23:59:59 UTC 1969
2016-05-18 00:54:45,704 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] source modification date at: Wed May 18 00:53:58 UTC 2016
2016-05-18 00:54:45,705 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] sink oldest modified date: Wed May 18 00:53:58 UTC 2016
2016-05-18 00:54:45,707 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] source modification date at: Wed May 18 00:52:47 UTC 2016
2016-05-18 00:54:45,707 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] skipping step: (1/2)
2016-05-18 00:54:45,709 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] starting step: (2/2) ...ckpoint/restartcheckpoint
2016-05-18 00:54:45,868 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] submitted hadoop job: job_1463532762339_0006
2016-05-18 00:54:45,868 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0006/
2016-05-18 00:55:01,432 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0006_01_000002 is : 143
2016-05-18 00:55:01,477 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0006_01_000005 is : 143
2016-05-18 00:55:01,671 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0006_01_000004 is : 143
2016-05-18 00:55:01,711 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0006_01_000003 is : 143
2016-05-18 00:55:07,968 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0006_01_000006 is : 143
2016-05-18 00:55:09,222 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testRestartCheckpoint/restartcheckpoint/_temporary
2016-05-18 00:55:09,223 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [restartable] completed in: 00:23.520, using cpu time: 00:05.140
2016-05-18 00:55:09,241 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testRestartCheckpoint/restartcheckpoint
2016-05-18 00:55:09,279 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:55:09,280 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:55:09,288 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executed rule registry: MapReduceHadoopRuleRegistry, completed as: ILLEGAL, in: 00:00.002
2016-05-18 00:55:09,288 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: MapReduceHadoopRuleRegistry, found assembly to be malformed
2016-05-18 00:55:09,288 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testFailCheckpointBeforeEvery/failcheckpointevery/tap
2016-05-18 00:55:09,289 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testFailCheckpointBeforeEvery/failcheckpointevery/sink
2016-05-18 00:55:09,306 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:55:09,307 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:55:09,367 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.055
2016-05-18 00:55:09,370 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 2, nodes: 3
2016-05-18 00:55:09,371 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 00:55:09,396 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting
2016-05-18 00:55:09,396 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/apache.10.txt"]
2016-05-18 00:55:09,396 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testSimpleCheckpoint/simplecheckpoint"]
2016-05-18 00:55:09,397 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] parallel execution of steps is enabled: true
2016-05-18 00:55:09,397 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] executing total steps: 2
2016-05-18 00:55:09,397 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] allocating management threads: 2
2016-05-18 00:55:09,398 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (1/2)
2016-05-18 00:55:09,539 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463532762339_0007
2016-05-18 00:55:09,539 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0007/
2016-05-18 00:55:24,476 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0007_01_000003 is : 143
2016-05-18 00:55:24,521 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0007_01_000002 is : 143
2016-05-18 00:55:25,057 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0007_01_000004 is : 143
2016-05-18 00:55:25,088 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0007_01_000005 is : 143
2016-05-18 00:55:26,283 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] starting step: (2/2) ...eckpoint/simplecheckpoint
2016-05-18 00:55:26,438 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] submitted hadoop job: job_1463532762339_0008
2016-05-18 00:55:26,438 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0008/
2016-05-18 00:55:42,019 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0008_01_000005 is : 143
2016-05-18 00:55:42,077 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0008_01_000002 is : 143
2016-05-18 00:55:42,153 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0008_01_000003 is : 143
2016-05-18 00:55:42,259 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0008_01_000004 is : 143
2016-05-18 00:55:48,998 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0008_01_000006 is : 143
2016-05-18 00:55:50,189 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testSimpleCheckpoint/simplecheckpoint/_temporary
2016-05-18 00:55:50,191 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [test] completed in: 00:40.789, using cpu time: 00:09.660
2016-05-18 00:55:50,208 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testSimpleCheckpoint/simplecheckpoint
2016-05-18 00:55:50,229 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:55:50,230 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:55:50,248 INFO planner.FlowPlanner (FlowPlanner.java:makeTempTap(768)) - found checkpoint: checkpoint, using tap: Hfs["TextDelimited[[UNKNOWN]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testSimpleCheckpointTextIntermediate/checkpoint/tap"]
2016-05-18 00:55:50,298 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executed rule registry: MapReduceHadoopRuleRegistry, completed as: SUCCESS, in: 00:00.062
2016-05-18 00:55:50,300 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: MapReduceHadoopRuleRegistry, supports assembly with steps: 2, nodes: 3
2016-05-18 00:55:50,300 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] rule registry: MapReduceHadoopRuleRegistry, result was selected using: 'default comparator: selects plan with fewest steps and fewest nodes'
2016-05-18 00:55:50,335 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting
2016-05-18 00:55:50,335 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] source: Hfs["TextLine[['offset', 'line']->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/classes/test/data/apache.10.txt"]
2016-05-18 00:55:50,336 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] sink: Hfs["TextLine[['offset', 'line' | long, String]->[ALL]]"]["/opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testSimpleCheckpointTextIntermediate/checkpoint/sink"]
2016-05-18 00:55:50,337 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] parallel execution of steps is enabled: true
2016-05-18 00:55:50,337 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] executing total steps: 2
2016-05-18 00:55:50,337 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] allocating management threads: 2
2016-05-18 00:55:50,339 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting step: (1/2) ...termediate/checkpoint/tap
2016-05-18 00:55:50,505 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] submitted hadoop job: job_1463532762339_0009
2016-05-18 00:55:50,505 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0009/
2016-05-18 00:56:05,761 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0009_01_000002 is : 143
2016-05-18 00:56:05,931 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0009_01_000004 is : 143
2016-05-18 00:56:05,958 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0009_01_000005 is : 143
2016-05-18 00:56:06,825 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0009_01_000003 is : 143
2016-05-18 00:56:08,008 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] starting step: (2/2) ...ermediate/checkpoint/sink
2016-05-18 00:56:08,141 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] submitted hadoop job: job_1463532762339_0010
2016-05-18 00:56:08,142 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] tracking url: http://ip-10-158-37-203.ec2.internal:58102/proxy/application_1463532762339_0010/
2016-05-18 00:56:27,797 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0010_01_000004 is : 143
2016-05-18 00:56:27,894 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0010_01_000005 is : 143
2016-05-18 00:56:27,914 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0010_01_000007 is : 143
2016-05-18 00:56:28,018 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0010_01_000002 is : 143
2016-05-18 00:56:28,133 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0010_01_000006 is : 143
2016-05-18 00:56:28,328 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0010_01_000003 is : 143
2016-05-18 00:56:34,362 WARN nodemanager.DefaultContainerExecutor (DefaultContainerExecutor.java:launchContainer(207)) - Exit code from container container_1463532762339_0010_01_000008 is : 143
2016-05-18 00:56:35,561 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testSimpleCheckpointTextIntermediate/checkpoint/tap/_temporary
2016-05-18 00:56:35,562 INFO util.Hadoop18TapUtil (Hadoop18TapUtil.java:cleanTempPath(226)) - deleting temp path /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output/hadoop2-mr1/checkpointplatform/testSimpleCheckpointTextIntermediate/checkpoint/sink/_temporary
2016-05-18 00:56:35,564 INFO flow.Flow (BaseFlow.java:logInfo(1504)) - [] completed in: 00:45.224, using cpu time: 00:11.490
2016-05-18 00:56:35,607 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testSimpleCheckpointTextIntermediate/checkpoint/tap
2016-05-18 00:56:35,617 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testSimpleCheckpointTextIntermediate/checkpoint/sink
2016-05-18 00:56:35,638 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:56:35,638 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:56:35,643 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testDuplicateCheckpoint/duplicatecheckpoint
2016-05-18 00:56:35,662 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:56:35,663 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:56:35,667 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testFailCheckpoint/failcheckpoint/sink
2016-05-18 00:56:35,667 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testFailCheckpoint/failcheckpoint/tap
2016-05-18 00:56:35,685 INFO util.Util (Util.java:findMainClass(1374)) - using default application jar, may cause class not found exceptions on the cluster
2016-05-18 00:56:35,686 INFO planner.HadoopPlanner (HadoopPlanner.java:initialize(176)) - using application jar: /opt/concurrent/home/teamcity/.gradle/caches/modules-2/files-2.1/cascading/cascading-hadoop2-mr1/3.1.0/fdadb6ac788ea19f3412b9569a43a7635318b0c5/cascading-hadoop2-mr1-3.1.0.jar
2016-05-18 00:56:35,690 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testFailCheckpointDeclaredFields/failcheckpointdeclared/tap
2016-05-18 00:56:35,691 INFO cascading.PlatformTestCase (PlatformTestCase.java:tearDown(189)) - copying to local /opt/buildAgent-8.0.3/work/9c1cc778dcd1fc2f/apache-2.3.x/build/test/output//hadoop2-mr1/checkpointplatform/testFailCheckpointDeclaredFields/failcheckpointdeclared/sink