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 82709D6B3 for ; Sun, 16 Sep 2012 19:21:55 +0000 (UTC) Received: (qmail 31111 invoked by uid 500); 16 Sep 2012 19:21:53 -0000 Delivered-To: apmail-lucene-dev-archive@lucene.apache.org Received: (qmail 31060 invoked by uid 500); 16 Sep 2012 19:21:53 -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 31050 invoked by uid 99); 16 Sep 2012 19:21:53 -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 19:21:53 +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 19:21:32 +0000 Received: from aegis.apache.org (localhost [127.0.0.1]) by aegis.apache.org (Postfix) with ESMTP id CA6F8C00A0 for ; Sun, 16 Sep 2012 19:21:09 +0000 (UTC) Date: Sun, 16 Sep 2012 19:20:49 +0000 (UTC) From: Apache Jenkins Server To: dev@lucene.apache.org Message-ID: <1509088084.565.1347823269818.JavaMail.hudson@aegis.apache.org> Subject: [JENKINS] Lucene-Solr-Tests-4.x-java7 - Build # 458 - Failure MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_564_376041460.1347823249615" ------=_Part_564_376041460.1347823249615 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Build: https://builds.apache.org/job/Lucene-Solr-Tests-4.x-java7/458/ 2 tests failed. REGRESSION: org.apache.solr.cloud.BasicDistributedZk2Test.testDistribSearc= h 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([2110B844980F532D:A0F6365CEF503311]= :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:601) =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:722) REGRESSION: org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch Error Message: Timeout occured while waiting response from server at: http://localhost:381= 96/solr/collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while wai= ting response from server at: http://localhost:38196/solr/collection1 =09at __randomizedtesting.SeedInfo.seed([2110B844980F532D:A0F6365CEF503311]= :0) =09at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServ= er.java:410) =09at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServ= er.java:182) =09at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(Ab= stractUpdateRequest.java:117) =09at org.apache.solr.BaseDistributedSearchTestCase.add(BaseDistributedSear= chTestCase.java:321) =09at org.apache.solr.cloud.BasicDistributedZkTest.testUpdateProcessorsRunO= nlyOnce(BasicDistributedZkTest.java:640) =09at org.apache.solr.cloud.BasicDistributedZkTest.doTest(BasicDistributedZ= kTest.java:328) =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:601) =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:722) Caused by: java.net.SocketTimeoutException: Read timed out =09at java.net.SocketInputStream.socketRead0(Native Method) =09at java.net.SocketInputStream.read(SocketInputStream.java:150) =09at java.net.SocketInputStream.read(SocketInputStream.java:121) =09at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(Abstrac= tSessionInputBuffer.java:149) =09at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffe= r.java:111) =09at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractS= essionInputBuffer.java:264) =09at org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResp= onseParser.java:98) =09at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessagePa= rser.java:252) =09at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHead= er(AbstractHttpClientConnection.java:282) =09at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHead= er(DefaultClientConnection.java:247) =09at org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHe= ader(AbstractClientConnAdapter.java:216) =09at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRe= questExecutor.java:298) =09at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecu= tor.java:125) =09at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(Default= RequestDirector.java:647) =09at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultReq= uestDirector.java:464) =09at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpCl= ient.java:820) =09at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpCl= ient.java:754) =09at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpCl= ient.java:732) =09at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServ= er.java:353) =09... 46 more Build Log: [...truncated 8272 lines...] [junit4:junit4] Suite: org.apache.solr.cloud.BasicDistributedZkTest [junit4:junit4] 2> 6 T865 oas.SolrTestCaseJ4.setUp ###Starting testDistri= bSearch [junit4:junit4] 2> Creating dataDir: /usr/home/hudson/hudson-slave/worksp= ace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-Bas= icDistributedZkTest-1347822209012 [junit4:junit4] 2> 8 T865 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4:junit4] 2> 11 T866 oazs.ZooKeeperServer.setTickTime tickTime set = to 1000 [junit4:junit4] 2> 11 T866 oazs.NIOServerCnxn$Factory. binding to p= ort 0.0.0.0/0.0.0.0:0 [junit4:junit4] 2> 12 T866 oazsp.FileTxnSnapLog.save Snapshotting: 0 [junit4:junit4] 2> 109 T865 oasc.ZkTestServer.run start zk server on port= :38156 [junit4:junit4] 2> 110 T865 oaz.ZooKeeper. Initiating client connec= tion, connectString=3D127.0.0.1:38156 sessionTimeout=3D10000 watcher=3Dorg.= apache.solr.common.cloud.ConnectionManager@110db592 [junit4:junit4] 2> 110 T871 oaz.ClientCnxn$SendThread.startConnect Openin= g socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 110 T865 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4:junit4] 2> 111 T871 oaz.ClientCnxn$SendThread.primeConnection Soc= ket connection established to localhost/127.0.0.1:38156, initiating session [junit4:junit4] 2> 112 T867 oazs.NIOServerCnxn$Factory.run Accepted socke= t connection from /140.211.11.196:38157 [junit4:junit4] 2> 112 T867 oazs.NIOServerCnxn.readConnectRequest Client = attempting to establish new session at /140.211.11.196:38157 [junit4:junit4] 2> 112 T869 oazsp.FileTxnLog.append Creating new log file= : log.1 [junit4:junit4] 2> 288 T869 oazs.NIOServerCnxn.finishSessionInit Establis= hed session 0x139d076c7fa0000 with negotiated timeout 10000 for client /140= .211.11.196:38157 [junit4:junit4] 2> 288 T871 oaz.ClientCnxn$SendThread.readConnectResult S= ession establishment complete on server localhost/127.0.0.1:38156, sessioni= d =3D 0x139d076c7fa0000, negotiated timeout =3D 10000 [junit4:junit4] 2> 288 T872 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@110db592 name:ZooKeeperConnection= Watcher:127.0.0.1:38156 got event WatchedEvent state:SyncConnected type:No= ne path:null path:null type:None [junit4:junit4] 2> 288 T865 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4:junit4] 2> 289 T865 oascc.SolrZkClient.makePath makePath: /solr [junit4:junit4] 2> 304 T870 oazs.PrepRequestProcessor.pRequest Processed = session termination for sessionid: 0x139d076c7fa0000 [junit4:junit4] 2> 313 T872 oaz.ClientCnxn$EventThread.run EventThread sh= ut down [junit4:junit4] 2> 313 T865 oaz.ZooKeeper.close Session: 0x139d076c7fa000= 0 closed [junit4:junit4] 2> 314 T867 oazs.NIOServerCnxn.closeSock Closed socket co= nnection for client /140.211.11.196:38157 which had sessionid 0x139d076c7fa= 0000 [junit4:junit4] 2> 314 T865 oaz.ZooKeeper. Initiating client connec= tion, connectString=3D127.0.0.1:38156/solr sessionTimeout=3D10000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@d23fc [junit4:junit4] 2> 315 T873 oaz.ClientCnxn$SendThread.startConnect Openin= g socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 315 T865 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4:junit4] 2> 316 T873 oaz.ClientCnxn$SendThread.primeConnection Soc= ket connection established to localhost/127.0.0.1:38156, initiating session [junit4:junit4] 2> 316 T867 oazs.NIOServerCnxn$Factory.run Accepted socke= t connection from /140.211.11.196:38158 [junit4:junit4] 2> 316 T867 oazs.NIOServerCnxn.readConnectRequest Client = attempting to establish new session at /140.211.11.196:38158 [junit4:junit4] 2> 322 T869 oazs.NIOServerCnxn.finishSessionInit Establis= hed session 0x139d076c7fa0001 with negotiated timeout 10000 for client /140= .211.11.196:38158 [junit4:junit4] 2> 322 T873 oaz.ClientCnxn$SendThread.readConnectResult S= ession establishment complete on server localhost/127.0.0.1:38156, sessioni= d =3D 0x139d076c7fa0001, negotiated timeout =3D 10000 [junit4:junit4] 2> 322 T874 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@d23fc name:ZooKeeperConnection Wa= tcher:127.0.0.1:38156/solr got event WatchedEvent state:SyncConnected type:= None path:null path:null type:None [junit4:junit4] 2> 322 T865 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4:junit4] 2> 323 T865 oascc.SolrZkClient.makePath makePath: /collec= tions/collection1 [junit4:junit4] 2> 326 T865 oascc.SolrZkClient.makePath makePath: /collec= tions/collection1/shards [junit4:junit4] 2> 333 T865 oascc.SolrZkClient.makePath makePath: /collec= tions/control_collection [junit4:junit4] 2> 335 T865 oascc.SolrZkClient.makePath makePath: /collec= tions/control_collection/shards [junit4:junit4] 2> 337 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/so= lrconfig.xml [junit4:junit4] 2> 338 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/solrconfig.xml [junit4:junit4] 2> 353 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema= .xml [junit4:junit4] 2> 354 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/schema.xml [junit4:junit4] 2> 461 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/so= lrconfig.xml [junit4:junit4] 2> 462 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/solrconfig.xml [junit4:junit4] 2> 476 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/sto= pwords.txt [junit4:junit4] 2> 476 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/stopwords.txt [junit4:junit4] 2> 488 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/pro= twords.txt [junit4:junit4] 2> 488 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/protwords.txt [junit4:junit4] 2> 499 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/curr= ency.xml [junit4:junit4] 2> 499 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/currency.xml [junit4:junit4] 2> 502 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/open-exchange-rates.json to /config= s/conf1/open-exchange-rates.json [junit4:junit4] 2> 502 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/open-exchange-rates.json [junit4:junit4] 2> 510 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /con= figs/conf1/mapping-ISOLatin1Accent.txt [junit4:junit4] 2> 511 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/mapping-ISOLatin1Accent.txt [junit4:junit4] 2> 518 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/= old_synonyms.txt [junit4:junit4] 2> 519 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/old_synonyms.txt [junit4:junit4] 2> 528 T865 oasc.AbstractZkTestCase.putConfig put /usr/ho= me/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/sol= r-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/syno= nyms.txt [junit4:junit4] 2> 528 T865 oascc.SolrZkClient.makePath makePath: /config= s/conf1/synonyms.txt [junit4:junit4] 2> 536 T870 oazs.PrepRequestProcessor.pRequest Processed = session termination for sessionid: 0x139d076c7fa0001 [junit4:junit4] 2> 537 T874 oaz.ClientCnxn$EventThread.run EventThread sh= ut down [junit4:junit4] 2> 537 T865 oaz.ZooKeeper.close Session: 0x139d076c7fa000= 1 closed [junit4:junit4] 2> 537 T867 oazs.NIOServerCnxn.closeSock Closed socket co= nnection for client /140.211.11.196:38158 which had sessionid 0x139d076c7fa= 0001 [junit4:junit4] 2> 539 T865 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 543 T865 oejs.AbstractConnector.doStart Started Socket= Connector@0.0.0.0:38162 [junit4:junit4] 2> 544 T865 oasc.SolrResourceLoader.locateSolrHome JNDI n= ot configured for solr (NoInitialContextEx) [junit4:junit4] 2> 544 T865 oasc.SolrResourceLoader.locateSolrHome using = system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr [junit4:junit4] 2> 544 T865 oasc.SolrResourceLoader. new SolrResour= ceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/' [junit4:junit4] 2> 582 T865 oass.SolrDispatchFilter.init SolrDispatchFilt= er.init() [junit4:junit4] 2> 583 T865 oasc.SolrResourceLoader.locateSolrHome JNDI n= ot configured for solr (NoInitialContextEx) [junit4:junit4] 2> 583 T865 oasc.SolrResourceLoader.locateSolrHome using = system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr [junit4:junit4] 2> 584 T865 oasc.CoreContainer$Initializer.initialize loo= king for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Test= s-4.x-java7/solr/build/solr-core/test-files/solr/solr.xml [junit4:junit4] 2> 584 T865 oasc.CoreContainer. New CoreContainer 8= 26337810 [junit4:junit4] 2> 585 T865 oasc.CoreContainer.load Loading CoreContainer= using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Test= s-4.x-java7/solr/build/solr-core/test-files/solr/' [junit4:junit4] 2> 585 T865 oasc.SolrResourceLoader. new SolrResour= ceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Sol= r-Tests-4.x-java7/solr/build/solr-core/test-files/solr/' [junit4:junit4] 2> 618 T865 oasc.CoreContainer.load Registering Log Liste= ner [junit4:junit4] 2> 633 T865 oasc.CoreContainer.initZooKeeper Zookeeper cl= ient=3D127.0.0.1:38156/solr [junit4:junit4] 2> 634 T865 oaz.ZooKeeper. Initiating client connec= tion, connectString=3D127.0.0.1:38156/solr sessionTimeout=3D5000 watcher=3D= org.apache.solr.common.cloud.ConnectionManager@5bcbbabf [junit4:junit4] 2> 635 T884 oaz.ClientCnxn$SendThread.startConnect Openin= g socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 635 T865 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4:junit4] 2> 637 T884 oaz.ClientCnxn$SendThread.primeConnection Soc= ket connection established to localhost/127.0.0.1:38156, initiating session [junit4:junit4] 2> 637 T867 oazs.NIOServerCnxn$Factory.run Accepted socke= t connection from /140.211.11.196:38163 [junit4:junit4] 2> 637 T867 oazs.NIOServerCnxn.readConnectRequest Client = attempting to establish new session at /140.211.11.196:38163 [junit4:junit4] 2> 639 T869 oazs.NIOServerCnxn.finishSessionInit Establis= hed session 0x139d076c7fa0002 with negotiated timeout 5000 for client /140.= 211.11.196:38163 [junit4:junit4] 2> 639 T884 oaz.ClientCnxn$SendThread.readConnectResult S= ession establishment complete on server localhost/127.0.0.1:38156, sessioni= d =3D 0x139d076c7fa0002, negotiated timeout =3D 5000 [junit4:junit4] 2> 639 T885 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@5bcbbabf name:ZooKeeperConnection= Watcher:127.0.0.1:38156/solr got event WatchedEvent state:SyncConnected ty= pe:None path:null path:null type:None [junit4:junit4] 2> 639 T865 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4:junit4] 2> 641 T870 oazs.PrepRequestProcessor.pRequest Got user-l= evel KeeperException when processing sessionid:0x139d076c7fa0002 type:creat= e cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/= solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 643 T865 oascc.SolrZkClient.makePath makePath: /live_n= odes [junit4:junit4] 2> 644 T865 oasc.ZkController.createEphemeralLiveNode Reg= ister node as live in ZooKeeper:/live_nodes/127.0.0.1:38162_solr [junit4:junit4] 2> 645 T870 oazs.PrepRequestProcessor.pRequest Got user-l= evel KeeperException when processing sessionid:0x139d076c7fa0002 type:delet= e cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/= solr/live_nodes/127.0.0.1:38162_solr Error:KeeperErrorCode =3D NoNode for /= solr/live_nodes/127.0.0.1:38162_solr [junit4:junit4] 2> 646 T865 oascc.SolrZkClient.makePath makePath: /live_n= odes/127.0.0.1:38162_solr [junit4:junit4] 2> 648 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting socketTimeout to: 0 [junit4:junit4] 2> 649 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting urlScheme to: http:// [junit4:junit4] 2> 649 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting connTimeout to: 0 [junit4:junit4] 2> 650 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 650 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting corePoolSize to: 0 [junit4:junit4] 2> 651 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 651 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting maxThreadIdleTime to: 5 [junit4:junit4] 2> 652 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting sizeOfQueue to: -1 [junit4:junit4] 2> 652 T865 oashc.HttpShardHandlerFactory.getParameter Se= tting fairnessPolicy to: false [junit4:junit4] 2> 652 T865 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&so= cketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 670 T865 oascc.SolrZkClient.makePath makePath: /overse= er_elect/election [junit4:junit4] 2> 683 T870 oazs.PrepRequestProcessor.pRequest Got user-l= evel KeeperException when processing sessionid:0x139d076c7fa0002 type:delet= e cxid:0x15 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer_elect/leader Error:KeeperErrorCode =3D NoNode for /solr/over= seer_elect/leader [junit4:junit4] 2> 684 T865 oascc.SolrZkClient.makePath makePath: /overse= er_elect/leader [junit4:junit4] 2> 687 T865 oasc.Overseer.start Overseer (id=3D8833087629= 0203650-127.0.0.1:38162_solr-n_0000000000) starting [junit4:junit4] 2> 687 T870 oazs.PrepRequestProcessor.pRequest Got user-l= evel KeeperException when processing sessionid:0x139d076c7fa0002 type:creat= e cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 688 T870 oazs.PrepRequestProcessor.pRequest Got user-l= evel KeeperException when processing sessionid:0x139d076c7fa0002 type:creat= e cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 696 T870 oazs.PrepRequestProcessor.pRequest Got user-l= evel KeeperException when processing sessionid:0x139d076c7fa0002 type:creat= e cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 697 T870 oazs.PrepRequestProcessor.pRequest Got user-l= evel KeeperException when processing sessionid:0x139d076c7fa0002 type:creat= e cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 698 T887 oasc.OverseerCollectionProcessor.run Process = current queue of collection creations [junit4:junit4] 2> 699 T865 oascc.SolrZkClient.makePath makePath: /cluste= rstate.json [junit4:junit4] 2> 702 T865 oascc.ZkStateReader.createClusterStateWatcher= sAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 712 T865 oasc.CoreContainer.create Creating SolrCore '= collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Luc= ene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1 [junit4:junit4] 2> 713 T865 oasc.ZkController.createCollectionZkNode Chec= k for collection zkNode:control_collection [junit4:junit4] 2> 713 T886 oasc.Overseer$ClusterStateUpdater.run Startin= g to work on the main queue [junit4:junit4] 2> 714 T865 oasc.ZkController.createCollectionZkNode Coll= ection zkNode exists [junit4:junit4] 2> 714 T865 oasc.ZkController.readConfigName Load collect= ion config from:/collections/control_collection [junit4:junit4] 2> 716 T865 oasc.SolrResourceLoader. new SolrResour= ceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Sol= r-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/' [junit4:junit4] 2> 717 T865 oasc.SolrResourceLoader.replaceClassLoader Ad= ding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-ja= va7/solr/build/solr-core/test-files/solr/collection1/lib/README' to classlo= ader [junit4:junit4] 2> 718 T865 oasc.SolrResourceLoader.replaceClassLoader Ad= ding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-ja= va7/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to class= loader [junit4:junit4] 2> 769 T865 oasc.SolrConfig. Using Lucene MatchVers= ion: LUCENE_40 [junit4:junit4] 2> 839 T865 oasc.SolrConfig. Loaded SolrConfig: sol= rconfig.xml [junit4:junit4] 2> 940 T865 oass.IndexSchema.readSchema Reading Solr Sche= ma [junit4:junit4] 2> 946 T865 oass.IndexSchema.readSchema Schema name=3Dtes= t [junit4:junit4] 2> 1574 T865 oass.OpenExchangeRatesOrgProvider.init Initi= alized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 1585 T865 oass.IndexSchema.readSchema default search f= ield in schema is text [junit4:junit4] 2> 1590 T865 oass.IndexSchema.readSchema unique key field= : id [junit4:junit4] 2> 1604 T865 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 1610 T865 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 1614 T865 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 1616 T865 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 1617 T865 oasc.SolrCore. [collection1] Opening n= ew SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.= x-java7/solr/build/solr-core/test-files/solr/collection1/, dataDir=3D./org.= apache.solr.cloud.BasicDistributedZkTest-1347822209012/control/data/ [junit4:junit4] 2> 1618 T865 oasc.JmxMonitoredMap. JMX monitoring i= s enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBe= anServer@69ad7d8c [junit4:junit4] 2> 1653 T865 oasc.SolrCore.getNewIndexDir WARNING New ind= ex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistri= butedZkTest-1347822209012/control/data/index/ [junit4:junit4] 2> 1654 T865 oasc.SolrCore.initIndex WARNING [collection1= ] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1347= 822209012/control/data/index' doesn't exist. Creating new index... [junit4:junit4] 2> 1656 T865 oasc.CachingDirectoryFactory.get return new = directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x= -java7/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistribute= dZkTest-1347822209012/control/data/index forceNew:false [junit4:junit4] 2> 1663 T865 oasc.SolrDeletionPolicy.onCommit SolrDeletio= nPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/control/data/index lockFactory=3Dorg.apache.l= ucene.store.NativeFSLockFactory@2b4564a5; maxCacheMB=3D48.0 maxMergeSizeMB= =3D4.0),segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 1664 T865 oasc.SolrDeletionPolicy.updateCommits newest= commit =3D 1 [junit4:junit4] 2> 1665 T865 oasc.SolrCore.initWriters created xml: solr.= XMLResponseWriter [junit4:junit4] 2> 1667 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe" [junit4:junit4] 2> 1668 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe-allfields" [junit4:junit4] 2> 1668 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "st= ored_sig" [junit4:junit4] 2> 1669 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "un= iq-fields" [junit4:junit4] 2> 1670 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "di= strib-dup-test-chain-implicit" [junit4:junit4] 2> 1670 T865 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 1671 T865 oasc.RequestHandlers.initHandlersFromConfig = created /replication: solr.ReplicationHandler [junit4:junit4] 2> 1672 T865 oasc.RequestHandlers.initHandlersFromConfig = created standard: solr.StandardRequestHandler [junit4:junit4] 2> 1672 T865 oasc.RequestHandlers.initHandlersFromConfig = created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 1673 T865 oasc.RequestHandlers.initHandlersFromConfig = created dismax: solr.SearchHandler [junit4:junit4] 2> 1674 T865 oasc.RequestHandlers.initHandlersFromConfig = created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 1675 T865 oasc.RequestHandlers.initHandlersFromConfig = created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 1675 T865 oasc.RequestHandlers.initHandlersFromConfig = created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 1676 T865 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 1676 T865 oasc.RequestHandlers.initHandlersFromConfig = created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 1677 T865 oasc.RequestHandlers.initHandlersFromConfig = created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 1678 T865 oasc.RequestHandlers.initHandlersFromConfig = created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 1678 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 1679 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 1680 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 1680 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.S= earchHandler [junit4:junit4] 2> 1681 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 1682 T865 oasc.RequestHandlers.initHandlersFromConfig = created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 1682 T865 oasc.RequestHandlers.initHandlersFromConfig = created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 1683 T865 oasc.RequestHandlers.initHandlersFromConfig = created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 1687 T865 oashl.XMLLoader.init xsltCacheLifetimeSecond= s=3D60 [junit4:junit4] 2> 1692 T865 oasc.SolrCore.initDeprecatedSupport WARNING = solrconfig.xml uses deprecated , Please update your co= nfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 1693 T865 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> 1697 T865 oass.SolrIndexSearcher. Opening Search= er@26ca0f33 main [junit4:junit4] 2> 1699 T865 oasu.CommitTracker. Hard AutoCommit: d= isabled [junit4:junit4] 2> 1699 T865 oasu.CommitTracker. Soft AutoCommit: d= isabled [junit4:junit4] 2> 1700 T865 oashc.SpellCheckComponent.inform Initializin= g spell checkers [junit4:junit4] 2> 1717 T865 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4:junit4] 2> 1771 T888 oasc.SolrCore.registerSearcher [collection1]= Registered new searcher Searcher@26ca0f33 main{StandardDirectoryReader(seg= ments_1:1)} [junit4:junit4] 2> 1777 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0002 type:crea= te cxid:0x56 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer/queue Error:KeeperErrorCode =3D NoNode for /solr/overseer/q= ueue [junit4:junit4] 2> 1789 T865 oasc.CoreContainer.register registering core= : collection1 [junit4:junit4] 2> 1789 T865 oasc.ZkController.register Register shard - = core:collection1 address:http://127.0.0.1:38162/solr shardId:control_shard [junit4:junit4] 2> 1803 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D10000&maxConnectionsPerHost=3D20&c= onnTimeout=3D30000&socketTimeout=3D30000&retry=3Dfalse [junit4:junit4] 2> 1818 T865 oascc.SolrZkClient.makePath makePath: /colle= ctions/control_collection/leader_elect/control_shard/election [junit4:junit4] 2> 1831 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0002 type:dele= te cxid:0x65 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> 1840 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess Running the leader process. [junit4:junit4] 2> 1841 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0002 type:crea= te cxid:0x66 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 2240 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 2242 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0002 type:crea= te cxid:0x6d 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> 2258 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 2344 T865 oasc.ShardLeaderElectionContext.waitForRepli= casToComeUp Enough replicas found to continue. [junit4:junit4] 2> 2345 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess I may be the new leader - try and sync [junit4:junit4] 2> 2345 T865 oasc.SyncStrategy.sync Sync replicas to http= ://127.0.0.1:38162/solr/collection1/ [junit4:junit4] 2> 2346 T865 oasc.SyncStrategy.syncReplicas Sync Success = - now sync replicas to me [junit4:junit4] 2> 2347 T865 oasc.SyncStrategy.syncToMe http://127.0.0.1:= 38162/solr/collection1/ has no replicas [junit4:junit4] 2> 2347 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess I am the new leader: http://127.0.0.1:38162/solr/collection1/ [junit4:junit4] 2> 2348 T865 oascc.SolrZkClient.makePath makePath: /colle= ctions/control_collection/leaders/control_shard [junit4:junit4] 2> 2352 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0002 type:crea= te cxid:0x8b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path= :/solr/overseer Error:KeeperErrorCode =3D NodeExists for /solr/overseer [junit4:junit4] 2> 2763 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 2769 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 2822 T865 oasc.ZkController.register We are http://127= .0.0.1:38162/solr/collection1/ and leader is http://127.0.0.1:38162/solr/co= llection1/ [junit4:junit4] 2> 2822 T865 oasc.ZkController.register No LogReplay need= ed for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38162/solr [junit4:junit4] 2> 2823 T865 oasc.ZkController.checkRecovery I am the lea= der, no recovery necessary [junit4:junit4] 2> 2825 T865 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 2826 T865 oass.SolrDispatchFilter.init user.dir=3D/usr= /home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/= solr-core/test/J0 [junit4:junit4] 2> 2826 T865 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() done [junit4:junit4] 2> 2827 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fol= lowRedirects=3Dfalse [junit4:junit4] 2> 2989 T865 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 2992 T865 oejs.AbstractConnector.doStart Started Socke= tConnector@0.0.0.0:38175 [junit4:junit4] 2> 2993 T865 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 2994 T865 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-13= 47822211843 [junit4:junit4] 2> 2994 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-1= 347822211843/' [junit4:junit4] 2> 3036 T865 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() [junit4:junit4] 2> 3036 T865 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 3037 T865 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-13= 47822211843 [junit4:junit4] 2> 3037 T865 oasc.CoreContainer$Initializer.initialize lo= oking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-1347822211843/s= olr.xml [junit4:junit4] 2> 3038 T865 oasc.CoreContainer. New CoreContainer = 1365798390 [junit4:junit4] 2> 3038 T865 oasc.CoreContainer.load Loading CoreContaine= r using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-1347822211843/' [junit4:junit4] 2> 3039 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-134782221= 1843/' [junit4:junit4] 2> 3071 T865 oasc.CoreContainer.load Registering Log List= ener [junit4:junit4] 2> 3087 T865 oasc.CoreContainer.initZooKeeper Zookeeper c= lient=3D127.0.0.1:38156/solr [junit4:junit4] 2> 3088 T865 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38156/solr sessionTimeout=3D5000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@1eb38731 [junit4:junit4] 2> 3089 T898 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 3089 T865 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 3090 T898 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38156, initiating sessio= n [junit4:junit4] 2> 3090 T867 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38176 [junit4:junit4] 2> 3091 T867 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38176 [junit4:junit4] 2> 3093 T869 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139d076c7fa0003 with negotiated timeout 5000 for client /140= .211.11.196:38176 [junit4:junit4] 2> 3093 T898 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38156, session= id =3D 0x139d076c7fa0003, negotiated timeout =3D 5000 [junit4:junit4] 2> 3094 T899 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@1eb38731 name:ZooKeeperConnectio= n Watcher:127.0.0.1:38156/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 3094 T865 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 3095 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0003 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> 3097 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0003 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> 3104 T865 oasc.ZkController.createEphemeralLiveNode Re= gister node as live in ZooKeeper:/live_nodes/127.0.0.1:38175_solr [junit4:junit4] 2> 3105 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0003 type:dele= te cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/live_nodes/127.0.0.1:38175_solr Error:KeeperErrorCode =3D NoNode for = /solr/live_nodes/127.0.0.1:38175_solr [junit4:junit4] 2> 3106 T865 oascc.SolrZkClient.makePath makePath: /live_= nodes/127.0.0.1:38175_solr [junit4:junit4] 2> 3108 T885 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 3109 T865 oashc.HttpShardHandlerFactory.getParameter S= etting socketTimeout to: 0 [junit4:junit4] 2> 3110 T865 oashc.HttpShardHandlerFactory.getParameter S= etting urlScheme to: http:// [junit4:junit4] 2> 3110 T865 oashc.HttpShardHandlerFactory.getParameter S= etting connTimeout to: 0 [junit4:junit4] 2> 3110 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 3111 T865 oashc.HttpShardHandlerFactory.getParameter S= etting corePoolSize to: 0 [junit4:junit4] 2> 3111 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 3112 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maxThreadIdleTime to: 5 [junit4:junit4] 2> 3112 T865 oashc.HttpShardHandlerFactory.getParameter S= etting sizeOfQueue to: -1 [junit4:junit4] 2> 3113 T865 oashc.HttpShardHandlerFactory.getParameter S= etting fairnessPolicy to: false [junit4:junit4] 2> 3113 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&s= ocketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 3135 T865 oascc.ZkStateReader.createClusterStateWatche= rsAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 3142 T865 oasc.CoreContainer.create Creating SolrCore = 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-13= 47822211843/collection1 [junit4:junit4] 2> 3142 T865 oasc.ZkController.createCollectionZkNode Che= ck for collection zkNode:collection1 [junit4:junit4] 2> 3143 T865 oasc.ZkController.createCollectionZkNode Col= lection zkNode exists [junit4:junit4] 2> 3144 T865 oasc.ZkController.readConfigName Load collec= tion config from:/collections/collection1 [junit4:junit4] 2> 3145 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-134782221= 1843/collection1/' [junit4:junit4] 2> 3146 T865 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-j= ava7/solr/build/solr-core/test/J0/solrtest-jetty1-1347822211843/collection1= /lib/classes/' to classloader [junit4:junit4] 2> 3147 T865 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-j= ava7/solr/build/solr-core/test/J0/solrtest-jetty1-1347822211843/collection1= /lib/README' to classloader [junit4:junit4] 2> 3199 T865 oasc.SolrConfig. Using Lucene MatchVer= sion: LUCENE_40 [junit4:junit4] 2> 3269 T865 oasc.SolrConfig. Loaded SolrConfig: so= lrconfig.xml [junit4:junit4] 2> 3282 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 3296 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 3371 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 3371 T865 oass.IndexSchema.readSchema Reading Solr Sch= ema [junit4:junit4] 2> 3378 T865 oass.IndexSchema.readSchema Schema name=3Dte= st [junit4:junit4] 2> 4030 T865 oass.OpenExchangeRatesOrgProvider.init Initi= alized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 4041 T865 oass.IndexSchema.readSchema default search f= ield in schema is text [junit4:junit4] 2> 4060 T865 oass.IndexSchema.readSchema unique key field= : id [junit4:junit4] 2> 4070 T865 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 4074 T865 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 4078 T865 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 4079 T865 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 4080 T865 oasc.SolrCore. [collection1] Opening n= ew SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.= x-java7/solr/build/solr-core/test/J0/./solrtest-jetty1-1347822211843/collec= tion1/, dataDir=3D./org.apache.solr.cloud.BasicDistributedZkTest-1347822209= 012/jetty1/ [junit4:junit4] 2> 4080 T865 oasc.JmxMonitoredMap. JMX monitoring i= s enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBe= anServer@69ad7d8c [junit4:junit4] 2> 4081 T865 oasc.SolrCore.getNewIndexDir WARNING New ind= ex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistri= butedZkTest-1347822209012/jetty1/index/ [junit4:junit4] 2> 4082 T865 oasc.SolrCore.initIndex WARNING [collection1= ] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1347= 822209012/jetty1/index' doesn't exist. Creating new index... [junit4:junit4] 2> 4083 T865 oasc.CachingDirectoryFactory.get return new = directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x= -java7/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistribute= dZkTest-1347822209012/jetty1/index forceNew:false [junit4:junit4] 2> 4089 T865 oasc.SolrDeletionPolicy.onCommit SolrDeletio= nPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty1/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@440beaaa; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0)= ,segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 4089 T865 oasc.SolrDeletionPolicy.updateCommits newest= commit =3D 1 [junit4:junit4] 2> 4090 T865 oasc.SolrCore.initWriters created xml: solr.= XMLResponseWriter [junit4:junit4] 2> 4092 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe" [junit4:junit4] 2> 4092 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe-allfields" [junit4:junit4] 2> 4093 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "st= ored_sig" [junit4:junit4] 2> 4093 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "un= iq-fields" [junit4:junit4] 2> 4094 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "di= strib-dup-test-chain-implicit" [junit4:junit4] 2> 4094 T865 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 4095 T865 oasc.RequestHandlers.initHandlersFromConfig = created /replication: solr.ReplicationHandler [junit4:junit4] 2> 4095 T865 oasc.RequestHandlers.initHandlersFromConfig = created standard: solr.StandardRequestHandler [junit4:junit4] 2> 4096 T865 oasc.RequestHandlers.initHandlersFromConfig = created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 4096 T865 oasc.RequestHandlers.initHandlersFromConfig = created dismax: solr.SearchHandler [junit4:junit4] 2> 4097 T865 oasc.RequestHandlers.initHandlersFromConfig = created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 4097 T865 oasc.RequestHandlers.initHandlersFromConfig = created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 4098 T865 oasc.RequestHandlers.initHandlersFromConfig = created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 4098 T865 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 4099 T865 oasc.RequestHandlers.initHandlersFromConfig = created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 4099 T865 oasc.RequestHandlers.initHandlersFromConfig = created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 4100 T865 oasc.RequestHandlers.initHandlersFromConfig = created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 4100 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 4101 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 4101 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 4102 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.S= earchHandler [junit4:junit4] 2> 4102 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 4103 T865 oasc.RequestHandlers.initHandlersFromConfig = created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 4103 T865 oasc.RequestHandlers.initHandlersFromConfig = created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 4104 T865 oasc.RequestHandlers.initHandlersFromConfig = created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 4106 T865 oashl.XMLLoader.init xsltCacheLifetimeSecond= s=3D60 [junit4:junit4] 2> 4110 T865 oasc.SolrCore.initDeprecatedSupport WARNING = solrconfig.xml uses deprecated , Please update your co= nfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 4111 T865 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> 4113 T865 oass.SolrIndexSearcher. Opening Search= er@765ee0 main [junit4:junit4] 2> 4114 T865 oasu.CommitTracker. Hard AutoCommit: d= isabled [junit4:junit4] 2> 4115 T865 oasu.CommitTracker. Soft AutoCommit: d= isabled [junit4:junit4] 2> 4115 T865 oashc.SpellCheckComponent.inform Initializin= g spell checkers [junit4:junit4] 2> 4131 T865 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4:junit4] 2> 4186 T900 oasc.SolrCore.registerSearcher [collection1]= Registered new searcher Searcher@765ee0 main{StandardDirectoryReader(segme= nts_1:1)} [junit4:junit4] 2> 4302 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 4325 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 4325 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 4693 T865 oasc.CoreContainer.register registering core= : collection1 [junit4:junit4] 2> 4693 T865 oasc.ZkController.register Register shard - = core:collection1 address:http://127.0.0.1:38175/solr shardId:shard1 [junit4:junit4] 2> 4695 T865 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/leader_elect/shard1/election [junit4:junit4] 2> 4701 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0003 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> 4701 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess Running the leader process. [junit4:junit4] 2> 4702 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0003 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> 4704 T865 oasc.ShardLeaderElectionContext.waitForRepli= casToComeUp Enough replicas found to continue. [junit4:junit4] 2> 4704 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess I may be the new leader - try and sync [junit4:junit4] 2> 4705 T865 oasc.SyncStrategy.sync Sync replicas to http= ://127.0.0.1:38175/solr/collection1/ [junit4:junit4] 2> 4705 T865 oasc.SyncStrategy.syncReplicas Sync Success = - now sync replicas to me [junit4:junit4] 2> 4706 T865 oasc.SyncStrategy.syncToMe http://127.0.0.1:= 38175/solr/collection1/ has no replicas [junit4:junit4] 2> 4706 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess I am the new leader: http://127.0.0.1:38175/solr/collection1/ [junit4:junit4] 2> 4707 T865 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/leaders/shard1 [junit4:junit4] 2> 4710 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0003 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> 4829 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 4836 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 4836 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 4865 T865 oasc.ZkController.register We are http://127= .0.0.1:38175/solr/collection1/ and leader is http://127.0.0.1:38175/solr/co= llection1/ [junit4:junit4] 2> 4865 T865 oasc.ZkController.register No LogReplay need= ed for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38175/solr [junit4:junit4] 2> 4866 T865 oasc.ZkController.checkRecovery I am the lea= der, no recovery necessary [junit4:junit4] 2> 4867 T865 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 4868 T865 oass.SolrDispatchFilter.init user.dir=3D/usr= /home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/= solr-core/test/J0 [junit4:junit4] 2> 4869 T865 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() done [junit4:junit4] 2> 4869 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fol= lowRedirects=3Dfalse [junit4:junit4] 2> 5035 T865 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 5039 T865 oejs.AbstractConnector.doStart Started Socke= tConnector@0.0.0.0:38185 [junit4:junit4] 2> 5039 T865 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 5040 T865 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-13= 47822213889 [junit4:junit4] 2> 5040 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-1= 347822213889/' [junit4:junit4] 2> 5082 T865 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() [junit4:junit4] 2> 5082 T865 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 5083 T865 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-13= 47822213889 [junit4:junit4] 2> 5083 T865 oasc.CoreContainer$Initializer.initialize lo= oking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-1347822213889/s= olr.xml [junit4:junit4] 2> 5084 T865 oasc.CoreContainer. New CoreContainer = 1682310284 [junit4:junit4] 2> 5084 T865 oasc.CoreContainer.load Loading CoreContaine= r using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-1347822213889/' [junit4:junit4] 2> 5085 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-134782221= 3889/' [junit4:junit4] 2> 5117 T865 oasc.CoreContainer.load Registering Log List= ener [junit4:junit4] 2> 5134 T865 oasc.CoreContainer.initZooKeeper Zookeeper c= lient=3D127.0.0.1:38156/solr [junit4:junit4] 2> 5134 T865 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38156/solr sessionTimeout=3D5000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@579ec0a6 [junit4:junit4] 2> 5136 T910 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 5136 T865 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 5137 T910 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38156, initiating sessio= n [junit4:junit4] 2> 5138 T867 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38187 [junit4:junit4] 2> 5138 T867 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38187 [junit4:junit4] 2> 5148 T869 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139d076c7fa0004 with negotiated timeout 5000 for client /140= .211.11.196:38187 [junit4:junit4] 2> 5148 T910 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38156, session= id =3D 0x139d076c7fa0004, negotiated timeout =3D 5000 [junit4:junit4] 2> 5149 T911 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@579ec0a6 name:ZooKeeperConnectio= n Watcher:127.0.0.1:38156/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 5149 T865 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 5150 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0004 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> 5156 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0004 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> 5167 T865 oasc.ZkController.createEphemeralLiveNode Re= gister node as live in ZooKeeper:/live_nodes/127.0.0.1:38185_solr [junit4:junit4] 2> 5168 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0004 type:dele= te cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/live_nodes/127.0.0.1:38185_solr Error:KeeperErrorCode =3D NoNode for = /solr/live_nodes/127.0.0.1:38185_solr [junit4:junit4] 2> 5179 T865 oascc.SolrZkClient.makePath makePath: /live_= nodes/127.0.0.1:38185_solr [junit4:junit4] 2> 5188 T899 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 5188 T885 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 5189 T865 oashc.HttpShardHandlerFactory.getParameter S= etting socketTimeout to: 0 [junit4:junit4] 2> 5190 T865 oashc.HttpShardHandlerFactory.getParameter S= etting urlScheme to: http:// [junit4:junit4] 2> 5190 T865 oashc.HttpShardHandlerFactory.getParameter S= etting connTimeout to: 0 [junit4:junit4] 2> 5191 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 5191 T865 oashc.HttpShardHandlerFactory.getParameter S= etting corePoolSize to: 0 [junit4:junit4] 2> 5192 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 5192 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maxThreadIdleTime to: 5 [junit4:junit4] 2> 5193 T865 oashc.HttpShardHandlerFactory.getParameter S= etting sizeOfQueue to: -1 [junit4:junit4] 2> 5193 T865 oashc.HttpShardHandlerFactory.getParameter S= etting fairnessPolicy to: false [junit4:junit4] 2> 5194 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&s= ocketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 5214 T865 oascc.ZkStateReader.createClusterStateWatche= rsAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 5220 T865 oasc.CoreContainer.create Creating SolrCore = 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-13= 47822213889/collection1 [junit4:junit4] 2> 5221 T865 oasc.ZkController.createCollectionZkNode Che= ck for collection zkNode:collection1 [junit4:junit4] 2> 5221 T865 oasc.ZkController.createCollectionZkNode Col= lection zkNode exists [junit4:junit4] 2> 5222 T865 oasc.ZkController.readConfigName Load collec= tion config from:/collections/collection1 [junit4:junit4] 2> 5223 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-134782221= 3889/collection1/' [junit4:junit4] 2> 5225 T865 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-j= ava7/solr/build/solr-core/test/J0/solrtest-jetty2-1347822213889/collection1= /lib/README' to classloader [junit4:junit4] 2> 5225 T865 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-j= ava7/solr/build/solr-core/test/J0/solrtest-jetty2-1347822213889/collection1= /lib/classes/' to classloader [junit4:junit4] 2> 5277 T865 oasc.SolrConfig. Using Lucene MatchVer= sion: LUCENE_40 [junit4:junit4] 2> 5341 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 5346 T911 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 5346 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 5346 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 5348 T865 oasc.SolrConfig. Loaded SolrConfig: so= lrconfig.xml [junit4:junit4] 2> 5449 T865 oass.IndexSchema.readSchema Reading Solr Sch= ema [junit4:junit4] 2> 5456 T865 oass.IndexSchema.readSchema Schema name=3Dte= st [junit4:junit4] 2> 6060 T865 oass.OpenExchangeRatesOrgProvider.init Initi= alized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 6068 T865 oass.IndexSchema.readSchema default search f= ield in schema is text [junit4:junit4] 2> 6071 T865 oass.IndexSchema.readSchema unique key field= : id [junit4:junit4] 2> 6082 T865 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 6086 T865 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 6089 T865 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 6090 T865 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 6091 T865 oasc.SolrCore. [collection1] Opening n= ew SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.= x-java7/solr/build/solr-core/test/J0/./solrtest-jetty2-1347822213889/collec= tion1/, dataDir=3D./org.apache.solr.cloud.BasicDistributedZkTest-1347822209= 012/jetty2/ [junit4:junit4] 2> 6091 T865 oasc.JmxMonitoredMap. JMX monitoring i= s enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBe= anServer@69ad7d8c [junit4:junit4] 2> 6092 T865 oasc.SolrCore.getNewIndexDir WARNING New ind= ex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistri= butedZkTest-1347822209012/jetty2/index/ [junit4:junit4] 2> 6093 T865 oasc.SolrCore.initIndex WARNING [collection1= ] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1347= 822209012/jetty2/index' doesn't exist. Creating new index... [junit4:junit4] 2> 6094 T865 oasc.CachingDirectoryFactory.get return new = directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x= -java7/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistribute= dZkTest-1347822209012/jetty2/index forceNew:false [junit4:junit4] 2> 6098 T865 oasc.SolrDeletionPolicy.onCommit SolrDeletio= nPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty2/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@19f963a5; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0)= ,segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 6099 T865 oasc.SolrDeletionPolicy.updateCommits newest= commit =3D 1 [junit4:junit4] 2> 6099 T865 oasc.SolrCore.initWriters created xml: solr.= XMLResponseWriter [junit4:junit4] 2> 6101 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe" [junit4:junit4] 2> 6102 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe-allfields" [junit4:junit4] 2> 6102 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "st= ored_sig" [junit4:junit4] 2> 6103 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "un= iq-fields" [junit4:junit4] 2> 6103 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "di= strib-dup-test-chain-implicit" [junit4:junit4] 2> 6104 T865 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 6104 T865 oasc.RequestHandlers.initHandlersFromConfig = created /replication: solr.ReplicationHandler [junit4:junit4] 2> 6105 T865 oasc.RequestHandlers.initHandlersFromConfig = created standard: solr.StandardRequestHandler [junit4:junit4] 2> 6105 T865 oasc.RequestHandlers.initHandlersFromConfig = created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 6106 T865 oasc.RequestHandlers.initHandlersFromConfig = created dismax: solr.SearchHandler [junit4:junit4] 2> 6106 T865 oasc.RequestHandlers.initHandlersFromConfig = created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 6107 T865 oasc.RequestHandlers.initHandlersFromConfig = created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 6107 T865 oasc.RequestHandlers.initHandlersFromConfig = created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 6108 T865 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 6108 T865 oasc.RequestHandlers.initHandlersFromConfig = created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 6108 T865 oasc.RequestHandlers.initHandlersFromConfig = created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 6109 T865 oasc.RequestHandlers.initHandlersFromConfig = created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 6110 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 6110 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 6111 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 6111 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.S= earchHandler [junit4:junit4] 2> 6112 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 6112 T865 oasc.RequestHandlers.initHandlersFromConfig = created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 6113 T865 oasc.RequestHandlers.initHandlersFromConfig = created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 6113 T865 oasc.RequestHandlers.initHandlersFromConfig = created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 6116 T865 oashl.XMLLoader.init xsltCacheLifetimeSecond= s=3D60 [junit4:junit4] 2> 6119 T865 oasc.SolrCore.initDeprecatedSupport WARNING = solrconfig.xml uses deprecated , Please update your co= nfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 6120 T865 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> 6123 T865 oass.SolrIndexSearcher. Opening Search= er@5589dc12 main [junit4:junit4] 2> 6124 T865 oasu.CommitTracker. Hard AutoCommit: d= isabled [junit4:junit4] 2> 6124 T865 oasu.CommitTracker. Soft AutoCommit: d= isabled [junit4:junit4] 2> 6125 T865 oashc.SpellCheckComponent.inform Initializin= g spell checkers [junit4:junit4] 2> 6137 T865 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4:junit4] 2> 6179 T912 oasc.SolrCore.registerSearcher [collection1]= Registered new searcher Searcher@5589dc12 main{StandardDirectoryReader(seg= ments_1:1)} [junit4:junit4] 2> 6353 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 6365 T911 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6365 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6365 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6685 T865 oasc.CoreContainer.register registering core= : collection1 [junit4:junit4] 2> 6685 T865 oasc.ZkController.register Register shard - = core:collection1 address:http://127.0.0.1:38185/solr shardId:shard2 [junit4:junit4] 2> 6687 T865 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/leader_elect/shard2/election [junit4:junit4] 2> 6692 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0004 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> 6693 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess Running the leader process. [junit4:junit4] 2> 6693 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0004 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> 6695 T865 oasc.ShardLeaderElectionContext.waitForRepli= casToComeUp Enough replicas found to continue. [junit4:junit4] 2> 6696 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess I may be the new leader - try and sync [junit4:junit4] 2> 6696 T865 oasc.SyncStrategy.sync Sync replicas to http= ://127.0.0.1:38185/solr/collection1/ [junit4:junit4] 2> 6697 T865 oasc.SyncStrategy.syncReplicas Sync Success = - now sync replicas to me [junit4:junit4] 2> 6697 T865 oasc.SyncStrategy.syncToMe http://127.0.0.1:= 38185/solr/collection1/ has no replicas [junit4:junit4] 2> 6698 T865 oasc.ShardLeaderElectionContext.runLeaderPro= cess I am the new leader: http://127.0.0.1:38185/solr/collection1/ [junit4:junit4] 2> 6698 T865 oascc.SolrZkClient.makePath makePath: /colle= ctions/collection1/leaders/shard2 [junit4:junit4] 2> 6701 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0004 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> 6869 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 6884 T911 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6884 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6884 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 6907 T865 oasc.ZkController.register We are http://127= .0.0.1:38185/solr/collection1/ and leader is http://127.0.0.1:38185/solr/co= llection1/ [junit4:junit4] 2> 6907 T865 oasc.ZkController.register No LogReplay need= ed for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38185/solr [junit4:junit4] 2> 6908 T865 oasc.ZkController.checkRecovery I am the lea= der, no recovery necessary [junit4:junit4] 2> 6909 T865 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 6910 T865 oass.SolrDispatchFilter.init user.dir=3D/usr= /home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/= solr-core/test/J0 [junit4:junit4] 2> 6911 T865 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() done [junit4:junit4] 2> 6911 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fol= lowRedirects=3Dfalse [junit4:junit4] 2> 7083 T865 oejs.Server.doStart jetty-8.1.2.v20120308 [junit4:junit4] 2> 7086 T865 oejs.AbstractConnector.doStart Started Socke= tConnector@0.0.0.0:38196 [junit4:junit4] 2> 7087 T865 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 7087 T865 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-13= 47822215934 [junit4:junit4] 2> 7088 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/L= ucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-1= 347822215934/' [junit4:junit4] 2> 7130 T865 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() [junit4:junit4] 2> 7131 T865 oasc.SolrResourceLoader.locateSolrHome JNDI = not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 7131 T865 oasc.SolrResourceLoader.locateSolrHome using= system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-13= 47822215934 [junit4:junit4] 2> 7132 T865 oasc.CoreContainer$Initializer.initialize lo= oking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-1347822215934/s= olr.xml [junit4:junit4] 2> 7132 T865 oasc.CoreContainer. New CoreContainer = 1876234722 [junit4:junit4] 2> 7133 T865 oasc.CoreContainer.load Loading CoreContaine= r using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tes= ts-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-1347822215934/' [junit4:junit4] 2> 7133 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-134782221= 5934/' [junit4:junit4] 2> 7166 T865 oasc.CoreContainer.load Registering Log List= ener [junit4:junit4] 2> 7182 T865 oasc.CoreContainer.initZooKeeper Zookeeper c= lient=3D127.0.0.1:38156/solr [junit4:junit4] 2> 7183 T865 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38156/solr sessionTimeout=3D5000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@7e265694 [junit4:junit4] 2> 7184 T922 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 7184 T865 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 7185 T922 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38156, initiating sessio= n [junit4:junit4] 2> 7186 T867 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38197 [junit4:junit4] 2> 7186 T867 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38197 [junit4:junit4] 2> 7199 T869 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139d076c7fa0005 with negotiated timeout 5000 for client /140= .211.11.196:38197 [junit4:junit4] 2> 7199 T922 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38156, session= id =3D 0x139d076c7fa0005, negotiated timeout =3D 5000 [junit4:junit4] 2> 7200 T923 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@7e265694 name:ZooKeeperConnectio= n Watcher:127.0.0.1:38156/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 7200 T865 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 7201 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0005 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> 7217 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0005 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> 7225 T865 oasc.ZkController.createEphemeralLiveNode Re= gister node as live in ZooKeeper:/live_nodes/127.0.0.1:38196_solr [junit4:junit4] 2> 7225 T870 oazs.PrepRequestProcessor.pRequest Got user-= level KeeperException when processing sessionid:0x139d076c7fa0005 type:dele= te cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:= /solr/live_nodes/127.0.0.1:38196_solr Error:KeeperErrorCode =3D NoNode for = /solr/live_nodes/127.0.0.1:38196_solr [junit4:junit4] 2> 7242 T865 oascc.SolrZkClient.makePath makePath: /live_= nodes/127.0.0.1:38196_solr [junit4:junit4] 2> 7250 T911 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 7250 T885 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 7250 T899 oascc.ZkStateReader$3.process Updating live = nodes [junit4:junit4] 2> 7251 T865 oashc.HttpShardHandlerFactory.getParameter S= etting socketTimeout to: 0 [junit4:junit4] 2> 7252 T865 oashc.HttpShardHandlerFactory.getParameter S= etting urlScheme to: http:// [junit4:junit4] 2> 7252 T865 oashc.HttpShardHandlerFactory.getParameter S= etting connTimeout to: 0 [junit4:junit4] 2> 7253 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 7253 T865 oashc.HttpShardHandlerFactory.getParameter S= etting corePoolSize to: 0 [junit4:junit4] 2> 7253 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 7254 T865 oashc.HttpShardHandlerFactory.getParameter S= etting maxThreadIdleTime to: 5 [junit4:junit4] 2> 7254 T865 oashc.HttpShardHandlerFactory.getParameter S= etting sizeOfQueue to: -1 [junit4:junit4] 2> 7255 T865 oashc.HttpShardHandlerFactory.getParameter S= etting fairnessPolicy to: false [junit4:junit4] 2> 7255 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&s= ocketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4:junit4] 2> 7275 T865 oascc.ZkStateReader.createClusterStateWatche= rsAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 7282 T865 oasc.CoreContainer.create Creating SolrCore = 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lu= cene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-13= 47822215934/collection1 [junit4:junit4] 2> 7282 T865 oasc.ZkController.createCollectionZkNode Che= ck for collection zkNode:collection1 [junit4:junit4] 2> 7283 T865 oasc.ZkController.createCollectionZkNode Col= lection zkNode exists [junit4:junit4] 2> 7284 T865 oasc.ZkController.readConfigName Load collec= tion config from:/collections/collection1 [junit4:junit4] 2> 7285 T865 oasc.SolrResourceLoader. new SolrResou= rceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-So= lr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-134782221= 5934/collection1/' [junit4:junit4] 2> 7287 T865 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-j= ava7/solr/build/solr-core/test/J0/solrtest-jetty3-1347822215934/collection1= /lib/README' to classloader [junit4:junit4] 2> 7288 T865 oasc.SolrResourceLoader.replaceClassLoader A= dding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-j= ava7/solr/build/solr-core/test/J0/solrtest-jetty3-1347822215934/collection1= /lib/classes/' to classloader [junit4:junit4] 2> 7342 T865 oasc.SolrConfig. Using Lucene MatchVer= sion: LUCENE_40 [junit4:junit4] 2> 7395 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 7401 T923 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 7401 T911 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 7401 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 7401 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 7416 T865 oasc.SolrConfig. Loaded SolrConfig: so= lrconfig.xml [junit4:junit4] 2> 7517 T865 oass.IndexSchema.readSchema Reading Solr Sch= ema [junit4:junit4] 2> 7524 T865 oass.IndexSchema.readSchema Schema name=3Dte= st [junit4:junit4] 2> 8118 T865 oass.OpenExchangeRatesOrgProvider.init Initi= alized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4:junit4] 2> 8126 T865 oass.IndexSchema.readSchema default search f= ield in schema is text [junit4:junit4] 2> 8128 T865 oass.IndexSchema.readSchema unique key field= : id [junit4:junit4] 2> 8139 T865 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 8142 T865 oass.FileExchangeRateProvider.reload Reloadi= ng exchange rates from file currency.xml [junit4:junit4] 2> 8146 T865 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 8147 T865 oass.OpenExchangeRatesOrgProvider.reload Rel= oading exchange rates from open-exchange-rates.json [junit4:junit4] 2> 8148 T865 oasc.SolrCore. [collection1] Opening n= ew SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.= x-java7/solr/build/solr-core/test/J0/./solrtest-jetty3-1347822215934/collec= tion1/, dataDir=3D./org.apache.solr.cloud.BasicDistributedZkTest-1347822209= 012/jetty3/ [junit4:junit4] 2> 8148 T865 oasc.JmxMonitoredMap. JMX monitoring i= s enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBe= anServer@69ad7d8c [junit4:junit4] 2> 8149 T865 oasc.SolrCore.getNewIndexDir WARNING New ind= ex directory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistri= butedZkTest-1347822209012/jetty3/index/ [junit4:junit4] 2> 8150 T865 oasc.SolrCore.initIndex WARNING [collection1= ] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1347= 822209012/jetty3/index' doesn't exist. Creating new index... [junit4:junit4] 2> 8150 T865 oasc.CachingDirectoryFactory.get return new = directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x= -java7/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistribute= dZkTest-1347822209012/jetty3/index forceNew:false [junit4:junit4] 2> 8155 T865 oasc.SolrDeletionPolicy.onCommit SolrDeletio= nPolicy.onCommit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty3/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@b2f5b46; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0),= segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 8156 T865 oasc.SolrDeletionPolicy.updateCommits newest= commit =3D 1 [junit4:junit4] 2> 8156 T865 oasc.SolrCore.initWriters created xml: solr.= XMLResponseWriter [junit4:junit4] 2> 8159 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe" [junit4:junit4] 2> 8159 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "de= dupe-allfields" [junit4:junit4] 2> 8159 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "st= ored_sig" [junit4:junit4] 2> 8160 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "un= iq-fields" [junit4:junit4] 2> 8160 T865 oasup.UpdateRequestProcessorChain.init inser= ting DistributedUpdateProcessorFactory into updateRequestProcessorChain "di= strib-dup-test-chain-implicit" [junit4:junit4] 2> 8161 T865 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.ReplicationHandler [junit4:junit4] 2> 8161 T865 oasc.RequestHandlers.initHandlersFromConfig = created /replication: solr.ReplicationHandler [junit4:junit4] 2> 8162 T865 oasc.RequestHandlers.initHandlersFromConfig = created standard: solr.StandardRequestHandler [junit4:junit4] 2> 8162 T865 oasc.RequestHandlers.initHandlersFromConfig = created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 8163 T865 oasc.RequestHandlers.initHandlersFromConfig = created dismax: solr.SearchHandler [junit4:junit4] 2> 8163 T865 oasc.RequestHandlers.initHandlersFromConfig = created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4:junit4] 2> 8164 T865 oasc.RequestHandlers.initHandlersFromConfig = created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 8164 T865 oasc.RequestHandlers.initHandlersFromConfig = created defaults: solr.StandardRequestHandler [junit4:junit4] 2> 8165 T865 oasc.RequestHandlers.initHandlersFromConfig = adding lazy requestHandler: solr.StandardRequestHandler [junit4:junit4] 2> 8165 T865 oasc.RequestHandlers.initHandlersFromConfig = created lazy: solr.StandardRequestHandler [junit4:junit4] 2> 8166 T865 oasc.RequestHandlers.initHandlersFromConfig = created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 8166 T865 oasc.RequestHandlers.initHandlersFromConfig = created /terms: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 8167 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 8167 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 8168 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHa= ndler [junit4:junit4] 2> 8168 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.S= earchHandler [junit4:junit4] 2> 8169 T865 oasc.RequestHandlers.initHandlersFromConfig = created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 8169 T865 oasc.RequestHandlers.initHandlersFromConfig = created tvrh: org.apache.solr.handler.component.SearchHandler [junit4:junit4] 2> 8170 T865 oasc.RequestHandlers.initHandlersFromConfig = created /mlt: solr.MoreLikeThisHandler [junit4:junit4] 2> 8170 T865 oasc.RequestHandlers.initHandlersFromConfig = created /debug/dump: solr.DumpRequestHandler [junit4:junit4] 2> 8173 T865 oashl.XMLLoader.init xsltCacheLifetimeSecond= s=3D60 [junit4:junit4] 2> 8176 T865 oasc.SolrCore.initDeprecatedSupport WARNING = solrconfig.xml uses deprecated , Please update your co= nfig to use the ShowFileRequestHandler. [junit4:junit4] 2> 8177 T865 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> 8180 T865 oass.SolrIndexSearcher. Opening Search= er@fc106f1 main [junit4:junit4] 2> 8181 T865 oasu.CommitTracker. Hard AutoCommit: d= isabled [junit4:junit4] 2> 8181 T865 oasu.CommitTracker. Soft AutoCommit: d= isabled [junit4:junit4] 2> 8182 T865 oashc.SpellCheckComponent.inform Initializin= g spell checkers [junit4:junit4] 2> 8197 T865 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4:junit4] 2> 8245 T924 oasc.SolrCore.registerSearcher [collection1]= Registered new searcher Searcher@fc106f1 main{StandardDirectoryReader(segm= ents_1:1)} [junit4:junit4] 2> 8407 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 8435 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8435 T923 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8435 T911 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8435 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8752 T865 oasc.CoreContainer.register registering core= : collection1 [junit4:junit4] 2> 8753 T865 oasc.ZkController.register Register shard - = core:collection1 address:http://127.0.0.1:38196/solr shardId:shard1 [junit4:junit4] 2> 8756 T865 oasc.ZkController.register We are http://127= .0.0.1:38196/solr/collection1/ and leader is http://127.0.0.1:38175/solr/co= llection1/ [junit4:junit4] 2> 8756 T865 oasc.ZkController.register No LogReplay need= ed for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:38196/solr [junit4:junit4] 2> 8757 T865 oasc.ZkController.checkRecovery Core needs t= o recover:collection1 [junit4:junit4] 2> 8757 T865 oasu.DefaultSolrCoreState.doRecovery Running= recovery - first canceling any ongoing recovery [junit4:junit4] 2> ASYNC NEW_CORE C76 name=3Dcollection1 org.apache.solr= .core.SolrCore@14ac90e url=3Dhttp://127.0.0.1:38196/solr/collection1 node= =3D127.0.0.1:38196_solr [junit4:junit4] 2> 8766 T925 C76 P38196 oasc.RecoveryStrategy.run Startin= g recovery process. core=3Dcollection1 recoveringAfterStartup=3Dtrue [junit4:junit4] 2> 8766 T865 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 8767 T925 C76 P38196 oasc.RecoveryStrategy.doRecovery = ###### startupVersions=3D[] [junit4:junit4] 2> 8768 T865 oass.SolrDispatchFilter.init user.dir=3D/usr= /home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/= solr-core/test/J0 [junit4:junit4] 2> 8769 T925 C76 P38196 oasc.RecoveryStrategy.doRecovery = Attempting to PeerSync from http://127.0.0.1:38175/solr/collection1/ core= =3Dcollection1 - recoveringAfterStartup=3Dtrue [junit4:junit4] 2> 8768 T865 oass.SolrDispatchFilter.init SolrDispatchFil= ter.init() done [junit4:junit4] 2> 8770 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&fol= lowRedirects=3Dfalse [junit4:junit4] 2> 8776 T925 C76 P38196 oascsi.HttpClientUtil.createClien= t Creating new http client, config:maxConnectionsPerHost=3D20&maxConnection= s=3D10000&connTimeout=3D30000&socketTimeout=3D30000&retry=3Dfalse [junit4:junit4] 2> 8799 T925 C76 P38196 oasu.PeerSync.sync PeerSync: core= =3Dcollection1 url=3Dhttp://127.0.0.1:38196/solr START replicas=3D[http://1= 27.0.0.1:38175/solr/collection1/] nUpdates=3D100 [junit4:junit4] 2> 8799 T865 oaz.ZooKeeper. Initiating client conne= ction, connectString=3D127.0.0.1:38156/solr sessionTimeout=3D10000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@477e5bcb [junit4:junit4] 2> 8800 T925 C76 P38196 oasu.PeerSync.sync WARNING no fra= me of reference to tell of we've missed updates [junit4:junit4] 2> 8801 T927 oaz.ClientCnxn$SendThread.startConnect Openi= ng socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 8801 T925 C76 P38196 oasc.RecoveryStrategy.doRecovery = PeerSync Recovery was not successful - trying replication. core=3Dcollectio= n1 [junit4:junit4] 2> 8801 T865 oascc.ConnectionManager.waitForConnected Wai= ting for client to connect to ZooKeeper [junit4:junit4] 2> 8801 T925 C76 P38196 oasc.RecoveryStrategy.doRecovery = Starting Replication Recovery. core=3Dcollection1 [junit4:junit4] 2> 8802 T927 oaz.ClientCnxn$SendThread.primeConnection So= cket connection established to localhost/127.0.0.1:38156, initiating sessio= n [junit4:junit4] 2> 8802 T925 C76 P38196 oascsi.HttpClientUtil.createClien= t Creating new http client, config:maxConnections=3D128&maxConnectionsPerHo= st=3D32&followRedirects=3Dfalse [junit4:junit4] 2> 8802 T867 oazs.NIOServerCnxn$Factory.run Accepted sock= et connection from /140.211.11.196:38208 [junit4:junit4] 2> ASYNC NEW_CORE C77 name=3Dcollection1 org.apache.solr= .core.SolrCore@13666d58 url=3Dhttp://127.0.0.1:38175/solr/collection1 node= =3D127.0.0.1:38175_solr [junit4:junit4] 2> 8812 T891 C77 P38175 REQ /get {distrib=3Dfalse&qt=3D/g= et&wt=3Djavabin&version=3D2&getVersions=3D100} status=3D0 QTime=3D0=20 [junit4:junit4] 2> 8816 T867 oazs.NIOServerCnxn.readConnectRequest Client= attempting to establish new session at /140.211.11.196:38208 [junit4:junit4] 2> 8818 T869 oazs.NIOServerCnxn.finishSessionInit Establi= shed session 0x139d076c7fa0006 with negotiated timeout 10000 for client /14= 0.211.11.196:38208 [junit4:junit4] 2> 8818 T927 oaz.ClientCnxn$SendThread.readConnectResult = Session establishment complete on server localhost/127.0.0.1:38156, session= id =3D 0x139d076c7fa0006, negotiated timeout =3D 10000 [junit4:junit4] 2> 8818 T928 oascc.ConnectionManager.process Watcher org.= apache.solr.common.cloud.ConnectionManager@477e5bcb name:ZooKeeperConnectio= n Watcher:127.0.0.1:38156/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 8818 T865 oascc.ConnectionManager.waitForConnected Cli= ent is connected to ZooKeeper [junit4:junit4] 2> 8819 T865 oascc.ZkStateReader.createClusterStateWatche= rsAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 8823 T865 oasc.ChaosMonkey.monkeyLog monkey: init - ex= pire sessions:true cause connection loss:true [junit4:junit4] 2> 8824 T865 oascsi.HttpClientUtil.createClient Creating = new http client, config: [junit4:junit4] 2> 8838 T865 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 8840 T865 oasc.AbstractDistribZkTestBase.waitForRecove= riesToFinish Wait for recoveries to finish - collection: collection1 failOn= Timeout:true timeout (sec):1800 [junit4:junit4] 2> 8841 T865 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 8940 T886 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 8945 T885 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8945 T928 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8945 T923 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8945 T911 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 8945 T899 oascc.ZkStateReader$2.process A cluster stat= e change has occurred - updating... [junit4:junit4] 2> 9842 T865 oascc.ZkStateReader.updateClusterState Updat= ing cloud state from ZooKeeper...=20 [junit4:junit4] 2> 10844 T865 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> C76_STATE=3Dcoll:collection1 core:collection1 props:{= shard=3Dshard1, roles=3Dnull, state=3Drecovering, core=3Dcollection1, colle= ction=3Dcollection1, node_name=3D127.0.0.1:38196_solr, base_url=3Dhttp://12= 7.0.0.1:38196/solr} [junit4:junit4] 2> 11819 T925 C76 P38196 oasc.RecoveryStrategy.doRecovery= Begin buffering updates. core=3Dcollection1 [junit4:junit4] 2> 11819 T925 C76 P38196 oasu.UpdateLog.bufferUpdates Sta= rting to buffer updates. FSUpdateLog{state=3DACTIVE, tlog=3Dnull} [junit4:junit4] 2> 11819 T925 C76 P38196 oasc.RecoveryStrategy.replicate = Attempting to replicate from http://127.0.0.1:38175/solr/collection1/. core= =3Dcollection1 [junit4:junit4] 2> 11820 T925 C76 P38196 oascsi.HttpClientUtil.createClie= nt Creating new http client, config:maxConnections=3D128&maxConnectionsPerH= ost=3D32&followRedirects=3Dfalse [junit4:junit4] 2> 11833 T893 C77 P38175 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 11838 T893 C77 P38175 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty1/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@440beaaa; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0)= ,segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 11839 T893 C77 P38175 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 11840 T893 C77 P38175 oass.SolrIndexSearcher. Op= ening Searcher@5f8a9234 main [junit4:junit4] 2> 11841 T893 C77 P38175 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 11842 T900 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@5f8a9234 main{StandardDirectoryReader(se= gments_1:1)} [junit4:junit4] 2> 11843 T893 C77 P38175 /update {waitSearcher=3Dtrue&com= mit=3Dtrue&commit_end_point=3Dtrue&wt=3Djavabin&softCommit=3Dfalse&version= =3D2} {commit=3D} 0 10 [junit4:junit4] 2> 11844 T925 C76 P38196 oash.ReplicationHandler.inform C= ommits will be reserved for 10000 [junit4:junit4] 2> 11845 T925 C76 P38196 oascsi.HttpClientUtil.createClie= nt Creating new http client, config:connTimeout=3D5000&socketTimeout=3D2000= 0&allowCompression=3Dfalse&maxConnections=3D10000&maxConnectionsPerHost=3D1= 0000 [junit4:junit4] 2> 11846 T865 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 11866 T925 C76 P38196 oash.SnapPuller. No value= set for 'pollInterval'. Timer Task not started. [junit4:junit4] 2> 11869 T894 C77 P38175 oash.ReplicationHandler.inform C= ommits will be reserved for 10000 [junit4:junit4] 2> 11869 T894 C77 P38175 REQ /replication {command=3Dinde= xversion&wt=3Djavabin&qt=3D/replication&version=3D2} status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 11874 T925 C76 P38196 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty3/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@b2f5b46; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0),= segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 11875 T925 C76 P38196 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 11876 T925 C76 P38196 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 11879 T925 C76 P38196 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty3/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@b2f5b46; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0),= segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty3/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@b2f5b46; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0),= segFN=3Dsegments_2,generation=3D2,filenames=3D[segments_2] [junit4:junit4] 2> 11880 T925 C76 P38196 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 2 [junit4:junit4] 2> 11883 T925 C76 P38196 oass.SolrIndexSearcher. Op= ening Searcher@73401188 main [junit4:junit4] 2> 11883 T925 C76 P38196 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 11885 T924 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@73401188 main{StandardDirectoryReader(se= gments_2:2)} [junit4:junit4] 2> 11886 T925 C76 P38196 oasc.RecoveryStrategy.replay No = replay needed. core=3Dcollection1 [junit4:junit4] 2> 11886 T925 C76 P38196 oasc.RecoveryStrategy.doRecovery= Replication Recovery was successful - registering as Active. core=3Dcollec= tion1 [junit4:junit4] 2> 11888 T925 C76 P38196 oasc.RecoveryStrategy.doRecovery= Finished recovery process. core=3Dcollection1 [junit4:junit4] 2> 11959 T886 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> 11971 T885 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11971 T928 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11971 T911 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11971 T899 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 11971 T923 oascc.ZkStateReader$2.process A cluster sta= te change has occurred - updating... [junit4:junit4] 2> 12848 T865 oascc.ZkStateReader.updateClusterState Upda= ting cloud state from ZooKeeper...=20 [junit4:junit4] 2> ASYNC NEW_CORE C78 name=3Dcollection1 org.apache.solr= .core.SolrCore@2a200274 url=3Dhttp://127.0.0.1:38162/solr/collection1 node= =3D127.0.0.1:38162_solr [junit4:junit4] 2> 12865 T877 C78 P38162 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/control/data/index lockFactory=3Dorg.apache.l= ucene.store.NativeFSLockFactory@2b4564a5; maxCacheMB=3D48.0 maxMergeSizeMB= =3D4.0),segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 12865 T877 C78 P38162 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 12867 T877 C78 P38162 oass.SolrIndexSearcher. Op= ening Searcher@f5e908f realtime [junit4:junit4] 2> 12867 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {deleteByQuery=3D*:* (-1413294034114314240)} 0 8 [junit4:junit4] 2> 12868 T865 oaz.ZooKeeper. Initiating client conn= ection, connectString=3D127.0.0.1:38156/solr sessionTimeout=3D10000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@964a42b [junit4:junit4] 2> 12869 T929 oaz.ClientCnxn$SendThread.startConnect Open= ing socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 12869 T865 oascc.ConnectionManager.waitForConnected Wa= iting for client to connect to ZooKeeper [junit4:junit4] 2> 12870 T929 oaz.ClientCnxn$SendThread.primeConnection S= ocket connection established to localhost/127.0.0.1:38156, initiating sessi= on [junit4:junit4] 2> 12871 T867 oazs.NIOServerCnxn$Factory.run Accepted soc= ket connection from /140.211.11.196:38227 [junit4:junit4] 2> 12871 T867 oazs.NIOServerCnxn.readConnectRequest Clien= t attempting to establish new session at /140.211.11.196:38227 [junit4:junit4] 2> 12873 T869 oazs.NIOServerCnxn.finishSessionInit Establ= ished session 0x139d076c7fa0007 with negotiated timeout 10000 for client /1= 40.211.11.196:38227 [junit4:junit4] 2> 12873 T929 oaz.ClientCnxn$SendThread.readConnectResult= Session establishment complete on server localhost/127.0.0.1:38156, sessio= nid =3D 0x139d076c7fa0007, negotiated timeout =3D 10000 [junit4:junit4] 2> 12873 T930 oascc.ConnectionManager.process Watcher org= .apache.solr.common.cloud.ConnectionManager@964a42b name:ZooKeeperConnectio= n Watcher:127.0.0.1:38156/solr got event WatchedEvent state:SyncConnected t= ype:None path:null path:null type:None [junit4:junit4] 2> 12873 T865 oascc.ConnectionManager.waitForConnected Cl= ient is connected to ZooKeeper [junit4:junit4] 2> 12874 T865 oascc.ZkStateReader.createClusterStateWatch= ersAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> ASYNC NEW_CORE C79 name=3Dcollection1 org.apache.solr= .core.SolrCore@2bb3230e url=3Dhttp://127.0.0.1:38185/solr/collection1 node= =3D127.0.0.1:38185_solr [junit4:junit4] 2> 12887 T903 C79 P38185 oasc.SolrDeletionPolicy.onInit S= olrDeletionPolicy.onInit: commits:num=3D1 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty2/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@19f963a5; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0)= ,segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> 12888 T903 C79 P38185 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 1 [junit4:junit4] 2> 12889 T903 C79 P38185 oass.SolrIndexSearcher. Op= ening Searcher@3050dc66 realtime [junit4:junit4] 2> 12894 T895 C77 P38175 oass.SolrIndexSearcher. Op= ening Searcher@1444f8cf realtime [junit4:junit4] 2> C76_STATE=3Dcoll:collection1 core:collection1 props:{= shard=3Dshard1, roles=3Dnull, state=3Dactive, core=3Dcollection1, collectio= n=3Dcollection1, node_name=3D127.0.0.1:38196_solr, base_url=3Dhttp://127.0.= 0.1:38196/solr} [junit4:junit4] 2> 12903 T915 C76 P38196 oass.SolrIndexSearcher. Op= ening Searcher@5d302aa0 realtime [junit4:junit4] 2> 12904 T915 C76 P38196 REQ /update {_version_=3D-141329= 4034146820096&update.distrib=3DFROMLEADER&update.from=3Dhttp://127.0.0.1:38= 175/solr/collection1/&wt=3Djavabin&version=3D2} status=3D0 QTime=3D3=20 [junit4:junit4] 2> 12905 T895 C77 P38175 REQ /update {update.distrib=3DTO= LEADER&wt=3Djavabin&version=3D2} status=3D0 QTime=3D14=20 [junit4:junit4] 2> 12906 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {deleteByQuery=3D*:* (-1413294034138431488)} 0 23 [junit4:junit4] 2> 12913 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[1 (1413294034166743040)]} 0 4 [junit4:junit4] 2> 12925 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D4=20 [junit4:junit4] 2> 12926 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[1 (1413294034173034496)]} 0 10 [junit4:junit4] 2> 12931 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[2 (1413294034187714560)]} 0 2 [junit4:junit4] 2> 12945 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D4=20 [junit4:junit4] 2> 12946 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[2]} 0 12 [junit4:junit4] 2> 12951 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[3 (1413294034208686080)]} 0 2 [junit4:junit4] 2> 12956 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[3 (1413294034212880384)]} 0 2 [junit4:junit4] 2> 12961 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[4 (1413294034219171840)]} 0 2 [junit4:junit4] 2> 12970 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 12971 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[4 (1413294034223366144)]} 0 7 [junit4:junit4] 2> 12976 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[5 (1413294034234900480)]} 0 2 [junit4:junit4] 2> 12981 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[5 (1413294034240143360)]} 0 2 [junit4:junit4] 2> 12986 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[6 (1413294034245386240)]} 0 2 [junit4:junit4] 2> 12991 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[6 (1413294034250629120)]} 0 2 [junit4:junit4] 2> 12996 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[7 (1413294034255872000)]} 0 2 [junit4:junit4] 2> 13001 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[7 (1413294034260066304)]} 0 2 [junit4:junit4] 2> 13006 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[8 (1413294034265309184)]} 0 2 [junit4:junit4] 2> 13015 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13016 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[8 (1413294034271600640)]} 0 7 [junit4:junit4] 2> 13021 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[9 (1413294034282086400)]} 0 2 [junit4:junit4] 2> 13029 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13030 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[9]} 0 6 [junit4:junit4] 2> 13055 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[10 (1413294034296766464)]} 0 22 [junit4:junit4] 2> 13067 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13067 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13068 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[10]} 0 10 [junit4:junit4] 2> 13074 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[11 (1413294034335563776)]} 0 3 [junit4:junit4] 2> 13086 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13087 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D7=20 [junit4:junit4] 2> 13088 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[11]} 0 11 [junit4:junit4] 2> 13093 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[12 (1413294034357583872)]} 0 2 [junit4:junit4] 2> 13102 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13103 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[12 (1413294034362826752)]} 0 7 [junit4:junit4] 2> 13108 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[13 (1413294034373312512)]} 0 2 [junit4:junit4] 2> 13121 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13122 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D8=20 [junit4:junit4] 2> 13122 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[13]} 0 11 [junit4:junit4] 2> 13128 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[14 (1413294034393235456)]} 0 2 [junit4:junit4] 2> 13136 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13137 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[14 (1413294034399526912)]} 0 6 [junit4:junit4] 2> 13141 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[15 (1413294034408964096)]} 0 1 [junit4:junit4] 2> 13149 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13150 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[15 (1413294034413158400)]} 0 6 [junit4:junit4] 2> 13154 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[16 (1413294034421547008)]} 0 1 [junit4:junit4] 2> 13190 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D15=20 [junit4:junit4] 2> 13191 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[16 (1413294034425741312)]} 0 34 [junit4:junit4] 2> 13197 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[17 (1413294034465587200)]} 0 3 [junit4:junit4] 2> 13207 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D3=20 [junit4:junit4] 2> 13208 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[17]} 0 8 [junit4:junit4] 2> 13212 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[100 (1413294034482364416)]} 0 1 [junit4:junit4] 2> 13226 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D3=20 [junit4:junit4] 2> 13226 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D8=20 [junit4:junit4] 2> 13227 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[100]} 0 12 [junit4:junit4] 2> 13231 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[101 (1413294034502287360)]} 0 1 [junit4:junit4] 2> 13239 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13240 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[101 (1413294034506481664)]} 0 6 [junit4:junit4] 2> 13259 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[102 (1413294034515918848)]} 0 16 [junit4:junit4] 2> 13271 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13271 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13272 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[102]} 0 10 [junit4:junit4] 2> 13278 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[103 (1413294034550521856)]} 0 3 [junit4:junit4] 2> 13284 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13284 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[103]} 0 5 [junit4:junit4] 2> 13288 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[104 (1413294034562056192)]} 0 1 [junit4:junit4] 2> 13295 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13296 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[104]} 0 5 [junit4:junit4] 2> 13300 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[105 (1413294034574639104)]} 0 1 [junit4:junit4] 2> 13318 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[105 (1413294034578833408)]} 0 15 [junit4:junit4] 2> 13322 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[106 (1413294034598756352)]} 0 1 [junit4:junit4] 2> 13330 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13331 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[106]} 0 6 [junit4:junit4] 2> 13336 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[107 (1413294034612387840)]} 0 2 [junit4:junit4] 2> 13347 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13348 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13349 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[107]} 0 10 [junit4:junit4] 2> 13353 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[108 (1413294034630213632)]} 0 1 [junit4:junit4] 2> 13364 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13365 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13366 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[108]} 0 10 [junit4:junit4] 2> 13371 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[109 (1413294034648039424)]} 0 2 [junit4:junit4] 2> 13379 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13380 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[109 (1413294034652233728)]} 0 7 [junit4:junit4] 2> 13386 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[110 (1413294034664816640)]} 0 1 [junit4:junit4] 2> 13396 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13397 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[110 (1413294034671108096)]} 0 7 [junit4:junit4] 2> 13403 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[111 (1413294034682642432)]} 0 2 [junit4:junit4] 2> 13416 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13418 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[111 (1413294034687885312)]} 0 12 [junit4:junit4] 2> 13437 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[112 (1413294034703613952)]} 0 16 [junit4:junit4] 2> 13442 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[112 (1413294034723536896)]} 0 2 [junit4:junit4] 2> 13448 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[113 (1413294034728779776)]} 0 3 [junit4:junit4] 2> 13459 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13460 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13461 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[113]} 0 10 [junit4:junit4] 2> 13466 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[114 (1413294034747654144)]} 0 2 [junit4:junit4] 2> 13501 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D14=20 [junit4:junit4] 2> 13502 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D31=20 [junit4:junit4] 2> 13503 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[114]} 0 35 [junit4:junit4] 2> 13508 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[115 (1413294034792742912)]} 0 2 [junit4:junit4] 2> 13516 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13516 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[115]} 0 5 [junit4:junit4] 2> 13520 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[116 (1413294034805325824)]} 0 1 [junit4:junit4] 2> 13524 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[116 (1413294034809520128)]} 0 1 [junit4:junit4] 2> 13528 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[117 (1413294034813714432)]} 0 1 [junit4:junit4] 2> 13532 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[117 (1413294034817908736)]} 0 1 [junit4:junit4] 2> 13536 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[118 (1413294034822103040)]} 0 1 [junit4:junit4] 2> 13546 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13547 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[118 (1413294034827345920)]} 0 8 [junit4:junit4] 2> 13552 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[119 (1413294034838880256)]} 0 2 [junit4:junit4] 2> 13557 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[119 (1413294034844123136)]} 0 2 [junit4:junit4] 2> 13561 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[120 (1413294034849366016)]} 0 1 [junit4:junit4] 2> 13568 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13569 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[120]} 0 5 [junit4:junit4] 2> 13573 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[121 (1413294034860900352)]} 0 1 [junit4:junit4] 2> 13580 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13581 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[121]} 0 5 [junit4:junit4] 2> 13598 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[122 (1413294034873483264)]} 0 14 [junit4:junit4] 2> 13606 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13607 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[122 (1413294034891309056)]} 0 6 [junit4:junit4] 2> 13613 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[123 (1413294034901794816)]} 0 3 [junit4:junit4] 2> 13620 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13621 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[123 (1413294034907037696)]} 0 6 [junit4:junit4] 2> 13625 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[124 (1413294034916474880)]} 0 1 [junit4:junit4] 2> 13636 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13637 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13638 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[124]} 0 10 [junit4:junit4] 2> 13658 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[125 (1413294034950029312)]} 0 17 [junit4:junit4] 2> 13666 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13667 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[125 (1413294034955272192)]} 0 6 [junit4:junit4] 2> 13671 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[126 (1413294034964709376)]} 0 1 [junit4:junit4] 2> 13678 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13679 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[126]} 0 5 [junit4:junit4] 2> 13683 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[127 (1413294034976243712)]} 0 1 [junit4:junit4] 2> 13703 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D14=20 [junit4:junit4] 2> 13703 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[127]} 0 17 [junit4:junit4] 2> 13707 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[128 (1413294035002458112)]} 0 1 [junit4:junit4] 2> 13715 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13716 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[128]} 0 6 [junit4:junit4] 2> 13720 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[129 (1413294035015041024)]} 0 1 [junit4:junit4] 2> 13731 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13732 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13733 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[129]} 0 10 [junit4:junit4] 2> 13737 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[130 (1413294035033915392)]} 0 1 [junit4:junit4] 2> 13741 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[130 (1413294035037061120)]} 0 1 [junit4:junit4] 2> 13745 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[131 (1413294035041255424)]} 0 1 [junit4:junit4] 2> 13749 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[131 (1413294035045449728)]} 0 1 [junit4:junit4] 2> 13766 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[132 (1413294035049644032)]} 0 14 [junit4:junit4] 2> 13777 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13778 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13779 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[132]} 0 10 [junit4:junit4] 2> 13785 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[133 (1413294035082149888)]} 0 3 [junit4:junit4] 2> 13799 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13800 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13801 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[133]} 0 10 [junit4:junit4] 2> 13805 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[134 (1413294035105218560)]} 0 1 [junit4:junit4] 2> 13809 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[134 (1413294035108364288)]} 0 1 [junit4:junit4] 2> 13813 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[135 (1413294035112558592)]} 0 1 [junit4:junit4] 2> 13824 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13825 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 13826 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[135]} 0 10 [junit4:junit4] 2> 13830 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[136 (1413294035131432960)]} 0 1 [junit4:junit4] 2> 13834 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[136 (1413294035135627264)]} 0 1 [junit4:junit4] 2> 13838 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[137 (1413294035138772992)]} 0 1 [junit4:junit4] 2> 13842 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[137 (1413294035144015872)]} 0 1 [junit4:junit4] 2> 13846 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[138 (1413294035148210176)]} 0 1 [junit4:junit4] 2> 13880 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D13=20 [junit4:junit4] 2> 13881 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D29=20 [junit4:junit4] 2> 13882 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[138]} 0 33 [junit4:junit4] 2> 13886 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[139 (1413294035190153216)]} 0 1 [junit4:junit4] 2> 13893 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13894 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[139]} 0 5 [junit4:junit4] 2> 13898 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[140 (1413294035201687552)]} 0 1 [junit4:junit4] 2> 13905 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 13906 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[140]} 0 5 [junit4:junit4] 2> 13910 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[141 (1413294035215319040)]} 0 1 [junit4:junit4] 2> 13914 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[141 (1413294035219513344)]} 0 1 [junit4:junit4] 2> 13930 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[142 (1413294035222659072)]} 0 13 [junit4:junit4] 2> 13948 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D12=20 [junit4:junit4] 2> 13949 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[142]} 0 16 [junit4:junit4] 2> 13955 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[143 (1413294035260407808)]} 0 3 [junit4:junit4] 2> 13962 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13963 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[143]} 0 6 [junit4:junit4] 2> 13967 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[144 (1413294035274039296)]} 0 1 [junit4:junit4] 2> 13971 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[144 (1413294035279282176)]} 0 1 [junit4:junit4] 2> 13975 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[145 (1413294035282427904)]} 0 1 [junit4:junit4] 2> 13979 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[145 (1413294035287670784)]} 0 1 [junit4:junit4] 2> 13983 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[146 (1413294035290816512)]} 0 1 [junit4:junit4] 2> 13993 T915 C76 P38196 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DFROMLEADER&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 13994 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[146 (1413294035296059392)]} 0 8 [junit4:junit4] 2> 13998 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[147 (1413294035306545152)]} 0 1 [junit4:junit4] 2> 14002 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[147 (1413294035311788032)]} 0 1 [junit4:junit4] 2> 14006 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[148 (1413294035315982336)]} 0 1 [junit4:junit4] 2> 14017 T915 C76 P38196 REQ /update {update.distrib=3DFR= OMLEADER&distrib.from=3Dhttp://127.0.0.1:38175/solr/collection1/&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 14018 T895 C77 P38175 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38185/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D6=20 [junit4:junit4] 2> 14019 T903 C79 P38185 /update {wt=3Djavabin&version=3D= 2} {add=3D[148]} 0 10 [junit4:junit4] 2> 14023 T877 C78 P38162 /update {wt=3Djavabin&version=3D= 2} {add=3D[149 (1413294035333808128)]} 0 1 [junit4:junit4] 2> 14030 T904 C79 P38185 REQ /update {distrib.from=3Dhttp= ://127.0.0.1:38175/solr/collection1/&update.distrib=3DTOLEADER&wt=3Djavabin= &version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 14031 T896 C77 P38175 /update {wt=3Djavabin&version=3D= 2} {add=3D[149]} 0 5 [junit4:junit4] 2> 14034 T877 C78 P38162 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 14644 T877 C78 P38162 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/control/data/index lockFactory=3Dorg.apache.l= ucene.store.NativeFSLockFactory@2b4564a5; maxCacheMB=3D48.0 maxMergeSizeMB= =3D4.0),segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/control/data/index lockFactory=3Dorg.apache.l= ucene.store.NativeFSLockFactory@2b4564a5; maxCacheMB=3D48.0 maxMergeSizeMB= =3D4.0),segFN=3Dsegments_2,generation=3D2,filenames=3D[_5_nrm.cfe, _6_MockF= ixedIntBlock_0.pyl, _2_SimpleText_0.pst, _0_MockSep_0.pos, _6_MockFixedIntB= lock_0.frq, _4_MockSep_0.tib, _4_MockSep_0.skp, _3.fdt, _5_Lucene40WithOrds= _0.tib, _0_MockFixedIntBlock_0.tib, _3_MockSep_0.frq, _2_MockSep_0.doc, _6_= MockFixedIntBlock_0.skp, _0_Lucene40WithOrds_0.tii, _5_Lucene40WithOrds_0.t= ii, _0_Lucene40WithOrds_0.frq, _1_Lucene40WithOrds_0.tib, _6_MockSep_0.doc,= _0_MockFixedIntBlock_0.tii, _5_MockSep_0.skp, _0_SimpleText_0.pst, _4_Mock= Sep_0.doc, _1_Lucene40WithOrds_0.tii, _6_MockSep_0.frq, _0_Lucene40WithOrds= _0.tib, _1_MockSep_0.pyl, _1_Lucene40WithOrds_0.frq, _1_MockSep_0.skp, _4_M= ockFixedIntBlock_0.pos, _1_MockSep_0.tib, _2.fdt, _5_MockSep_0.doc, _2.fdx,= _1_MockSep_0.tii, _1.fdx, _5_nrm.cfs, _4_MockSep_0.pyl, _3_MockSep_0.pos, = _1.fdt, _4_MockFixedIntBlock_0.frq, _3.si, _2_MockFixedIntBlock_0.doc, _1_M= ockFixedIntBlock_0.pos, _6.fdt, _5_Lucene40WithOrds_0.prx, _4_MockSep_0.tii= , _1_SimpleText_0.pst, _2.si, _4_Lucene40WithOrds_0.tib, _4_Lucene40WithOrd= s_0.tii, _3_MockFixedIntBlock_0.frq, _6_MockSep_0.pyl, _6.fdx, _2_MockSep_0= .skp, _1_Lucene40WithOrds_0.prx, _2_MockFixedIntBlock_0.skp, _6_MockFixedIn= tBlock_0.tib, _3.fnm, _6_MockFixedIntBlock_0.tii, _5_MockSep_0.tii, _3_Mock= Sep_0.pyl, _2_nrm.cfe, _0_MockFixedIntBlock_0.pyl, _6_MockSep_0.pos, _2_nrm= .cfs, _6_MockFixedIntBlock_0.doc, _5_MockFixedIntBlock_0.frq, _1_MockSep_0.= pos, _2_Lucene40WithOrds_0.frq, _5_MockFixedIntBlock_0.tib, _6_MockSep_0.sk= p, _3_MockFixedIntBlock_0.pos, _2.fnm, _3.fdx, _2_MockSep_0.pyl, _0_MockFix= edIntBlock_0.doc, _5_MockSep_0.tib, _1.si, _6.si, _6.fnm, _3_MockSep_0.skp,= _0_Lucene40WithOrds_0.prx, _3_Lucene40WithOrds_0.prx, _5_MockFixedIntBlock= _0.tii, _3_nrm.cfe, _3_MockSep_0.doc, _5_MockSep_0.pos, _5.fdt, _4_MockFixe= dIntBlock_0.tib, _3_MockFixedIntBlock_0.skp, _3_Lucene40WithOrds_0.tii, _1_= MockFixedIntBlock_0.pyl, _6_Lucene40WithOrds_0.prx, _4_nrm.cfe, _4.fnm, _1.= fnm, _2_MockFixedIntBlock_0.tii, _3_Lucene40WithOrds_0.tib, _4.fdx, _3_Mock= FixedIntBlock_0.pyl, _2_MockFixedIntBlock_0.tib, _2_MockFixedIntBlock_0.pyl= , _0_MockSep_0.skp, _3_MockSep_0.tib, _3_SimpleText_0.pst, _4_MockFixedIntB= lock_0.tii, _2_MockFixedIntBlock_0.frq, _6_MockSep_0.tii, _1_MockSep_0.doc,= _6_Lucene40WithOrds_0.frq, _6_MockSep_0.tib, _0.fnm, _1_MockFixedIntBlock_= 0.frq, _5_MockFixedIntBlock_0.pyl, _4_MockSep_0.pos, _4_MockFixedIntBlock_0= .skp, _5_MockSep_0.frq, _0_MockFixedIntBlock_0.pos, _2_MockSep_0.tii, _6_Lu= cene40WithOrds_0.tii, _2_MockSep_0.tib, _3_MockSep_0.tii, _5.si, _5_Lucene4= 0WithOrds_0.frq, _3_nrm.cfs, _6_MockFixedIntBlock_0.pos, _5_MockFixedIntBlo= ck_0.skp, _1_MockFixedIntBlock_0.skp, _4_Lucene40WithOrds_0.prx, _2_MockFix= edIntBlock_0.pos, _6_Lucene40WithOrds_0.tib, _4_MockFixedIntBlock_0.doc, _4= _nrm.cfs, _2_MockSep_0.pos, _5_MockSep_0.pyl, _1_MockSep_0.frq, _1_MockFixe= dIntBlock_0.doc, _4_Lucene40WithOrds_0.frq, _3_MockFixedIntBlock_0.doc, _6_= nrm.cfs, _0_MockFixedIntBlock_0.skp, _2_Lucene40WithOrds_0.prx, _4_MockFixe= dIntBlock_0.pyl, _0.si, _0_MockSep_0.doc, _5_SimpleText_0.pst, _1_MockFixed= IntBlock_0.tii, _1_nrm.cfs, _5.fnm, _6_nrm.cfe, _5_MockFixedIntBlock_0.pos,= _3_MockFixedIntBlock_0.tib, _5_MockFixedIntBlock_0.doc, _2_MockSep_0.frq, = _4.si, _4.fdt, _0_nrm.cfs, _3_Lucene40WithOrds_0.frq, _6_SimpleText_0.pst, = _1_nrm.cfe, _0_MockSep_0.tib, _0_MockFixedIntBlock_0.frq, _4_SimpleText_0.p= st, _2_Lucene40WithOrds_0.tii, _0_nrm.cfe, _5.fdx, _4_MockSep_0.frq, segmen= ts_2, _0_MockSep_0.frq, _1_MockFixedIntBlock_0.tib, _0.fdx, _2_Lucene40With= Ords_0.tib, _0_MockSep_0.tii, _0_MockSep_0.pyl, _0.fdt, _3_MockFixedIntBloc= k_0.tii] [junit4:junit4] 2> 14645 T877 C78 P38162 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 2 [junit4:junit4] 2> 14661 T877 C78 P38162 oass.SolrIndexSearcher. Op= ening Searcher@3596740e main [junit4:junit4] 2> 14662 T877 C78 P38162 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 14663 T888 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@3596740e main{StandardDirectoryReader(se= gments_2:15:nrt _0(4.0.0.2):C10 _1(4.0.0.2):C10 _2(4.0.0.2):C10 _3(4.0.0.2)= :C10 _4(4.0.0.2):C10 _5(4.0.0.2):C10 _6(4.0.0.2):C7)} [junit4:junit4] 2> 14664 T877 C78 P38162 /update {waitSearcher=3Dtrue&wt= =3Djavabin&commit=3Dtrue&softCommit=3Dfalse&version=3D2} {commit=3D} 0 630 [junit4:junit4] 2> 14668 T903 C79 P38185 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15035 T903 C79 P38185 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty2/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@19f963a5; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0)= ,segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty2/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@19f963a5; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0)= ,segFN=3Dsegments_2,generation=3D2,filenames=3D[_2_SimpleText_0.pst, _0_Moc= kSep_0.pos, _3.fdt, _0_MockFixedIntBlock_0.tib, _3_MockSep_0.frq, _2_MockSe= p_0.doc, _0_Lucene40WithOrds_0.tii, _0_Lucene40WithOrds_0.frq, _1_Lucene40W= ithOrds_0.tib, _0_MockFixedIntBlock_0.tii, _0_SimpleText_0.pst, _1_Lucene40= WithOrds_0.tii, _0_Lucene40WithOrds_0.tib, _1_MockSep_0.pyl, _1_Lucene40Wit= hOrds_0.frq, _1_MockSep_0.skp, _1_MockSep_0.tib, _2.fdt, _2.fdx, _1_MockSep= _0.tii, _1.fdx, _3_MockSep_0.pos, _1.fdt, _3.si, _2_MockFixedIntBlock_0.doc= , _1_MockFixedIntBlock_0.pos, _1_SimpleText_0.pst, _2.si, _3_MockFixedIntBl= ock_0.frq, _2_MockSep_0.skp, _1_Lucene40WithOrds_0.prx, _2_MockFixedIntBloc= k_0.skp, _3.fnm, _3_MockSep_0.pyl, _2_nrm.cfe, _0_MockFixedIntBlock_0.pyl, = _2_nrm.cfs, _1_MockSep_0.pos, _2_Lucene40WithOrds_0.frq, _3_MockFixedIntBlo= ck_0.pos, _2.fnm, _3.fdx, _2_MockSep_0.pyl, _0_MockFixedIntBlock_0.doc, _1.= si, _3_MockSep_0.skp, _0_Lucene40WithOrds_0.prx, _3_Lucene40WithOrds_0.prx,= _3_nrm.cfe, _3_MockSep_0.doc, _3_MockFixedIntBlock_0.skp, _3_Lucene40WithO= rds_0.tii, _1_MockFixedIntBlock_0.pyl, _1.fnm, _2_MockFixedIntBlock_0.tii, = _3_Lucene40WithOrds_0.tib, _3_MockFixedIntBlock_0.pyl, _2_MockFixedIntBlock= _0.tib, _2_MockFixedIntBlock_0.pyl, _0_MockSep_0.skp, _3_MockSep_0.tib, _3_= SimpleText_0.pst, _2_MockFixedIntBlock_0.frq, _1_MockSep_0.doc, _0.fnm, _1_= MockFixedIntBlock_0.frq, _0_MockFixedIntBlock_0.pos, _2_MockSep_0.tii, _2_M= ockSep_0.tib, _3_MockSep_0.tii, _3_nrm.cfs, _1_MockFixedIntBlock_0.skp, _2_= MockFixedIntBlock_0.pos, _2_MockSep_0.pos, _1_MockSep_0.frq, _1_MockFixedIn= tBlock_0.doc, _3_MockFixedIntBlock_0.doc, _0_MockFixedIntBlock_0.skp, _2_Lu= cene40WithOrds_0.prx, _0.si, _0_MockSep_0.doc, _1_MockFixedIntBlock_0.tii, = _1_nrm.cfs, _3_MockFixedIntBlock_0.tib, _2_MockSep_0.frq, _0_nrm.cfs, _3_Lu= cene40WithOrds_0.frq, _1_nrm.cfe, _0_MockFixedIntBlock_0.frq, _0_MockSep_0.= tib, _2_Lucene40WithOrds_0.tii, _0_nrm.cfe, segments_2, _0_MockSep_0.frq, _= 1_MockFixedIntBlock_0.tib, _0.fdx, _2_Lucene40WithOrds_0.tib, _0_MockSep_0.= tii, _0_MockSep_0.pyl, _0.fdt, _3_MockFixedIntBlock_0.tii] [junit4:junit4] 2> 15036 T903 C79 P38185 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 2 [junit4:junit4] 2> 15047 T903 C79 P38185 oass.SolrIndexSearcher. Op= ening Searcher@2189e7a main [junit4:junit4] 2> 15048 T903 C79 P38185 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15050 T912 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@2189e7a main{StandardDirectoryReader(seg= ments_2:9:nrt _0(4.0.0.2):C10 _1(4.0.0.2):C10 _2(4.0.0.2):C10 _3(4.0.0.2):C= 5)} [junit4:junit4] 2> 15051 T903 C79 P38185 oasu.SolrCmdDistributor.distribC= ommit Distrib commit to:[StdNode: http://127.0.0.1:38175/solr/collection1/,= StdNode: http://127.0.0.1:38196/solr/collection1/] [junit4:junit4] 2> 15054 T895 C77 P38175 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15055 T915 C76 P38196 oasu.DirectUpdateHandler2.commit= start commit{flags=3D0,_version_=3D0,optimize=3Dfalse,openSearcher=3Dtrue,= waitSearcher=3Dtrue,expungeDeletes=3Dfalse,softCommit=3Dfalse} [junit4:junit4] 2> 15467 T895 C77 P38175 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty1/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@440beaaa; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0)= ,segFN=3Dsegments_1,generation=3D1,filenames=3D[segments_1] [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty1/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@440beaaa; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0)= ,segFN=3Dsegments_2,generation=3D2,filenames=3D[_2_SimpleText_0.pst, _0_Moc= kSep_0.pos, _3.fdt, _0_MockFixedIntBlock_0.tib, _3_MockSep_0.frq, _2_MockSe= p_0.doc, _0_Lucene40WithOrds_0.tii, _0_Lucene40WithOrds_0.frq, _1_Lucene40W= ithOrds_0.tib, _0_MockFixedIntBlock_0.tii, _0_SimpleText_0.pst, _1_Lucene40= WithOrds_0.tii, _0_Lucene40WithOrds_0.tib, _1_MockSep_0.pyl, _1_Lucene40Wit= hOrds_0.frq, _1_MockSep_0.skp, _1_MockSep_0.tib, _2.fdt, _2.fdx, _1_MockSep= _0.tii, _1.fdx, _3_MockSep_0.pos, _1.fdt, _3.si, _2_MockFixedIntBlock_0.doc= , _1_MockFixedIntBlock_0.pos, _1_SimpleText_0.pst, _2.si, _3_MockFixedIntBl= ock_0.frq, _2_MockSep_0.skp, _1_Lucene40WithOrds_0.prx, _2_MockFixedIntBloc= k_0.skp, _3.fnm, _3_MockSep_0.pyl, _2_nrm.cfe, _0_MockFixedIntBlock_0.pyl, = _2_nrm.cfs, _1_MockSep_0.pos, _2_Lucene40WithOrds_0.frq, _3_MockFixedIntBlo= ck_0.pos, _2.fnm, _3.fdx, _2_MockSep_0.pyl, _0_MockFixedIntBlock_0.doc, _1.= si, _3_MockSep_0.skp, _0_Lucene40WithOrds_0.prx, _3_Lucene40WithOrds_0.prx,= _3_nrm.cfe, _3_MockSep_0.doc, _3_MockFixedIntBlock_0.skp, _3_Lucene40WithO= rds_0.tii, _1_MockFixedIntBlock_0.pyl, _1.fnm, _2_MockFixedIntBlock_0.tii, = _3_Lucene40WithOrds_0.tib, _3_MockFixedIntBlock_0.pyl, _2_MockFixedIntBlock= _0.tib, _2_MockFixedIntBlock_0.pyl, _0_MockSep_0.skp, _3_MockSep_0.tib, _3_= SimpleText_0.pst, _2_MockFixedIntBlock_0.frq, _1_MockSep_0.doc, _0.fnm, _1_= MockFixedIntBlock_0.frq, _0_MockFixedIntBlock_0.pos, _2_MockSep_0.tii, _2_M= ockSep_0.tib, _3_MockSep_0.tii, _3_nrm.cfs, _1_MockFixedIntBlock_0.skp, _2_= MockFixedIntBlock_0.pos, _2_MockSep_0.pos, _1_MockSep_0.frq, _1_MockFixedIn= tBlock_0.doc, _3_MockFixedIntBlock_0.doc, _0_MockFixedIntBlock_0.skp, _2_Lu= cene40WithOrds_0.prx, _0.si, _0_MockSep_0.doc, _1_MockFixedIntBlock_0.tii, = _1_nrm.cfs, _3_MockFixedIntBlock_0.tib, _2_MockSep_0.frq, _0_nrm.cfs, _3_Lu= cene40WithOrds_0.frq, _1_nrm.cfe, _0_MockSep_0.tib, _0_MockFixedIntBlock_0.= frq, _2_Lucene40WithOrds_0.tii, _0_nrm.cfe, segments_2, _0_MockSep_0.frq, _= 1_MockFixedIntBlock_0.tib, _0.fdx, _2_Lucene40WithOrds_0.tib, _0_MockSep_0.= tii, _0_MockSep_0.pyl, _0.fdt, _3_MockFixedIntBlock_0.tii] [junit4:junit4] 2> 15469 T895 C77 P38175 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 2 [junit4:junit4] 2> 15470 T915 C76 P38196 oasc.SolrDeletionPolicy.onCommit= SolrDeletionPolicy.onCommit: commits:num=3D2 [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty3/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@b2f5b46; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0),= segFN=3Dsegments_2,generation=3D2,filenames=3D[segments_2] [junit4:junit4] 2> =09=09commit{dir=3DNRTCachingDirectory(org.apache.luce= ne.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr= -Tests-4.x-java7/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDi= stributedZkTest-1347822209012/jetty3/index lockFactory=3Dorg.apache.lucene.= store.NativeFSLockFactory@b2f5b46; maxCacheMB=3D48.0 maxMergeSizeMB=3D4.0),= segFN=3Dsegments_3,generation=3D3,filenames=3D[_2_SimpleText_0.pst, _0_Mock= Sep_0.pos, _3.fdt, _0_MockFixedIntBlock_0.tib, _3_MockSep_0.frq, _2_MockSep= _0.doc, _0_Lucene40WithOrds_0.tii, _0_Lucene40WithOrds_0.frq, _1_Lucene40Wi= thOrds_0.tib, _0_MockFixedIntBlock_0.tii, _0_SimpleText_0.pst, _1_Lucene40W= ithOrds_0.tii, _0_Lucene40WithOrds_0.tib, _1_MockSep_0.pyl, _1_Lucene40With= Ords_0.frq, _1_MockSep_0.skp, _1_MockSep_0.tib, _2.fdt, _2.fdx, _1_MockSep_= 0.tii, _1.fdx, _3_MockSep_0.pos, _1.fdt, _3.si, _2_MockFixedIntBlock_0.doc,= _1_MockFixedIntBlock_0.pos, _1_SimpleText_0.pst, _2.si, _3_MockFixedIntBlo= ck_0.frq, _2_MockSep_0.skp, _1_Lucene40WithOrds_0.prx, _2_MockFixedIntBlock= _0.skp, _3.fnm, _3_MockSep_0.pyl, _2_nrm.cfe, _0_MockFixedIntBlock_0.pyl, _= 2_nrm.cfs, _1_MockSep_0.pos, _2_Lucene40WithOrds_0.frq, _3_MockFixedIntBloc= k_0.pos, _2.fnm, _3.fdx, _2_MockSep_0.pyl, _0_MockFixedIntBlock_0.doc, _1.s= i, _3_MockSep_0.skp, _0_Lucene40WithOrds_0.prx, _3_Lucene40WithOrds_0.prx, = _3_nrm.cfe, _3_MockSep_0.doc, _3_MockFixedIntBlock_0.skp, _3_Lucene40WithOr= ds_0.tii, _1_MockFixedIntBlock_0.pyl, _1.fnm, _2_MockFixedIntBlock_0.tii, _= 3_Lucene40WithOrds_0.tib, _3_MockFixedIntBlock_0.pyl, _2_MockFixedIntBlock_= 0.tib, _2_MockFixedIntBlock_0.pyl, _0_MockSep_0.skp, _3_MockSep_0.tib, _3_S= impleText_0.pst, _2_MockFixedIntBlock_0.frq, _1_MockSep_0.doc, _0.fnm, _1_M= ockFixedIntBlock_0.frq, _0_MockFixedIntBlock_0.pos, _2_MockSep_0.tii, _2_Mo= ckSep_0.tib, _3_MockSep_0.tii, _3_nrm.cfs, _1_MockFixedIntBlock_0.skp, _2_M= ockFixedIntBlock_0.pos, _2_MockSep_0.pos, _1_MockSep_0.frq, _1_MockFixedInt= Block_0.doc, _3_MockFixedIntBlock_0.doc, _0_MockFixedIntBlock_0.skp, _2_Luc= ene40WithOrds_0.prx, _0.si, _0_MockSep_0.doc, _1_MockFixedIntBlock_0.tii, _= 1_nrm.cfs, _3_MockFixedIntBlock_0.tib, _2_MockSep_0.frq, _0_nrm.cfs, _3_Luc= ene40WithOrds_0.frq, _1_nrm.cfe, _0_MockSep_0.tib, _0_MockFixedIntBlock_0.f= rq, _2_Lucene40WithOrds_0.tii, _0_nrm.cfe, _0_MockSep_0.frq, _1_MockFixedIn= tBlock_0.tib, _0.fdx, _2_Lucene40WithOrds_0.tib, _0_MockSep_0.tii, _0_MockS= ep_0.pyl, _0.fdt, segments_3, _3_MockFixedIntBlock_0.tii] [junit4:junit4] 2> 15471 T915 C76 P38196 oasc.SolrDeletionPolicy.updateCo= mmits newest commit =3D 3 [junit4:junit4] 2> 15482 T895 C77 P38175 oass.SolrIndexSearcher. Op= ening Searcher@39d216bb main [junit4:junit4] 2> 15483 T895 C77 P38175 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15485 T900 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@39d216bb main{StandardDirectoryReader(se= gments_2:9:nrt _0(4.0.0.2):C10 _1(4.0.0.2):C10 _2(4.0.0.2):C10 _3(4.0.0.2):= C2)} [junit4:junit4] 2> 15485 T915 C76 P38196 oass.SolrIndexSearcher. Op= ening Searcher@6044798d main [junit4:junit4] 2> 15485 T895 C77 P38175 /update {waitSearcher=3Dtrue&com= mit=3Dtrue&wt=3Djavabin&commit_end_point=3Dtrue&expungeDeletes=3Dfalse&soft= Commit=3Dfalse&version=3D2} {commit=3D} 0 432 [junit4:junit4] 2> 15486 T915 C76 P38196 oasu.DirectUpdateHandler2.commit= end_commit_flush [junit4:junit4] 2> 15488 T924 oasc.SolrCore.registerSearcher [collection1= ] Registered new searcher Searcher@6044798d main{StandardDirectoryReader(se= gments_3:10:nrt _0(4.0.0.2):C10 _1(4.0.0.2):C10 _2(4.0.0.2):C10 _3(4.0.0.2)= :C2)} [junit4:junit4] 2> 15488 T915 C76 P38196 /update {waitSearcher=3Dtrue&com= mit=3Dtrue&wt=3Djavabin&commit_end_point=3Dtrue&expungeDeletes=3Dfalse&soft= Commit=3Dfalse&version=3D2} {commit=3D} 0 433 [junit4:junit4] 2> 15489 T903 C79 P38185 /update {waitSearcher=3Dtrue&wt= =3Djavabin&commit=3Dtrue&softCommit=3Dfalse&version=3D2} {commit=3D} 0 822 [junit4:junit4] 2> 15493 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_ti1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15497 T865 oascsi.HttpClientUtil.createClient Creating= new http client, config: [junit4:junit4] 2> 15509 T865 oaz.ZooKeeper. Initiating client conn= ection, connectString=3D127.0.0.1:38156/solr sessionTimeout=3D10000 watcher= =3Dorg.apache.solr.common.cloud.ConnectionManager@44789a1c [junit4:junit4] 2> 15510 T934 oaz.ClientCnxn$SendThread.startConnect Open= ing socket connection to server /127.0.0.1:38156 [junit4:junit4] 2> 15510 T865 oascc.ConnectionManager.waitForConnected Wa= iting for client to connect to ZooKeeper [junit4:junit4] 2> 15511 T934 oaz.ClientCnxn$SendThread.primeConnection S= ocket connection established to localhost/127.0.0.1:38156, initiating sessi= on [junit4:junit4] 2> 15512 T867 oazs.NIOServerCnxn$Factory.run Accepted soc= ket connection from /140.211.11.196:38236 [junit4:junit4] 2> 15512 T867 oazs.NIOServerCnxn.readConnectRequest Clien= t attempting to establish new session at /140.211.11.196:38236 [junit4:junit4] 2> 15514 T869 oazs.NIOServerCnxn.finishSessionInit Establ= ished session 0x139d076c7fa0008 with negotiated timeout 10000 for client /1= 40.211.11.196:38236 [junit4:junit4] 2> 15514 T934 oaz.ClientCnxn$SendThread.readConnectResult= Session establishment complete on server localhost/127.0.0.1:38156, sessio= nid =3D 0x139d076c7fa0008, negotiated timeout =3D 10000 [junit4:junit4] 2> 15514 T935 oascc.ConnectionManager.process Watcher org= .apache.solr.common.cloud.ConnectionManager@44789a1c name:ZooKeeperConnecti= on Watcher:127.0.0.1:38156/solr got event WatchedEvent state:SyncConnected = type:None path:null path:null type:None [junit4:junit4] 2> 15515 T865 oascc.ConnectionManager.waitForConnected Cl= ient is connected to ZooKeeper [junit4:junit4] 2> 15516 T865 oascc.ZkStateReader.createClusterStateWatch= ersAndUpdate Updating cluster state from ZooKeeper...=20 [junit4:junit4] 2> 15528 T905 C79 P38185 REQ /select {sort=3Dn_ti1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= NOW=3D1347822224529&shard.url=3D127.0.0.1:38185/solr/collection1/&fl=3Did&s= tart=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 15528 T897 C77 P38175 REQ /select {sort=3Dn_ti1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= NOW=3D1347822224529&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1= :38196/solr/collection1/&fl=3Did&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtru= e} hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15559 T905 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224529&q=3D*:*&ids=3D134,3,128,120&= distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavabin&versio= n=3D2} status=3D0 QTime=3D0=20 [junit4:junit4] 2> 15559 T897 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24529&q=3D*:*&ids=3D1,132,122,148,111,124&distrib=3Dfalse&collection=3Dcoll= ection1&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15562 T916 C76 P38196 REQ /select {collection=3Dcollec= tion1&sort=3Dn_ti1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status= =3D0 QTime=3D38=20 [junit4:junit4] 2> 15572 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_ti1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15580 T906 C79 P38185 REQ /select {sort=3Dn_ti1+asc&di= strib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&N= OW=3D1347822224582&shard.url=3D127.0.0.1:38185/solr/collection1/&fl=3Did&st= art=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D0= =20 [junit4:junit4] 2> 15581 T917 C76 P38196 REQ /select {sort=3Dn_ti1+asc&di= strib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&N= OW=3D1347822224582&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:= 38196/solr/collection1/&fl=3Did&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue= } hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15586 T906 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224582&q=3D*:*&ids=3D127,137,140,13= 1,119&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavabin&= version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15586 T917 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24582&q=3D*:*&ids=3D135,114,129,102,101&distrib=3Dfalse&collection=3Dcollec= tion1&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15588 T896 C77 P38175 REQ /select {collection=3Dcollec= tion1&sort=3Dn_ti1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status= =3D0 QTime=3D11=20 [junit4:junit4] 2> 15594 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_f1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15603 T917 C76 P38196 REQ /select {sort=3Dn_f1+desc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D1347822= 224604&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QT= ime=3D1=20 [junit4:junit4] 2> 15603 T906 C79 P38185 REQ /select {sort=3Dn_f1+desc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38185/solr/collection1/&NOW=3D1347822224604&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15608 T917 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24604&q=3D*:*&ids=3D132,16&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&vers= ion=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15608 T906 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224604&q=3D*:*&ids=3D116,3,117,147,= 112,149,137,105&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} st= atus=3D0 QTime=3D1=20 [junit4:junit4] 2> 15611 T896 C77 P38175 REQ /select {sort=3Dn_f1+desc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D12=20 [junit4:junit4] 2> 15616 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_f1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D0=20 [junit4:junit4] 2> 15625 T905 C79 P38185 REQ /select {sort=3Dn_f1+asc&dis= trib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224626&start=3D0&q=3D*:*&isShard=3D= true&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15625 T897 C77 P38175 REQ /select {sort=3Dn_f1+asc&dis= trib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24626&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QTi= me=3D1=20 [junit4:junit4] 2> 15630 T897 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24626&q=3D*:*&ids=3D114,4,102,100&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15631 T905 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224626&q=3D*:*&ids=3D143,145,115,13= 9,17,142&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D= 0 QTime=3D2=20 [junit4:junit4] 2> 15633 T916 C76 P38196 REQ /select {sort=3Dn_f1+asc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D12=20 [junit4:junit4] 2> 15643 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_tf1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D5=20 [junit4:junit4] 2> 15652 T918 C76 P38196 REQ /select {sort=3Dn_tf1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= NOW=3D1347822224652&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1= :38196/solr/collection1/&fl=3Did&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtru= e} hits=3D32 status=3D0 QTime=3D3=20 [junit4:junit4] 2> 15653 T905 C79 P38185 REQ /select {sort=3Dn_tf1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= fl=3Did&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822224652&s= tart=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D3= =20 [junit4:junit4] 2> 15658 T918 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24652&q=3D*:*&ids=3D146,16,101&distrib=3Dfalse&collection=3Dcollection1&isS= hard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15659 T905 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224652&q=3D*:*&ids=3D134,121,139,13= 6,137,106,17&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Dj= avabin&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15661 T916 C76 P38196 REQ /select {collection=3Dcollec= tion1&sort=3Dn_tf1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status= =3D0 QTime=3D14=20 [junit4:junit4] 2> 15666 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_tf1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D0=20 [junit4:junit4] 2> 15674 T905 C79 P38185 REQ /select {sort=3Dn_tf1+asc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38185/solr/collection1/&NOW=3D1347822224676&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15676 T897 C77 P38175 REQ /select {sort=3Dn_tf1+asc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D1347822= 224676&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QT= ime=3D3=20 [junit4:junit4] 2> 15680 T897 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24676&q=3D*:*&ids=3D135,4,15&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&ve= rsion=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15680 T905 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224676&q=3D*:*&ids=3D2,115,7,147,5,= 9,120&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 Q= Time=3D1=20 [junit4:junit4] 2> 15683 T919 C76 P38196 REQ /select {sort=3Dn_tf1+asc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D12=20 [junit4:junit4] 2> 15691 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_d1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D3=20 [junit4:junit4] 2> 15701 T920 C76 P38196 REQ /select {sort=3Dn_d1+desc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D1347822= 224700&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QT= ime=3D3=20 [junit4:junit4] 2> 15702 T907 C79 P38185 REQ /select {sort=3Dn_d1+desc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38185/solr/collection1/&NOW=3D1347822224700&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D3=20 [junit4:junit4] 2> 15707 T920 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24700&q=3D*:*&ids=3D133,148,14,101&distrib=3Dfalse&isShard=3Dtrue&wt=3Djava= bin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15707 T907 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224700&q=3D*:*&ids=3D128,115,121,13= 9,137,119&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status= =3D0 QTime=3D2=20 [junit4:junit4] 2> 15710 T903 C79 P38185 REQ /select {sort=3Dn_d1+desc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D15=20 [junit4:junit4] 2> 15716 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_d1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15724 T905 C79 P38185 REQ /select {sort=3Dn_d1+asc&dis= trib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&fl= =3Did&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822224725&sta= rt=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15725 T897 C77 P38175 REQ /select {sort=3Dn_d1+asc&dis= trib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&fl= =3Did&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/solr/co= llection1/&NOW=3D1347822224725&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue}= hits=3D32 status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15729 T897 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24725&q=3D*:*&ids=3D135,114,113,8,16,118&distrib=3Dfalse&collection=3Dcolle= ction1&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15730 T905 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224725&q=3D*:*&ids=3D116,112,104,14= 1&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavabin&vers= ion=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15732 T916 C76 P38196 REQ /select {collection=3Dcollec= tion1&sort=3Dn_d1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D= 0 QTime=3D12=20 [junit4:junit4] 2> 15738 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_td1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15745 T892 C77 P38175 REQ /select {sort=3Dn_td1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= NOW=3D1347822224747&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1= :38196/solr/collection1/&fl=3Did&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtru= e} hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15746 T907 C79 P38185 REQ /select {sort=3Dn_td1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= NOW=3D1347822224747&shard.url=3D127.0.0.1:38185/solr/collection1/&fl=3Did&s= tart=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 15750 T892 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24747&q=3D*:*&ids=3D10,109,122,111,15,102&distrib=3Dfalse&collection=3Dcoll= ection1&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15751 T907 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224747&q=3D*:*&ids=3D116,106,105,12= 0&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavabin&vers= ion=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15754 T908 C79 P38185 REQ /select {collection=3Dcollec= tion1&sort=3Dn_td1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status= =3D0 QTime=3D12=20 [junit4:junit4] 2> 15760 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_td1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15766 T943 C77 P38175 REQ /select {sort=3Dn_td1+asc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D1347822= 224768&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QT= ime=3D1=20 [junit4:junit4] 2> 15767 T906 C79 P38185 REQ /select {sort=3Dn_td1+asc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38185/solr/collection1/&NOW=3D1347822224768&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15771 T943 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24768&q=3D*:*&ids=3D113,110,107,101&distrib=3Dfalse&isShard=3Dtrue&wt=3Djav= abin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15772 T906 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224768&q=3D*:*&ids=3D2,128,104,131,= 130,141&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0= QTime=3D1=20 [junit4:junit4] 2> 15774 T893 C77 P38175 REQ /select {sort=3Dn_td1+asc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D11=20 [junit4:junit4] 2> 15783 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_l1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D4=20 [junit4:junit4] 2> 15794 T917 C76 P38196 REQ /select {sort=3Dn_l1+desc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D1347822= 224792&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QT= ime=3D4=20 [junit4:junit4] 2> 15794 T906 C79 P38185 REQ /select {sort=3Dn_l1+desc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38185/solr/collection1/&NOW=3D1347822224792&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D4=20 [junit4:junit4] 2> 15799 T917 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24792&q=3D*:*&ids=3D135,138,16,100&distrib=3Dfalse&isShard=3Dtrue&wt=3Djava= bin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15799 T906 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224792&q=3D*:*&ids=3D134,2,115,149,= 142,141&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0= QTime=3D1=20 [junit4:junit4] 2> 15801 T896 C77 P38175 REQ /select {sort=3Dn_l1+desc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D14=20 [junit4:junit4] 2> 15807 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_l1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15815 T918 C76 P38196 REQ /select {sort=3Dn_l1+asc&dis= trib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24816&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QTi= me=3D1=20 [junit4:junit4] 2> 15815 T905 C79 P38185 REQ /select {sort=3Dn_l1+asc&dis= trib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224816&start=3D0&q=3D*:*&isShard=3D= true&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15819 T905 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224816&q=3D*:*&ids=3D5,9&distrib=3D= false&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15819 T918 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24816&q=3D*:*&ids=3D133,148,113,109,108,111,15,102&distrib=3Dfalse&isShard= =3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15822 T916 C76 P38196 REQ /select {sort=3Dn_l1+asc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D11=20 [junit4:junit4] 2> 15828 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_tl1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15837 T905 C79 P38185 REQ /select {sort=3Dn_tl1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= fl=3Did&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822224838&s= tart=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 15837 T897 C77 P38175 REQ /select {sort=3Dn_tl1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= fl=3Did&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/solr/= collection1/&NOW=3D1347822224838&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtru= e} hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15842 T897 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24838&q=3D*:*&ids=3D148,107,15,8&distrib=3Dfalse&collection=3Dcollection1&i= sShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15843 T905 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224838&q=3D*:*&ids=3D127,145,115,5,= 131,119&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavabi= n&version=3D2} status=3D0 QTime=3D2=20 [junit4:junit4] 2> 15845 T919 C76 P38196 REQ /select {collection=3Dcollec= tion1&sort=3Dn_tl1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status= =3D0 QTime=3D12=20 [junit4:junit4] 2> 15851 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_tl1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15859 T907 C79 P38185 REQ /select {sort=3Dn_tl1+asc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38185/solr/collection1/&NOW=3D1347822224860&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15859 T920 C76 P38196 REQ /select {sort=3Dn_tl1+asc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D1347822= 224860&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QT= ime=3D1=20 [junit4:junit4] 2> 15864 T920 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24860&q=3D*:*&ids=3D125,129&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&ver= sion=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15864 T907 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224860&q=3D*:*&ids=3D143,128,136,10= 6,9,103,130,142&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} st= atus=3D0 QTime=3D1=20 [junit4:junit4] 2> 15867 T903 C79 P38185 REQ /select {sort=3Dn_tl1+asc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D12=20 [junit4:junit4] 2> 15873 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_dt1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15881 T907 C79 P38185 REQ /select {sort=3Dn_dt1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= fl=3Did&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822224882&s= tart=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 15881 T920 C76 P38196 REQ /select {sort=3Dn_dt1+desc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= NOW=3D1347822224882&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1= :38196/solr/collection1/&fl=3Did&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtru= e} hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15886 T907 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224882&q=3D*:*&ids=3D121,137,17,131= ,140&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavabin&v= ersion=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15886 T920 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24882&q=3D*:*&ids=3D135,113,108,111,4&distrib=3Dfalse&collection=3Dcollecti= on1&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15889 T908 C79 P38185 REQ /select {collection=3Dcollec= tion1&sort=3Dn_dt1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status= =3D0 QTime=3D12=20 [junit4:junit4] 2> 15895 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_dt1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 15903 T907 C79 P38185 REQ /select {sort=3Dn_dt1+asc&di= strib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&f= l=3Did&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822224904&st= art=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D0= =20 [junit4:junit4] 2> 15903 T892 C77 P38175 REQ /select {sort=3Dn_dt1+asc&di= strib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&f= l=3Did&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/solr/c= ollection1/&NOW=3D1347822224904&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue= } hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15908 T907 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224904&q=3D*:*&ids=3D126,112,139,10= 6,105,141&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djava= bin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15908 T892 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24904&q=3D*:*&ids=3D146,109,107,11&distrib=3Dfalse&collection=3Dcollection1= &isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15911 T908 C79 P38185 REQ /select {collection=3Dcollec= tion1&sort=3Dn_dt1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status= =3D0 QTime=3D12=20 [junit4:junit4] 2> 15950 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_tdt1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTim= e=3D31=20 [junit4:junit4] 2> 15975 T897 C77 P38175 REQ /select {sort=3Dn_tdt1+desc&= distrib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.= 0.0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478= 22224961&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 = QTime=3D16=20 [junit4:junit4] 2> 15977 T905 C79 P38185 REQ /select {sort=3Dn_tdt1+desc&= distrib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.= 0.0.1:38185/solr/collection1/&NOW=3D1347822224961&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D18=20 [junit4:junit4] 2> 15981 T897 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 24961&q=3D*:*&ids=3D10,110,129,11&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 15981 T905 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822224961&q=3D*:*&ids=3D145,147,5,104,= 142,141&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0= QTime=3D1=20 [junit4:junit4] 2> 15984 T919 C76 P38196 REQ /select {sort=3Dn_tdt1+desc&= wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D28=20 [junit4:junit4] 2> 15994 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_tdt1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 16001 T906 C79 P38185 REQ /select {sort=3Dn_tdt1+asc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= fl=3Did&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822225002&s= tart=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 16001 T943 C77 P38175 REQ /select {sort=3Dn_tdt1+asc&d= istrib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&= NOW=3D1347822225002&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1= :38196/solr/collection1/&fl=3Did&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtru= e} hits=3D32 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 16005 T906 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822225002&q=3D*:*&ids=3D127,6,137,105,= 131&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavabin&ve= rsion=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16005 T943 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 25002&q=3D*:*&ids=3D148,113,8,102,13&distrib=3Dfalse&collection=3Dcollectio= n1&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16008 T893 C77 P38175 REQ /select {collection=3Dcollec= tion1&sort=3Dn_tdt1+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status= =3D0 QTime=3D11=20 [junit4:junit4] 2> 16018 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Da_si+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 16026 T917 C76 P38196 REQ /select {sort=3Da_si+desc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D1347822= 225027&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 QT= ime=3D1=20 [junit4:junit4] 2> 16026 T906 C79 P38185 REQ /select {sort=3Da_si+desc&di= strib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0.= 0.1:38185/solr/collection1/&NOW=3D1347822225027&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 16031 T917 C76 P38196 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 25027&q=3D*:*&ids=3D10,1,8,13,12&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabi= n&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16031 T906 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822225027&q=3D*:*&ids=3D3,2,7,5,9&dist= rib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D0= =20 [junit4:junit4] 2> 16033 T896 C77 P38175 REQ /select {sort=3Da_si+desc&wt= =3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D11=20 [junit4:junit4] 2> 16043 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Da_si+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 16050 T943 C77 P38175 REQ /select {sort=3Da_si+asc&dis= trib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&fl= =3Did&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/solr/co= llection1/&NOW=3D1347822225051&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue}= hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16050 T906 C79 P38185 REQ /select {sort=3Da_si+asc&dis= trib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&fl= =3Did&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822225051&sta= rt=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 16060 T906 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822225051&q=3D*:*&ids=3D3,2,7,6,9&dist= rib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavabin&version=3D= 2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16060 T943 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 25051&q=3D*:*&ids=3D1,4,13,11,12&distrib=3Dfalse&collection=3Dcollection1&i= sShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16061 T896 C77 P38175 REQ /select {collection=3Dcollec= tion1&sort=3Da_si+asc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D= 0 QTime=3D15=20 [junit4:junit4] 2> 16066 T877 C78 P38162 REQ /select {sort=3Da_si+desc&fl= =3D*,score&q=3D*:*&distrib=3Dfalse&wt=3Djavabin&version=3D2} hits=3D67 stat= us=3D0 QTime=3D1=20 [junit4:junit4] 2> 16073 T906 C79 P38185 REQ /select {sort=3Da_si+desc&di= strib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&f= l=3Did,score&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822225= 074&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 16073 T917 C76 P38196 REQ /select {sort=3Da_si+desc&di= strib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&f= l=3Did,score&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/= solr/collection1/&NOW=3D1347822225074&start=3D0&q=3D*:*&isShard=3Dtrue&fsv= =3Dtrue} hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16077 T917 C76 P38196 REQ /select {fl=3D*,score&shard.= url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&N= OW=3D1347822225074&q=3D*:*&ids=3D10,1,8,13,12&distrib=3Dfalse&collection=3D= collection1&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1= =20 [junit4:junit4] 2> 16077 T906 C79 P38185 REQ /select {fl=3D*,score&shard.= url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822225074&q=3D*:*&ids=3D3= ,2,7,5,9&distrib=3Dfalse&collection=3Dcollection1&isShard=3Dtrue&wt=3Djavab= in&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16078 T896 C77 P38175 REQ /select {sort=3Da_si+desc&fl= =3D*,score&q=3D*:*&collection=3Dcollection1&wt=3Djavabin&version=3D2} hits= =3D67 status=3D0 QTime=3D9=20 [junit4:junit4] 2> 16082 T877 C78 P38162 REQ /select {sort=3Dn_tl1+asc&fl= =3D*,score&q=3D*:*&distrib=3Dfalse&wt=3Djavabin&version=3D2} hits=3D67 stat= us=3D0 QTime=3D0=20 [junit4:junit4] 2> 16090 T918 C76 P38196 REQ /select {sort=3Dn_tl1+asc&di= strib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&f= l=3Did,score&shard.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/= solr/collection1/&NOW=3D1347822225091&start=3D0&q=3D*:*&isShard=3Dtrue&fsv= =3Dtrue} hits=3D32 status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16090 T905 C79 P38185 REQ /select {sort=3Dn_tl1+asc&di= strib=3Dfalse&collection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&f= l=3Did,score&shard.url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822225= 091&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 16094 T918 C76 P38196 REQ /select {fl=3D*,score&shard.= url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&N= OW=3D1347822225091&q=3D*:*&ids=3D125,129&distrib=3Dfalse&collection=3Dcolle= ction1&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16094 T905 C79 P38185 REQ /select {fl=3D*,score&shard.= url=3D127.0.0.1:38185/solr/collection1/&NOW=3D1347822225091&q=3D*:*&ids=3D1= 43,128,136,106,9,103,130,142&distrib=3Dfalse&collection=3Dcollection1&isSha= rd=3Dtrue&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16097 T916 C76 P38196 REQ /select {sort=3Dn_tl1+asc&fl= =3D*,score&q=3D*:*&collection=3Dcollection1&wt=3Djavabin&version=3D2} hits= =3D67 status=3D0 QTime=3D11=20 [junit4:junit4] 2> 16102 T877 C78 P38162 REQ /select {distrib=3Dfalse&sor= t=3Dn_tl1+desc&wt=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime= =3D1=20 [junit4:junit4] 2> 16108 T907 C79 P38185 REQ /select {sort=3Dn_tl1+desc&d= istrib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0= .0.1:38185/solr/collection1/&NOW=3D1347822225110&start=3D0&q=3D*:*&isShard= =3Dtrue&fsv=3Dtrue} hits=3D35 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 16109 T892 C77 P38175 REQ /select {sort=3Dn_tl1+desc&d= istrib=3Dfalse&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did&shard.url=3D127.0= .0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D134782= 2225110&start=3D0&q=3D*:*&isShard=3Dtrue&fsv=3Dtrue} hits=3D32 status=3D0 Q= Time=3D1=20 [junit4:junit4] 2> 16113 T892 C77 P38175 REQ /select {shard.url=3D127.0.0= .1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/&NOW=3D13478222= 25110&q=3D*:*&ids=3D148,107,15,8&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabi= n&version=3D2} status=3D0 QTime=3D1=20 [junit4:junit4] 2> 16113 T907 C79 P38185 REQ /select {shard.url=3D127.0.0= .1:38185/solr/collection1/&NOW=3D1347822225110&q=3D*:*&ids=3D127,145,115,5,= 131,119&distrib=3Dfalse&isShard=3Dtrue&wt=3Djavabin&version=3D2} status=3D0= QTime=3D1=20 [junit4:junit4] 2> 16114 T903 C79 P38185 REQ /select {sort=3Dn_tl1+desc&w= t=3Djavabin&q=3D*:*&version=3D2} hits=3D67 status=3D0 QTime=3D9=20 [junit4:junit4] 2> 16117 T877 C78 P38162 REQ /select {distrib=3Dfalse&wt= =3Djavabin&q=3D{!func}a_si&version=3D2} hits=3D67 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 16124 T897 C77 P38175 REQ /select {distrib=3Dfalse&col= lection=3Dcollection1&wt=3Djavabin&rows=3D10&version=3D2&fl=3Did,score&shar= d.url=3D127.0.0.1:38175/solr/collection1/|127.0.0.1:38196/solr/collection1/= &NOW=3D1347822225126&start=3D0&q=3D{!func}a_si&isShard=3Dtrue&fsv=3Dtrue} h= its=3D32 status=3D0 QTime=3D0=20 [junit4:junit4] 2> 16125 T905 C79 P38185 REQ /select {distrib=3Df [...truncated too long message...] t 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:1804) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:430) [junit4:junit4] 2> =09at com.sun.jmx.interceptor.DefaultMBeanServerInterc= eptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415) [junit4:junit4] 2> =09at com.sun.jmx.mbeanserver.JmxMBeanServer.unregiste= rMBean(JmxMBeanServer.java:536) [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> 309307 T2907 oasc.SolrCore.closeSearcher [collection1]= Closing main searcher on request. [junit4:junit4] 2> 309311 T2907 oasu.DirectUpdateHandler2.close closing D= irectUpdateHandler2{commits=3D5,autocommits=3D0,soft autocommits=3D0,optimi= zes=3D0,rollbacks=3D0,expungeDeletes=3D0,docsPending=3D0,adds=3D0,deletesBy= Id=3D0,deletesByQuery=3D0,errors=3D0,cumulative_adds=3D35,cumulative_delete= sById=3D0,cumulative_deletesByQuery=3D0,cumulative_errors=3D0} [junit4:junit4] 2> 309311 T2907 oasu.DefaultSolrCoreState.decref SolrCore= State ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 309313 T2907 oasu.DefaultSolrCoreState.decref Closing = SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 309314 T2907 oascc.ZkStateReader$3.process Updating li= ve nodes [junit4:junit4] 2> 309314 T2907 oascc.ZkStateReader$3.process WARNING Zoo= Keeper watch triggered, but Solr cannot talk to ZK [junit4:junit4] 2> 309314 T2907 oascc.ZkStateReader$2.process A cluster s= tate change has occurred - updating... [junit4:junit4] 2> 309314 T2907 oascc.ZkStateReader$2.process WARNING Zoo= Keeper watch triggered, but Solr cannot talk to ZK [junit4:junit4] 2> 309315 T2907 oascc.ConnectionManager.process Watcher o= rg.apache.solr.common.cloud.ConnectionManager@36d3c28d name:ZooKeeperConnec= tion Watcher:127.0.0.1:36823/solr got event WatchedEvent state:Disconnected= type:None path:null path:null type:None [junit4:junit4] 2> 309315 T2907 oascc.ConnectionManager.process Client->Z= ooKeeper status change trigger but we are already closed [junit4:junit4] 2> 309315 T2907 oaz.ClientCnxn$EventThread.run EventThrea= d shut down [junit4:junit4] 2> NOTE: test params are: codec=3DLucene40: {n_f1=3DPosti= ngsFormat(name=3DAsserting), foo_b=3DLucene40(minBlockSize=3D59 maxBlockSiz= e=3D154), foo_d=3DPostingsFormat(name=3DLucene40WithOrds), foo_f=3DLucene40= (minBlockSize=3D59 maxBlockSize=3D154), n_tl1=3DPostingsFormat(name=3DAsser= ting), n_d1=3DPostingsFormat(name=3DSimpleText), rnd_b=3DPostingsFormat(nam= e=3DLucene40WithOrds), intDefault=3DPostingsFormat(name=3DSimpleText), n_td= 1=3DPostingsFormat(name=3DAsserting), timestamp=3DPostingsFormat(name=3DSim= pleText), id=3DPostingsFormat(name=3DLucene40WithOrds), range_facet_sl=3DLu= cene40(minBlockSize=3D59 maxBlockSize=3D154), range_facet_si=3DPostingsForm= at(name=3DAsserting), oddField_s=3DLucene40(minBlockSize=3D59 maxBlockSize= =3D154), multiDefault=3DPostingsFormat(name=3DAsserting), n_tf1=3DPostingsF= ormat(name=3DSimpleText), n_dt1=3DPostingsFormat(name=3DAsserting), n_ti1= =3DPostingsFormat(name=3DLucene40WithOrds), range_facet_l=3DPostingsFormat(= name=3DSimpleText), text=3DLucene40(minBlockSize=3D59 maxBlockSize=3D154), = _version_=3DPostingsFormat(name=3DSimpleText), SubjectTerms_mfacet=3DPostin= gsFormat(name=3DSimpleText), a_t=3DPostingsFormat(name=3DSimpleText), n_tdt= 1=3DPostingsFormat(name=3DSimpleText), other_tl1=3DPostingsFormat(name=3DSi= mpleText), n_l1=3DPostingsFormat(name=3DSimpleText), a_si=3DPostingsFormat(= name=3DAsserting)}, sim=3DDefaultSimilarity, locale=3Des_CR, timezone=3DInd= ian/Mahe [junit4:junit4] 2> NOTE: FreeBSD 9.0-RELEASE amd64/Oracle Corporation 1.7= .0_06 (64-bit)/cpus=3D16,threads=3D2,free=3D225105976,total=3D475004928 [junit4:junit4] 2> NOTE: All tests run in this JVM: [PingRequestHandlerTe= st, TestPluginEnable, DisMaxRequestHandlerTest, TestSolrDeletionPolicy2, Sc= riptEngineTest, TestCSVResponseWriter, SyncSliceTest, PrimUtilsTest, TestSt= ressLucene, BadIndexSchemaTest, DebugComponentTest, TestMultiCoreConfBootst= rap, StatsComponentTest, XmlUpdateRequestHandlerTest, SignatureUpdateProces= sorFactoryTest, ZkSolrClientTest, TestUpdate, SuggesterTSTTest, TestCollati= onKeyRangeQueries, OverseerTest, TestSolrDeletionPolicy1, TestPropInject, T= estMergePolicyConfig, TestRTGBase, QueryParsingTest, TestQuerySenderListene= r, TestPropInjectDefaults, HighlighterTest, DirectSolrSpellCheckerTest, Tes= tTrie, TestSolrCoreProperties, TestSort, BasicZkTest, SpellingQueryConverte= rTest, SolrCoreTest, UUIDFieldTest, TestSurroundQueryParser, ClusterStateUp= dateTest, TestFastWriter, TestCSVLoader, TestDistributedGrouping, UpdatePar= amsTest, DocumentBuilderTest, PolyFieldTest, PrimitiveFieldTypeTest, TestUt= ils, TestJmxIntegration, LukeRequestHandlerTest, RAMDirectoryFactoryTest, T= estStressRecovery, LeaderElectionTest, TestDFRSimilarityFactory, SolrIndexC= onfigTest, XsltUpdateRequestHandlerTest, BasicFunctionalityTest, RecoveryZk= Test, FullSolrCloudDistribCmdsTest, TestReplicationHandler, LeaderElectionI= ntegrationTest, DistributedSpellCheckComponentTest, TestRealTimeGet, TestRa= ndomFaceting, TestDistributedSearch, SpellCheckCollatorTest, TestExtendedDi= smaxParser, SoftAutoCommitTest, AutoCommitTest, WordBreakSolrSpellCheckerTe= st, TestHashPartitioner, TestRecovery, TestJoin, DirectUpdateHandlerTest, S= impleFacetsTest, TestCoreContainer, FileBasedSpellCheckerTest, ConvertedLeg= acyTest, PeerSyncTest, QueryElevationComponentTest, SortByFunctionTest, Tes= tBinaryResponseWriter, SampleTest, TestIndexSearcher, CoreAdminHandlerTest,= TestFunctionQuery, TestRemoteStreaming, QueryEqualityTest, MBeansHandlerTe= st, DistributedQueryElevationComponentTest, IndexSchemaTest, TermsComponent= Test, DistanceFunctionTest, SolrInfoMBeanTest, MinimalSchemaTest, StandardR= equestHandlerTest, TestQueryTypes, TestPHPSerializedResponseWriter, TermVec= torComponentTest, SuggesterWFSTTest, JsonLoaderTest, DocumentAnalysisReques= tHandlerTest, DirectUpdateHandlerOptimizeTest, IndexSchemaRuntimeFieldTest,= TestSolrQueryParser, TestValueSourceCache, TestReversedWildcardFilterFacto= ry, JSONWriterTest, ReturnFieldsTest, RequestHandlersTest, RequiredFieldsTe= st, TestOmitPositions, SuggesterFSTTest, CopyFieldTest, TestArbitraryIndexD= ir, TestQueryUtils, LoggingHandlerTest, UniqFieldsUpdateProcessorFactoryTes= t, SuggesterTest, ShowFileRequestHandlerTest, TestFoldingMultitermQuery, Te= stLuceneMatchVersion, UpdateRequestProcessorFactoryTest, TestWriterPerf, No= CacheHeaderTest, FieldMutatingUpdateProcessorTest, BadComponentTest, TestBi= naryField, SOLR749Test, DefaultValueUpdateProcessorTest, TestDocSet, TestCo= llationField, TestQuerySenderNoQuery, IndexReaderFactoryTest, OutputWriterT= est, MultiTermTest, EchoParamsTest, TestBM25SimilarityFactory, TestPhraseSu= ggestions, TestPerFieldSimilarity, LegacyHTMLStripCharFilterTest, TestCodec= Support, TimeZoneUtilsTest, TestFastLRUCache, URLClassifyProcessorTest, Ope= nExchangeRatesOrgProviderTest, ResourceLoaderTest, FileUtilsTest, TestSyste= mIdResolver, TestSolrXMLSerializer, TestSuggestSpellingConverter, TestBadCo= nfig, DOMUtilTest, TestLRUCache, SystemInfoHandlerTest, ZkNodePropsTest, Ci= rcularListTest, TestDocumentBuilder, PathHierarchyTokenizerFactoryTest, Tes= tCharFilters, BasicDistributedZk2Test] [junit4:junit4] Completed on J1 in 309.89s, 1 test, 1 failure <<< FAILURES! [...truncated 5 lines...] BUILD FAILED /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/build.x= ml:32: The following error occurred while executing this line: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/bu= ild.xml:146: The following error occurred while executing this line: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/lucene/= module-build.xml:63: The following error occurred while executing this line= : /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/lucene/= common-build.xml:1133: The following error occurred while executing this li= ne: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/lucene/= common-build.xml:810: There were test failures: 229 suites, 927 tests, 1 er= ror, 1 failure, 6 ignored (1 assumption) Total time: 66 minutes 21 seconds Build step 'Invoke Ant' marked build as failure Recording test results Email was triggered for: Failure Sending email for trigger: Failure ------=_Part_564_376041460.1347823249615 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_564_376041460.1347823249615--