`
445822357
  • 浏览: 731001 次
文章分类
社区版块
存档分类
最新评论

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的主要特点如下:

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

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

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学习途径

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

Storm简单例子

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

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

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

/**
 * 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处理。

/**
 * 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方法。

/**
 * 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了。

/**
 * 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();
		
		
	}
}

最后运行结果:

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




分享到:
评论

相关推荐

Global site tag (gtag.js) - Google Analytics