------------------------------------------------------- T E S T S ------------------------------------------------------- Running com.yahoo.storm.yarn.TestIntegration SLF4J: Class path contains multiple SLF4J bindings. SLF4J: Found binding in [jar:file:/root/.m2/repository/ch/qos/logback/logback-classic/1.0.6/logback-classic-1.0.6.jar!/org/slf4j/impl/StaticLoggerBinder.class] SLF4J: Found binding in [jar:file:/root/.m2/repository/org/slf4j/slf4j-log4j12/1.6.1/slf4j-log4j12-1.6.1.jar!/org/slf4j/impl/StaticLoggerBinder.class] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. 20:38:16,790 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 20:38:16,857 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT] 20:38:16,979 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 20:38:17,272 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO 20:38:17,272 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT] 20:38:17,276 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. 20:38:17,283 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ffa1294 - Registering current configuration as safe fallback point SLF4J: Actual binding is of type [ch.qos.logback.classic.selector.DefaultContextSelector] 20:38:17.320 [main] INFO c.yahoo.storm.yarn.EmbeddedZKServer - Starting up embedded Zookeeper server 20:38:17.588 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:zookeeper.version=3.3.3-1073969, built on 02/23/2011 22:27 GMTsg 20:38:17.601 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:host.name=idhvmsg 20:38:17.601 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:java.version=1.7.0_25sg 20:38:17.601 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:java.vendor=Oracle Corporationsg 20:38:17.602 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:java.home=/usr/java/jdk1.7.0_25/jresg 20:38:17.602 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:java.class.path=/myData/storm/storm_yarn/storm-yarn/target/test-classes:/myData/storm/storm_yarn/storm-yarn/target/classes:/root/.m2/repository/storm/storm-core/0.9.0-wip21/storm-core-0.9.0-wip21.jar:/root/.m2/repository/org/clojure/clojure/1.4.0/clojure-1.4.0.jar:/root/.m2/repository/org/apache/commons/commons-exec/1.1/commons-exec-1.1.jar:/root/.m2/repository/storm/libthrift7/0.7.0-2/libthrift7-0.7.0-2.jar:/root/.m2/repository/clj-time/clj-time/0.4.1/clj-time-0.4.1.jar:/root/.m2/repository/joda-time/joda-time/2.0/joda-time-2.0.jar:/root/.m2/repository/com/netflix/curator/curator-framework/1.0.1/curator-framework-1.0.1.jar:/root/.m2/repository/com/netflix/curator/curator-client/1.0.1/curator-client-1.0.1.jar:/root/.m2/repository/backtype/jzmq/2.1.0/jzmq-2.1.0.jar:/root/.m2/repository/com/googlecode/json-simple/json-simple/1.1/json-simple-1.1.jar:/root/.m2/repository/compojure/compojure/1.1.3/compojure-1.1.3.jar:/root/.m2/repository/org/clojure/core.incubator/0.1.0/core.incubator-0.1.0.jar:/root/.m2/repository/org/clojure/tools.macro/0.1.0/tools.macro-0.1.0.jar:/root/.m2/repository/clout/clout/1.0.1/clout-1.0.1.jar:/root/.m2/repository/ring/ring-core/1.1.5/ring-core-1.1.5.jar:/root/.m2/repository/commons-fileupload/commons-fileupload/1.2.1/commons-fileupload-1.2.1.jar:/root/.m2/repository/hiccup/hiccup/0.3.6/hiccup-0.3.6.jar:/root/.m2/repository/ring/ring-devel/0.3.11/ring-devel-0.3.11.jar:/root/.m2/repository/clj-stacktrace/clj-stacktrace/0.2.2/clj-stacktrace-0.2.2.jar:/root/.m2/repository/ring/ring-jetty-adapter/0.3.11/ring-jetty-adapter-0.3.11.jar:/root/.m2/repository/ring/ring-servlet/0.3.11/ring-servlet-0.3.11.jar:/root/.m2/repository/org/clojure/tools.logging/0.2.3/tools.logging-0.2.3.jar:/root/.m2/repository/org/clojure/math.numeric-tower/0.0.1/math.numeric-tower-0.0.1.jar:/root/.m2/repository/storm/carbonite/1.5.0/carbonite-1.5.0.jar:/root/.m2/repository/com/esotericsoftware/kryo/kryo/2.17/kryo-2.17.jar:/root/.m2/repository/com/esotericsoftware/reflectasm/reflectasm/1.07/reflectasm-1.07-shaded.jar:/root/.m2/repository/org/ow2/asm/asm/4.0/asm-4.0.jar:/root/.m2/repository/com/esotericsoftware/minlog/minlog/1.2/minlog-1.2.jar:/root/.m2/repository/org/objenesis/objenesis/1.2/objenesis-1.2.jar:/root/.m2/repository/org/yaml/snakeyaml/1.11/snakeyaml-1.11.jar:/root/.m2/repository/org/apache/httpcomponents/httpclient/4.1.1/httpclient-4.1.1.jar:/root/.m2/repository/org/apache/httpcomponents/httpcore/4.1/httpcore-4.1.jar:/root/.m2/repository/storm/tools.cli/0.2.2/tools.cli-0.2.2.jar:/root/.m2/repository/com/googlecode/disruptor/disruptor/2.10.1/disruptor-2.10.1.jar:/root/.m2/repository/storm/jgrapht/0.8.3/jgrapht-0.8.3.jar:/root/.m2/repository/com/google/guava/guava/13.0/guava-13.0.jar:/root/.m2/repository/ch/qos/logback/logback-classic/1.0.6/logback-classic-1.0.6.jar:/root/.m2/repository/ch/qos/logback/logback-core/1.0.6/logback-core-1.0.6.jar:/root/.m2/repository/storm/storm-netty/0.9.0-wip21/storm-netty-0.9.0-wip21.jar:/root/.m2/repository/io/netty/netty/3.6.3.Final/netty-3.6.3.Final.jar:/root/.m2/repository/org/slf4j/jcl-over-slf4j/1.7.2/jcl-over-slf4j-1.7.2.jar:/root/.m2/repository/org/slf4j/slf4j-api/1.7.2/slf4j-api-1.7.2.jar:/root/.m2/repository/commons-io/commons-io/2.1/commons-io-2.1.jar:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-server-tests/2.1.0.2.0.4.0-38/hadoop-yarn-server-tests-2.1.0.2.0.4.0-38-tests.jar:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-server-common/2.1.0.2.0.4.0-38/hadoop-yarn-server-common-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-server-nodemanager/2.1.0.2.0.4.0-38/hadoop-yarn-server-nodemanager-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-server-resourcemanager/2.1.0.2.0.4.0-38/hadoop-yarn-server-resourcemanager-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-server-web-proxy/2.1.0.2.0.4.0-38/hadoop-yarn-server-web-proxy-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/org/slf4j/slf4j-log4j12/1.6.1/slf4j-log4j12-1.6.1.jar:/root/.m2/repository/org/apache/hadoop/hadoop-annotations/2.1.0.2.0.4.0-38/hadoop-annotations-2.1.0.2.0.4.0-38.jar:/usr/java/jdk1.7.0_25/jre/../lib/tools.jar:/root/.m2/repository/com/google/inject/extensions/guice-servlet/3.0/guice-servlet-3.0.jar:/root/.m2/repository/com/google/protobuf/protobuf-java/2.4.0a/protobuf-java-2.4.0a.jar:/root/.m2/repository/com/google/inject/guice/3.0/guice-3.0.jar:/root/.m2/repository/javax/inject/javax.inject/1/javax.inject-1.jar:/root/.m2/repository/aopalliance/aopalliance/1.0/aopalliance-1.0.jar:/root/.m2/repository/com/sun/jersey/jersey-test-framework/jersey-test-framework-grizzly2/1.8/jersey-test-framework-grizzly2-1.8.jar:/root/.m2/repository/com/sun/jersey/jersey-test-framework/jersey-test-framework-core/1.8/jersey-test-framework-core-1.8.jar:/root/.m2/repository/org/glassfish/javax.servlet/3.0/javax.servlet-3.0.jar:/root/.m2/repository/com/sun/jersey/jersey-client/1.8/jersey-client-1.8.jar:/root/.m2/repository/com/sun/jersey/jersey-grizzly2/1.8/jersey-grizzly2-1.8.jar:/root/.m2/repository/org/glassfish/grizzly/grizzly-http/2.1.1/grizzly-http-2.1.1.jar:/root/.m2/repository/org/glassfish/grizzly/grizzly-framework/2.1.1/grizzly-framework-2.1.1.jar:/root/.m2/repository/org/glassfish/gmbal/gmbal-api-only/3.0.0-b023/gmbal-api-only-3.0.0-b023.jar:/root/.m2/repository/org/glassfish/external/management-api/3.0.0-b012/management-api-3.0.0-b012.jar:/root/.m2/repository/org/glassfish/grizzly/grizzly-http-server/2.1.1/grizzly-http-server-2.1.1.jar:/root/.m2/repository/org/glassfish/grizzly/grizzly-rcm/2.1.1/grizzly-rcm-2.1.1.jar:/root/.m2/repository/org/glassfish/grizzly/grizzly-http-servlet/2.1.1/grizzly-http-servlet-2.1.1.jar:/root/.m2/repository/org/glassfish/grizzly/grizzly-framework/2.1.1/grizzly-framework-2.1.1-tests.jar:/root/.m2/repository/com/sun/jersey/jersey-server/1.8/jersey-server-1.8.jar:/root/.m2/repository/asm/asm/3.1/asm-3.1.jar:/root/.m2/repository/com/sun/jersey/jersey-json/1.8/jersey-json-1.8.jar:/root/.m2/repository/org/codehaus/jettison/jettison/1.1/jettison-1.1.jar:/root/.m2/repository/stax/stax-api/1.0.1/stax-api-1.0.1.jar:/root/.m2/repository/com/sun/xml/bind/jaxb-impl/2.2.3-1/jaxb-impl-2.2.3-1.jar:/root/.m2/repository/javax/xml/bind/jaxb-api/2.2.2/jaxb-api-2.2.2.jar:/root/.m2/repository/javax/activation/activation/1.1/activation-1.1.jar:/root/.m2/repository/org/codehaus/jackson/jackson-jaxrs/1.7.1/jackson-jaxrs-1.7.1.jar:/root/.m2/repository/org/codehaus/jackson/jackson-xc/1.7.1/jackson-xc-1.7.1.jar:/root/.m2/repository/com/sun/jersey/contribs/jersey-guice/1.8/jersey-guice-1.8.jar:/root/.m2/repository/org/apache/hadoop/hadoop-common/2.1.0.2.0.4.0-38/hadoop-common-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/commons-cli/commons-cli/1.2/commons-cli-1.2.jar:/root/.m2/repository/org/apache/commons/commons-math/2.1/commons-math-2.1.jar:/root/.m2/repository/xmlenc/xmlenc/0.52/xmlenc-0.52.jar:/root/.m2/repository/commons-httpclient/commons-httpclient/3.1/commons-httpclient-3.1.jar:/root/.m2/repository/commons-codec/commons-codec/1.4/commons-codec-1.4.jar:/root/.m2/repository/commons-net/commons-net/3.1/commons-net-3.1.jar:/root/.m2/repository/javax/servlet/servlet-api/2.5/servlet-api-2.5.jar:/root/.m2/repository/org/mortbay/jetty/jetty/6.1.26/jetty-6.1.26.jar:/root/.m2/repository/org/mortbay/jetty/jetty-util/6.1.26/jetty-util-6.1.26.jar:/root/.m2/repository/com/sun/jersey/jersey-core/1.8/jersey-core-1.8.jar:/root/.m2/repository/tomcat/jasper-compiler/5.5.23/jasper-compiler-5.5.23.jar:/root/.m2/repository/tomcat/jasper-runtime/5.5.23/jasper-runtime-5.5.23.jar:/root/.m2/repository/javax/servlet/jsp/jsp-api/2.1/jsp-api-2.1.jar:/root/.m2/repository/commons-el/commons-el/1.0/commons-el-1.0.jar:/root/.m2/repository/commons-logging/commons-logging/1.1.1/commons-logging-1.1.1.jar:/root/.m2/repository/log4j/log4j/1.2.17/log4j-1.2.17.jar:/root/.m2/repository/net/java/dev/jets3t/jets3t/0.6.1/jets3t-0.6.1.jar:/root/.m2/repository/commons-lang/commons-lang/2.5/commons-lang-2.5.jar:/root/.m2/repository/commons-configuration/commons-configuration/1.6/commons-configuration-1.6.jar:/root/.m2/repository/commons-collections/commons-collections/3.2.1/commons-collections-3.2.1.jar:/root/.m2/repository/commons-digester/commons-digester/1.8/commons-digester-1.8.jar:/root/.m2/repository/commons-beanutils/commons-beanutils/1.7.0/commons-beanutils-1.7.0.jar:/root/.m2/repository/commons-beanutils/commons-beanutils-core/1.8.0/commons-beanutils-core-1.8.0.jar:/root/.m2/repository/org/codehaus/jackson/jackson-core-asl/1.8.8/jackson-core-asl-1.8.8.jar:/root/.m2/repository/org/codehaus/jackson/jackson-mapper-asl/1.8.8/jackson-mapper-asl-1.8.8.jar:/root/.m2/repository/org/apache/avro/avro/1.5.3/avro-1.5.3.jar:/root/.m2/repository/com/thoughtworks/paranamer/paranamer/2.3/paranamer-2.3.jar:/root/.m2/repository/org/xerial/snappy/snappy-java/1.0.3.2/snappy-java-1.0.3.2.jar:/root/.m2/repository/org/apache/hadoop/hadoop-auth/2.1.0.2.0.4.0-38/hadoop-auth-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/com/jcraft/jsch/0.1.42/jsch-0.1.42.jar:/root/.m2/repository/org/apache/commons/commons-compress/1.4/commons-compress-1.4.jar:/root/.m2/repository/org/tukaani/xz/1.0/xz-1.0.jar:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-client/2.1.0.2.0.4.0-38/hadoop-yarn-client-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-api/2.1.0.2.0.4.0-38/hadoop-yarn-api-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-common/2.1.0.2.0.4.0-38/hadoop-yarn-common-2.1.0.2.0.4.0-38.jar:/root/.m2/repository/junit/junit/4.10/junit-4.10.jar:/root/.m2/repository/org/hamcrest/hamcrest-core/1.1/hamcrest-core-1.1.jar:/root/.m2/repository/org/apache/zookeeper/zookeeper/3.3.3/zookeeper-3.3.3.jar:/root/.m2/repository/jline/jline/0.9.94/jline-0.9.94.jar:/root/.m2/repository/org/mockito/mockito-all/1.9.5/mockito-all-1.9.5.jar:conf:sg 20:38:17.605 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:java.library.path=/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/libsg 20:38:17.605 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:java.io.tmpdir=/tmpsg 20:38:17.606 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:java.compiler=sg 20:38:17.606 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:os.name=Linuxsg 20:38:17.606 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:os.arch=amd64sg 20:38:17.649 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:os.version=2.6.32-358.11.1.el6.x86_64sg 20:38:17.649 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:user.name=rootsg 20:38:17.650 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:user.home=/rootsg 20:38:17.650 [mainhread] org.apache.zookeeper.Environment.logEnv(Environment.java:97)evel org.apache.zookeeper.Environment.logEnv(Environment.java:97)ogger{36} - Server environment:user.dir=/myData/storm/storm_yarn/storm-yarnsg 20:38:17.737 [mainhread] org.apache.zookeeper.server.ZooKeeperServer.(ZooKeeperServer.java:151)evel org.apache.zookeeper.server.ZooKeeperServer.(ZooKeeperServer.java:151)ogger{36} - Created server with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir ./target/zookeeper.data/version-2 snapdir ./target/zookeeper.data/version-2sg 20:38:17.814 [mainhread] org.apache.zookeeper.server.NIOServerCnxn$Factory.(NIOServerCnxn.java:143)evel org.apache.zookeeper.server.NIOServerCnxn$Factory.(NIOServerCnxn.java:143)ogger{36} - binding to port 0.0.0.0/0.0.0.0:60000sg 20:38:17.817 [main] INFO c.yahoo.storm.yarn.EmbeddedZKServer - Zookeeper port allocated:60000 20:38:17.835 [mainhread] org.apache.zookeeper.server.persistence.FileSnap.deserialize(FileSnap.java:82)evel org.apache.zookeeper.server.persistence.FileSnap.deserialize(FileSnap.java:82)ogger{36} - Reading snapshot ./target/zookeeper.data/version-2/snapshot.0sg 20:38:17.874 [mainhread] org.apache.zookeeper.server.persistence.FileTxnSnapLog.save(FileTxnSnapLog.java:208)evel org.apache.zookeeper.server.persistence.FileTxnSnapLog.save(FileTxnSnapLog.java:208)ogger{36} - Snapshotting: 0sg 20:38:18.067 [main] INFO com.yahoo.storm.yarn.TestIntegration - Starting up MiniYARN cluster 20:38:18.942 [main] WARN o.a.hadoop.util.NativeCodeLoader - Unable to load native-hadoop library for your platform... using builtin-java classes where applicable 20:38:19.878 [main] INFO o.a.h.y.s.r.s.AMRMTokenSecretManager - Rolling master-key for amrm-tokens 20:38:19.927 [main] INFO o.a.h.y.s.r.s.RMContainerTokenSecretManager - ContainerTokenKeyRollingInterval: 86400000ms and ContainerTokenKeyActivationDelay: 900000ms 20:38:19.947 [main] INFO o.a.h.y.s.r.s.NMTokenSecretManagerInRM - NMTokenKeyRollingInterval: 86400000ms and NMTokenKeyActivationDelay: 900000ms 20:38:19.958 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.recovery.RMStateStoreEventType for class org.apache.hadoop.yarn.server.resourcemanager.recovery.RMStateStore$ForwardingEventHandler 20:38:19.985 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.history.RMHistoryEventType for class org.apache.hadoop.yarn.server.resourcemanager.history.RMHistoryStore$ForwardingEventHandler 20:38:19.997 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.NodesListManagerEventType for class org.apache.hadoop.yarn.server.resourcemanager.NodesListManager 20:38:19.998 [main] INFO o.a.h.y.s.r.ResourceManager - Using Scheduler: org.apache.hadoop.yarn.server.resourcemanager.scheduler.capacity.CapacityScheduler 20:38:20.333 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.scheduler.event.SchedulerEventType for class org.apache.hadoop.yarn.server.resourcemanager.ResourceManager$SchedulerEventDispatcher 20:38:20.340 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.rmapp.RMAppEventType for class org.apache.hadoop.yarn.server.resourcemanager.ResourceManager$ApplicationEventDispatcher 20:38:20.346 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.rmapp.attempt.RMAppAttemptEventType for class org.apache.hadoop.yarn.server.resourcemanager.ResourceManager$ApplicationAttemptEventDispatcher 20:38:20.352 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.rmnode.RMNodeEventType for class org.apache.hadoop.yarn.server.resourcemanager.ResourceManager$NodeEventDispatcher 20:38:20.782 [main] WARN o.a.h.metrics2.impl.MetricsConfig - Cannot locate configuration: tried hadoop-metrics2-resourcemanager.properties,hadoop-metrics2.properties 20:38:20.887 [main] INFO o.a.h.m.impl.MetricsSystemImpl - Scheduled snapshot period at 10 second(s). 20:38:20.888 [main] INFO o.a.h.m.impl.MetricsSystemImpl - ResourceManager metrics system started 20:38:21.182 [main] INFO o.a.h.y.s.r.s.capacity.ParentQueue - root, capacity=1.0, asboluteCapacity=1.0, maxCapacity=1.0, asboluteMaxCapacity=1.0, state=RUNNING, acls=ADMINISTER_QUEUE:*SUBMIT_APPLICATIONS:* 20:38:21.182 [main] INFO o.a.h.y.s.r.s.capacity.ParentQueue - Initialized parent-queue root name=root, fullname=root 20:38:21.219 [main] INFO o.a.h.y.s.r.s.capacity.LeafQueue - Initializing default capacity = 1.0 [= (float) configuredCapacity / 100 ] asboluteCapacity = 1.0 [= parentAbsoluteCapacity * capacity ] maxCapacity = 1.0 [= configuredMaxCapacity ] absoluteMaxCapacity = 1.0 [= 1.0 maximumCapacity undefined, (parentAbsoluteMaxCapacity * maximumCapacity) / 100 otherwise ] userLimit = 100 [= configuredUserLimit ] userLimitFactor = 1.0 [= configuredUserLimitFactor ] maxApplications = 10000 [= configuredMaximumSystemApplicationsPerQueue or (int)(configuredMaximumSystemApplications * absoluteCapacity)] maxApplicationsPerUser = 10000 [= (int)(maxApplications * (userLimit / 100.0f) * userLimitFactor) ] maxActiveApplications = 1 [= max((int)ceil((clusterResourceMemory / minimumAllocation) * maxAMResourcePerQueuePercent * absoluteMaxCapacity),1) ] maxActiveAppsUsingAbsCap = 1 [= max((int)ceil((clusterResourceMemory / minimumAllocation) *maxAMResourcePercent * absoluteCapacity),1) ] maxActiveApplicationsPerUser = 1 [= max((int)(maxActiveApplications * (userLimit / 100.0f) * userLimitFactor),1) ] usedCapacity = 0.0 [= usedResourcesMemory / (clusterResourceMemory * absoluteCapacity)] absoluteUsedCapacity = 0.0 [= usedResourcesMemory / clusterResourceMemory] maxAMResourcePerQueuePercent = 0.1 [= configuredMaximumAMResourcePercent ] minimumAllocationFactor = 0.75 [= (float)(maximumAllocationMemory - minimumAllocationMemory) / maximumAllocationMemory ] numContainers = 0 [= currentNumContainers ] state = RUNNING [= configuredState ] acls = ADMINISTER_QUEUE:*SUBMIT_APPLICATIONS:* [= configuredAcls ] nodeLocalityDelay = 0 20:38:21.220 [main] INFO o.a.h.y.s.r.s.c.CapacityScheduler - Initialized queue: default: capacity=1.0, absoluteCapacity=1.0, usedResources=usedCapacity=0.0, absoluteUsedCapacity=0.0, numApps=0, numContainers=0 20:38:21.221 [main] INFO o.a.h.y.s.r.s.c.CapacityScheduler - Initialized queue: root: numChildQueue= 1, capacity=1.0, absoluteCapacity=1.0, usedResources=usedCapacity=0.0, numApps=0, numContainers=0 20:38:21.221 [main] INFO o.a.h.y.s.r.s.c.CapacityScheduler - Initialized root queue root: numChildQueue= 1, capacity=1.0, absoluteCapacity=1.0, usedResources=usedCapacity=0.0, numApps=0, numContainers=0 20:38:21.221 [main] INFO o.a.h.y.s.r.s.c.CapacityScheduler - Initialized CapacityScheduler with calculator=class org.apache.hadoop.yarn.server.resourcemanager.resource.DefaultResourceCalculator, minimumAllocation=<>, maximumAllocation=<> 20:38:21.402 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.RMAppManagerEventType for class org.apache.hadoop.yarn.server.resourcemanager.RMAppManager 20:38:21.457 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.resourcemanager.amlauncher.AMLauncherEventType for class org.apache.hadoop.yarn.server.resourcemanager.amlauncher.ApplicationMasterLauncher 20:38:21.467 [main] INFO o.a.h.y.s.resourcemanager.RMNMInfo - Registered RMNMInfo MBean 20:38:21.472 [main] INFO o.apache.hadoop.util.HostsFileReader - Refreshing hosts (include/exclude) list 20:38:21.526 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Waiting for RM to start... 20:38:21.545 [Thread-9] INFO o.a.h.y.s.r.s.RMContainerTokenSecretManager - Rolling master-key for container-tokens 20:38:21.545 [Timer-0] INFO o.a.h.y.s.r.s.AMRMTokenSecretManager - Rolling master-key for amrm-tokens 20:38:21.562 [Thread-9] INFO o.a.h.y.s.r.s.NMTokenSecretManagerInRM - Rolling master-key for nm-tokens 20:38:21.859 [Thread-9] INFO org.mortbay.log - Logging to Logger[org.mortbay.log] via org.mortbay.log.Slf4jLog 20:38:22.097 [Thread-9] INFO org.apache.hadoop.http.HttpServer - Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer$QuotingInputFilter) 20:38:22.108 [Thread-9] INFO org.apache.hadoop.http.HttpServer - Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context cluster 20:38:22.108 [Thread-9] INFO org.apache.hadoop.http.HttpServer - Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static 20:38:22.130 [Thread-9] INFO org.apache.hadoop.http.HttpServer - adding path spec: /cluster 20:38:22.130 [Thread-9] INFO org.apache.hadoop.http.HttpServer - adding path spec: /cluster/* 20:38:22.130 [Thread-9] INFO org.apache.hadoop.http.HttpServer - adding path spec: /ws 20:38:22.131 [Thread-9] INFO org.apache.hadoop.http.HttpServer - adding path spec: /ws/* 20:38:22.137 [Thread-9] INFO org.apache.hadoop.http.HttpServer - Added global filter 'guice' (class=com.google.inject.servlet.GuiceFilter) 20:38:22.137 [Thread-9] INFO org.apache.hadoop.http.HttpServer - Jetty bound to port 51872 20:38:22.138 [Thread-9] INFO org.mortbay.log - jetty-6.1.26 20:38:22.261 [Thread-9] INFO org.mortbay.log - Extract jar:file:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-common/2.1.0.2.0.4.0-38/hadoop-yarn-common-2.1.0.2.0.4.0-38.jar!/webapps/cluster to /tmp/Jetty_idhvm_51872_cluster____.sxx3br/webapp 20:38:22.693 [Thread-9] INFO org.mortbay.log - Started SelectChannelConnector@idhvm:51872 20:38:22.698 [Thread-9] INFO o.apache.hadoop.yarn.webapp.WebApps - Web app /cluster started at 51872 20:38:23.029 [main] INFO o.a.h.yarn.server.MiniYARNCluster - MiniYARN ResourceManager address: idhvm:0 20:38:23.029 [main] INFO o.a.h.yarn.server.MiniYARNCluster - MiniYARN ResourceManager web address: idhvm:0 20:38:23.048 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Created localDir in /myData/storm/storm_yarn/storm-yarn/target/com.yahoo.storm.yarn.TestIntegration/com.yahoo.storm.yarn.TestIntegration-localDir-nm-0_0 20:38:23.052 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Created logDir in /myData/storm/storm_yarn/storm-yarn/target/com.yahoo.storm.yarn.TestIntegration/com.yahoo.storm.yarn.TestIntegration-logDir-nm-0_0 20:38:23.055 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Starting NM: 0 20:38:23.474 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl$ContainerEventDispatcher 20:38:23.485 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl$ApplicationEventDispatcher 20:38:23.489 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.localizer.event.LocalizationEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.localizer.ResourceLocalizationService 20:38:23.495 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServicesEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices 20:38:23.502 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl 20:38:23.507 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainersLauncherEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainersLauncher 20:38:23.527 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.ContainerManagerEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl 20:38:23.537 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.NodeManagerEventType for class org.apache.hadoop.yarn.server.MiniYARNCluster$CustomNodeManager 20:38:23.537 [main] INFO o.a.h.m.impl.MetricsSystemImpl - NodeManager metrics system started (again) 20:38:23.646 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.loghandler.event.LogHandlerEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.loghandler.NonAggregatingLogHandler 20:38:23.647 [main] INFO o.a.h.y.s.n.c.l.ResourceLocalizationService - per directory file limit = 8192 20:38:24.040 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.localizer.event.LocalizerEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.localizer.ResourceLocalizationService$LocalizerTracker 20:38:24.092 [main] INFO o.a.h.y.s.n.c.m.ContainersMonitorImpl - Using ResourceCalculatorPlugin : org.apache.hadoop.yarn.util.LinuxResourceCalculatorPlugin@40461581 20:38:24.092 [main] INFO o.a.h.y.s.n.c.m.ContainersMonitorImpl - Using ResourceCalculatorProcessTree : null 20:38:24.092 [main] INFO o.a.h.y.s.n.c.m.ContainersMonitorImpl - Physical memory check enabled: true 20:38:24.093 [main] INFO o.a.h.y.s.n.c.m.ContainersMonitorImpl - Virtual memory check enabled: true 20:38:24.102 [main] WARN o.a.h.y.s.n.c.m.ContainersMonitorImpl - NodeManager configured with 4 G physical memory allocated to containers, which is more than 80% of the total physical memory available (1.8 G). Thrashing might happen. 20:38:24.104 [main] INFO o.a.h.y.s.n.NodeStatusUpdaterImpl - Initialized nodemanager for null: physical-memory=4096 virtual-memory=8602 virtual-cores=8 20:38:24.110 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Waiting for NM 0 to start... 20:38:24.384 [Socket Reader #1 for port 55109] INFO org.apache.hadoop.ipc.Server - Starting Socket Reader #1 for port 55109 20:38:24.535 [Thread-23] INFO o.a.h.y.f.i.p.RpcServerFactoryPBImpl - Adding protocol org.apache.hadoop.yarn.api.ContainerManagementProtocolPB to the server 20:38:24.536 [Thread-23] INFO o.a.h.y.s.n.c.ContainerManagerImpl - Blocking new container-requests as container manager rpc server is still starting. 20:38:24.537 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - IPC Server Responder: starting 20:38:24.539 [IPC Server listener on 55109] INFO org.apache.hadoop.ipc.Server - IPC Server listener on 55109: starting 20:38:24.592 [Thread-23] INFO o.a.h.y.s.n.s.NMContainerTokenSecretManager - Updating node address : idhvm:55109 20:38:24.592 [Thread-23] INFO o.a.h.y.s.n.c.ContainerManagerImpl - ContainerManager started at /192.168.56.101:55109 20:38:24.652 [Socket Reader #1 for port 40965] INFO org.apache.hadoop.ipc.Server - Starting Socket Reader #1 for port 40965 20:38:24.658 [Thread-23] INFO o.a.h.y.f.i.p.RpcServerFactoryPBImpl - Adding protocol org.apache.hadoop.yarn.server.nodemanager.api.LocalizationProtocolPB to the server 20:38:24.660 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - IPC Server Responder: starting 20:38:24.667 [IPC Server listener on 40965] INFO org.apache.hadoop.ipc.Server - IPC Server listener on 40965: starting 20:38:24.680 [Thread-23] INFO o.a.h.y.s.n.c.l.ResourceLocalizationService - Localizer started on port 40965 20:38:24.701 [Thread-23] INFO o.a.h.y.s.n.webapp.WebServer - Instantiating NMWebApp at idhvm:0 20:38:24.706 [Thread-23] INFO org.apache.hadoop.http.HttpServer - Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer$QuotingInputFilter) 20:38:24.708 [Thread-23] INFO org.apache.hadoop.http.HttpServer - Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context node 20:38:24.708 [Thread-23] INFO org.apache.hadoop.http.HttpServer - Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static 20:38:24.710 [Thread-23] INFO org.apache.hadoop.http.HttpServer - adding path spec: /node 20:38:24.711 [Thread-23] INFO org.apache.hadoop.http.HttpServer - adding path spec: /node/* 20:38:24.711 [Thread-23] INFO org.apache.hadoop.http.HttpServer - adding path spec: /ws 20:38:24.712 [Thread-23] INFO org.apache.hadoop.http.HttpServer - adding path spec: /ws/* 20:38:24.713 [Thread-23] INFO org.apache.hadoop.http.HttpServer - Added global filter 'guice' (class=com.google.inject.servlet.GuiceFilter) 20:38:24.714 [Thread-23] INFO org.apache.hadoop.http.HttpServer - Jetty bound to port 56194 20:38:24.714 [Thread-23] INFO org.mortbay.log - jetty-6.1.26 20:38:24.781 [Thread-23] INFO org.mortbay.log - Extract jar:file:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-common/2.1.0.2.0.4.0-38/hadoop-yarn-common-2.1.0.2.0.4.0-38.jar!/webapps/node to /tmp/Jetty_idhvm_56194_node____9g7565/webapp 20:38:24.950 [Thread-23] INFO org.mortbay.log - Started SelectChannelConnector@idhvm:56194 20:38:24.952 [Thread-23] INFO o.apache.hadoop.yarn.webapp.WebApps - Web app /node started at 56194 20:38:25.114 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Created localDir in /myData/storm/storm_yarn/storm-yarn/target/com.yahoo.storm.yarn.TestIntegration/com.yahoo.storm.yarn.TestIntegration-localDir-nm-1_0 20:38:25.117 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Created logDir in /myData/storm/storm_yarn/storm-yarn/target/com.yahoo.storm.yarn.TestIntegration/com.yahoo.storm.yarn.TestIntegration-logDir-nm-1_0 20:38:25.120 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Starting NM: 1 20:38:25.284 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl$ContainerEventDispatcher 20:38:25.284 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl$ApplicationEventDispatcher 20:38:25.284 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.localizer.event.LocalizationEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.localizer.ResourceLocalizationService 20:38:25.284 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServicesEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices 20:38:25.285 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl 20:38:25.285 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainersLauncherEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainersLauncher 20:38:25.285 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.ContainerManagerEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl 20:38:25.285 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.NodeManagerEventType for class org.apache.hadoop.yarn.server.MiniYARNCluster$CustomNodeManager 20:38:25.285 [main] INFO o.a.h.m.impl.MetricsSystemImpl - NodeManager metrics system started (again) 20:38:25.355 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.loghandler.event.LogHandlerEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.loghandler.NonAggregatingLogHandler 20:38:25.356 [main] INFO o.a.h.y.s.n.c.l.ResourceLocalizationService - per directory file limit = 8192 20:38:25.553 [Thread-23] INFO o.apache.hadoop.yarn.webapp.WebApps - Registered webapp guice modules Aug 12, 2013 8:38:25 PM com.google.inject.servlet.GuiceFilter setPipeline WARNING: Multiple Servlet injectors detected. This is a warning indicating that you have more than one GuiceFilter running in your web application. If this is deliberate, you may safely ignore this message. If this is NOT deliberate however, your application may not work as expected. 20:38:25.581 [Thread-9] INFO o.apache.hadoop.yarn.webapp.WebApps - Registered webapp guice modules 20:38:25.584 [Thread-9] INFO o.a.h.s.t.d.AbstractDelegationTokenSecretManager - Updating the current master key for generating delegation tokens 20:38:25.592 [Thread-9] INFO o.a.h.y.s.r.s.RMDelegationTokenSecretManager - storing master key with keyID 1 20:38:25.605 [Thread-23] INFO o.a.h.y.s.n.NodeStatusUpdaterImpl - Connecting to ResourceManager at /0.0.0.0:8031. current no. of attempts is 1 20:38:25.603 [Thread[Thread-64,5,main]] INFO o.a.h.s.t.d.AbstractDelegationTokenSecretManager - Starting expired delegation token remover thread, tokenRemoverScanInterval=60 min(s) 20:38:25.615 [Thread[Thread-64,5,main]] INFO o.a.h.s.t.d.AbstractDelegationTokenSecretManager - Updating the current master key for generating delegation tokens 20:38:25.617 [Thread[Thread-64,5,main]] INFO o.a.h.y.s.r.s.RMDelegationTokenSecretManager - storing master key with keyID 2 20:38:25.695 [main] INFO o.a.h.yarn.event.AsyncDispatcher - Registering class org.apache.hadoop.yarn.server.nodemanager.containermanager.localizer.event.LocalizerEventType for class org.apache.hadoop.yarn.server.nodemanager.containermanager.localizer.ResourceLocalizationService$LocalizerTracker 20:38:25.696 [main] INFO o.a.h.y.s.n.c.m.ContainersMonitorImpl - Using ResourceCalculatorPlugin : org.apache.hadoop.yarn.util.LinuxResourceCalculatorPlugin@4aa15c60 20:38:25.697 [main] INFO o.a.h.y.s.n.c.m.ContainersMonitorImpl - Using ResourceCalculatorProcessTree : null 20:38:25.697 [main] INFO o.a.h.y.s.n.c.m.ContainersMonitorImpl - Physical memory check enabled: true 20:38:25.697 [main] INFO o.a.h.y.s.n.c.m.ContainersMonitorImpl - Virtual memory check enabled: true 20:38:25.700 [main] WARN o.a.h.y.s.n.c.m.ContainersMonitorImpl - NodeManager configured with 4 G physical memory allocated to containers, which is more than 80% of the total physical memory available (1.8 G). Thrashing might happen. 20:38:25.701 [main] INFO o.a.h.y.s.n.NodeStatusUpdaterImpl - Initialized nodemanager for null: physical-memory=4096 virtual-memory=8602 virtual-cores=8 20:38:25.702 [main] INFO o.a.h.yarn.server.MiniYARNCluster - Waiting for NM 1 to start... 20:38:25.725 [Socket Reader #1 for port 33975] INFO org.apache.hadoop.ipc.Server - Starting Socket Reader #1 for port 33975 20:38:25.726 [Socket Reader #1 for port 46029] INFO org.apache.hadoop.ipc.Server - Starting Socket Reader #1 for port 46029 20:38:25.747 [Thread-9] INFO o.a.h.y.f.i.p.RpcServerFactoryPBImpl - Adding protocol org.apache.hadoop.yarn.server.api.ResourceTrackerPB to the server 20:38:25.749 [IPC Server listener on 33975] INFO org.apache.hadoop.ipc.Server - IPC Server listener on 33975: starting 20:38:25.753 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - IPC Server Responder: starting 20:38:25.788 [Thread-74] INFO o.a.h.y.f.i.p.RpcServerFactoryPBImpl - Adding protocol org.apache.hadoop.yarn.api.ContainerManagementProtocolPB to the server 20:38:25.788 [Thread-74] INFO o.a.h.y.s.n.c.ContainerManagerImpl - Blocking new container-requests as container manager rpc server is still starting. 20:38:25.789 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - IPC Server Responder: starting 20:38:25.789 [IPC Server listener on 46029] INFO org.apache.hadoop.ipc.Server - IPC Server listener on 46029: starting 20:38:25.856 [Thread-74] INFO o.a.h.y.s.n.s.NMContainerTokenSecretManager - Updating node address : idhvm:46029 20:38:25.856 [Thread-74] INFO o.a.h.y.s.n.c.ContainerManagerImpl - ContainerManager started at /192.168.56.101:46029 20:38:25.863 [Socket Reader #1 for port 43009] INFO org.apache.hadoop.ipc.Server - Starting Socket Reader #1 for port 43009 20:38:25.866 [Thread-23] INFO o.a.hadoop.yarn.util.RackResolver - Resolved idhvm to /default-rack 20:38:25.876 [Thread-74] INFO o.a.h.y.f.i.p.RpcServerFactoryPBImpl - Adding protocol org.apache.hadoop.yarn.server.nodemanager.api.LocalizationProtocolPB to the server 20:38:25.878 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - IPC Server Responder: starting 20:38:25.881 [IPC Server listener on 43009] INFO org.apache.hadoop.ipc.Server - IPC Server listener on 43009: starting 20:38:25.901 [Thread-74] INFO o.a.h.y.s.n.c.l.ResourceLocalizationService - Localizer started on port 43009 20:38:25.914 [Thread-23] INFO o.a.h.y.s.r.ResourceTrackerService - NodeManager from node idhvm(cmPort: 55109 httpPort: 56194) registered with capability: , assigned nodeId idhvm:55109 20:38:25.925 [Thread-23] INFO o.a.h.y.s.n.s.NMContainerTokenSecretManager - Rolling master-key for container-tokens, got key with id -1462191846 20:38:25.931 [Thread-23] INFO o.a.h.y.s.n.s.NMTokenSecretManagerInNM - Rolling master-key for nm-tokens, got key with id :-1687433504 20:38:25.933 [Thread-23] INFO o.a.h.y.s.n.NodeStatusUpdaterImpl - Registered with ResourceManager as idhvm:55109 with total resource of 20:38:25.933 [Thread-23] INFO o.a.h.y.s.n.NodeStatusUpdaterImpl - Notifying ContainerManager to unblock new container-requests 20:38:25.937 [Thread-74] INFO o.a.h.y.s.n.webapp.WebServer - Instantiating NMWebApp at idhvm:0 20:38:25.944 [Thread-74] INFO org.apache.hadoop.http.HttpServer - Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer$QuotingInputFilter) 20:38:25.945 [Thread-74] INFO org.apache.hadoop.http.HttpServer - Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context node 20:38:25.946 [Thread-74] INFO org.apache.hadoop.http.HttpServer - Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static 20:38:25.949 [Thread-74] INFO org.apache.hadoop.http.HttpServer - adding path spec: /node 20:38:25.950 [Thread-74] INFO org.apache.hadoop.http.HttpServer - adding path spec: /node/* 20:38:25.951 [Thread-74] INFO org.apache.hadoop.http.HttpServer - adding path spec: /ws 20:38:25.953 [Thread-74] INFO org.apache.hadoop.http.HttpServer - adding path spec: /ws/* 20:38:25.954 [Thread-74] INFO org.apache.hadoop.http.HttpServer - Added global filter 'guice' (class=com.google.inject.servlet.GuiceFilter) 20:38:25.954 [AsyncDispatcher event handler] INFO o.a.h.y.s.r.rmnode.RMNodeImpl - idhvm:55109 Node Transitioned from NEW to RUNNING 20:38:25.955 [Thread-74] INFO org.apache.hadoop.http.HttpServer - Jetty bound to port 38571 20:38:25.956 [Thread-74] INFO org.mortbay.log - jetty-6.1.26 20:38:25.975 [ResourceManager Event Processor] INFO o.a.h.y.s.r.s.c.CapacityScheduler - Added node idhvm:55109 clusterResource: 20:38:26.029 [Socket Reader #1 for port 39858] INFO org.apache.hadoop.ipc.Server - Starting Socket Reader #1 for port 39858 20:38:26.039 [Thread-9] INFO o.a.h.y.f.i.p.RpcServerFactoryPBImpl - Adding protocol org.apache.hadoop.yarn.api.ApplicationMasterProtocolPB to the server 20:38:26.043 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - IPC Server Responder: starting 20:38:26.044 [IPC Server listener on 39858] INFO org.apache.hadoop.ipc.Server - IPC Server listener on 39858: starting 20:38:26.081 [Thread-74] INFO org.mortbay.log - Extract jar:file:/root/.m2/repository/org/apache/hadoop/hadoop-yarn-common/2.1.0.2.0.4.0-38/hadoop-yarn-common-2.1.0.2.0.4.0-38.jar!/webapps/node to /tmp/Jetty_idhvm_38571_node____q673g/webapp 20:38:26.420 [Socket Reader #1 for port 42426] INFO org.apache.hadoop.ipc.Server - Starting Socket Reader #1 for port 42426 20:38:26.427 [Thread-9] INFO o.a.h.y.f.i.p.RpcServerFactoryPBImpl - Adding protocol org.apache.hadoop.yarn.api.ApplicationClientProtocolPB to the server 20:38:26.431 [IPC Server listener on 42426] INFO org.apache.hadoop.ipc.Server - IPC Server listener on 42426: starting 20:38:26.436 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - IPC Server Responder: starting 20:38:26.725 [Socket Reader #1 for port 34702] INFO org.apache.hadoop.ipc.Server - Starting Socket Reader #1 for port 34702 20:38:26.732 [Thread-9] INFO o.a.h.y.f.i.p.RpcServerFactoryPBImpl - Adding protocol org.apache.hadoop.yarn.api.ResourceManagerAdministrationProtocolPB to the server 20:38:26.734 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - IPC Server Responder: starting 20:38:26.735 [IPC Server listener on 34702] INFO org.apache.hadoop.ipc.Server - IPC Server listener on 34702: starting Aug 12, 2013 8:38:27 PM com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register INFO: Registering org.apache.hadoop.yarn.server.resourcemanager.webapp.JAXBContextResolver as a provider class Aug 12, 2013 8:38:27 PM com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register INFO: Registering org.apache.hadoop.yarn.server.resourcemanager.webapp.RMWebServices as a root resource class Aug 12, 2013 8:38:27 PM com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register INFO: Registering org.apache.hadoop.yarn.webapp.GenericExceptionHandler as a provider class Aug 12, 2013 8:38:27 PM com.sun.jersey.server.impl.application.WebApplicationImpl _initiate INFO: Initiating Jersey application, version 'Jersey: 1.8 06/24/2011 12:17 PM' Aug 12, 2013 8:38:27 PM com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory getComponentProvider INFO: Binding org.apache.hadoop.yarn.server.resourcemanager.webapp.JAXBContextResolver to GuiceManagedComponentProvider with the scope "Singleton" 20:38:28.896 [main] INFO com.yahoo.storm.yarn.TestConfig - storm_home: null 20:38:28.947 [main] ERROR com.yahoo.storm.yarn.TestIntegration - setup failure java.lang.NullPointerException: null at java.util.Hashtable.put(Hashtable.java:542) ~[na:1.7.0_25] at java.util.Properties.setProperty(Properties.java:161) ~[na:1.7.0_25] at java.lang.System.setProperty(System.java:786) ~[na:1.7.0_25] at com.yahoo.storm.yarn.TestConfig.stormHomePath(TestConfig.java:74) ~[test-classes/:na] at com.yahoo.storm.yarn.TestIntegration.setup(TestIntegration.java:79) ~[test-classes/:na] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.7.0_25] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) ~[na:1.7.0_25] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.7.0_25] at java.lang.reflect.Method.invoke(Method.java:606) ~[na:1.7.0_25] at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45) ~[junit-4.10.jar:na] at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15) ~[junit-4.10.jar:na] at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42) ~[junit-4.10.jar:na] at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:27) ~[junit-4.10.jar:na] at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30) ~[junit-4.10.jar:na] at org.junit.runners.ParentRunner.run(ParentRunner.java:300) ~[junit-4.10.jar:na] at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) ~[na:na] at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) ~[na:na] at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) ~[na:na] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.7.0_25] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) ~[na:1.7.0_25] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.7.0_25] at java.lang.reflect.Method.invoke(Method.java:606) ~[na:1.7.0_25] at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) ~[surefire-api-2.10.jar:2.10] at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) ~[surefire-booter-2.10.jar:2.10] at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) ~[surefire-booter-2.10.jar:2.10] at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) ~[surefire-booter-2.10.jar:2.10] at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) ~[surefire-booter-2.10.jar:2.10] 20:38:28.948 [main] INFO com.yahoo.storm.yarn.TestIntegration - java.lang.NullPointerException 20:38:28.949 [main] INFO c.yahoo.storm.yarn.EmbeddedZKServer - shutdown embedded zookeeper server with port 60000 20:38:28.949 [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:60000hread] org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:278)evel org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:278)ogger{36} - NIOServerCnxn factory exited run methodsg 20:38:28.950 [ProcessThread:-1hread] org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:119)evel org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:119)ogger{36} - PrepRequestProcessor exited loop!sg 20:38:28.950 [SyncThread:0hread] org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:151)evel org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:151)ogger{36} - SyncRequestProcessor exited!sg 20:38:28.952 [mainhread] org.apache.zookeeper.server.FinalRequestProcessor.shutdown(FinalRequestProcessor.java:378)evel org.apache.zookeeper.server.FinalRequestProcessor.shutdown(FinalRequestProcessor.java:378)ogger{36} - shutdown of request processor completesg 20:38:28.953 [main] INFO com.yahoo.storm.yarn.TestIntegration - shutdown MiniYarn cluster Aug 12, 2013 8:38:29 PM com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory getComponentProvider INFO: Binding org.apache.hadoop.yarn.webapp.GenericExceptionHandler to GuiceManagedComponentProvider with the scope "Singleton" 20:38:30.001 [SessionTrackerhread] org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:158)evel org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:158)ogger{36} - SessionTrackerImpl exited loop!sg Aug 12, 2013 8:38:31 PM com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory getComponentProvider INFO: Binding org.apache.hadoop.yarn.server.resourcemanager.webapp.RMWebServices to GuiceManagedComponentProvider with the scope "Singleton" 20:38:31.436 [Thread-74] INFO org.mortbay.log - Started SelectChannelConnector@idhvm:38571 20:38:31.437 [Thread-74] INFO o.apache.hadoop.yarn.webapp.WebApps - Web app /node started at 38571 Aug 12, 2013 8:38:31 PM com.google.inject.servlet.GuiceFilter setPipeline WARNING: Multiple Servlet injectors detected. This is a warning indicating that you have more than one GuiceFilter running in your web application. If this is deliberate, you may safely ignore this message. If this is NOT deliberate however, your application may not work as expected. 20:38:31.453 [Thread-74] INFO o.apache.hadoop.yarn.webapp.WebApps - Registered webapp guice modules 20:38:31.457 [Thread-74] INFO o.a.h.y.s.n.NodeStatusUpdaterImpl - Connecting to ResourceManager at /0.0.0.0:8031. current no. of attempts is 1 20:38:31.458 [Thread-74] INFO o.a.hadoop.yarn.util.RackResolver - Resolved idhvm to /default-rack 20:38:31.459 [Thread-74] INFO o.a.h.y.s.r.ResourceTrackerService - NodeManager from node idhvm(cmPort: 46029 httpPort: 38571) registered with capability: , assigned nodeId idhvm:46029 20:38:31.459 [AsyncDispatcher event handler] INFO o.a.h.y.s.r.rmnode.RMNodeImpl - idhvm:46029 Node Transitioned from NEW to RUNNING 20:38:31.459 [Thread-74] INFO o.a.h.y.s.n.s.NMContainerTokenSecretManager - Rolling master-key for container-tokens, got key with id -1462191846 20:38:31.459 [Thread-74] INFO o.a.h.y.s.n.s.NMTokenSecretManagerInNM - Rolling master-key for nm-tokens, got key with id :-1687433504 20:38:31.459 [Thread-74] INFO o.a.h.y.s.n.NodeStatusUpdaterImpl - Registered with ResourceManager as idhvm:46029 with total resource of 20:38:31.459 [Thread-74] INFO o.a.h.y.s.n.NodeStatusUpdaterImpl - Notifying ContainerManager to unblock new container-requests 20:38:31.459 [ResourceManager Event Processor] INFO o.a.h.y.s.r.s.c.CapacityScheduler - Added node idhvm:46029 clusterResource: 20:38:31.464 [Node Status Updater] ERROR o.a.h.y.s.n.NodeStatusUpdaterImpl - Caught exception in status-updater java.lang.NullPointerException: null at org.apache.hadoop.yarn.server.nodemanager.NodeStatusUpdaterImpl$1.run(NodeStatusUpdaterImpl.java:469) ~[hadoop-yarn-server-nodemanager-2.1.0.2.0.4.0-38.jar:na] at java.lang.Thread.run(Thread.java:724) ~[na:1.7.0_25] 20:38:31.484 [main] INFO org.mortbay.log - Stopped SelectChannelConnector@idhvm:0 20:38:31.590 [main] INFO org.apache.hadoop.ipc.Server - Stopping server on 46029 20:38:31.596 [IPC Server listener on 46029] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server listener on 46029 20:38:31.596 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server Responder 20:38:31.605 [Container Monitor] WARN o.a.h.y.s.n.c.m.ContainersMonitorImpl - org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl is interrupted. Exiting. 20:38:31.611 [main] INFO org.apache.hadoop.ipc.Server - Stopping server on 43009 20:38:31.614 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server Responder 20:38:31.615 [Public Localizer] INFO o.a.h.y.s.n.c.l.ResourceLocalizationService - Public cache exiting 20:38:31.614 [IPC Server listener on 43009] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server listener on 43009 20:38:31.640 [main] INFO org.mortbay.log - Stopped SelectChannelConnector@idhvm:0 20:38:31.745 [main] INFO org.apache.hadoop.ipc.Server - Stopping server on 55109 20:38:31.746 [IPC Server listener on 55109] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server listener on 55109 20:38:31.751 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server Responder 20:38:31.758 [Container Monitor] WARN o.a.h.y.s.n.c.m.ContainersMonitorImpl - org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl is interrupted. Exiting. 20:38:31.762 [main] INFO org.apache.hadoop.ipc.Server - Stopping server on 40965 20:38:31.765 [IPC Server listener on 40965] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server listener on 40965 20:38:31.770 [Public Localizer] INFO o.a.h.y.s.n.c.l.ResourceLocalizationService - Public cache exiting 20:38:31.770 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server Responder 20:38:31.805 [main] INFO org.mortbay.log - Stopped SelectChannelConnector@idhvm:0 20:38:31.912 [Thread[Thread-64,5,main]] ERROR o.a.h.s.t.d.AbstractDelegationTokenSecretManager - InterruptedExcpetion recieved for ExpiredTokenRemover thread java.lang.InterruptedException: sleep interrupted 20:38:31.915 [main] INFO o.a.h.m.impl.MetricsSystemImpl - Stopping NodeManager metrics system... 20:38:31.940 [main] INFO o.a.h.m.impl.MetricsSystemImpl - NodeManager metrics system stopped. 20:38:31.941 [main] INFO o.a.h.m.impl.MetricsSystemImpl - NodeManager metrics system shutdown complete. 20:38:31.950 [ApplicationMaster Launcher] WARN o.a.h.y.s.r.a.ApplicationMasterLauncher - org.apache.hadoop.yarn.server.resourcemanager.amlauncher.ApplicationMasterLauncher$LauncherThread interrupted. Returning. 20:38:31.952 [main] INFO org.apache.hadoop.ipc.Server - Stopping server on 34702 20:38:31.954 [IPC Server listener on 34702] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server listener on 34702 20:38:31.955 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server Responder 20:38:31.957 [main] INFO org.apache.hadoop.ipc.Server - Stopping server on 42426 20:38:31.960 [IPC Server listener on 42426] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server listener on 42426 20:38:31.964 [main] INFO org.apache.hadoop.ipc.Server - Stopping server on 39858 20:38:31.961 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server Responder 20:38:32.045 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server Responder 20:38:32.045 [IPC Server listener on 39858] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server listener on 39858 20:38:32.058 [main] INFO org.apache.hadoop.ipc.Server - Stopping server on 33975 20:38:32.061 [IPC Server listener on 33975] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server listener on 33975 20:38:32.063 [IPC Server Responder] INFO org.apache.hadoop.ipc.Server - Stopping IPC Server Responder 20:38:32.065 [ResourceManager Event Processor] ERROR o.a.h.y.s.r.ResourceManager - Returning, interrupted : java.lang.InterruptedException 20:38:32.065 [Ping Checker] INFO o.a.h.y.u.AbstractLivelinessMonitor - NMLivelinessMonitor thread interrupted 20:38:32.082 [Ping Checker] INFO o.a.h.y.u.AbstractLivelinessMonitor - org.apache.hadoop.yarn.server.resourcemanager.rmcontainer.ContainerAllocationExpirer thread interrupted 20:38:32.082 [Ping Checker] INFO o.a.h.y.u.AbstractLivelinessMonitor - AMLivelinessMonitor thread interrupted 20:38:32.082 [Ping Checker] INFO o.a.h.y.u.AbstractLivelinessMonitor - AMLivelinessMonitor thread interrupted Tests run: 2, Failures: 1, Errors: 1, Skipped: 0, Time elapsed: 17.238 sec <<< FAILURE! Running com.yahoo.storm.yarn.TestStormCluster 20:38:33.121 [main] INFO c.yahoo.storm.yarn.EmbeddedZKServer - Starting up embedded Zookeeper server 20:38:33.122 [mainhread] org.apache.zookeeper.server.ZooKeeperServer.(ZooKeeperServer.java:151)evel org.apache.zookeeper.server.ZooKeeperServer.(ZooKeeperServer.java:151)ogger{36} - Created server with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir ./target/zookeeper.data/version-2 snapdir ./target/zookeeper.data/version-2sg 20:38:33.123 [mainhread] org.apache.zookeeper.server.NIOServerCnxn$Factory.(NIOServerCnxn.java:143)evel org.apache.zookeeper.server.NIOServerCnxn$Factory.(NIOServerCnxn.java:143)ogger{36} - binding to port 0.0.0.0/0.0.0.0:60000sg 20:38:33.123 [main] INFO c.yahoo.storm.yarn.EmbeddedZKServer - Zookeeper port allocated:60000 20:38:33.141 [mainhread] org.apache.zookeeper.server.persistence.FileSnap.deserialize(FileSnap.java:82)evel org.apache.zookeeper.server.persistence.FileSnap.deserialize(FileSnap.java:82)ogger{36} - Reading snapshot ./target/zookeeper.data/version-2/snapshot.0sg 20:38:33.145 [mainhread] org.apache.zookeeper.server.persistence.FileTxnSnapLog.save(FileTxnSnapLog.java:208)evel org.apache.zookeeper.server.persistence.FileTxnSnapLog.save(FileTxnSnapLog.java:208)ogger{36} - Snapshotting: 0sg 20:38:33.162 [main] INFO com.yahoo.storm.yarn.TestConfig - storm_home: null Tests run: 2, Failures: 0, Errors: 2, Skipped: 0, Time elapsed: 0.023 sec <<< FAILURE! Running com.yahoo.storm.yarn.TestStormMaster 20:38:33.168 [main] INFO c.yahoo.storm.yarn.EmbeddedZKServer - Starting up embedded Zookeeper server 20:38:33.171 [mainhread] org.apache.zookeeper.server.ZooKeeperServer.(ZooKeeperServer.java:151)evel org.apache.zookeeper.server.ZooKeeperServer.(ZooKeeperServer.java:151)ogger{36} - Created server with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir ./target/zookeeper.data/version-2 snapdir ./target/zookeeper.data/version-2sg 20:38:33.171 [mainhread] org.apache.zookeeper.server.NIOServerCnxn$Factory.(NIOServerCnxn.java:143)evel org.apache.zookeeper.server.NIOServerCnxn$Factory.(NIOServerCnxn.java:143)ogger{36} - binding to port 0.0.0.0/0.0.0.0:60000sg 20:38:33.173 [mainhread] org.apache.zookeeper.server.NIOServerCnxn$Factory.(NIOServerCnxn.java:143)evel org.apache.zookeeper.server.NIOServerCnxn$Factory.(NIOServerCnxn.java:143)ogger{36} - binding to port 0.0.0.0/0.0.0.0:60001sg 20:38:33.173 [main] INFO c.yahoo.storm.yarn.EmbeddedZKServer - Zookeeper port allocated:60001 20:38:33.216 [mainhread] org.apache.zookeeper.server.persistence.FileSnap.deserialize(FileSnap.java:82)evel org.apache.zookeeper.server.persistence.FileSnap.deserialize(FileSnap.java:82)ogger{36} - Reading snapshot ./target/zookeeper.data/version-2/snapshot.0sg 20:38:33.224 [mainhread] org.apache.zookeeper.server.persistence.FileTxnSnapLog.save(FileTxnSnapLog.java:208)evel org.apache.zookeeper.server.persistence.FileTxnSnapLog.save(FileTxnSnapLog.java:208)ogger{36} - Snapshotting: 0sg 20:38:33.246 [mainhread] org.apache.zookeeper.jmx.MBeanRegistry.register(MBeanRegistry.java:78)evel org.apache.zookeeper.jmx.MBeanRegistry.register(MBeanRegistry.java:78)ogger{36} - Failed to register MBean StandaloneServer_port-1sg 20:38:33.260 [mainhread] org.apache.zookeeper.server.ZooKeeperServer.registerJMX(ZooKeeperServer.java:354)evel org.apache.zookeeper.server.ZooKeeperServer.registerJMX(ZooKeeperServer.java:354)ogger{36} - Failed to register with JMXsg javax.management.InstanceAlreadyExistsException: org.apache.ZooKeeperService:name0=StandaloneServer_port-1 at com.sun.jmx.mbeanserver.Repository.addMBean(Repository.java:437) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerWithRepository(DefaultMBeanServerInterceptor.java:1898) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerDynamicMBean(DefaultMBeanServerInterceptor.java:966) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerObject(DefaultMBeanServerInterceptor.java:900) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerMBean(DefaultMBeanServerInterceptor.java:324) at com.sun.jmx.mbeanserver.JmxMBeanServer.registerMBean(JmxMBeanServer.java:522) at org.apache.zookeeper.jmx.MBeanRegistry.register(MBeanRegistry.java:76) at org.apache.zookeeper.server.ZooKeeperServer.registerJMX(ZooKeeperServer.java:344) at org.apache.zookeeper.server.ZooKeeperServer.startup(ZooKeeperServer.java:374) at org.apache.zookeeper.server.NIOServerCnxn$Factory.startup(NIOServerCnxn.java:161) at com.yahoo.storm.yarn.EmbeddedZKServer.start(EmbeddedZKServer.java:47) at com.yahoo.storm.yarn.TestStormMaster.setup(TestStormMaster.java:47) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:27) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30) at org.junit.runners.ParentRunner.run(ParentRunner.java:300) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) 20:38:33.712 [main] INFO com.yahoo.storm.yarn.TestConfig - storm_home: null Tests run: 2, Failures: 0, Errors: 2, Skipped: 0, Time elapsed: 0.463 sec <<< FAILURE! Results : Failed tests: com.yahoo.storm.yarn.TestIntegration: expected: but was: Tests in error: com.yahoo.storm.yarn.TestIntegration com.yahoo.storm.yarn.TestStormCluster com.yahoo.storm.yarn.TestStormCluster com.yahoo.storm.yarn.TestStormMaster com.yahoo.storm.yarn.TestStormMaster Tests run: 6, Failures: 1, Errors: 5, Skipped: 0 [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 43.617s [INFO] Finished at: Mon Aug 12 20:38:34 CST 2013 [INFO] Final Memory: 11M/116M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.10:test (default-test) on project storm-yarn: There are test failures. [ERROR] [ERROR] Please refer to /myData/storm/storm_yarn/storm-yarn/target/surefire-reports for the individual test results. [ERROR] -> [Help 1] [ERROR] [ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch. [ERROR] Re-run Maven using the -X switch to enable full debug logging. [ERROR] [ERROR] For more information about the errors and possible solutions, please read the following articles: [ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException