You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@twill.apache.org by "Henry Saputra (JIRA)" <ji...@apache.org> on 2015/08/24 23:29:46 UTC

[jira] [Closed] (TWILL-32) AppMaster fails to change from ACCEPTED to RUNNING

     [ https://issues.apache.org/jira/browse/TWILL-32?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Henry Saputra closed TWILL-32.
------------------------------
    Resolution: Cannot Reproduce

Closing this one until we got confirmation from reporter about how to repro.

Feel free to reopen when appropriate.

> AppMaster fails to change from ACCEPTED to RUNNING 
> ---------------------------------------------------
>
>                 Key: TWILL-32
>                 URL: https://issues.apache.org/jira/browse/TWILL-32
>             Project: Apache Twill
>          Issue Type: Bug
>         Environment: CentOS 6.5 64bit, Hadoop 2.2.0 GA
>            Reporter: CJ
>
> After compiling Twill 0.1, I've imported the sample code demos (EchoServer, Twill, etc.) and have run them on the server. Unfortunately none of the examples provided move from the ACCEPTED state to RUNNING on the cluster. The application shows as ACCEPTED in the Resource Manager website but then the TwillController kills it because the final state is "UNDEFINED" as the YARN Application never runs. I have attached the output below when running the DistributedShell example:
> CLIENT SIDE OUTPUT:
> 20:37:25.911 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:zookeeper.version=3.4.5-1392090, built on 09/30/2012 17:52 GMT
> 20:37:25.917 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:host.name=localhost.localdomain
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:java.version=1.7.0_45
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:java.vendor=Oracle Corporation
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:java.home=/media/_CentOS-6.4-x86_/software/eclipse/jre
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:java.class.path=/software/workspace/Twill/bin:/software/workspace/Twill/lib/twill-api-0.1.0-SNAPSHOT.jar:/software/workspace/Twill/lib/twill-common-0.1.0-SNAPSHOT.jar:/software/workspace/Twill/lib/twill-core-0.1.0-SNAPSHOT.jar:/software/workspace/Twill/lib/twill-discovery-api-0.1.0-SNAPSHOT.jar:/software/workspace/Twill/lib/twill-discovery-core-0.1.0-SNAPSHOT.jar:/software/workspace/Twill/lib/twill-yarn-0.1.0-SNAPSHOT.jar:/software/workspace/Twill/lib/twill-zookeeper-0.1.0-SNAPSHOT.jar:/software/workspace/Twill/lib/slf4j-api-1.7.5.jar:/software/workspace/Twill/lib/guava-14.0.1.jar:/software/workspace/Twill/lib/netty-3.7.0.Final.jar:/software/workspace/Twill/lib/gson-2.2.4.jar:/software/workspace/Twill/lib/hadoop-common-2.2.0.jar:/software/workspace/Twill/lib/hadoop-yarn-api-2.2.0.jar:/software/workspace/Twill/lib/hadoop-yarn-client-2.2.0.jar:/software/workspace/Twill/lib/hadoop-yarn-common-2.2.0.jar:/software/workspace/Twill/lib/protobuf-java-2.5.0.jar:/software/workspace/Twill/lib/zookeeper-3.4.5.jar:/software/workspace/Twill/lib/commons-io-2.1.jar:/software/workspace/Twill/lib/commons-logging-1.1.1.jar:/software/workspace/Twill/lib/commons-net-3.1.jar:/software/workspace/Twill/lib/hadoop-auth-2.2.0.jar:/software/workspace/Twill/lib/commons-collections-3.2.1.jar:/software/workspace/Twill/lib/commons-configuration-1.6.jar:/software/workspace/Twill/lib/commons-lang-2.5.jar:/software/workspace/Twill/lib/log4j-1.2.17.jar:/software/workspace/Twill/lib/asm-4.2.jar:/software/workspace/Twill/lib/hadoop-hdfs-2.2.0.jar:/software/workspace/Twill/lib/logback-classic-1.0.13.jar:/software/workspace/Twill/lib/slf4j-log4j12-1.7.5.jar:/software/workspace/Twill/lib/logback-core-1.0.13.jar:/software/workspace/Twill/lib/junit-4.11.jar:/software/workspace/Twill/lib/hamcrest-all-1.3.jar
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:java.library.path=/home/hduser/yarn/hadoop-2.2.0/lib/native
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:java.io.tmpdir=/tmp
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:java.compiler=<NA>
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:os.name=Linux
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:os.arch=amd64
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:os.version=2.6.32-431.3.1.el6.x86_64
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:user.name=root
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:user.home=/root
> 20:37:25.918 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Client environment:user.dir=/software/workspace/Twill
> 20:37:25.920 [YarnTwillRunnerService STARTING] INFO  org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=10.0.9.3:2181 sessionTimeout=10000 watcher=ServiceDelegate [STARTING]
> 20:37:25.924 [YarnTwillRunnerService STARTING] DEBUG org.apache.zookeeper.ClientCnxn - zookeeper.disableAutoWatchReset is false
> 20:37:25.954 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] INFO  org.apache.zookeeper.ClientCnxn - Opening socket connection to server 10.0.9.3/10.0.9.3:2181. Will not attempt to authenticate using SASL (unknown error)
> 20:37:25.964 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] INFO  org.apache.zookeeper.ClientCnxn - Socket connection established to 10.0.9.3/10.0.9.3:2181, initiating session
> 20:37:25.966 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Session establishment request sent on 10.0.9.3/10.0.9.3:2181
> 20:37:26.075 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] INFO  org.apache.zookeeper.ClientCnxn - Session establishment complete on server 10.0.9.3/10.0.9.3:2181, sessionid = 0x1436a2891790076, negotiated timeout = 10000
> 20:37:26.082 [YarnTwillRunnerService STARTING-EventThread] INFO  o.a.t.i.z.DefaultZKClientService - Connected to ZooKeeper: 10.0.9.3:2181
> 20:37:26.110 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/ serverPath:/ finished:false header:: 1,1  replyHeader:: 1,578,-110  request:: '/,,v{s{31,s{'world,'anyone}}},0  response::  
> 20:37:26.141 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/ serverPath:/ finished:false header:: 2,12  replyHeader:: 2,578,0  request:: '/,T  response:: v{'CoolDataApplication,'distributedshell,'BuggyServer,'zookeeper,'DistributedShell,'TimeoutApplication,'FailureRunnable,'SleepTask,'Executor,'EchoServer,'ResourceApplication,'EnvironmentEchoServer},s{0,0,0,0,0,10,0,0,0,12,557} 
> 20:37:26.166 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/CoolDataApplication/instances serverPath:/CoolDataApplication/instances finished:false header:: 3,12  replyHeader:: 3,578,0  request:: '/CoolDataApplication/instances,T  response:: v{},s{367,367,1389141047391,1389141047391,0,2,0,0,0,0,380} 
> 20:37:26.168 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/distributedshell/instances serverPath:/distributedshell/instances finished:false header:: 4,12  replyHeader:: 4,578,0  request:: '/distributedshell/instances,T  response:: v{},s{167,167,1389123708114,1389123708114,0,14,0,0,0,0,328} 
> 20:37:26.171 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/BuggyServer/instances serverPath:/BuggyServer/instances finished:false header:: 5,12  replyHeader:: 5,578,0  request:: '/BuggyServer/instances,T  response:: v{},s{478,478,1389144744216,1389144744216,0,2,0,0,0,0,511} 
> 20:37:26.171 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/zookeeper/instances serverPath:/zookeeper/instances finished:false header:: 6,12  replyHeader:: 6,578,-101  request:: '/zookeeper/instances,T  response:: v{} 
> 20:37:26.172 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/instances serverPath:/DistributedShell/instances finished:false header:: 7,12  replyHeader:: 7,578,0  request:: '/DistributedShell/instances,T  response:: v{},s{393,393,1389143638574,1389143638574,0,2,0,0,0,0,407} 
> 20:37:26.174 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/TimeoutApplication/instances serverPath:/TimeoutApplication/instances finished:false header:: 8,12  replyHeader:: 8,578,0  request:: '/TimeoutApplication/instances,T  response:: v{},s{558,558,1389144894351,1389144894351,0,2,0,0,0,0,575} 
> 20:37:26.175 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/FailureRunnable/instances serverPath:/FailureRunnable/instances finished:false header:: 9,12  replyHeader:: 9,578,0  request:: '/FailureRunnable/instances,T  response:: v{},s{538,538,1389144834465,1389144834465,0,2,0,0,0,0,572} 
> 20:37:26.176 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/SleepTask/instances serverPath:/SleepTask/instances finished:false header:: 10,12  replyHeader:: 10,578,0  request:: '/SleepTask/instances,T  response:: v{},s{518,518,1389144804886,1389144804886,0,2,0,0,0,0,551} 
> 20:37:26.177 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/Executor/instances serverPath:/Executor/instances finished:false header:: 11,12  replyHeader:: 11,578,0  request:: '/Executor/instances,T  response:: v{},s{341,341,1389139053678,1389139053678,0,2,0,0,0,0,355} 
> 20:37:26.179 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/EchoServer/instances serverPath:/EchoServer/instances finished:false header:: 12,12  replyHeader:: 12,578,0  request:: '/EchoServer/instances,T  response:: v{},s{416,416,1389143916750,1389143916750,0,4,0,0,0,0,471} 
> 20:37:26.180 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/ResourceApplication/instances serverPath:/ResourceApplication/instances finished:false header:: 13,12  replyHeader:: 13,578,0  request:: '/ResourceApplication/instances,T  response:: v{},s{458,458,1389144717456,1389144717456,0,2,0,0,0,0,491} 
> 20:37:26.181 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/EnvironmentEchoServer/instances serverPath:/EnvironmentEchoServer/instances finished:false header:: 14,12  replyHeader:: 14,578,0  request:: '/EnvironmentEchoServer/instances,T  response:: v{},s{498,498,1389144774248,1389144774248,0,2,0,0,0,0,532} 
> 20:37:26.182 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/zookeeper/instances serverPath:/zookeeper/instances finished:false header:: 15,3  replyHeader:: 15,578,-101  request:: '/zookeeper/instances,T  response::  
> 20:37:26.187 [main] DEBUG o.a.twill.internal.yarn.YarnUtils - Security is not enabled
> 20:37:26.363 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/instances/ac719bf4-c4ab-49e5-a761-c0744c0629b5 serverPath:/DistributedShell/instances/ac719bf4-c4ab-49e5-a761-c0744c0629b5 finished:false header:: 16,3  replyHeader:: 16,578,-101  request:: '/DistributedShell/instances/ac719bf4-c4ab-49e5-a761-c0744c0629b5,T  response::  
> 20:37:26.364 [twill-log-poller-ac719bf4-c4ab-49e5-a761-c0744c0629b5] INFO  o.a.t.i.AbstractTwillController - Twill log poller thread 'twill-log-poller-ac719bf4-c4ab-49e5-a761-c0744c0629b5' started.
> 20:37:26.365 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state serverPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state finished:false header:: 17,3  replyHeader:: 17,578,-101  request:: '/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state,T  response::  
> 20:37:26.368 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/ids serverPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/ids finished:false header:: 18,12  replyHeader:: 18,578,-101  request:: '/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/ids,T  response:: v{} 
> 20:37:26.369 [zk-client-EventThread] INFO  o.a.t.i.k.client.KafkaBrokerCache - Path /brokers/ids not exists. Watch for creation.
> 20:37:26.371 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/topics serverPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/topics finished:false header:: 19,12  replyHeader:: 19,578,-101  request:: '/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/topics,T  response:: v{} 
> 20:37:26.372 [zk-client-EventThread] INFO  o.a.t.i.k.client.KafkaBrokerCache - Path /brokers/topics not exists. Watch for creation.
> 20:37:26.372 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/ids serverPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/ids finished:false header:: 20,3  replyHeader:: 20,578,-101  request:: '/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/ids,T  response::  
> 20:37:26.374 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/topics serverPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/topics finished:false header:: 21,3  replyHeader:: 21,578,-101  request:: '/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/kafka/brokers/topics,T  response::  
> 20:37:26.392 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Create and copy appMaster.jar
> 20:37:26.403 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - start creating bundle appMaster.408d5028-390d-473a-a985-060e37e2a96f.jar. building a temporary file locally at first
> 20:37:26.414 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - adding bundle entry lib/twill-yarn-0.1.0-SNAPSHOT.jar
> [truncated adding bundle entry notices]
> 20:37:28.671 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - copying temporary bundle to destination file:/twill/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/appMaster.408d5028-390d-473a-a985-060e37e2a96f.jar (27711383 bytes)
> 20:37:28.853 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - finished creating bundle at file:/twill/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/appMaster.408d5028-390d-473a-a985-060e37e2a96f.jar
> 20:37:28.859 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - cleaned up local temporary for bundle file:/tmp/appMaster.408d5028-390d-473a-a985-060e37e2a96f.jar8820134787031095664.tmp
> 20:37:28.859 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done appMaster.jar
> 20:37:28.863 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Create and copy container.jar
> 20:37:28.863 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - start creating bundle container.acad790d-e09f-40d0-b324-21ba75724465.jar. building a temporary file locally at first
> 20:37:28.863 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - adding bundle entry lib/twill-yarn-0.1.0-SNAPSHOT.jar
> 20:37:28.865 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - adding whole dir /software/workspace/Twill/bin to bundle at 'classes/'
> 20:37:30.385 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - copying temporary bundle to destination file:/twill/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/container.acad790d-e09f-40d0-b324-21ba75724465.jar (26361189 bytes)
> 20:37:30.454 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - finished creating bundle at file:/twill/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/container.acad790d-e09f-40d0-b324-21ba75724465.jar
> 20:37:30.458 [ServiceDelegate STARTING] DEBUG o.a.t.internal.ApplicationBundler - cleaned up local temporary for bundle file:/tmp/container.acad790d-e09f-40d0-b324-21ba75724465.jar5546115131146087214.tmp
> 20:37:30.458 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done container.jar
> 20:37:30.459 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Populating Runnable LocalFiles
> 20:37:30.459 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done Runnable LocalFiles
> 20:37:30.460 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Create and copy twillSpec.json
> 20:37:30.510 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done twillSpec.json
> 20:37:30.510 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Create and copy logback-template.xml
> 20:37:30.511 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done logback-template.xml
> 20:37:30.511 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Create and copy launcher.jar
> 20:37:30.515 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done launcher.jar
> 20:37:30.516 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Copy kafka.tgz
> 20:37:30.542 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done kafka.tgz
> 20:37:30.542 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Copy jvm.opts
> 20:37:30.548 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done jvm.opts
> 20:37:30.554 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Create and copy arguments.json
> 20:37:30.558 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done arguments.json
> 20:37:30.564 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Create and copy localizeFiles.json
> 20:37:30.569 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Done localizeFiles.json
> 20:37:30.570 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillPreparer - Submit AM container spec: application_1389144535626_0008
> 20:37:30.657 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Application application_1389144535626_0008 submit
> 20:37:30.658 [ServiceDelegate STARTING] INFO  o.a.twill.yarn.YarnTwillController - Checking yarn application status
> 20:37:30.660 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:31.663 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:32.666 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:33.048 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 0ms
> 20:37:33.577 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got notification sessionid:0x1436a2891790076
> 20:37:33.578 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got WatchedEvent state:SyncConnected type:NodeCreated path:/DistributedShell/instances/ac719bf4-c4ab-49e5-a761-c0744c0629b5 for sessionid 0x1436a2891790076
> 20:37:33.579 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got notification sessionid:0x1436a2891790076
> 20:37:33.579 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/DistributedShell/instances for sessionid 0x1436a2891790076
> 20:37:33.589 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/instances/ac719bf4-c4ab-49e5-a761-c0744c0629b5 serverPath:/DistributedShell/instances/ac719bf4-c4ab-49e5-a761-c0744c0629b5 finished:false header:: 22,4  replyHeader:: 22,581,0  request:: '/DistributedShell/instances/ac719bf4-c4ab-49e5-a761-c0744c0629b5,T  response:: #7b2264617461223a7b226170704964223a382c226170704964436c757374657254696d65223a313338393134343533353632362c22636f6e7461696e65724964223a22636f6e7461696e65725f313338393134343533353632365f303030385f30315f303030303031227d7d,s{581,581,1389145053571,1389145053571,0,0,0,91033139949404279,108,0,581} 
> 20:37:33.669 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:33.672 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got notification sessionid:0x1436a2891790076
> 20:37:33.673 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got WatchedEvent state:SyncConnected type:NodeCreated path:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state for sessionid 0x1436a2891790076
> 20:37:33.675 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state serverPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state finished:false header:: 23,4  replyHeader:: 23,590,0  request:: '/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state,T  response:: #7b227374617465223a225354415254494e47227d,s{590,590,1389145053670,1389145053670,0,0,0,0,20,0,590} 
> 20:37:33.684 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got notification sessionid:0x1436a2891790076
> 20:37:33.684 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got WatchedEvent state:SyncConnected type:NodeDataChanged path:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state for sessionid 0x1436a2891790076
> 20:37:33.688 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Reading reply sessionid:0x1436a2891790076, packet:: clientPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state serverPath:/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state finished:false header:: 24,4  replyHeader:: 24,592,0  request:: '/DistributedShell/ac719bf4-c4ab-49e5-a761-c0744c0629b5/state,T  response:: #7b227374617465223a225354415254494e47227d,s{590,592,1389145053670,1389145053681,1,0,0,0,20,0,590} 
> 20:37:34.676 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:35.684 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:36.691 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:37.026 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:37:37.698 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:38.704 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:39.711 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:40.361 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:37:40.718 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:41.727 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:42.735 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:43.699 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 1ms
> 20:37:43.746 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:44.752 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:45.759 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:46.767 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:47.036 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:37:47.775 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:48.782 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:49.789 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:50.374 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 1ms
> 20:37:50.796 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:51.803 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:52.813 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:53.711 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:37:53.819 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:54.826 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:55.833 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:56.841 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:57.047 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:37:57.847 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:58.855 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:37:59.865 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:00.385 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:38:00.873 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:01.878 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:02.884 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:03.723 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:38:03.890 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:04.897 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:05.900 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:06.903 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:07.059 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 0ms
> 20:38:07.906 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:08.909 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:09.912 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:10.396 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 0ms
> 20:38:10.914 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:11.917 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:12.920 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:13.731 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 0ms
> 20:38:13.922 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:14.925 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:15.927 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:16.930 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:17.068 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 0ms
> 20:38:17.935 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:18.943 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:19.950 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:20.406 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 3ms
> 20:38:20.958 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:21.966 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:22.973 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:23.741 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 1ms
> 20:38:23.980 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:24.986 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:25.993 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:26.999 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:27.078 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 1ms
> 20:38:28.009 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:29.015 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:30.024 [ServiceDelegate STARTING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application status: ACCEPTED
> 20:38:30.417 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 3ms
> 20:38:31.024 [ServiceDelegate STARTING] INFO  o.a.twill.yarn.YarnTwillController - Yarn application is in state ACCEPTED
> 20:38:31.025 [ServiceDelegate STARTING] INFO  o.a.twill.yarn.YarnTwillController - Yarn application is not in running state. Shutting down controller.
> 20:38:31.053 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:32.059 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:33.065 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:33.754 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:38:34.073 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:35.080 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:36.086 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:37.092 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 5ms
> 20:38:37.094 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:38.100 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:39.107 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:40.113 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:40.424 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:38:41.121 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:42.127 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:43.133 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:43.761 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:38:44.139 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:45.147 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:46.154 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:47.101 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 4ms
> 20:38:47.161 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:48.168 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:49.177 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:50.183 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:50.438 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 3ms
> 20:38:51.190 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:52.197 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:53.204 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:53.775 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 3ms
> 20:38:54.210 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:55.219 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:56.225 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:57.112 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:38:57.230 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:58.235 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:38:59.238 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:00.245 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:00.450 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:39:01.251 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:02.257 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:03.264 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:03.789 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 4ms
> 20:39:04.271 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:05.276 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:06.287 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:07.125 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:39:07.301 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:08.308 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:09.313 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:10.320 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:10.462 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 3ms
> 20:39:11.322 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:12.329 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:13.335 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:13.800 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:39:14.338 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:15.346 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:16.353 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:17.138 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:39:17.361 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:18.367 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:19.375 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:20.382 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:20.474 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 0ms
> 20:39:21.387 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:22.394 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:23.401 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:23.815 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:39:24.408 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:25.415 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:26.423 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:27.153 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:39:27.430 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:28.437 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:29.443 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:30.450 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status for application_1389144535626_0008 UNDEFINED
> 20:39:30.491 [YarnTwillRunnerService STARTING-SendThread(10.0.9.3:2181)] DEBUG org.apache.zookeeper.ClientCnxn - Got ping response for sessionid: 0x1436a2891790076 after 2ms
> 20:39:31.456 [ServiceDelegate STOPPING] DEBUG o.a.twill.yarn.YarnTwillController - Yarn application final status is UNDEFINED
> 20:39:31.464 [ServiceDelegate STOPPING] INFO  o.a.twill.yarn.YarnTwillController - Killing application application_1389144535626_0008
> 20:39:31.499 [twill-log-poller-ac719bf4-c4ab-49e5-a761-c0744c0629b5] WARN  o.a.t.i.AbstractTwillController - Failed to fetch offsets from Kafka. Retrying.
> java.lang.NullPointerException: null
> 	at org.apache.twill.internal.kafka.client.SimpleKafkaClient.getOffset(SimpleKafkaClient.java:199) ~[twill-core-0.1.0-SNAPSHOT.jar:na]
> 	at org.apache.twill.internal.AbstractTwillController$LogPollerThread.run(AbstractTwillController.java:134) ~[twill-core-0.1.0-SNAPSHOT.jar:na]
> 20:39:31.521 [twill-log-poller-ac719bf4-c4ab-49e5-a761-c0744c0629b5] INFO  o.a.t.i.AbstractTwillController - Twill log poller thread stopped.
> SERVER-SIDE RESULTS:
> Launching main: public static void org.apache.twill.internal.appmaster.ApplicationMasterMain.main(java.lang.String[]) throws java.lang.Exception []
> 20:29:56.946 [main] INFO  o.apache.twill.internal.ServiceMain - Starting service org.apache.twill.internal.appmaster.ApplicationMasterService@338e5318.
> 20:29:57.091 [main-EventThread] INFO  o.a.t.i.z.DefaultZKClientService - Connected to ZooKeeper: 10.0.9.3:2181/EchoServer
> 20:29:57.091 [main-EventThread] INFO  o.a.t.i.z.DefaultZKClientService - Connected to ZooKeeper: 10.0.9.3:2181/EchoServer/940e3f21-b4bf-4322-a2cc-80afebb50af0/kafka
> 20:29:57.097 [main-EventThread] INFO  o.a.t.internal.ZKServiceDecorator - Create live node 10.0.9.3:2181/EchoServer/instances/940e3f21-b4bf-4322-a2cc-80afebb50af0
> 20:29:57.166 [zk-client-EventThread] INFO  o.a.t.i.k.client.KafkaBrokerCache - Path /brokers/ids not exists. Watch for creation.
> 20:29:57.172 [zk-client-EventThread] INFO  o.a.t.i.k.client.KafkaBrokerCache - Path /brokers/topics not exists. Watch for creation.
> 20:29:57.187 [zk-client-EventThread] INFO  o.a.t.internal.ZKServiceDecorator - Starting: 940e3f21-b4bf-4322-a2cc-80afebb50af0
> 20:29:57.208 [ServiceDelegate] INFO  o.a.t.i.a.ApplicationMasterService - Start application master with spec: {"name":"EchoServer","runnables":{"EchoServer":{"name":"EchoServer","runnable":{"classname":"org.apache.twill.yarn.EchoServer","name":"EchoServer","arguments":{}},"resources":{"cores":1,"memorySize":1024,"instances":2,"uplink":-1,"downlink":-1},"files":[]}},"orders":[{"names":["EchoServer"],"type":"STARTED"}],"handler":{"classname":"org.apache.twill.internal.LogOnlyEventHandler","configs":{}}}
> 20:29:57.521 [ServiceDelegate] INFO  o.a.t.i.a.ApplicationMasterService - Starting application master tracker server
> 20:29:57.557 [ServiceDelegate] INFO  o.a.t.i.a.ApplicationMasterService - Started application master tracker server on http://localhost.localdomain:37258/resources
> Cleanup directory tmp/twill.launcher-1389144595279-0
> 20:31:54.639 [main] INFO  o.apache.twill.internal.ServiceMain - Service org.apache.twill.internal.appmaster.ApplicationMasterService@338e5318 started.



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)