lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-Tests-4.x-Java6 - Build # 626 - Failure
Date Wed, 12 Sep 2012 22:23:48 GMT
Build: https://builds.apache.org/job/Lucene-Solr-Tests-4.x-Java6/626/

1 tests failed.
REGRESSION:  org.apache.solr.cloud.RecoveryZkTest.testDistribSearch

Error Message:
Server at http://localhost:17556/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select

Stack Trace:
org.apache.solr.common.SolrException: Server at http://localhost:17556/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
	at __randomizedtesting.SeedInfo.seed([AC8053E3566AD2D9:2D66DDFB2135B2E5]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:373)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:182)
	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:324)
	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:691)
	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:616)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:679)




Build Log:
[...truncated 6912 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 7 T13 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/./solrtest-RecoveryZkTest-1347487697172
[junit4:junit4]   2> 14 T13 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 181 T14 oaz.Environment.logEnv Server environment:zookeeper.version=3.3.6-1366786, built on 07/29/2012 06:22 GMT
[junit4:junit4]   2> 181 T14 oaz.Environment.logEnv Server environment:host.name=lucene.zones.apache.org
[junit4:junit4]   2> 182 T14 oaz.Environment.logEnv Server environment:java.version=1.6.0_32
[junit4:junit4]   2> 182 T14 oaz.Environment.logEnv Server environment:java.vendor=Sun Microsystems Inc.
[junit4:junit4]   2> 183 T14 oaz.Environment.logEnv Server environment:java.home=/usr/local/openjdk6/jre
[junit4:junit4]   2> 183 T14 oaz.Environment.logEnv Server environment:java.class.path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/classes/test:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-test-framework/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/codecs/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/test-framework/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-solrj/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/analysis/common/lucene-analyzers-common-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/analysis/kuromoji/lucene-analyzers-kuromoji-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/analysis/phonetic/lucene-analyzers-phonetic-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/highlighter/lucene-highlighter-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/memory/lucene-memory-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/misc/lucene-misc-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/spatial/lucene-spatial-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/suggest/lucene-suggest-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/grouping/lucene-grouping-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/queries/lucene-queries-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/queryparser/lucene-queryparser-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/commons-cli-1.2.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/commons-codec-1.6.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/commons-fileupload-1.2.1.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/commons-lang-2.6.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/easymock-2.2.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/guava-r05.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/javax.servlet-api-3.0.1.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/spatial4j-0.3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/commons-io-2.1.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/httpclient-4.1.3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/httpcore-4.1.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/httpmime-4.1.3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/jcl-over-slf4j-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/log4j-over-slf4j-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/slf4j-api-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/slf4j-jdk14-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/wstx-asl-3.2.7.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/zookeeper-3.3.6.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-continuation-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-deploy-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-http-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-io-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-jmx-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-security-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-server-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-servlet-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-util-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-webapp-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-xml-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/servlet-api-3.0.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/example-DIH/solr/db/lib/hsqldb-1.8.0.10.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/core/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/test-framework/lib/junit-4.10.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/test-framework/lib/randomizedtesting-runner-2.0.0.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-launcher.jar:/home/hudson/.ant/lib/ivy-2.2.0.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-regexp.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-junit.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-bsf.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-commons-net.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-antlr.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-log4j.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-commons-logging.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-oro.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-junit4.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-netrexx.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-swing.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-javamail.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jsch.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jmf.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-bcel.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jai.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-testutil.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-resolver.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jdepend.jar:/usr/local/openjdk6/lib/tools.jar:/home/hudson/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.0.0.jar
[junit4:junit4]   2> 185 T14 oaz.Environment.logEnv Server environment:java.library.path=/usr/local/openjdk6/jre/lib/amd64/server:/usr/local/openjdk6/jre/lib/amd64:/usr/local/openjdk6/jre/../lib/amd64:/usr/java/packages/lib/amd64:/lib:/usr/lib:/usr/local/lib
[junit4:junit4]   2> 185 T14 oaz.Environment.logEnv Server environment:java.io.tmpdir=.
[junit4:junit4]   2> 185 T14 oaz.Environment.logEnv Server environment:java.compiler=<NA>
[junit4:junit4]   2> 186 T14 oaz.Environment.logEnv Server environment:os.name=FreeBSD
[junit4:junit4]   2> 186 T14 oaz.Environment.logEnv Server environment:os.arch=amd64
[junit4:junit4]   2> 187 T14 oaz.Environment.logEnv Server environment:os.version=9.0-RELEASE
[junit4:junit4]   2> 187 T14 oaz.Environment.logEnv Server environment:user.name=hudson
[junit4:junit4]   2> 188 T14 oaz.Environment.logEnv Server environment:user.home=/home/hudson
[junit4:junit4]   2> 188 T14 oaz.Environment.logEnv Server environment:user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1
[junit4:junit4]   2> 255 T14 oazs.ZooKeeperServer.setTickTime tickTime set to 3000
[junit4:junit4]   2> 311 T14 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 323 T13 oasc.ZkTestServer.run start zk server on port:35084
[junit4:junit4]   2> 488 T14 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 514 T13 oaz.Environment.logEnv Client environment:zookeeper.version=3.3.6-1366786, built on 07/29/2012 06:22 GMT
[junit4:junit4]   2> 515 T13 oaz.Environment.logEnv Client environment:host.name=lucene.zones.apache.org
[junit4:junit4]   2> 515 T13 oaz.Environment.logEnv Client environment:java.version=1.6.0_32
[junit4:junit4]   2> 515 T13 oaz.Environment.logEnv Client environment:java.vendor=Sun Microsystems Inc.
[junit4:junit4]   2> 516 T13 oaz.Environment.logEnv Client environment:java.home=/usr/local/openjdk6/jre
[junit4:junit4]   2> 516 T13 oaz.Environment.logEnv Client environment:java.class.path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/classes/test:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-test-framework/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/codecs/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/test-framework/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-solrj/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/analysis/common/lucene-analyzers-common-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/analysis/kuromoji/lucene-analyzers-kuromoji-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/analysis/phonetic/lucene-analyzers-phonetic-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/highlighter/lucene-highlighter-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/memory/lucene-memory-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/misc/lucene-misc-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/spatial/lucene-spatial-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/suggest/lucene-suggest-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/grouping/lucene-grouping-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/queries/lucene-queries-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/queryparser/lucene-queryparser-4.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/commons-cli-1.2.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/commons-codec-1.6.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/commons-fileupload-1.2.1.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/commons-lang-2.6.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/easymock-2.2.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/guava-r05.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/javax.servlet-api-3.0.1.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/core/lib/spatial4j-0.3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/commons-io-2.1.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/httpclient-4.1.3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/httpcore-4.1.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/httpmime-4.1.3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/jcl-over-slf4j-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/log4j-over-slf4j-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/slf4j-api-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/slf4j-jdk14-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/wstx-asl-3.2.7.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/solrj/lib/zookeeper-3.3.6.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-continuation-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-deploy-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-http-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-io-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-jmx-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-security-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-server-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-servlet-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-util-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-webapp-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/jetty-xml-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/lib/servlet-api-3.0.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/example/example-DIH/solr/db/lib/hsqldb-1.8.0.10.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/build/core/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/test-framework/lib/junit-4.10.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/test-framework/lib/randomizedtesting-runner-2.0.0.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-launcher.jar:/home/hudson/.ant/lib/ivy-2.2.0.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-regexp.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-junit.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-bsf.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-commons-net.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-antlr.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-log4j.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-commons-logging.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-oro.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-junit4.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-netrexx.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-swing.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-javamail.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jsch.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jmf.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-bcel.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jai.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-testutil.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-apache-resolver.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jdepend.jar:/usr/local/openjdk6/lib/tools.jar:/home/hudson/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.0.0.jar
[junit4:junit4]   2> 517 T13 oaz.Environment.logEnv Client environment:java.library.path=/usr/local/openjdk6/jre/lib/amd64/server:/usr/local/openjdk6/jre/lib/amd64:/usr/local/openjdk6/jre/../lib/amd64:/usr/java/packages/lib/amd64:/lib:/usr/lib:/usr/local/lib
[junit4:junit4]   2> 518 T13 oaz.Environment.logEnv Client environment:java.io.tmpdir=.
[junit4:junit4]   2> 518 T13 oaz.Environment.logEnv Client environment:java.compiler=<NA>
[junit4:junit4]   2> 519 T13 oaz.Environment.logEnv Client environment:os.name=FreeBSD
[junit4:junit4]   2> 519 T13 oaz.Environment.logEnv Client environment:os.arch=amd64
[junit4:junit4]   2> 520 T13 oaz.Environment.logEnv Client environment:os.version=9.0-RELEASE
[junit4:junit4]   2> 520 T13 oaz.Environment.logEnv Client environment:user.name=hudson
[junit4:junit4]   2> 520 T13 oaz.Environment.logEnv Client environment:user.home=/home/hudson
[junit4:junit4]   2> 521 T13 oaz.Environment.logEnv Client environment:user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1
[junit4:junit4]   2> 532 T13 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35084 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@17be3bb2
[junit4:junit4]   2> 628 T17 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35084
[junit4:junit4]   2> 633 T13 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 634 T17 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35084, initiating session
[junit4:junit4]   2> 635 T15 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:38493
[junit4:junit4]   2> 674 T15 oazs.NIOServerCnxn.doIO WARNING Exception causing close of session 0x0 due to java.io.IOException: ZooKeeperServer not running
[junit4:junit4]   2> 675 T15 oazs.NIOServerCnxn.closeSock Closed socket connection for client /140.211.11.196:38493 (no session established for client)
[junit4:junit4]   2> 676 T17 oaz.ClientCnxn$SendThread.run Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit4:junit4]   2> 2654 T17 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:35084
[junit4:junit4]   2> 2655 T17 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35084, initiating session
[junit4:junit4]   2> 2655 T15 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:60677
[junit4:junit4]   2> 2657 T15 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:60677
[junit4:junit4]   2> 2677 T18 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 2719 T18 oazs.NIOServerCnxn.finishSessionInit Established session 0x139bc868b310000 with negotiated timeout 10000 for client /140.211.11.196:60677
[junit4:junit4]   2> 2719 T17 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35084, sessionid = 0x139bc868b310000, negotiated timeout = 10000
[junit4:junit4]   2> 2724 T19 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@17be3bb2 name:ZooKeeperConnection Watcher:127.0.0.1:35084 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2725 T13 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2729 T13 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 2806 T20 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x139bc868b310000
[junit4:junit4]   2> 2808 T19 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 2808 T13 oaz.ZooKeeper.close Session: 0x139bc868b310000 closed
[junit4:junit4]   2> 2810 T15 oazs.NIOServerCnxn.closeSock Closed socket connection for client /140.211.11.196:60677 which had sessionid 0x139bc868b310000
[junit4:junit4]   2> 2810 T13 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35084/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@283b18f
[junit4:junit4]   2> 2812 T21 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35084
[junit4:junit4]   2> 2812 T13 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 2813 T21 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35084, initiating session
[junit4:junit4]   2> 2813 T15 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:24221
[junit4:junit4]   2> 2815 T15 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:24221
[junit4:junit4]   2> 2817 T18 oazs.NIOServerCnxn.finishSessionInit Established session 0x139bc868b310001 with negotiated timeout 10000 for client /140.211.11.196:24221
[junit4:junit4]   2> 2817 T21 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35084, sessionid = 0x139bc868b310001, negotiated timeout = 10000
[junit4:junit4]   2> 2818 T22 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@283b18f name:ZooKeeperConnection Watcher:127.0.0.1:35084/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2819 T13 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2845 T13 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 2852 T13 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 2858 T13 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 2862 T13 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 2868 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 2898 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 2917 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 2923 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 3029 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 3031 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 3047 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 3048 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 3053 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 3054 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 3058 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 3059 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 3063 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 3064 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 3068 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 3069 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 3074 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 3075 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 3079 T13 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 3080 T13 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 3084 T20 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x139bc868b310001
[junit4:junit4]   2> 3086 T22 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 3086 T15 oazs.NIOServerCnxn.closeSock Closed socket connection for client /140.211.11.196:24221 which had sessionid 0x139bc868b310001
[junit4:junit4]   2> 3086 T13 oaz.ZooKeeper.close Session: 0x139bc868b310001 closed
[junit4:junit4]   2> 3480 T13 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 3743 T13 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:64001
[junit4:junit4]   2> 3788 T13 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3790 T13 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 3791 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 3842 T13 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3844 T13 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3844 T13 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 3845 T13 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 3846 T13 oasc.CoreContainer.<init> New CoreContainer 658781736
[junit4:junit4]   2> 3848 T13 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 3849 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 3901 T13 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3926 T13 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35084/solr
[junit4:junit4]   2> 3960 T13 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35084/solr sessionTimeout=8000 watcher=org.apache.solr.common.cloud.ConnectionManager@74220711
[junit4:junit4]   2> 3961 T33 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35084
[junit4:junit4]   2> 3961 T13 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3963 T33 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35084, initiating session
[junit4:junit4]   2> 3964 T15 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:36568
[junit4:junit4]   2> 3965 T15 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:36568
[junit4:junit4]   2> 3969 T18 oazs.NIOServerCnxn.finishSessionInit Established session 0x139bc868b310002 with negotiated timeout 8000 for client /140.211.11.196:36568
[junit4:junit4]   2> 3969 T33 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35084, sessionid = 0x139bc868b310002, negotiated timeout = 8000
[junit4:junit4]   2> 3970 T34 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@74220711 name:ZooKeeperConnection Watcher:127.0.0.1:35084/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3971 T13 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3995 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4033 T13 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 4045 T13 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64001_solr
[junit4:junit4]   2> 4052 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:64001_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:64001_solr
[junit4:junit4]   2> 4054 T13 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:64001_solr
[junit4:junit4]   2> 4059 T13 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 4060 T13 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 4061 T13 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 4062 T13 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 4063 T13 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 4063 T13 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 4064 T13 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 4065 T13 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 4066 T13 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 4066 T13 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 4089 T13 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 4113 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:delete cxid:0x15 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 4115 T13 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 4120 T13 oasc.Overseer.start Overseer (id=88308953757319170-127.0.0.1:64001_solr-n_0000000000) starting
[junit4:junit4]   2> 4121 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4137 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4138 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4145 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4148 T36 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 4150 T13 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 4153 T13 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 4184 T35 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 4237 T13 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 4238 T13 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 4240 T13 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 4240 T13 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 4243 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 4245 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 4246 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 4378 T13 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_40
[junit4:junit4]   2> 4479 T13 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 4581 T13 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 4641 T13 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 5229 T13 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 5242 T13 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 5245 T13 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5274 T13 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5280 T13 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5286 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5290 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5293 T13 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1347487697171/control/data/
[junit4:junit4]   2> 5297 T13 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6477eb97
[junit4:junit4]   2> 5322 T13 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1347487697171/control/data/index/
[junit4:junit4]   2> 5323 T13 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1347487697171/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 5331 T13 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1347487697171/control/data/index forceNew:false
[junit4:junit4]   2> 5338 T13 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347487697171/control/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@5c09036e; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5339 T13 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 5339 T13 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 5342 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 5342 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 5343 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 5344 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 5344 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 5345 T13 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 5346 T13 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 5365 T13 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 5366 T13 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 5367 T13 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 5368 T13 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 5368 T13 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 5369 T13 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 5370 T13 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 5370 T13 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 5371 T13 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5372 T13 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5373 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5373 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5374 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5375 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5376 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5377 T13 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5378 T13 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 5379 T13 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 5382 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5386 T13 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 5388 T13 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 5392 T13 oass.SolrIndexSearcher.<init> Opening Searcher@10469e8 main
[junit4:junit4]   2> 5410 T13 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 5411 T13 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 5412 T13 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 5430 T13 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 5496 T37 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10469e8 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 5509 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x56 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 5521 T13 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 5521 T13 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:64001/solr shardId:control_shard
[junit4:junit4]   2> 5536 T13 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=10000&maxConnectionsPerHost=20&connTimeout=30000&socketTimeout=30000&retry=false
[junit4:junit4]   2> 5556 T13 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 5575 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:delete cxid:0x65 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/control_collection/leaders Error:KeeperErrorCode = NoNode for /solr/collections/control_collection/leaders
[junit4:junit4]   2> 5576 T13 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process. afterExpiration=false
[junit4:junit4]   2> 5578 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x66 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5592 T13 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:64001/solr/collection1/
[junit4:junit4]   2> 5593 T13 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 5601 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x6f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5712 T35 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5723 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310002 type:create cxid:0x77 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 5758 T34 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5814 T13 oasc.ZkController.register We are http://127.0.0.1:64001/solr/collection1/ and leader is http://127.0.0.1:64001/solr/collection1/
[junit4:junit4]   2> 5817 T13 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:64001/solr
[junit4:junit4]   2> 5818 T13 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 5821 T13 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5822 T13 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1
[junit4:junit4]   2> 5822 T13 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5870 T13 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5888 T13 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 5891 T13 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:61047
[junit4:junit4]   2> 5891 T13 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5892 T13 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 5892 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 5919 T13 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 5919 T13 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5920 T13 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 5920 T13 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 5921 T13 oasc.CoreContainer.<init> New CoreContainer 259937031
[junit4:junit4]   2> 5921 T13 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 5922 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 5945 T13 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5958 T13 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35084/solr
[junit4:junit4]   2> 5959 T13 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35084/solr sessionTimeout=8000 watcher=org.apache.solr.common.cloud.ConnectionManager@247cb66a
[junit4:junit4]   2> 5960 T47 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35084
[junit4:junit4]   2> 5960 T13 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5962 T47 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35084, initiating session
[junit4:junit4]   2> 5962 T15 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:61294
[junit4:junit4]   2> 5963 T15 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:61294
[junit4:junit4]   2> 5965 T18 oazs.NIOServerCnxn.finishSessionInit Established session 0x139bc868b310003 with negotiated timeout 8000 for client /140.211.11.196:61294
[junit4:junit4]   2> 5965 T47 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35084, sessionid = 0x139bc868b310003, negotiated timeout = 8000
[junit4:junit4]   2> 5966 T48 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@247cb66a name:ZooKeeperConnection Watcher:127.0.0.1:35084/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5967 T13 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5968 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5976 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5978 T13 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61047_solr
[junit4:junit4]   2> 5979 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:61047_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:61047_solr
[junit4:junit4]   2> 5980 T13 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:61047_solr
[junit4:junit4]   2> 5984 T34 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 5985 T13 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5985 T13 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5986 T13 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5986 T13 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5987 T13 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5987 T13 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5988 T13 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5988 T13 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5988 T13 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5989 T13 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 6016 T13 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 6023 T13 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 6024 T13 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 6025 T13 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 6025 T13 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 6027 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 6028 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 6029 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 6126 T13 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_40
[junit4:junit4]   2> 6193 T13 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 6270 T35 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6284 T34 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6294 T48 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6294 T13 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 6332 T13 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 6912 T13 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 6924 T13 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 6927 T13 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 6952 T13 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 6958 T13 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 6963 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 6967 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 6971 T13 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty1/
[junit4:junit4]   2> 6972 T13 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6477eb97
[junit4:junit4]   2> 6973 T13 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty1/index/
[junit4:junit4]   2> 6974 T13 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 6975 T13 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty1/index forceNew:false
[junit4:junit4]   2> 6980 T13 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty1/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@41f2e41d; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6981 T13 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 6982 T13 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 6984 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 6985 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 6986 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 6987 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 6987 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 6988 T13 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 6989 T13 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 6989 T13 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 6990 T13 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 6991 T13 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 6992 T13 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 6993 T13 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 6994 T13 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 6994 T13 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 6995 T13 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 6996 T13 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 6997 T13 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6999 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7000 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7002 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7003 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7004 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7006 T13 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7007 T13 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 7008 T13 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 7013 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 7018 T13 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 7020 T13 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 7024 T13 oass.SolrIndexSearcher.<init> Opening Searcher@29578426 main
[junit4:junit4]   2> 7025 T13 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 7025 T13 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 7027 T13 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 7032 T13 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 7087 T49 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@29578426 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 7294 T35 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7307 T34 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7307 T48 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7599 T13 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 7600 T13 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:61047/solr shardId:shard1
[junit4:junit4]   2> 7601 T13 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 7634 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310003 type:delete cxid:0x43 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders
[junit4:junit4]   2> 7636 T13 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process. afterExpiration=false
[junit4:junit4]   2> 7637 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7645 T13 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:61047/solr/collection1/
[junit4:junit4]   2> 7646 T13 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 7652 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310003 type:create cxid:0x4d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7823 T35 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7843 T34 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7843 T48 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7866 T13 oasc.ZkController.register We are http://127.0.0.1:61047/solr/collection1/ and leader is http://127.0.0.1:61047/solr/collection1/
[junit4:junit4]   2> 7866 T13 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:61047/solr
[junit4:junit4]   2> 7867 T13 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 7870 T13 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7871 T13 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1
[junit4:junit4]   2> 7872 T13 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 7873 T13 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 7894 T13 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 7897 T13 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:17556
[junit4:junit4]   2> 7898 T13 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 7898 T13 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 7899 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 7951 T13 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 7951 T13 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 7952 T13 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 7952 T13 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 7953 T13 oasc.CoreContainer.<init> New CoreContainer 1259174124
[junit4:junit4]   2> 7954 T13 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 7955 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 7990 T13 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 8011 T13 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35084/solr
[junit4:junit4]   2> 8012 T13 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35084/solr sessionTimeout=8000 watcher=org.apache.solr.common.cloud.ConnectionManager@143b9a5f
[junit4:junit4]   2> 8013 T59 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35084
[junit4:junit4]   2> 8013 T13 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 8015 T59 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35084, initiating session
[junit4:junit4]   2> 8015 T15 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:50407
[junit4:junit4]   2> 8016 T15 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:50407
[junit4:junit4]   2> 8018 T18 oazs.NIOServerCnxn.finishSessionInit Established session 0x139bc868b310004 with negotiated timeout 8000 for client /140.211.11.196:50407
[junit4:junit4]   2> 8018 T59 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35084, sessionid = 0x139bc868b310004, negotiated timeout = 8000
[junit4:junit4]   2> 8018 T60 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@143b9a5f name:ZooKeeperConnection Watcher:127.0.0.1:35084/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 8019 T13 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 8020 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 8022 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 8030 T13 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:17556_solr
[junit4:junit4]   2> 8031 T20 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139bc868b310004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:17556_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:17556_solr
[junit4:junit4]   2> 8032 T13 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:17556_solr
[junit4:junit4]   2> 8041 T34 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 8041 T48 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 8043 T13 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 8043 T13 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 8044 T13 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 8045 T13 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 8045 T13 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 8046 T13 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 8047 T13 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 8047 T13 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 8048 T13 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 8049 T13 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 8064 T13 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 8073 T13 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 8074 T13 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 8075 T13 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 8076 T13 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 8078 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 8080 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 8081 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 8159 T13 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_40
[junit4:junit4]   2> 8254 T13 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 8355 T13 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 8358 T35 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 8375 T34 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 8375 T60 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 8375 T48 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 8404 T13 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 9188 T13 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 9206 T13 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 9211 T13 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 9256 T13 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 9264 T13 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 9271 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 9274 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 9278 T13 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty2/
[junit4:junit4]   2> 9279 T13 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6477eb97
[junit4:junit4]   2> 9281 T13 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty2/index/
[junit4:junit4]   2> 9282 T13 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 9284 T13 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty2/index forceNew:false
[junit4:junit4]   2> 9297 T13 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty2/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@54563cc2; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 9297 T13 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 9299 T13 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 9303 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 9304 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 9304 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 9305 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 9307 T13 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 9308 T13 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 9309 T13 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 9310 T13 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 9312 T13 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 9313 T13 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 9314 T13 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 9315 T13 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 9316 T13 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 9317 T13 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 9318 T13 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 9319 T13 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 9321 T13 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9322 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9323 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9324 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9326 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9327 T13 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9328 T13 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9329 T13 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 9331 T13 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 9337 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 9343 T13 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 9345 T13 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 9352 T13 oass.SolrIndexSearcher.<init> Opening Searcher@1391f61c main
[junit4:junit4]   2> 9354 T13 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 9354 T13 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 9356 T13 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 9366 T13 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 9420 T61 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1391f61c main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 9888 T35 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 9903 T34 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 9903 T48 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 9903 T60 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 9936 T13 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 9936 T13 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:17556/solr shardId:shard1
[junit4:junit4]   2> 9941 T13 oasc.ZkController.register We are http://127.0.0.1:17556/solr/collection1/ and leader is http://127.0.0.1:61047/solr/collection1/
[junit4:junit4]   2> 9942 T13 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:17556/solr
[junit4:junit4]   2> 9942 T13 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 9943 T13 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@6ef7cbcc url=http://127.0.0.1:17556/solr/collection1 node=127.0.0.1:17556_solr
[junit4:junit4]   2> 9951 T62 C1 P17556 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 9951 T13 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 9952 T62 C1 P17556 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 9953 T13 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1
[junit4:junit4]   2> 9953 T13 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 9954 T62 C1 P17556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 9954 T13 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 9978 T13 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35084/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@6531767b
[junit4:junit4]   2> 9979 T63 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35084
[junit4:junit4]   2> 9979 T13 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 9980 T63 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35084, initiating session
[junit4:junit4]   2> 9981 T15 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:60691
[junit4:junit4]   2> 9981 T15 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:60691
[junit4:junit4]   2> 9984 T18 oazs.NIOServerCnxn.finishSessionInit Established session 0x139bc868b310005 with negotiated timeout 10000 for client /140.211.11.196:60691
[junit4:junit4]   2> 9984 T63 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35084, sessionid = 0x139bc868b310005, negotiated timeout = 10000
[junit4:junit4]   2> 9985 T64 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6531767b name:ZooKeeperConnection Watcher:127.0.0.1:35084/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 9985 T13 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 9987 T13 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 10000 T13 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 10005 T13 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 10016 T13 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 10409 T35 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 10424 T60 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 10424 T34 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 10424 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 10424 T48 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> ASYNC  NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@6df5205c url=http://127.0.0.1:64001/solr/collection1 node=127.0.0.1:64001_solr
[junit4:junit4]   2> 11352 T27 C2 P64001 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347487697171/control/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@5c09036e; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 11353 T27 C2 P64001 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 11393 T27 C2 P64001 /update {wt=javabin&version=2} {add=[1 (1412943271440678912)]} 0 90
[junit4:junit4]   2> 11393 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10001 (1412943271440678913)]} 0 90
[junit4:junit4]   2> 11582 T66 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35084/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@602f892f
[junit4:junit4]   2> 11583 T67 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35084
[junit4:junit4]   2> 11583 T66 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 11584 T67 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35084, initiating session
[junit4:junit4]   2> 11585 T15 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:60785
[junit4:junit4]   2> 11586 T15 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:60785
[junit4:junit4]   2> 11587 T18 oazs.NIOServerCnxn.finishSessionInit Established session 0x139bc868b310006 with negotiated timeout 10000 for client /140.211.11.196:60785
[junit4:junit4]   2> 11588 T67 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35084, sessionid = 0x139bc868b310006, negotiated timeout = 10000
[junit4:junit4]   2> 11588 T68 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@602f892f name:ZooKeeperConnection Watcher:127.0.0.1:35084/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 11589 T66 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 11590 T66 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C3 name=collection1 org.apache.solr.core.SolrCore@7096985e url=http://127.0.0.1:61047/solr/collection1 node=127.0.0.1:61047_solr
[junit4:junit4]   2> 11642 T42 C3 P61047 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty1/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@41f2e41d; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 11643 T42 C3 P61047 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2>  C1_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=recovering, core=collection1, collection=collection1, node_name=127.0.0.1:17556_solr, base_url=http://127.0.0.1:17556/solr}
[junit4:junit4]   2> 11718 T53 C1 P17556 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347487697171/jetty2/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@54563cc2; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 11719 T53 C1 P17556 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 11726 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=15 
[junit4:junit4]   2> 11727 T41 C3 P61047 /update {wt=javabin&version=2} {add=[1 (1412943271744765952)]} 0 90
[junit4:junit4]   2> 11728 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=17 
[junit4:junit4]   2> 11729 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10001 (1412943271743717376)]} 0 104
[junit4:junit4]   2> 11735 T27 C2 P64001 /update {wt=javabin&version=2} {add=[2 (1412943271843332096)]} 0 3
[junit4:junit4]   2> 11737 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10002 (1412943271845429248)]} 0 3
[junit4:junit4]   2> 11750 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 11751 T42 C3 P61047 /update {wt=javabin&version=2} {add=[2 (1412943271850672128)]} 0 12
[junit4:junit4]   2> 11755 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 11756 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10002 (1412943271853817856)]} 0 15
[junit4:junit4]   2> 11758 T26 C2 P64001 /update {wt=javabin&version=2} {add=[3 (1412943271867449344)]} 0 3
[junit4:junit4]   2> 11763 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10003 (1412943271872692224)]} 0 4
[junit4:junit4]   2> 11771 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 11772 T41 C3 P61047 /update {wt=javabin&version=2} {add=[3 (1412943271874789376)]} 0 10
[junit4:junit4]   2> 11776 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 11777 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10003 (1412943271880032256)]} 0 11
[junit4:junit4]   2> 11778 T27 C2 P64001 /update {wt=javabin&version=2} {add=[4 (1412943271889469440)]} 0 3
[junit4:junit4]   2> 11784 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10004 (1412943271894712320)]} 0 3
[junit4:junit4]   2> 11792 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 11793 T42 C3 P61047 /update {wt=javabin&version=2} {add=[4 (1412943271896809472)]} 0 11
[junit4:junit4]   2> 11803 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[2 (-1412943271917780992)]} 0 6
[junit4:junit4]   2> 11804 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=10 
[junit4:junit4]   2> 11805 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10004 (1412943271902052352)]} 0 17
[junit4:junit4]   2> 11809 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10002 (-1412943271924072448)]} 0 1
[junit4:junit4]   2> 11817 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 11817 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 11818 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[2 (-1412943271923023872)]} 0 11
[junit4:junit4]   2> 11818 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10002 (-1412943271928266752)]} 0 6
[junit4:junit4]   2> 11824 T26 C2 P64001 /update {wt=javabin&version=2} {add=[5 (1412943271937703936)]} 0 3
[junit4:junit4]   2> 11860 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=22 
[junit4:junit4]   2> 11861 T41 C3 P61047 /update {wt=javabin&version=2} {add=[5 (1412943271945043968)]} 0 32
[junit4:junit4]   2> 11865 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[3 (-1412943271982792704)]} 0 1
[junit4:junit4]   2> 11872 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 11873 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[3 (-1412943271986987008)]} 0 5
[junit4:junit4]   2> 11880 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10005 (1412943271937703937)]} 0 58
[junit4:junit4]   2> 11881 T26 C2 P64001 /update {wt=javabin&version=2} {add=[6 (1412943271995375616)]} 0 5
[junit4:junit4]   2> 11909 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 11911 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=17 
[junit4:junit4]   2> 11911 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10005 (1412943272002715648)]} 0 27
[junit4:junit4]   2> 11912 T42 C3 P61047 /update {wt=javabin&version=2} {add=[6 (1412943272004812800)]} 0 27
[junit4:junit4]   2> 11916 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10003 (-1412943272036270080)]} 0 0
[junit4:junit4]   2> 11920 T27 C2 P64001 /update {wt=javabin&version=2} {add=[7 (1412943272037318656)]} 0 3
[junit4:junit4]   2> 11924 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 11925 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10003 (-1412943272041512960)]} 0 4
[junit4:junit4]   2> 11933 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 11933 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10006 (1412943272050950144)]} 0 3
[junit4:junit4]   2> 11934 T41 C3 P61047 /update {wt=javabin&version=2} {add=[7 (1412943272044658688)]} 0 11
[junit4:junit4]   2> 11941 T27 C2 P64001 /update {wt=javabin&version=2} {add=[8 (1412943272059338752)]} 0 3
[junit4:junit4]   2> 11948 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 11949 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10006 (1412943272059338752)]} 0 12
[junit4:junit4]   2> 11955 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 11956 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10007 (1412943272076115968)]} 0 3
[junit4:junit4]   2> 11957 T41 C3 P61047 /update {wt=javabin&version=2} {add=[8 (1412943272066678784)]} 0 12
[junit4:junit4]   2> 11964 T27 C2 P64001 /update {wt=javabin&version=2} {add=[9 (1412943272083456000)]} 0 3
[junit4:junit4]   2> 11973 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 11975 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10007 (1412943272084504576)]} 0 14
[junit4:junit4]   2> 11977 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 11978 T41 C3 P61047 /update {wt=javabin&version=2} {add=[9 (1412943272090796032)]} 0 11
[junit4:junit4]   2> 11983 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10008 (1412943272103378944)]} 0 3
[junit4:junit4]   2> 11983 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[4 (-1412943272105476096)]} 0 1
[junit4:junit4]   2> 11992 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 11993 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[4 (-1412943272111767552)]} 0 5
[junit4:junit4]   2> 11998 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 11999 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10008 (1412943272110718976)]} 0 13
[junit4:junit4]   2> 12003 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10 (1412943272123301888)]} 0 5
[junit4:junit4]   2> 12006 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10009 (1412943272127496192)]} 0 3
[junit4:junit4]   2> 12019 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12021 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10 (1412943272132739072)]} 0 13
[junit4:junit4]   2> 12022 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12023 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10009 (1412943272135884800)]} 0 13
[junit4:junit4]   2> 12025 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[5 (-1412943272150564864)]} 0 0
[junit4:junit4]   2> 12028 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10004 (-1412943272153710592)]} 0 0
[junit4:junit4]   2> 12033 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12034 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[5 (-1412943272154759168)]} 0 5
[junit4:junit4]   2> 12037 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12038 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10004 (-1412943272158953472)]} 0 5
[junit4:junit4]   2> 12046 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10010 (1412943272168390656)]} 0 5
[junit4:junit4]   2> 12061 T26 C2 P64001 /update {wt=javabin&version=2} {add=[11 (1412943272165244928)]} 0 22
[junit4:junit4]   2> 12088 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 12089 T42 C3 P61047 /update {wt=javabin&version=2} {add=[11 (1412943272194605056)]} 0 23
[junit4:junit4]   2> 12094 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[6 (-1412943272222916608)]} 0 0
[junit4:junit4]   2> 12103 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=32 
[junit4:junit4]   2> 12103 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12104 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[6 (-1412943272228159488)]} 0 6
[junit4:junit4]   2> 12104 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10010 (1412943272177827840)]} 0 53
[junit4:junit4]   2> 12109 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10005 (-1412943272238645248)]} 0 0
[junit4:junit4]   2> 12113 T26 C2 P64001 /update {wt=javabin&version=2} {add=[12 (1412943272238645249)]} 0 4
[junit4:junit4]   2> 12116 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12117 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10005 (-1412943272242839552)]} 0 4
[junit4:junit4]   2> 12125 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10011 (1412943272251228160)]} 0 4
[junit4:junit4]   2> 12126 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12127 T42 C3 P61047 /update {wt=javabin&version=2} {add=[12 (1412943272247033856)]} 0 11
[junit4:junit4]   2> 12137 T26 C2 P64001 /update {wt=javabin&version=2} {add=[13 (1412943272263811072)]} 0 5
[junit4:junit4]   2> 12141 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12142 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10011 (1412943272260665344)]} 0 13
[junit4:junit4]   2> 12146 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10006 (-1412943272277442560)]} 0 0
[junit4:junit4]   2> 12153 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12154 T42 C3 P61047 /update {wt=javabin&version=2} {add=[13 (1412943272273248256)]} 0 13
[junit4:junit4]   2> 12154 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12155 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10006 (-1412943272282685440)]} 0 4
[junit4:junit4]   2> 12158 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[13 (-1412943272290025472)]} 0 1
[junit4:junit4]   2> 12161 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10012 (1412943272291074048)]} 0 3
[junit4:junit4]   2> 12165 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12166 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[13 (-1412943272294219776)]} 0 5
[junit4:junit4]   2> 12172 T27 C2 P64001 /update {wt=javabin&version=2} {add=[14 (1412943272302608384)]} 0 3
[junit4:junit4]   2> 12174 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12175 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10012 (1412943272298414080)]} 0 9
[junit4:junit4]   2> 12182 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10013 (1412943272313094144)]} 0 3
[junit4:junit4]   2> 12184 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12185 T41 C3 P61047 /update {wt=javabin&version=2} {add=[14 (1412943272308899840)]} 0 9
[junit4:junit4]   2> 12190 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[14 (-1412943272323579904)]} 0 0
[junit4:junit4]   2> 12194 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12195 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10013 (1412943272320434176)]} 0 9
[junit4:junit4]   2> 12198 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12199 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[14 (-1412943272327774208)]} 0 6
[junit4:junit4]   2> 12201 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10013 (-1412943272334065664)]} 0 1
[junit4:junit4]   2> 12209 T26 C2 P64001 /update {wt=javabin&version=2} {add=[15 (1412943272338259968)]} 0 6
[junit4:junit4]   2> 12209 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12211 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10013 (-1412943272339308544)]} 0 7
[junit4:junit4]   2> 12218 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10014 (1412943272349794304)]} 0 3
[junit4:junit4]   2> 12224 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 12226 T42 C3 P61047 /update {wt=javabin&version=2} {add=[15 (1412943272347697152)]} 0 14
[junit4:junit4]   2> 12230 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[15 (-1412943272365522944)]} 0 0
[junit4:junit4]   2> 12233 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12235 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10014 (1412943272358182912)]} 0 12
[junit4:junit4]   2> 12238 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12239 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10014 (-1412943272374960128)]} 0 0
[junit4:junit4]   2> 12240 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[15 (-1412943272370765824)]} 0 5
[junit4:junit4]   2> 12248 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12250 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10014 (-1412943272380203008)]} 0 6
[junit4:junit4]   2> 12258 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10015 (1412943272390688768)]} 0 4
[junit4:junit4]   2> 12270 T26 C2 P64001 /update {wt=javabin&version=2} {add=[16 (1412943272381251584)]} 0 26
[junit4:junit4]   2> 12289 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 12290 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10015 (1412943272401174528)]} 0 27
[junit4:junit4]   2> 12295 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10015 (-1412943272432631808)]} 0 1
[junit4:junit4]   2> 12302 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12303 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10015 (-1412943272437874688)]} 0 5
[junit4:junit4]   2> 12303 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=22 
[junit4:junit4]   2> 12305 T42 C3 P61047 /update {wt=javabin&version=2} {add=[16 (1412943272411660288)]} 0 32
[junit4:junit4]   2> 12311 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10016 (1412943272446263296)]} 0 4
[junit4:junit4]   2> 12313 T27 C2 P64001 /update {wt=javabin&version=2} {add=[17 (1412943272448360448)]} 0 5
[junit4:junit4]   2> 12325 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12326 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10016 (1412943272455700480)]} 0 11
[junit4:junit4]   2> 12327 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 12328 T41 C3 P61047 /update {wt=javabin&version=2} {add=[17 (1412943272456749056)]} 0 12
[junit4:junit4]   2> 12332 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10017 (1412943272470380544)]} 0 3
[junit4:junit4]   2> 12335 T26 C2 P64001 /update {wt=javabin&version=2} {add=[18 (1412943272472477696)]} 0 4
[junit4:junit4]   2> 12343 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12344 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10017 (1412943272476672000)]} 0 9
[junit4:junit4]   2> 12348 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12350 T42 C3 P61047 /update {wt=javabin&version=2} {add=[18 (1412943272480866304)]} 0 11
[junit4:junit4]   2> 12352 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10018 (1412943272490303488)]} 0 4
[junit4:junit4]   2> 12356 T27 C2 P64001 /update {wt=javabin&version=2} {add=[19 (1412943272495546368)]} 0 3
[junit4:junit4]   2> 12367 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12368 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10018 (1412943272498692096)]} 0 12
[junit4:junit4]   2> 12368 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12370 T41 C3 P61047 /update {wt=javabin&version=2} {add=[19 (1412943272501837824)]} 0 11
[junit4:junit4]   2> 12374 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10019 (1412943272514420736)]} 0 2
[junit4:junit4]   2> 12377 T26 C2 P64001 /update {wt=javabin&version=2} {add=[20 (1412943272516517888)]} 0 3
[junit4:junit4]   2> 12386 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12388 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10019 (1412943272520712192)]} 0 11
[junit4:junit4]   2> 12392 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12393 T42 C3 P61047 /update {wt=javabin&version=2} {add=[20 (1412943272524906496)]} 0 11
[junit4:junit4]   2> 12397 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[19 (-1412943272540635136)]} 0 0
[junit4:junit4]   2> 12406 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12407 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[19 (-1412943272544829440)]} 0 7
[junit4:junit4]   2> 12414 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10020 (1412943272535392256)]} 0 22
[junit4:junit4]   2> 12415 T27 C2 P64001 /update {wt=javabin&version=2} {add=[21 (1412943272555315200)]} 0 5
[junit4:junit4]   2> 12442 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12443 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10020 (1412943272562655232)]} 0 25
[junit4:junit4]   2> 12448 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10019 (-1412943272594112512)]} 0 0
[junit4:junit4]   2> 12450 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=21 
[junit4:junit4]   2> 12451 T41 C3 P61047 /update {wt=javabin&version=2} {add=[21 (1412943272563703808)]} 0 32
[junit4:junit4]   2> 12456 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[21 (-1412943272602501120)]} 0 0
[junit4:junit4]   2> 12456 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12458 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10019 (-1412943272598306816)]} 0 6
[junit4:junit4]   2> 12463 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12464 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10021 (1412943272608792576)]} 0 3
[junit4:junit4]   2> 12465 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[21 (-1412943272606695424)]} 0 6
[junit4:junit4]   2> 12472 T27 C2 P64001 /update {wt=javabin&version=2} {add=[22 (1412943272616132608)]} 0 3
[junit4:junit4]   2> 12480 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12482 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10021 (1412943272616132608)]} 0 13
[junit4:junit4]   2> 12484 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12485 T41 C3 P61047 /update {wt=javabin&version=2} {add=[22 (1412943272623472640)]} 0 9
[junit4:junit4]   2> 12486 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10021 (-1412943272633958400)]} 0 1
[junit4:junit4]   2> 12493 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12494 T26 C2 P64001 /update {wt=javabin&version=2} {add=[23 (1412943272638152704)]} 0 4
[junit4:junit4]   2> 12494 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10021 (-1412943272638152704)]} 0 5
[junit4:junit4]   2> 12501 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10022 (1412943272646541312)]} 0 3
[junit4:junit4]   2> 12505 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12506 T42 C3 P61047 /update {wt=javabin&version=2} {add=[23 (1412943272646541312)]} 0 9
[junit4:junit4]   2> 12510 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[23 (-1412943272659124224)]} 0 0
[junit4:junit4]   2> 12513 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12514 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10022 (1412943272654929920)]} 0 9
[junit4:junit4]   2> 12517 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12518 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[23 (-1412943272663318528)]} 0 5
[junit4:junit4]   2> 12521 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10023 (1412943272667512832)]} 0 3
[junit4:junit4]   2> 12524 T27 C2 P64001 /update {wt=javabin&version=2} {add=[24 (1412943272671707136)]} 0 3
[junit4:junit4]   2> 12533 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12534 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10023 (1412943272675901440)]} 0 9
[junit4:junit4]   2> 12536 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12537 T41 C3 P61047 /update {wt=javabin&version=2} {add=[24 (1412943272677998592)]} 0 10
[junit4:junit4]   2> 12538 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10023 (-1412943272688484352)]} 0 1
[junit4:junit4]   2> 12546 T26 C2 P64001 /update {wt=javabin&version=2} {add=[25 (1412943272692678656)]} 0 4
[junit4:junit4]   2> 12547 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12548 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10023 (-1412943272692678656)]} 0 6
[junit4:junit4]   2> 12556 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10024 (1412943272704212992)]} 0 3
[junit4:junit4]   2> 12558 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12560 T42 C3 P61047 /update {wt=javabin&version=2} {add=[25 (1412943272701067264)]} 0 11
[junit4:junit4]   2> 12569 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12570 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10024 (1412943272711553024)]} 0 11
[junit4:junit4]   2> 12579 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10025 (1412943272727281664)]} 0 4
[junit4:junit4]   2> 12584 T26 C2 P64001 /update {wt=javabin&version=2} {add=[26 (1412943272715747328)]} 0 20
[junit4:junit4]   2> 12607 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 12608 T42 C3 P61047 /update {wt=javabin&version=2} {add=[26 (1412943272743010304)]} 0 19
[junit4:junit4]   2> 12612 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=13 
[junit4:junit4]   2> 12614 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10025 (1412943272735670272)]} 0 31
[junit4:junit4]   2> 12617 T26 C2 P64001 /update {wt=javabin&version=2} {add=[27 (1412943272767127552)]} 0 4
[junit4:junit4]   2> 12620 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10026 (1412943272772370432)]} 0 2
[junit4:junit4]   2> 12628 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12629 T41 C3 P61047 /update {wt=javabin&version=2} {add=[27 (1412943272775516160)]} 0 8
[junit4:junit4]   2> 12635 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12636 T27 C2 P64001 /update {wt=javabin&version=2} {add=[28 (1412943272789147648)]} 0 2
[junit4:junit4]   2> 12636 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10026 (1412943272780759040)]} 0 11
[junit4:junit4]   2> 12644 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10027 (1412943272796487680)]} 0 4
[junit4:junit4]   2> 12649 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12650 T41 C3 P61047 /update {wt=javabin&version=2} {add=[28 (1412943272796487680)]} 0 9
[junit4:junit4]   2> 12654 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[25 (-1412943272810119168)]} 0 1
[junit4:junit4]   2> 12657 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12658 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10027 (1412943272803827712)]} 0 10
[junit4:junit4]   2> 12661 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12662 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[25 (-1412943272814313472)]} 0 5
[junit4:junit4]   2> 12666 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10028 (1412943272819556352)]} 0 3
[junit4:junit4]   2> 12671 T26 C2 P64001 /update {wt=javabin&version=2} {add=[29 (1412943272824799232)]} 0 4
[junit4:junit4]   2> 12677 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12677 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10028 (1412943272826896384)]} 0 7
[junit4:junit4]   2> 12681 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10025 (-1412943272838430720)]} 0 1
[junit4:junit4]   2> 12684 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12685 T42 C3 P61047 /update {wt=javabin&version=2} {add=[29 (1412943272833187840)]} 0 10
[junit4:junit4]   2> 12688 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12689 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10025 (-1412943272842625024)]} 0 5
[junit4:junit4]   2> 12690 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[28 (-1412943272847867904)]} 0 0
[junit4:junit4]   2> 12695 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10029 (1412943272851013632)]} 0 3
[junit4:junit4]   2> 12698 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12699 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[28 (-1412943272853110784)]} 0 4
[junit4:junit4]   2> 12706 T27 C2 P64001 /update {wt=javabin&version=2} {add=[30 (1412943272862547968)]} 0 3
[junit4:junit4]   2> 12708 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12709 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10029 (1412943272857305088)]} 0 10
[junit4:junit4]   2> 12713 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10028 (-1412943272871985152)]} 0 1
[junit4:junit4]   2> 12717 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12718 T41 C3 P61047 /update {wt=javabin&version=2} {add=[30 (1412943272868839424)]} 0 8
[junit4:junit4]   2> 12721 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12722 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[29 (-1412943272881422336)]} 0 1
[junit4:junit4]   2> 12722 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10028 (-1412943272876179456)]} 0 6
[junit4:junit4]   2> 12730 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12732 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[29 (-1412943272885616640)]} 0 6
[junit4:junit4]   2> 12740 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10030 (1412943272886665216)]} 0 15
[junit4:junit4]   2> 12742 T26 C2 P64001 /update {wt=javabin&version=2} {add=[31 (1412943272896102400)]} 0 6
[junit4:junit4]   2> 12774 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12775 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10030 (1412943272906588160)]} 0 30
[junit4:junit4]   2> 12776 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=21 
[junit4:junit4]   2> 12778 T41 C3 P61047 /update {wt=javabin&version=2} {add=[31 (1412943272906588161)]} 0 33
[junit4:junit4]   2> 12780 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10029 (-1412943272942239744)]} 0 0
[junit4:junit4]   2> 12786 T27 C2 P64001 /update {wt=javabin&version=2} {add=[32 (1412943272944336896)]} 0 4
[junit4:junit4]   2> 12789 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 12790 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10029 (-1412943272947482624)]} 0 6
[junit4:junit4]   2> 12799 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10031 (1412943272959016960)]} 0 5
[junit4:junit4]   2> 12804 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 12805 T42 C3 P61047 /update {wt=javabin&version=2} {add=[32 (1412943272952725504)]} 0 16
[junit4:junit4]   2> 12810 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[30 (-1412943272973697024)]} 0 1
[junit4:junit4]   2> 12812 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12814 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10031 (1412943272966356992)]} 0 11
[junit4:junit4]   2> 12819 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12820 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10032 (1412943272982085632)]} 0 3
[junit4:junit4]   2> 12820 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[30 (-1412943272977891328)]} 0 6
[junit4:junit4]   2> 12827 T27 C2 P64001 /update {wt=javabin&version=2} {add=[33 (1412943272989425664)]} 0 3
[junit4:junit4]   2> 12834 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12835 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10032 (1412943272989425664)]} 0 11
[junit4:junit4]   2> 12840 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10030 (-1412943273005154304)]} 0 1
[junit4:junit4]   2> 12840 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12841 T42 C3 P61047 /update {wt=javabin&version=2} {add=[33 (1412943272995717120)]} 0 10
[junit4:junit4]   2> 12848 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12848 T27 C2 P64001 /update {wt=javabin&version=2} {add=[34 (1412943273011445760)]} 0 2
[junit4:junit4]   2> 12849 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10030 (-1412943273009348608)]} 0 6
[junit4:junit4]   2> 12856 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10033 (1412943273019834368)]} 0 3
[junit4:junit4]   2> 12862 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12863 T42 C3 P61047 /update {wt=javabin&version=2} {add=[34 (1412943273018785792)]} 0 10
[junit4:junit4]   2> 12868 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12869 T27 C2 P64001 /update {wt=javabin&version=2} {add=[35 (1412943273033465856)]} 0 3
[junit4:junit4]   2> 12870 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10033 (1412943273026125824)]} 0 10
[junit4:junit4]   2> 12876 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10034 (1412943273040805888)]} 0 3
[junit4:junit4]   2> 12883 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12885 T42 C3 P61047 /update {wt=javabin&version=2} {add=[35 (1412943273039757312)]} 0 13
[junit4:junit4]   2> 12887 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12888 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10034 (1412943273047097344)]} 0 8
[junit4:junit4]   2> 12897 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10035 (1412943273060728832)]} 0 5
[junit4:junit4]   2> 12902 T27 C2 P64001 /update {wt=javabin&version=2} {add=[36 (1412943273056534528)]} 0 14
[junit4:junit4]   2> 12923 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 12924 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10035 (1412943273070166016)]} 0 22
[junit4:junit4]   2> 12927 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=13 
[junit4:junit4]   2> 12928 T42 C3 P61047 /update {wt=javabin&version=2} {add=[36 (1412943273075408896)]} 0 22
[junit4:junit4]   2> 12930 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10036 (1412943273097428992)]} 0 3
[junit4:junit4]   2> 12932 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[36 (-1412943273101623296)]} 0 1
[junit4:junit4]   2> 12939 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12940 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[36 (-1412943273104769024)]} 0 5
[junit4:junit4]   2> 12941 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12942 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10036 (1412943273103720448)]} 0 9
[junit4:junit4]   2> 12946 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10036 (-1412943273115254785)]} 0 1
[junit4:junit4]   2> 12948 T26 C2 P64001 /update {wt=javabin&version=2} {add=[37 (1412943273115254784)]} 0 4
[junit4:junit4]   2> 12953 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12954 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10036 (-1412943273119449088)]} 0 5
[junit4:junit4]   2> 12959 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12960 T41 C3 P61047 /update {wt=javabin&version=2} {add=[37 (1412943273122594816)]} 0 9
[junit4:junit4]   2> 12960 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10037 (1412943273128886272)]} 0 3
[junit4:junit4]   2> 12966 T27 C2 P64001 /update {wt=javabin&version=2} {add=[38 (1412943273135177728)]} 0 3
[junit4:junit4]   2> 12972 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 12973 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10037 (1412943273136226304)]} 0 9
[junit4:junit4]   2> 12976 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12977 T42 C3 P61047 /update {wt=javabin&version=2} {add=[38 (1412943273141469184)]} 0 8
[junit4:junit4]   2> 12978 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10038 (1412943273148809216)]} 0 2
[junit4:junit4]   2> 12981 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[37 (-1412943273153003520)]} 0 1
[junit4:junit4]   2> 12988 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 12989 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[37 (-1412943273157197824)]} 0 5
[junit4:junit4]   2> 12990 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 12991 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10038 (1412943273155100672)]} 0 9
[junit4:junit4]   2> 12995 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10037 (-1412943273166635008)]} 0 1
[junit4:junit4]   2> 12995 T26 C2 P64001 /update {wt=javabin&version=2} {add=[39 (1412943273165586432)]} 0 2
[junit4:junit4]   2> 13002 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13003 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10037 (-1412943273171877888)]} 0 5
[junit4:junit4]   2> 13007 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13008 T41 C3 P61047 /update {wt=javabin&version=2} {add=[39 (1412943273172926464)]} 0 9
[junit4:junit4]   2> 13010 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10039 (1412943273181315072)]} 0 3
[junit4:junit4]   2> 13013 T27 C2 P64001 /update {wt=javabin&version=2} {add=[40 (1412943273185509376)]} 0 2
[junit4:junit4]   2> 13021 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13022 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10039 (1412943273188655104)]} 0 8
[junit4:junit4]   2> 13023 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13024 T42 C3 P61047 /update {wt=javabin&version=2} {add=[40 (1412943273190752256)]} 0 8
[junit4:junit4]   2> 13028 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[40 (-1412943273202286592)]} 0 1
[junit4:junit4]   2> 13036 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13037 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[40 (-1412943273207529472)]} 0 5
[junit4:junit4]   2> 13064 T26 C2 P64001 /update {wt=javabin&version=2} {add=[41 (1412943273215918080)]} 0 24
[junit4:junit4]   2> 13162 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10040 (1412943273201238016)]} 0 136
[junit4:junit4]   2> 13187 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13188 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10040 (1412943273346990080)]} 0 23
[junit4:junit4]   2> 13192 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10040 (-1412943273374253056)]} 0 1
[junit4:junit4]   2> 13198 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13199 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10040 (-1412943273377398784)]} 0 4
[junit4:junit4]   2> 13218 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10041 (1412943273385787392)]} 0 16
[junit4:junit4]   2> 13225 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=54 
[junit4:junit4]   2> 13226 T42 C3 P61047 /update {wt=javabin&version=2} {add=[41 (1412943273245278208)]} 0 158
[junit4:junit4]   2> 13238 T27 C2 P64001 /update {wt=javabin&version=2} {add=[42 (1412943273414098944)]} 0 9
[junit4:junit4]   2> 13251 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=25 
[junit4:junit4]   2> 13253 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10041 (1412943273405710336)]} 0 32
[junit4:junit4]   2> 13257 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 13258 T42 C3 P61047 /update {wt=javabin&version=2} {add=[42 (1412943273426681856)]} 0 17
[junit4:junit4]   2> 13259 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10042 (1412943273441361920)]} 0 4
[junit4:junit4]   2> 13264 T26 C2 P64001 /update {wt=javabin&version=2} {add=[43 (1412943273447653376)]} 0 1
[junit4:junit4]   2> 13269 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13270 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10042 (1412943273448701952)]} 0 8
[junit4:junit4]   2> 13274 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13274 T41 C3 P61047 /update {wt=javabin&version=2} {add=[43 (1412943273453944832)]} 0 7
[junit4:junit4]   2> 13275 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10043 (1412943273460236288)]} 0 2
[junit4:junit4]   2> 13278 T27 C2 P64001 /update {wt=javabin&version=2} {add=[44 (1412943273463382016)]} 0 1
[junit4:junit4]   2> 13291 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 13292 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10043 (1412943273465479168)]} 0 14
[junit4:junit4]   2> 13293 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 13295 T42 C3 P61047 /update {wt=javabin&version=2} {add=[44 (1412943273468624896)]} 0 13
[junit4:junit4]   2> 13298 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10044 (1412943273484353536)]} 0 2
[junit4:junit4]   2> 13299 T26 C2 P64001 /update {wt=javabin&version=2} {add=[45 (1412943273485402112)]} 0 2
[junit4:junit4]   2> 13307 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13308 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10044 (1412943273488547840)]} 0 7
[junit4:junit4]   2> 13308 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13309 T41 C3 P61047 /update {wt=javabin&version=2} {add=[45 (1412943273490644992)]} 0 7
[junit4:junit4]   2> 13313 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[42 (-1412943273500082177)]} 0 1
[junit4:junit4]   2> 13320 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13321 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[42 (-1412943273504276480)]} 0 4
[junit4:junit4]   2> 13326 T27 C2 P64001 /update {wt=javabin&version=2} {add=[46 (1412943273511616512)]} 0 3
[junit4:junit4]   2> 13354 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10045 (1412943273500082176)]} 0 43
[junit4:junit4]   2> 13358 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=15 
[junit4:junit4]   2> 13359 T41 C3 P61047 /update {wt=javabin&version=2} {add=[46 (1412943273518956544)]} 0 30
[junit4:junit4]   2> 13363 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[45 (-1412943273552510976)]} 0 1
[junit4:junit4]   2> 13366 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 13367 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10045 (1412943273548316672)]} 0 10
[junit4:junit4]   2> 13369 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10042 (-1412943273559851008)]} 0 0
[junit4:junit4]   2> 13370 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13371 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[45 (-1412943273556705280)]} 0 5
[junit4:junit4]   2> 13375 T26 C2 P64001 /update {wt=javabin&version=2} {add=[47 (1412943273564045312)]} 0 2
[junit4:junit4]   2> 13376 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13377 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10042 (-1412943273562996736)]} 0 5
[junit4:junit4]   2> 13382 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10046 (1412943273572433920)]} 0 2
[junit4:junit4]   2> 13384 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13385 T41 C3 P61047 /update {wt=javabin&version=2} {add=[47 (1412943273569288192)]} 0 7
[junit4:junit4]   2> 13390 T26 C2 P64001 /update {wt=javabin&version=2} {add=[48 (1412943273579773952)]} 0 2
[junit4:junit4]   2> 13391 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13392 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10046 (1412943273576628224)]} 0 7
[junit4:junit4]   2> 13396 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10045 (-1412943273587113984)]} 0 1
[junit4:junit4]   2> 13398 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13399 T41 C3 P61047 /update {wt=javabin&version=2} {add=[48 (1412943273586065408)]} 0 6
[junit4:junit4]   2> 13401 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13402 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10045 (-1412943273590259712)]} 0 4
[junit4:junit4]   2> 13404 T26 C2 P64001 /update {wt=javabin&version=2} {add=[49 (1412943273594454016)]} 0 2
[junit4:junit4]   2> 13407 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10047 (1412943273598648320)]} 0 2
[junit4:junit4]   2> 13412 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13413 T42 C3 P61047 /update {wt=javabin&version=2} {add=[49 (1412943273599696896)]} 0 6
[junit4:junit4]   2> 13417 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13418 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10047 (1412943273603891200)]} 0 8
[junit4:junit4]   2> 13418 T27 C2 P64001 /update {wt=javabin&version=2} {add=[50 (1412943273610182656)]} 0 2
[junit4:junit4]   2> 13423 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10048 (1412943273615425536)]} 0 2
[junit4:junit4]   2> 13428 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13429 T41 C3 P61047 /update {wt=javabin&version=2} {add=[50 (1412943273615425536)]} 0 7
[junit4:junit4]   2> 13431 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13432 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10048 (1412943273620668416)]} 0 6
[junit4:junit4]   2> 13432 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[46 (-1412943273625911296)]} 0 0
[junit4:junit4]   2> 13437 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10049 (1412943273630105600)]} 0 1
[junit4:junit4]   2> 13438 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13439 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[46 (-1412943273629057024)]} 0 4
[junit4:junit4]   2> 13446 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13446 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10049 (1412943273635348480)]} 0 6
[junit4:junit4]   2> 13449 T26 C2 P64001 /update {wt=javabin&version=2} {add=[51 (1412943273636397056)]} 0 7
[junit4:junit4]   2> 13452 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10050 (1412943273644785664)]} 0 3
[junit4:junit4]   2> 13464 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13465 T41 C3 P61047 /update {wt=javabin&version=2} {add=[51 (1412943273645834240)]} 0 14
[junit4:junit4]   2> 13465 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 13466 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10050 (1412943273651077120)]} 0 10
[junit4:junit4]   2> 13469 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10046 (-1412943273664708609)]} 0 0
[junit4:junit4]   2> 13470 T27 C2 P64001 /update {wt=javabin&version=2} {add=[52 (1412943273664708608)]} 0 2
[junit4:junit4]   2> 13475 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13476 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10046 (-1412943273667854336)]} 0 4
[junit4:junit4]   2> 13478 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13479 T41 C3 P61047 /update {wt=javabin&version=2} {add=[52 (1412943273669951488)]} 0 6
[junit4:junit4]   2> 13481 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10051 (1412943273675194368)]} 0 2
[junit4:junit4]   2> 13482 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[49 (-1412943273678340096)]} 0 0
[junit4:junit4]   2> 13488 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13488 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[49 (-1412943273681485825)]} 0 3
[junit4:junit4]   2> 13489 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13490 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10051 (1412943273681485824)]} 0 6
[junit4:junit4]   2> 13492 T26 C2 P64001 /update {wt=javabin&version=2} {add=[53 (1412943273687777280)]} 0 1
[junit4:junit4]   2> 13496 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10052 (1412943273690923008)]} 0 3
[junit4:junit4]   2> 13501 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13501 T41 C3 P61047 /update {wt=javabin&version=2} {add=[53 (1412943273691971584)]} 0 6
[junit4:junit4]   2> 13504 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13505 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10052 (1412943273696165888)]} 0 6
[junit4:junit4]   2> 13505 T27 C2 P64001 /update {wt=javabin&version=2} {add=[54 (1412943273701408768)]} 0 1
[junit4:junit4]   2> 13507 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10049 (-1412943273704554496)]} 0 0
[junit4:junit4]   2> 13512 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13513 T42 C3 P61047 /update {wt=javabin&version=2} {add=[54 (1412943273705603072)]} 0 5
[junit4:junit4]   2> 13514 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13514 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10049 (-1412943273707700224)]} 0 4
[junit4:junit4]   2> 13517 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[50 (-1412943273713991680)]} 0 1
[junit4:junit4]   2> 13519 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10053 (1412943273715040256)]} 0 2
[junit4:junit4]   2> 13523 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13523 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[50 (-1412943273717137408)]} 0 4
[junit4:junit4]   2> 13526 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13527 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10053 (1412943273720283136)]} 0 5
[junit4:junit4]   2> 13528 T27 C2 P64001 /update {wt=javabin&version=2} {add=[55 (1412943273725526016)]} 0 2
[junit4:junit4]   2> 13531 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10054 (1412943273728671744)]} 0 1
[junit4:junit4]   2> 13536 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13537 T42 C3 P61047 /update {wt=javabin&version=2} {add=[55 (1412943273729720320)]} 0 6
[junit4:junit4]   2> 13539 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13540 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10054 (1412943273733914624)]} 0 6
[junit4:junit4]   2> 13544 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10050 (-1412943273742303232)]} 0 1
[junit4:junit4]   2> 13545 T26 C2 P64001 /update {wt=javabin&version=2} {add=[56 (1412943273738108928)]} 0 6
[junit4:junit4]   2> 13549 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13550 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10050 (-1412943273745448960)]} 0 4
[junit4:junit4]   2> 13556 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10055 (1412943273753837568)]} 0 3
[junit4:junit4]   2> 13562 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 13562 T42 C3 P61047 /update {wt=javabin&version=2} {add=[56 (1412943273747546112)]} 0 14
[junit4:junit4]   2> 13566 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13567 T26 C2 P64001 /update {wt=javabin&version=2} {add=[57 (1412943273765371904)]} 0 2
[junit4:junit4]   2> 13567 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10055 (1412943273760129024)]} 0 8
[junit4:junit4]   2> 13572 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10056 (1412943273771663360)]} 0 2
[junit4:junit4]   2> 13575 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13576 T42 C3 P61047 /update {wt=javabin&version=2} {add=[57 (1412943273770614784)]} 0 6
[junit4:junit4]   2> 13579 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13580 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[53 (-1412943273780051968)]} 0 1
[junit4:junit4]   2> 13580 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10056 (1412943273775857664)]} 0 5
[junit4:junit4]   2> 13585 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10057 (1412943273784246272)]} 0 2
[junit4:junit4]   2> 13586 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13587 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[53 (-1412943273785294848)]} 0 4
[junit4:junit4]   2> 13592 T26 C2 P64001 /update {wt=javabin&version=2} {add=[58 (1412943273792634880)]} 0 2
[junit4:junit4]   2> 13593 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13594 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10057 (1412943273789489152)]} 0 6
[junit4:junit4]   2> 13596 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10053 (-1412943273797877760)]} 0 0
[junit4:junit4]   2> 13600 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13601 T41 C3 P61047 /update {wt=javabin&version=2} {add=[58 (1412943273797877760)]} 0 6
[junit4:junit4]   2> 13603 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13604 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10053 (-1412943273801023488)]} 0 5
[junit4:junit4]   2> 13605 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[54 (-1412943273806266368)]} 0 1
[junit4:junit4]   2> 13608 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10058 (1412943273808363520)]} 0 2
[junit4:junit4]   2> 13611 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13612 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[54 (-1412943273809412096)]} 0 5
[junit4:junit4]   2> 13616 T27 C2 P64001 /update {wt=javabin&version=2} {add=[59 (1412943273817800704)]} 0 1
[junit4:junit4]   2> 13617 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13618 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10058 (1412943273813606400)]} 0 7
[junit4:junit4]   2> 13622 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10054 (-1412943273824092160)]} 0 1
[junit4:junit4]   2> 13626 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13627 T42 C3 P61047 /update {wt=javabin&version=2} {add=[59 (1412943273823043584)]} 0 7
[junit4:junit4]   2> 13628 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13629 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10054 (-1412943273828286464)]} 0 4
[junit4:junit4]   2> 13629 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[55 (-1412943273832480768)]} 0 0
[junit4:junit4]   2> 13634 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10059 (1412943273836675072)]} 0 2
[junit4:junit4]   2> 13636 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13636 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[55 (-1412943273835626496)]} 0 4
[junit4:junit4]   2> 13641 T26 C2 P64001 /update {wt=javabin&version=2} {add=[60 (1412943273844015104)]} 0 2
[junit4:junit4]   2> 13642 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13643 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10059 (1412943273840869376)]} 0 6
[junit4:junit4]   2> 13647 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10055 (-1412943273850306560)]} 0 1
[junit4:junit4]   2> 13650 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13651 T41 C3 P61047 /update {wt=javabin&version=2} {add=[60 (1412943273848209408)]} 0 7
[junit4:junit4]   2> 13653 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13654 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10055 (-1412943273854500864)]} 0 5
[junit4:junit4]   2> 13660 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10060 (1412943273862889472)]} 0 3
[junit4:junit4]   2> 13663 T26 C2 P64001 /update {wt=javabin&version=2} {add=[61 (1412943273859743744)]} 0 9
[junit4:junit4]   2> 13676 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13677 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10060 (1412943273869180928)]} 0 14
[junit4:junit4]   2> 13681 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=9 
[junit4:junit4]   2> 13681 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10061 (1412943273885958144)]} 0 1
[junit4:junit4]   2> 13682 T41 C3 P61047 /update {wt=javabin&version=2} {add=[61 (1412943273872326656)]} 0 16
[junit4:junit4]   2> 13686 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[56 (-1412943273891201024)]} 0 1
[junit4:junit4]   2> 13690 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13691 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10061 (1412943273891201024)]} 0 7
[junit4:junit4]   2> 13692 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13693 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[56 (-1412943273895395328)]} 0 4
[junit4:junit4]   2> 13694 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10056 (-1412943273900638208)]} 0 0
[junit4:junit4]   2> 13698 T27 C2 P64001 /update {wt=javabin&version=2} {add=[62 (1412943273903783936)]} 0 2
[junit4:junit4]   2> 13699 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13700 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10056 (-1412943273903783936)]} 0 3
[junit4:junit4]   2> 13704 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10062 (1412943273910075392)]} 0 1
[junit4:junit4]   2> 13706 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13707 T42 C3 P61047 /update {wt=javabin&version=2} {add=[62 (1412943273907978240)]} 0 6
[junit4:junit4]   2> 13710 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[57 (-1412943273917415424)]} 0 0
[junit4:junit4]   2> 13712 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13713 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10062 (1412943273915318272)]} 0 6
[junit4:junit4]   2> 13716 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10057 (-1412943273923706880)]} 0 0
[junit4:junit4]   2> 13716 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13717 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[57 (-1412943273920561152)]} 0 4
[junit4:junit4]   2> 13721 T27 C2 P64001 /update {wt=javabin&version=2} {add=[63 (1412943273927901184)]} 0 1
[junit4:junit4]   2> 13722 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13723 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10057 (-1412943273926852608)]} 0 4
[junit4:junit4]   2> 13727 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10063 (1412943273934192640)]} 0 1
[junit4:junit4]   2> 13730 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13731 T42 C3 P61047 /update {wt=javabin&version=2} {add=[63 (1412943273933144064)]} 0 7
[junit4:junit4]   2> 13735 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13735 T27 C2 P64001 /update {wt=javabin&version=2} {add=[64 (1412943273942581248)]} 0 1
[junit4:junit4]   2> 13736 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10063 (1412943273938386944)]} 0 6
[junit4:junit4]   2> 13740 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10064 (1412943273947824128)]} 0 1
[junit4:junit4]   2> 13742 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13743 T41 C3 P61047 /update {wt=javabin&version=2} {add=[64 (1412943273946775552)]} 0 5
[junit4:junit4]   2> 13747 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[58 (-1412943273956212736)]} 0 1
[junit4:junit4]   2> 13756 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13757 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[58 (-1412943273962504192)]} 0 5
[junit4:junit4]   2> 13757 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 13763 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10064 (1412943273953067008)]} 0 20
[junit4:junit4]   2> 13765 T27 C2 P64001 /update {wt=javabin&version=2} {add=[65 (1412943273974038528)]} 0 1
[junit4:junit4]   2> 13767 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10058 (-1412943273977184256)]} 0 0
[junit4:junit4]   2> 13774 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13774 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10058 (-1412943273980329984)]} 0 4
[junit4:junit4]   2> 13775 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 13776 T42 C3 P61047 /update {wt=javabin&version=2} {add=[65 (1412943273979281408)]} 0 8
[junit4:junit4]   2> 13780 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[59 (-1412943273990815744)]} 0 0
[junit4:junit4]   2> 13783 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10065 (1412943273987670016)]} 0 6
[junit4:junit4]   2> 13787 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13788 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[59 (-1412943273995010048)]} 0 5
[junit4:junit4]   2> 13794 T26 C2 P64001 /update {wt=javabin&version=2} {add=[66 (1412943274003398656)]} 0 3
[junit4:junit4]   2> 13805 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 13806 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 13806 T42 C3 P61047 /update {wt=javabin&version=2} {add=[66 (1412943274009690112)]} 0 9
[junit4:junit4]   2> 13807 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10065 (1412943273998155776)]} 0 21
[junit4:junit4]   2> 13810 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10059 (-1412943274022273025)]} 0 0
[junit4:junit4]   2> 13811 T26 C2 P64001 /update {wt=javabin&version=2} {add=[67 (1412943274022273024)]} 0 2
[junit4:junit4]   2> 13817 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13817 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10059 (-1412943274025418752)]} 0 4
[junit4:junit4]   2> 13818 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13819 T42 C3 P61047 /update {wt=javabin&version=2} {add=[67 (1412943274026467328)]} 0 5
[junit4:junit4]   2> 13822 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10066 (1412943274033807360)]} 0 2
[junit4:junit4]   2> 13822 T27 C2 P64001 /update {wt=javabin&version=2} {add=[68 (1412943274033807361)]} 0 1
[junit4:junit4]   2> 13828 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13829 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10066 (1412943274036953088)]} 0 5
[junit4:junit4]   2> 13831 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13832 T41 C3 P61047 /update {wt=javabin&version=2} {add=[68 (1412943274039050240)]} 0 7
[junit4:junit4]   2> 13833 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10067 (1412943274045341696)]} 0 1
[junit4:junit4]   2> 13835 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[60 (-1412943274047438848)]} 0 1
[junit4:junit4]   2> 13841 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13841 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13841 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[60 (-1412943274050584577)]} 0 4
[junit4:junit4]   2> 13842 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10067 (1412943274050584576)]} 0 6
[junit4:junit4]   2> 13845 T26 C2 P64001 /update {wt=javabin&version=2} {add=[69 (1412943274057924608)]} 0 1
[junit4:junit4]   2> 13846 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10068 (1412943274058973184)]} 0 1
[junit4:junit4]   2> 13852 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13853 T41 C3 P61047 /update {wt=javabin&version=2} {add=[69 (1412943274062118912)]} 0 5
[junit4:junit4]   2> 13855 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13855 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[63 (-1412943274069458944)]} 0 0
[junit4:junit4]   2> 13855 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10068 (1412943274064216064)]} 0 6
[junit4:junit4]   2> 13858 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10060 (-1412943274072604672)]} 0 0
[junit4:junit4]   2> 13861 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13861 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[63 (-1412943274072604672)]} 0 3
[junit4:junit4]   2> 13864 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13864 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10060 (-1412943274075750400)]} 0 3
[junit4:junit4]   2> 13865 T27 C2 P64001 /update {wt=javabin&version=2} {add=[70 (1412943274078896128)]} 0 1
[junit4:junit4]   2> 13869 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10069 (1412943274082041856)]} 0 2
[junit4:junit4]   2> 13872 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13873 T41 C3 P61047 /update {wt=javabin&version=2} {add=[70 (1412943274083090432)]} 0 5
[junit4:junit4]   2> 13875 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13876 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10069 (1412943274086236160)]} 0 5
[junit4:junit4]   2> 13878 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10063 (-1412943274093576192)]} 0 0
[junit4:junit4]   2> 13881 T26 C2 P64001 /update {wt=javabin&version=2} {add=[71 (1412943274090430464)]} 0 6
[junit4:junit4]   2> 13883 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13884 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10063 (-1412943274096721920)]} 0 3
[junit4:junit4]   2> 13888 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10070 (1412943274101964800)]} 0 2
[junit4:junit4]   2> 13899 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 13900 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10070 (1412943274108256256)]} 0 8
[junit4:junit4]   2> 13901 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 13902 T41 C3 P61047 /update {wt=javabin&version=2} {add=[71 (1412943274100916224)]} 0 18
[junit4:junit4]   2> 13904 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10071 (1412943274119790592)]} 0 1
[junit4:junit4]   2> 13906 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[64 (-1412943274122936320)]} 0 1
[junit4:junit4]   2> 13912 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13912 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13913 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10071 (1412943274123984896)]} 0 6
[junit4:junit4]   2> 13913 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[64 (-1412943274126082048)]} 0 4
[junit4:junit4]   2> 13917 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10064 (-1412943274134470656)]} 0 1
[junit4:junit4]   2> 13917 T26 C2 P64001 /update {wt=javabin&version=2} {add=[72 (1412943274133422080)]} 0 1
[junit4:junit4]   2> 13923 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 13924 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13924 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10064 (-1412943274137616385)]} 0 4
[junit4:junit4]   2> 13925 T41 C3 P61047 /update {wt=javabin&version=2} {add=[72 (1412943274137616384)]} 0 5
[junit4:junit4]   2> 13928 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10072 (1412943274144956416)]} 0 1
[junit4:junit4]   2> 13930 T27 C2 P64001 /update {wt=javabin&version=2} {add=[73 (1412943274147053568)]} 0 2
[junit4:junit4]   2> 13936 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13937 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10072 (1412943274149150720)]} 0 6
[junit4:junit4]   2> 13938 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13939 T42 C3 P61047 /update {wt=javabin&version=2} {add=[73 (1412943274151247872)]} 0 6
[junit4:junit4]   2> 13942 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10073 (1412943274159636480)]} 0 2
[junit4:junit4]   2> 13943 T26 C2 P64001 /update {wt=javabin&version=2} {add=[74 (1412943274160685056)]} 0 1
[junit4:junit4]   2> 13951 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13951 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13951 T41 C3 P61047 /update {wt=javabin&version=2} {add=[74 (1412943274164879361)]} 0 5
[junit4:junit4]   2> 13952 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10073 (1412943274164879360)]} 0 7
[junit4:junit4]   2> 13955 T26 C2 P64001 /update {wt=javabin&version=2} {add=[75 (1412943274173267968)]} 0 1
[junit4:junit4]   2> 13956 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10074 (1412943274174316544)]} 0 1
[junit4:junit4]   2> 13963 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 13963 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 13964 T42 C3 P61047 /update {wt=javabin&version=2} {add=[75 (1412943274177462272)]} 0 6
[junit4:junit4]   2> 13964 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10074 (1412943274178510848)]} 0 5
[junit4:junit4]   2> 13970 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10075 (1412943274186899457)]} 0 3
[junit4:junit4]   2> 13998 T27 C2 P64001 /update {wt=javabin&version=2} {add=[76 (1412943274186899456)]} 0 32
[junit4:junit4]   2> 14014 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 14016 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10075 (1412943274194239488)]} 0 43
[junit4:junit4]   2> 14021 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10076 (1412943274242473984)]} 0 2
[junit4:junit4]   2> 14028 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=22 
[junit4:junit4]   2> 14029 T42 C3 P61047 /update {wt=javabin&version=2} {add=[76 (1412943274223599616)]} 0 28
[junit4:junit4]   2> 14031 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 14032 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10076 (1412943274247716864)]} 0 8
[junit4:junit4]   2> 14033 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[65 (-1412943274256105472)]} 0 1
[junit4:junit4]   2> 14036 T26 C2 P64001 /update {wt=javabin&version=2} {delete=[10065 (-1412943274259251200)]} 0 1
[junit4:junit4]   2> 14040 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 14041 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[65 (-1412943274259251200)]} 0 5
[junit4:junit4]   2> 14042 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 14043 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[10065 (-1412943274263445504)]} 0 4
[junit4:junit4]   2> 14046 T26 C2 P64001 /update {wt=javabin&version=2} {add=[77 (1412943274267639808)]} 0 2
[junit4:junit4]   2> 14048 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10077 (1412943274270785536)]} 0 2
[junit4:junit4]   2> 14052 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14053 T42 C3 P61047 /update {wt=javabin&version=2} {add=[77 (1412943274271834112)]} 0 5
[junit4:junit4]   2> 14057 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[66 (-1412943274281271296)]} 0 1
[junit4:junit4]   2> 14057 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14059 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10077 (1412943274276028416)]} 0 6
[junit4:junit4]   2> 14063 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10066 (-1412943274286514176)]} 0 1
[junit4:junit4]   2> 14064 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14064 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[66 (-1412943274284417024)]} 0 4
[junit4:junit4]   2> 14069 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 14069 T27 C2 P64001 /update {wt=javabin&version=2} {add=[78 (1412943274292805632)]} 0 2
[junit4:junit4]   2> 14070 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10066 (-1412943274290708480)]} 0 4
[junit4:junit4]   2> 14075 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10078 (1412943274299097088)]} 0 2
[junit4:junit4]   2> 14077 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14079 T42 C3 P61047 /update {wt=javabin&version=2} {add=[78 (1412943274298048512)]} 0 6
[junit4:junit4]   2> 14083 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[67 (-1412943274308534272)]} 0 1
[junit4:junit4]   2> 14085 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 14085 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10078 (1412943274304339968)]} 0 6
[junit4:junit4]   2> 14089 T27 C2 P64001 /update {wt=javabin&version=2} {delete=[10067 (-1412943274313777152)]} 0 1
[junit4:junit4]   2> 14090 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14090 T42 C3 P61047 /update {wt=javabin&version=2} {delete=[67 (-1412943274311680000)]} 0 4
[junit4:junit4]   2> 14095 T27 C2 P64001 /update {wt=javabin&version=2} {add=[79 (1412943274320068608)]} 0 2
[junit4:junit4]   2> 14096 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 14097 T41 C3 P61047 /update {wt=javabin&version=2} {delete=[10067 (-1412943274317971456)]} 0 5
[junit4:junit4]   2> 14103 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10079 (1412943274327408640)]} 0 3
[junit4:junit4]   2> 14104 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14105 T42 C3 P61047 /update {wt=javabin&version=2} {add=[79 (1412943274326360064)]} 0 6
[junit4:junit4]   2> 14110 T27 C2 P64001 /update {wt=javabin&version=2} {add=[80 (1412943274335797248)]} 0 2
[junit4:junit4]   2> 14111 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14112 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10079 (1412943274333700096)]} 0 6
[junit4:junit4]   2> 14120 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 14121 T42 C3 P61047 /update {wt=javabin&version=2} {add=[80 (1412943274342088704)]} 0 7
[junit4:junit4]   2> 14128 T26 C2 P64001 /update {wt=javabin&version=2} {add=[81 (1412943274352574464)]} 0 4
[junit4:junit4]   2> 14129 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10080 (1412943274343137280)]} 0 14
[junit4:junit4]   2> 14146 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 14147 T42 C3 P61047 /update {wt=javabin&version=2} {add=[81 (1412943274359914496)]} 0 16
[junit4:junit4]   2> 14148 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 14149 T41 C3 P61047 /update {wt=javabin&version=2} {add=[10080 (1412943274362011648)]} 0 16
[junit4:junit4]   2> 14152 T27 C2 P64001 /update {wt=javabin&version=2} {add=[82 (1412943274379837440)]} 0 2
[junit4:junit4]   2> 14153 T26 C2 P64001 /update {wt=javabin&version=2} {add=[10081 (1412943274380886016)]} 0 2
[junit4:junit4]   2> 14161 T52 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14162 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 14162 T41 C3 P61047 /update {wt=javabin&version=2} {add=[82 (1412943274386128896)]} 0 6
[junit4:junit4]   2> 14163 T42 C3 P61047 /update {wt=javabin&version=2} {add=[10081 (1412943274386128897)]} 0 7
[junit4:junit4]   2> 14167 T26 C2 P64001 /update {wt=javabin&version=2} {add=[83 (1412943274395566080)]} 0 1
[junit4:junit4]   2> 14169 T27 C2 P64001 /update {wt=javabin&version=2} {add=[10082 (1412943274396614656)]} 0 2
[junit4:junit4]   2> 14176 T53 C1 P17556 REQ /update {distrib.from=http://127.0.0.1:61047/solr/collection1/&update.distrib=FROMLEADER&wt=ja

[...truncated too long message...]

 61047
[junit4:junit4]   2> 35292 T13 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=259937031
[junit4:junit4]   2> 35293 T13 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7096985e
[junit4:junit4]   2> 35299 T13 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 35301 T13 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2303,cumulative_deletesById=1102,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 35302 T13 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 35304 T13 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 36509 T47 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:35084
[junit4:junit4]   2> 36837 T16 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4]   2> 36892 T145 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:35084
[junit4:junit4]   2> 43240 T145 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 8001ms for sessionid 0x139bc868b310007, closing socket connection and attempting reconnect
[junit4:junit4]   2> 43340 T48 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 43340 T13 oaz.ZooKeeper.close Session: 0x139bc868b310003 closed
[junit4:junit4]   2> 43342 T13 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 43395 T13 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 17556
[junit4:junit4]   2> 43395 T13 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=931422537
[junit4:junit4]   2> 44933 T145 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:35084
[junit4:junit4]   2> 51443 T146 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 51443 T13 oaz.ZooKeeper.close Session: 0x139bc868b310007 closed
[junit4:junit4]   2> 51444 T13 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 51585 T13 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=AC8053E3566AD2D9 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en_NZ -Dtests.timezone=Africa/Abidjan -Dtests.file.encoding=US-ASCII
[junit4:junit4] ERROR   51.7s J1 | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.common.SolrException: Server at http://localhost:17556/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([AC8053E3566AD2D9:2D66DDFB2135B2E5]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:373)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:182)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:324)
[junit4:junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:691)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:616)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]   2> 51682 T13 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Asserting, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=en_NZ, timezone=Africa/Abidjan
[junit4:junit4]   2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=1,free=125698880,total=258539520
[junit4:junit4]   2> NOTE: All tests run in this JVM: [DocumentBuilderTest, RecoveryZkTest]
[junit4:junit4] Completed on J1 in 51.93s, 1 test, 1 error <<< FAILURES!

[...truncated 653 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/build.xml:29: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build.xml:146: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/module-build.xml:63: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/common-build.xml:1133: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/common-build.xml:810: There were test failures: 229 suites, 926 tests, 1 error, 6 ignored (1 assumption)

Total time: 31 minutes 42 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message