Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/2683/ Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed. FAILED: org.apache.solr.TestDistributedSearch.test Error Message: Error from server at http://127.0.0.1:55352//collection1: java.lang.NullPointerException at org.apache.solr.search.grouping.distributed.responseprocessor.TopGroupsShardResponseProcessor.process(TopGroupsShardResponseProcessor.java:102) at org.apache.solr.handler.component.QueryComponent.handleGroupedResponses(QueryComponent.java:748) at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:731) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:409) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2079) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:667) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:460) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:210) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:179) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:106) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83) at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97) at org.eclipse.jetty.server.Server.handle(Server.java:499) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257) at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555) at java.lang.Thread.run(Thread.java:745) Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:55352//collection1: java.lang.NullPointerException at org.apache.solr.search.grouping.distributed.responseprocessor.TopGroupsShardResponseProcessor.process(TopGroupsShardResponseProcessor.java:102) at org.apache.solr.handler.component.QueryComponent.handleGroupedResponses(QueryComponent.java:748) at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:731) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:409) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2079) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:667) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:460) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:210) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:179) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:106) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83) at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97) at org.eclipse.jetty.server.Server.handle(Server.java:499) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257) at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555) at java.lang.Thread.run(Thread.java:745) at __randomizedtesting.SeedInfo.seed([71C5F28EC14F0CC2:F991CD546FB3613A]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958) at org.apache.solr.TestDistributedSearch.queryRandomUpServer(TestDistributedSearch.java:1133) at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1095) at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:968) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:985) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) 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:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) 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:54) 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) Build Log: [...truncated 10285 lines...] [junit4] Suite: org.apache.solr.TestDistributedSearch [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/init-core-data-001 [junit4] 2> 1811586 INFO (SUITE-TestDistributedSearch-seed#[71C5F28EC14F0CC2]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 1811586 INFO (SUITE-TestDistributedSearch-seed#[71C5F28EC14F0CC2]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 1811841 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1 [junit4] 2> 1811843 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 1811846 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@35d4e705{/,null,AVAILABLE} [junit4] 2> 1811847 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.e.j.s.ServerConnector Started ServerConnector@30200479{HTTP/1.1}{127.0.0.1:55334} [junit4] 2> 1811847 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.e.j.s.Server Started @1816437ms [junit4] 2> 1811847 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=55334, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores} [junit4] 2> 1811847 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@74a14482 [junit4] 2> 1811847 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/' [junit4] 2> 1811868 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/solr.xml [junit4] 2> 1811874 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores [junit4] 2> 1811874 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer New CoreContainer 414001657 [junit4] 2> 1811874 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/] [junit4] 2> 1811874 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer loading shared library: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/lib [junit4] 2> 1811874 WARN (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/lib). [junit4] 2> 1811920 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1811923 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1811923 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1811923 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1811924 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1811924 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1811926 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores [junit4] 2> 1811927 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1/, configSet=collection1, dataDir=data/} [junit4] 2> 1811927 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoresLocator Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1/ [junit4] 2> 1811927 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 1811928 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1811928 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1811929 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1811933 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1 [junit4] 2> 1811933 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1811949 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1811958 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1811976 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 1811976 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1811979 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1812086 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1812096 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 1812097 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1812103 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1812105 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1812106 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1812107 WARN (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1812107 WARN (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1812107 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1812108 WARN (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1812108 WARN (coreLoadExecutor-5136-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1812110 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf' [junit4] 2> 1812111 INFO (coreLoadExecutor-5136-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1 [junit4] 2> 1812111 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1812111 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/], dataDir=[null] [junit4] 2> 1812111 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@55096edf [junit4] 2> 1812112 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1/data [junit4] 2> 1812112 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1/data/index/ [junit4] 2> 1812112 WARN (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1812112 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1/data/index [junit4] 2> 1812113 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=16, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 1812113 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5ff3ebbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f6aa79d),segFN=segments_1,generation=1} [junit4] 2> 1812113 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 1812117 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1/data/ [junit4] 2> 1812118 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/control/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 1812118 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 1812119 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1812119 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1812119 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1812119 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1812119 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1812119 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1812120 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1812120 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1812120 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1812120 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1812120 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1812126 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1812127 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1812129 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1812130 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1812133 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1812134 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump [junit4] 2> 1812134 WARN (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1812136 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1812137 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1812137 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1812138 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 1812138 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 1812138 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=3.77734375, floorSegmentMB=1.669921875, forceMergeDeletesPctAllowed=15.250562881739295, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3065425379265827 [junit4] 2> 1812138 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5ff3ebbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f6aa79d),segFN=segments_1,generation=1} [junit4] 2> 1812139 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 1812139 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4c8fd061[collection1] main [junit4] 2> 1812139 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1812139 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1812139 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1812139 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1812149 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1812195 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1812196 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1812197 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 1812197 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 1812197 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 1812197 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1812198 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1812198 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1812198 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1812199 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1812199 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1812199 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1812200 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1812197 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1510769143364714496 [junit4] 2> 1812201 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4c8fd061[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1812202 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 4.0ms to seed version buckets with highest version 1510769143364714496 [junit4] 2> 1812202 INFO (coreLoadExecutor-5136-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1812696 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 1812698 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 1812701 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4f939849{/,null,AVAILABLE} [junit4] 2> 1812701 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.e.j.s.ServerConnector Started ServerConnector@141cf167{HTTP/1.1}{127.0.0.1:55335} [junit4] 2> 1812702 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.e.j.s.Server Started @1817292ms [junit4] 2> 1812702 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=55335, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores} [junit4] 2> 1812702 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@74a14482 [junit4] 2> 1812702 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/' [junit4] 2> 1812729 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/solr.xml [junit4] 2> 1812739 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores [junit4] 2> 1812739 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer New CoreContainer 152984087 [junit4] 2> 1812739 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/] [junit4] 2> 1812739 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer loading shared library: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/lib [junit4] 2> 1812740 WARN (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/lib). [junit4] 2> 1812746 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1812749 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1812749 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1812749 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1812749 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1812749 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1812750 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores [junit4] 2> 1812751 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1/, configSet=collection1, dataDir=data/} [junit4] 2> 1812751 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoresLocator Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1/ [junit4] 2> 1812751 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 1812752 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1812753 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1812753 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1812760 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1 [junit4] 2> 1812760 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1812778 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1812792 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1812807 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 1812808 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1812812 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1812911 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1812920 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 1812921 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1812927 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1812945 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1812948 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1812948 WARN (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1812949 WARN (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1812949 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1812949 WARN (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1812949 WARN (coreLoadExecutor-5147-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1812952 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf' [junit4] 2> 1812952 INFO (coreLoadExecutor-5147-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1 [junit4] 2> 1812953 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1812953 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/], dataDir=[null] [junit4] 2> 1812953 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@55096edf [junit4] 2> 1812954 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1/data [junit4] 2> 1812954 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1/data/index/ [junit4] 2> 1812954 WARN (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1812954 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1/data/index [junit4] 2> 1812954 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=16, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 1812956 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@44566145 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3662b937),segFN=segments_1,generation=1} [junit4] 2> 1812956 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 1812956 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1/data/ [junit4] 2> 1812957 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001/tempDir-001/shard0/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 1812961 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 1812962 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1812962 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1812962 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1812962 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1812962 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1812962 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1812963 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1812963 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1812963 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1812964 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1812964 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1812970 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1812972 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1812973 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1812974 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1812981 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1812983 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump [junit4] 2> 1812984 WARN (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1812985 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1812986 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1812986 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1812988 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 1812988 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 1812989 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=3.77734375, floorSegmentMB=1.669921875, forceMergeDeletesPctAllowed=15.250562881739295, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3065425379265827 [junit4] 2> 1812989 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@44566145 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3662b937),segFN=segments_1,generation=1} [junit4] 2> 1812989 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 1812989 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@186e5eaf[collection1] main [junit4] 2> 1812990 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1812990 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1812990 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1812990 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1813001 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1813039 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1813040 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1813040 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 1813040 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1813040 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1813040 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1813040 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 1813041 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 1813041 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1510769144249712640 [junit4] 2> 1813041 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1813041 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1813042 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1813042 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1813042 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1813042 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 1510769144249712640 [junit4] 2> 1813043 INFO (coreLoadExecutor-5147-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1813043 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@186e5eaf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1813264 INFO (TEST-TestDistributedSearch.test-seed#[71C5F28EC14F0CC2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 1813271 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1510769144488787968)} 0 2 [junit4] 2> 1813278 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1510769144494030848)} 0 3 [junit4] 2> 1813284 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1 (1510769144502419456)]} 0 1 [junit4] 2> 1813291 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1 (1510769144510808064)]} 0 1 [junit4] 2> 1813294 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[2 (1510769144515002368)]} 0 0 [junit4] 2> 1813300 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[2 (1510769144520245248)]} 0 1 [junit4] 2> 1813304 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[3 (1510769144524439552)]} 0 1 [junit4] 2> 1813307 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[3 (1510769144527585280)]} 0 0 [junit4] 2> 1813310 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[4 (1510769144530731008)]} 0 0 [junit4] 2> 1813313 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[4 (1510769144533876736)]} 0 0 [junit4] 2> 1813318 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[5 (1510769144539119616)]} 0 1 [junit4] 2> 1813323 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[5 (1510769144544362496)]} 0 0 [junit4] 2> 1813327 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[6 (1510769144549605376)]} 0 0 [junit4] 2> 1813331 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[6 (1510769144552751104)]} 0 0 [junit4] 2> 1813334 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[7 (1510769144555896832)]} 0 0 [junit4] 2> 1813336 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[7 (1510769144559042560)]} 0 0 [junit4] 2> 1813341 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[8 (1510769144563236864)]} 0 0 [junit4] 2> 1813343 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[8 (1510769144566382592)]} 0 0 [junit4] 2> 1813346 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[9 (1510769144569528320)]} 0 0 [junit4] 2> 1813349 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[9 (1510769144571625472)]} 0 0 [junit4] 2> 1813358 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1813364 INFO (qtp169544779-11074) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5ff3ebbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f6aa79d),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5ff3ebbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f6aa79d),segFN=segments_2,generation=2} [junit4] 2> 1813365 INFO (qtp169544779-11074) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2 [junit4] 2> 1813366 INFO (qtp169544779-11074) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3044b2de[collection1] main [junit4] 2> 1813366 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 1813367 INFO (searcherExecutor-5137-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3044b2de[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c9)))} [junit4] 2> 1813367 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 8 [junit4] 2> 1813369 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1813374 INFO (qtp626686584-11092) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@44566145 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3662b937),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@44566145 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3662b937),segFN=segments_2,generation=2} [junit4] 2> 1813375 INFO (qtp626686584-11092) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2 [junit4] 2> 1813376 INFO (qtp626686584-11092) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@5eefd046[collection1] main [junit4] 2> 1813376 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 1813377 INFO (searcherExecutor-5148-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5eefd046[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c9)))} [junit4] 2> 1813377 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 8 [junit4] 2> 1813382 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[10 (1510769144605179904)]} 0 2 [junit4] 2> 1813387 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[10 (1510769144609374208)]} 0 2 [junit4] 2> 1813389 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[11 (1510769144614617088)]} 0 0 [junit4] 2> 1813393 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[11 (1510769144617762816)]} 0 0 [junit4] 2> 1813395 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[12 (1510769144620908544)]} 0 0 [junit4] 2> 1813398 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[12 (1510769144624054272)]} 0 0 [junit4] 2> 1813401 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[13 (1510769144626151424)]} 0 0 [junit4] 2> 1813403 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[13 (1510769144629297152)]} 0 0 [junit4] 2> 1813406 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1001 (1510769144631394304)]} 0 0 [junit4] 2> 1813408 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1001 (1510769144634540032)]} 0 0 [junit4] 2> 1813411 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[14 (1510769144636637184)]} 0 0 [junit4] 2> 1813414 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[14 (1510769144640831488)]} 0 0 [junit4] 2> 1813416 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[15 (1510769144642928640)]} 0 0 [junit4] 2> 1813418 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[15 (1510769144645025792)]} 0 0 [junit4] 2> 1813421 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[16 (1510769144647122944)]} 0 0 [junit4] 2> 1813429 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[16 (1510769144656560128)]} 0 1 [junit4] 2> 1813438 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[17 (1510769144664948736)]} 0 0 [junit4] 2> 1813440 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[17 (1510769144668094464)]} 0 0 [junit4] 2> 1813442 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[100 (1510769144670191616)]} 0 0 [junit4] 2> 1813444 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[100 (1510769144672288768)]} 0 0 [junit4] 2> 1813447 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[101 (1510769144675434496)]} 0 0 [junit4] 2> 1813450 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[101 (1510769144678580224)]} 0 0 [junit4] 2> 1813453 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[102 (1510769144681725952)]} 0 0 [junit4] 2> 1813456 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[102 (1510769144684871680)]} 0 0 [junit4] 2> 1813458 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[103 (1510769144686968832)]} 0 0 [junit4] 2> 1813460 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[103 (1510769144689065984)]} 0 0 [junit4] 2> 1813463 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[104 (1510769144692211712)]} 0 0 [junit4] 2> 1813474 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[104 (1510769144702697472)]} 0 0 [junit4] 2> 1813481 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[105 (1510769144711086080)]} 0 0 [junit4] 2> 1813484 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[105 (1510769144714231808)]} 0 0 [junit4] 2> 1813486 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[106 (1510769144716328960)]} 0 0 [junit4] 2> 1813490 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[106 (1510769144720523264)]} 0 0 [junit4] 2> 1813494 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[107 (1510769144724717568)]} 0 0 [junit4] 2> 1813496 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[107 (1510769144726814720)]} 0 0 [junit4] 2> 1813501 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[108 (1510769144731009024)]} 0 0 [junit4] 2> 1813503 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[108 (1510769144734154752)]} 0 0 [junit4] 2> 1813505 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[109 (1510769144736251904)]} 0 0 [junit4] 2> 1813508 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[109 (1510769144739397632)]} 0 0 [junit4] 2> 1813510 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[110 (1510769144741494784)]} 0 0 [junit4] 2> 1813516 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[110 (1510769144746737664)]} 0 1 [junit4] 2> 1813520 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[111 (1510769144751980544)]} 0 0 [junit4] 2> 1813523 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[111 (1510769144754077696)]} 0 0 [junit4] 2> 1813526 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[112 (1510769144758272000)]} 0 0 [junit4] 2> 1813528 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[112 (1510769144760369152)]} 0 0 [junit4] 2> 1813532 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[113 (1510769144763514880)]} 0 0 [junit4] 2> 1813535 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[113 (1510769144767709184)]} 0 0 [junit4] 2> 1813537 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[114 (1510769144769806336)]} 0 0 [junit4] 2> 1813540 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[114 (1510769144772952064)]} 0 0 [junit4] 2> 1813542 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[115 (1510769144775049216)]} 0 0 [junit4] 2> 1813545 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[115 (1510769144778194944)]} 0 0 [junit4] 2> 1813547 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[116 (1510769144780292096)]} 0 0 [junit4] 2> 1813549 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[116 (1510769144782389248)]} 0 0 [junit4] 2> 1813553 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[117 (1510769144785534976)]} 0 0 [junit4] 2> 1813555 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[117 (1510769144788680704)]} 0 0 [junit4] 2> 1813558 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[118 (1510769144791826432)]} 0 0 [junit4] 2> 1813560 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[118 (1510769144793923584)]} 0 0 [junit4] 2> 1813563 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[119 (1510769144797069312)]} 0 0 [junit4] 2> 1813566 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[119 (1510769144800215040)]} 0 0 [junit4] 2> 1813571 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[120 (1510769144805457920)]} 0 0 [junit4] 2> 1813576 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[120 (1510769144809652224)]} 0 0 [junit4] 2> 1813586 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[121 (1510769144821186560)]} 0 0 [junit4] 2> 1813589 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[121 (1510769144824332288)]} 0 0 [junit4] 2> 1813592 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[122 (1510769144827478016)]} 0 0 [junit4] 2> 1813594 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[122 (1510769144829575168)]} 0 0 [junit4] 2> 1813597 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[123 (1510769144832720896)]} 0 0 [junit4] 2> 1813600 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[123 (1510769144835866624)]} 0 0 [junit4] 2> 1813602 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[124 (1510769144837963776)]} 0 0 [junit4] 2> 1813604 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[124 (1510769144840060928)]} 0 0 [junit4] 2> 1813607 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[125 (1510769144843206656)]} 0 0 [junit4] 2> 1813610 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[125 (1510769144846352384)]} 0 0 [junit4] 2> 1813614 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[126 (1510769144850546688)]} 0 0 [junit4] 2> 1813616 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[126 (1510769144852643840)]} 0 0 [junit4] 2> 1813619 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[127 (1510769144854740992)]} 0 0 [junit4] 2> 1813621 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[127 (1510769144857886720)]} 0 0 [junit4] 2> 1813624 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[128 (1510769144859983872)]} 0 0 [junit4] 2> 1813626 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[128 (1510769144863129600)]} 0 0 [junit4] 2> 1813628 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[129 (1510769144865226752)]} 0 0 [junit4] 2> 1813630 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[129 (1510769144867323904)]} 0 0 [junit4] 2> 1813635 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[130 (1510769144871518208)]} 0 0 [junit4] 2> 1813637 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[130 (1510769144874663936)]} 0 0 [junit4] 2> 1813639 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[131 (1510769144876761088)]} 0 0 [junit4] 2> 1813641 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[131 (1510769144878858240)]} 0 0 [junit4] 2> 1813644 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[132 (1510769144882003968)]} 0 0 [junit4] 2> 1813646 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[132 (1510769144884101120)]} 0 0 [junit4] 2> 1813651 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[133 (1510769144889344000)]} 0 0 [junit4] 2> 1813653 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[133 (1510769144891441152)]} 0 0 [junit4] 2> 1813655 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[134 (1510769144893538304)]} 0 0 [junit4] 2> 1813660 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[134 (1510769144898781184)]} 0 0 [junit4] 2> 1813665 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[135 (1510769144902975488)]} 0 0 [junit4] 2> 1813670 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[135 (1510769144909266944)]} 0 0 [junit4] 2> 1813673 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[136 (1510769144912412672)]} 0 0 [junit4] 2> 1813677 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[136 (1510769144916606976)]} 0 0 [junit4] 2> 1813680 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[137 (1510769144918704128)]} 0 0 [junit4] 2> 1813682 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[137 (1510769144921849856)]} 0 0 [junit4] 2> 1813684 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[138 (1510769144923947008)]} 0 0 [junit4] 2> 1813687 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[138 (1510769144927092736)]} 0 0 [junit4] 2> 1813690 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[139 (1510769144930238464)]} 0 0 [junit4] 2> 1813694 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[139 (1510769144934432768)]} 0 0 [junit4] 2> 1813696 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[140 (1510769144936529920)]} 0 0 [junit4] 2> 1813700 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[140 (1510769144940724224)]} 0 0 [junit4] 2> 1813702 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[141 (1510769144942821376)]} 0 0 [junit4] 2> 1813705 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[141 (1510769144944918528)]} 0 0 [junit4] 2> 1813710 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[142 (1510769144951209984)]} 0 0 [junit4] 2> 1813714 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[142 (1510769144955404288)]} 0 0 [junit4] 2> 1813717 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[143 (1510769144957501440)]} 0 0 [junit4] 2> 1813719 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[143 (1510769144960647168)]} 0 0 [junit4] 2> 1813721 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[144 (1510769144962744320)]} 0 0 [junit4] 2> 1813724 INFO (qtp626686584-11092) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[144 (1510769144965890048)]} 0 0 [junit4] 2> 1813727 INFO (qtp169544779-11075) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[145 (1510769144969035776)]} 0 0 [junit4] 2> 1813730 INFO (qtp626686584-11093) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[145 (1510769144972181504)]} 0 0 [junit4] 2> 1813734 INFO (qtp169544779-11070) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[146 (1510769144976375808)]} 0 0 [junit4] 2> 1813737 INFO (qtp626686584-11088) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[146 (1510769144978472960)]} 0 0 [junit4] 2> 1813740 INFO (qtp169544779-11071) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[147 (1510769144982667264)]} 0 0 [junit4] 2> 1813745 INFO (qtp626686584-11089) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[147 (1510769144986861568)]} 0 0 [junit4] 2> 1813750 INFO (qtp169544779-11072) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[148 (1510769144993153024)]} 0 0 [junit4] 2> 1813755 INFO (qtp626686584-11090) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[148 (1510769144997347328)]} 0 0 [junit4] 2> 1813758 INFO (qtp169544779-11073) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[149 (1510769145001541632)]} 0 0 [junit4] 2> 1813761 INFO (qtp626686584-11091) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[149 (1510769145003638784)]} 0 0 [junit4] 2> 1813763 INFO (qtp169544779-11074) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1813774 INFO (qtp169544779-11074) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5ff3ebbe lockFactory=org.apache.lucene. [...truncated too long message...] ope(ServletHandler.java:515) [junit4] > at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [junit4] > at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061) [junit4] > at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [junit4] > at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97) [junit4] > at org.eclipse.jetty.server.Server.handle(Server.java:499) [junit4] > at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310) [junit4] > at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257) [junit4] > at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540) [junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635) [junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > at __randomizedtesting.SeedInfo.seed([71C5F28EC14F0CC2:F991CD546FB3613A]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958) [junit4] > at org.apache.solr.TestDistributedSearch.queryRandomUpServer(TestDistributedSearch.java:1133) [junit4] > at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1095) [junit4] > at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:968) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:985) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 1983054 INFO (SUITE-TestDistributedSearch-seed#[71C5F28EC14F0CC2]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_71C5F28EC14F0CC2-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {other_tl1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_l_dv=PostingsFormat(name=MockRandom), SubjectTerms_mfacet=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), n_l1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), a_n_tdt=PostingsFormat(name=MockRandom), multiDefault=Lucene50(blocksize=128), intDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), n_td1=Lucene50(blocksize=128), n_d1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), n_f1=Lucene50(blocksize=128), range_facet_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), n_tl1=Lucene50(blocksize=128), oddField_s=FST50, n_tf1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), lowerfilt1and2=Lucene50(blocksize=128), a_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), lowerfilt=Lucene50(blocksize=128), id=PostingsFormat(name=MockRandom), text=FST50, timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), severity=FST50, foo_sev_enum=PostingsFormat(name=MockRandom), n_dt1=Lucene50(blocksize=128), a_i1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), b_n_tdt=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), n_ti1=PostingsFormat(name=MockRandom), rnd_b=PostingsFormat(name=MockRandom), _version_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), foo_b=FST50, n_tdt1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), foo_d=PostingsFormat(name=MockRandom), range_facet_i_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), foo_f=FST50}, docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), foo_sev_enum=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Lucene50), timestamp=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, locale=el_CY, timezone=Antarctica/Davis [junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_60 (64-bit)/cpus=3,threads=1,free=242969840,total=508166144 [junit4] 2> NOTE: All tests run in this JVM: [ShardSplitTest, DateMathParserTest, CacheHeaderTest, TestMiniSolrCloudClusterSSL, ShardRoutingCustomTest, CollectionReloadTest, DistanceFunctionTest, TestSolrConfigHandlerCloud, TestMinMaxOnMultiValuedField, TestLMJelinekMercerSimilarityFactory, DirectUpdateHandlerOptimizeTest, TestScoreJoinQPNoScore, MultiThreadedOCPTest, TestConfigSetImmutable, ConvertedLegacyTest, FacetPivotSmallTest, TestUniqueKeyFieldResource, TestObjectReleaseTracker, SharedFSAutoReplicaFailoverTest, TestRuleBasedAuthorizationPlugin, TestManagedSchemaFieldResource, BasicFunctionalityTest, TestConfigSetsAPI, OpenCloseCoreStressTest, LukeRequestHandlerTest, OutputWriterTest, TestSolrQueryParserDefaultOperatorResource, MultiTermTest, TestStressUserVersions, TestDynamicFieldCollectionResource, UniqFieldsUpdateProcessorFactoryTest, QueryParsingTest, SpellCheckCollatorTest, TestCollationField, SecurityConfHandlerTest, SpellPossibilityIteratorTest, SolrCmdDistributorTest, TestSolrDynamicMBean, ShowFileRequestHandlerTest, LeaderElectionIntegrationTest, BitVectorTest, AliasIntegrationTest, TestManagedStopFilterFactory, TestHdfsUpdateLog, TestRealTimeGet, NumericFieldsTest, TestJsonRequest, ClusterStateTest, TestFastOutputStream, DocExpirationUpdateProcessorFactoryTest, CollectionStateFormat2Test, TestPKIAuthenticationPlugin, BinaryUpdateRequestHandlerTest, ChaosMonkeySafeLeaderTest, CdcrRequestHandlerTest, TestSha256AuthenticationProvider, TestHighFrequencyDictionaryFactory, TestIndexingPerformance, DistanceUnitsTest, TestPHPSerializedResponseWriter, AddSchemaFieldsUpdateProcessorFactoryTest, SynonymTokenizerTest, AsyncCallRequestStatusResponseTest, TestSolrIndexConfig, TestUtils, SignatureUpdateProcessorFactoryTest, TestCopyFieldCollectionResource, TestQueryUtils, TestAtomicUpdateErrorCases, TestCoreDiscovery, ZkStateReaderTest, TestManagedSynonymFilterFactory, TestRawResponseWriter, PKIAuthenticationIntegrationTest, TestDistribDocBasedVersion, MinimalSchemaTest, TestCrossCoreJoin, CollectionTooManyReplicasTest, SuggesterTest, UpdateRequestProcessorFactoryTest, TestJsonFacets, CoreAdminHandlerTest, TestFoldingMultitermQuery, BaseCdcrDistributedZkTest, RequestHandlersTest, TermVectorComponentDistributedTest, HighlighterMaxOffsetTest, TestPerFieldSimilarity, SolrTestCaseJ4Test, TestStressRecovery, OpenExchangeRatesOrgProviderTest, HighlighterConfigTest, UUIDUpdateProcessorFallbackTest, EnumFieldTest, TestCustomDocTransformer, SuggesterWFSTTest, TriLevelCompositeIdRoutingTest, TestOverriddenPrefixQueryForCustomFieldType, TestBadConfig, TestEmbeddedSolrServerConstructors, TestOrdValues, DistributedQueueTest, TestShortCircuitedRequests, TestNonDefinedSimilarityFactory, TestIndexSearcher, TestHighlightDedupGrouping, DefaultValueUpdateProcessorTest, TestDefaultSimilarityFactory, TestDistributedGrouping, CdcrUpdateLogTest, MergeStrategyTest, LoggingHandlerTest, TestRecoveryHdfs, TestReversedWildcardFilterFactory, SolrCloudExampleTest, SSLMigrationTest, BasicZkTest, TestClassNameShortening, UUIDFieldTest, TestBinaryField, IndexSchemaRuntimeFieldTest, TestJoin, CircularListTest, TestWriterPerf, OverseerStatusTest, StatsComponentTest, DistributedTermsComponentTest, TestOmitPositions, TestInfoStreamLogging, CSVRequestHandlerTest, TestRandomRequestDistribution, TestMissingGroups, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, TestDistributedSearch] [junit4] Completed [348/543] on J1 in 171.49s, 1 test, 1 error <<< FAILURES! [...truncated 620 lines...] BUILD FAILED /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:775: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:719: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:59: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:233: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:514: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1432: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:987: There were test failures: 543 suites, 2145 tests, 1 error, 76 ignored (34 assumptions) Total time: 69 minutes 38 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
