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 EB01810EDF for ; Wed, 24 Jul 2013 18:12:47 +0000 (UTC) Received: (qmail 27373 invoked by uid 500); 24 Jul 2013 18:12:46 -0000 Delivered-To: apmail-lucene-dev-archive@lucene.apache.org Received: (qmail 26707 invoked by uid 500); 24 Jul 2013 18:12:44 -0000 Mailing-List: contact dev-help@lucene.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@lucene.apache.org Delivered-To: mailing list dev@lucene.apache.org Received: (qmail 26699 invoked by uid 99); 24 Jul 2013 18:12:42 -0000 Received: from nike.apache.org (HELO nike.apache.org) (192.87.106.230) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 24 Jul 2013 18:12:42 +0000 X-ASF-Spam-Status: No, hits=0.0 required=5.0 tests=NORMAL_HTTP_TO_IP,SPF_PASS,WEIRD_PORT X-Spam-Check-By: apache.org Received-SPF: pass (nike.apache.org: domain of jenkins@thetaphi.de designates 188.138.97.18 as permitted sender) Received: from [188.138.97.18] (HELO mail.sd-datasolutions.de) (188.138.97.18) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 24 Jul 2013 18:12:30 +0000 Received: from serv1 (localhost.localdomain [127.0.0.1]) by mail.sd-datasolutions.de (Postfix) with ESMTP id 8354214AA025 for ; Wed, 24 Jul 2013 18:12:09 +0000 (UTC) Date: Wed, 24 Jul 2013 18:12:00 +0000 (UTC) From: Policeman Jenkins Server To: dev@lucene.apache.org Message-ID: <468183307.53.1374689529514.JavaMail.jenkins@serv1.sd-datasolutions.de> Subject: [JENKINS] Lucene-Solr-4.x-Linux (32bit/ibm-j9-jdk6) - Build # 6636 - Failure! MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_52_228046635.1374689520320" X-Jenkins-Job: Lucene-Solr-4.x-Linux X-Jenkins-Result: FAILURE X-Virus-Checked: Checked by ClamAV on apache.org ------=_Part_52_228046635.1374689520320 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/6636/ Java: 32bit/ibm-j9-jdk6 -Xjit:exclude=3D{org/apache/lucene/util/fst/FST.pac= k(IIF)Lorg/apache/lucene/util/fst/FST;} 2 tests failed. REGRESSION: org.apache.solr.core.TestJmxIntegration.testJmxRegistration Error Message: No SolrDynamicMBeans found Stack Trace: java.lang.AssertionError: No SolrDynamicMBeans found =09at __randomizedtesting.SeedInfo.seed([EAD7FFEA55D6F80E:64069BD03897A06B]= :0) =09at org.junit.Assert.fail(Assert.java:93) =09at org.junit.Assert.assertTrue(Assert.java:43) =09at org.apache.solr.core.TestJmxIntegration.testJmxRegistration(TestJmxIn= tegration.java:94) =09at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) =09at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.= java:60) =09at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces= sorImpl.java:37) =09at java.lang.reflect.Method.invoke(Method.java:611) =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:46) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRul= e$1.evaluate(SystemPropertiesInvariantRule.java:55) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:49) =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:46) =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:738) FAILED: org.apache.solr.cloud.BasicDistributedZk2Test.testDistribSearch Error Message: Server at http://127.0.0.1:58849/onenodecollectioncore returned non ok stat= us:404, message:Can not find: /onenodecollectioncore/update Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Serve= r at http://127.0.0.1:58849/onenodecollectioncore returned non ok status:40= 4, message:Can not find: /onenodecollectioncore/update =09at __randomizedtesting.SeedInfo.seed([EAD7FFEA55D6F80E:6B3171F222899832]= :0) =09at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServ= er.java:385) =09at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServ= er.java:180) =09at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(Ab= stractUpdateRequest.java:117) =09at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:116) =09at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:102) =09at org.apache.solr.cloud.BasicDistributedZk2Test.testNodeWithoutCollecti= onForwarding(BasicDistributedZk2Test.java:196) =09at org.apache.solr.cloud.BasicDistributedZk2Test.doTest(BasicDistributed= Zk2Test.java:88) =09at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseD= istributedSearchTestCase.java:835) =09at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) =09at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.= java:60) =09at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces= sorImpl.java:37) =09at java.lang.reflect.Method.invoke(Method.java:611) =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:46) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRul= e$1.evaluate(SystemPropertiesInvariantRule.java:55) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:49) =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:46) =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:738) Build Log: [...truncated 8874 lines...] [junit4] Suite: org.apache.solr.core.TestJmxIntegration [junit4] 2> 114483 T363 oas.SolrTestCaseJ4.initCore ####initCore [junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4= .x-Linux/solr/build/solr-core/test/J1/./solrtest-TestJmxIntegration-1374687= 844713 [junit4] 2> 114485 T363 oasc.SolrResourceLoader. new SolrResourc= eLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/so= lr/build/solr-core/test-files/solr/collection1/' [junit4] 2> 114487 T363 oasc.SolrResourceLoader.replaceClassLoader Add= ing 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-= core/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 114487 T363 oasc.SolrResourceLoader.replaceClassLoader Add= ing 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-= core/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 114590 T363 oasc.SolrConfig. Using Lucene MatchVersi= on: LUCENE_45 [junit4] 2> 114651 T363 oasc.SolrConfig. Loaded SolrConfig: solr= config.xml [junit4] 2> 114652 T363 oass.IndexSchema.readSchema Reading Solr Schem= a from schema.xml [junit4] 2> 114664 T363 oass.IndexSchema.readSchema [null] Schema name= =3Dtest [junit4] 2> 115264 T363 oass.ByteField.init WARN ByteField is deprecat= ed and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 115265 T363 oass.ShortField.init WARN ShortField is deprec= ated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 115266 T363 oass.OpenExchangeRatesOrgProvider.init Initial= ized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4] 2> 115273 T363 oass.IndexSchema.readSchema default search fie= ld in schema is text [junit4] 2> 115276 T363 oass.IndexSchema.readSchema unique key field: = id [junit4] 2> 115284 T363 oass.FileExchangeRateProvider.reload Reloading= exchange rates from file currency.xml [junit4] 2> 115289 T363 oass.FileExchangeRateProvider.reload Reloading= exchange rates from file currency.xml [junit4] 2> 115293 T363 oass.OpenExchangeRatesOrgProvider.reload Reloa= ding exchange rates from open-exchange-rates.json [junit4] 2> 115294 T363 oass.OpenExchangeRatesOrgProvider$OpenExchange= Rates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 115294 T363 oass.OpenExchangeRatesOrgProvider$OpenExchange= Rates. WARN Expected key, got STRING [junit4] 2> 115295 T363 oass.OpenExchangeRatesOrgProvider.reload Reloa= ding exchange rates from open-exchange-rates.json [junit4] 2> 115296 T363 oass.OpenExchangeRatesOrgProvider$OpenExchange= Rates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 115296 T363 oass.OpenExchangeRatesOrgProvider$OpenExchange= Rates. WARN Expected key, got STRING [junit4] 2> 115297 T363 oasc.SolrResourceLoader.locateSolrHome JNDI no= t configured for solr (NoInitialContextEx) [junit4] 2> 115298 T363 oasc.SolrResourceLoader.locateSolrHome using s= ystem property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-L= inux/solr/build/solr-core/test-files/solr [junit4] 2> 115298 T363 oasc.SolrResourceLoader. new SolrResourc= eLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/so= lr/build/solr-core/test-files/solr/' [junit4] 2> 115309 T363 oasc.SolrResourceLoader.locateSolrHome JNDI no= t configured for solr (NoInitialContextEx) [junit4] 2> 115309 T363 oasc.SolrResourceLoader.locateSolrHome using s= ystem property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-L= inux/solr/build/solr-core/test-files/solr [junit4] 2> 115310 T363 oasc.SolrResourceLoader. new SolrResourc= eLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-= Linux/solr/build/solr-core/test-files/solr/' [junit4] 2> 115366 T363 oasc.CoreContainer. New CoreContainer 17= 01078372 [junit4] 2> 115366 T363 oasc.CoreContainer.load Loading cores into Cor= eContainer [instanceDir=3D/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/= solr/build/solr-core/test-files/solr/] [junit4] 2> 115368 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting socketTimeout to: 0 [junit4] 2> 115368 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting urlScheme to: http:// [junit4] 2> 115369 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting connTimeout to: 0 [junit4] 2> 115369 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting maxConnectionsPerHost to: 20 [junit4] 2> 115370 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting corePoolSize to: 0 [junit4] 2> 115371 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting maximumPoolSize to: 2147483647 [junit4] 2> 115371 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting maxThreadIdleTime to: 5 [junit4] 2> 115372 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting sizeOfQueue to: -1 [junit4] 2> 115372 T363 oashc.HttpShardHandlerFactory.getParameter Set= ting fairnessPolicy to: false [junit4] 2> 115373 T363 oascsi.HttpClientUtil.createClient Creating ne= w http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&soc= ketTimeout=3D0&connTimeout=3D0&retry=3Dfalse [junit4] 2> 115380 T363 oasl.LogWatcher.newRegisteredLogWatcher Regist= ering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 115393 T364 oasc.CoreContainer.create Creating SolrCore 'c= ollection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-L= inux/solr/build/solr-core/test-files/solr/collection1 [junit4] 2> 115393 T364 oasc.SolrResourceLoader. new SolrResourc= eLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/so= lr/build/solr-core/test-files/solr/collection1/' [junit4] 2> 115395 T364 oasc.SolrResourceLoader.replaceClassLoader Add= ing 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-= core/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 115395 T364 oasc.SolrResourceLoader.replaceClassLoader Add= ing 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-= core/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 115482 T364 oasc.SolrConfig. Using Lucene MatchVersi= on: LUCENE_45 [junit4] 2> 115533 T364 oasc.SolrConfig. Loaded SolrConfig: solr= config.xml [junit4] 2> 115534 T364 oass.IndexSchema.readSchema Reading Solr Schem= a from schema.xml [junit4] 2> 115542 T364 oass.IndexSchema.readSchema [collection1] Sche= ma name=3Dtest [junit4] 2> 115999 T364 oass.ByteField.init WARN ByteField is deprecat= ed and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 116000 T364 oass.ShortField.init WARN ShortField is deprec= ated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 116001 T364 oass.OpenExchangeRatesOrgProvider.init Initial= ized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4] 2> 116007 T364 oass.IndexSchema.readSchema default search fie= ld in schema is text [junit4] 2> 116012 T364 oass.IndexSchema.readSchema unique key field: = id [junit4] 2> 116021 T364 oass.FileExchangeRateProvider.reload Reloading= exchange rates from file currency.xml [junit4] 2> 116025 T364 oass.FileExchangeRateProvider.reload Reloading= exchange rates from file currency.xml [junit4] 2> 116029 T364 oass.OpenExchangeRatesOrgProvider.reload Reloa= ding exchange rates from open-exchange-rates.json [junit4] 2> 116030 T364 oass.OpenExchangeRatesOrgProvider$OpenExchange= Rates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 116030 T364 oass.OpenExchangeRatesOrgProvider$OpenExchange= Rates. WARN Expected key, got STRING [junit4] 2> 116031 T364 oass.OpenExchangeRatesOrgProvider.reload Reloa= ding exchange rates from open-exchange-rates.json [junit4] 2> 116032 T364 oass.OpenExchangeRatesOrgProvider$OpenExchange= Rates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 116032 T364 oass.OpenExchangeRatesOrgProvider$OpenExchange= Rates. WARN Expected key, got STRING [junit4] 2> 116033 T364 oasc.SolrCore.initDirectoryFactory org.apache.= solr.core.MockDirectoryFactory [junit4] 2> 116033 T364 oasc.SolrCore. [collection1] Opening new= SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/so= lr-core/test-files/solr/collection1/, dataDir=3D/mnt/ssd/jenkins/workspace/= Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestJmxIntegr= ation-1374687844713/ [junit4] 2> 116034 T364 oasc.JmxMonitoredMap. No JMX servers fou= nd, not exposing Solr information with JMX. [junit4] 2> 116035 T364 oasc.CachingDirectoryFactory.get return new di= rectory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/sol= r-core/test/J1/./solrtest-TestJmxIntegration-1374687844713 [junit4] 2> 116035 T364 oasc.SolrCore.getNewIndexDir New index directo= ry detected: old=3Dnull new=3D/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Li= nux/solr/build/solr-core/test/J1/./solrtest-TestJmxIntegration-137468784471= 3/index/ [junit4] 2> 116036 T364 oasc.SolrCore.initIndex WARN [collection1] Sol= r index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/bu= ild/solr-core/test/J1/./solrtest-TestJmxIntegration-1374687844713/index' do= esn't exist. Creating new index... [junit4] 2> 116037 T364 oasc.CachingDirectoryFactory.get return new di= rectory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/sol= r-core/test/J1/./solrtest-TestJmxIntegration-1374687844713/index [junit4] 2> 116039 T364 oasc.SolrDeletionPolicy.onCommit SolrDeletionP= olicy.onCommit: commits: num=3D1 [junit4] 2> =09=09commit{dir=3DRateLimitedDirectoryWrapper(MockDirWrap= per(org.apache.lucene.store.RAMDirectory@6d186d18 lockFactory=3Dorg.apache.= lucene.store.NativeFSLockFactory@7d867d86)),segFN=3Dsegments_1,generation= =3D1} [junit4] 2> 116039 T364 oasc.SolrDeletionPolicy.updateCommits newest c= ommit generation =3D 1 [junit4] 2> 116040 T364 oasc.SolrCore.initWriters created xml: solr.XM= LResponseWriter [junit4] 2> 116041 T364 oasup.UpdateRequestProcessorChain.init inserti= ng DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedu= pe" [junit4] 2> 116042 T364 oasup.UpdateRequestProcessorChain.init inserti= ng DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedu= pe-allfields" [junit4] 2> 116042 T364 oasup.UpdateRequestProcessorChain.init inserti= ng DistributedUpdateProcessorFactory into updateRequestProcessorChain "stor= ed_sig" [junit4] 2> 116043 T364 oasup.UpdateRequestProcessorChain.init inserti= ng DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq= -fields" [junit4] 2> 116044 T364 oasup.UpdateRequestProcessorChain.init inserti= ng DistributedUpdateProcessorFactory into updateRequestProcessorChain "dist= rib-dup-test-chain-implicit" [junit4] 2> 116044 T364 oasc.RequestHandlers.initHandlersFromConfig ad= ding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 116045 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated /replication: solr.ReplicationHandler [junit4] 2> 116045 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated standard: solr.StandardRequestHandler [junit4] 2> 116046 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated /get: solr.RealTimeGetHandler [junit4] 2> 116046 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated dismax: solr.SearchHandler [junit4] 2> 116047 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4] 2> 116047 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 116048 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated defaults: solr.StandardRequestHandler [junit4] 2> 116048 T364 oasc.RequestHandlers.initHandlersFromConfig ad= ding lazy requestHandler: solr.StandardRequestHandler [junit4] 2> 116049 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated lazy: solr.StandardRequestHandler [junit4] 2> 116049 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated /update: solr.UpdateRequestHandler [junit4] 2> 116050 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated /terms: org.apache.solr.handler.component.SearchHandler [junit4] 2> 116050 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4] 2> 116051 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHand= ler [junit4] 2> 116051 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHand= ler [junit4] 2> 116052 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.Sea= rchHandler [junit4] 2> 116052 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4] 2> 116053 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated mltrh: org.apache.solr.handler.component.SearchHandler [junit4] 2> 116053 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated tvrh: org.apache.solr.handler.component.SearchHandler [junit4] 2> 116054 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated /mlt: solr.MoreLikeThisHandler [junit4] 2> 116054 T364 oasc.RequestHandlers.initHandlersFromConfig cr= eated /debug/dump: solr.DumpRequestHandler [junit4] 2> 116056 T364 oashl.XMLLoader.init xsltCacheLifetimeSeconds= =3D60 [junit4] 2> 116057 T364 oasc.SolrCore.initDeprecatedSupport WARN solrc= onfig.xml uses deprecated , Please update your config = to use the ShowFileRequestHandler. [junit4] 2> 116059 T364 oasc.SolrCore.initDeprecatedSupport WARN addin= g ShowFileRequestHandler with hidden files: [SCHEMA-REQUIRED-FIELDS.XML, SO= LRCONFIG-PROPINJECT.XML, SCHEMA11.XML, SCHEMA15.XML, SCHEMA-SIM.XML, SOLRCO= NFIG-NATIVELOCK.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, CONDIT= IONAL.UPDATEPROCESSOR.JS, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, BAD-SCHEMA= -DOCVALUES-NOT-REQUIRED-NO-DEFAULT.XML, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA= -CHARFILTERS.XML, SCHEMA-EFF.XML, SOLRCONFIG_CODEC.XML, SOLRCONFIG-MUTABLE-= MANAGED-SCHEMA.XML, HYPHENATION.DTD, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, SOL= RCONFIG-MERGEPOLICY.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-SLAVE1.XML= , SCHEMA-LMJELINEKMERCER.XML, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-DUP-FIELD.XM= L, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, SOLRCONFIG-PARSING-UPD= ATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-TFIDF.XML, SOLRC= ONFIG-ELEVATE.XML, STOPWITHBOM.TXT, SOLRCONFIG-QUERYSENDER.XML, WDFTYPES.TX= T, SOLRCONFIG-COMPONENTS-NAME.XML, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, = SOLRCONFIG-DELPOLICY1.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, KEEP-2.TXT= , SCHEMA-STOP-KEEP.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, STOP-SNOWBAL= L.TXT, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SO= LRCONFIG-INDEXCONFIG.XML, SCHEMA-DOCVALUESMULTI.XML, SCHEMA-CLASS-NAME-SHOR= TENING-ON-SERIALIZATION.XML, STOPWORDSWRONGENCODING.TXT, SOLRCONFIG-SPELLCH= ECKCOMPONENT.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, SOLRCONFIG-MINI= MAL.XML, SOLRCONFIG-TLOG.XML, SCHEMA-DOCVALUESFACETING.XML, SOLRCONFIG-TERM= INDEX.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, OPEN-EXCHANGE-RATES.JSON,= BAD-SCHEMA-DUP-FIELDTYPE.XML, PHRASESUGGEST.TXT, SOLRCONFIG-INFOSTREAM-LOG= GING.XML, OLD_SYNONYMS.TXT, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SCHEMA-REVE= RSED.XML, SCHEMA-FOLDING.XML, SCHEMA-BM25.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF= .XML, SOLRCONFIG-ENABLEPLUGIN.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SO= LRCONFIG-TRANSFORMERS.XML, SCHEMA-COPYFIELD-TEST.XML, BAD-SCHEMA-DUP-DYNAMI= CFIELD.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, CURRENCY.XML, FUZZYS= UGGEST.TXT, SCHEMA-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONF= IG_PERF.XML, SCHEMA-SWEETSPOT.XML, SOLRCONFIG-SIMPLELOCK.XML, SCHEMA-TINY.X= ML, SOLRCONFIG-LAZYWRITER.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEM= A-REPLICATION2.XML, SCHEMA-SNIPPET-TYPE.XML, SOLRCONFIG-XINCLUDE.XML, SCHEM= A-SPELLCHECKER.XML, SOLRCONFIG-WARMER.XML, KEEP-1.TXT, SCHEMA-TRIE.XML, BAD= -SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.X= ML, STOPTYPES-2.TXT, SCHEMA_CODEC.XML, SCHEMA-SYNONYM-TOKENIZER.XML, SOLRCO= NFIG-DEFAULTS.XML, SCHEMA-XINCLUDE.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMA-= SNIPPET-FIELD.XML, SCHEMA-PHRASESUGGEST.XML, SCHEMA-DFR.XML, SOLRCONFIG-UPD= ATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-MASTER3.XML, BAD-SCHEMA-MULTIPLE-ASTER= ISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEF= AULT-CODE.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-MANAGED-SCHEMA= .XML, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, SOLRCONFIG-MASTER= 1-KEEPONEBACKUP.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-MERGEPOLIC= Y-DEFAULTS.XML, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML= , STOP-2.TXT, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA-DOCVALUES.XML, = BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XM= L, SOLRCONFIG-REPEATER.XML, SOLRCONFIG-NOCACHE.XML, SOLRCONFIG-SOLCOREPROPE= RTIES.XML, SOLRCONFIG-PHRASESUGGEST.XML, JASUGGEST.TXT, BAD-MP-SOLRCONFIG.X= ML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SOLRCONFIG-MASTER.XML, SYNONYMS.T= XT, SCHEMA-REPLICATION1.XML, SCHEMA-SNIPPET-TYPES.INCL, SOLRCONFIG-SNIPPET-= PROCESSOR.XML, BAD_SOLRCONFIG.XML, HUNSPELL-TEST.DIC, SCHEMA-LUCENEMATCHVER= SION.XML, SCHEMA-NUMERIC.XML, SCHEMA-IB.XML, SOLRCONFIG-SLAVE.XML, SCHEMA-A= DD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML= , THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, BAD-SCHEMA-MISPLACED-ASTERISK-COPY= FIELD-SOURCE-SHOULD-FAIL-TEST.XML, STOPTYPES-1.TXT, REGEX-BOOST-PROCESSOR-T= EST.TXT, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, COMPOUNDDICTIONARY.TXT, DA_COMPO= UNDDICTIONARY.TXT, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SH= OULD-FAIL-TEST.XML, SCHEMASURROUND.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.= XML, SOLRCONFIG-MASTER2.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, BA= D-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SCHEMA-LMDIRICHLET.XML, BAD-SCHEM= A-NOT-INDEXED-BUT-POS.XML, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CH= AINS.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, MAPPING-ISOLATIN1ACCENT.TXT,= SOLRCONFIG-CACHING.XML, ADDFIELDS.UPDATEPROCESSOR.JS, BAD-CURRENCY.XML, ST= OP-1.TXT, SCHEMA-REST.XML, SCHEMA12.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.X= ML, DA_UTF8.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, STOPWORDS.TX= T, HUNSPELL-TEST.AFF, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, SOLRCONFIG-= TLOG-MANAGED-SCHEMA.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, BAD-SCHEMA= -MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, FRENCHARTICLES.TXT= , BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC.XML, SCHEMA-SPATIAL.XML, XSLT, SO= LRCONFIG-DELPOLICY2.XML, TRIVIAL.UPDATEPROCESSOR0.JS, BAD-SCHEMA-CURRENCY-D= YNAMIC-MULTIVALUED.XML, SOLRCONFIG-TLOG-MUTABLE-MANAGED-SCHEMA.XML, SCHEMA-= BINARYFIELD.XML, SCHEMA-COLLATEFILTER.XML, SCHEMA-REST-LUCENE-MATCH-VERSION= .XML, SCHEMA-MINIMAL.XML, STEMDICT.TXT, SCHEMA-COLLATE.XML, ELEVATE.XML, PR= OTWORDS.TXT, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SOLRCONFIG-MASTER1.X= ML, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, SOLRCONFIG-FUNCTIONQ= UERY.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-ALTDIRECTORY= .XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML= , BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, BAD-SCHEMA-BOGUS-FIELD-PARAME= TERS.XML] [junit4] 2> 116061 T364 oass.SolrIndexSearcher. Opening Searcher= @266f266f main [junit4] 2> 116063 T364 oasu.CommitTracker. Hard AutoCommit: dis= abled [junit4] 2> 116063 T364 oasu.CommitTracker. Soft AutoCommit: dis= abled [junit4] 2> 116064 T364 oashc.SpellCheckComponent.inform Initializing = spell checkers [junit4] 2> 116147 T364 oass.DirectSolrSpellChecker.init init: {name= =3Ddirect,classname=3DDirectSolrSpellChecker,field=3Dlowerfilt,minQueryLeng= th=3D3} [junit4] 2> 116203 T365 oasc.SolrCore.registerSearcher [collection1] R= egistered new searcher Searcher@266f266f main{StandardDirectoryReader(segme= nts_1:1)} [junit4] 2> 116203 T364 oasc.CoreContainer.registerCore registering co= re: collection1 [junit4] 2> 116205 T363 oas.SolrTestCaseJ4.initCore ####initCore end [junit4] 2> 116289 T363 oas.SolrTestCaseJ4.setUp ###Starting testJmxUp= date [junit4] 2> 116293 T363 oas.SolrTestCaseJ4.tearDown ###Ending testJmxU= pdate [junit4] IGNOR/A 0.13s J1 | TestJmxIntegration.testJmxUpdate [junit4] > Assumption #1: got: , expected: is [junit4] 2> 116339 T363 oas.SolrTestCaseJ4.setUp ###Starting testJmxRe= gistration [junit4] 2> 116340 T363 oasc.TestJmxIntegration.testJmxRegistration Se= rvers in testJmxRegistration: [com.sun.jmx.mbeanserver.JmxMBeanServer@53665= 366] [junit4] 2> 116347 T363 oas.SolrTestCaseJ4.tearDown ###Ending testJmxR= egistration [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=3DTestJmxIntegr= ation -Dtests.method=3DtestJmxRegistration -Dtests.seed=3DEAD7FFEA55D6F80E = -Dtests.multiplier=3D3 -Dtests.slow=3Dtrue -Dtests.locale=3Den_GB_EURO -Dte= sts.timezone=3DUS/Mountain -Dtests.file.encoding=3DUTF-8 [junit4] FAILURE 0.02s J1 | TestJmxIntegration.testJmxRegistration <<< [junit4] > Throwable #1: java.lang.AssertionError: No SolrDynamicMBea= ns found [junit4] > =09at __randomizedtesting.SeedInfo.seed([EAD7FFEA55D6F80E:= 64069BD03897A06B]:0) [junit4] > =09at org.apache.solr.core.TestJmxIntegration.testJmxRegis= tration(TestJmxIntegration.java:94) [junit4] > =09at java.lang.Thread.run(Thread.java:738) [junit4] 2> 116361 T363 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> 116361 T363 oasc.CoreContainer.shutdown Shutting down Core= Container instance=3D1701078372 [junit4] 2> 116362 T363 oasc.SolrCore.close [collection1] CLOSING Sol= rCore org.apache.solr.core.SolrCore@52645264 [junit4] 2> 116362 T363 oasu.DirectUpdateHandler2.close closing Direct= UpdateHandler2{commits=3D0,autocommits=3D0,soft autocommits=3D0,optimizes= =3D0,rollbacks=3D0,expungeDeletes=3D0,docsPending=3D0,adds=3D0,deletesById= =3D0,deletesByQuery=3D0,errors=3D0,cumulative_adds=3D0,cumulative_deletesBy= Id=3D0,cumulative_deletesByQuery=3D0,cumulative_errors=3D0} [junit4] 2> 116363 T363 oasu.SolrCoreState.decrefSolrCoreState Closing= SolrCoreState [junit4] 2> 116364 T363 oasu.DefaultSolrCoreState.closeIndexWriter Sol= rCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 116364 T363 oasu.DefaultSolrCoreState.closeIndexWriter clo= sing IndexWriter with IndexWriterCloser [junit4] 2> 116365 T363 oasc.SolrCore.closeSearcher [collection1] Clos= ing main searcher on request. [junit4] 2> 116365 T363 oasc.CachingDirectoryFactory.close Closing Moc= kDirectoryFactory - 2 directories currently being tracked [junit4] 2> 116366 T363 oasc.CachingDirectoryFactory.closeCacheValue l= ooking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build= /solr-core/test/J1/./solrtest-TestJmxIntegration-1374687844713 [CachedDir<<= refCount=3D0;path=3D/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/b= uild/solr-core/test/J1/./solrtest-TestJmxIntegration-1374687844713;done=3Df= alse>>] [junit4] 2> 116366 T363 oasc.CachingDirectoryFactory.close Closing dir= ectory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-co= re/test/J1/./solrtest-TestJmxIntegration-1374687844713 [junit4] 2> 116367 T363 oasc.CachingDirectoryFactory.closeCacheValue l= ooking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build= /solr-core/test/J1/./solrtest-TestJmxIntegration-1374687844713/index [Cache= dDir<>] [junit4] 2> 116367 T363 oasc.CachingDirectoryFactory.close Closing dir= ectory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-co= re/test/J1/./solrtest-TestJmxIntegration-1374687844713/index [junit4] 2> NOTE: test params are: codec=3DLucene42: {}, docValues:{},= sim=3DRandomSimilarityProvider(queryNorm=3Dtrue,coord=3Dcrazy): {}, locale= =3Den_GB_EURO, timezone=3DUS/Mountain [junit4] 2> NOTE: Linux 3.2.0-49-generic x86/IBM Corporation 1.6.0 (32= -bit)/cpus=3D8,threads=3D2,free=3D20636336,total=3D35773952 [junit4] 2> NOTE: All tests run in this JVM: [TestFieldTypeResource, S= olrCmdDistributorTest, TestPartialUpdateDeduplication, URLClassifyProcessor= Test, TestLuceneMatchVersion, DocValuesMultiTest, TestDynamicFieldCollectio= nResource, TestBinaryResponseWriter, FileUtilsTest, TestPropInject, BlockCa= cheTest, JSONWriterTest, TestAddFieldRealTimeGet, TestFastOutputStream, Out= putWriterTest, HighlighterTest, SpellCheckCollatorTest, TestMergePolicyConf= ig, TestSolrJ, TestLazyCores, TestFiltering, TestJmxIntegration] [junit4] Completed on J1 in 1.94s, 3 tests, 1 failure, 2 skipped <<< FAI= LURES! [...truncated 256 lines...] [junit4] Suite: org.apache.solr.cloud.BasicDistributedZk2Test [junit4] 2> 582056 T1831 oas.BaseDistributedSearchTestCase.initHostCon= text Setting hostContext system property: / [junit4] 2> 582061 T1831 oas.SolrTestCaseJ4.setUp ###Starting testDist= ribSearch [junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4= .x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicDistributedZk2Test-13= 74688312292 [junit4] 2> 582063 T1831 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 2> 582064 T1832 oasc.ZkTestServer$ZKServerMain.runFromConfig = Starting server [junit4] 2> 582164 T1831 oasc.ZkTestServer.run start zk server on port= :48730 [junit4] 2> 582166 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 582231 T1838 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@1d8e1d8e name:ZooKeeperConnection= Watcher:127.0.0.1:48730 got event WatchedEvent state:SyncConnected type:No= ne path:null path:null type:None [junit4] 2> 582231 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 582232 T1831 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 582240 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 582242 T1840 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@1a941a94 name:ZooKeeperConnection= Watcher:127.0.0.1:48730/solr got event WatchedEvent state:SyncConnected ty= pe:None path:null path:null type:None [junit4] 2> 582243 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 582243 T1831 oascc.SolrZkClient.makePath makePath: /collec= tions/collection1 [junit4] 2> 582251 T1831 oascc.SolrZkClient.makePath makePath: /collec= tions/collection1/shards [junit4] 2> 582259 T1831 oascc.SolrZkClient.makePath makePath: /collec= tions/control_collection [junit4] 2> 582274 T1831 oascc.SolrZkClient.makePath makePath: /collec= tions/control_collection/shards [junit4] 2> 582282 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 582283 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/solrconfig.xml [junit4] 2> 582294 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 582295 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/schema.xml [junit4] 2> 582305 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 582306 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/stopwords.txt [junit4] 2> 582313 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 582314 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/protwords.txt [junit4] 2> 582322 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 582323 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/currency.xml [junit4] 2> 582330 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchan= ge-rates.json [junit4] 2> 582331 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/open-exchange-rates.json [junit4] 2> 582339 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-= ISOLatin1Accent.txt [junit4] 2> 582340 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 582348 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 582349 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/old_synonyms.txt [junit4] 2> 582357 T1831 oasc.AbstractZkTestCase.putConfig put /mnt/ss= d/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/s= olr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 582358 T1831 oascc.SolrZkClient.makePath makePath: /config= s/conf1/synonyms.txt [junit4] 2> 582545 T1831 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 582548 T1831 oejs.AbstractConnector.doStart Started Select= ChannelConnector@127.0.0.1:51063 [junit4] 2> 582549 T1831 oass.SolrDispatchFilter.init SolrDispatchFilt= er.init() [junit4] 2> 582550 T1831 oasc.SolrResourceLoader.locateSolrHome JNDI n= ot configured for solr (NoInitialContextEx) [junit4] 2> 582551 T1831 oasc.SolrResourceLoader.locateSolrHome using = system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-= Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributed= Zk2Test-controljetty-1374688312604 [junit4] 2> 582552 T1831 oasc.SolrResourceLoader. new SolrResour= ceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/s= olr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test= -controljetty-1374688312604/' [junit4] 2> 582572 T1831 oasc.ConfigSolr.fromFile Loading container co= nfiguration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/buil= d/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test-control= jetty-1374688312604/solr.xml [junit4] 2> 582609 T1831 oasc.CoreContainer. New CoreContainer 1= 392792324 [junit4] 2> 582610 T1831 oasc.CoreContainer.load Loading cores into Co= reContainer [instanceDir=3D/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux= /solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Te= st-controljetty-1374688312604/] [junit4] 2> 582612 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting socketTimeout to: 120000 [junit4] 2> 582612 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting urlScheme to: http:// [junit4] 2> 582613 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting connTimeout to: 15000 [junit4] 2> 582614 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maxConnectionsPerHost to: 20 [junit4] 2> 582615 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting corePoolSize to: 0 [junit4] 2> 582615 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maximumPoolSize to: 2147483647 [junit4] 2> 582616 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maxThreadIdleTime to: 5 [junit4] 2> 582617 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting sizeOfQueue to: -1 [junit4] 2> 582618 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting fairnessPolicy to: false [junit4] 2> 582619 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&so= cketTimeout=3D120000&connTimeout=3D15000&retry=3Dfalse [junit4] 2> 582626 T1831 oasc.ZkContainer.initZooKeeper Zookeeper clie= nt=3D127.0.0.1:48730/solr [junit4] 2> 582627 T1831 oasc.ZkController.checkChrootPath zkHost incl= udes chroot [junit4] 2> 582628 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 582631 T1851 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@20eb20eb name:ZooKeeperConnection= Watcher:127.0.0.1:48730 got event WatchedEvent state:SyncConnected type:No= ne path:null path:null type:None [junit4] 2> 582631 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 582636 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnections=3D500&maxConnectionsPerHost=3D16&sock= etTimeout=3D120000&connTimeout=3D15000 [junit4] 2> 582643 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 582645 T1853 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@60b160b1 name:ZooKeeperConnection= Watcher:127.0.0.1:48730/solr got event WatchedEvent state:SyncConnected ty= pe:None path:null path:null type:None [junit4] 2> 582646 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 582650 T1831 oascc.SolrZkClient.makePath makePath: /overse= er/queue [junit4] 2> 582672 T1831 oascc.SolrZkClient.makePath makePath: /overse= er/collection-queue-work [junit4] 2> 582683 T1831 oascc.SolrZkClient.makePath makePath: /live_n= odes [junit4] 2> 582689 T1831 oasc.ZkController.createEphemeralLiveNode Reg= ister node as live in ZooKeeper:/live_nodes/127.0.0.1:51063_ [junit4] 2> 582691 T1831 oascc.SolrZkClient.makePath makePath: /live_n= odes/127.0.0.1:51063_ [junit4] 2> 582704 T1831 oascc.SolrZkClient.makePath makePath: /overse= er_elect/election [junit4] 2> 582718 T1831 oascc.SolrZkClient.makePath makePath: /overse= er_elect/leader [junit4] 2> 582726 T1831 oasc.Overseer.start Overseer (id=3D9009157323= 4630659-127.0.0.1:51063_-n_0000000000) starting [junit4] 2> 582736 T1831 oascc.SolrZkClient.makePath makePath: /overse= er/queue-work [junit4] 2> 582759 T1855 oasc.OverseerCollectionProcessor.run Process = current queue of collection creations [junit4] 2> 582763 T1831 oascc.SolrZkClient.makePath makePath: /cluste= rstate.json [junit4] 2> 582771 T1831 oascc.SolrZkClient.makePath makePath: /aliase= s.json [junit4] 2> 582778 T1831 oascc.ZkStateReader.createClusterStateWatcher= sAndUpdate Updating cluster state from ZooKeeper...=20 [junit4] 2> 582789 T1854 oasc.Overseer$ClusterStateUpdater.run Startin= g to work on the main queue [junit4] 2> 582800 T1856 oasc.ZkController.publish publishing core=3Dc= ollection1 state=3Ddown [junit4] 2> 582800 T1856 oasc.ZkController.publish numShards not found= on descriptor - reading it from system property [junit4] 2> 582803 T1856 oasc.ZkController.waitForCoreNodeName look fo= r our core node name [junit4] 2> 584303 T1854 oascc.ZkStateReader.updateClusterState Updati= ng cloud state from ZooKeeper...=20 [junit4] 2> 584307 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Update state numShards=3D1 message=3D{ [junit4] 2> =09 "shard_state":"active", [junit4] 2> =09 "base_url":"http://127.0.0.1:51063", [junit4] 2> =09 "state":"down", [junit4] 2> =09 "operation":"state", [junit4] 2> =09 "core_node_name":"core_node1", [junit4] 2> =09 "node_name":"127.0.0.1:51063_", [junit4] 2> =09 "numShards":"1", [junit4] 2> =09 "shard_range":null, [junit4] 2> =09 "roles":null, [junit4] 2> =09 "collection":"control_collection", [junit4] 2> =09 "shard":null, [junit4] 2> =09 "core":"collection1"} [junit4] 2> 584308 T1854 oasc.Overseer$ClusterStateUpdater.createColle= ction Create collection control_collection with numShards 1 [junit4] 2> 584308 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Assigning new node to shard shard=3Dshard1 [junit4] 2> 584319 T1853 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 584804 T1856 oasc.ZkController.waitForShardId waiting to f= ind shard id in clusterstate for collection1 [junit4] 2> 584804 T1856 oasc.CoreContainer.create Creating SolrCore '= collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-= Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributed= Zk2Test-controljetty-1374688312604/collection1 [junit4] 2> 584805 T1856 oasc.ZkController.createCollectionZkNode Chec= k for collection zkNode:control_collection [junit4] 2> 584807 T1856 oasc.ZkController.createCollectionZkNode Coll= ection zkNode exists [junit4] 2> 584808 T1856 oasc.ZkController.readConfigName Load collect= ion config from:/collections/control_collection [junit4] 2> 584811 T1856 oasc.SolrResourceLoader. new SolrResour= ceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/s= olr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test= -controljetty-1374688312604/collection1/' [junit4] 2> 584812 T1856 oasc.SolrResourceLoader.replaceClassLoader Ad= ding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr= -core/test/J1/org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-13= 74688312604/collection1/lib/README' to classloader [junit4] 2> 584813 T1856 oasc.SolrResourceLoader.replaceClassLoader Ad= ding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr= -core/test/J1/org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-13= 74688312604/collection1/lib/classes/' to classloader [junit4] 2> 584847 T1856 oasc.SolrConfig. Using Lucene MatchVers= ion: LUCENE_45 [junit4] 2> 584902 T1856 oasc.SolrConfig. Loaded SolrConfig: sol= rconfig.xml [junit4] 2> 584906 T1856 oass.IndexSchema.readSchema Reading Solr Sche= ma from schema.xml [junit4] 2> 584917 T1856 oass.IndexSchema.readSchema [collection1] Sch= ema name=3Dtest [junit4] 2> 585339 T1856 oass.ByteField.init WARN ByteField is depreca= ted and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 585340 T1856 oass.ShortField.init WARN ShortField is depre= cated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 585341 T1856 oass.OpenExchangeRatesOrgProvider.init Initia= lized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4] 2> 585347 T1856 oass.IndexSchema.readSchema default search fi= eld in schema is text [junit4] 2> 585350 T1856 oass.IndexSchema.readSchema unique key field:= id [junit4] 2> 585388 T1856 oass.FileExchangeRateProvider.reload Reloadin= g exchange rates from file currency.xml [junit4] 2> 585395 T1856 oass.FileExchangeRateProvider.reload Reloadin= g exchange rates from file currency.xml [junit4] 2> 585402 T1856 oass.OpenExchangeRatesOrgProvider.reload Relo= ading exchange rates from open-exchange-rates.json [junit4] 2> 585406 T1856 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 585406 T1856 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Expected key, got STRING [junit4] 2> 585407 T1856 oass.OpenExchangeRatesOrgProvider.reload Relo= ading exchange rates from open-exchange-rates.json [junit4] 2> 585422 T1856 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 585422 T1856 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Expected key, got STRING [junit4] 2> 585423 T1856 oasc.SolrCore.initDirectoryFactory org.apache= .solr.core.MockDirectoryFactory [junit4] 2> 585423 T1856 oasc.SolrCore. [collection1] Opening ne= w SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/s= olr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test-controljet= ty-1374688312604/collection1/, dataDir=3D./org.apache.solr.cloud.BasicDistr= ibutedZk2Test-1374688312291/control/data/ [junit4] 2> 585424 T1856 oasc.JmxMonitoredMap. JMX monitoring is= enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBea= nServer@53665366 [junit4] 2> 585425 T1856 oasc.CachingDirectoryFactory.get return new d= irectory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1374688312291/= control/data [junit4] 2> 585426 T1856 oasc.SolrCore.getNewIndexDir New index direct= ory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistributedZk2T= est-1374688312291/control/data/index/ [junit4] 2> 585426 T1856 oasc.SolrCore.initIndex WARN [collection1] So= lr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-1374688= 312291/control/data/index' doesn't exist. Creating new index... [junit4] 2> 585427 T1856 oasc.CachingDirectoryFactory.get return new d= irectory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1374688312291/= control/data/index [junit4] 2> 585429 T1856 oasc.SolrDeletionPolicy.onCommit SolrDeletion= Policy.onCommit: commits: num=3D1 [junit4] 2> =09=09commit{dir=3DMockDirWrapper(org.apache.lucene.store.= RAMDirectory@5cde5cde lockFactory=3Dorg.apache.lucene.store.NativeFSLockFac= tory@75037503),segFN=3Dsegments_1,generation=3D1} [junit4] 2> 585430 T1856 oasc.SolrDeletionPolicy.updateCommits newest = commit generation =3D 1 [junit4] 2> 585436 T1856 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "ded= upe" [junit4] 2> 585436 T1856 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "sto= red_sig" [junit4] 2> 585437 T1856 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "dis= trib-dup-test-chain-implicit" [junit4] 2> 585438 T1856 oasc.RequestHandlers.initHandlersFromConfig c= reated standard: solr.StandardRequestHandler [junit4] 2> 585439 T1856 oasc.RequestHandlers.initHandlersFromConfig c= reated /get: solr.RealTimeGetHandler [junit4] 2> 585439 T1856 oasc.RequestHandlers.initHandlersFromConfig a= dding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 585440 T1856 oasc.RequestHandlers.initHandlersFromConfig c= reated /replication: solr.ReplicationHandler [junit4] 2> 585441 T1856 oasc.RequestHandlers.initHandlersFromConfig c= reated /update: solr.UpdateRequestHandler [junit4] 2> 585442 T1856 oasc.RequestHandlers.initHandlersFromConfig c= reated /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 585443 T1856 oashl.XMLLoader.init xsltCacheLifetimeSeconds= =3D60 [junit4] 2> 585445 T1856 oass.SolrIndexSearcher. Opening Searche= r@4a344a34 main [junit4] 2> 585446 T1856 oasu.CommitTracker. Hard AutoCommit: di= sabled [junit4] 2> 585447 T1856 oasu.CommitTracker. Soft AutoCommit: di= sabled [junit4] 2> 585457 T1857 oasc.SolrCore.registerSearcher [collection1] = Registered new searcher Searcher@4a344a34 main{StandardDirectoryReader(segm= ents_1:1)} [junit4] 2> 585461 T1856 oasc.CoreContainer.registerCore registering c= ore: collection1 [junit4] 2> 585462 T1856 oasc.ZkController.register Register replica -= core:collection1 address:http://127.0.0.1:51063 collection:control_collect= ion shard:shard1 [junit4] 2> 585463 T1856 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnections=3D10000&maxConnectionsPerHost=3D20&co= nnTimeout=3D30000&socketTimeout=3D30000&retry=3Dfalse [junit4] 2> 585472 T1856 oascc.SolrZkClient.makePath makePath: /collec= tions/control_collection/leader_elect/shard1/election [junit4] 2> 585501 T1856 oasc.ShardLeaderElectionContext.runLeaderProc= ess Running the leader process for shard shard1 [junit4] 2> 585520 T1856 oasc.ShardLeaderElectionContext.waitForReplic= asToComeUp Enough replicas found to continue. [junit4] 2> 585521 T1856 oasc.ShardLeaderElectionContext.runLeaderProc= ess I may be the new leader - try and sync [junit4] 2> 585521 T1856 oasc.SyncStrategy.sync Sync replicas to http:= //127.0.0.1:51063/collection1/ [junit4] 2> 585522 T1856 oasc.SyncStrategy.syncReplicas Sync Success -= now sync replicas to me [junit4] 2> 585523 T1856 oasc.SyncStrategy.syncToMe http://127.0.0.1:5= 1063/collection1/ has no replicas [junit4] 2> 585523 T1856 oasc.ShardLeaderElectionContext.runLeaderProc= ess I am the new leader: http://127.0.0.1:51063/collection1/ shard1 [junit4] 2> 585524 T1856 oascc.SolrZkClient.makePath makePath: /collec= tions/control_collection/leaders/shard1 [junit4] 2> 585884 T1854 oascc.ZkStateReader.updateClusterState Updati= ng cloud state from ZooKeeper...=20 [junit4] 2> 585907 T1853 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 586001 T1856 oasc.ZkController.register We are http://127.= 0.0.1:51063/collection1/ and leader is http://127.0.0.1:51063/collection1/ [junit4] 2> 586002 T1856 oasc.ZkController.register No LogReplay neede= d for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:51063 [junit4] 2> 586002 T1856 oasc.ZkController.checkRecovery I am the lead= er, no recovery necessary [junit4] 2> 586003 T1856 oasc.ZkController.publish publishing core=3Dc= ollection1 state=3Dactive [junit4] 2> 586003 T1856 oasc.ZkController.publish numShards not found= on descriptor - reading it from system property [junit4] 2> 586008 T1856 oascc.ZkStateReader.updateClusterState Updati= ng cloud state from ZooKeeper...=20 [junit4] 2> 586010 T1831 oass.SolrDispatchFilter.init user.dir=3D/mnt/= ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1 [junit4] 2> 586011 T1831 oass.SolrDispatchFilter.init SolrDispatchFilt= er.init() done [junit4] 2> 586012 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&foll= owRedirects=3Dfalse [junit4] 2> 586018 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config: [junit4] 2> 586019 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 586021 T1860 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@2e542e54 name:ZooKeeperConnection= Watcher:127.0.0.1:48730/solr got event WatchedEvent state:SyncConnected ty= pe:None path:null path:null type:None [junit4] 2> 586022 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 586025 T1831 oascc.ZkStateReader.createClusterStateWatcher= sAndUpdate Updating cluster state from ZooKeeper...=20 [junit4] 2> 586033 T1831 oasc.ChaosMonkey.monkeyLog monkey: init - exp= ire sessions:true cause connection loss:true [junit4] 2> 586215 T1831 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 586217 T1831 oejs.AbstractConnector.doStart Started Select= ChannelConnector@127.0.0.1:46223 [junit4] 2> 586218 T1831 oass.SolrDispatchFilter.init SolrDispatchFilt= er.init() [junit4] 2> 586219 T1831 oasc.SolrResourceLoader.locateSolrHome JNDI n= ot configured for solr (NoInitialContextEx) [junit4] 2> 586220 T1831 oasc.SolrResourceLoader.locateSolrHome using = system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-= Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributed= Zk2Test-jetty1-1374688316263 [junit4] 2> 586220 T1831 oasc.SolrResourceLoader. new SolrResour= ceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/s= olr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test= -jetty1-1374688316263/' [junit4] 2> 586242 T1831 oasc.ConfigSolr.fromFile Loading container co= nfiguration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/buil= d/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-= 1374688316263/solr.xml [junit4] 2> 586280 T1831 oasc.CoreContainer. New CoreContainer 1= 782671937 [junit4] 2> 586281 T1831 oasc.CoreContainer.load Loading cores into Co= reContainer [instanceDir=3D/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux= /solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Te= st-jetty1-1374688316263/] [junit4] 2> 586283 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting socketTimeout to: 120000 [junit4] 2> 586284 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting urlScheme to: http:// [junit4] 2> 586284 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting connTimeout to: 15000 [junit4] 2> 586285 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maxConnectionsPerHost to: 20 [junit4] 2> 586286 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting corePoolSize to: 0 [junit4] 2> 586287 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maximumPoolSize to: 2147483647 [junit4] 2> 586287 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maxThreadIdleTime to: 5 [junit4] 2> 586288 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting sizeOfQueue to: -1 [junit4] 2> 586289 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting fairnessPolicy to: false [junit4] 2> 586290 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&so= cketTimeout=3D120000&connTimeout=3D15000&retry=3Dfalse [junit4] 2> 586297 T1831 oasc.ZkContainer.initZooKeeper Zookeeper clie= nt=3D127.0.0.1:48730/solr [junit4] 2> 586298 T1831 oasc.ZkController.checkChrootPath zkHost incl= udes chroot [junit4] 2> 586299 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 586301 T1871 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@7bce7bce name:ZooKeeperConnection= Watcher:127.0.0.1:48730 got event WatchedEvent state:SyncConnected type:No= ne path:null path:null type:None [junit4] 2> 586302 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 586306 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnections=3D500&maxConnectionsPerHost=3D16&sock= etTimeout=3D120000&connTimeout=3D15000 [junit4] 2> 586321 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 586324 T1873 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@17761776 name:ZooKeeperConnection= Watcher:127.0.0.1:48730/solr got event WatchedEvent state:SyncConnected ty= pe:None path:null path:null type:None [junit4] 2> 586324 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 586336 T1831 oascc.ZkStateReader.createClusterStateWatcher= sAndUpdate Updating cluster state from ZooKeeper...=20 [junit4] 2> 587347 T1831 oasc.ZkController.createEphemeralLiveNode Reg= ister node as live in ZooKeeper:/live_nodes/127.0.0.1:46223_ [junit4] 2> 587350 T1831 oascc.SolrZkClient.makePath makePath: /live_n= odes/127.0.0.1:46223_ [junit4] 2> 587358 T1860 oascc.ZkStateReader$3.process Updating live n= odes... (2) [junit4] 2> 587359 T1873 oascc.ZkStateReader$3.process Updating live n= odes... (2) [junit4] 2> 587360 T1853 oascc.ZkStateReader$3.process Updating live n= odes... (2) [junit4] 2> 587361 T1853 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/li= ve_nodes, has occurred - updating... (live nodes size: 2) [junit4] 2> 587436 T1874 oasc.ZkController.publish publishing core=3Dc= ollection1 state=3Ddown [junit4] 2> 587437 T1874 oasc.ZkController.publish numShards not found= on descriptor - reading it from system property [junit4] 2> 587439 T1874 oasc.ZkController.waitForCoreNodeName look fo= r our core node name [junit4] 2> 587459 T1854 oascc.ZkStateReader.updateClusterState Updati= ng cloud state from ZooKeeper...=20 [junit4] 2> 587463 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Update state numShards=3D1 message=3D{ [junit4] 2> =09 "shard_state":"active", [junit4] 2> =09 "base_url":"http://127.0.0.1:51063", [junit4] 2> =09 "state":"active", [junit4] 2> =09 "operation":"state", [junit4] 2> =09 "core_node_name":"core_node1", [junit4] 2> =09 "node_name":"127.0.0.1:51063_", [junit4] 2> =09 "numShards":"1", [junit4] 2> =09 "shard_range":null, [junit4] 2> =09 "roles":null, [junit4] 2> =09 "collection":"control_collection", [junit4] 2> =09 "shard":"shard1", [junit4] 2> =09 "core":"collection1"} [junit4] 2> 587476 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Update state numShards=3D2 message=3D{ [junit4] 2> =09 "shard_state":"active", [junit4] 2> =09 "base_url":"http://127.0.0.1:46223", [junit4] 2> =09 "state":"down", [junit4] 2> =09 "operation":"state", [junit4] 2> =09 "core_node_name":"core_node1", [junit4] 2> =09 "node_name":"127.0.0.1:46223_", [junit4] 2> =09 "numShards":"2", [junit4] 2> =09 "shard_range":null, [junit4] 2> =09 "roles":null, [junit4] 2> =09 "collection":"collection1", [junit4] 2> =09 "shard":null, [junit4] 2> =09 "core":"collection1"} [junit4] 2> 587476 T1854 oasc.Overseer$ClusterStateUpdater.createColle= ction Create collection collection1 with numShards 2 [junit4] 2> 587477 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Assigning new node to shard shard=3Dshard1 [junit4] 2> 587488 T1860 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 587489 T1853 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 587489 T1873 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 588440 T1874 oasc.ZkController.waitForShardId waiting to f= ind shard id in clusterstate for collection1 [junit4] 2> 588441 T1874 oasc.CoreContainer.create Creating SolrCore '= collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-= Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributed= Zk2Test-jetty1-1374688316263/collection1 [junit4] 2> 588441 T1874 oasc.ZkController.createCollectionZkNode Chec= k for collection zkNode:collection1 [junit4] 2> 588444 T1874 oasc.ZkController.createCollectionZkNode Coll= ection zkNode exists [junit4] 2> 588444 T1874 oasc.ZkController.readConfigName Load collect= ion config from:/collections/collection1 [junit4] 2> 588448 T1874 oasc.SolrResourceLoader. new SolrResour= ceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/s= olr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test= -jetty1-1374688316263/collection1/' [junit4] 2> 588450 T1874 oasc.SolrResourceLoader.replaceClassLoader Ad= ding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr= -core/test/J1/org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-13746883= 16263/collection1/lib/README' to classloader [junit4] 2> 588451 T1874 oasc.SolrResourceLoader.replaceClassLoader Ad= ding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr= -core/test/J1/org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-13746883= 16263/collection1/lib/classes/' to classloader [junit4] 2> 588492 T1874 oasc.SolrConfig. Using Lucene MatchVers= ion: LUCENE_45 [junit4] 2> 588539 T1874 oasc.SolrConfig. Loaded SolrConfig: sol= rconfig.xml [junit4] 2> 588545 T1874 oass.IndexSchema.readSchema Reading Solr Sche= ma from schema.xml [junit4] 2> 588552 T1874 oass.IndexSchema.readSchema [collection1] Sch= ema name=3Dtest [junit4] 2> 589040 T1874 oass.ByteField.init WARN ByteField is depreca= ted and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 589041 T1874 oass.ShortField.init WARN ShortField is depre= cated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 589041 T1874 oass.OpenExchangeRatesOrgProvider.init Initia= lized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4] 2> 589047 T1874 oass.IndexSchema.readSchema default search fi= eld in schema is text [junit4] 2> 589050 T1874 oass.IndexSchema.readSchema unique key field:= id [junit4] 2> 589101 T1874 oass.FileExchangeRateProvider.reload Reloadin= g exchange rates from file currency.xml [junit4] 2> 589109 T1874 oass.FileExchangeRateProvider.reload Reloadin= g exchange rates from file currency.xml [junit4] 2> 589128 T1874 oass.OpenExchangeRatesOrgProvider.reload Relo= ading exchange rates from open-exchange-rates.json [junit4] 2> 589133 T1874 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 589134 T1874 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Expected key, got STRING [junit4] 2> 589135 T1874 oass.OpenExchangeRatesOrgProvider.reload Relo= ading exchange rates from open-exchange-rates.json [junit4] 2> 589140 T1874 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 589141 T1874 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Expected key, got STRING [junit4] 2> 589142 T1874 oasc.SolrCore.initDirectoryFactory org.apache= .solr.core.MockDirectoryFactory [junit4] 2> 589143 T1874 oasc.SolrCore. [collection1] Opening ne= w SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/s= olr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-137= 4688316263/collection1/, dataDir=3D./org.apache.solr.cloud.BasicDistributed= Zk2Test-1374688312291/jetty1/ [junit4] 2> 589144 T1874 oasc.JmxMonitoredMap. JMX monitoring is= enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBea= nServer@53665366 [junit4] 2> 589146 T1874 oasc.CachingDirectoryFactory.get return new d= irectory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1374688312291/= jetty1 [junit4] 2> 589146 T1874 oasc.SolrCore.getNewIndexDir New index direct= ory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistributedZk2T= est-1374688312291/jetty1/index/ [junit4] 2> 589147 T1874 oasc.SolrCore.initIndex WARN [collection1] So= lr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-1374688= 312291/jetty1/index' doesn't exist. Creating new index... [junit4] 2> 589148 T1874 oasc.CachingDirectoryFactory.get return new d= irectory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1374688312291/= jetty1/index [junit4] 2> 589150 T1874 oasc.SolrDeletionPolicy.onCommit SolrDeletion= Policy.onCommit: commits: num=3D1 [junit4] 2> =09=09commit{dir=3DMockDirWrapper(org.apache.lucene.store.= RAMDirectory@57c057c lockFactory=3Dorg.apache.lucene.store.NativeFSLockFact= ory@9510951),segFN=3Dsegments_1,generation=3D1} [junit4] 2> 589150 T1874 oasc.SolrDeletionPolicy.updateCommits newest = commit generation =3D 1 [junit4] 2> 589158 T1874 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "ded= upe" [junit4] 2> 589158 T1874 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "sto= red_sig" [junit4] 2> 589159 T1874 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "dis= trib-dup-test-chain-implicit" [junit4] 2> 589160 T1874 oasc.RequestHandlers.initHandlersFromConfig c= reated standard: solr.StandardRequestHandler [junit4] 2> 589161 T1874 oasc.RequestHandlers.initHandlersFromConfig c= reated /get: solr.RealTimeGetHandler [junit4] 2> 589162 T1874 oasc.RequestHandlers.initHandlersFromConfig a= dding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 589162 T1874 oasc.RequestHandlers.initHandlersFromConfig c= reated /replication: solr.ReplicationHandler [junit4] 2> 589163 T1874 oasc.RequestHandlers.initHandlersFromConfig c= reated /update: solr.UpdateRequestHandler [junit4] 2> 589164 T1874 oasc.RequestHandlers.initHandlersFromConfig c= reated /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 589166 T1874 oashl.XMLLoader.init xsltCacheLifetimeSeconds= =3D60 [junit4] 2> 589168 T1874 oass.SolrIndexSearcher. Opening Searche= r@6d1b6d1b main [junit4] 2> 589169 T1874 oasu.CommitTracker. Hard AutoCommit: di= sabled [junit4] 2> 589170 T1874 oasu.CommitTracker. Soft AutoCommit: di= sabled [junit4] 2> 589180 T1875 oasc.SolrCore.registerSearcher [collection1] = Registered new searcher Searcher@6d1b6d1b main{StandardDirectoryReader(segm= ents_1:1)} [junit4] 2> 589184 T1874 oasc.CoreContainer.registerCore registering c= ore: collection1 [junit4] 2> 589184 T1874 oasc.ZkController.register Register replica -= core:collection1 address:http://127.0.0.1:46223 collection:collection1 sha= rd:shard1 [junit4] 2> 589185 T1874 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnections=3D10000&maxConnectionsPerHost=3D20&co= nnTimeout=3D30000&socketTimeout=3D30000&retry=3Dfalse [junit4] 2> 589193 T1874 oascc.SolrZkClient.makePath makePath: /collec= tions/collection1/leader_elect/shard1/election [junit4] 2> 589234 T1874 oasc.ShardLeaderElectionContext.runLeaderProc= ess Running the leader process for shard shard1 [junit4] 2> 589242 T1874 oasc.ShardLeaderElectionContext.waitForReplic= asToComeUp Enough replicas found to continue. [junit4] 2> 589242 T1874 oasc.ShardLeaderElectionContext.runLeaderProc= ess I may be the new leader - try and sync [junit4] 2> 589243 T1874 oasc.SyncStrategy.sync Sync replicas to http:= //127.0.0.1:46223/collection1/ [junit4] 2> 589243 T1874 oasc.SyncStrategy.syncReplicas Sync Success -= now sync replicas to me [junit4] 2> 589244 T1874 oasc.SyncStrategy.syncToMe http://127.0.0.1:4= 6223/collection1/ has no replicas [junit4] 2> 589244 T1874 oasc.ShardLeaderElectionContext.runLeaderProc= ess I am the new leader: http://127.0.0.1:46223/collection1/ shard1 [junit4] 2> 589245 T1874 oascc.SolrZkClient.makePath makePath: /collec= tions/collection1/leaders/shard1 [junit4] 2> 590549 T1854 oascc.ZkStateReader.updateClusterState Updati= ng cloud state from ZooKeeper...=20 [junit4] 2> 590611 T1860 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 590611 T1873 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 590612 T1853 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 590669 T1874 oasc.ZkController.register We are http://127.= 0.0.1:46223/collection1/ and leader is http://127.0.0.1:46223/collection1/ [junit4] 2> 590669 T1874 oasc.ZkController.register No LogReplay neede= d for core=3Dcollection1 baseURL=3Dhttp://127.0.0.1:46223 [junit4] 2> 590670 T1874 oasc.ZkController.checkRecovery I am the lead= er, no recovery necessary [junit4] 2> 590670 T1874 oasc.ZkController.publish publishing core=3Dc= ollection1 state=3Dactive [junit4] 2> 590671 T1874 oasc.ZkController.publish numShards not found= on descriptor - reading it from system property [junit4] 2> 590677 T1874 oascc.ZkStateReader.updateClusterState Updati= ng cloud state from ZooKeeper...=20 [junit4] 2> 590681 T1831 oass.SolrDispatchFilter.init user.dir=3D/mnt/= ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1 [junit4] 2> 590681 T1831 oass.SolrDispatchFilter.init SolrDispatchFilt= er.init() done [junit4] 2> 590683 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnections=3D128&maxConnectionsPerHost=3D32&foll= owRedirects=3Dfalse [junit4] 2> 590882 T1831 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 590884 T1831 oejs.AbstractConnector.doStart Started Select= ChannelConnector@127.0.0.1:58849 [junit4] 2> 590885 T1831 oass.SolrDispatchFilter.init SolrDispatchFilt= er.init() [junit4] 2> 590886 T1831 oasc.SolrResourceLoader.locateSolrHome JNDI n= ot configured for solr (NoInitialContextEx) [junit4] 2> 590887 T1831 oasc.SolrResourceLoader.locateSolrHome using = system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-= Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributed= Zk2Test-jetty2-1374688320917 [junit4] 2> 590888 T1831 oasc.SolrResourceLoader. new SolrResour= ceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/s= olr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test= -jetty2-1374688320917/' [junit4] 2> 590906 T1831 oasc.ConfigSolr.fromFile Loading container co= nfiguration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/buil= d/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-= 1374688320917/solr.xml [junit4] 2> 590955 T1831 oasc.CoreContainer. New CoreContainer 1= 401836430 [junit4] 2> 590957 T1831 oasc.CoreContainer.load Loading cores into Co= reContainer [instanceDir=3D/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux= /solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Te= st-jetty2-1374688320917/] [junit4] 2> 590959 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting socketTimeout to: 120000 [junit4] 2> 590960 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting urlScheme to: http:// [junit4] 2> 590961 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting connTimeout to: 15000 [junit4] 2> 590963 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maxConnectionsPerHost to: 20 [junit4] 2> 590963 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting corePoolSize to: 0 [junit4] 2> 590964 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maximumPoolSize to: 2147483647 [junit4] 2> 590965 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting maxThreadIdleTime to: 5 [junit4] 2> 590966 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting sizeOfQueue to: -1 [junit4] 2> 590966 T1831 oashc.HttpShardHandlerFactory.getParameter Se= tting fairnessPolicy to: false [junit4] 2> 590967 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnectionsPerHost=3D20&maxConnections=3D10000&so= cketTimeout=3D120000&connTimeout=3D15000&retry=3Dfalse [junit4] 2> 590974 T1831 oasc.ZkContainer.initZooKeeper Zookeeper clie= nt=3D127.0.0.1:48730/solr [junit4] 2> 590975 T1831 oasc.ZkController.checkChrootPath zkHost incl= udes chroot [junit4] 2> 590977 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 590980 T1887 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@72167216 name:ZooKeeperConnection= Watcher:127.0.0.1:48730 got event WatchedEvent state:SyncConnected type:No= ne path:null path:null type:None [junit4] 2> 590980 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 590985 T1831 oascsi.HttpClientUtil.createClient Creating n= ew http client, config:maxConnections=3D500&maxConnectionsPerHost=3D16&sock= etTimeout=3D120000&connTimeout=3D15000 [junit4] 2> 590991 T1831 oascc.ConnectionManager.waitForConnected Wait= ing for client to connect to ZooKeeper [junit4] 2> 590993 T1889 oascc.ConnectionManager.process Watcher org.a= pache.solr.common.cloud.ConnectionManager@191f191f name:ZooKeeperConnection= Watcher:127.0.0.1:48730/solr got event WatchedEvent state:SyncConnected ty= pe:None path:null path:null type:None [junit4] 2> 590994 T1831 oascc.ConnectionManager.waitForConnected Clie= nt is connected to ZooKeeper [junit4] 2> 591007 T1831 oascc.ZkStateReader.createClusterStateWatcher= sAndUpdate Updating cluster state from ZooKeeper...=20 [junit4] 2> 592018 T1831 oasc.ZkController.createEphemeralLiveNode Reg= ister node as live in ZooKeeper:/live_nodes/127.0.0.1:58849_ [junit4] 2> 592022 T1831 oascc.SolrZkClient.makePath makePath: /live_n= odes/127.0.0.1:58849_ [junit4] 2> 592072 T1860 oascc.ZkStateReader$3.process Updating live n= odes... (3) [junit4] 2> 592072 T1860 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/li= ve_nodes, has occurred - updating... (live nodes size: 3) [junit4] 2> 592073 T1889 oascc.ZkStateReader$3.process Updating live n= odes... (3) [junit4] 2> 592075 T1873 oascc.ZkStateReader$3.process Updating live n= odes... (3) [junit4] 2> 592075 T1873 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/li= ve_nodes, has occurred - updating... (live nodes size: 3) [junit4] 2> 592076 T1853 oascc.ZkStateReader$3.process Updating live n= odes... (3) [junit4] 2> 592076 T1853 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/li= ve_nodes, has occurred - updating... (live nodes size: 3) [junit4] 2> 592099 T1890 oasc.ZkController.publish publishing core=3Dc= ollection1 state=3Ddown [junit4] 2> 592099 T1890 oasc.ZkController.publish numShards not found= on descriptor - reading it from system property [junit4] 2> 592102 T1890 oasc.ZkController.waitForCoreNodeName look fo= r our core node name [junit4] 2> 592136 T1854 oascc.ZkStateReader.updateClusterState Updati= ng cloud state from ZooKeeper...=20 [junit4] 2> 592140 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Update state numShards=3D2 message=3D{ [junit4] 2> =09 "shard_state":"active", [junit4] 2> =09 "base_url":"http://127.0.0.1:46223", [junit4] 2> =09 "state":"active", [junit4] 2> =09 "operation":"state", [junit4] 2> =09 "core_node_name":"core_node1", [junit4] 2> =09 "node_name":"127.0.0.1:46223_", [junit4] 2> =09 "numShards":"2", [junit4] 2> =09 "shard_range":null, [junit4] 2> =09 "roles":null, [junit4] 2> =09 "collection":"collection1", [junit4] 2> =09 "shard":"shard1", [junit4] 2> =09 "core":"collection1"} [junit4] 2> 592163 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Update state numShards=3D2 message=3D{ [junit4] 2> =09 "shard_state":"active", [junit4] 2> =09 "base_url":"http://127.0.0.1:58849", [junit4] 2> =09 "state":"down", [junit4] 2> =09 "operation":"state", [junit4] 2> =09 "core_node_name":"core_node2", [junit4] 2> =09 "node_name":"127.0.0.1:58849_", [junit4] 2> =09 "numShards":"2", [junit4] 2> =09 "shard_range":null, [junit4] 2> =09 "roles":null, [junit4] 2> =09 "collection":"collection1", [junit4] 2> =09 "shard":null, [junit4] 2> =09 "core":"collection1"} [junit4] 2> 592163 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Collection already exists with numShards=3D2 [junit4] 2> 592164 T1854 oasc.Overseer$ClusterStateUpdater.updateState= Assigning new node to shard shard=3Dshard2 [junit4] 2> 592174 T1873 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 592174 T1889 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 592174 T1860 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 592175 T1853 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/cluste= rstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 593102 T1890 oasc.ZkController.waitForShardId waiting to f= ind shard id in clusterstate for collection1 [junit4] 2> 593103 T1890 oasc.CoreContainer.create Creating SolrCore '= collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-= Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributed= Zk2Test-jetty2-1374688320917/collection1 [junit4] 2> 593104 T1890 oasc.ZkController.createCollectionZkNode Chec= k for collection zkNode:collection1 [junit4] 2> 593106 T1890 oasc.ZkController.createCollectionZkNode Coll= ection zkNode exists [junit4] 2> 593106 T1890 oasc.ZkController.readConfigName Load collect= ion config from:/collections/collection1 [junit4] 2> 593110 T1890 oasc.SolrResourceLoader. new SolrResour= ceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/s= olr/build/solr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test= -jetty2-1374688320917/collection1/' [junit4] 2> 593111 T1890 oasc.SolrResourceLoader.replaceClassLoader Ad= ding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr= -core/test/J1/org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-13746883= 20917/collection1/lib/README' to classloader [junit4] 2> 593112 T1890 oasc.SolrResourceLoader.replaceClassLoader Ad= ding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr= -core/test/J1/org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-13746883= 20917/collection1/lib/classes/' to classloader [junit4] 2> 593148 T1890 oasc.SolrConfig. Using Lucene MatchVers= ion: LUCENE_45 [junit4] 2> 593209 T1890 oasc.SolrConfig. Loaded SolrConfig: sol= rconfig.xml [junit4] 2> 593213 T1890 oass.IndexSchema.readSchema Reading Solr Sche= ma from schema.xml [junit4] 2> 593224 T1890 oass.IndexSchema.readSchema [collection1] Sch= ema name=3Dtest [junit4] 2> 593729 T1890 oass.ByteField.init WARN ByteField is depreca= ted and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 593730 T1890 oass.ShortField.init WARN ShortField is depre= cated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 593731 T1890 oass.OpenExchangeRatesOrgProvider.init Initia= lized with rates=3Dopen-exchange-rates.json, refreshInterval=3D1440. [junit4] 2> 593737 T1890 oass.IndexSchema.readSchema default search fi= eld in schema is text [junit4] 2> 593740 T1890 oass.IndexSchema.readSchema unique key field:= id [junit4] 2> 593777 T1890 oass.FileExchangeRateProvider.reload Reloadin= g exchange rates from file currency.xml [junit4] 2> 593792 T1890 oass.FileExchangeRateProvider.reload Reloadin= g exchange rates from file currency.xml [junit4] 2> 593799 T1890 oass.OpenExchangeRatesOrgProvider.reload Relo= ading exchange rates from open-exchange-rates.json [junit4] 2> 593803 T1890 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 593804 T1890 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Expected key, got STRING [junit4] 2> 593804 T1890 oass.OpenExchangeRatesOrgProvider.reload Relo= ading exchange rates from open-exchange-rates.json [junit4] 2> 593808 T1890 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Unknown key IMPORTANT NOTE [junit4] 2> 593809 T1890 oass.OpenExchangeRatesOrgProvider$OpenExchang= eRates. WARN Expected key, got STRING [junit4] 2> 593809 T1890 oasc.SolrCore.initDirectoryFactory org.apache= .solr.core.MockDirectoryFactory [junit4] 2> 593810 T1890 oasc.SolrCore. [collection1] Opening ne= w SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/s= olr-core/test/J1/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-137= 4688320917/collection1/, dataDir=3D./org.apache.solr.cloud.BasicDistributed= Zk2Test-1374688312291/jetty2/ [junit4] 2> 593811 T1890 oasc.JmxMonitoredMap. JMX monitoring is= enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBea= nServer@53665366 [junit4] 2> 593812 T1890 oasc.CachingDirectoryFactory.get return new d= irectory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1374688312291/= jetty2 [junit4] 2> 593812 T1890 oasc.SolrCore.getNewIndexDir New index direct= ory detected: old=3Dnull new=3D./org.apache.solr.cloud.BasicDistributedZk2T= est-1374688312291/jetty2/index/ [junit4] 2> 593813 T1890 oasc.SolrCore.initIndex WARN [collection1] So= lr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-1374688= 312291/jetty2/index' doesn't exist. Creating new index... [junit4] 2> 593814 T1890 oasc.CachingDirectoryFactory.get return new d= irectory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1374688312291/= jetty2/index [junit4] 2> 593816 T1890 oasc.SolrDeletionPolicy.onCommit SolrDeletion= Policy.onCommit: commits: num=3D1 [junit4] 2> =09=09commit{dir=3DMockDirWrapper(org.apache.lucene.store.= RAMDirectory@4efc4efc lockFactory=3Dorg.apache.lucene.store.NativeFSLockFac= tory@6e226e22),segFN=3Dsegments_1,generation=3D1} [junit4] 2> 593816 T1890 oasc.SolrDeletionPolicy.updateCommits newest = commit generation =3D 1 [junit4] 2> 593825 T1890 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "ded= upe" [junit4] 2> 593825 T1890 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "sto= red_sig" [junit4] 2> 593826 T1890 oasup.UpdateRequestProcessorChain.init insert= ing DistributedUpdateProcessorFactory into updateRequestProcessorChain "dis= trib-dup-test-chain-implicit" [junit4] 2> 593827 T1890 oasc.RequestHandlers.initHandlersFromConfig c= reated standard: solr.StandardRequestHandler [junit4] 2> 593828 T1890 oasc.RequestHandlers.initHandlersFromConfig c= reated /get: solr.RealTimeGetHandler [junit4] 2> 593829 T1890 oasc.RequestHandlers.initHandlersFromConfig a= dding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 593829 T1890 oasc.RequestHandlers.initHandlersFromConfig c= reated /replication: solr.ReplicationHandler [junit4] 2> 593830 T1890 oasc.RequestHandlers.initHandlersFromConfig c= reated /update: solr.UpdateRequestHandler [junit4] 2> 593831 T1890 oasc.RequestHandlers.initHandlersFromConfig c= reated /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 593833 T1890 oashl.XMLLoader.init xsltCacheLifetimeSeconds= =3D60 [junit4] 2> 593835 T1890 oass.SolrIndexSearcher. Opening Searche= r@4f3d4f3d main [junit4] 2> 593836 T1890 oasu.CommitTracker. Hard AutoCommit: di= sabled [junit4] 2> 593837 T1890 oasu.CommitTracker. Soft AutoCommit: di= sabled [junit4] 2> 593861 T1891 oasc.SolrCore.registerSearcher [collection1] = Registered new searcher Searcher@4f3d4f3d main{StandardDirectoryReader(segm= ents_1:1)} [junit4] 2> 593865 T1890 oasc.CoreContainer.registerCore registering c= ore: collection1 [junit4] 2> 593866 T1890 oasc.Z [...truncated too long message...] 0) [junit4] 1> DATA: [junit4] 1> { [junit4] 1> "base_url":"http://127.0.0.1:46223", [junit4] 1> "node_name":"127.0.0.1:46223_", [junit4] 1> "core":"onenodecollectioncore"} [junit4] 1> /solr/aliases.json (0) [junit4] 1> /solr/live_nodes (5) [junit4] 1> /solr/live_nodes/127.0.0.1:52320_ (0) [junit4] 1> /solr/live_nodes/127.0.0.1:58849_ (0) [junit4] 1> /solr/live_nodes/127.0.0.1:43165_ (0) [junit4] 1> /solr/live_nodes/127.0.0.1:46223_ (0) [junit4] 1> /solr/live_nodes/127.0.0.1:51063_ (0) [junit4] 1> /solr/clusterstate.json (0) [junit4] 1> DATA: [junit4] 1> { [junit4] 1> "control_collection":{ [junit4] 1> "shards":{"shard1":{ [junit4] 1> "range":"80000000-7fffffff", [junit4] 1> "state":"active", [junit4] 1> "replicas":{"core_node1":{ [junit4] 1> "base_url":"http://127.0.0.1:51063", [junit4] 1> "state":"active", [junit4] 1> "node_name":"127.0.0.1:51063_", [junit4] 1> "core":"collection1", [junit4] 1> "leader":"true"}}}}, [junit4] 1> "router":"compositeId"}, [junit4] 1> "onenodecollection":{ [junit4] 1> "shards":{"shard1":{ [junit4] 1> "range":"80000000-7fffffff", [junit4] 1> "state":"active", [junit4] 1> "replicas":{"core_node1":{ [junit4] 1> "base_url":"http://127.0.0.1:46223", [junit4] 1> "state":"active", [junit4] 1> "node_name":"127.0.0.1:46223_", [junit4] 1> "roles":"none", [junit4] 1> "core":"onenodecollectioncore", [junit4] 1> "leader":"true"}}}}, [junit4] 1> "router":"compositeId"}, [junit4] 1> "collection1":{ [junit4] 1> "shards":{ [junit4] 1> "shard1":{ [junit4] 1> "range":"80000000-ffffffff", [junit4] 1> "state":"active", [junit4] 1> "replicas":{ [junit4] 1> "core_node1":{ [junit4] 1> "base_url":"http://127.0.0.1:46223", [junit4] 1> "state":"active", [junit4] 1> "node_name":"127.0.0.1:46223_", [junit4] 1> "core":"collection1", [junit4] 1> "leader":"true"}, [junit4] 1> "core_node3":{ [junit4] 1> "base_url":"http://127.0.0.1:43165", [junit4] 1> "state":"active", [junit4] 1> "node_name":"127.0.0.1:43165_", [junit4] 1> "core":"collection1"}}}, [junit4] 1> "shard2":{ [junit4] 1> "range":"0-7fffffff", [junit4] 1> "state":"active", [junit4] 1> "replicas":{ [junit4] 1> "core_node2":{ [junit4] 1> "base_url":"http://127.0.0.1:58849", [junit4] 1> "state":"active", [junit4] 1> "node_name":"127.0.0.1:58849_", [junit4] 1> "core":"collection1", [junit4] 1> "leader":"true"}, [junit4] 1> "core_node4":{ [junit4] 1> "base_url":"http://127.0.0.1:52320", [junit4] 1> "state":"active", [junit4] 1> "node_name":"127.0.0.1:52320_", [junit4] 1> "core":"collection1"}}}}, [junit4] 1> "router":"compositeId"}} [junit4] 1> /zookeeper (1) [junit4] 1> DATA: [junit4] 1> =20 [junit4] 1>=20 [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=3DBasicDistribu= tedZk2Test -Dtests.method=3DtestDistribSearch -Dtests.seed=3DEAD7FFEA55D6F8= 0E -Dtests.multiplier=3D3 -Dtests.slow=3Dtrue -Dtests.locale=3Dno_NO_NY -Dt= ests.timezone=3DAsia/Damascus -Dtests.file.encoding=3DUTF-8 [junit4] ERROR 32.6s J1 | BasicDistributedZk2Test.testDistribSearch <<= < [junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrSe= rver$RemoteSolrException: Server at http://127.0.0.1:58849/onenodecollectio= ncore returned non ok status:404, message:Can not find: /onenodecollectionc= ore/update [junit4] > =09at __randomizedtesting.SeedInfo.seed([EAD7FFEA55D6F80E:= 6B3171F222899832]:0) [junit4] > =09at org.apache.solr.client.solrj.impl.HttpSolrServer.req= uest(HttpSolrServer.java:385) [junit4] > =09at org.apache.solr.client.solrj.impl.HttpSolrServer.req= uest(HttpSolrServer.java:180) [junit4] > =09at org.apache.solr.client.solrj.request.AbstractUpdateR= equest.process(AbstractUpdateRequest.java:117) [junit4] > =09at org.apache.solr.client.solrj.SolrServer.add(SolrServ= er.java:116) [junit4] > =09at org.apache.solr.client.solrj.SolrServer.add(SolrServ= er.java:102) [junit4] > =09at org.apache.solr.cloud.BasicDistributedZk2Test.testNo= deWithoutCollectionForwarding(BasicDistributedZk2Test.java:196) [junit4] > =09at org.apache.solr.cloud.BasicDistributedZk2Test.doTest= (BasicDistributedZk2Test.java:88) [junit4] > =09at org.apache.solr.BaseDistributedSearchTestCase.testDi= stribSearch(BaseDistributedSearchTestCase.java:835) [junit4] > =09at java.lang.Thread.run(Thread.java:738) [junit4] 2> 614643 T1831 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> 32602 T1830 ccr.ThreadLeakControl.checkThreadLeaks WARNING= Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> 614669 T1905 oascc.ZkStateReader$3.process WARN ZooKeeper = watch triggered, but Solr cannot talk to ZK [junit4] 2> 614669 T1905 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/li= ve_nodes, has occurred - updating... (live nodes size: 2) [junit4] 2> 614670 T1905 oascc.ZkStateReader$2.process WARN ZooKeeper = watch triggered, but Solr cannot talk to ZK [junit4] 2> 615843 T1922 oascc.ZkStateReader$3.process WARN ZooKeeper = watch triggered, but Solr cannot talk to ZK [junit4] 2> 615844 T1922 oascc.ZkStateReader$2.process A cluster state= change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/li= ve_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 615844 T1922 oascc.ZkStateReader$2.process WARN ZooKeeper = watch triggered, but Solr cannot talk to ZK [junit4] 2> NOTE: test params are: codec=3DLucene42: {}, docValues:{},= sim=3DDefaultSimilarity, locale=3Dno_NO_NY, timezone=3DAsia/Damascus [junit4] 2> NOTE: Linux 3.2.0-49-generic x86/IBM Corporation 1.6.0 (32= -bit)/cpus=3D8,threads=3D2,free=3D8691224,total=3D42394624 [junit4] 2> NOTE: All tests run in this JVM: [TestFieldTypeResource, S= olrCmdDistributorTest, TestPartialUpdateDeduplication, URLClassifyProcessor= Test, TestLuceneMatchVersion, DocValuesMultiTest, TestDynamicFieldCollectio= nResource, TestBinaryResponseWriter, FileUtilsTest, TestPropInject, BlockCa= cheTest, JSONWriterTest, TestAddFieldRealTimeGet, TestFastOutputStream, Out= putWriterTest, HighlighterTest, SpellCheckCollatorTest, TestMergePolicyConf= ig, TestSolrJ, TestLazyCores, TestFiltering, TestJmxIntegration, DirectUpda= teHandlerTest, IndexSchemaRuntimeFieldTest, TestUtils, TestAtomicUpdateErro= rCases, ChaosMonkeySafeLeaderTest, SampleTest, DistanceFunctionTest, Cachin= gDirectoryFactoryTest, OpenExchangeRatesOrgProviderTest, TestSolr4Spatial, = XsltUpdateRequestHandlerTest, TestSolrXml, TestUpdate, SuggesterTSTTest, Nu= mericFieldsTest, TestRandomFaceting, ZkNodePropsTest, TestCloudManagedSchem= a, HardAutoCommitTest, TestFieldCollectionResource, TestSerializedLuceneMat= chVersion, ZkSolrClientTest, TestNumberUtils, CoreContainerCoreInitFailures= Test, ShardRoutingCustomTest, EchoParamsTest, TestCodecSupport, CopyFieldTe= st, RequiredFieldsTest, TestCloudManagedSchemaAddField, MultiTermTest, Path= HierarchyTokenizerFactoryTest, DirectSolrSpellCheckerTest, SolrIndexConfigT= est, TestManagedSchemaFieldResource, SimplePostToolTest, UniqFieldsUpdatePr= ocessorFactoryTest, TestIndexSearcher, TestFoldingMultitermQuery, TestSolrQ= ueryParserResource, SolrTestCaseJ4Test, FullSolrCloudDistribCmdsTest, DOMUt= ilTest, TestSuggestSpellingConverter, TestLMJelinekMercerSimilarityFactory,= TestCopyFieldCollectionResource, TestSolrXMLSerializer, TestCSVLoader, Tes= tDefaultSimilarityFactory, TestDefaultSearchFieldResource, SuggesterWFSTTes= t, BasicDistributedZk2Test] [junit4] Completed on J1 in 33.88s, 1 test, 1 error <<< FAILURES! [...truncated 663 lines...] BUILD FAILED /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:395: The followi= ng error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:388: The followi= ng error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The followin= g error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:181: The fo= llowing error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:449:= The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:12= 33: The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:87= 6: There were test failures: 319 suites, 1345 tests, 1 error, 1 failure, 35= ignored (7 assumptions) Total time: 56 minutes 30 seconds Build step 'Invoke Ant' marked build as failure Description set: Java: 32bit/ibm-j9-jdk6 -Xjit:exclude=3D{org/apache/lucene= /util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;} Archiving artifacts Recording test results Email was triggered for: Failure Sending email for trigger: Failure ------=_Part_52_228046635.1374689520320 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_52_228046635.1374689520320--