Twitter Storm开篇之作

Storm介绍

Twitter将Storm正式开源了，这是一个分布式的、容错的实时计算系统，它被托管在GitHub上，遵循 Eclipse Public License 1.0。Storm是由BackType开发的实时处理系统，BackType现在已在Twitter麾下。GitHub上的最新版本是Storm
0.5.2，基本是用Clojure写的。

Storm为分布式实时计算提供了一组通用原语，可被用于“流处理”之中，实时处理消息并更新数据库。这是管理队列及工作者集群的另一种方式。 Storm也可被用于“连续计算”（continuous computation），对数据流做连续查询，在计算时就将结果以流的形式输出给用户。它还可被用于“分布式RPC”，以并行的方式运行昂贵的运算。 Storm的主工程师Nathan Marz表示：

Storm可以方便地在一个计算机集群中编写与扩展复杂的实时计算，Storm之于实时处理，就好比 Hadoop之于批处理。Storm保证每个消息都会得到处理，而且它很快——在一个小集群中，每秒可以处理数以百万计的消息。更棒的是你可以使用任意编程语言来做开发。

Storm的主要特点如下：

简单的编程模型。类似于MapReduce降低了并行批处理复杂性，Storm降低了进行实时处理的复杂性。
可以使用各种编程语言。你可以在Storm之上使用各种编程语言。默认支持Clojure、Java、Ruby和Python。要增加对其他语言的支持，只需实现一个简单的Storm通信协议即可。
容错性。Storm会管理工作进程和节点的故障。
水平扩展。计算是在多个线程、进程和服务器之间并行进行的。
可靠的消息处理。Storm保证每个消息至少能得到一次完整处理。任务失败时，它会负责从消息源重试消息。
快速。系统的设计保证了消息能得到快速的处理，使用ØMQ作为其底层消息队列。
本地模式。Storm有一个“本地模式”，可以在处理过程中完全模拟Storm集群。这让你可以快速进行开发和单元测试。

Storm集群由一个主节点和多个工作节点组成。主节点运行了一个名为“Nimbus”的守护进程，用于分配代码、布置任务及故障检测。每个工作节 点都运行了一个名为“Supervisor”的守护进程，用于监听工作，开始并终止工作进程。Nimbus和Supervisor都能快速失败，而且是无 状态的，这样一来它们就变得十分健壮，两者的协调工作是由Apache ZooKeeper来完成的。

Storm的术语包括Stream、Spout、Bolt、Task、Worker、Stream Grouping和Topology。Stream是被处理的数据。Sprout是数据源。Bolt处理数据。Task是运行于Spout或Bolt中的 线程。Worker是运行这些线程的进程。Stream Grouping规定了Bolt接收什么东西作为输入数据。数据可以随机分配（术语为Shuffle），或者根据字段值分配（术语为Fields），或者 广播（术语为All），或者总是发给一个Task（术语为Global），也可以不关心该数据（术语为None），或者由自定义逻辑来决定（术语为
Direct）。Topology是由Stream Grouping连接起来的Spout和Bolt节点网络。在Storm Concepts页面里对这些术语有更详细的描述。

可以和Storm相提并论的系统有Esper、Streambase、HStreaming和Yahoo S4。其中和Storm最接近的就是S4。两者最大的区别在于Storm会保证消息得到处理。这些系统中有的拥有内建数据存储层，这是Storm所没有的，如果需要持久化，可以使用一个类似于Cassandra或Riak这样的外部数据库。

入门的最佳途径是阅读GitHub上的官方《Storm Tutorial》。 其中讨论了多种Storm概念和抽象，提供了范例代码以便你可以运行一个Storm Topology。开发过程中，可以用本地模式来运行Storm，这样就能在本地开发，在进程中测试Topology。一切就绪后，以远程模式运行 Storm，提交用于在集群中运行的Topology。Maven用户可以使用clojars.org提供的Storm依赖，地址是 http://clojars.org/repo。
要运行Storm集群，你需要Apache Zookeeper、ØMQ、JZMQ、Java 6和Python 2.6.6。ZooKeeper用于管理集群中的不同组件，ØMQ是内部消息系统，JZMQ是ØMQ的Java Binding。有个名为storm-deploy的子项目，可以在AWS上一键部署Storm集群。关于详细的步骤，可以阅读Storm Wiki上的《Setting up a Storm cluster》。

本软件介绍内容来自 InfoQ

Storm学习途径

作者: xumingming | 网址: http://xumingming.sinaapp.com/179/twitter-storm-搭建storm集群/

作者：量子恒道 网址:http://blog.linezing.com/

Storm简单例子

通过阅读以上两位高人的文章，就试着写了一个简单demo

通过demo主要来掌握storm的运行流程是怎样的

首先新建一个Person 对象，主要是用来将其封装为数据源进行传输

[java] view
plaincopy

/**

* Person.java

* 版权所有(C) 2013

* 创建:cuiran 2013-01-15 15:49:25

*/

package com.stormdemo.demo;

import java.io.Serializable;

/**

* TODO

* @author cuiran

* @version TODO

*/

public class Person implements Serializable {

/**

*

*/

private static final long serialVersionUID = -2279602642375811203L;

private Long id;

private String name;

private Integer age;

/**

* @return the id

*/

public Long getId() {

return id;

}

/**

* @param id the id to set

*/

public void setId(Long id) {

this.id = id;

}

/**

* @return the name

*/

public String getName() {

return name;

}

/**

* @param name the name to set

*/

public void setName(String name) {

this.name = name;

}

/**

* @return the age

*/

public Integer getAge() {

return age;

}

/**

* @param age the age to set

*/

public void setAge(Integer age) {

this.age = age;

}

public String toString(){

return "[Person id="+id+" name="+name+" age="+age+"]";

}

}

然后设置数据源实现接口IRichSpout，在这个类中首先是需要设置输出字段，然后是在open方法中将存放有Person对象的集合进行迭代然后放入queue队列中，在nextTuple方法中从队列中取出Person对象并emit发送给Bolt处理。

[java] view
plaincopy

/**

* DemoSpout.java

* 版权所有(C) 2013

* 创建:cuiran 2013-01-15 15:43:26

*/

package com.stormdemo.demo;

import java.util.Iterator;

import java.util.LinkedList;

import java.util.List;

import java.util.Map;

import java.util.Queue;

import org.apache.commons.logging.Log;

import org.apache.commons.logging.LogFactory;

import backtype.storm.spout.SpoutOutputCollector;

import backtype.storm.task.TopologyContext;

import backtype.storm.topology.IRichSpout;

import backtype.storm.topology.OutputFieldsDeclarer;

import backtype.storm.tuple.Fields;

import backtype.storm.tuple.Values;

/**

* TODO

* @author cuiran

* @version TODO

*/

public class DemoSpout implements IRichSpout {

/**

*

*/

private static final long serialVersionUID = 3980242432526476937L;

private static Log log = LogFactory.getLog(DemoSpout.class.getName());

Queue<Person> queues = new LinkedList<Person>();

List<Person> list=null;

private SpoutOutputCollector collector;

private Map conf;

private TopologyContext context;

/* (non-Javadoc)

* @see backtype.storm.topology.IRichSpout#isDistributed()

*/

/* (non-Javadoc)

* @see backtype.storm.spout.ISpout#ack(java.lang.Object)

*/

@Override

public void ack(Object arg0) {

// TODO Auto-generated method stub

log.debug("ack-----> "+arg0);

}

/* (non-Javadoc)

* @see backtype.storm.spout.ISpout#close()

*/

@Override

public void close() {

// TODO Auto-generated method stub

log.debug("close-----> ");

}

/* (non-Javadoc)

* @see backtype.storm.spout.ISpout#fail(java.lang.Object)

*/

@Override

public void fail(Object arg0) {

// TODO Auto-generated method stub

log.debug("fail-----> "+arg0);

}

/* (non-Javadoc)

* @see backtype.storm.spout.ISpout#nextTuple()

*/

@Override

public void nextTuple() {

// TODO Auto-generated method stub

Person p= queues.poll();

if(p!=null){

log.debug("nextTuple----> 发送数据，用户ID="+p.getId());

collector.emit(new Values(p), p);

}

}

/* (non-Javadoc)

* @see backtype.storm.spout.ISpout#open(java.util.Map, backtype.storm.task.TopologyContext, backtype.storm.spout.SpoutOutputCollector)

*/

@Override

public void open(Map map, TopologyContext context, SpoutOutputCollector collector) {

// TODO Auto-generated method stub

log.debug("spout-----> 将集合数据转换至队列中");

this.collector = collector;

this.conf = conf;

this.context = context;

Iterator<Person> it= list.iterator();

while(it.hasNext()){

Person p=it.next();

queues.add(p);

}

}

/* (non-Javadoc)

* @see backtype.storm.topology.IComponent#declareOutputFields(backtype.storm.topology.OutputFieldsDeclarer)

*/

@Override

public void declareOutputFields(OutputFieldsDeclarer declarer) {

// TODO Auto-generated method stub

log.debug("declareOutputFields----> 设置输出字段");

declarer.declare(new Fields("person"));

}

public DemoSpout(List<Person> list) {

super();

this.list = list;

}

/* (non-Javadoc)

* @see backtype.storm.spout.ISpout#activate()

*/

@Override

public void activate() {

// TODO Auto-generated method stub

}

/* (non-Javadoc)

* @see backtype.storm.spout.ISpout#deactivate()

*/

@Override

public void deactivate() {

// TODO Auto-generated method stub

}

/* (non-Javadoc)

* @see backtype.storm.topology.IComponent#getComponentConfiguration()

*/

@Override

public Map<String, Object> getComponentConfiguration() {

// TODO Auto-generated method stub

return null;

}

}

接着新建一个处理数据的Bolt,主要是在execute方法中通过之前设置的字段person,获取当前传输的对象（此处需要主要的是storm早期版本貌似不能传输对象，我后来采用的是当前最新版本 0.8版本也可以这样）。然后进行处理，处理成功会调用ack方法，若失败则调用fail方法。

[java] view
plaincopy

/**

* ListBolt.java

* 版权所有(C) 2013

* 创建:cuiran 2013-01-15 16:05:25

*/

package com.stormdemo.demo;

import java.util.Map;

import org.apache.commons.logging.Log;

import org.apache.commons.logging.LogFactory;

import backtype.storm.task.OutputCollector;

import backtype.storm.task.TopologyContext;

import backtype.storm.topology.IRichBolt;

import backtype.storm.topology.OutputFieldsDeclarer;

import backtype.storm.tuple.Tuple;

/**

* TODO

* @author cuiran

* @version TODO

*/

public class ListBolt implements IRichBolt {

/**

*

*/

private static final long serialVersionUID = 6467077126541265761L;

private static Log log = LogFactory.getLog(ListBolt.class.getName());

private OutputCollector collector;

/* (non-Javadoc)

* @see backtype.storm.task.IBolt#cleanup()

*/

@Override

public void cleanup() {

// TODO Auto-generated method stub

}

/* (non-Javadoc)

* @see backtype.storm.task.IBolt#execute(backtype.storm.tuple.Tuple)

*/

@Override

public void execute(Tuple tuple) {

// TODO Auto-generated method stub

try {

log.debug("execute----->处理数据");

Person p= (Person)tuple.getValueByField("person");

log.debug("处理数据 用户="+p.toString());

collector.ack(tuple);

}catch (Exception e) {

collector.fail(tuple);

// TODO: handle exception

log.error("处理数据出现异常", e);

}

}

/* (non-Javadoc)

* @see backtype.storm.task.IBolt#prepare(java.util.Map, backtype.storm.task.TopologyContext, backtype.storm.task.OutputCollector)

*/

@Override

public void prepare(Map map, TopologyContext context, OutputCollector collector) {

// TODO Auto-generated method stub

this.collector=collector;

}

/* (non-Javadoc)

* @see backtype.storm.topology.IComponent#declareOutputFields(backtype.storm.topology.OutputFieldsDeclarer)

*/

@Override

public void declareOutputFields(OutputFieldsDeclarer declarer) {

// TODO Auto-generated method stub

}

/* (non-Javadoc)

* @see backtype.storm.topology.IComponent#getComponentConfiguration()

*/

@Override

public Map<String, Object> getComponentConfiguration() {

// TODO Auto-generated method stub

return null;

}

}

最后就是我们的测试类：由于启动storm后一直运行，若需要停止需要kill掉，我们测试时候就是用的

cluster.killTopology("test");

cluster.shutdown();

需要注意的是在setSpout和setBolt方法中第一个参数id在早期版本是int类型，后期版本就改为string了。

[java] view
plaincopy

/**

* DemoTopology.java

* 版权所有(C) 2013

* 创建:cuiran 2013-01-15 16:13:27

*/

package com.stormdemo.demo;

import java.util.ArrayList;

import java.util.List;

import org.apache.commons.logging.Log;

import org.apache.commons.logging.LogFactory;

import backtype.storm.Config;

import backtype.storm.LocalCluster;

import backtype.storm.generated.StormTopology;

import backtype.storm.topology.TopologyBuilder;

import backtype.storm.utils.Utils;

import junit.framework.TestCase;

/**

* TODO

* @author cuiran

* @version TODO

*/

public class DemoTopology extends TestCase {

private static Log log = LogFactory.getLog(DemoTopology.class.getName());

public static StormTopology buildTopology(List<Person> list) {

TopologyBuilder builder = new TopologyBuilder();

builder.setSpout("1", new DemoSpout(list));

builder.setBolt("2", new ListBolt()).globalGrouping("1");

return builder.createTopology();

}

public static List<Person> getPerson(){

List<Person> list=new ArrayList<Person>();

for(int i=1;i<10;i++){

Person p=new Person();

p.setId((long)i);

p.setName("zhang"+i);

p.setAge(20+i);

list.add(p);

}

return list;

}

public static List<String> getStr(){

List<String> list=new ArrayList<String>();

for(int i=1;i<10;i++){

list.add("test"+i);

}

return list;

}

public void testTopology(){

log.debug("stormdemo开始");

long startTime=System.currentTimeMillis();

Config conf = new Config();

conf.setDebug(true);

conf.setNumWorkers(2);

conf.setMaxSpoutPending(1);

LocalCluster cluster = new LocalCluster();

List<Person> list=getPerson();

cluster.submitTopology("demo", conf, buildTopology(list));

long executeTime=System.currentTimeMillis();

Utils.sleep(30000);

log.debug("stormdemo结束");

long stopTime=System.currentTimeMillis();

log.debug("共消耗时间：运行="+(executeTime-startTime)+",总时间："+(stopTime-startTime)+"");

cluster.killTopology("test");

cluster.shutdown();

}

}

最后运行结果：

[plain] view
plaincopy

log4j:ERROR Could not find value for key log4j.appender.fileout

log4j:ERROR Could not instantiate appender named "fileout".

2013-01-16 09:20:42:DEBUG com.stormdemo.demo.DemoTopology - stormdemo开始

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:zookeeper.version=3.3.3-1073969, built on 02/23/2011 22:27 GMT

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:host.name=PC2010110311cvt

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:java.version=1.6.0_01

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:java.vendor=Sun Microsystems Inc.

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:java.home=D:\Java\jre1.6.0_01

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:java.class.path=D:\workspace\stormdemo1\WebRoot\WEB-INF\classes;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\clout-0.4.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-exec-1.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-fileupload-1.2.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-io-1.4.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\compojure-0.6.4.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\core.incubator-0.1.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\hiccup-0.3.6.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jetty-6.1.26.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jetty-util-6.1.26.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jline-0.9.94.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\json-simple-1.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\junit-3.8.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jzmq-2.1.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\log4j-1.2.16.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\ring-core-0.3.10.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\ring-jetty-adapter-0.3.11.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\ring-servlet-0.3.11.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\servlet-api-2.5-20081211.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\servlet-api-2.5.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\tools.macro-0.1.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\asm-4.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\carbonite-1.5.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\clj-time-0.4.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\clojure-1.4.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-codec-1.4.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-lang-2.5.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-logging-1.1.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\curator-client-1.0.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\curator-framework-1.0.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\disruptor-2.10.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\guava-13.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\httpclient-4.1.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\httpcore-4.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jgrapht-0.8.3.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\joda-time-2.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\kryo-2.17.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\libthrift7-0.7.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\log4j-over-slf4j-1.6.6.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\logback-classic-1.0.6.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\logback-core-1.0.6.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\math.numeric-tower-0.0.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\minlog-1.2.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\objenesis-1.2.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\reflectasm-1.07-shaded.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\slf4j-api-1.6.5.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\snakeyaml-1.9.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\tools.cli-0.2.2.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\tools.logging-0.2.3.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\zookeeper-3.3.3.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\storm-0.9.0-wip7.jar;/D:/MyEclipse 6.6/eclipse/configuration/org.eclipse.osgi/bundles/543/1/.cp/;/D:/MyEclipse 6.6/eclipse/configuration/org.eclipse.osgi/bundles/541/1/.cp/

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:java.library.path=D:\Java\jre1.6.0_01\bin;.;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;D:\Java\jdk1.6.0_01\bin;e:\oracle\product\10.2.0\client_1\bin;d:\oracle\product\10.2.0\client_1\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;D:\Program Files\TortoiseSVN\bin;;C:\Program Files\Common Files\Thunder Network\KanKan\Codecs;E:\ant182\bin;C:\Program Files\Java\jdk1.6.0_01\bin;;C:\Program Files\Android\android-sdk-windows\platform-tools;c:\php\ext;D:\Java\jdk1.6.0_01;C:\Program Files\MySQL\MySQL Server 5.1\bin;D:\Program Files\TortoiseSVN\bin;C:\Program Files\Microsoft SQL Server\80\Tools\Binn\;C:\Program Files\Microsoft SQL Server\90\Tools\binn\;C:\Program Files\Microsoft SQL Server\90\DTS\Binn\;C:\Program Files\Microsoft SQL Server\90\Tools\Binn\VSShell\Common7\IDE\;C:\Program Files\Microsoft Visual Studio 8\Common7\IDE\PrivateAssemblies\;D:\Ruby193\bin;D:\PHP;D:\PHP\ext;D:\Maven\bin

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:java.io.tmpdir=C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:java.compiler=<NA>

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:os.name=Windows XP

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:os.arch=x86

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:os.version=5.1

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:user.name=Administrator

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:user.home=C:\Documents and Settings\Administrator

2013-01-16 09:20:45:INFO org.apache.zookeeper.ZooKeeper - Client environment:user.dir=D:\workspace\stormdemo1

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:zookeeper.version=3.3.3-1073969, built on 02/23/2011 22:27 GMT

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:host.name=PC2010110311cvt

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:java.version=1.6.0_01

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:java.vendor=Sun Microsystems Inc.

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:java.home=D:\Java\jre1.6.0_01

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:java.class.path=D:\workspace\stormdemo1\WebRoot\WEB-INF\classes;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\clout-0.4.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-exec-1.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-fileupload-1.2.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-io-1.4.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\compojure-0.6.4.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\core.incubator-0.1.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\hiccup-0.3.6.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jetty-6.1.26.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jetty-util-6.1.26.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jline-0.9.94.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\json-simple-1.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\junit-3.8.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jzmq-2.1.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\log4j-1.2.16.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\ring-core-0.3.10.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\ring-jetty-adapter-0.3.11.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\ring-servlet-0.3.11.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\servlet-api-2.5-20081211.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\servlet-api-2.5.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\tools.macro-0.1.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\asm-4.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\carbonite-1.5.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\clj-time-0.4.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\clojure-1.4.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-codec-1.4.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-lang-2.5.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\commons-logging-1.1.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\curator-client-1.0.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\curator-framework-1.0.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\disruptor-2.10.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\guava-13.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\httpclient-4.1.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\httpcore-4.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\jgrapht-0.8.3.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\joda-time-2.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\kryo-2.17.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\libthrift7-0.7.0.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\log4j-over-slf4j-1.6.6.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\logback-classic-1.0.6.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\logback-core-1.0.6.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\math.numeric-tower-0.0.1.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\minlog-1.2.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\objenesis-1.2.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\reflectasm-1.07-shaded.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\slf4j-api-1.6.5.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\snakeyaml-1.9.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\tools.cli-0.2.2.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\tools.logging-0.2.3.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\zookeeper-3.3.3.jar;D:\workspace\stormdemo1\WebRoot\WEB-INF\lib\storm-0.9.0-wip7.jar;/D:/MyEclipse 6.6/eclipse/configuration/org.eclipse.osgi/bundles/543/1/.cp/;/D:/MyEclipse 6.6/eclipse/configuration/org.eclipse.osgi/bundles/541/1/.cp/

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:java.library.path=D:\Java\jre1.6.0_01\bin;.;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;D:\Java\jdk1.6.0_01\bin;e:\oracle\product\10.2.0\client_1\bin;d:\oracle\product\10.2.0\client_1\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;D:\Program Files\TortoiseSVN\bin;;C:\Program Files\Common Files\Thunder Network\KanKan\Codecs;E:\ant182\bin;C:\Program Files\Java\jdk1.6.0_01\bin;;C:\Program Files\Android\android-sdk-windows\platform-tools;c:\php\ext;D:\Java\jdk1.6.0_01;C:\Program Files\MySQL\MySQL Server 5.1\bin;D:\Program Files\TortoiseSVN\bin;C:\Program Files\Microsoft SQL Server\80\Tools\Binn\;C:\Program Files\Microsoft SQL Server\90\Tools\binn\;C:\Program Files\Microsoft SQL Server\90\DTS\Binn\;C:\Program Files\Microsoft SQL Server\90\Tools\Binn\VSShell\Common7\IDE\;C:\Program Files\Microsoft Visual Studio 8\Common7\IDE\PrivateAssemblies\;D:\Ruby193\bin;D:\PHP;D:\PHP\ext;D:\Maven\bin

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:java.io.tmpdir=C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:java.compiler=<NA>

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:os.name=Windows XP

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:os.arch=x86

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:os.version=5.1

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:user.name=Administrator

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:user.home=C:\Documents and Settings\Administrator

2013-01-16 09:20:45:INFO org.apache.zookeeper.server.ZooKeeperServer - Server environment:user.dir=D:\workspace\stormdemo1

2013-01-16 09:20:47:INFO org.apache.zookeeper.server.ZooKeeperServer - Created server with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\a79a4c6f-b820-4d54-85e2-212abbd237f6\version-2 snapdir C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\a79a4c6f-b820-4d54-85e2-212abbd237f6\version-2

2013-01-16 09:20:47:INFO org.apache.zookeeper.server.NIOServerCnxn - binding to port 0.0.0.0/0.0.0.0:2000

3312 [main] INFO backtype.storm.zookeeper - Starting inprocess zookeeper at port 2000 and dir C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\/a79a4c6f-b820-4d54-85e2-212abbd237f6

2013-01-16 09:20:47:INFO org.apache.zookeeper.server.persistence.FileTxnSnapLog - Snapshotting: 0

3734 [main] INFO backtype.storm.daemon.nimbus - Starting Nimbus with conf {"dev.zookeeper.path" "/tmp/dev-storm-zookeeper", "topology.tick.tuple.freq.secs" nil, "topology.builtin.metrics.bucket.size.secs" 60, "topology.fall.back.on.java.serialization" true, "topology.max.error.report.per.interval" 5, "zmq.linger.millis" 0, "topology.skip.missing.kryo.registrations" true, "ui.childopts" "-Xmx768m", "storm.zookeeper.session.timeout" 20000, "nimbus.reassign" true, "topology.trident.batch.emit.interval.millis" 50, "nimbus.monitor.freq.secs" 10, "java.library.path" "/usr/local/lib:/opt/local/lib:/usr/lib", "topology.executor.send.buffer.size" 1024, "storm.local.dir" "C:\\DOCUME~1\\ADMINI~1\\LOCALS~1\\Temp\\/905e5ab3-42c8-47ef-9687-322ffe72a619", "supervisor.worker.start.timeout.secs" 120, "topology.enable.message.timeouts" true, "nimbus.cleanup.inbox.freq.secs" 600, "nimbus.inbox.jar.expiration.secs" 3600, "topology.worker.shared.thread.pool.size" 4, "nimbus.host" "localhost", "storm.zookeeper.port" 2000, "transactional.zookeeper.port" nil, "topology.executor.receive.buffer.size" 1024, "transactional.zookeeper.servers" nil, "storm.zookeeper.root" "/storm", "supervisor.enable" true, "storm.zookeeper.servers" ["localhost"], "transactional.zookeeper.root" "/transactional", "topology.acker.executors" 1, "topology.transfer.buffer.size" 1024, "topology.worker.childopts" nil, "worker.childopts" "-Xmx768m", "supervisor.heartbeat.frequency.secs" 5, "topology.error.throttle.interval.secs" 10, "zmq.hwm" 0, "drpc.port" 3772, "supervisor.monitor.frequency.secs" 3, "topology.receiver.buffer.size" 8, "task.heartbeat.frequency.secs" 3, "topology.tasks" nil, "topology.spout.wait.strategy" "backtype.storm.spout.SleepSpoutWaitStrategy", "topology.max.spout.pending" nil, "storm.zookeeper.retry.interval" 1000, "topology.sleep.spout.wait.strategy.time.ms" 1, "nimbus.topology.validator" "backtype.storm.nimbus.DefaultTopologyValidator", "supervisor.slots.ports" [6700 6701 6702 6703], "topology.debug" false, "nimbus.task.launch.secs" 120, "nimbus.supervisor.timeout.secs" 60, "topology.message.timeout.secs" 30, "task.refresh.poll.secs" 10, "topology.workers" 1, "supervisor.childopts" "-Xmx256m", "nimbus.thrift.port" 6627, "topology.stats.sample.rate" 0.05, "worker.heartbeat.frequency.secs" 1, "topology.acker.tasks" nil, "topology.disruptor.wait.strategy" "com.lmax.disruptor.BlockingWaitStrategy", "nimbus.task.timeout.secs" 30, "storm.zookeeper.connection.timeout" 15000, "topology.kryo.factory" "backtype.storm.serialization.DefaultKryoFactory", "drpc.invocations.port" 3773, "zmq.threads" 1, "storm.zookeeper.retry.times" 5, "topology.state.synchronization.timeout.secs" 60, "supervisor.worker.timeout.secs" 30, "nimbus.file.copy.expiration.secs" 600, "drpc.request.timeout.secs" 600, "storm.local.mode.zmq" false, "ui.port" 8080, "nimbus.childopts" "-Xmx1024m", "storm.cluster.mode" "local", "topology.optimize" true, "topology.max.task.parallelism" nil}

3765 [main] INFO backtype.storm.daemon.nimbus - Using default scheduler

3859 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:47:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000 sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@46a09b

2013-01-16 09:20:47:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:47:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:47:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2006

2013-01-16 09:20:47:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2006

2013-01-16 09:20:47:INFO org.apache.zookeeper.server.persistence.FileTxnLog - Creating new log file: log.1

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720000 with negotiated timeout 20000 for client /127.0.0.1:2006

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720000, negotiated timeout = 20000

4546 [main-EventThread] INFO backtype.storm.zookeeper - Zookeeper state update: :connected:none

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.PrepRequestProcessor - Processed session termination for sessionid: 0x13c40f1b2720000

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Session: 0x13c40f1b2720000 closed

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - EventThread shut down

2013-01-16 09:20:48:WARN org.apache.zookeeper.server.NIOServerCnxn - EndOfStreamException: Unable to read additional data from client sessionid 0x13c40f1b2720000, likely client has closed socket

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Closed socket connection for client /127.0.0.1:2006 which had sessionid 0x13c40f1b2720000

4625 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000/storm sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@1eea7f0

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2009

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2009

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720001 with negotiated timeout 20000 for client /127.0.0.1:2009

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720001, negotiated timeout = 20000

4796 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000 sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@62be97

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2013

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2013

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720002 with negotiated timeout 20000 for client /127.0.0.1:2013

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720002, negotiated timeout = 20000

4843 [main-EventThread] INFO backtype.storm.zookeeper - Zookeeper state update: :connected:none

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.PrepRequestProcessor - Processed session termination for sessionid: 0x13c40f1b2720002

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Session: 0x13c40f1b2720002 closed

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - EventThread shut down

4859 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Closed socket connection for client /127.0.0.1:2013 which had sessionid 0x13c40f1b2720002

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000/storm sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@d8e902

4859 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000 sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@6c08b2

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2016

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2016

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2019

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2019

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720003 with negotiated timeout 20000 for client /127.0.0.1:2016

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720003, negotiated timeout = 20000

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720004, negotiated timeout = 20000

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720004 with negotiated timeout 20000 for client /127.0.0.1:2019

4890 [main-EventThread] INFO backtype.storm.zookeeper - Zookeeper state update: :connected:none

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.PrepRequestProcessor - Processed session termination for sessionid: 0x13c40f1b2720004

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Session: 0x13c40f1b2720004 closed

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - EventThread shut down

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Closed socket connection for client /127.0.0.1:2019 which had sessionid 0x13c40f1b2720004

4906 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000/storm sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@164804

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2023

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2023

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720005 with negotiated timeout 20000 for client /127.0.0.1:2023

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720005, negotiated timeout = 20000

4953 [main] INFO backtype.storm.daemon.supervisor - Starting Supervisor with conf {"dev.zookeeper.path" "/tmp/dev-storm-zookeeper", "topology.tick.tuple.freq.secs" nil, "topology.builtin.metrics.bucket.size.secs" 60, "topology.fall.back.on.java.serialization" true, "topology.max.error.report.per.interval" 5, "zmq.linger.millis" 0, "topology.skip.missing.kryo.registrations" true, "ui.childopts" "-Xmx768m", "storm.zookeeper.session.timeout" 20000, "nimbus.reassign" true, "topology.trident.batch.emit.interval.millis" 50, "nimbus.monitor.freq.secs" 10, "java.library.path" "/usr/local/lib:/opt/local/lib:/usr/lib", "topology.executor.send.buffer.size" 1024, "storm.local.dir" "C:\\DOCUME~1\\ADMINI~1\\LOCALS~1\\Temp\\/dd108ee9-8f33-4324-9ef7-7b3b2f443f23", "supervisor.worker.start.timeout.secs" 120, "topology.enable.message.timeouts" true, "nimbus.cleanup.inbox.freq.secs" 600, "nimbus.inbox.jar.expiration.secs" 3600, "topology.worker.shared.thread.pool.size" 4, "nimbus.host" "localhost", "storm.zookeeper.port" 2000, "transactional.zookeeper.port" nil, "topology.executor.receive.buffer.size" 1024, "transactional.zookeeper.servers" nil, "storm.zookeeper.root" "/storm", "supervisor.enable" true, "storm.zookeeper.servers" ["localhost"], "transactional.zookeeper.root" "/transactional", "topology.acker.executors" 1, "topology.transfer.buffer.size" 1024, "topology.worker.childopts" nil, "worker.childopts" "-Xmx768m", "supervisor.heartbeat.frequency.secs" 5, "topology.error.throttle.interval.secs" 10, "zmq.hwm" 0, "drpc.port" 3772, "supervisor.monitor.frequency.secs" 3, "topology.receiver.buffer.size" 8, "task.heartbeat.frequency.secs" 3, "topology.tasks" nil, "topology.spout.wait.strategy" "backtype.storm.spout.SleepSpoutWaitStrategy", "topology.max.spout.pending" nil, "storm.zookeeper.retry.interval" 1000, "topology.sleep.spout.wait.strategy.time.ms" 1, "nimbus.topology.validator" "backtype.storm.nimbus.DefaultTopologyValidator", "supervisor.slots.ports" (1 2 3), "topology.debug" false, "nimbus.task.launch.secs" 120, "nimbus.supervisor.timeout.secs" 60, "topology.message.timeout.secs" 30, "task.refresh.poll.secs" 10, "topology.workers" 1, "supervisor.childopts" "-Xmx256m", "nimbus.thrift.port" 6627, "topology.stats.sample.rate" 0.05, "worker.heartbeat.frequency.secs" 1, "topology.acker.tasks" nil, "topology.disruptor.wait.strategy" "com.lmax.disruptor.BlockingWaitStrategy", "nimbus.task.timeout.secs" 30, "storm.zookeeper.connection.timeout" 15000, "topology.kryo.factory" "backtype.storm.serialization.DefaultKryoFactory", "drpc.invocations.port" 3773, "zmq.threads" 1, "storm.zookeeper.retry.times" 5, "topology.state.synchronization.timeout.secs" 60, "supervisor.worker.timeout.secs" 30, "nimbus.file.copy.expiration.secs" 600, "drpc.request.timeout.secs" 600, "storm.local.mode.zmq" false, "ui.port" 8080, "nimbus.childopts" "-Xmx1024m", "storm.cluster.mode" "local", "topology.optimize" true, "topology.max.task.parallelism" nil}

5031 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000 sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@19d794d

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2026

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2026

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720006 with negotiated timeout 20000 for client /127.0.0.1:2026

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720006, negotiated timeout = 20000

5062 [main-EventThread] INFO backtype.storm.zookeeper - Zookeeper state update: :connected:none

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.PrepRequestProcessor - Processed session termination for sessionid: 0x13c40f1b2720006

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Session: 0x13c40f1b2720006 closed

2013-01-16 09:20:48:WARN org.apache.zookeeper.server.NIOServerCnxn - EndOfStreamException: Unable to read additional data from client sessionid 0x13c40f1b2720006, likely client has closed socket

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - EventThread shut down

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Closed socket connection for client /127.0.0.1:2026 which had sessionid 0x13c40f1b2720006

5078 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:48:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000/storm sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@d713fe

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2030

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2030

2013-01-16 09:20:48:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720007 with negotiated timeout 20000 for client /127.0.0.1:2030

2013-01-16 09:20:48:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720007, negotiated timeout = 20000

5125 [main] INFO backtype.storm.daemon.supervisor - Starting supervisor with id a753e74a-55c8-47b5-b5f8-3e5c957335f8 at host PC2010110311cvt

5140 [main] INFO backtype.storm.daemon.supervisor - Starting Supervisor with conf {"dev.zookeeper.path" "/tmp/dev-storm-zookeeper", "topology.tick.tuple.freq.secs" nil, "topology.builtin.metrics.bucket.size.secs" 60, "topology.fall.back.on.java.serialization" true, "topology.max.error.report.per.interval" 5, "zmq.linger.millis" 0, "topology.skip.missing.kryo.registrations" true, "ui.childopts" "-Xmx768m", "storm.zookeeper.session.timeout" 20000, "nimbus.reassign" true, "topology.trident.batch.emit.interval.millis" 50, "nimbus.monitor.freq.secs" 10, "java.library.path" "/usr/local/lib:/opt/local/lib:/usr/lib", "topology.executor.send.buffer.size" 1024, "storm.local.dir" "C:\\DOCUME~1\\ADMINI~1\\LOCALS~1\\Temp\\/86c7a04d-fe18-4dba-b751-24507fd794e0", "supervisor.worker.start.timeout.secs" 120, "topology.enable.message.timeouts" true, "nimbus.cleanup.inbox.freq.secs" 600, "nimbus.inbox.jar.expiration.secs" 3600, "topology.worker.shared.thread.pool.size" 4, "nimbus.host" "localhost", "storm.zookeeper.port" 2000, "transactional.zookeeper.port" nil, "topology.executor.receive.buffer.size" 1024, "transactional.zookeeper.servers" nil, "storm.zookeeper.root" "/storm", "supervisor.enable" true, "storm.zookeeper.servers" ["localhost"], "transactional.zookeeper.root" "/transactional", "topology.acker.executors" 1, "topology.transfer.buffer.size" 1024, "topology.worker.childopts" nil, "worker.childopts" "-Xmx768m", "supervisor.heartbeat.frequency.secs" 5, "topology.error.throttle.interval.secs" 10, "zmq.hwm" 0, "drpc.port" 3772, "supervisor.monitor.frequency.secs" 3, "topology.receiver.buffer.size" 8, "task.heartbeat.frequency.secs" 3, "topology.tasks" nil, "topology.spout.wait.strategy" "backtype.storm.spout.SleepSpoutWaitStrategy", "topology.max.spout.pending" nil, "storm.zookeeper.retry.interval" 1000, "topology.sleep.spout.wait.strategy.time.ms" 1, "nimbus.topology.validator" "backtype.storm.nimbus.DefaultTopologyValidator", "supervisor.slots.ports" (4 5 6), "topology.debug" false, "nimbus.task.launch.secs" 120, "nimbus.supervisor.timeout.secs" 60, "topology.message.timeout.secs" 30, "task.refresh.poll.secs" 10, "topology.workers" 1, "supervisor.childopts" "-Xmx256m", "nimbus.thrift.port" 6627, "topology.stats.sample.rate" 0.05, "worker.heartbeat.frequency.secs" 1, "topology.acker.tasks" nil, "topology.disruptor.wait.strategy" "com.lmax.disruptor.BlockingWaitStrategy", "nimbus.task.timeout.secs" 30, "storm.zookeeper.connection.timeout" 15000, "topology.kryo.factory" "backtype.storm.serialization.DefaultKryoFactory", "drpc.invocations.port" 3773, "zmq.threads" 1, "storm.zookeeper.retry.times" 5, "topology.state.synchronization.timeout.secs" 60, "supervisor.worker.timeout.secs" 30, "nimbus.file.copy.expiration.secs" 600, "drpc.request.timeout.secs" 600, "storm.local.mode.zmq" false, "ui.port" 8080, "nimbus.childopts" "-Xmx1024m", "storm.cluster.mode" "local", "topology.optimize" true, "topology.max.task.parallelism" nil}

5156 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:49:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000 sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@16c1227

2013-01-16 09:20:49:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:49:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2033

2013-01-16 09:20:49:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:49:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2033

2013-01-16 09:20:49:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720008 with negotiated timeout 20000 for client /127.0.0.1:2033

2013-01-16 09:20:49:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720008, negotiated timeout = 20000

5171 [main-EventThread] INFO backtype.storm.zookeeper - Zookeeper state update: :connected:none

2013-01-16 09:20:49:INFO org.apache.zookeeper.server.PrepRequestProcessor - Processed session termination for sessionid: 0x13c40f1b2720008

2013-01-16 09:20:49:INFO org.apache.zookeeper.ZooKeeper - Session: 0x13c40f1b2720008 closed

5187 [main] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:49:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000/storm sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@1b5eba4

2013-01-16 09:20:49:INFO org.apache.zookeeper.ClientCnxn - EventThread shut down

2013-01-16 09:20:49:WARN org.apache.zookeeper.server.NIOServerCnxn - EndOfStreamException: Unable to read additional data from client sessionid 0x13c40f1b2720008, likely client has closed socket

2013-01-16 09:20:49:INFO org.apache.zookeeper.server.NIOServerCnxn - Closed socket connection for client /127.0.0.1:2033 which had sessionid 0x13c40f1b2720008

2013-01-16 09:20:49:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:49:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2036

2013-01-16 09:20:49:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:49:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2036

2013-01-16 09:20:49:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b2720009 with negotiated timeout 20000 for client /127.0.0.1:2036

2013-01-16 09:20:49:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b2720009, negotiated timeout = 20000

5234 [main] INFO backtype.storm.daemon.supervisor - Starting supervisor with id a9368e3d-c540-49c8-b7ef-11327e92f9cd at host PC2010110311cvt

2013-01-16 09:20:49:DEBUG com.stormdemo.demo.DemoSpout - declareOutputFields----> 设置输出字段

5546 [main] INFO backtype.storm.daemon.nimbus - Received topology submission for demo with conf {"topology.max.task.parallelism" nil, "topology.acker.executors" 1, "topology.kryo.register" nil, "topology.kryo.decorators" (), "topology.name" "demo", "storm.id" "demo-1-1358299249", "topology.workers" 2, "topology.debug" true, "topology.max.spout.pending" 1}

5593 [main] INFO backtype.storm.daemon.nimbus - Activating demo: demo-1-1358299249

5734 [main] INFO backtype.storm.scheduler.EvenScheduler - Available slots: (["a9368e3d-c540-49c8-b7ef-11327e92f9cd" 4] ["a9368e3d-c540-49c8-b7ef-11327e92f9cd" 5] ["a9368e3d-c540-49c8-b7ef-11327e92f9cd" 6] ["a753e74a-55c8-47b5-b5f8-3e5c957335f8" 1] ["a753e74a-55c8-47b5-b5f8-3e5c957335f8" 2] ["a753e74a-55c8-47b5-b5f8-3e5c957335f8" 3])

5765 [main] INFO backtype.storm.daemon.nimbus - Setting new assignment for topology id demo-1-1358299249: #backtype.storm.daemon.common.Assignment{:master-code-dir "C:\\DOCUME~1\\ADMINI~1\\LOCALS~1\\Temp\\/905e5ab3-42c8-47ef-9687-322ffe72a619/nimbus/stormdist/demo-1-1358299249", :node->host {"a753e74a-55c8-47b5-b5f8-3e5c957335f8" "PC2010110311cvt", "a9368e3d-c540-49c8-b7ef-11327e92f9cd" "PC2010110311cvt"}, :executor->node+port {[3 3] ["a9368e3d-c540-49c8-b7ef-11327e92f9cd" 4], [2 2] ["a753e74a-55c8-47b5-b5f8-3e5c957335f8" 1], [1 1] ["a9368e3d-c540-49c8-b7ef-11327e92f9cd" 4]}, :executor->start-time-secs {[1 1] 1358299249, [3 3] 1358299249, [2 2] 1358299249}}

6109 [Thread-5] INFO backtype.storm.daemon.supervisor - Downloading code for storm id demo-1-1358299249 from C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\/905e5ab3-42c8-47ef-9687-322ffe72a619/nimbus/stormdist/demo-1-1358299249

6328 [Thread-8] INFO backtype.storm.daemon.supervisor - Downloading code for storm id demo-1-1358299249 from C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\/905e5ab3-42c8-47ef-9687-322ffe72a619/nimbus/stormdist/demo-1-1358299249

6578 [Thread-5] INFO backtype.storm.daemon.supervisor - Finished downloading code for storm id demo-1-1358299249 from C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\/905e5ab3-42c8-47ef-9687-322ffe72a619/nimbus/stormdist/demo-1-1358299249

6640 [Thread-6] INFO backtype.storm.daemon.supervisor - Launching worker with assignment #backtype.storm.daemon.supervisor.LocalAssignment{:storm-id "demo-1-1358299249", :executors [[2 2]]} for this supervisor a753e74a-55c8-47b5-b5f8-3e5c957335f8 on port 1 with id ce797194-f0a1-4d1f-a0df-6a388935cf26

6656 [Thread-6] INFO backtype.storm.daemon.worker - Launching worker for demo-1-1358299249 on a753e74a-55c8-47b5-b5f8-3e5c957335f8:1 with id ce797194-f0a1-4d1f-a0df-6a388935cf26 and conf {"dev.zookeeper.path" "/tmp/dev-storm-zookeeper", "topology.tick.tuple.freq.secs" nil, "topology.builtin.metrics.bucket.size.secs" 60, "topology.fall.back.on.java.serialization" true, "topology.max.error.report.per.interval" 5, "zmq.linger.millis" 0, "topology.skip.missing.kryo.registrations" true, "ui.childopts" "-Xmx768m", "storm.zookeeper.session.timeout" 20000, "nimbus.reassign" true, "topology.trident.batch.emit.interval.millis" 50, "nimbus.monitor.freq.secs" 10, "java.library.path" "/usr/local/lib:/opt/local/lib:/usr/lib", "topology.executor.send.buffer.size" 1024, "storm.local.dir" "C:\\DOCUME~1\\ADMINI~1\\LOCALS~1\\Temp\\/dd108ee9-8f33-4324-9ef7-7b3b2f443f23", "supervisor.worker.start.timeout.secs" 120, "topology.enable.message.timeouts" true, "nimbus.cleanup.inbox.freq.secs" 600, "nimbus.inbox.jar.expiration.secs" 3600, "topology.worker.shared.thread.pool.size" 4, "nimbus.host" "localhost", "storm.zookeeper.port" 2000, "transactional.zookeeper.port" nil, "topology.executor.receive.buffer.size" 1024, "transactional.zookeeper.servers" nil, "storm.zookeeper.root" "/storm", "supervisor.enable" true, "storm.zookeeper.servers" ["localhost"], "transactional.zookeeper.root" "/transactional", "topology.acker.executors" 1, "topology.transfer.buffer.size" 1024, "topology.worker.childopts" nil, "worker.childopts" "-Xmx768m", "supervisor.heartbeat.frequency.secs" 5, "topology.error.throttle.interval.secs" 10, "zmq.hwm" 0, "drpc.port" 3772, "supervisor.monitor.frequency.secs" 3, "topology.receiver.buffer.size" 8, "task.heartbeat.frequency.secs" 3, "topology.tasks" nil, "topology.spout.wait.strategy" "backtype.storm.spout.SleepSpoutWaitStrategy", "topology.max.spout.pending" nil, "storm.zookeeper.retry.interval" 1000, "topology.sleep.spout.wait.strategy.time.ms" 1, "nimbus.topology.validator" "backtype.storm.nimbus.DefaultTopologyValidator", "supervisor.slots.ports" (1 2 3), "topology.debug" false, "nimbus.task.launch.secs" 120, "nimbus.supervisor.timeout.secs" 60, "topology.message.timeout.secs" 30, "task.refresh.poll.secs" 10, "topology.workers" 1, "supervisor.childopts" "-Xmx256m", "nimbus.thrift.port" 6627, "topology.stats.sample.rate" 0.05, "worker.heartbeat.frequency.secs" 1, "topology.acker.tasks" nil, "topology.disruptor.wait.strategy" "com.lmax.disruptor.BlockingWaitStrategy", "nimbus.task.timeout.secs" 30, "storm.zookeeper.connection.timeout" 15000, "topology.kryo.factory" "backtype.storm.serialization.DefaultKryoFactory", "drpc.invocations.port" 3773, "zmq.threads" 1, "storm.zookeeper.retry.times" 5, "topology.state.synchronization.timeout.secs" 60, "supervisor.worker.timeout.secs" 30, "nimbus.file.copy.expiration.secs" 600, "drpc.request.timeout.secs" 600, "storm.local.mode.zmq" false, "ui.port" 8080, "nimbus.childopts" "-Xmx1024m", "storm.cluster.mode" "local", "topology.optimize" true, "topology.max.task.parallelism" nil}

6656 [Thread-6] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:50:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000 sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@a64a92

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2039

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2039

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b272000a, negotiated timeout = 20000

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b272000a with negotiated timeout 20000 for client /127.0.0.1:2039

6671 [Thread-6-EventThread] INFO backtype.storm.zookeeper - Zookeeper state update: :connected:none

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.PrepRequestProcessor - Processed session termination for sessionid: 0x13c40f1b272000a

2013-01-16 09:20:50:INFO org.apache.zookeeper.ZooKeeper - Session: 0x13c40f1b272000a closed

2013-01-16 09:20:50:WARN org.apache.zookeeper.server.NIOServerCnxn - EndOfStreamException: Unable to read additional data from client sessionid 0x13c40f1b272000a, likely client has closed socket

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Closed socket connection for client /127.0.0.1:2039 which had sessionid 0x13c40f1b272000a

6687 [Thread-6] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:50:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000/storm sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@1264666

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - EventThread shut down

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2042

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2042

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b272000b, negotiated timeout = 20000

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b272000b with negotiated timeout 20000 for client /127.0.0.1:2042

7031 [Thread-8] INFO backtype.storm.daemon.supervisor - Finished downloading code for storm id demo-1-1358299249 from C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\/905e5ab3-42c8-47ef-9687-322ffe72a619/nimbus/stormdist/demo-1-1358299249

7093 [Thread-9] INFO backtype.storm.daemon.supervisor - Launching worker with assignment #backtype.storm.daemon.supervisor.LocalAssignment{:storm-id "demo-1-1358299249", :executors ([3 3] [1 1])} for this supervisor a9368e3d-c540-49c8-b7ef-11327e92f9cd on port 4 with id b56bca1d-cdd0-458c-941a-7f1719d5bc2b

7109 [Thread-9] INFO backtype.storm.daemon.worker - Launching worker for demo-1-1358299249 on a9368e3d-c540-49c8-b7ef-11327e92f9cd:4 with id b56bca1d-cdd0-458c-941a-7f1719d5bc2b and conf {"dev.zookeeper.path" "/tmp/dev-storm-zookeeper", "topology.tick.tuple.freq.secs" nil, "topology.builtin.metrics.bucket.size.secs" 60, "topology.fall.back.on.java.serialization" true, "topology.max.error.report.per.interval" 5, "zmq.linger.millis" 0, "topology.skip.missing.kryo.registrations" true, "ui.childopts" "-Xmx768m", "storm.zookeeper.session.timeout" 20000, "nimbus.reassign" true, "topology.trident.batch.emit.interval.millis" 50, "nimbus.monitor.freq.secs" 10, "java.library.path" "/usr/local/lib:/opt/local/lib:/usr/lib", "topology.executor.send.buffer.size" 1024, "storm.local.dir" "C:\\DOCUME~1\\ADMINI~1\\LOCALS~1\\Temp\\/86c7a04d-fe18-4dba-b751-24507fd794e0", "supervisor.worker.start.timeout.secs" 120, "topology.enable.message.timeouts" true, "nimbus.cleanup.inbox.freq.secs" 600, "nimbus.inbox.jar.expiration.secs" 3600, "topology.worker.shared.thread.pool.size" 4, "nimbus.host" "localhost", "storm.zookeeper.port" 2000, "transactional.zookeeper.port" nil, "topology.executor.receive.buffer.size" 1024, "transactional.zookeeper.servers" nil, "storm.zookeeper.root" "/storm", "supervisor.enable" true, "storm.zookeeper.servers" ["localhost"], "transactional.zookeeper.root" "/transactional", "topology.acker.executors" 1, "topology.transfer.buffer.size" 1024, "topology.worker.childopts" nil, "worker.childopts" "-Xmx768m", "supervisor.heartbeat.frequency.secs" 5, "topology.error.throttle.interval.secs" 10, "zmq.hwm" 0, "drpc.port" 3772, "supervisor.monitor.frequency.secs" 3, "topology.receiver.buffer.size" 8, "task.heartbeat.frequency.secs" 3, "topology.tasks" nil, "topology.spout.wait.strategy" "backtype.storm.spout.SleepSpoutWaitStrategy", "topology.max.spout.pending" nil, "storm.zookeeper.retry.interval" 1000, "topology.sleep.spout.wait.strategy.time.ms" 1, "nimbus.topology.validator" "backtype.storm.nimbus.DefaultTopologyValidator", "supervisor.slots.ports" (4 5 6), "topology.debug" false, "nimbus.task.launch.secs" 120, "nimbus.supervisor.timeout.secs" 60, "topology.message.timeout.secs" 30, "task.refresh.poll.secs" 10, "topology.workers" 1, "supervisor.childopts" "-Xmx256m", "nimbus.thrift.port" 6627, "topology.stats.sample.rate" 0.05, "worker.heartbeat.frequency.secs" 1, "topology.acker.tasks" nil, "topology.disruptor.wait.strategy" "com.lmax.disruptor.BlockingWaitStrategy", "nimbus.task.timeout.secs" 30, "storm.zookeeper.connection.timeout" 15000, "topology.kryo.factory" "backtype.storm.serialization.DefaultKryoFactory", "drpc.invocations.port" 3773, "zmq.threads" 1, "storm.zookeeper.retry.times" 5, "topology.state.synchronization.timeout.secs" 60, "supervisor.worker.timeout.secs" 30, "nimbus.file.copy.expiration.secs" 600, "drpc.request.timeout.secs" 600, "storm.local.mode.zmq" false, "ui.port" 8080, "nimbus.childopts" "-Xmx1024m", "storm.cluster.mode" "local", "topology.optimize" true, "topology.max.task.parallelism" nil}

7109 [Thread-9] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:50:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000 sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@b80017

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2045

2013-01-16 09:20:50:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:50:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2045

2013-01-16 09:20:51:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b272000c with negotiated timeout 20000 for client /127.0.0.1:2045

2013-01-16 09:20:51:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b272000c, negotiated timeout = 20000

7171 [Thread-9-EventThread] INFO backtype.storm.zookeeper - Zookeeper state update: :connected:none

2013-01-16 09:20:51:INFO org.apache.zookeeper.server.PrepRequestProcessor - Processed session termination for sessionid: 0x13c40f1b272000c

2013-01-16 09:20:51:INFO org.apache.zookeeper.ZooKeeper - Session: 0x13c40f1b272000c closed

2013-01-16 09:20:51:WARN org.apache.zookeeper.server.NIOServerCnxn - EndOfStreamException: Unable to read additional data from client sessionid 0x13c40f1b272000c, likely client has closed socket

2013-01-16 09:20:51:INFO org.apache.zookeeper.server.NIOServerCnxn - Closed socket connection for client /127.0.0.1:2045 which had sessionid 0x13c40f1b272000c

7203 [Thread-9] INFO com.netflix.curator.framework.imps.CuratorFrameworkImpl - Starting

2013-01-16 09:20:51:INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=localhost:2000/storm sessionTimeout=20000 watcher=com.netflix.curator.ConnectionState@1be3bb2

2013-01-16 09:20:51:INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server localhost/127.0.0.1:2000

2013-01-16 09:20:51:INFO org.apache.zookeeper.ClientCnxn - EventThread shut down

2013-01-16 09:20:51:INFO org.apache.zookeeper.ClientCnxn - Socket connection established to localhost/127.0.0.1:2000, initiating session

2013-01-16 09:20:51:INFO org.apache.zookeeper.server.NIOServerCnxn - Accepted socket connection from /127.0.0.1:2048

2013-01-16 09:20:51:INFO org.apache.zookeeper.server.NIOServerCnxn - Client attempting to establish new session at /127.0.0.1:2048

2013-01-16 09:20:51:INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server localhost/127.0.0.1:2000, sessionid = 0x13c40f1b272000d, negotiated timeout = 20000

2013-01-16 09:20:51:INFO org.apache.zookeeper.server.NIOServerCnxn - Established session 0x13c40f1b272000d with negotiated timeout 20000 for client /127.0.0.1:2048

7531 [Thread-6] INFO backtype.storm.daemon.executor - Loading executor 2:[2 2]

7531 [Thread-9] INFO backtype.storm.daemon.executor - Loading executor __acker:[3 3]

7546 [Thread-6] INFO backtype.storm.daemon.task - Emitting: 2 __system ["startup"]

7546 [Thread-9] INFO backtype.storm.daemon.task - Emitting: __acker __system ["startup"]

7546 [Thread-9] INFO backtype.storm.daemon.executor - Loaded executor tasks __acker:[3 3]

7546 [Thread-6] INFO backtype.storm.daemon.executor - Loaded executor tasks 2:[2 2]

7562 [Thread-6] INFO backtype.storm.daemon.executor - Finished loading executor 2:[2 2]

7562 [Thread-6] INFO backtype.storm.daemon.worker - Launching receive-thread for a753e74a-55c8-47b5-b5f8-3e5c957335f8:1

7562 [Thread-23] INFO backtype.storm.daemon.executor - Preparing bolt 2:(2)

7562 [Thread-22] INFO backtype.storm.daemon.executor - Preparing bolt __acker:(3)

7562 [Thread-9] INFO backtype.storm.daemon.executor - Finished loading executor __acker:[3 3]

7578 [Thread-23] INFO backtype.storm.daemon.executor - Prepared bolt 2:(2)

7578 [Thread-22] INFO backtype.storm.daemon.executor - Prepared bolt __acker:(3)

7578 [Thread-9] INFO backtype.storm.daemon.executor - Loading executor 1:[1 1]

7593 [Thread-9] INFO backtype.storm.daemon.task - Emitting: 1 __system ["startup"]

7593 [Thread-9] INFO backtype.storm.daemon.executor - Loaded executor tasks 1:[1 1]

7593 [Thread-6] INFO backtype.storm.daemon.worker - Worker has topology config {"storm.id" "demo-1-1358299249", "dev.zookeeper.path" "/tmp/dev-storm-zookeeper", "topology.tick.tuple.freq.secs" nil, "topology.builtin.metrics.bucket.size.secs" 60, "topology.fall.back.on.java.serialization" true, "topology.max.error.report.per.interval" 5, "zmq.linger.millis" 0, "topology.skip.missing.kryo.registrations" true, "ui.childopts" "-Xmx768m", "storm.zookeeper.session.timeout" 20000, "nimbus.reassign" true, "topology.trident.batch.emit.interval.millis" 50, "nimbus.monitor.freq.secs" 10, "java.library.path" "/usr/local/lib:/opt/local/lib:/usr/lib", "topology.executor.send.buffer.size" 1024, "storm.local.dir" "C:\\DOCUME~1\\ADMINI~1\\LOCALS~1\\Temp\\/dd108ee9-8f33-4324-9ef7-7b3b2f443f23", "supervisor.worker.start.timeout.secs" 120, "topology.enable.message.timeouts" true, "nimbus.cleanup.inbox.freq.secs" 600, "nimbus.inbox.jar.expiration.secs" 3600, "topology.worker.shared.thread.pool.size" 4, "nimbus.host" "localhost", "storm.zookeeper.port" 2000, "transactional.zookeeper.port" nil, "topology.executor.receive.buffer.size" 1024, "transactional.zookeeper.servers" nil, "storm.zookeeper.root" "/storm", "supervisor.enable" true, "storm.zookeeper.servers" ["localhost"], "transactional.zookeeper.root" "/transactional", "topology.acker.executors" 1, "topology.kryo.decorators" (), "topology.name" "demo", "topology.transfer.buffer.size" 1024, "topology.worker.childopts" nil, "worker.childopts" "-Xmx768m", "supervisor.heartbeat.frequency.secs" 5, "topology.error.throttle.interval.secs" 10, "zmq.hwm" 0, "drpc.port" 3772, "supervisor.monitor.frequency.secs" 3, "topology.receiver.buffer.size" 8, "task.heartbeat.frequency.secs" 3, "topology.tasks" nil, "topology.spout.wait.strategy" "backtype.storm.spout.SleepSpoutWaitStrategy", "topology.max.spout.pending" 1, "storm.zookeeper.retry.interval" 1000, "topology.sleep.spout.wait.strategy.time.ms" 1, "nimbus.topology.validator" "backtype.storm.nimbus.DefaultTopologyValidator", "supervisor.slots.ports" (1 2 3), "topology.debug" true, "nimbus.task.launch.secs" 120, "nimbus.supervisor.timeout.secs" 60, "topology.kryo.register" nil, "topology.message.timeout.secs" 30, "task.refresh.poll.secs" 10, "topology.workers" 2, "supervisor.childopts" "-Xmx256m", "nimbus.thrift.port" 6627, "topology.stats.sample.rate" 0.05, "worker.heartbeat.frequency.secs" 1, "topology.acker.tasks" nil, "topology.disruptor.wait.strategy" "com.lmax.disruptor.BlockingWaitStrategy", "nimbus.task.timeout.secs" 30, "storm.zookeeper.connection.timeout" 15000, "topology.kryo.factory" "backtype.storm.serialization.DefaultKryoFactory", "drpc.invocations.port" 3773, "zmq.threads" 1, "storm.zookeeper.retry.times" 5, "topology.state.synchronization.timeout.secs" 60, "supervisor.worker.timeout.secs" 30, "nimbus.file.copy.expiration.secs" 600, "drpc.request.timeout.secs" 600, "storm.local.mode.zmq" false, "ui.port" 8080, "nimbus.childopts" "-Xmx1024m", "storm.cluster.mode" "local", "topology.optimize" true, "topology.max.task.parallelism" nil}

7593 [Thread-6] INFO backtype.storm.daemon.worker - Worker ce797194-f0a1-4d1f-a0df-6a388935cf26 for storm demo-1-1358299249 on a753e74a-55c8-47b5-b5f8-3e5c957335f8:1 has finished loading

7609 [Thread-9] INFO backtype.storm.daemon.executor - Finished loading executor 1:[1 1]

7609 [Thread-9] INFO backtype.storm.daemon.worker - Launching receive-thread for a9368e3d-c540-49c8-b7ef-11327e92f9cd:4

7609 [Thread-27] INFO backtype.storm.daemon.executor - Opening spout 1:(1)

7609 [Thread-9] INFO backtype.storm.daemon.worker - Worker has topology config {"storm.id" "demo-1-1358299249", "dev.zookeeper.path" "/tmp/dev-storm-zookeeper", "topology.tick.tuple.freq.secs" nil, "topology.builtin.metrics.bucket.size.secs" 60, "topology.fall.back.on.java.serialization" true, "topology.max.error.report.per.interval" 5, "zmq.linger.millis" 0, "topology.skip.missing.kryo.registrations" true, "ui.childopts" "-Xmx768m", "storm.zookeeper.session.timeout" 20000, "nimbus.reassign" true, "topology.trident.batch.emit.interval.millis" 50, "nimbus.monitor.freq.secs" 10, "java.library.path" "/usr/local/lib:/opt/local/lib:/usr/lib", "topology.executor.send.buffer.size" 1024, "storm.local.dir" "C:\\DOCUME~1\\ADMINI~1\\LOCALS~1\\Temp\\/86c7a04d-fe18-4dba-b751-24507fd794e0", "supervisor.worker.start.timeout.secs" 120, "topology.enable.message.timeouts" true, "nimbus.cleanup.inbox.freq.secs" 600, "nimbus.inbox.jar.expiration.secs" 3600, "topology.worker.shared.thread.pool.size" 4, "nimbus.host" "localhost", "storm.zookeeper.port" 2000, "transactional.zookeeper.port" nil, "topology.executor.receive.buffer.size" 1024, "transactional.zookeeper.servers" nil, "storm.zookeeper.root" "/storm", "supervisor.enable" true, "storm.zookeeper.servers" ["localhost"], "transactional.zookeeper.root" "/transactional", "topology.acker.executors" 1, "topology.kryo.decorators" (), "topology.name" "demo", "topology.transfer.buffer.size" 1024, "topology.worker.childopts" nil, "worker.childopts" "-Xmx768m", "supervisor.heartbeat.frequency.secs" 5, "topology.error.throttle.interval.secs" 10, "zmq.hwm" 0, "drpc.port" 3772, "supervisor.monitor.frequency.secs" 3, "topology.receiver.buffer.size" 8, "task.heartbeat.frequency.secs" 3, "topology.tasks" nil, "topology.spout.wait.strategy" "backtype.storm.spout.SleepSpoutWaitStrategy", "topology.max.spout.pending" 1, "storm.zookeeper.retry.interval" 1000, "topology.sleep.spout.wait.strategy.time.ms" 1, "nimbus.topology.validator" "backtype.storm.nimbus.DefaultTopologyValidator", "supervisor.slots.ports" (4 5 6), "topology.debug" true, "nimbus.task.launch.secs" 120, "nimbus.supervisor.timeout.secs" 60, "topology.kryo.register" nil, "topology.message.timeout.secs" 30, "task.refresh.poll.secs" 10, "topology.workers" 2, "supervisor.childopts" "-Xmx256m", "nimbus.thrift.port" 6627, "topology.stats.sample.rate" 0.05, "worker.heartbeat.frequency.secs" 1, "topology.acker.tasks" nil, "topology.disruptor.wait.strategy" "com.lmax.disruptor.BlockingWaitStrategy", "nimbus.task.timeout.secs" 30, "storm.zookeeper.connection.timeout" 15000, "topology.kryo.factory" "backtype.storm.serialization.DefaultKryoFactory", "drpc.invocations.port" 3773, "zmq.threads" 1, "storm.zookeeper.retry.times" 5, "topology.state.synchronization.timeout.secs" 60, "supervisor.worker.timeout.secs" 30, "nimbus.file.copy.expiration.secs" 600, "drpc.request.timeout.secs" 600, "storm.local.mode.zmq" false, "ui.port" 8080, "nimbus.childopts" "-Xmx1024m", "storm.cluster.mode" "local", "topology.optimize" true, "topology.max.task.parallelism" nil}

7609 [Thread-9] INFO backtype.storm.daemon.worker - Worker b56bca1d-cdd0-458c-941a-7f1719d5bc2b for storm demo-1-1358299249 on a9368e3d-c540-49c8-b7ef-11327e92f9cd:4 has finished loading

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - spout-----> 将集合数据转换至队列中

7609 [Thread-27] INFO backtype.storm.daemon.executor - Opened spout 1:(1)

7609 [Thread-27] INFO backtype.storm.daemon.executor - Activating spout 1:(1)

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=1

7609 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=1 name=zhang1 age=21]]

7609 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [2694535958820228165 3828879903368972585 1]

7609 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [2694535958820228165 3828879903368972585 1]

7625 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {2694535958820228165=3828879903368972585}, [[Person id=1 name=zhang1 age=21]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=1 name=zhang1 age=21]

7625 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [2694535958820228165 3828879903368972585]

7625 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [2694535958820228165, 3828879903368972585]

7625 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [2694535958820228165]

7625 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [2694535958820228165]

7625 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=1 name=zhang1 age=21]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=1 name=zhang1 age=21]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=2

7625 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=2 name=zhang2 age=22]]

7625 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [-5811949556035385002 -6890630316263539517 1]

7625 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [-5811949556035385002 -6890630316263539517 1]

7625 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {-5811949556035385002=-6890630316263539517}, [[Person id=2 name=zhang2 age=22]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=2 name=zhang2 age=22]

7625 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [-5811949556035385002 -6890630316263539517]

7625 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [-5811949556035385002, -6890630316263539517]

7625 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [-5811949556035385002]

7640 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [-5811949556035385002]

7640 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=2 name=zhang2 age=22]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=2 name=zhang2 age=22]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=3

7640 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=3 name=zhang3 age=23]]

7640 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [219257472962751953 6078625470356348063 1]

7640 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [219257472962751953 6078625470356348063 1]

7640 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {219257472962751953=6078625470356348063}, [[Person id=3 name=zhang3 age=23]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=3 name=zhang3 age=23]

7640 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [219257472962751953 6078625470356348063]

7640 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [219257472962751953, 6078625470356348063]

7640 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [219257472962751953]

7640 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [219257472962751953]

7640 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=3 name=zhang3 age=23]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=3 name=zhang3 age=23]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=4

7640 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=4 name=zhang4 age=24]]

7640 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [4318562922526141994 8191650156051441196 1]

7640 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [4318562922526141994 8191650156051441196 1]

7640 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {4318562922526141994=8191650156051441196}, [[Person id=4 name=zhang4 age=24]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=4 name=zhang4 age=24]

7640 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [4318562922526141994 8191650156051441196]

7640 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [4318562922526141994, 8191650156051441196]

7640 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [4318562922526141994]

7640 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [4318562922526141994]

7640 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=4 name=zhang4 age=24]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=4 name=zhang4 age=24]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=5

7640 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=5 name=zhang5 age=25]]

7640 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [-5525623119314927399 3663529653696391654 1]

7640 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {-5525623119314927399=3663529653696391654}, [[Person id=5 name=zhang5 age=25]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=5 name=zhang5 age=25]

7640 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [-5525623119314927399 3663529653696391654 1]

7640 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [-5525623119314927399 3663529653696391654]

7656 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [-5525623119314927399, 3663529653696391654]

7656 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [-5525623119314927399]

7656 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [-5525623119314927399]

7656 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=5 name=zhang5 age=25]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=5 name=zhang5 age=25]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=6

7656 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=6 name=zhang6 age=26]]

7656 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [4444831176256327809 6692541082140116000 1]

7656 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [4444831176256327809 6692541082140116000 1]

7656 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {4444831176256327809=6692541082140116000}, [[Person id=6 name=zhang6 age=26]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=6 name=zhang6 age=26]

7656 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [4444831176256327809 6692541082140116000]

7656 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [4444831176256327809, 6692541082140116000]

7656 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [4444831176256327809]

7656 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [4444831176256327809]

7656 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=6 name=zhang6 age=26]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=6 name=zhang6 age=26]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=7

7656 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=7 name=zhang7 age=27]]

7656 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [6115911456780872788 1675690715082104323 1]

7656 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [6115911456780872788 1675690715082104323 1]

7656 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {6115911456780872788=1675690715082104323}, [[Person id=7 name=zhang7 age=27]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=7 name=zhang7 age=27]

7656 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [6115911456780872788 1675690715082104323]

7656 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [6115911456780872788, 1675690715082104323]

7656 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [6115911456780872788]

7671 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [6115911456780872788]

7671 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=7 name=zhang7 age=27]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=7 name=zhang7 age=27]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=8

7671 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=8 name=zhang8 age=28]]

7671 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [8569256651305376437 5838382650884274902 1]

7671 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [8569256651305376437 5838382650884274902 1]

7671 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {8569256651305376437=5838382650884274902}, [[Person id=8 name=zhang8 age=28]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=8 name=zhang8 age=28]

7671 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [8569256651305376437 5838382650884274902]

7671 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [8569256651305376437, 5838382650884274902]

7671 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [8569256651305376437]

7671 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [8569256651305376437]

7671 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=8 name=zhang8 age=28]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=8 name=zhang8 age=28]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - nextTuple----> 发送数据，用户ID=9

7671 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 default [[Person id=9 name=zhang9 age=29]]

7671 [Thread-27] INFO backtype.storm.daemon.task - Emitting: 1 __ack_init [4632521528974275102 -5861573244111071873 1]

7671 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: __ack_init, id: {}, [4632521528974275102 -5861573244111071873 1]

7671 [Thread-23] INFO backtype.storm.daemon.executor - Processing received message source: 1:1, stream: default, id: {4632521528974275102=-5861573244111071873}, [[Person id=9 name=zhang9 age=29]]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - execute----->处理数据

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.ListBolt - 处理数据 用户=[Person id=9 name=zhang9 age=29]

7671 [Thread-23] INFO backtype.storm.daemon.task - Emitting: 2 __ack_ack [4632521528974275102 -5861573244111071873]

7671 [Thread-22] INFO backtype.storm.daemon.executor - Processing received message source: 2:2, stream: __ack_ack, id: {}, [4632521528974275102, -5861573244111071873]

7671 [Thread-22] INFO backtype.storm.daemon.task - Emitting direct: 1; __acker __ack_ack [4632521528974275102]

7671 [Thread-27] INFO backtype.storm.daemon.executor - Processing received message source: __acker:3, stream: __ack_ack, id: {}, [4632521528974275102]

7671 [Thread-27] INFO backtype.storm.daemon.executor - Acking message [Person id=9 name=zhang9 age=29]

2013-01-16 09:20:51:DEBUG com.stormdemo.demo.DemoSpout - ack-----> [Person id=9 name=zhang9 age=29]

2013-01-16 09:21:19:DEBUG com.stormdemo.demo.DemoTopology - stormdemo结束

2013-01-16 09:21:19:DEBUG com.stormdemo.demo.DemoTopology - 共消耗时间：运行=7109,总时间：37109