You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/08/15 20:26:31 UTC
[JENKINS] Lucene-Solr-trunk-MacOSX (64bit/jdk1.7.0) - Build # 1772
- Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1772/
Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed.
REGRESSION: org.apache.solr.update.SolrCmdDistributorTest.testDistribSearch
Error Message:
expected:<4> but was:<3>
Stack Trace:
java.lang.AssertionError: expected:<4> but was:<3>
at __randomizedtesting.SeedInfo.seed([60AA239DB0AFFE8F:E14CAD85C7F09EB3]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.update.SolrCmdDistributorTest.doTest(SolrCmdDistributorTest.java:312)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.GeneratedMethodAccessor92.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.schema.TestCloudSchemaless.testDistribSearch
Error Message:
Timeout occured while waiting response from server at: https://127.0.0.1:51268/y/p/collection1
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:51268/y/p/collection1
at __randomizedtesting.SeedInfo.seed([60AA239DB0AFFE8F:E14CAD85C7F09EB3]:0)
at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:558)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:124)
at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:68)
at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:54)
at org.apache.solr.schema.TestCloudSchemaless.doTest(TestCloudSchemaless.java:140)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.GeneratedMethodAccessor92.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:152)
at java.net.SocketInputStream.read(SocketInputStream.java:122)
at sun.security.ssl.InputRecord.readFully(InputRecord.java:442)
at sun.security.ssl.InputRecord.read(InputRecord.java:480)
at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:927)
at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:884)
at sun.security.ssl.AppInputStream.read(AppInputStream.java:102)
at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260)
at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123)
at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486)
at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57)
at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:448)
... 46 more
Build Log:
[...truncated 11336 lines...]
[junit4] Suite: org.apache.solr.update.SolrCmdDistributorTest
[junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/init-core-data-001
[junit4] 2> 3663084 T7529 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
[junit4] 2> 3663085 T7529 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /_zas/
[junit4] 2> 3663086 T7529 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 3663098 T7529 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> 3663103 T7529 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3663113 T7529 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3663116 T7529 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:51233
[junit4] 2> 3663126 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3663130 T7529 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3663135 T7529 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr
[junit4] 2> 3663136 T7529 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/'
[junit4] 2> 3663235 T7529 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/solr.xml
[junit4] 2> 3663419 T7529 oasc.CoreContainer.<init> New CoreContainer 157710233
[junit4] 2> 3663419 T7529 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/]
[junit4] 2> 3663421 T7529 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3663421 T7529 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 3663421 T7529 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3663422 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3663422 T7529 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3663423 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3663423 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3663424 T7529 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3663424 T7529 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3663426 T7529 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3663429 T7529 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3663429 T7529 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3663429 T7529 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3663441 T7539 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 3663444 T7539 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 3663444 T7539 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3663445 T7539 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3663542 T7539 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3663600 T7539 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3663601 T7539 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3663686 T7539 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 3664178 T7539 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3664191 T7539 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3664195 T7539 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3664206 T7539 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3664209 T7539 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3664215 T7539 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3664215 T7539 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3664218 T7539 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3664218 T7539 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3664219 T7539 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3664219 T7539 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3664219 T7539 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 3664220 T7539 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3664220 T7539 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/control/data/
[junit4] 2> 3664220 T7539 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7126a8f0
[junit4] 2> 3664222 T7539 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/control/data
[junit4] 2> 3664222 T7539 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/control/data/index/
[junit4] 2> 3664222 T7539 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 3664223 T7539 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/control/data/index
[junit4] 2> 3664224 T7539 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448ff884 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c0b2c5d),segFN=segments_1,generation=1}
[junit4] 2> 3664225 T7539 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3664232 T7539 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3664233 T7539 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3664233 T7539 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3664233 T7539 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3664234 T7539 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3664235 T7539 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3664236 T7539 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3664236 T7539 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3664236 T7539 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3664237 T7539 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3664238 T7539 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3664239 T7539 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3664239 T7539 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3664240 T7539 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3664241 T7539 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3664241 T7539 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3664241 T7539 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3664242 T7539 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3664242 T7539 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3664243 T7539 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3664244 T7539 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3664245 T7539 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3664264 T7539 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3664267 T7539 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3664271 T7539 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3664274 T7539 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3664277 T7539 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3664283 T7539 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3664283 T7539 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3664284 T7539 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448ff884 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c0b2c5d),segFN=segments_1,generation=1}
[junit4] 2> 3664285 T7539 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3664285 T7539 oass.SolrIndexSearcher.<init> Opening Searcher@39b2e2ce[collection1] main
[junit4] 2> 3664286 T7539 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 3664286 T7539 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 3664287 T7539 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 3664287 T7539 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 3664287 T7539 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 3664287 T7539 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 3664297 T7540 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@39b2e2ce[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 3664300 T7539 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3664301 T7529 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 3664302 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3664310 T7529 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3664319 T7529 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3664323 T7529 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:51234
[junit4] 2> 3664335 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3664335 T7529 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3664336 T7529 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr
[junit4] 2> 3664336 T7529 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/'
[junit4] 2> 3664414 T7529 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/solr.xml
[junit4] 2> 3664506 T7529 oasc.CoreContainer.<init> New CoreContainer 1352108667
[junit4] 2> 3664507 T7529 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/]
[junit4] 2> 3664508 T7529 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3664509 T7529 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 3664509 T7529 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3664509 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3664510 T7529 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3664510 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3664510 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3664511 T7529 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3664511 T7529 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3664515 T7529 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3664518 T7529 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3664518 T7529 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3664518 T7529 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3664526 T7551 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 3664531 T7551 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 3664539 T7551 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3664540 T7551 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3664647 T7551 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3664725 T7551 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3664728 T7551 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3664750 T7551 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 3665434 T7551 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3665442 T7551 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3665448 T7551 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3665466 T7551 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3665474 T7551 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3665486 T7551 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3665488 T7551 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3665495 T7551 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3665496 T7551 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3665497 T7551 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3665498 T7551 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3665498 T7551 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 3665499 T7551 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3665499 T7551 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard0/data/
[junit4] 2> 3665499 T7551 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7126a8f0
[junit4] 2> 3665501 T7551 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard0/data
[junit4] 2> 3665501 T7551 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard0/data/index/
[junit4] 2> 3665501 T7551 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard0/data/index' doesn't exist. Creating new index...
[junit4] 2> 3665502 T7551 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard0/data/index
[junit4] 2> 3665504 T7551 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5c870ebc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7aafde72),segFN=segments_1,generation=1}
[junit4] 2> 3665504 T7551 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3665512 T7551 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3665512 T7551 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3665514 T7551 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3665514 T7551 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3665514 T7551 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3665515 T7551 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3665516 T7551 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3665516 T7551 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3665517 T7551 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3665518 T7551 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3665519 T7551 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3665519 T7551 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3665520 T7551 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3665521 T7551 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3665522 T7551 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3665522 T7551 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3665523 T7551 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3665524 T7551 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3665524 T7551 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3665528 T7551 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3665530 T7551 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3665531 T7551 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3665560 T7551 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3665565 T7551 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3665570 T7551 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3665572 T7551 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3665575 T7551 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3665585 T7551 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3665586 T7551 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3665588 T7551 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5c870ebc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7aafde72),segFN=segments_1,generation=1}
[junit4] 2> 3665589 T7551 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3665589 T7551 oass.SolrIndexSearcher.<init> Opening Searcher@78ede70e[collection1] main
[junit4] 2> 3665591 T7551 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 3665592 T7551 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 3665592 T7551 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 3665593 T7551 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 3665593 T7551 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 3665594 T7551 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 3665603 T7552 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@78ede70e[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 3665606 T7551 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3665608 T7529 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 3665609 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3665614 T7529 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3665627 T7529 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3665630 T7529 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:51235
[junit4] 2> 3665634 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3665635 T7529 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3665635 T7529 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr
[junit4] 2> 3665636 T7529 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/'
[junit4] 2> 3665708 T7529 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/solr.xml
[junit4] 2> 3665800 T7529 oasc.CoreContainer.<init> New CoreContainer 276273188
[junit4] 2> 3665800 T7529 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/]
[junit4] 2> 3665801 T7529 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3665802 T7529 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 3665803 T7529 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3665803 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3665804 T7529 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3665804 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3665804 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3665805 T7529 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3665805 T7529 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3665808 T7529 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3665812 T7529 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3665813 T7529 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3665813 T7529 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3665820 T7563 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 3665822 T7563 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 3665823 T7563 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3665823 T7563 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3665906 T7563 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3665980 T7563 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3665981 T7563 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3665998 T7563 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 3666599 T7563 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3666615 T7563 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3666620 T7563 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3666634 T7563 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3666642 T7563 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3666646 T7563 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3666649 T7563 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3666651 T7563 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3666651 T7563 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3666652 T7563 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3666652 T7563 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3666653 T7563 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 3666654 T7563 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3666655 T7563 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard1/data/
[junit4] 2> 3666656 T7563 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7126a8f0
[junit4] 2> 3666657 T7563 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard1/data
[junit4] 2> 3666657 T7563 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard1/data/index/
[junit4] 2> 3666658 T7563 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard1/data/index' doesn't exist. Creating new index...
[junit4] 2> 3666659 T7563 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard1/data/index
[junit4] 2> 3666660 T7563 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@581cd70d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6dce1786),segFN=segments_1,generation=1}
[junit4] 2> 3666660 T7563 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3666668 T7563 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3666669 T7563 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3666669 T7563 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3666670 T7563 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3666671 T7563 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3666671 T7563 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3666672 T7563 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3666672 T7563 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3666673 T7563 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3666674 T7563 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3666676 T7563 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3666677 T7563 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3666678 T7563 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3666678 T7563 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3666679 T7563 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3666679 T7563 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3666680 T7563 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3666680 T7563 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3666681 T7563 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3666681 T7563 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3666682 T7563 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3666683 T7563 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3666703 T7563 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3666708 T7563 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3666711 T7563 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3666716 T7563 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3666721 T7563 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3666730 T7563 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3666730 T7563 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3666732 T7563 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@581cd70d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6dce1786),segFN=segments_1,generation=1}
[junit4] 2> 3666732 T7563 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3666733 T7563 oass.SolrIndexSearcher.<init> Opening Searcher@3560e9a0[collection1] main
[junit4] 2> 3666733 T7563 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 3666734 T7563 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 3666734 T7563 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 3666735 T7563 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 3666735 T7563 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 3666735 T7563 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 3666742 T7564 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3560e9a0[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 3666746 T7563 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3666748 T7529 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 3666748 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3666753 T7529 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3666762 T7529 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3666763 T7529 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:51236
[junit4] 2> 3666766 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3666766 T7529 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3666767 T7529 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr
[junit4] 2> 3666767 T7529 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/'
[junit4] 2> 3666839 T7529 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/solr.xml
[junit4] 2> 3666943 T7529 oasc.CoreContainer.<init> New CoreContainer 290551087
[junit4] 2> 3666943 T7529 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/]
[junit4] 2> 3666945 T7529 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3666945 T7529 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 3666945 T7529 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3666946 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3666946 T7529 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3666946 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3666946 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3666947 T7529 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3666950 T7529 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3666955 T7529 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3666960 T7529 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3666961 T7529 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3666962 T7529 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3666970 T7575 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 3666975 T7575 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 3666976 T7575 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3666977 T7575 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3667080 T7575 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3667154 T7575 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3667156 T7575 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3667178 T7575 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 3667807 T7575 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3667818 T7575 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3667821 T7575 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3667844 T7575 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3667857 T7575 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3667865 T7575 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3667867 T7575 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3667870 T7575 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3667870 T7575 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3667871 T7575 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3667872 T7575 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3667872 T7575 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 3667873 T7575 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3667874 T7575 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard2/data/
[junit4] 2> 3667874 T7575 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7126a8f0
[junit4] 2> 3667875 T7575 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard2/data
[junit4] 2> 3667876 T7575 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard2/data/index/
[junit4] 2> 3667876 T7575 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard2/data/index' doesn't exist. Creating new index...
[junit4] 2> 3667877 T7575 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard2/data/index
[junit4] 2> 3667878 T7575 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@266fd1c1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@23b87daf),segFN=segments_1,generation=1}
[junit4] 2> 3667879 T7575 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3667889 T7575 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3667891 T7575 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3667891 T7575 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3667891 T7575 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3667891 T7575 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3667892 T7575 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3667897 T7575 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3667898 T7575 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3667899 T7575 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3667903 T7575 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3667904 T7575 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3667905 T7575 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3667907 T7575 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3667908 T7575 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3667909 T7575 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3667909 T7575 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3667909 T7575 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3667910 T7575 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3667910 T7575 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3667911 T7575 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3667911 T7575 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3667912 T7575 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3667929 T7575 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3667932 T7575 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3667936 T7575 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3667939 T7575 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3667940 T7575 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3667946 T7575 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3667946 T7575 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3667947 T7575 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@266fd1c1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@23b87daf),segFN=segments_1,generation=1}
[junit4] 2> 3667948 T7575 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3667948 T7575 oass.SolrIndexSearcher.<init> Opening Searcher@e5ce717[collection1] main
[junit4] 2> 3667948 T7575 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 3667949 T7575 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 3667949 T7575 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 3667949 T7575 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 3667950 T7575 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 3667950 T7575 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 3667958 T7576 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e5ce717[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 3667962 T7575 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3667963 T7529 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 3667964 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3667970 T7529 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3667979 T7529 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3667981 T7529 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:51237
[junit4] 2> 3667985 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3667985 T7529 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3667985 T7529 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr
[junit4] 2> 3667986 T7529 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/'
[junit4] 2> 3668049 T7529 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/solr.xml
[junit4] 2> 3668138 T7529 oasc.CoreContainer.<init> New CoreContainer 2143151265
[junit4] 2> 3668138 T7529 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/]
[junit4] 2> 3668139 T7529 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3668140 T7529 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 3668140 T7529 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3668141 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3668141 T7529 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3668142 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3668142 T7529 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3668142 T7529 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3668143 T7529 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3668146 T7529 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3668149 T7529 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3668149 T7529 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3668150 T7529 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3668156 T7587 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 3668161 T7587 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 3668162 T7587 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3668163 T7587 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3668257 T7587 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3668324 T7587 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3668325 T7587 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3668346 T7587 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 3668886 T7587 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3668900 T7587 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3668905 T7587 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3668917 T7587 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3668923 T7587 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3668928 T7587 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3668929 T7587 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3668930 T7587 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3668931 T7587 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3668931 T7587 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3668931 T7587 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3668932 T7587 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 3668932 T7587 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3668932 T7587 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard3/data/
[junit4] 2> 3668932 T7587 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7126a8f0
[junit4] 2> 3668933 T7587 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard3/data
[junit4] 2> 3668933 T7587 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard3/data/index/
[junit4] 2> 3668934 T7587 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard3/data/index' doesn't exist. Creating new index...
[junit4] 2> 3668934 T7587 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.update.SolrCmdDistributorTest-60AA239DB0AFFE8F-001/tempDir-001/shard3/data/index
[junit4] 2> 3668935 T7587 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@53b8a216 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6164c93c),segFN=segments_1,generation=1}
[junit4] 2> 3668935 T7587 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3668943 T7587 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3668943 T7587 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3668944 T7587 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3668944 T7587 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3668944 T7587 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3668944 T7587 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3668945 T7587 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3668946 T7587 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3668946 T7587 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3668947 T7587 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3668947 T7587 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3668948 T7587 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3668949 T7587 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3668951 T7587 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3668951 T7587 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3668951 T7587 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3668952 T7587 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3668953 T7587 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3668953 T7587 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3668954 T7587 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3668955 T7587 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3668955 T7587 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3668973 T7587 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3668975 T7587 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3668978 T7587 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3668981 T7587 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3668983 T7587 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3668989 T7587 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3668989 T7587 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3668991 T7587 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@53b8a216 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6164c93c),segFN=segments_1,generation=1}
[junit4] 2> 3668991 T7587 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3668992 T7587 oass.SolrIndexSearcher.<init> Opening Searcher@73f6371[collection1] main
[junit4] 2> 3668993 T7587 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 3668993 T7587 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 3668994 T7587 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 3668994 T7587 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 3668994 T7587 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 3668994 T7587 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 3669005 T7588 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@73f6371[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 3669009 T7587 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3669010 T7529 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 3669010 T7529 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C1041 name=collection1 org.apache.solr.core.SolrCore@1aa31777
[junit4] 2> 3669055 T7537 C1041 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1476523959100899328)} 0 7
[junit4] 2> ASYNC NEW_CORE C1042 name=collection1 org.apache.solr.core.SolrCore@6070f4d5
[junit4] 2> 3669090 T7546 C1042 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1476523959140745216)} 0 4
[junit4] 2> ASYNC NEW_CORE C1043 name=collection1 org.apache.solr.core.SolrCore@216a1ed3
[junit4] 2> 3669132 T7561 C1043 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1476523959184785408)} 0 5
[junit4] 2> ASYNC NEW_CORE C1044 name=collection1 org.apache.solr.core.SolrCore@5f0940f9
[junit4] 2> 3669172 T7570 C1044 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1476523959226728448)} 0 4
[junit4] 2> ASYNC NEW_CORE C1045 name=collection1 org.apache.solr.core.SolrCore@28d67227
[junit4] 2> 3669211 T7586 C1045 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1476523959266574336)} 0 5
[junit4] 2> 3669253 T7535 C1041 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2} {add=[1 (1476523959315857408)]} 0 0
[junit4] 2> 3669260 T7536 C1041 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3669262 T7536 C1041 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448ff884 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c0b2c5d),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448ff884 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c0b2c5d),segFN=segments_2,generation=2}
[junit4] 2> 3669264 T7536 C1041 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 3669265 T7536 C1041 oass.SolrIndexSearcher.<init> Opening Searcher@2e229ff2[collection1] main
[junit4] 2> 3669266 T7536 C1041 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 3669267 T7540 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2e229ff2[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1))}
[junit4] 2> 3669268 T7536 C1041 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={commit=true&wt=javabin&version=2&softCommit=false&commit_end_point=true&openSearcher=true&expungeDeletes=false&waitSearcher=true} {commit=} 0 8
[junit4] 2> 3669273 T7537 C1041 oasc.SolrCore.execute [collection1] webapp=/_zas path=/select params={wt=javabin&version=2&q=*:*} hits=1 status=0 QTime=0
[junit4] 2> 3669285 T7538 C1041 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2&commit_end_point=true} {add=[2 (1476523959343120384), 3 (1476523959349411840)]} 0 6
[junit4] 2> 3669314 T7545 C1042 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2&commit_end_point=true} {add=[2 (1476523959377723392), 3 (1476523959377723393), 4 (1476523959378771968)]} 0 2
[junit4] 2> 3669318 T7546 C1042 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3669318 T7533 C1041 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3669324 T7546 C1042 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5c870ebc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7aafde72),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5c870ebc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7aafde72),segFN=segments_2,generation=2}
[junit4] 2> 3669324 T7533 C1041 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448ff884 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c0b2c5d),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448ff884 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c0b2c5d),segFN=segments_3,generation=3}
[junit4] 2> 3669326 T7533 C1041 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 3669325 T7546 C1042 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 3669329 T7546 C1042 oass.SolrIndexSearcher.<init> Opening Searcher@6937eba0[collection1] main
[junit4] 2> 3669332 T7546 C1042 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 3669332 T7552 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6937eba0[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C3))}
[junit4] 2> 3669334 T7546 C1042 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={commit=true&wt=javabin&version=2&softCommit=false&commit_end_point=true&openSearcher=true&expungeDeletes=false&waitSearcher=true} {commit=} 0 17
[junit4] 2> 3669380 T7533 C1041 oass.SolrIndexSearcher.<init> Opening Searcher@2a524152[collection1] main
[junit4] 2> 3669381 T7533 C1041 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 3669383 T7540 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2a524152[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1) Uninverting(_1(5.0):C2))}
[junit4] 2> 3669385 T7533 C1041 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={commit=true&wt=javabin&version=2&softCommit=false&commit_end_point=true&openSearcher=true&expungeDeletes=false&waitSearcher=true} {commit=} 0 67
[junit4] 2> 3669395 T7534 C1041 oasc.SolrCore.execute [collection1] webapp=/_zas path=/select params={wt=javabin&version=2&q=*:*} hits=3 status=0 QTime=2
[junit4] 2> 3669406 T7547 C1042 oasc.SolrCore.execute [collection1] webapp=/_zas path=/select params={wt=javabin&version=2&q=*:*} hits=3 status=0 QTime=1
[junit4] 2> 3669415 T7548 C1042 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2&commit_end_point=true} {delete=[3 (-1476523959483629568)]} 0 2
[junit4] 2> 3669416 T7535 C1041 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={wt=javabin&version=2&commit_end_point=true} {delete=[3 (-1476523959484678144)]} 0 2
[junit4] 2> 3669422 T7536 C1041 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3669422 T7549 C1042 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3669428 T7536 C1041 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448ff884 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c0b2c5d),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448ff884 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c0b2c5d),segFN=segments_4,generation=4}
[junit4] 2> 3669428 T7549 C1042 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5c870ebc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7aafde72),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5c870ebc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7aafde72),segFN=segments_3,generation=3}
[junit4] 2> 3669429 T7549 C1042 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 3669428 T7536 C1041 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 3669431 T7549 C1042 oass.SolrIndexSearcher.<init> Opening Searcher@7a2631a7[collection1] main
[junit4] 2> 3669432 T7536 C1041 oass.SolrIndexSearcher.<init> Opening Searcher@7cc7e5e6[collection1] main
[junit4] 2> 3669432 T7549 C1042 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 3669433 T7552 oasc.JmxMonitoredMap.put WARN Failed to register info bean: searcher javax.management.InstanceAlreadyExistsException: solr/collection1:type=searcher,id=org.apache.solr.search.SolrIndexSearcher
[junit4] 2> at com.sun.jmx.mbeanserver.Repository.addMBean(Repository.java:437)
[junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerWithRepository(DefaultMBeanServerInterceptor.java:1898)
[junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerDynamicMBean(DefaultMBeanServerInterceptor.java:966)
[junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerObject(DefaultMBeanServerInterceptor.java:900)
[junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerMBean(DefaultMBeanServerInterceptor.java:324)
[junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.registerMBean(JmxMBeanServer.java:522)
[junit4] 2> at org.apache.solr.core.JmxMonitoredMap.put(JmxMonitoredMap.java:140)
[junit4] 2> at org.apache.solr.core.JmxMonitoredMap.put(JmxMonitoredMap.java:51)
[junit4] 2> at org.apache.solr.search.SolrIndexSearcher.register(SolrIndexSearcher.java:369)
[junit4] 2> at org.apache.solr.core.SolrCore.registerSearcher(SolrCore.java:1936)
[junit4] 2> at org.apache.solr.core.SolrCore.access$100(SolrCore.java:146)
[junit4] 2> at org.apache.solr.core.SolrCore$7.call(SolrCore.java:1803)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:262)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3669432 T7536 C1041 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 3669434 T7540 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7cc7e5e6[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1) Uninverting(_1(5.0):C2/1:delGen=1))}
[junit4] 2> 3669435 T7552 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7a2631a7[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C3/1:delGen=1))}
[junit4] 2> 3669436 T7536 C1041 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={commit=true&wt=javabin&version=2&softCommit=false&commit_end_point=true&openSearcher=true&expungeDeletes=false&waitSearcher=true} {commit=} 0 14
[junit4] 2> 3669437 T7549 C1042 oasup.LogUpdateProcessor.finish [collection1] webapp=/_zas path=/update params={commit=true&wt=javabin&version=2&softCommit=false&commit_end_point=true&openSearcher=true&expungeDeletes=false&waitSearcher=true} {commit=} 0 15
[junit4] 2> 3669444 T7537 C1041 oasc.SolrCore.execute [collection1] webapp=/_zas path=/select params={wt=javabin&version=2&q=*
[...truncated too long message...]
a:210)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
[junit4] > at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:124)
[junit4] > at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:68)
[junit4] > at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:54)
[junit4] > at org.apache.solr.schema.TestCloudSchemaless.doTest(TestCloudSchemaless.java:140)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:152)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:122)
[junit4] > at sun.security.ssl.InputRecord.readFully(InputRecord.java:442)
[junit4] > at sun.security.ssl.InputRecord.read(InputRecord.java:480)
[junit4] > at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:927)
[junit4] > at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:884)
[junit4] > at sun.security.ssl.AppInputStream.read(AppInputStream.java:102)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
[junit4] > at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260)
[junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
[junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
[junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:448)
[junit4] > ... 46 more
[junit4] 2> 4076234 T7605 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-60AA239DB0AFFE8F-001
[junit4] 2> 173248 T7604 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene45, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=ja_JP_JP_#u-ca-japanese, timezone=America/Porto_Velho
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_65 (64-bit)/cpus=2,threads=1,free=265940416,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestPivotHelperCode, TestPhraseSuggestions, TermVectorComponentTest, FunctionTest, TestFieldResource, SOLR749Test, BadIndexSchemaTest, TestCoreContainer, TestSchemaNameResource, HighlighterMaxOffsetTest, CachingDirectoryFactoryTest, TestJmxIntegration, DisMaxRequestHandlerTest, HighlighterConfigTest, CoreContainerCoreInitFailuresTest, StressHdfsTest, ResponseLogComponentTest, HighlighterTest, DistributedFacetPivotLongTailTest, ExternalFileFieldSortTest, DistributedTermsComponentTest, BlockCacheTest, TestFunctionQuery, SolrIndexConfigTest, TestNoOpRegenerator, CoreAdminRequestStatusTest, TestLMDirichletSimilarityFactory, TestSchemaVersionResource, DistributedExpandComponentTest, RemoteQueryErrorTest, RAMDirectoryFactoryTest, SolrPluginUtilsTest, TestDefaultSimilarityFactory, AnalyticsQueryTest, TestSearcherReuse, AsyncMigrateRouteKeyTest, DocValuesMultiTest, SuggesterFSTTest, TestXIncludeConfig, DocumentAnalysisRequestHandlerTest, BasicDistributedZkTest, CursorMarkTest, DistributedSpellCheckComponentTest, TestSchemaResource, TestCSVResponseWriter, ScriptEngineTest, AlternateDirectoryTest, TestDistributedSearch, TestSolrDeletionPolicy1, ShardRoutingTest, SearchHandlerTest, TriLevelCompositeIdRoutingTest, TestExtendedDismaxParser, CoreMergeIndexesAdminHandlerTest, CollectionsAPIDistributedZkTest, CoreAdminCreateDiscoverTest, BasicDistributedZk2Test, TestSolr4Spatial, UpdateRequestProcessorFactoryTest, TestNonDefinedSimilarityFactory, DistribCursorPagingTest, SchemaVersionSpecificBehaviorTest, TestRequestStatusCollectionAPI, ChaosMonkeySafeLeaderTest, TestDocBasedVersionConstraints, TestDynamicFieldResource, TestRTGBase, AliasIntegrationTest, CircularListTest, TestFieldCollectionResource, TestFiltering, TestTrie, DistributedFacetPivotSmallTest, PolyFieldTest, TestDocSet, TestSolrXmlPersistence, TestRangeQuery, TestManagedSchemaFieldResource, FileUtilsTest, ParsingFieldUpdateProcessorsTest, MinimalSchemaTest, CSVRequestHandlerTest, DirectUpdateHandlerOptimizeTest, IndexBasedSpellCheckerTest, TestSort, SharedFSAutoReplicaFailoverUtilsTest, RollingRestartTest, SampleTest, DocValuesTest, SSLMigrationTest, TestStressUserVersions, SpellingQueryConverterTest, TestCloudInspectUtil, HdfsDirectoryTest, FieldFacetTest, HardAutoCommitTest, HdfsUnloadDistributedZkTest, DocumentBuilderTest, StandardRequestHandlerTest, UUIDFieldTest, ExpressionTest, CollectionsAPIAsyncDistributedZkTest, TestBinaryResponseWriter, RecoveryZkTest, StatelessScriptUpdateProcessorFactoryTest, MBeansHandlerTest, EnumFieldTest, HdfsBasicDistributedZkTest, BinaryUpdateRequestHandlerTest, OverseerRolesTest, PrimUtilsTest, TestDocumentBuilder, AutoCommitTest, DistributedIntervalFacetingTest, TestConfig, TestLazyCores, QueryEqualityTest, TestSimpleQParserPlugin, HdfsCollectionsAPIDistributedZkTest, TestMaxScoreQueryParser, NumericFieldsTest, OverseerCollectionProcessorTest, WordBreakSolrSpellCheckerTest, TestCodecSupport, TestSolrCoreProperties, DeleteInactiveReplicaTest, TestMergePolicyConfig, TestBlendedInfixSuggestions, JsonLoaderTest, MultiThreadedOCPTest, QueryParsingTest, TestOrdValues, TestTolerantSearch, FileBasedSpellCheckerTest, TestUniqueKeyFieldResource, TestAtomicUpdateErrorCases, XsltUpdateRequestHandlerTest, TestDistributedMissingSort, FieldMutatingUpdateProcessorTest, SolrCoreCheckLockOnStartupTest, SynonymTokenizerTest, TestReload, SolrInfoMBeanTest, DirectUpdateHandlerTest, SuggesterWFSTTest, SignatureUpdateProcessorFactoryTest, TestStandardQParsers, SliceStateTest, TestOverriddenPrefixQueryForCustomFieldType, TestUpdate, ClusterStateTest, TestChildDocTransformer, TestCollectionAPI, DocExpirationUpdateProcessorFactoryTest, TestShortCircuitedRequests, TestFieldTypeResource, ResourceLoaderTest, BasicZkTest, TestAnalyzedSuggestions, MigrateRouteKeyTest, DistributedQueryComponentOptimizationTest, AnalyticsMergeStrategyTest, SolrCoreTest, TestQueryTypes, TestExpandComponent, OutputWriterTest, TestSolr4Spatial2, TestBM25SimilarityFactory, ShardRoutingCustomTest, PingRequestHandlerTest, TestSerializedLuceneMatchVersion, XmlUpdateRequestHandlerTest, DocValuesMissingTest, CurrencyFieldOpenExchangeTest, TestMissingGroups, SolrCmdDistributorTest, SuggestComponentTest, TestFuzzyAnalyzedSuggestions, TestCloudSchemaless]
[junit4] Completed in 173.83s, 1 test, 1 error <<< FAILURES!
[...truncated 765 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:474: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:454: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:45: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:37: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:189: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:496: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1307: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:922: There were test failures: 430 suites, 1782 tests, 1 error, 1 failure, 45 ignored (18 assumptions)
Total time: 185 minutes 40 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any