Return-Path: X-Original-To: apmail-lucene-dev-archive@www.apache.org Delivered-To: apmail-lucene-dev-archive@www.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id 05816DD2A for ; Sun, 16 Sep 2012 00:09:46 +0000 (UTC) Received: (qmail 71857 invoked by uid 500); 16 Sep 2012 00:09:44 -0000 Delivered-To: apmail-lucene-dev-archive@lucene.apache.org Received: (qmail 71803 invoked by uid 500); 16 Sep 2012 00:09:44 -0000 Mailing-List: contact dev-help@lucene.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@lucene.apache.org Delivered-To: mailing list dev@lucene.apache.org Received: (qmail 71724 invoked by uid 99); 16 Sep 2012 00:09:44 -0000 Received: from nike.apache.org (HELO nike.apache.org) (192.87.106.230) by apache.org (qpsmtpd/0.29) with ESMTP; Sun, 16 Sep 2012 00:09:44 +0000 X-ASF-Spam-Status: No, hits=-2000.0 required=5.0 tests=ALL_TRUSTED,NORMAL_HTTP_TO_IP,WEIRD_PORT X-Spam-Check-By: apache.org Received: from [140.211.11.8] (HELO aegis.apache.org) (140.211.11.8) by apache.org (qpsmtpd/0.29) with ESMTP; Sun, 16 Sep 2012 00:09:22 +0000 Received: from aegis.apache.org (localhost [127.0.0.1]) by aegis.apache.org (Postfix) with ESMTP id 15A5DC00A0 for ; Sun, 16 Sep 2012 00:09:00 +0000 (UTC) Date: Sun, 16 Sep 2012 00:08:48 +0000 (UTC) From: Apache Jenkins Server To: dev@lucene.apache.org Message-ID: <427568821.403.1347754140073.JavaMail.hudson@aegis.apache.org> In-Reply-To: <858804443.372.1347745603439.JavaMail.hudson@aegis.apache.org> References: <858804443.372.1347745603439.JavaMail.hudson@aegis.apache.org> Subject: [JENKINS] Lucene-Solr-Tests-trunk-Java6 - Build # 15241 - Still Failing MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_402_1355766936.1347754128331" ------=_Part_402_1355766936.1347754128331 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Build: https://builds.apache.org/job/Lucene-Solr-Tests-trunk-Java6/15241/ 1 tests failed. FAILED: org.apache.solr.cloud.BasicDistributedZk2Test.testDistribSearch Error Message: Shard still reported as live in zk Stack Trace: java.lang.AssertionError: Shard still reported as live in zk =09at __randomizedtesting.SeedInfo.seed([942A0A45B338BCA7:15CC845DC467DC9B]= :0) =09at org.junit.Assert.fail(Assert.java:93) =09at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitToSeeNotLive(= AbstractFullDistribZkTestBase.java:1220) =09at org.apache.solr.cloud.BasicDistributedZk2Test.brindDownShardIndexSome= DocsAndRecover(BasicDistributedZk2Test.java:190) =09at org.apache.solr.cloud.BasicDistributedZk2Test.doTest(BasicDistributed= Zk2Test.java:83) =09at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseD= istributedSearchTestCase.java:695) =09at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) =09at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.= java:57) =09at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces= sorImpl.java:43) =09at java.lang.reflect.Method.invoke(Method.java:616) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1559) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(Random= izedRunner.java:79) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:737) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:773) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:787) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:53) =09at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRu= leSetupTeardownChained.java:50) =09at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFi= eldCacheSanity.java:51) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRul= e$1.evaluate(SystemPropertiesInvariantRule.java:55) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:70) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:48) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:358) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTa= sk(ThreadLeakControl.java:782) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(Threa= dLeakControl.java:442) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran= domizedRunner.java:746) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(Random= izedRunner.java:648) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(Random= izedRunner.java:682) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:693) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:53) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStor= eClassName.java:42) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRul= e$1.evaluate(SystemPropertiesInvariantRule.java:55) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRule= AssertionsRequired.java:43) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:70) =09at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIg= noreTestSuites.java:55) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:358) =09at java.lang.Thread.run(Thread.java:679) Build Log: [...truncated 7128 lines...] [junit4:junit4] Suite: org.apache.solr.cloud.BasicDistributedZk2Test [junit4:junit4] 2> 4 T283 oas.SolrTestCaseJ4.setUp ###Starting testDistri= bSearch [junit4:junit4] 2> Creating dataDir: /usr/home/hudson/hudson-slave/worksp= ace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-B= asicDistributedZk2Test-1347753318807 [junit4:junit4] 2> 10 T283 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4:junit4] 2> 160 T284 oaz.Environment.logEnv Server environment:zoo= keeper.version=3D3.3.6-1366786, built on 07/29/2012 06:22 GMT [junit4:junit4] 2> 160 T284 oaz.Environment.logEnv Server environment:hos= t.name=3Dlucene.zones.apache.org [junit4:junit4] 2> 161 T284 oaz.Environment.logEnv Server environment:jav= a.version=3D1.6.0_32 [junit4:junit4] 2> 161 T284 oaz.Environment.logEnv Server environment:jav= a.vendor=3DSun Microsystems Inc. [junit4:junit4] 2> 161 T284 oaz.Environment.logEnv Server environment:jav= a.home=3D/usr/local/openjdk6/jre [junit4:junit4] 2> 161 T284 oaz.Environment.logEnv Server environment:jav= a.class.path=3D/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tr= unk-Java6/solr/build/solr-core/classes/test:/usr/home/hudson/hudson-slave/w= orkspace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-test-framework/class= es/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Jav= a6/solr/build/solr-core/test-files:/usr/home/hudson/hudson-slave/workspace/= Lucene-Solr-Tests-trunk-Java6/lucene/build/codecs/classes/java:/usr/home/hu= dson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/test= -framework/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-trunk-Java6/solr/build/solr-solrj/classes/java:/usr/home/hudson/huds= on-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/class= es/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Jav= a6/lucene/build/analysis/common/lucene-analyzers-common-5.0-SNAPSHOT.jar:/u= sr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/= build/analysis/kuromoji/lucene-analyzers-kuromoji-5.0-SNAPSHOT.jar:/usr/hom= e/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/= analysis/phonetic/lucene-analyzers-phonetic-5.0-SNAPSHOT.jar:/usr/home/huds= on/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/highli= ghter/lucene-highlighter-5.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/wor= kspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/memory/lucene-memory-5.0-= SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trun= k-Java6/lucene/build/misc/lucene-misc-5.0-SNAPSHOT.jar:/usr/home/hudson/hud= son-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/spatial/luce= ne-spatial-5.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-= Solr-Tests-trunk-Java6/lucene/build/suggest/lucene-suggest-5.0-SNAPSHOT.jar= :/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/luce= ne/build/grouping/lucene-grouping-5.0-SNAPSHOT.jar:/usr/home/hudson/hudson-= slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/queries/lucene-q= ueries-5.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-trunk-Java6/lucene/build/queryparser/lucene-queryparser-5.0-SNAPSHOT= .jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/= solr/core/lib/commons-cli-1.2.jar:/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/core/lib/commons-codec-1.6.jar:/usr/home/= hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/core/lib/c= ommons-fileupload-1.2.1.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-= Solr-Tests-trunk-Java6/solr/core/lib/commons-lang-2.6.jar:/usr/home/hudson/= hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/core/lib/easymock= -2.2.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Ja= va6/solr/core/lib/guava-r05.jar:/usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-trunk-Java6/solr/core/lib/javax.servlet-api-3.0.1.jar:/usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/core/l= ib/spatial4j-0.3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Te= sts-trunk-Java6/solr/solrj/lib/commons-io-2.1.jar:/usr/home/hudson/hudson-s= lave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/httpclient-4.1.= 3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6= /solr/solrj/lib/httpcore-4.1.4.jar:/usr/home/hudson/hudson-slave/workspace/= Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/httpmime-4.1.3.jar:/usr/home/h= udson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/j= cl-over-slf4j-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-trunk-Java6/solr/solrj/lib/log4j-over-slf4j-1.6.4.jar:/usr/home/huds= on/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/slf4= j-api-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-t= runk-Java6/solr/solrj/lib/slf4j-jdk14-1.6.4.jar:/usr/home/hudson/hudson-sla= ve/workspace/Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/wstx-asl-3.2.7.ja= r:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/sol= r/solrj/lib/zookeeper-3.3.6.jar:/usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-trunk-Java6/solr/example/lib/jetty-continuation-8.1.2.v20120= 308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Jav= a6/solr/example/lib/jetty-deploy-8.1.2.v20120308.jar:/usr/home/hudson/hudso= n-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/example/lib/jetty-http= -8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Te= sts-trunk-Java6/solr/example/lib/jetty-io-8.1.2.v20120308.jar:/usr/home/hud= son/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/example/lib/j= etty-jmx-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene= -Solr-Tests-trunk-Java6/solr/example/lib/jetty-security-8.1.2.v20120308.jar= :/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr= /example/lib/jetty-server-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave= /workspace/Lucene-Solr-Tests-trunk-Java6/solr/example/lib/jetty-servlet-8.1= .2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-= trunk-Java6/solr/example/lib/jetty-util-8.1.2.v20120308.jar:/usr/home/hudso= n/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/example/lib/jet= ty-webapp-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucen= e-Solr-Tests-trunk-Java6/solr/example/lib/jetty-xml-8.1.2.v20120308.jar:/us= r/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/exa= mple/lib/servlet-api-3.0.jar:/usr/home/hudson/hudson-slave/workspace/Lucene= -Solr-Tests-trunk-Java6/solr/example/example-DIH/solr/db/lib/hsqldb-1.8.0.1= 0.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6= /lucene/build/core/classes/java:/usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-trunk-Java6/lucene/test-framework/lib/junit-4.10.jar:/usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-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.ja= r:/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/hudso= n-slave/tools/Ant/ant-1.8.2/lib/ant-commons-net.jar:/home/hudson/hudson-sla= ve/tools/Ant/ant-1.8.2/lib/ant-antlr.jar:/home/hudson/hudson-slave/tools/An= t/ant-1.8.2/lib/ant-apache-log4j.jar:/home/hudson/hudson-slave/tools/Ant/an= t-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/li= b/ant-junit4.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-netr= exx.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-swing.jar:/ho= me/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-javamail.jar:/home/hudso= n/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jsch.jar:/home/hudson/hudson-sla= ve/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:/hom= e/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/ope= njdk6/lib/tools.jar:/home/hudson/.ivy2/cache/com.carrotsearch.randomizedtes= ting/junit4-ant/jars/junit4-ant-2.0.0.jar [junit4:junit4] 2> 162 T284 oaz.Environment.logEnv Server environment:jav= a.library.path=3D/usr/local/openjdk6/jre/lib/amd64/server:/usr/local/openjd= k6/jre/lib/amd64:/usr/local/openjdk6/jre/../lib/amd64:/usr/java/packages/li= b/amd64:/lib:/usr/lib:/usr/local/lib [junit4:junit4] 2> 163 T284 oaz.Environment.logEnv Server environment:jav= a.io.tmpdir=3D. [junit4:junit4] 2> 163 T284 oaz.Environment.logEnv Server environment:jav= a.compiler=3D [junit4:junit4] 2> 163 T284 oaz.Environment.logEnv Server environment:os.= name=3DFreeBSD [junit4:junit4] 2> 163 T284 oaz.Environment.logEnv Server environment:os.= arch=3Damd64 [junit4:junit4] 2> 163 T284 oaz.Environment.logEnv Server environment:os.= version=3D9.0-RELEASE [junit4:junit4] 2> 164 T284 oaz.Environment.logEnv Server environment:use= r.name=3Dhudson [junit4:junit4] 2> 164 T284 oaz.Environment.logEnv Server environment:use= r.home=3D/home/hudson [junit4:junit4] 2> 164 T284 oaz.Environment.logEnv Server environment:use= r.dir=3D/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Jav= a6/solr/build/solr-core/test/J1 [junit4:junit4] 2> 222 T284 oazs.ZooKeeperServer.setTickTime tickTime set= to 1000 [junit4:junit4] 2> 266 T284 oazs.NIOServerCnxn$Factory. binding to = port 0.0.0.0/0.0.0.0:0 [junit4:junit4] 2> 318 T283 oasc.ZkTestServer.run start zk server on port= :38065 [junit4:junit4] 2> 372 T284 oazsp.FileTxnSnapLog.save Snapshotting: 0 [junit4:junit4] 2> 447 T283 oaz.Environment.logEnv Client environment:zoo= keeper.version=3D3.3.6-1366786, built on 07/29/2012 06:22 GMT [junit4:junit4] 2> 448 T283 oaz.Environment.logEnv Client environment:hos= t.name=3Dlucene.zones.apache.org [junit4:junit4] 2> 448 T283 oaz.Environment.logEnv Client environment:jav= a.version=3D1.6.0_32 [junit4:junit4] 2> 448 T283 oaz.Environment.logEnv Client environment:jav= a.vendor=3DSun Microsystems Inc. [junit4:junit4] 2> 449 T283 oaz.Environment.logEnv Client environment:jav= a.home=3D/usr/local/openjdk6/jre [junit4:junit4] 2> 449 T283 oaz.Environment.logEnv Client environment:jav= a.class.path=3D/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tr= unk-Java6/solr/build/solr-core/classes/test:/usr/home/hudson/hudson-slave/w= orkspace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-test-framework/class= es/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Jav= a6/solr/build/solr-core/test-files:/usr/home/hudson/hudson-slave/workspace/= Lucene-Solr-Tests-trunk-Java6/lucene/build/codecs/classes/java:/usr/home/hu= dson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/test= -framework/classes/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-trunk-Java6/solr/build/solr-solrj/classes/java:/usr/home/hudson/huds= on-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/class= es/java:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Jav= a6/lucene/build/analysis/common/lucene-analyzers-common-5.0-SNAPSHOT.jar:/u= sr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/= build/analysis/kuromoji/lucene-analyzers-kuromoji-5.0-SNAPSHOT.jar:/usr/hom= e/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/= analysis/phonetic/lucene-analyzers-phonetic-5.0-SNAPSHOT.jar:/usr/home/huds= on/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/highli= ghter/lucene-highlighter-5.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/wor= kspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/memory/lucene-memory-5.0-= SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trun= k-Java6/lucene/build/misc/lucene-misc-5.0-SNAPSHOT.jar:/usr/home/hudson/hud= son-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/spatial/luce= ne-spatial-5.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-= Solr-Tests-trunk-Java6/lucene/build/suggest/lucene-suggest-5.0-SNAPSHOT.jar= :/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/luce= ne/build/grouping/lucene-grouping-5.0-SNAPSHOT.jar:/usr/home/hudson/hudson-= slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucene/build/queries/lucene-q= ueries-5.0-SNAPSHOT.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-trunk-Java6/lucene/build/queryparser/lucene-queryparser-5.0-SNAPSHOT= .jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/= solr/core/lib/commons-cli-1.2.jar:/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/core/lib/commons-codec-1.6.jar:/usr/home/= hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/core/lib/c= ommons-fileupload-1.2.1.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-= Solr-Tests-trunk-Java6/solr/core/lib/commons-lang-2.6.jar:/usr/home/hudson/= hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/core/lib/easymock= -2.2.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Ja= va6/solr/core/lib/guava-r05.jar:/usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-trunk-Java6/solr/core/lib/javax.servlet-api-3.0.1.jar:/usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/core/l= ib/spatial4j-0.3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Te= sts-trunk-Java6/solr/solrj/lib/commons-io-2.1.jar:/usr/home/hudson/hudson-s= lave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/httpclient-4.1.= 3.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6= /solr/solrj/lib/httpcore-4.1.4.jar:/usr/home/hudson/hudson-slave/workspace/= Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/httpmime-4.1.3.jar:/usr/home/h= udson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/j= cl-over-slf4j-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-trunk-Java6/solr/solrj/lib/log4j-over-slf4j-1.6.4.jar:/usr/home/huds= on/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/slf4= j-api-1.6.4.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-t= runk-Java6/solr/solrj/lib/slf4j-jdk14-1.6.4.jar:/usr/home/hudson/hudson-sla= ve/workspace/Lucene-Solr-Tests-trunk-Java6/solr/solrj/lib/wstx-asl-3.2.7.ja= r:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/sol= r/solrj/lib/zookeeper-3.3.6.jar:/usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-trunk-Java6/solr/example/lib/jetty-continuation-8.1.2.v20120= 308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Jav= a6/solr/example/lib/jetty-deploy-8.1.2.v20120308.jar:/usr/home/hudson/hudso= n-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/example/lib/jetty-http= -8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Te= sts-trunk-Java6/solr/example/lib/jetty-io-8.1.2.v20120308.jar:/usr/home/hud= son/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/example/lib/j= etty-jmx-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene= -Solr-Tests-trunk-Java6/solr/example/lib/jetty-security-8.1.2.v20120308.jar= :/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr= /example/lib/jetty-server-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave= /workspace/Lucene-Solr-Tests-trunk-Java6/solr/example/lib/jetty-servlet-8.1= .2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-= trunk-Java6/solr/example/lib/jetty-util-8.1.2.v20120308.jar:/usr/home/hudso= n/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/example/lib/jet= ty-webapp-8.1.2.v20120308.jar:/usr/home/hudson/hudson-slave/workspace/Lucen= e-Solr-Tests-trunk-Java6/solr/example/lib/jetty-xml-8.1.2.v20120308.jar:/us= r/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/exa= mple/lib/servlet-api-3.0.jar:/usr/home/hudson/hudson-slave/workspace/Lucene= -Solr-Tests-trunk-Java6/solr/example/example-DIH/solr/db/lib/hsqldb-1.8.0.1= 0.jar:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6= /lucene/build/core/classes/java:/usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-trunk-Java6/lucene/test-framework/lib/junit-4.10.jar:/usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-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.ja= r:/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/hudso= n-slave/tools/Ant/ant-1.8.2/lib/ant-commons-net.jar:/home/hudson/hudson-sla= ve/tools/Ant/ant-1.8.2/lib/ant-antlr.jar:/home/hudson/hudson-slave/tools/An= t/ant-1.8.2/lib/ant-apache-log4j.jar:/home/hudson/hudson-slave/tools/Ant/an= t-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/li= b/ant-junit4.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-netr= exx.jar:/home/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-swing.jar:/ho= me/hudson/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-javamail.jar:/home/hudso= n/hudson-slave/tools/Ant/ant-1.8.2/lib/ant-jsch.jar:/home/hudson/hudson-sla= ve/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:/hom= e/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/ope= njdk6/lib/tools.jar:/home/hudson/.ivy2/cache/com.carrotsearch.randomizedtes= ting/junit4-ant/jars/junit4-ant-2.0.0.jar [junit4:junit4] 2> 450 T283 oaz.Environment.logEnv Client environment:jav= a.library.path=3D/usr/local/openjdk6/jre/lib/amd64/server:/usr/local/openjd= k6/jre/lib/amd64:/usr/local/openjdk6/jre/../lib/amd64:/usr/java/packages/li= b/amd64:/lib:/usr/lib:/usr/local/lib [junit4:junit4] 2> 450 T283 oaz.Environment.logEnv Client environment:jav= a.io.tmpdir=3D. [junit4:junit4] 2> 450 T283 oaz.Environment.logEnv Client environment:jav= a.compiler=3D [junit4:junit4] 2> 451 T283 oaz.Environment.logEnv Client environment:os.= name=3DFreeBSD [junit4:junit4] 2> 451 T283 oaz.Environment.logEnv Client environment:os.= arch=3Damd64 [junit4:junit4] 2> 451 T283 oaz.Environment.logEnv Client environment:os.= version=3D9.0-RELEASE [junit4:junit4] 2> 451 T283 oaz.Environment.logEnv Client environment:use= r.name=3Dhudson [junit4:junit4] 2> 452 T283 oaz.Environment.logEnv Client environment:use= r.home=3D/home/hudson [junit4:junit4] 2> 452 T283 oaz.Environment.logEnv Client environment:use= r.dir=3D/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Jav= a6/solr/build/solr-core/test/J1 [junit4:junit4] 2> 455 T283 oaz.ZooKeeper. Initiating client connec= tion, connectString=3D127.0.0.1:38065 sessionTimeout=3D10000 watcher=3Dorg.= apache.solr.common.cloud.ConnectionManager@f50fa46 [junit4:junit4] 2> 542 T288 oaz.ClientCnxn$SendThread.startConnect Openin= g socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 545 T283 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4:junit4] 2> 547 T288 oaz.ClientCnxn$SendThread.primeConnection Soc= ket connection established to localhost/127.0.0.1:38065, initiating session [junit4:junit4] 2> 547 T285 oazs.NIOServerCnxn$Factory.run Accepted socke= t connection from /140.211.11.196:38066 [junit4:junit4] 2> 573 T285 oazs.NIOServerCnxn.doIO WARNING Exception cau= sing close of session 0x0 due to java.io.IOException: ZooKeeperServer not r= unning [junit4:junit4] 2> 573 T285 oazs.NIOServerCnxn.closeSock Closed socket co= nnection for client /140.211.11.196:38066 (no session established for clien= t) [junit4:junit4] 2> 574 T288 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> 1701 T288 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server localhost/127.0.0.1:38065 [junit4:junit4] 2> 1701 T288 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38065, initiating sessio= n [junit4:junit4] 2> 1702 T285 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38067 [junit4:junit4] 2> 1702 T285 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38067 [junit4:junit4] 2> 1716 T287 oazsp.FileTxnLog.append Creating new log fil= e: log.1 [junit4:junit4] 2> 1778 T287 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139cc5b9b4e0000 with negotiated timeout 10000 for client /14= 0.211.11.196:38067 [junit4:junit4] 2> 1778 T288 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38065, session= id =3D 0x139cc5b9b4e0000, negotiated timeout =3D 10000 [junit4:junit4] 2> 1781 T290 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@f50fa46 name:ZooKeeperConnection= Watcher:127.0.0.1:38065 got event WatchedEvent state:SyncConnected type:No= ne path:null path:null type:None [junit4:junit4] 2> 1782 T283 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 1784 T283 oascc.SolrZkClient.makePath makePath: /solr [junit4:junit4] 2> 1843 T289 oazs.PrepRequestProcessor.pRequest Processed= session termination for sessionid: 0x139cc5b9b4e0000 [junit4:junit4] 2> 1845 T290 oaz.ClientCnxn$EventThread.run EventThread s= hut down [junit4:junit4] 2> 1845 T283 oaz.ZooKeeper.close Session: 0x139cc5b9b4e00= 00 closed [junit4:junit4] 2> 1845 T285 oazs.NIOServerCnxn.doIO WARNING EndOfStreamE= xception: Unable to read additional data from client sessionid 0x139cc5b9b4= e0000, likely client has closed socket [junit4:junit4] 2> 1846 T283 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D10000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@f530ff3 [junit4:junit4] 2> 1846 T285 oazs.NIOServerCnxn.closeSock Closed socket c= onnection for client /140.211.11.196:38067 which had sessionid 0x139cc5b9b4= e0000 [junit4:junit4] 2> 1847 T291 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 1847 T283 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 1848 T291 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38065, initiating sessio= n [junit4:junit4] 2> 1848 T285 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38068 [junit4:junit4] 2> 1848 T285 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38068 [junit4:junit4] 2> 1850 T287 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139cc5b9b4e0001 with negotiated timeout 10000 for client /14= 0.211.11.196:38068 [junit4:junit4] 2> 1850 T291 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38065, session= id =3D 0x139cc5b9b4e0001, negotiated timeout =3D 10000 [junit4:junit4] 2> 1850 T292 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@f530ff3 name:ZooKeeperConnection= Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected ty= pe:None path:null path:null type:None [junit4:junit4] 2> 1851 T283 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 1863 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1 [junit4:junit4] 2> 1869 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/shards [junit4:junit4] 2> 1878 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/control_collection [junit4:junit4] 2> 1881 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/control_collection/shards [junit4:junit4] 2> 1885 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1= /solrconfig.xml [junit4:junit4] 2> 1886 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/solrconfig.xml [junit4:junit4] 2> 1899 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/sch= ema.xml [junit4:junit4] 2> 1900 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/schema.xml [junit4:junit4] 2> 2005 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1= /solrconfig.xml [junit4:junit4] 2> 2007 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/solrconfig.xml [junit4:junit4] 2> 2021 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/= stopwords.txt [junit4:junit4] 2> 2022 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/stopwords.txt [junit4:junit4] 2> 2026 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/= protwords.txt [junit4:junit4] 2> 2027 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/protwords.txt [junit4:junit4] 2> 2030 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/c= urrency.xml [junit4:junit4] 2> 2031 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/currency.xml [junit4:junit4] 2> 2034 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /con= figs/conf1/open-exchange-rates.json [junit4:junit4] 2> 2035 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/open-exchange-rates.json [junit4:junit4] 2> 2038 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /= configs/conf1/mapping-ISOLatin1Accent.txt [junit4:junit4] 2> 2039 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/mapping-ISOLatin1Accent.txt [junit4:junit4] 2> 2042 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/con= f1/old_synonyms.txt [junit4:junit4] 2> 2043 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/old_synonyms.txt [junit4:junit4] 2> 2046 T283 oasc.AbstractZkTestCase.putConfig put /usr/h= ome/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/= solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/s= ynonyms.txt [junit4:junit4] 2> 2047 T283 oascc.SolrZkClient.makePath makePath: /confi= gs/conf1/synonyms.txt [junit4:junit4] 2> 2135 T289 oazs.PrepRequestProcessor.pRequest Processed= session termination for sessionid: 0x139cc5b9b4e0001 [junit4:junit4] 2> 2146 T292 oaz.ClientCnxn$EventThread.run EventThread s= hut down [junit4:junit4] 2> 2146 T283 oaz.ZooKeeper.close Session: 0x139cc5b9b4e00= 01 closed [junit4:junit4] 2> 2148 T285 oazs.NIOServerCnxn.closeSock Closed socket c= onnection for client /140.211.11.196:38068 which had sessionid 0x139cc5b9b4= e0001 [junit4:junit4] 2> 2149 T283 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 2151 T283 oejs.AbstractConnector.doStart Started Socke= tConnector@0.0.0.0:38070 [junit4:junit4] 2> 2152 T283 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 2152 T283 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test-files/solr [junit4:junit4] 2> 2152 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test-files/solr/' [junit4:junit4] 2> 2177 T283 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() [junit4:junit4] 2> 2177 T283 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 2178 T283 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test-files/solr [junit4:junit4] 2> 2178 T283 oasc.CoreContainer$Initializer.initialize lo= oking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-trunk-Java6/solr/build/solr-core/test-files/solr/solr.xml [junit4:junit4] 2> 2178 T283 oasc.CoreContainer. New CoreContainer = 2064473613 [junit4:junit4] 2> 2179 T283 oasc.CoreContainer.load Loading CoreContaine= r using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-trunk-Java6/solr/build/solr-core/test-files/solr/' [junit4:junit4] 2> 2179 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-trunk-Java6/solr/build/solr-core/test-files/solr/' [junit4:junit4] 2> 2198 T283 oasc.CoreContainer.load Registering Log List= ener [junit4:junit4] 2> 2210 T283 oasc.CoreContainer.initZooKeeper Zookeeper c= lient=3D127.0.0.1:38065/solr [junit4:junit4] 2> 2232 T283 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D5000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@20b1c468 [junit4:junit4] 2> 2233 T302 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 2233 T283 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 2235 T302 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38065, initiating sessio= n [junit4:junit4] 2> 2235 T285 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38071 [junit4:junit4] 2> 2236 T285 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38071 [junit4:junit4] 2> 2238 T287 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139cc5b9b4e0002 with negotiated timeout 5000 for client /140= .211.11.196:38071 [junit4:junit4] 2> 2238 T302 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38065, session= id =3D 0x139cc5b9b4e0002, negotiated timeout =3D 5000 [junit4:junit4] 2> 2238 T303 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@20b1c468 name:ZooKeeperConnectio= n Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 2238 T283 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 2259 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 2268 T283 oascc.SolrZkClient.makePath makePath: /live_= nodes [junit4:junit4] 2> 2271 T283 oasc.ZkController.createEphemeralLiveNode Re= gister node as live in ZooKeeper:/live_nodes/127.0.0.1:38070_solr [junit4:junit4] 2> 2276 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:dele= te cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/live_nodes/127.0.0.1:38070_solr Error:KeeperErrorCode =3D NoNode for = /solr/live_nodes/127.0.0.1:38070_solr [junit4:junit4] 2> 2277 T283 oascc.SolrZkClient.makePath makePath: /live_= nodes/127.0.0.1:38070_solr [junit4:junit4] 2> 2281 T283 oashc.HttpShardHandlerFactory.getParameter S= etting socketTimeout to: 0 [junit4:junit4] 2> 2282 T283 oashc.HttpShardHandlerFactory.getParameter S= etting urlScheme to: http:// [junit4:junit4] 2> 2282 T283 oashc.HttpShardHandlerFactory.getParameter S= etting connTimeout to: 0 [junit4:junit4] 2> 2282 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 2283 T283 oashc.HttpShardHandlerFactory.getParameter S= etting corePoolSize to: 0 [junit4:junit4] 2> 2283 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 2283 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maxThreadIdleTime to: 5 [junit4:junit4] 2> 2284 T283 oashc.HttpShardHandlerFactory.getParameter S= etting sizeOfQueue to: -1 [junit4:junit4] 2> 2284 T283 oashc.HttpShardHandlerFactory.getParameter S= etting fairnessPolicy to: false [junit4:junit4] 2> 2284 T283 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&s= ocketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 2295 T283 oascc.SolrZkClient.makePath makePath: /overs= eer_elect/election [junit4:junit4] 2> 2319 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:dele= te cxid:0x15 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer_elect/leader Error:KeeperErrorCode =3D NoNode for /solr/ove= rseer_elect/leader [junit4:junit4] 2> 2321 T283 oascc.SolrZkClient.makePath makePath: /overs= eer_elect/leader [junit4:junit4] 2> 2325 T283 oasc.Overseer.start Overseer (id=3D883263615= 30105858-127.0.0.1:38070_solr-n_0000000000) starting [junit4:junit4] 2> 2325 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 2336 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 2338 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 2347 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 2349 T305 oasc.OverseerCollectionProcessor.run Process= current queue of collection creations [junit4:junit4] 2> 2349 T283 oascc.SolrZkClient.makePath makePath: /clust= erstate.json [junit4:junit4] 2> 2352 T283 oascc.ZkStateReader.createClusterStateWatche= rsAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 2376 T304 oasc.Overseer$ClusterStateUpdater.run Starti= ng to work on the main queue [junit4:junit4] 2> 2383 T283 oasc.CoreContainer.create Creating SolrCore = 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test-files/solr/collection= 1 [junit4:junit4] 2> 2383 T283 oasc.ZkController.createCollectionZkNode Che= ck for collection zkNode:control_collection [junit4:junit4] 2> 2384 T283 oasc.ZkController.createCollectionZkNode Col= lection zkNode exists [junit4:junit4] 2> 2385 T283 oasc.ZkController.readConfigName Load collec= tion config from:/collections/control_collection [junit4:junit4] 2> 2386 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-trunk-Java6/solr/build/solr-core/test-files/solr/collection1/' [junit4:junit4] 2> 2387 T283 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk= -Java6/solr/build/solr-core/test-files/solr/collection1/lib/README' to clas= sloader [junit4:junit4] 2> 2388 T283 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk= -Java6/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to cl= assloader [junit4:junit4] 2> 2435 T283 oasc.SolrConfig. Using Lucene MatchVer= sion: LUCENE_50 [junit4:junit4] 2> 2485 T283 oasc.SolrConfig. Loaded SolrConfig: so= lrconfig.xml [junit4:junit4] 2> 2587 T283 oass.IndexSchema.readSchema Reading Solr Sch= ema [junit4:junit4] 2> 2593 T283 oass.IndexSchema.readSchema Schema name=3Dte= st [junit4:junit4] 2> 3049 T283 oass.OpenExchangeRatesOrgProvider.init Initi= alized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 3059 T283 oass.IndexSchema.readSchema default search f= ield in schema is text [junit4:junit4] 2> 3062 T283 oass.IndexSchema.readSchema unique key field= : id [junit4:junit4] 2> 3082 T283 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 3087 T283 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 3091 T283 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 3094 T283 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 3096 T283 oasc.SolrCore. [collection1] Opening n= ew SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tr= unk-Java6/solr/build/solr-core/test-files/solr/collection1/, dataDir=3D./or= g.apache.solr.cloud.BasicDistributedZk2Test-1347753318806/control/data/ [junit4:junit4] 2> 3096 T283 oasc.JmxMonitoredMap. JMX monitoring i= s enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBe= anServer@16edbe39 [junit4:junit4] 2> 3123 T283 oasc.SolrCore.getNewIndexDir WARNING New ind= ex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistri= butedZk2Test-1347753318806/control/data/index/ [junit4:junit4] 2> 3124 T283 oasc.SolrCore.initIndex WARNING [collection1= ] Solr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-134= 7753318806/control/data/index' doesn't exist. Creating new index... [junit4:junit4] 2> 3125 T283 oasc.CachingDirectoryFactory.get return new = directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tru= nk-Java6/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistribu= tedZk2Test-1347753318806/control/data/index forceNew:false [junit4:junit4] 2> 3141 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletio= nPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/control/data/index,segFN= =3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 3142 T283 oasc.SolrDeletionPolicy.updateCommits newest= commit =3D 1 [junit4:junit4] 2> 3142 T283 oasc.SolrCore.initWriters created xml: solr.= XMLResponseWriter [junit4:junit4] 2> 3145 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe" [junit4:junit4] 2> 3145 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe-allfields" [junit4:junit4] 2> 3145 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "st= ored_sig" [junit4:junit4] 2> 3146 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "un= iq-fields" [junit4:junit4] 2> 3146 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "di= strib-dup-test-chain-implicit" [junit4:junit4] 2> 3147 T283 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 3147 T283 oasc.RequestHandlers.initHandlersFromConfig = created /replication: solr.ReplicationHandler [junit4:junit4] 2> 3148 T283 oasc.RequestHandlers.initHandlersFromConfig = created standard: solr.StandardRequestHandler [junit4:junit4] 2> 3148 T283 oasc.RequestHandlers.initHandlersFromConfig = created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 3149 T283 oasc.RequestHandlers.initHandlersFromConfig = created dismax: solr.SearchHandler [junit4:junit4] 2> 3149 T283 oasc.RequestHandlers.initHandlersFromConfig = created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 3150 T283 oasc.RequestHandlers.initHandlersFromConfig = created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 3150 T283 oasc.RequestHandlers.initHandlersFromConfig = created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 3150 T283 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 3151 T283 oasc.RequestHandlers.initHandlersFromConfig = created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 3151 T283 oasc.RequestHandlers.initHandlersFromConfig = created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 3152 T283 oasc.RequestHandlers.initHandlersFromConfig = created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 3153 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 3153 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 3154 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 3154 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.S= earchHandler [junit4:junit4] 2> 3155 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 3155 T283 oasc.RequestHandlers.initHandlersFromConfig = created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 3156 T283 oasc.RequestHandlers.initHandlersFromConfig = created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 3156 T283 oasc.RequestHandlers.initHandlersFromConfig = created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 3159 T283 oashl.XMLLoader.init xsltCacheLifetimeSecond= s=3D60 [junit4:junit4] 2> 3163 T283 oasc.SolrCore.initDeprecatedSupport WARNING = solrconfig.xml uses deprecated , Please update your co= nfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 3165 T283 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> 3168 T283 oass.SolrIndexSearcher. Opening Search= er@586b736f main [junit4:junit4] 2> 3169 T283 oasu.CommitTracker. Hard AutoCommit: d= isabled [junit4:junit4] 2> 3170 T283 oasu.CommitTracker. Soft AutoCommit: d= isabled [junit4:junit4] 2> 3170 T283 oashc.SpellCheckComponent.inform Initializin= g spell checkers [junit4:junit4] 2> 3177 T283 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4:junit4] 2> 3230 T306 oasc.SolrCore.registerSearcher [collection1]= Registered new searcher Searcher@586b736f main{StandardDirectoryReader(seg= ments_1:1)} [junit4:junit4] 2> 3235 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x53 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer/queue Error:KeeperErrorCode =3D NoNode for /solr/overseer/q= ueue [junit4:junit4] 2> 3246 T283 oasc.CoreContainer.register registering core= : collection1 [junit4:junit4] 2> 3247 T283 oasc.ZkController.register Register shard - = core:collection1 address:http://127.0.0.1:38070/solr shardId:control_shard [junit4:junit4] 2> 3260 T283 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D10000&maxConnectionsPerHost=3D20&c= onnTimeout=3D30000&socketTimeout=3D30000&retry=3Dfalse [junit4:junit4] 2> 3271 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/control_collection/leader_elect/control_shard/election [junit4:junit4] 2> 3287 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:dele= te cxid:0x62 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/collections/control_collection/leaders Error:KeeperErrorCode =3D NoN= ode for /solr/collections/control_collection/leaders [junit4:junit4] 2> 3288 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess Running the leader process. [junit4:junit4] 2> 3289 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x63 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 3383 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 3396 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x6a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer/queue-work Error:KeeperErrorCode =3D NoNode for /solr/overs= eer/queue-work [junit4:junit4] 2> 3426 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 3800 T283 oasc.ShardLeaderElectionContext.waitForRepli= casToComeUp Enough replicas found to continue. [junit4:junit4] 2> 3801 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess I may be the new leader - try and sync [junit4:junit4] 2> 3801 T283 oasc.SyncStrategy.sync Sync replicas to http= ://127.0.0.1:38070/solr/collection1/ [junit4:junit4] 2> 3802 T283 oasc.SyncStrategy.syncReplicas Sync Success = - now sync replicas to me [junit4:junit4] 2> 3802 T283 oasc.SyncStrategy.syncToMe http://127.0.0.1:= 38070/solr/collection1/ has no replicas [junit4:junit4] 2> 3803 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess I am the new leader: http://127.0.0.1:38070/solr/collection1/ [junit4:junit4] 2> 3803 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/control_collection/leaders/control_shard [junit4:junit4] 2> 3810 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0002 type:crea= te cxid:0x88 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 3933 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 3964 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 3974 T283 oasc.ZkController.register We are http://127= .0.0.1:38070/solr/collection1/ and leader is http://127.0.0.1:38070/solr/co= llection1/ [junit4:junit4] 2> 3974 T283 oasc.ZkController.register No LogReplay need= ed for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38070/solr [junit4:junit4] 2> 3975 T283 oasc.ZkController.checkRecovery I am the lea= der, no recovery necessary [junit4:junit4] 2> 3978 T283 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 3979 T283 oass.SolrDispatchFilter.init user.dir=3D/usr= /home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/buil= d/solr-core/test/J1 [junit4:junit4] 2> 3980 T283 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() done [junit4:junit4] 2> 3981 T283 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fol= lowRedirects=3Dfalse [junit4:junit4] 2> 4159 T283 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 4162 T283 oejs.AbstractConnector.doStart Started Socke= tConnector@0.0.0.0:38073 [junit4:junit4] 2> 4163 T283 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 4163 T283 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1-= 1347753322793 [junit4:junit4] 2> 4164 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1= -1347753322793/' [junit4:junit4] 2> 4208 T283 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() [junit4:junit4] 2> 4209 T283 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 4209 T283 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1-= 1347753322793 [junit4:junit4] 2> 4210 T283 oasc.CoreContainer$Initializer.initialize lo= oking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1-1347753322793= /solr.xml [junit4:junit4] 2> 4210 T283 oasc.CoreContainer. New CoreContainer = 928015047 [junit4:junit4] 2> 4211 T283 oasc.CoreContainer.load Loading CoreContaine= r using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1-1347753322793= /' [junit4:junit4] 2> 4212 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1-1347753= 322793/' [junit4:junit4] 2> 4239 T283 oasc.CoreContainer.load Registering Log List= ener [junit4:junit4] 2> 4256 T283 oasc.CoreContainer.initZooKeeper Zookeeper c= lient=3D127.0.0.1:38065/solr [junit4:junit4] 2> 4257 T283 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D5000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@52aeb38d [junit4:junit4] 2> 4258 T316 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 4258 T283 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 4259 T316 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38065, initiating sessio= n [junit4:junit4] 2> 4260 T285 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38074 [junit4:junit4] 2> 4260 T285 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38074 [junit4:junit4] 2> 4267 T287 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139cc5b9b4e0003 with negotiated timeout 5000 for client /140= .211.11.196:38074 [junit4:junit4] 2> 4267 T316 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38065, session= id =3D 0x139cc5b9b4e0003, negotiated timeout =3D 5000 [junit4:junit4] 2> 4267 T317 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@52aeb38d name:ZooKeeperConnectio= n Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 4268 T283 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 4269 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0003 type:crea= te cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 4281 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0003 type:crea= te cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 4283 T283 oasc.ZkController.createEphemeralLiveNode Re= gister node as live in ZooKeeper:/live_nodes/127.0.0.1:38073_solr [junit4:junit4] 2> 4284 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0003 type:dele= te cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/live_nodes/127.0.0.1:38073_solr Error:KeeperErrorCode =3D NoNode for = /solr/live_nodes/127.0.0.1:38073_solr [junit4:junit4] 2> 4285 T283 oascc.SolrZkClient.makePath makePath: /live_= nodes/127.0.0.1:38073_solr [junit4:junit4] 2> 4288 T303 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 4289 T283 oashc.HttpShardHandlerFactory.getParameter S= etting socketTimeout to: 0 [junit4:junit4] 2> 4289 T283 oashc.HttpShardHandlerFactory.getParameter S= etting urlScheme to: http:// [junit4:junit4] 2> 4290 T283 oashc.HttpShardHandlerFactory.getParameter S= etting connTimeout to: 0 [junit4:junit4] 2> 4290 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 4291 T283 oashc.HttpShardHandlerFactory.getParameter S= etting corePoolSize to: 0 [junit4:junit4] 2> 4291 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 4292 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maxThreadIdleTime to: 5 [junit4:junit4] 2> 4292 T283 oashc.HttpShardHandlerFactory.getParameter S= etting sizeOfQueue to: -1 [junit4:junit4] 2> 4293 T283 oashc.HttpShardHandlerFactory.getParameter S= etting fairnessPolicy to: false [junit4:junit4] 2> 4293 T283 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&s= ocketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 4317 T283 oascc.ZkStateReader.createClusterStateWatche= rsAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 4325 T283 oasc.CoreContainer.create Creating SolrCore = 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1-= 1347753322793/collection1 [junit4:junit4] 2> 4325 T283 oasc.ZkController.createCollectionZkNode Che= ck for collection zkNode:collection1 [junit4:junit4] 2> 4326 T283 oasc.ZkController.createCollectionZkNode Col= lection zkNode exists [junit4:junit4] 2> 4327 T283 oasc.ZkController.readConfigName Load collec= tion config from:/collections/collection1 [junit4:junit4] 2> 4329 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1-1347753= 322793/collection1/' [junit4:junit4] 2> 4330 T283 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk= -Java6/solr/build/solr-core/test/J1/solrtest-jetty1-1347753322793/collectio= n1/lib/README' to classloader [junit4:junit4] 2> 4331 T283 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk= -Java6/solr/build/solr-core/test/J1/solrtest-jetty1-1347753322793/collectio= n1/lib/classes/' to classloader [junit4:junit4] 2> 4386 T283 oasc.SolrConfig. Using Lucene MatchVer= sion: LUCENE_50 [junit4:junit4] 2> 4468 T283 oasc.SolrConfig. Loaded SolrConfig: so= lrconfig.xml [junit4:junit4] 2> 4477 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 4496 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 4572 T317 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 4572 T283 oass.IndexSchema.readSchema Reading Solr Sch= ema [junit4:junit4] 2> 4581 T283 oass.IndexSchema.readSchema Schema name=3Dte= st [junit4:junit4] 2> 5279 T283 oass.OpenExchangeRatesOrgProvider.init Initi= alized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 5294 T283 oass.IndexSchema.readSchema default search f= ield in schema is text [junit4:junit4] 2> 5300 T283 oass.IndexSchema.readSchema unique key field= : id [junit4:junit4] 2> 5324 T283 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 5330 T283 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 5336 T283 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 5339 T283 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 5343 T283 oasc.SolrCore. [collection1] Opening n= ew SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tr= unk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty1-1347753322793/coll= ection1/, dataDir=3D./org.apache.solr.cloud.BasicDistributedZk2Test-1347753= 318806/jetty1/ [junit4:junit4] 2> 5343 T283 oasc.JmxMonitoredMap. JMX monitoring i= s enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBe= anServer@16edbe39 [junit4:junit4] 2> 5345 T283 oasc.SolrCore.getNewIndexDir WARNING New ind= ex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistri= butedZk2Test-1347753318806/jetty1/index/ [junit4:junit4] 2> 5346 T283 oasc.SolrCore.initIndex WARNING [collection1= ] Solr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-134= 7753318806/jetty1/index' doesn't exist. Creating new index... [junit4:junit4] 2> 5347 T283 oasc.CachingDirectoryFactory.get return new = directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tru= nk-Java6/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistribu= tedZk2Test-1347753318806/jetty1/index forceNew:false [junit4:junit4] 2> 5381 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletio= nPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty1/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 5381 T283 oasc.SolrDeletionPolicy.updateCommits newest= commit =3D 1 [junit4:junit4] 2> 5382 T283 oasc.SolrCore.initWriters created xml: solr.= XMLResponseWriter [junit4:junit4] 2> 5385 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe" [junit4:junit4] 2> 5385 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe-allfields" [junit4:junit4] 2> 5386 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "st= ored_sig" [junit4:junit4] 2> 5386 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "un= iq-fields" [junit4:junit4] 2> 5387 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "di= strib-dup-test-chain-implicit" [junit4:junit4] 2> 5388 T283 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 5388 T283 oasc.RequestHandlers.initHandlersFromConfig = created /replication: solr.ReplicationHandler [junit4:junit4] 2> 5389 T283 oasc.RequestHandlers.initHandlersFromConfig = created standard: solr.StandardRequestHandler [junit4:junit4] 2> 5390 T283 oasc.RequestHandlers.initHandlersFromConfig = created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 5390 T283 oasc.RequestHandlers.initHandlersFromConfig = created dismax: solr.SearchHandler [junit4:junit4] 2> 5391 T283 oasc.RequestHandlers.initHandlersFromConfig = created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 5392 T283 oasc.RequestHandlers.initHandlersFromConfig = created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 5393 T283 oasc.RequestHandlers.initHandlersFromConfig = created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 5393 T283 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 5394 T283 oasc.RequestHandlers.initHandlersFromConfig = created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 5395 T283 oasc.RequestHandlers.initHandlersFromConfig = created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 5396 T283 oasc.RequestHandlers.initHandlersFromConfig = created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 5396 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 5397 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 5398 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 5399 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.S= earchHandler [junit4:junit4] 2> 5399 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 5400 T283 oasc.RequestHandlers.initHandlersFromConfig = created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 5401 T283 oasc.RequestHandlers.initHandlersFromConfig = created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 5402 T283 oasc.RequestHandlers.initHandlersFromConfig = created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 5405 T283 oashl.XMLLoader.init xsltCacheLifetimeSecond= s=3D60 [junit4:junit4] 2> 5410 T283 oasc.SolrCore.initDeprecatedSupport WARNING = solrconfig.xml uses deprecated , Please update your co= nfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 5412 T283 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> 5431 T283 oass.SolrIndexSearcher. Opening Search= er@2194ca49 main [junit4:junit4] 2> 5432 T283 oasu.CommitTracker. Hard AutoCommit: d= isabled [junit4:junit4] 2> 5433 T283 oasu.CommitTracker. Soft AutoCommit: d= isabled [junit4:junit4] 2> 5434 T283 oashc.SpellCheckComponent.inform Initializin= g spell checkers [junit4:junit4] 2> 5441 T283 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4:junit4] 2> 5494 T318 oasc.SolrCore.registerSearcher [collection1]= Registered new searcher Searcher@2194ca49 main{StandardDirectoryReader(seg= ments_1:1)} [junit4:junit4] 2> 5504 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 5527 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 5527 T317 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6003 T283 oasc.CoreContainer.register registering core= : collection1 [junit4:junit4] 2> 6003 T283 oasc.ZkController.register Register shard - = core:collection1 address:http://127.0.0.1:38073/solr shardId:shard1 [junit4:junit4] 2> 6005 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/leader_elect/shard1/election [junit4:junit4] 2> 6021 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0003 type:dele= te cxid:0x43 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/collections/collection1/leaders Error:KeeperErrorCode =3D NoNode for= /solr/collections/collection1/leaders [junit4:junit4] 2> 6022 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess Running the leader process. [junit4:junit4] 2> 6023 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0003 type:crea= te cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 6026 T283 oasc.ShardLeaderElectionContext.waitForRepli= casToComeUp Enough replicas found to continue. [junit4:junit4] 2> 6026 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess I may be the new leader - try and sync [junit4:junit4] 2> 6027 T283 oasc.SyncStrategy.sync Sync replicas to http= ://127.0.0.1:38073/solr/collection1/ [junit4:junit4] 2> 6027 T283 oasc.SyncStrategy.syncReplicas Sync Success = - now sync replicas to me [junit4:junit4] 2> 6028 T283 oasc.SyncStrategy.syncToMe http://127.0.0.1:= 38073/solr/collection1/ has no replicas [junit4:junit4] 2> 6028 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess I am the new leader: http://127.0.0.1:38073/solr/collection1/ [junit4:junit4] 2> 6029 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/leaders/shard1 [junit4:junit4] 2> 6034 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 6035 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0003 type:crea= te cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 6046 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6046 T317 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6088 T283 oasc.ZkController.register We are http://127= .0.0.1:38073/solr/collection1/ and leader is http://127.0.0.1:38073/solr/co= llection1/ [junit4:junit4] 2> 6088 T283 oasc.ZkController.register No LogReplay need= ed for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38073/solr [junit4:junit4] 2> 6089 T283 oasc.ZkController.checkRecovery I am the lea= der, no recovery necessary [junit4:junit4] 2> 6092 T283 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 6093 T283 oass.SolrDispatchFilter.init user.dir=3D/usr= /home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/buil= d/solr-core/test/J1 [junit4:junit4] 2> 6093 T283 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() done [junit4:junit4] 2> 6094 T283 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fol= lowRedirects=3Dfalse [junit4:junit4] 2> 6246 T283 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 6248 T283 oejs.AbstractConnector.doStart Started Socke= tConnector@0.0.0.0:38076 [junit4:junit4] 2> 6249 T283 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 6250 T283 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2-= 1347753324911 [junit4:junit4] 2> 6250 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2= -1347753324911/' [junit4:junit4] 2> 6282 T283 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() [junit4:junit4] 2> 6283 T283 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 6283 T283 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2-= 1347753324911 [junit4:junit4] 2> 6284 T283 oasc.CoreContainer$Initializer.initialize lo= oking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2-1347753324911= /solr.xml [junit4:junit4] 2> 6284 T283 oasc.CoreContainer. New CoreContainer = 2145588569 [junit4:junit4] 2> 6285 T283 oasc.CoreContainer.load Loading CoreContaine= r using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2-1347753324911= /' [junit4:junit4] 2> 6286 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2-1347753= 324911/' [junit4:junit4] 2> 6309 T283 oasc.CoreContainer.load Registering Log List= ener [junit4:junit4] 2> 6325 T283 oasc.CoreContainer.initZooKeeper Zookeeper c= lient=3D127.0.0.1:38065/solr [junit4:junit4] 2> 6326 T283 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D5000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@50d5afff [junit4:junit4] 2> 6327 T328 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 6327 T283 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 6328 T328 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38065, initiating sessio= n [junit4:junit4] 2> 6328 T285 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38077 [junit4:junit4] 2> 6329 T285 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38077 [junit4:junit4] 2> 6331 T287 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139cc5b9b4e0004 with negotiated timeout 5000 for client /140= .211.11.196:38077 [junit4:junit4] 2> 6331 T328 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38065, session= id =3D 0x139cc5b9b4e0004, negotiated timeout =3D 5000 [junit4:junit4] 2> 6331 T329 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@50d5afff name:ZooKeeperConnectio= n Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 6332 T283 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 6333 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0004 type:crea= te cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 6334 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0004 type:crea= te cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 6346 T283 oasc.ZkController.createEphemeralLiveNode Re= gister node as live in ZooKeeper:/live_nodes/127.0.0.1:38076_solr [junit4:junit4] 2> 6347 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0004 type:dele= te cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/live_nodes/127.0.0.1:38076_solr Error:KeeperErrorCode =3D NoNode for = /solr/live_nodes/127.0.0.1:38076_solr [junit4:junit4] 2> 6348 T283 oascc.SolrZkClient.makePath makePath: /live_= nodes/127.0.0.1:38076_solr [junit4:junit4] 2> 6351 T303 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 6351 T317 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 6352 T283 oashc.HttpShardHandlerFactory.getParameter S= etting socketTimeout to: 0 [junit4:junit4] 2> 6353 T283 oashc.HttpShardHandlerFactory.getParameter S= etting urlScheme to: http:// [junit4:junit4] 2> 6353 T283 oashc.HttpShardHandlerFactory.getParameter S= etting connTimeout to: 0 [junit4:junit4] 2> 6354 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 6354 T283 oashc.HttpShardHandlerFactory.getParameter S= etting corePoolSize to: 0 [junit4:junit4] 2> 6355 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 6355 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maxThreadIdleTime to: 5 [junit4:junit4] 2> 6356 T283 oashc.HttpShardHandlerFactory.getParameter S= etting sizeOfQueue to: -1 [junit4:junit4] 2> 6356 T283 oashc.HttpShardHandlerFactory.getParameter S= etting fairnessPolicy to: false [junit4:junit4] 2> 6356 T283 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&s= ocketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 6375 T283 oascc.ZkStateReader.createClusterStateWatche= rsAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 6383 T283 oasc.CoreContainer.create Creating SolrCore = 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2-= 1347753324911/collection1 [junit4:junit4] 2> 6383 T283 oasc.ZkController.createCollectionZkNode Che= ck for collection zkNode:collection1 [junit4:junit4] 2> 6384 T283 oasc.ZkController.createCollectionZkNode Col= lection zkNode exists [junit4:junit4] 2> 6385 T283 oasc.ZkController.readConfigName Load collec= tion config from:/collections/collection1 [junit4:junit4] 2> 6387 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2-1347753= 324911/collection1/' [junit4:junit4] 2> 6388 T283 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk= -Java6/solr/build/solr-core/test/J1/solrtest-jetty2-1347753324911/collectio= n1/lib/README' to classloader [junit4:junit4] 2> 6389 T283 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk= -Java6/solr/build/solr-core/test/J1/solrtest-jetty2-1347753324911/collectio= n1/lib/classes/' to classloader [junit4:junit4] 2> 6441 T283 oasc.SolrConfig. Using Lucene MatchVer= sion: LUCENE_50 [junit4:junit4] 2> 6520 T283 oasc.SolrConfig. Loaded SolrConfig: so= lrconfig.xml [junit4:junit4] 2> 6560 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 6574 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6574 T317 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6621 T329 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6621 T283 oass.IndexSchema.readSchema Reading Solr Sch= ema [junit4:junit4] 2> 6630 T283 oass.IndexSchema.readSchema Schema name=3Dte= st [junit4:junit4] 2> 7288 T283 oass.OpenExchangeRatesOrgProvider.init Initi= alized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 7301 T283 oass.IndexSchema.readSchema default search f= ield in schema is text [junit4:junit4] 2> 7306 T283 oass.IndexSchema.readSchema unique key field= : id [junit4:junit4] 2> 7332 T283 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 7338 T283 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 7344 T283 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 7347 T283 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 7349 T283 oasc.SolrCore. [collection1] Opening n= ew SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tr= unk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty2-1347753324911/coll= ection1/, dataDir=3D./org.apache.solr.cloud.BasicDistributedZk2Test-1347753= 318806/jetty2/ [junit4:junit4] 2> 7350 T283 oasc.JmxMonitoredMap. JMX monitoring i= s enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBe= anServer@16edbe39 [junit4:junit4] 2> 7351 T283 oasc.SolrCore.getNewIndexDir WARNING New ind= ex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistri= butedZk2Test-1347753318806/jetty2/index/ [junit4:junit4] 2> 7352 T283 oasc.SolrCore.initIndex WARNING [collection1= ] Solr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-134= 7753318806/jetty2/index' doesn't exist. Creating new index... [junit4:junit4] 2> 7353 T283 oasc.CachingDirectoryFactory.get return new = directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tru= nk-Java6/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistribu= tedZk2Test-1347753318806/jetty2/index forceNew:false [junit4:junit4] 2> 7386 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletio= nPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty2/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 7387 T283 oasc.SolrDeletionPolicy.updateCommits newest= commit =3D 1 [junit4:junit4] 2> 7388 T283 oasc.SolrCore.initWriters created xml: solr.= XMLResponseWriter [junit4:junit4] 2> 7390 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe" [junit4:junit4] 2> 7391 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe-allfields" [junit4:junit4] 2> 7391 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "st= ored_sig" [junit4:junit4] 2> 7392 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "un= iq-fields" [junit4:junit4] 2> 7392 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "di= strib-dup-test-chain-implicit" [junit4:junit4] 2> 7393 T283 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 7394 T283 oasc.RequestHandlers.initHandlersFromConfig = created /replication: solr.ReplicationHandler [junit4:junit4] 2> 7394 T283 oasc.RequestHandlers.initHandlersFromConfig = created standard: solr.StandardRequestHandler [junit4:junit4] 2> 7395 T283 oasc.RequestHandlers.initHandlersFromConfig = created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 7396 T283 oasc.RequestHandlers.initHandlersFromConfig = created dismax: solr.SearchHandler [junit4:junit4] 2> 7397 T283 oasc.RequestHandlers.initHandlersFromConfig = created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 7397 T283 oasc.RequestHandlers.initHandlersFromConfig = created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 7398 T283 oasc.RequestHandlers.initHandlersFromConfig = created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 7398 T283 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 7399 T283 oasc.RequestHandlers.initHandlersFromConfig = created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 7400 T283 oasc.RequestHandlers.initHandlersFromConfig = created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 7400 T283 oasc.RequestHandlers.initHandlersFromConfig = created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 7401 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 7402 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 7403 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 7403 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.S= earchHandler [junit4:junit4] 2> 7404 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 7405 T283 oasc.RequestHandlers.initHandlersFromConfig = created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 7406 T283 oasc.RequestHandlers.initHandlersFromConfig = created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 7406 T283 oasc.RequestHandlers.initHandlersFromConfig = created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 7410 T283 oashl.XMLLoader.init xsltCacheLifetimeSecond= s=3D60 [junit4:junit4] 2> 7414 T283 oasc.SolrCore.initDeprecatedSupport WARNING = solrconfig.xml uses deprecated , Please update your co= nfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 7416 T283 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> 7420 T283 oass.SolrIndexSearcher. Opening Search= er@2e55d1ef main [junit4:junit4] 2> 7421 T283 oasu.CommitTracker. Hard AutoCommit: d= isabled [junit4:junit4] 2> 7422 T283 oasu.CommitTracker. Soft AutoCommit: d= isabled [junit4:junit4] 2> 7423 T283 oashc.SpellCheckComponent.inform Initializin= g spell checkers [junit4:junit4] 2> 7430 T283 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4:junit4] 2> 7492 T330 oasc.SolrCore.registerSearcher [collection1]= Registered new searcher Searcher@2e55d1ef main{StandardDirectoryReader(seg= ments_1:1)} [junit4:junit4] 2> 7583 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 7596 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 7596 T329 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 7596 T317 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8002 T283 oasc.CoreContainer.register registering core= : collection1 [junit4:junit4] 2> 8002 T283 oasc.ZkController.register Register shard - = core:collection1 address:http://127.0.0.1:38076/solr shardId:shard2 [junit4:junit4] 2> 8004 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/leader_elect/shard2/election [junit4:junit4] 2> 8023 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0004 type:dele= te cxid:0x42 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/collections/collection1/leaders/shard2 Error:KeeperErrorCode =3D NoN= ode for /solr/collections/collection1/leaders/shard2 [junit4:junit4] 2> 8024 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess Running the leader process. [junit4:junit4] 2> 8025 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0004 type:crea= te cxid:0x43 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 8028 T283 oasc.ShardLeaderElectionContext.waitForRepli= casToComeUp Enough replicas found to continue. [junit4:junit4] 2> 8029 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess I may be the new leader - try and sync [junit4:junit4] 2> 8030 T283 oasc.SyncStrategy.sync Sync replicas to http= ://127.0.0.1:38076/solr/collection1/ [junit4:junit4] 2> 8030 T283 oasc.SyncStrategy.syncReplicas Sync Success = - now sync replicas to me [junit4:junit4] 2> 8031 T283 oasc.SyncStrategy.syncToMe http://127.0.0.1:= 38076/solr/collection1/ has no replicas [junit4:junit4] 2> 8031 T283 oasc.ShardLeaderElectionContext.runLeaderPro= cess I am the new leader: http://127.0.0.1:38076/solr/collection1/ [junit4:junit4] 2> 8032 T283 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/leaders/shard2 [junit4:junit4] 2> 8037 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0004 type:crea= te cxid:0x4c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 8102 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 8118 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8119 T317 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8119 T329 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8148 T283 oasc.ZkController.register We are http://127= .0.0.1:38076/solr/collection1/ and leader is http://127.0.0.1:38076/solr/co= llection1/ [junit4:junit4] 2> 8148 T283 oasc.ZkController.register No LogReplay need= ed for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38076/solr [junit4:junit4] 2> 8149 T283 oasc.ZkController.checkRecovery I am the lea= der, no recovery necessary [junit4:junit4] 2> 8152 T283 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 8153 T283 oass.SolrDispatchFilter.init user.dir=3D/usr= /home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/buil= d/solr-core/test/J1 [junit4:junit4] 2> 8154 T283 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() done [junit4:junit4] 2> 8154 T283 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fol= lowRedirects=3Dfalse [junit4:junit4] 2> 8381 T283 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 8385 T283 oejs.AbstractConnector.doStart Started Socke= tConnector@0.0.0.0:38080 [junit4:junit4] 2> 8386 T283 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 8387 T283 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3-= 1347753326973 [junit4:junit4] 2> 8388 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3= -1347753326973/' [junit4:junit4] 2> 8445 T283 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() [junit4:junit4] 2> 8446 T283 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 8446 T283 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3-= 1347753326973 [junit4:junit4] 2> 8447 T283 oasc.CoreContainer$Initializer.initialize lo= oking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3-1347753326973= /solr.xml [junit4:junit4] 2> 8448 T283 oasc.CoreContainer. New CoreContainer = 2051976295 [junit4:junit4] 2> 8449 T283 oasc.CoreContainer.load Loading CoreContaine= r using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3-1347753326973= /' [junit4:junit4] 2> 8450 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3-1347753= 326973/' [junit4:junit4] 2> 8490 T283 oasc.CoreContainer.load Registering Log List= ener [junit4:junit4] 2> 8515 T283 oasc.CoreContainer.initZooKeeper Zookeeper c= lient=3D127.0.0.1:38065/solr [junit4:junit4] 2> 8516 T283 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D5000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@15502c5e [junit4:junit4] 2> 8517 T340 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 8517 T283 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 8519 T340 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38065, initiating sessio= n [junit4:junit4] 2> 8519 T285 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38081 [junit4:junit4] 2> 8520 T285 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38081 [junit4:junit4] 2> 8523 T287 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139cc5b9b4e0005 with negotiated timeout 5000 for client /140= .211.11.196:38081 [junit4:junit4] 2> 8523 T340 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38065, session= id =3D 0x139cc5b9b4e0005, negotiated timeout =3D 5000 [junit4:junit4] 2> 8523 T341 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@15502c5e name:ZooKeeperConnectio= n Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 8524 T283 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 8525 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0005 type:crea= te cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 8537 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0005 type:crea= te cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 8539 T283 oasc.ZkController.createEphemeralLiveNode Re= gister node as live in ZooKeeper:/live_nodes/127.0.0.1:38080_solr [junit4:junit4] 2> 8540 T289 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139cc5b9b4e0005 type:dele= te cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/live_nodes/127.0.0.1:38080_solr Error:KeeperErrorCode =3D NoNode for = /solr/live_nodes/127.0.0.1:38080_solr [junit4:junit4] 2> 8542 T283 oascc.SolrZkClient.makePath makePath: /live_= nodes/127.0.0.1:38080_solr [junit4:junit4] 2> 8550 T303 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 8550 T317 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 8550 T329 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 8551 T283 oashc.HttpShardHandlerFactory.getParameter S= etting socketTimeout to: 0 [junit4:junit4] 2> 8552 T283 oashc.HttpShardHandlerFactory.getParameter S= etting urlScheme to: http:// [junit4:junit4] 2> 8552 T283 oashc.HttpShardHandlerFactory.getParameter S= etting connTimeout to: 0 [junit4:junit4] 2> 8553 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 8553 T283 oashc.HttpShardHandlerFactory.getParameter S= etting corePoolSize to: 0 [junit4:junit4] 2> 8554 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 8554 T283 oashc.HttpShardHandlerFactory.getParameter S= etting maxThreadIdleTime to: 5 [junit4:junit4] 2> 8554 T283 oashc.HttpShardHandlerFactory.getParameter S= etting sizeOfQueue to: -1 [junit4:junit4] 2> 8555 T283 oashc.HttpShardHandlerFactory.getParameter S= etting fairnessPolicy to: false [junit4:junit4] 2> 8555 T283 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&s= ocketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 8575 T283 oascc.ZkStateReader.createClusterStateWatche= rsAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 8583 T283 oasc.CoreContainer.create Creating SolrCore = 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3-= 1347753326973/collection1 [junit4:junit4] 2> 8583 T283 oasc.ZkController.createCollectionZkNode Che= ck for collection zkNode:collection1 [junit4:junit4] 2> 8584 T283 oasc.ZkController.createCollectionZkNode Col= lection zkNode exists [junit4:junit4] 2> 8585 T283 oasc.ZkController.readConfigName Load collec= tion config from:/collections/collection1 [junit4:junit4] 2> 8587 T283 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3-1347753= 326973/collection1/' [junit4:junit4] 2> 8588 T283 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk= -Java6/solr/build/solr-core/test/J1/solrtest-jetty3-1347753326973/collectio= n1/lib/classes/' to classloader [junit4:junit4] 2> 8589 T283 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk= -Java6/solr/build/solr-core/test/J1/solrtest-jetty3-1347753326973/collectio= n1/lib/README' to classloader [junit4:junit4] 2> 8626 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 8639 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8639 T329 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8639 T341 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8639 T317 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8641 T283 oasc.SolrConfig. Using Lucene MatchVer= sion: LUCENE_50 [junit4:junit4] 2> 8714 T283 oasc.SolrConfig. Loaded SolrConfig: so= lrconfig.xml [junit4:junit4] 2> 8816 T283 oass.IndexSchema.readSchema Reading Solr Sch= ema [junit4:junit4] 2> 8824 T283 oass.IndexSchema.readSchema Schema name=3Dte= st [junit4:junit4] 2> 9491 T283 oass.OpenExchangeRatesOrgProvider.init Initi= alized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 9500 T283 oass.IndexSchema.readSchema default search f= ield in schema is text [junit4:junit4] 2> 9503 T283 oass.IndexSchema.readSchema unique key field= : id [junit4:junit4] 2> 9525 T283 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 9529 T283 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 9533 T283 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 9536 T283 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 9538 T283 oasc.SolrCore. [collection1] Opening n= ew SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tr= unk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty3-1347753326973/coll= ection1/, dataDir=3D./org.apache.solr.cloud.BasicDistributedZk2Test-1347753= 318806/jetty3/ [junit4:junit4] 2> 9539 T283 oasc.JmxMonitoredMap. JMX monitoring i= s enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBe= anServer@16edbe39 [junit4:junit4] 2> 9540 T283 oasc.SolrCore.getNewIndexDir WARNING New ind= ex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistri= butedZk2Test-1347753318806/jetty3/index/ [junit4:junit4] 2> 9540 T283 oasc.SolrCore.initIndex WARNING [collection1= ] Solr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-134= 7753318806/jetty3/index' doesn't exist. Creating new index... [junit4:junit4] 2> 9541 T283 oasc.CachingDirectoryFactory.get return new = directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tru= nk-Java6/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistribu= tedZk2Test-1347753318806/jetty3/index forceNew:false [junit4:junit4] 2> 9546 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletio= nPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty3/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 9546 T283 oasc.SolrDeletionPolicy.updateCommits newest= commit =3D 1 [junit4:junit4] 2> 9547 T283 oasc.SolrCore.initWriters created xml: solr.= XMLResponseWriter [junit4:junit4] 2> 9549 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe" [junit4:junit4] 2> 9549 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe-allfields" [junit4:junit4] 2> 9549 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "st= ored_sig" [junit4:junit4] 2> 9550 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "un= iq-fields" [junit4:junit4] 2> 9550 T283 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "di= strib-dup-test-chain-implicit" [junit4:junit4] 2> 9551 T283 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 9551 T283 oasc.RequestHandlers.initHandlersFromConfig = created /replication: solr.ReplicationHandler [junit4:junit4] 2> 9552 T283 oasc.RequestHandlers.initHandlersFromConfig = created standard: solr.StandardRequestHandler [junit4:junit4] 2> 9552 T283 oasc.RequestHandlers.initHandlersFromConfig = created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 9553 T283 oasc.RequestHandlers.initHandlersFromConfig = created dismax: solr.SearchHandler [junit4:junit4] 2> 9554 T283 oasc.RequestHandlers.initHandlersFromConfig = created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 9554 T283 oasc.RequestHandlers.initHandlersFromConfig = created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 9555 T283 oasc.RequestHandlers.initHandlersFromConfig = created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 9555 T283 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 9555 T283 oasc.RequestHandlers.initHandlersFromConfig = created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 9556 T283 oasc.RequestHandlers.initHandlersFromConfig = created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 9557 T283 oasc.RequestHandlers.initHandlersFromConfig = created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 9557 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 9558 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 9558 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 9559 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.S= earchHandler [junit4:junit4] 2> 9559 T283 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 9560 T283 oasc.RequestHandlers.initHandlersFromConfig = created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 9560 T283 oasc.RequestHandlers.initHandlersFromConfig = created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 9561 T283 oasc.RequestHandlers.initHandlersFromConfig = created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 9564 T283 oashl.XMLLoader.init xsltCacheLifetimeSecond= s=3D60 [junit4:junit4] 2> 9568 T283 oasc.SolrCore.initDeprecatedSupport WARNING = solrconfig.xml uses deprecated , Please update your co= nfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 9569 T283 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> 9573 T283 oass.SolrIndexSearcher. Opening Search= er@28e34772 main [junit4:junit4] 2> 9574 T283 oasu.CommitTracker. Hard AutoCommit: d= isabled [junit4:junit4] 2> 9574 T283 oasu.CommitTracker. Soft AutoCommit: d= isabled [junit4:junit4] 2> 9575 T283 oashc.SpellCheckComponent.inform Initializin= g spell checkers [junit4:junit4] 2> 9580 T283 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4:junit4] 2> 9629 T342 oasc.SolrCore.registerSearcher [collection1]= Registered new searcher Searcher@28e34772 main{StandardDirectoryReader(seg= ments_1:1)} [junit4:junit4] 2> 9651 T304 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 9664 T303 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 9664 T317 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 9664 T341 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 9664 T329 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 10136 T283 oasc.CoreContainer.register registering cor= e: collection1 [junit4:junit4] 2> 10136 T283 oasc.ZkController.register Register shard -= core:collection1 address:http://127.0.0.1:38080/solr shardId:shard1 [junit4:junit4] 2> 10141 T283 oasc.ZkController.register We are http://12= 7.0.0.1:38080/solr/collection1/ and leader is http://127.0.0.1:38073/solr/c= ollection1/ [junit4:junit4] 2> 10141 T283 oasc.ZkController.register No LogReplay nee= ded for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38080/solr [junit4:junit4] 2> 10141 T283 oasc.ZkController.checkRecovery Core needs = to recover:collection1 [junit4:junit4] 2> 10142 T283 oasu.DefaultSolrCoreState.doRecovery Runnin= g recovery - first canceling any ongoing recovery [junit4:junit4] 2> ASYNC NEW_CORE C25 name=3Dcollection1 org.apache.solr= .core.SolrCore@1703c2db url=3Dhttp://127.0.0.1:38080/solr/collection1 node= =3D127.0.0.1:38080_solr [junit4:junit4] 2> 10147 T343 C25 P38080 oasc.RecoveryStrategy.run Starti= ng recovery process. core=3Dcollection1 recoveringAfterStartup=3Dtrue [junit4:junit4] 2> 10147 T343 C25 P38080 oasc.RecoveryStrategy.doRecovery= ###### startupVersions=3D[] [junit4:junit4] 2> 10147 T283 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 10149 T343 C25 P38080 oasc.RecoveryStrategy.doRecovery= Attempting to PeerSync from http://127.0.0.1:38073/solr/collection1/ core= =3Dcollection1 - recoveringAfterStartup=3Dtrue [junit4:junit4] 2> 10149 T283 oass.SolrDispatchFilter.init user.dir=3D/us= r/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/bui= ld/solr-core/test/J1 [junit4:junit4] 2> 10149 T283 oass.SolrDispatchFilter.init SolrDispatchFi= lter.init() done [junit4:junit4] 2> 10150 T283 oascsi.HttpClientUtil.createClient Creating= new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fo= llowRedirects=3Dfalse [junit4:junit4] 2> 10156 T343 C25 P38080 oascsi.HttpClientUtil.createClie= nt Creating new http client, config:maxConnectionsPerHost=3D20&maxConnectio= ns=3D10000&connTimeout=3D30000&socketTimeout=3D30000&retry=3Dfalse [junit4:junit4] 2> 10169 T304 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 10169 T343 C25 P38080 oasu.PeerSync.sync PeerSync: cor= e=3Dcollection1 url=3Dhttp://127.0.0.1:38080/solr START replicas=3D[http://= 127.0.0.1:38073/solr/collection1/] nUpdates=3D100 [junit4:junit4] 2> 10178 T343 C25 P38080 oasu.PeerSync.sync WARNING no fr= ame of reference to tell of we've missed updates [junit4:junit4] 2> 10179 T343 C25 P38080 oasc.RecoveryStrategy.doRecovery= PeerSync Recovery was not successful - trying replication. core=3Dcollecti= on1 [junit4:junit4] 2> 10179 T343 C25 P38080 oasc.RecoveryStrategy.doRecovery= Starting Replication Recovery. core=3Dcollection1 [junit4:junit4] 2> 10179 T343 C25 P38080 oascsi.HttpClientUtil.createClie= nt Creating new http client, config:maxConnections=3D128&maxConnectionsPerH= ost=3D32&followRedirects=3Dfalse [junit4:junit4] 2> 10182 T303 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 10183 T341 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 10183 T329 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 10183 T317 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> ASYNC NEW_CORE C26 name=3Dcollection1 org.apache.solr= .core.SolrCore@1d06f08e url=3Dhttp://127.0.0.1:38073/solr/collection1 node= =3D127.0.0.1:38073_solr [junit4:junit4] 2> 10197 T309 C26 P38073 REQ /get {distrib=3Dfalse&qt=3D/= get&wt=3Djavabin&version=3D2&getVersions=3D100} status=3D0 QTime=3D0=20 [junit4:junit4] 2> 10271 T283 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 10274 T283 oejs.AbstractConnector.doStart Started Sock= etConnector@0.0.0.0:38084 [junit4:junit4] 2> 10274 T283 oasc.SolrResourceLoader.locateSolrHome JNDI= not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 10275 T283 oasc.SolrResourceLoader.locateSolrHome usin= g system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty4= -1347753328963 [junit4:junit4] 2> 10275 T283 oasc.SolrResourceLoader. new SolrReso= urceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/= Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty= 4-1347753328963/' [junit4:junit4] 2> 10300 T283 oass.SolrDispatchFilter.init SolrDispatchFi= lter.init() [junit4:junit4] 2> 10301 T283 oasc.SolrResourceLoader.locateSolrHome JNDI= not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 10301 T283 oasc.SolrResourceLoader.locateSolrHome usin= g system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty4= -1347753328963 [junit4:junit4] 2> 10301 T283 oasc.CoreContainer$Initializer.initialize l= ooking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Te= sts-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty4-134775332896= 3/solr.xml [junit4:junit4] 2> 10302 T283 oasc.CoreContainer. New CoreContainer= 1293126184 [junit4:junit4] 2> 10302 T283 oasc.CoreContainer.load Loading CoreContain= er using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Te= sts-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty4-134775332896= 3/' [junit4:junit4] 2> 10302 T283 oasc.SolrResourceLoader. new SolrReso= urceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-S= olr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty4-134775= 3328963/' [junit4:junit4] 2> 10320 T283 oasc.CoreContainer.load Registering Log Lis= tener [junit4:junit4] 2> 10331 T283 oasc.CoreContainer.initZooKeeper Zookeeper = client=3D127.0.0.1:38065/solr [junit4:junit4] 2> 10332 T283 oaz.ZooKeeper. Initiating client conn= ection, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D5000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@4459116 [junit4:junit4] 2> 10333 T354 oaz.ClientCnxn$SendThread.startConnect Open= ing socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 10333 T283 oascc.ConnectionManager.waitForConnected Wa= iting for client to connect to ZooKeeper [junit4:junit4] 2> 10334 T354 oaz.ClientCnxn$SendThread.primeConnection S= ocket connection established to localhost/127.0.0.1:38065, initiating sessi= on [junit4:junit4] 2> 10334 T285 oazs.NIOServerCnxn$Factory.run Accepted soc= ket connection from /140.211.11.196:38085 [junit4:junit4] 2> 10334 T285 oazs.NIOServerCnxn.readConnectRequest Clien= t attempting to establish new session at /140.211.11.196:38085 [junit4:junit4] 2> 10336 T287 oazs.NIOServerCnxn.finishSessionInit Establ= ished session 0x139cc5b9b4e0006 with negotiated timeout 5000 for client /14= 0.211.11.196:38085 [junit4:junit4] 2> 10336 T354 oaz.ClientCnxn$SendThread.readConnectResult= Session establishment complete on server localhost/127.0.0.1:38065, sessio= nid =3D 0x139cc5b9b4e0006, negotiated timeout =3D 5000 [junit4:junit4] 2> 10337 T355 oascc.ConnectionManager.process Watcher org= .apache.solr.common.cloud.ConnectionManager@4459116 name:ZooKeeperConnectio= n Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 10337 T283 oascc.ConnectionManager.waitForConnected Cl= ient is connected to ZooKeeper [junit4:junit4] 2> 10338 T289 oazs.PrepRequestProcessor.pRequest Got user= -level KeeperException when processing sessionid:0x139cc5b9b4e0006 type:cre= ate cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 10347 T289 oazs.PrepRequestProcessor.pRequest Got user= -level KeeperException when processing sessionid:0x139cc5b9b4e0006 type:cre= ate cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 10348 T283 oasc.ZkController.createEphemeralLiveNode R= egister node as live in ZooKeeper:/live_nodes/127.0.0.1:38084_solr [junit4:junit4] 2> 10349 T289 oazs.PrepRequestProcessor.pRequest Got user= -level KeeperException when processing sessionid:0x139cc5b9b4e0006 type:del= ete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/live_nodes/127.0.0.1:38084_solr Error:KeeperErrorCode =3D NoNode for= /solr/live_nodes/127.0.0.1:38084_solr [junit4:junit4] 2> 10350 T283 oascc.SolrZkClient.makePath makePath: /live= _nodes/127.0.0.1:38084_solr [junit4:junit4] 2> 10358 T303 oascc.ZkStateReader$3.process Updating live= nodes [junit4:junit4] 2> 10359 T329 oascc.ZkStateReader$3.process Updating live= nodes [junit4:junit4] 2> 10359 T341 oascc.ZkStateReader$3.process Updating live= nodes [junit4:junit4] 2> 10359 T317 oascc.ZkStateReader$3.process Updating live= nodes [junit4:junit4] 2> 10360 T283 oashc.HttpShardHandlerFactory.getParameter = Setting socketTimeout to: 0 [junit4:junit4] 2> 10360 T283 oashc.HttpShardHandlerFactory.getParameter = Setting urlScheme to: http:// [junit4:junit4] 2> 10360 T283 oashc.HttpShardHandlerFactory.getParameter = Setting connTimeout to: 0 [junit4:junit4] 2> 10361 T283 oashc.HttpShardHandlerFactory.getParameter = Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 10361 T283 oashc.HttpShardHandlerFactory.getParameter = Setting corePoolSize to: 0 [junit4:junit4] 2> 10361 T283 oashc.HttpShardHandlerFactory.getParameter = Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 10362 T283 oashc.HttpShardHandlerFactory.getParameter = Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 10362 T283 oashc.HttpShardHandlerFactory.getParameter = Setting sizeOfQueue to: -1 [junit4:junit4] 2> 10362 T283 oashc.HttpShardHandlerFactory.getParameter = Setting fairnessPolicy to: false [junit4:junit4] 2> 10363 T283 oascsi.HttpClientUtil.createClient Creating= new http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&= socketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 10376 T283 oascc.ZkStateReader.createClusterStateWatch= ersAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 10382 T283 oasc.CoreContainer.create Creating SolrCore= 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty4= -1347753328963/collection1 [junit4:junit4] 2> 10382 T283 oasc.ZkController.createCollectionZkNode Ch= eck for collection zkNode:collection1 [junit4:junit4] 2> 10383 T283 oasc.ZkController.createCollectionZkNode Co= llection zkNode exists [junit4:junit4] 2> 10383 T283 oasc.ZkController.readConfigName Load colle= ction config from:/collections/collection1 [junit4:junit4] 2> 10385 T283 oasc.SolrResourceLoader. new SolrReso= urceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-S= olr-Tests-trunk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty4-134775= 3328963/collection1/' [junit4:junit4] 2> 10386 T283 oasc.SolrResourceLoader.replaceClassLoader = Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trun= k-Java6/solr/build/solr-core/test/J1/solrtest-jetty4-1347753328963/collecti= on1/lib/README' to classloader [junit4:junit4] 2> 10387 T283 oasc.SolrResourceLoader.replaceClassLoader = Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trun= k-Java6/solr/build/solr-core/test/J1/solrtest-jetty4-1347753328963/collecti= on1/lib/classes/' to classloader [junit4:junit4] 2> 10425 T283 oasc.SolrConfig. Using Lucene MatchVe= rsion: LUCENE_50 [junit4:junit4] 2> 10482 T283 oasc.SolrConfig. Loaded SolrConfig: s= olrconfig.xml [junit4:junit4] 2> 10583 T283 oass.IndexSchema.readSchema Reading Solr Sc= hema [junit4:junit4] 2> 10592 T283 oass.IndexSchema.readSchema Schema name=3Dt= est [junit4:junit4] 2> 11276 T283 oass.OpenExchangeRatesOrgProvider.init Init= ialized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 11289 T283 oass.IndexSchema.readSchema default search = field in schema is text [junit4:junit4] 2> 11293 T283 oass.IndexSchema.readSchema unique key fiel= d: id [junit4:junit4] 2> 11320 T283 oass.FileExchangeRateProvider.reload Reload= ing exchange rates from file currency.xml [junit4:junit4] 2> 11326 T283 oass.FileExchangeRateProvider.reload Reload= ing exchange rates from file currency.xml [junit4:junit4] 2> 11332 T283 oass.OpenExchangeRatesOrgProvider.reload Re= loading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 11336 T283 oass.OpenExchangeRatesOrgProvider.reload Re= loading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 11339 T283 oasc.SolrCore. [collection1] Opening = new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-t= runk-Java6/solr/build/solr-core/test/J1/./solrtest-jetty4-1347753328963/col= lection1/, dataDir=3D./org.apache.solr.cloud.BasicDistributedZk2Test-134775= 3318806/jetty4/ [junit4:junit4] 2> 11340 T283 oasc.JmxMonitoredMap. JMX monitoring = is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMB= eanServer@16edbe39 [junit4:junit4] 2> 11341 T283 oasc.SolrCore.getNewIndexDir WARNING New in= dex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistr= ibutedZk2Test-1347753318806/jetty4/index/ [junit4:junit4] 2> 11342 T283 oasc.SolrCore.initIndex WARNING [collection= 1] Solr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-13= 47753318806/jetty4/index' doesn't exist. Creating new index... [junit4:junit4] 2> 11343 T283 oasc.CachingDirectoryFactory.get return new= directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-tr= unk-Java6/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistrib= utedZk2Test-1347753318806/jetty4/index forceNew:false [junit4:junit4] 2> 11375 T283 oasc.SolrDeletionPolicy.onCommit SolrDeleti= onPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty4/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 11376 T283 oasc.SolrDeletionPolicy.updateCommits newes= t commit =3D 1 [junit4:junit4] 2> 11377 T283 oasc.SolrCore.initWriters created xml: solr= .XMLResponseWriter [junit4:junit4] 2> 11380 T283 oasup.UpdateRequestProcessorChain.init inse= rting DistributedUpdateProcessorFactory into updateRequestProcessorChain "d= edupe" [junit4:junit4] 2> 11381 T283 oasup.UpdateRequestProcessorChain.init inse= rting DistributedUpdateProcessorFactory into updateRequestProcessorChain "d= edupe-allfields" [junit4:junit4] 2> 11382 T283 oasup.UpdateRequestProcessorChain.init inse= rting DistributedUpdateProcessorFactory into updateRequestProcessorChain "s= tored_sig" [junit4:junit4] 2> 11382 T283 oasup.UpdateRequestProcessorChain.init inse= rting DistributedUpdateProcessorFactory into updateRequestProcessorChain "u= niq-fields" [junit4:junit4] 2> 11383 T283 oasup.UpdateRequestProcessorChain.init inse= rting DistributedUpdateProcessorFactory into updateRequestProcessorChain "d= istrib-dup-test-chain-implicit" [junit4:junit4] 2> 11384 T283 oasc.RequestHandlers.initHandlersFromConfig= adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 11384 T283 oasc.RequestHandlers.initHandlersFromConfig= created /replication: solr.ReplicationHandler [junit4:junit4] 2> 11385 T283 oasc.RequestHandlers.initHandlersFromConfig= created standard: solr.StandardRequestHandler [junit4:junit4] 2> 11386 T283 oasc.RequestHandlers.initHandlersFromConfig= created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 11387 T283 oasc.RequestHandlers.initHandlersFromConfig= created dismax: solr.SearchHandler [junit4:junit4] 2> 11388 T283 oasc.RequestHandlers.initHandlersFromConfig= created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 11389 T283 oasc.RequestHandlers.initHandlersFromConfig= created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 11390 T283 oasc.RequestHandlers.initHandlersFromConfig= created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 11390 T283 oasc.RequestHandlers.initHandlersFromConfig= adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 11391 T283 oasc.RequestHandlers.initHandlersFromConfig= created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 11392 T283 oasc.RequestHandlers.initHandlersFromConfig= created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 11393 T283 oasc.RequestHandlers.initHandlersFromConfig= created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 11394 T283 oasc.RequestHandlers.initHandlersFromConfig= created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 11394 T283 oasc.RequestHandlers.initHandlersFromConfig= created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchH= andler [junit4:junit4] 2> 11395 T283 oasc.RequestHandlers.initHandlersFromConfig= created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchH= andler [junit4:junit4] 2> 11396 T283 oasc.RequestHandlers.initHandlersFromConfig= created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.= SearchHandler [junit4:junit4] 2> 11397 T283 oasc.RequestHandlers.initHandlersFromConfig= created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 11398 T283 oasc.RequestHandlers.initHandlersFromConfig= created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 11399 T283 oasc.RequestHandlers.initHandlersFromConfig= created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 11400 T283 oasc.RequestHandlers.initHandlersFromConfig= created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 11404 T283 oashl.XMLLoader.init xsltCacheLifetimeSecon= ds=3D60 [junit4:junit4] 2> 11409 T283 oasc.SolrCore.initDeprecatedSupport WARNING= solrconfig.xml uses deprecated , Please update your c= onfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 11411 T283 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> 11416 T283 oass.SolrIndexSearcher. Opening Searc= her@53f61628 main [junit4:junit4] 2> 11417 T283 oasu.CommitTracker. Hard AutoCommit: = disabled [junit4:junit4] 2> 11418 T283 oasu.CommitTracker. Soft AutoCommit: = disabled [junit4:junit4] 2> 11419 T283 oashc.SpellCheckComponent.inform Initializi= ng spell checkers [junit4:junit4] 2> 11427 T283 oass.DirectSolrSpellChecker.init init: {nam= e=3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLen= gth=3D3} [junit4:junit4] 2> 11484 T356 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@53f61628 main{StandardDirectoryReader(se= gments_1:1)} [junit4:junit4] 2> 11694 T304 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 11708 T303 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11708 T317 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11708 T329 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11708 T355 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11708 T341 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11995 T283 oasc.CoreContainer.register registering cor= e: collection1 [junit4:junit4] 2> 11995 T283 oasc.ZkController.register Register shard -= core:collection1 address:http://127.0.0.1:38084/solr shardId:shard2 [junit4:junit4] 2> 12001 T283 oasc.ZkController.register We are http://12= 7.0.0.1:38084/solr/collection1/ and leader is http://127.0.0.1:38076/solr/c= ollection1/ [junit4:junit4] 2> 12001 T283 oasc.ZkController.register No LogReplay nee= ded for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38084/solr [junit4:junit4] 2> 12002 T283 oasc.ZkController.checkRecovery Core needs = to recover:collection1 [junit4:junit4] 2> 12002 T283 oasu.DefaultSolrCoreState.doRecovery Runnin= g recovery - first canceling any ongoing recovery [junit4:junit4] 2> ASYNC NEW_CORE C27 name=3Dcollection1 org.apache.solr= .core.SolrCore@7437e222 url=3Dhttp://127.0.0.1:38084/solr/collection1 node= =3D127.0.0.1:38084_solr [junit4:junit4] 2> 12003 T357 C27 P38084 oasc.RecoveryStrategy.run Starti= ng recovery process. core=3Dcollection1 recoveringAfterStartup=3Dtrue [junit4:junit4] 2> 12004 T357 C27 P38084 oasc.RecoveryStrategy.doRecovery= ###### startupVersions=3D[] [junit4:junit4] 2> 12003 T283 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 12005 T357 C27 P38084 oasc.RecoveryStrategy.doRecovery= Attempting to PeerSync from http://127.0.0.1:38076/solr/collection1/ core= =3Dcollection1 - recoveringAfterStartup=3Dtrue [junit4:junit4] 2> 12005 T357 C27 P38084 oasu.PeerSync.sync PeerSync: cor= e=3Dcollection1 url=3Dhttp://127.0.0.1:38084/solr START replicas=3D[http://= 127.0.0.1:38076/solr/collection1/] nUpdates=3D100 [junit4:junit4] 2> 12006 T283 oass.SolrDispatchFilter.init user.dir=3D/us= r/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/bui= ld/solr-core/test/J1 [junit4:junit4] 2> 12006 T357 C27 P38084 oasu.PeerSync.sync WARNING no fr= ame of reference to tell of we've missed updates [junit4:junit4] 2> 12006 T283 oass.SolrDispatchFilter.init SolrDispatchFi= lter.init() done [junit4:junit4] 2> 12052 T357 C27 P38084 oasc.RecoveryStrategy.doRecovery= PeerSync Recovery was not successful - trying replication. core=3Dcollecti= on1 [junit4:junit4] 2> 12052 T357 C27 P38084 oasc.RecoveryStrategy.doRecovery= Starting Replication Recovery. core=3Dcollection1 [junit4:junit4] 2> 12052 T283 oascsi.HttpClientUtil.createClient Creating= new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fo= llowRedirects=3Dfalse [junit4:junit4] 2> 12053 T357 C27 P38084 oascsi.HttpClientUtil.createClie= nt Creating new http client, config:maxConnections=3D128&maxConnectionsPerH= ost=3D32&followRedirects=3Dfalse [junit4:junit4] 2> ASYNC NEW_CORE C28 name=3Dcollection1 org.apache.solr= .core.SolrCore@76fa4dab url=3Dhttp://127.0.0.1:38076/solr/collection1 node= =3D127.0.0.1:38076_solr [junit4:junit4] 2> 12059 T321 C28 P38076 REQ /get {distrib=3Dfalse&qt=3D/= get&wt=3Djavabin&version=3D2&getVersions=3D100} status=3D0 QTime=3D0=20 [junit4:junit4] 2> 12078 T283 oaz.ZooKeeper. Initiating client conn= ection, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D10000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@4aec078b [junit4:junit4] 2> 12079 T359 oaz.ClientCnxn$SendThread.startConnect Open= ing socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 12079 T283 oascc.ConnectionManager.waitForConnected Wa= iting for client to connect to ZooKeeper [junit4:junit4] 2> 12080 T359 oaz.ClientCnxn$SendThread.primeConnection S= ocket connection established to localhost/127.0.0.1:38065, initiating sessi= on [junit4:junit4] 2> 12080 T285 oazs.NIOServerCnxn$Factory.run Accepted soc= ket connection from /140.211.11.196:38089 [junit4:junit4] 2> 12081 T285 oazs.NIOServerCnxn.readConnectRequest Clien= t attempting to establish new session at /140.211.11.196:38089 [junit4:junit4] 2> 12082 T287 oazs.NIOServerCnxn.finishSessionInit Establ= ished session 0x139cc5b9b4e0007 with negotiated timeout 10000 for client /1= 40.211.11.196:38089 [junit4:junit4] 2> 12082 T359 oaz.ClientCnxn$SendThread.readConnectResult= Session establishment complete on server localhost/127.0.0.1:38065, sessio= nid =3D 0x139cc5b9b4e0007, negotiated timeout =3D 10000 [junit4:junit4] 2> 12082 T360 oascc.ConnectionManager.process Watcher org= .apache.solr.common.cloud.ConnectionManager@4aec078b name:ZooKeeperConnecti= on Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected = type:None path:null path:null type:None [junit4:junit4] 2> 12082 T283 oascc.ConnectionManager.waitForConnected Cl= ient is connected to ZooKeeper [junit4:junit4] 2> 12083 T283 oascc.ZkStateReader.createClusterStateWatch= ersAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 12087 T283 oasc.ChaosMonkey.monkeyLog monkey: init - e= xpire sessions:true cause connection loss:true [junit4:junit4] 2> 12088 T283 oascsi.HttpClientUtil.createClient Creating= new http client, config: [junit4:junit4] 2> 12101 T283 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> ASYNC NEW_CORE C29 name=3Dcollection1 org.apache.solr= .core.SolrCore@3ffa1b16 url=3Dhttp://127.0.0.1:38070/solr/collection1 node= =3D127.0.0.1:38070_solr [junit4:junit4] 2> 12126 T295 C29 P38070 oascsi.HttpClientUtil.createClie= nt Creating new http client, config:maxConnections=3D500&maxConnectionsPerH= ost=3D16 [junit4:junit4] 2> 12154 T295 C29 P38070 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/control/data/index,segFN= =3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 12155 T295 C29 P38070 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 12189 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[1 (1413221796755275776)]} 0 78 [junit4:junit4] 2> 12190 T283 oaz.ZooKeeper. Initiating client conn= ection, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D10000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@7357444f [junit4:junit4] 2> 12191 T361 oaz.ClientCnxn$SendThread.startConnect Open= ing socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 12191 T283 oascc.ConnectionManager.waitForConnected Wa= iting for client to connect to ZooKeeper [junit4:junit4] 2> 12192 T361 oaz.ClientCnxn$SendThread.primeConnection S= ocket connection established to localhost/127.0.0.1:38065, initiating sessi= on [junit4:junit4] 2> 12193 T285 oazs.NIOServerCnxn$Factory.run Accepted soc= ket connection from /140.211.11.196:38091 [junit4:junit4] 2> 12193 T285 oazs.NIOServerCnxn.readConnectRequest Clien= t attempting to establish new session at /140.211.11.196:38091 [junit4:junit4] 2> 12194 T287 oazs.NIOServerCnxn.finishSessionInit Establ= ished session 0x139cc5b9b4e0008 with negotiated timeout 10000 for client /1= 40.211.11.196:38091 [junit4:junit4] 2> 12194 T361 oaz.ClientCnxn$SendThread.readConnectResult= Session establishment complete on server localhost/127.0.0.1:38065, sessio= nid =3D 0x139cc5b9b4e0008, negotiated timeout =3D 10000 [junit4:junit4] 2> 12195 T362 oascc.ConnectionManager.process Watcher org= .apache.solr.common.cloud.ConnectionManager@7357444f name:ZooKeeperConnecti= on Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected = type:None path:null path:null type:None [junit4:junit4] 2> 12195 T283 oascc.ConnectionManager.waitForConnected Cl= ient is connected to ZooKeeper [junit4:junit4] 2> 12196 T283 oascc.ZkStateReader.createClusterStateWatch= ersAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> C25_STATE=3Dcoll:collection1 core:collection1 props:{= shard=3Dshard1, roles=3Dnull, state=3Drecovering, core=3Dcollection1, colle= ction=3Dcollection1, node_name=3D127.0.0.1:38080_solr, base_url=3Dhttp://12= 7.0.0.1:38080/solr} [junit4:junit4] 2> 12197 T343 C25 P38080 oasc.RecoveryStrategy.doRecovery= Begin buffering updates. core=3Dcollection1 [junit4:junit4] 2> 12197 T343 C25 P38080 oasu.UpdateLog.bufferUpdates Sta= rting to buffer updates. FSUpdateLog{state=3DACTIVE, tlog=3Dnull} [junit4:junit4] 2> 12197 T343 C25 P38080 oasc.RecoveryStrategy.replicate = Attempting to replicate from http://127.0.0.1:38073/solr/collection1/. core= =3Dcollection1 [junit4:junit4] 2> 12198 T343 C25 P38080 oascsi.HttpClientUtil.createClie= nt Creating new http client, config:maxConnections=3D128&maxConnectionsPerH= ost=3D32&followRedirects=3Dfalse [junit4:junit4] 2> 12213 T311 C26 P38073 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 12214 T304 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 12218 T311 C26 P38073 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty1/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 12219 T311 C26 P38073 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 12220 T311 C26 P38073 oass.SolrIndexSearcher. Op= ening Searcher@2dcf4363 main [junit4:junit4] 2> 12221 T311 C26 P38073 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 12223 T318 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@2dcf4363 main{StandardDirectoryReader(se= gments_1:1)} [junit4:junit4] 2> 12223 T311 C26 P38073 /update {waitSearcher=3Dtrue&com= mit=3Dtrue&commit_end_point=3Dtrue&wt=3Djavabin&softCommit=3Dfalse&version= =3D2} {commit=3D} 0 10 [junit4:junit4] 2> 12224 T343 C25 P38080 oash.ReplicationHandler.inform C= ommits will be reserved for 10000 [junit4:junit4] 2> 12224 T343 C25 P38080 oash.SnapPuller. No value= set for 'pollInterval'. Timer Task not started. [junit4:junit4] 2> 12227 T313 C26 P38073 oash.ReplicationHandler.inform C= ommits will be reserved for 10000 [junit4:junit4] 2> 12227 T313 C26 P38073 REQ /replication {command=3Dinde= xversion&wt=3Djavabin&qt=3D/replication&version=3D2} status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 12228 T355 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12228 T362 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12228 T360 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12228 T317 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12227 T329 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12227 T341 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12227 T303 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12236 T343 C25 P38080 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty3/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 12236 T343 C25 P38080 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 12237 T343 C25 P38080 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 12246 T343 C25 P38080 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty3/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty3/index,segFN=3Dsegme= nts_2,generation=3D2,filenames=3D[segments_2] [junit4:junit4] 2> 12246 T343 C25 P38080 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 2 [junit4:junit4] 2> 12250 T343 C25 P38080 oass.SolrIndexSearcher. Op= ening Searcher@53c3fdfb main [junit4:junit4] 2> 12251 T343 C25 P38080 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 12252 T342 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@53c3fdfb main{StandardDirectoryReader(se= gments_2:2)} [junit4:junit4] 2> 12253 T343 C25 P38080 oasc.RecoveryStrategy.replay No = replay needed. core=3Dcollection1 [junit4:junit4] 2> 12253 T343 C25 P38080 oasc.RecoveryStrategy.doRecovery= Replication Recovery was successful - registering as Active. core=3Dcollec= tion1 [junit4:junit4] 2> 12255 T343 C25 P38080 oasc.RecoveryStrategy.doRecovery= Finished recovery process. core=3Dcollection1 [junit4:junit4] 2> 12282 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D4=20 [junit4:junit4] 2> 12283 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[1 (1413221796831821824)]} 0 70 [junit4:junit4] 2> 12284 T283 oasc.AbstractDistribZkTestBase.waitForRecov= eriesToFinish Wait for recoveries to finish - collection: collection1 failO= nTimeout:true timeout (sec):1800 [junit4:junit4] 2> 12285 T283 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 12737 T304 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 12757 T329 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12757 T362 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12757 T360 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12757 T317 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12757 T303 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12757 T355 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12757 T341 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 13287 T283 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 14289 T283 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> C27_STATE=3Dcoll:collection1 core:collection1 props:{= shard=3Dshard2, roles=3Dnull, state=3Drecovering, core=3Dcollection1, colle= ction=3Dcollection1, node_name=3D127.0.0.1:38084_solr, base_url=3Dhttp://12= 7.0.0.1:38084/solr} [junit4:junit4] 2> 15076 T357 C27 P38084 oasc.RecoveryStrategy.doRecovery= Begin buffering updates. core=3Dcollection1 [junit4:junit4] 2> 15076 T357 C27 P38084 oasu.UpdateLog.bufferUpdates Sta= rting to buffer updates. FSUpdateLog{state=3DACTIVE, tlog=3Dnull} [junit4:junit4] 2> 15077 T357 C27 P38084 oasc.RecoveryStrategy.replicate = Attempting to replicate from http://127.0.0.1:38076/solr/collection1/. core= =3Dcollection1 [junit4:junit4] 2> 15077 T357 C27 P38084 oascsi.HttpClientUtil.createClie= nt Creating new http client, config:maxConnections=3D128&maxConnectionsPerH= ost=3D32&followRedirects=3Dfalse [junit4:junit4] 2> 15085 T323 C28 P38076 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15089 T323 C28 P38076 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty2/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 15089 T323 C28 P38076 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 15090 T323 C28 P38076 oass.SolrIndexSearcher. Op= ening Searcher@66e0e0e2 main [junit4:junit4] 2> 15090 T323 C28 P38076 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15092 T330 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@66e0e0e2 main{StandardDirectoryReader(se= gments_1:1)} [junit4:junit4] 2> 15092 T323 C28 P38076 /update {waitSearcher=3Dtrue&com= mit=3Dtrue&commit_end_point=3Dtrue&wt=3Djavabin&softCommit=3Dfalse&version= =3D2} {commit=3D} 0 7 [junit4:junit4] 2> 15093 T357 C27 P38084 oash.ReplicationHandler.inform C= ommits will be reserved for 10000 [junit4:junit4] 2> 15093 T357 C27 P38084 oash.SnapPuller. No value= set for 'pollInterval'. Timer Task not started. [junit4:junit4] 2> 15095 T324 C28 P38076 oash.ReplicationHandler.inform C= ommits will be reserved for 10000 [junit4:junit4] 2> 15095 T324 C28 P38076 REQ /replication {command=3Dinde= xversion&wt=3Djavabin&qt=3D/replication&version=3D2} status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 15098 T357 C27 P38084 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty4/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 15098 T357 C27 P38084 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 15099 T357 C27 P38084 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15101 T357 C27 P38084 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty4/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty4/index,segFN=3Dsegme= nts_2,generation=3D2,filenames=3D[segments_2] [junit4:junit4] 2> 15102 T357 C27 P38084 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 2 [junit4:junit4] 2> 15104 T357 C27 P38084 oass.SolrIndexSearcher. Op= ening Searcher@57083fae main [junit4:junit4] 2> 15104 T357 C27 P38084 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15106 T356 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@57083fae main{StandardDirectoryReader(se= gments_2:2)} [junit4:junit4] 2> 15106 T357 C27 P38084 oasc.RecoveryStrategy.replay No = replay needed. core=3Dcollection1 [junit4:junit4] 2> 15106 T357 C27 P38084 oasc.RecoveryStrategy.doRecovery= Replication Recovery was successful - registering as Active. core=3Dcollec= tion1 [junit4:junit4] 2> 15118 T357 C27 P38084 oasc.RecoveryStrategy.doRecovery= Finished recovery process. core=3Dcollection1 [junit4:junit4] 2> 15274 T304 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 15291 T329 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 15292 T362 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 15292 T360 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 15292 T317 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 15292 T303 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 15291 T355 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 15291 T341 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 15292 T283 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 15297 T295 C29 P38070 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15381 T295 C29 P38070 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/control/data/index,segFN= =3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/control/data/index,segFN= =3Dsegments_2,generation=3D2,filenames=3D[_0_MockRandom_0.tib, _0_Block_0.p= os, _0_Block_0.tip, _0.fnm, _0_Block_0.doc, _0_Block_0.tim, _0_Memory_0.ram= , _0_MockVariableIntBlock_0.doc, _0_MockRandom_0.prx, _0_nrm.cfs, _0_MockVa= riableIntBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockRandom_0.frq, _= 0_MockRandom_0.sd, _0_MockVariableIntBlock_0.tib, _0_MockVariableIntBlock_0= .frq, _0_nrm.cfe, _0_MockRandom_0.tii, _0_MockVariableIntBlock_0.pos, segme= nts_2, _0.fdx, _0.si, _0.fdt, _0_MockVariableIntBlock_0.tii] [junit4:junit4] 2> 15382 T295 C29 P38070 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 2 [junit4:junit4] 2> 15414 T295 C29 P38070 oass.SolrIndexSearcher. Op= ening Searcher@7ba01bb6 main [junit4:junit4] 2> 15415 T295 C29 P38070 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15416 T306 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@7ba01bb6 main{StandardDirectoryReader(se= gments_2:3 _0(5.0):C1)} [junit4:junit4] 2> 15417 T295 C29 P38070 /update {waitSearcher=3Dtrue&wt= =3Djavabin&commit=3Dtrue&softCommit=3Dfalse&version=3D2} {commit=3D} 0 120 [junit4:junit4] 2> 15420 T312 C26 P38073 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15526 T312 C26 P38073 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty1/index,segFN=3Dsegme= nts_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty1/index,segFN=3Dsegme= nts_2,generation=3D2,filenames=3D[_0_MockRandom_0.tib, _0_Block_0.pos, _0_B= lock_0.tip, _0.fnm, _0_Block_0.doc, _0_Block_0.tim, _0_Memory_0.ram, _0_Moc= kVariableIntBlock_0.doc, _0_MockRandom_0.prx, _0_nrm.cfs, _0_MockVariableIn= tBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockRandom_0.frq, _0_MockRa= ndom_0.sd, _0_MockRandom_0.tiv, _0_MockVariableIntBlock_0.tib, _0_MockVaria= bleIntBlock_0.frq, _0_nrm.cfe, _0_MockVariableIntBlock_0.pos, segments_2, _= 0.fdx, _0.si, _0.fdt, _0_MockVariableIntBlock_0.tii] [junit4:junit4] 2> 15527 T312 C26 P38073 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 2 [junit4:junit4] 2> 15543 T312 C26 P38073 oass.SolrIndexSearcher. Op= ening Searcher@353180dc main [junit4:junit4] 2> 15544 T312 C26 P38073 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15545 T318 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@353180dc main{StandardDirectoryReader(se= gments_2:3 _0(5.0):C1)} [junit4:junit4] 2> 15546 T312 C26 P38073 oasu.SolrCmdDistributor.distribC= ommit Distrib commit to:[StdNode: http://127.0.0.1:38080/solr/collection1/,= StdNode: http://127.0.0.1:38076/solr/collection1/, StdNode: http://127.0.0= .1:38084/solr/collection1/] [junit4:junit4] 2> C25_STATE=3Dcoll:collection1 core:collection1 props:{= shard=3Dshard1, roles=3Dnull, state=3Dactive, core=3Dcollection1, collectio= n=3Dcollection1, node_name=3D127.0.0.1:38080_solr, base_url=3Dhttp://127.0.= 0.1:38080/solr} [junit4:junit4] 2> 15549 T333 C25 P38080 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15549 T325 C28 P38076 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15553 T325 C28 P38076 oass.SolrIndexSearcher. Op= ening Searcher@58f5def1 main [junit4:junit4] 2> 15553 T325 C28 P38076 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15555 T330 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@58f5def1 main{StandardDirectoryReader(se= gments_1:1)} [junit4:junit4] 2> 15558 T325 C28 P38076 /update {waitSearcher=3Dtrue&com= mit=3Dtrue&wt=3Djavabin&commit_end_point=3Dtrue&expungeDeletes=3Dfalse&soft= Commit=3Dfalse&version=3D2} {commit=3D} 0 9 [junit4:junit4] 2> C27_STATE=3Dcoll:collection1 core:collection1 props:{= shard=3Dshard2, roles=3Dnull, state=3Dactive, core=3Dcollection1, collectio= n=3Dcollection1, node_name=3D127.0.0.1:38084_solr, base_url=3Dhttp://127.0.= 0.1:38084/solr} [junit4:junit4] 2> 15560 T347 C27 P38084 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15564 T347 C27 P38084 oass.SolrIndexSearcher. Op= ening Searcher@7bca4b51 main [junit4:junit4] 2> 15564 T347 C27 P38084 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15565 T356 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@7bca4b51 main{StandardDirectoryReader(se= gments_2:2)} [junit4:junit4] 2> 15566 T347 C27 P38084 /update {waitSearcher=3Dtrue&com= mit=3Dtrue&wt=3Djavabin&commit_end_point=3Dtrue&expungeDeletes=3Dfalse&soft= Commit=3Dfalse&version=3D2} {commit=3D} 0 6 [junit4:junit4] 2> 15588 T333 C25 P38080 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty3/index,segFN=3Dsegme= nts_2,generation=3D2,filenames=3D[segments_2] [junit4:junit4] 2> =09=09commit{dir=3D/usr/home/hudson/hudson-slave/works= pace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.apache.= solr.cloud.BasicDistributedZk2Test-1347753318806/jetty3/index,segFN=3Dsegme= nts_3,generation=3D3,filenames=3D[_0_MockRandom_0.tib, _0_Block_0.pos, _0_B= lock_0.tip, _0.fnm, _0_Block_0.doc, _0_Block_0.tim, _0_Memory_0.ram, _0_Moc= kVariableIntBlock_0.doc, _0_MockRandom_0.prx, _0_nrm.cfs, _0_MockVariableIn= tBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockRandom_0.frq, _0_MockRa= ndom_0.sd, _0_MockVariableIntBlock_0.tib, _0_MockVariableIntBlock_0.frq, _0= _nrm.cfe, _0_MockRandom_0.tii, _0_MockVariableIntBlock_0.pos, _0.fdx, _0.si= , _0.fdt, _0_MockVariableIntBlock_0.tii, segments_3] [junit4:junit4] 2> 15589 T333 C25 P38080 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 3 [junit4:junit4] 2> 15600 T333 C25 P38080 oass.SolrIndexSearcher. Op= ening Searcher@3a3e8692 main [junit4:junit4] 2> 15601 T333 C25 P38080 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15603 T342 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@3a3e8692 main{StandardDirectoryReader(se= gments_3:4 _0(5.0):C1)} [junit4:junit4] 2> 15603 T333 C25 P38080 /update {waitSearcher=3Dtrue&com= mit=3Dtrue&wt=3Djavabin&commit_end_point=3Dtrue&expungeDeletes=3Dfalse&soft= Commit=3Dfalse&version=3D2} {commit=3D} 0 55 [junit4:junit4] 2> 15604 T312 C26 P38073 /update {waitSearcher=3Dtrue&wt= =3Djavabin&commit=3Dtrue&softCommit=3Dfalse&version=3D2} {commit=3D} 0 184 [junit4:junit4] 2> 15609 T296 C29 P38070 REQ /select {fl=3Did,score&shard= .url=3D127.0.0.1:38070/solr/collection1/&NOW=3D1347753334408&start=3D0&q=3D= *:*&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&fsv=3Dtrue&rows=3D10&versio= n=3D2} hits=3D1 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 15626 T296 C29 P38070 REQ /select {shard.url=3D127.0.0= .1:38070/solr/collection1/&NOW=3D1347753334408&q=3D*:*&ids=3D1&distrib=3Dfa= lse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D0=20 [junit4:junit4] 2> 15627 T295 C29 P38070 REQ /select {wt=3Djavabin&q=3D*:= *&version=3D2} hits=3D1 status=3D0 QTime=3D21=20 [junit4:junit4] 2> 15628 T283 oaz.ZooKeeper. Initiating client conn= ection, connectString=3D127.0.0.1:38065/solr sessionTimeout=3D10000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@367cca66 [junit4:junit4] 2> 15629 T367 oaz.ClientCnxn$SendThread.startConnect Open= ing socket connection to server /127.0.0.1:38065 [junit4:junit4] 2> 15629 T283 oascc.ConnectionManager.waitForConnected Wa= iting for client to connect to ZooKeeper [junit4:junit4] 2> 15630 T367 oaz.ClientCnxn$SendThread.primeConnection S= ocket connection established to localhost/127.0.0.1:38065, initiating sessi= on [junit4:junit4] 2> 15630 T285 oazs.NIOServerCnxn$Factory.run Accepted soc= ket connection from /140.211.11.196:38103 [junit4:junit4] 2> 15630 T285 oazs.NIOServerCnxn.readConnectRequest Clien= t attempting to establish new session at /140.211.11.196:38103 [junit4:junit4] 2> 15632 T287 oazs.NIOServerCnxn.finishSessionInit Establ= ished session 0x139cc5b9b4e0009 with negotiated timeout 10000 for client /1= 40.211.11.196:38103 [junit4:junit4] 2> 15632 T367 oaz.ClientCnxn$SendThread.readConnectResult= Session establishment complete on server localhost/127.0.0.1:38065, sessio= nid =3D 0x139cc5b9b4e0009, negotiated timeout =3D 10000 [junit4:junit4] 2> 15632 T368 oascc.ConnectionManager.process Watcher org= .apache.solr.common.cloud.ConnectionManager@367cca66 name:ZooKeeperConnecti= on Watcher:127.0.0.1:38065/solr got event WatchedEvent state:SyncConnected = type:None path:null path:null type:None [junit4:junit4] 2> 15633 T283 oascc.ConnectionManager.waitForConnected Cl= ient is connected to ZooKeeper [junit4:junit4] 2> 15633 T283 oascc.ZkStateReader.createClusterStateWatch= ersAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 15635 T289 oazs.PrepRequestProcessor.pRequest Processe= d session termination for sessionid: 0x139cc5b9b4e0009 [junit4:junit4] 2> 15636 T368 oaz.ClientCnxn$EventThread.run EventThread = shut down [junit4:junit4] 2> 15636 T283 oaz.ZooKeeper.close Session: 0x139cc5b9b4e0= 009 closed [junit4:junit4] 2> 15636 T285 oazs.NIOServerCnxn.closeSock Closed socket = connection for client /140.211.11.196:38103 which had sessionid 0x139cc5b9b= 4e0009 [junit4:junit4] 2> 15641 T314 C26 P38073 REQ /select {distrib=3Dfalse&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D1 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 15644 T326 C28 P38076 REQ /select {distrib=3Dfalse&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D0 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 15651 T348 C27 P38084 REQ /select {fl=3Did,score&shard= .url=3D127.0.0.1:38076/solr/collection1/|127.0.0.1:38084/solr/collection1/&= NOW=3D1347753334449&start=3D0&q=3D*:*&distrib=3Dfalse&isShard=3Dtrue&wt=3Dj= avabin&fsv=3Dtrue&rows=3D10&version=3D2} hits=3D0 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 15651 T334 C25 P38080 REQ /select {fl=3Did,score&shard= .url=3D127.0.0.1:38073/solr/collection1/|127.0.0.1:38080/solr/collection1/&= NOW=3D1347753334449&start=3D0&q=3D*:*&distrib=3Dfalse&isShard=3Dtrue&wt=3Dj= avabin&fsv=3Dtrue&rows=3D10&version=3D2} hits=3D1 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 15655 T334 C25 P38080 REQ /select {shard.url=3D127.0.0= .1:38073/solr/collection1/|127.0.0.1:38080/solr/collection1/&NOW=3D13477533= 34449&q=3D*:*&ids=3D1&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version= =3D2} status=3D0 QTime=3D0=20 [junit4:junit4] 2> 15656 T312 C26 P38073 REQ /select {wt=3Djavabin&q=3D*:= *&version=3D2} hits=3D1 status=3D0 QTime=3D9=20 [junit4:junit4] 2> 15663 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[2 (1413221800435777536)]} 0 4 [junit4:junit4] 2> 15682 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D4=20 [junit4:junit4] 2> 15683 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D11=20 [junit4:junit4] 2> 15683 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[2]} 0 17 [junit4:junit4] 2> 15688 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[3 (1413221800464089088)]} 0 2 [junit4:junit4] 2> 15697 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15698 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[3 (1413221800468283392)]} 0 8 [junit4:junit4] 2> 15703 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[4 (1413221800479817728)]} 0 2 [junit4:junit4] 2> 15721 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D4=20 [junit4:junit4] 2> 15722 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D14=20 [junit4:junit4] 2> 15723 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[4]} 0 17 [junit4:junit4] 2> 15728 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[5 (1413221800506032128)]} 0 2 [junit4:junit4] 2> 15740 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15741 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D7=20 [junit4:junit4] 2> 15742 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[5]} 0 11 [junit4:junit4] 2> 15747 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[6 (1413221800525955072)]} 0 2 [junit4:junit4] 2> 15759 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15759 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 15760 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[6]} 0 10 [junit4:junit4] 2> 15765 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[7 (1413221800544829440)]} 0 2 [junit4:junit4] 2> 15776 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15776 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 15777 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[7]} 0 9 [junit4:junit4] 2> 15781 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[8 (1413221800561606656)]} 0 2 [junit4:junit4] 2> 15791 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15792 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[8 (1413221800566849536)]} 0 8 [junit4:junit4] 2> 15796 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[9 (1413221800577335296)]} 0 2 [junit4:junit4] 2> 15805 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15805 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[9 (1413221800582578176)]} 0 6 [junit4:junit4] 2> 15810 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[10 (1413221800592015360)]} 0 2 [junit4:junit4] 2> 15822 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15823 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D7=20 [junit4:junit4] 2> 15823 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[10]} 0 10 [junit4:junit4] 2> 15867 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[11 (1413221800610889728)]} 0 41 [junit4:junit4] 2> 15877 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15878 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[11 (1413221800657027072)]} 0 8 [junit4:junit4] 2> 15884 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[12 (1413221800668561408)]} 0 3 [junit4:junit4] 2> 15895 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15896 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[12 (1413221800675901440)]} 0 9 [junit4:junit4] 2> 15901 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[13 (1413221800687435776)]} 0 2 [junit4:junit4] 2> 15911 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15912 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[13 (1413221800692678656)]} 0 8 [junit4:junit4] 2> 15919 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[14 (1413221800705261568)]} 0 3 [junit4:junit4] 2> 15932 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15932 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D7=20 [junit4:junit4] 2> 15933 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[14]} 0 11 [junit4:junit4] 2> 15938 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[15 (1413221800726233088)]} 0 2 [junit4:junit4] 2> 15950 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15950 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D7=20 [junit4:junit4] 2> 15951 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[15]} 0 10 [junit4:junit4] 2> 15956 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[16 (1413221800745107456)]} 0 2 [junit4:junit4] 2> 15968 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15969 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D8=20 [junit4:junit4] 2> 15969 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[16]} 0 11 [junit4:junit4] 2> 15978 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[17 (1413221800765030400)]} 0 6 [junit4:junit4] 2> 15992 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D4=20 [junit4:junit4] 2> 15992 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[17 (1413221800774467584)]} 0 11 [junit4:junit4] 2> 15996 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[100 (1413221800788099072)]} 0 1 [junit4:junit4] 2> 16075 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D33=20 [junit4:junit4] 2> 16077 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[100 (1413221800792293376)]} 0 78 [junit4:junit4] 2> 16082 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[101 (1413221800877228032)]} 0 2 [junit4:junit4] 2> 16094 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D4=20 [junit4:junit4] 2> 16095 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[101 (1413221800881422336)]} 0 11 [junit4:junit4] 2> 16099 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[102 (1413221800896102400)]} 0 1 [junit4:junit4] 2> 16110 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16111 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D7=20 [junit4:junit4] 2> 16112 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[102]} 0 10 [junit4:junit4] 2> 16146 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[103 (1413221800913928192)]} 0 31 [junit4:junit4] 2> 16157 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16158 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[103 (1413221800951676928)]} 0 7 [junit4:junit4] 2> 16164 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[104 (1413221800962162688)]} 0 3 [junit4:junit4] 2> 16171 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16172 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[104 (1413221800967405568)]} 0 6 [junit4:junit4] 2> 16177 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[105 (1413221800976842752)]} 0 2 [junit4:junit4] 2> 16228 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D23=20 [junit4:junit4] 2> 16229 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[105 (1413221800982085632)]} 0 49 [junit4:junit4] 2> 16234 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[106 (1413221801036611584)]} 0 2 [junit4:junit4] 2> 16245 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D3=20 [junit4:junit4] 2> 16245 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[106 (1413221801040805888)]} 0 9 [junit4:junit4] 2> 16249 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[107 (1413221801053388800)]} 0 1 [junit4:junit4] 2> 16260 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D3=20 [junit4:junit4] 2> 16261 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[107 (1413221801057583104)]} 0 9 [junit4:junit4] 2> 16265 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[108 (1413221801070166016)]} 0 1 [junit4:junit4] 2> 16275 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16276 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 16277 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[108]} 0 9 [junit4:junit4] 2> 16281 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[109 (1413221801086943232)]} 0 1 [junit4:junit4] 2> 16289 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16290 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[109 (1413221801091137536)]} 0 6 [junit4:junit4] 2> 16294 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[110 (1413221801100574720)]} 0 1 [junit4:junit4] 2> 16304 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16305 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 16306 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[110]} 0 9 [junit4:junit4] 2> 16310 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[111 (1413221801117351936)]} 0 1 [junit4:junit4] 2> 16320 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16321 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 16322 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[111]} 0 9 [junit4:junit4] 2> 16327 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[112 (1413221801134129152)]} 0 2 [junit4:junit4] 2> 16335 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16335 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[112 (1413221801138323456)]} 0 6 [junit4:junit4] 2> 16356 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[113 (1413221801147760640)]} 0 18 [junit4:junit4] 2> 16366 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16367 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 16368 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[113]} 0 9 [junit4:junit4] 2> 16372 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[114 (1413221801181315072)]} 0 2 [junit4:junit4] 2> 16381 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16381 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[114 (1413221801186557952)]} 0 6 [junit4:junit4] 2> 16385 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[115 (1413221801195995136)]} 0 1 [junit4:junit4] 2> 16394 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16395 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[115 (1413221801200189440)]} 0 7 [junit4:junit4] 2> 16398 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[116 (1413221801209626624)]} 0 1 [junit4:junit4] 2> 16408 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16409 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 16409 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[116]} 0 8 [junit4:junit4] 2> 16413 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[117 (1413221801225355264)]} 0 1 [junit4:junit4] 2> 16423 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16424 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16425 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[117]} 0 9 [junit4:junit4] 2> 16429 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[118 (1413221801242132480)]} 0 1 [junit4:junit4] 2> 16480 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D26=20 [junit4:junit4] 2> 16481 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D47=20 [junit4:junit4] 2> 16482 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[118]} 0 50 [junit4:junit4] 2> 16485 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[119 (1413221801300852736)]} 0 1 [junit4:junit4] 2> 16495 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16496 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16497 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[119]} 0 9 [junit4:junit4] 2> 16500 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[120 (1413221801316581376)]} 0 1 [junit4:junit4] 2> 16510 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16511 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16511 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[120]} 0 8 [junit4:junit4] 2> 16516 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[121 (1413221801333358592)]} 0 1 [junit4:junit4] 2> 16524 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16525 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[121 (1413221801337552896)]} 0 6 [junit4:junit4] 2> 16528 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[122 (1413221801345941504)]} 0 1 [junit4:junit4] 2> 16541 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D3=20 [junit4:junit4] 2> 16542 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D9=20 [junit4:junit4] 2> 16542 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[122]} 0 11 [junit4:junit4] 2> 16564 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[123 (1413221801364815872)]} 0 19 [junit4:junit4] 2> 16573 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16574 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[123 (1413221801388933120)]} 0 7 [junit4:junit4] 2> 16580 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[124 (1413221801398370304)]} 0 3 [junit4:junit4] 2> 16589 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16590 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 16591 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[124]} 0 9 [junit4:junit4] 2> 16595 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[125 (1413221801416196096)]} 0 1 [junit4:junit4] 2> 16605 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16606 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 16607 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[125]} 0 9 [junit4:junit4] 2> 16610 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[126 (1413221801431924736)]} 0 1 [junit4:junit4] 2> 16620 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16621 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16621 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[126]} 0 8 [junit4:junit4] 2> 16625 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[127 (1413221801447653376)]} 0 1 [junit4:junit4] 2> 16667 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D15=20 [junit4:junit4] 2> 16668 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D37=20 [junit4:junit4] 2> 16669 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[127]} 0 41 [junit4:junit4] 2> 16673 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[128 (1413221801497985024)]} 0 1 [junit4:junit4] 2> 16684 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D3=20 [junit4:junit4] 2> 16684 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[128 (1413221801502179328)]} 0 8 [junit4:junit4] 2> 16688 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[129 (1413221801513713664)]} 0 1 [junit4:junit4] 2> 16698 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16698 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16699 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[129]} 0 8 [junit4:junit4] 2> 16703 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[130 (1413221801529442304)]} 0 1 [junit4:junit4] 2> 16711 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16711 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[130 (1413221801533636608)]} 0 5 [junit4:junit4] 2> 16715 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[131 (1413221801542025216)]} 0 1 [junit4:junit4] 2> 16725 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16725 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16726 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[131]} 0 8 [junit4:junit4] 2> 16729 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[132 (1413221801556705280)]} 0 1 [junit4:junit4] 2> 16738 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D3=20 [junit4:junit4] 2> 16739 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[132 (1413221801560899584)]} 0 7 [junit4:junit4] 2> 16757 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[133 (1413221801570336768)]} 0 16 [junit4:junit4] 2> 16766 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16766 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[133 (1413221801590259712)]} 0 6 [junit4:junit4] 2> 16772 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[134 (1413221801599696896)]} 0 3 [junit4:junit4] 2> 16783 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16783 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 16784 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[134]} 0 9 [junit4:junit4] 2> 16788 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[135 (1413221801618571264)]} 0 1 [junit4:junit4] 2> 16796 T333 C25 P38080 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16797 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[135 (1413221801622765568)]} 0 6 [junit4:junit4] 2> 16801 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[136 (1413221801632202752)]} 0 1 [junit4:junit4] 2> 16810 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16811 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16811 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[136]} 0 7 [junit4:junit4] 2> 16815 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[137 (1413221801646882816)]} 0 1 [junit4:junit4] 2> 16828 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16828 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D8=20 [junit4:junit4] 2> 16829 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[137]} 0 11 [junit4:junit4] 2> 16832 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[138 (1413221801664708608)]} 0 1 [junit4:junit4] 2> 16841 T333 C25 P38080 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38073/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16842 T315 C26 P38073 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16842 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[138]} 0 7 [junit4:junit4] 2> 16846 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[139 (1413221801679388672)]} 0 1 [junit4:junit4] 2> 16853 T347 C27 P38084 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38076/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16854 T327 C28 P38076 /update {wt=3Djavabin&version=3D= 2} {add=3D[139 (1413221801682534400)]} 0 6 [junit4:junit4] 2> 16859 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[140 (1413221801691971584)]} 0 2 [junit4:junit4] 2> 16868 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16868 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2> 16869 T312 C26 P38073 /update {wt=3Djavabin&version=3D= 2} {add=3D[140]} 0 8 [junit4:junit4] 2> 16872 T295 C29 P38070 /update {wt=3Djavabin&version=3D= 2} {add=3D[141 (1413221801706651648)]} 0 1 [junit4:junit4] 2> 16882 T347 C27 P38084 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38076/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 16882 T325 C28 P38076 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38073/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D5=20 [junit4:junit4] 2>=20 [...truncated too long message...] eaderElection Not rejoining election because CoreContainer is shutdown [junit4:junit4] 2> 307982 T355 oasc.SolrCore.close [collection1] CLOSING= SolrCore org.apache.solr.core.SolrCore@7437e222 [junit4:junit4] 2> 307988 T355 oasc.JmxMonitoredMap$SolrDynamicMBean.getM= BeanInfo WARNING Could not getStatistics on info bean Lazy[solr.Replication= Handler] java.lang.IllegalArgumentException: /usr/home/hudson/hudson-slave/= workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.ap= ache.solr.cloud.BasicDistributedZk2Test-1347753318806/jetty4/index does not= exist [junit4:junit4] 2> =09at org.apache.commons.io.FileUtils.sizeOfDirectory(= FileUtils.java:2074) [junit4:junit4] 2> =09at org.apache.solr.handler.ReplicationHandler.getIn= dexSize(ReplicationHandler.java:477) [junit4:junit4] 2> =09at org.apache.solr.handler.ReplicationHandler.getSt= atistics(ReplicationHandler.java:525) [junit4:junit4] 2> =09at org.apache.solr.core.RequestHandlers$LazyRequest= HandlerWrapper.getStatistics(RequestHandlers.java:310) [junit4:junit4] 2> =09at org.apache.solr.core.JmxMonitoredMap$SolrDynamic= MBean.getMBeanInfo(JmxMonitoredMap.java:231) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.getClassName(DefaultMBeanServerInterceptor.java:1824) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1661) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1833) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.getAttribute(DefaultMBeanServerInterceptor.java:680) [junit4:junit4] 2> =09at com.sun.jmx.mbeanserver.JmxMBeanServer.getAttrib= ute(JmxMBeanServer.java:672) [junit4:junit4] 2> =09at org.apache.solr.core.JmxMonitoredMap.unregister(= JmxMonitoredMap.java:174) [junit4:junit4] 2> =09at org.apache.solr.core.JmxMonitoredMap.clear(JmxMo= nitoredMap.java:116) [junit4:junit4] 2> =09at org.apache.solr.core.SolrCore.close(SolrCore.jav= a:864) [junit4:junit4] 2> =09at org.apache.solr.cloud.ShardLeaderElectionContext= .runLeaderProcess(ElectionContext.java:213) [junit4:junit4] 2> =09at org.apache.solr.cloud.LeaderElector.runIamLeader= Process(LeaderElector.java:158) [junit4:junit4] 2> =09at org.apache.solr.cloud.LeaderElector.checkIfIamLe= ader(LeaderElector.java:102) [junit4:junit4] 2> =09at org.apache.solr.cloud.LeaderElector.access$000(L= eaderElector.java:56) [junit4:junit4] 2> =09at org.apache.solr.cloud.LeaderElector$1.process(Le= aderElector.java:131) [junit4:junit4] 2> =09at org.apache.zookeeper.ClientCnxn$EventThread.proc= essEvent(ClientCnxn.java:526) [junit4:junit4] 2> =09at org.apache.zookeeper.ClientCnxn$EventThread.run(= ClientCnxn.java:502) [junit4:junit4] 2>=20 [junit4:junit4] 2> 307989 T355 oasc.JmxMonitoredMap$SolrDynamicMBean.getM= BeanInfo WARNING Could not getStatistics on info bean Lazy[solr.Replication= Handler] java.lang.IllegalArgumentException: /usr/home/hudson/hudson-slave/= workspace/Lucene-Solr-Tests-trunk-Java6/solr/build/solr-core/test/J1/org.ap= ache.solr.cloud.BasicDistributedZk2Test-1347753318806/jetty4/index does not= exist [junit4:junit4] 2> =09at org.apache.commons.io.FileUtils.sizeOfDirectory(= FileUtils.java:2074) [junit4:junit4] 2> =09at org.apache.solr.handler.ReplicationHandler.getIn= dexSize(ReplicationHandler.java:477) [junit4:junit4] 2> =09at org.apache.solr.handler.ReplicationHandler.getSt= atistics(ReplicationHandler.java:525) [junit4:junit4] 2> =09at org.apache.solr.core.RequestHandlers$LazyRequest= HandlerWrapper.getStatistics(RequestHandlers.java:310) [junit4:junit4] 2> =09at org.apache.solr.core.JmxMonitoredMap$SolrDynamic= MBean.getMBeanInfo(JmxMonitoredMap.java:231) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.getClassName(DefaultMBeanServerInterceptor.java:1824) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1661) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1833) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:436) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.unregisterMBean(DefaultMBeanServerInterceptor.java:421) [junit4:junit4] 2> =09at com.sun.jmx.mbeanserver.JmxMBeanServer.unregiste= rMBean(JmxMBeanServer.java:540) [junit4:junit4] 2> =09at org.apache.solr.core.JmxMonitoredMap.unregister(= JmxMonitoredMap.java:175) [junit4:junit4] 2> =09at org.apache.solr.core.JmxMonitoredMap.clear(JmxMo= nitoredMap.java:116) [junit4:junit4] 2> =09at org.apache.solr.core.SolrCore.close(SolrCore.jav= a:864) [junit4:junit4] 2> =09at org.apache.solr.cloud.ShardLeaderElectionContext= .runLeaderProcess(ElectionContext.java:213) [junit4:junit4] 2> =09at org.apache.solr.cloud.LeaderElector.runIamLeader= Process(LeaderElector.java:158) [junit4:junit4] 2> =09at org.apache.solr.cloud.LeaderElector.checkIfIamLe= ader(LeaderElector.java:102) [junit4:junit4] 2> =09at org.apache.solr.cloud.LeaderElector.access$000(L= eaderElector.java:56) [junit4:junit4] 2> =09at org.apache.solr.cloud.LeaderElector$1.process(Le= aderElector.java:131) [junit4:junit4] 2> =09at org.apache.zookeeper.ClientCnxn$EventThread.proc= essEvent(ClientCnxn.java:526) [junit4:junit4] 2> =09at org.apache.zookeeper.ClientCnxn$EventThread.run(= ClientCnxn.java:502) [junit4:junit4] 2>=20 [junit4:junit4] 2> 307995 T355 oasc.SolrCore.closeSearcher [collection1] = Closing main searcher on request. [junit4:junit4] 2> 307999 T355 oasu.DirectUpdateHandler2.close closing Di= rectUpdateHandler2{commits=3D5,autocommits=3D0,soft autocommits=3D0,optimiz= es=3D0,rollbacks=3D0,expungeDeletes=3D0,docsPending=3D0,adds=3D0,deletesByI= d=3D0,deletesByQuery=3D0,errors=3D0,cumulative_adds=3D35,cumulative_deletes= ById=3D0,cumulative_deletesByQuery=3D0,cumulative_errors=3D0} [junit4:junit4] 2> 307999 T355 oasu.DefaultSolrCoreState.decref SolrCoreS= tate ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 308001 T355 oasu.DefaultSolrCoreState.decref Closing S= olrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 308002 T355 oascc.ZkStateReader$3.process Updating liv= e nodes [junit4:junit4] 2> 308002 T355 oascc.ZkStateReader$3.process WARNING ZooK= eeper watch triggered, but Solr cannot talk to ZK [junit4:junit4] 2> 308002 T355 oascc.ZkStateReader$2.process A cluster st= ate change has occurred - updating... [junit4:junit4] 2> 308002 T355 oascc.ZkStateReader$2.process WARNING ZooK= eeper watch triggered, but Solr cannot talk to ZK [junit4:junit4] 2> 308003 T355 oascc.ConnectionManager.process Watcher or= g.apache.solr.common.cloud.ConnectionManager@4459116 name:ZooKeeperConnecti= on Watcher:127.0.0.1:38065/solr got event WatchedEvent state:Disconnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 308003 T355 oascc.ConnectionManager.process Client->Zo= oKeeper status change trigger but we are already closed [junit4:junit4] 2> 308003 T355 oaz.ClientCnxn$EventThread.run EventThread= shut down [junit4:junit4] 2> NOTE: test params are: codec=3DLucene40: {n_f1=3DBlock= (blocksize=3D128), foo_b=3DPostingsFormat(name=3DMemory doPackFST=3D true),= foo_d=3DMockVariableIntBlock(baseBlockSize=3D80), foo_f=3DPostingsFormat(n= ame=3DMemory doPackFST=3D true), n_tl1=3DBlock(blocksize=3D128), n_d1=3DPos= tingsFormat(name=3DMockRandom), rnd_b=3DMockVariableIntBlock(baseBlockSize= =3D80), intDefault=3DPostingsFormat(name=3DMockRandom), n_td1=3DBlock(block= size=3D128), id=3DMockVariableIntBlock(baseBlockSize=3D80), timestamp=3DPos= tingsFormat(name=3DMockRandom), range_facet_sl=3DPostingsFormat(name=3DMemo= ry doPackFST=3D true), range_facet_si=3DBlock(blocksize=3D128), oddField_s= =3DPostingsFormat(name=3DMemory doPackFST=3D true), multiDefault=3DBlock(bl= ocksize=3D128), n_tf1=3DPostingsFormat(name=3DMockRandom), n_dt1=3DBlock(bl= ocksize=3D128), n_ti1=3DMockVariableIntBlock(baseBlockSize=3D80), range_fac= et_l=3DPostingsFormat(name=3DMockRandom), text=3DPostingsFormat(name=3DMemo= ry doPackFST=3D true), _version_=3DPostingsFormat(name=3DMockRandom), Subje= ctTerms_mfacet=3DPostingsFormat(name=3DMockRandom), a_t=3DPostingsFormat(na= me=3DMockRandom), n_tdt1=3DPostingsFormat(name=3DMockRandom), other_tl1=3DP= ostingsFormat(name=3DMockRandom), n_l1=3DPostingsFormat(name=3DMockRandom),= a_si=3DBlock(blocksize=3D128)}, sim=3DRandomSimilarityProvider(queryNorm= =3Dfalse,coord=3Dno): {}, locale=3Del, timezone=3DAmerica/Denver [junit4:junit4] 2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. = 1.6.0_32 (64-bit)/cpus=3D16,threads=3D2,free=3D65015576,total=3D128843776 [junit4:junit4] 2> NOTE: All tests run in this JVM: [StandardRequestHandl= erTest, PrimitiveFieldTypeTest, BasicFunctionalityTest, MultiTermTest, Test= PropInjectDefaults, TestRemoteStreaming, TermVectorComponentTest, TestRepli= cationHandler, ConvertedLegacyTest, ShowFileRequestHandlerTest, TestWriterP= erf, FileUtilsTest, TestDocSet, BasicDistributedZk2Test] [junit4:junit4] Completed on J1 in 308.70s, 1 test, 1 failure <<< FAILURES! [...truncated 471 lines...] BUILD FAILED /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/build= .xml:32: The following error occurred while executing this line: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/solr/= build.xml:146: The following error occurred while executing this line: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucen= e/module-build.xml:63: The following error occurred while executing this li= ne: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucen= e/common-build.xml:1133: The following error occurred while executing this = line: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java6/lucen= e/common-build.xml:810: There were test failures: 228 suites, 923 tests, 1 = failure, 6 ignored (1 assumption) Total time: 31 minutes 28 seconds Build step 'Invoke Ant' marked build as failure Recording test results Email was triggered for: Failure Sending email for trigger: Failure ------=_Part_402_1355766936.1347754128331 Content-Type: text/plain; charset=us-ascii --------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org For additional commands, e-mail: dev-help@lucene.apache.org ------=_Part_402_1355766936.1347754128331--