Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/2325/ Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.TestDistributedSearch.test Error Message: Error from server at https://127.0.0.1:65073/kp_dt/sb/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:744) at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:727) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:388) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2047) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:636) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:436) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:217) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:186) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:105) 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:497) 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 https://127.0.0.1:65073/kp_dt/sb/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:744) at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:727) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:388) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2047) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:636) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:436) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:217) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:186) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:105) 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:497) 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([728D1C3A8A1364A7:FAD923E024EF095F]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227) 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:982) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935) 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 10178 lines...] [junit4] Suite: org.apache.solr.TestDistributedSearch [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/init-core-data-001 [junit4] 2> 1397820 T7672 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 1397820 T7672 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /kp_dt/sb [junit4] 2> 1398397 T7672 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores/collection1 [junit4] 2> 1398400 T7672 oejs.Server.doStart jetty-9.2.10.v20150310 [junit4] 2> 1398405 T7672 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@34b601c1{/kp_dt/sb,null,AVAILABLE} [junit4] 2> 1398425 T7672 oejs.AbstractConnector.doStart Started ServerConnector@58637ab6{SSL-http/1.1}{127.0.0.1:64987} [junit4] 2> 1398425 T7672 oejs.Server.doStart Started @1400998ms [junit4] 2> 1398425 T7672 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/kp_dt/sb, hostPort=64987, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores} [junit4] 2> 1398427 T7672 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@74a14482 [junit4] 2> 1398428 T7672 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/' [junit4] 2> 1398465 T7672 oasc.SolrXmlConfig.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/solr.xml [junit4] 2> 1398498 T7672 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores [junit4] 2> 1398499 T7672 oasc.CoreContainer.<init> New CoreContainer 70975538 [junit4] 2> 1398499 T7672 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/] [junit4] 2> 1398499 T7672 oasc.CoreContainer.load loading shared library: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/lib [junit4] 2> 1398502 T7672 oasc.SolrResourceLoader.addToClassLoader WARN 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/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/lib). [junit4] 2> 1398516 T7672 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1398524 T7672 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1398527 T7672 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1398527 T7672 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1398527 T7672 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 1398528 T7672 oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used. [junit4] 2> 1398533 T7672 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores [junit4] 2> 1398534 T7672 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores/collection1, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores/collection1/, configSet=collection1, dataDir=data/} [junit4] 2> 1398534 T7672 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores/collection1/ [junit4] 2> 1398534 T7672 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1398536 T7684 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1398537 T7684 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1398538 T7684 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1398568 T7684 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1398577 T7684 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1398595 T7684 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1398596 T7684 oass.IndexSchema.readSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1398601 T7684 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1398688 T7684 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1398695 T7684 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1398695 T7684 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1398703 T7684 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1398705 T7684 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1398707 T7684 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1398707 T7684 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1398707 T7684 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1398708 T7684 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1398708 T7684 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1398708 T7684 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1398708 T7684 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1 [junit4] 2> 1398709 T7684 x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1398709 T7684 x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/], dataDir=[null] [junit4] 2> 1398709 T7684 x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7469fc18 [junit4] 2> 1398709 T7684 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores/collection1/data [junit4] 2> 1398710 T7684 x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores/collection1/data/index/ [junit4] 2> 1398710 T7684 x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1398710 T7684 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/control/cores/collection1/data/index [junit4] 2> 1398710 T7684 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=49, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=53.689453125, floorSegmentMB=1.9375, forceMergeDeletesPctAllowed=29.237363255377705, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5662993835307087 [junit4] 2> 1398711 T7684 x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@123d1d3b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4190777e),segFN=segments_1,generation=1} [junit4] 2> 1398711 T7684 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1398715 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 1398715 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1398716 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1398716 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1398716 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1398716 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1398716 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1398717 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1398717 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1398717 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1398717 T7684 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1398718 T7684 x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1398724 T7684 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1398726 T7684 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1398727 T7684 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1398728 T7684 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1398733 T7684 x:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1398735 T7684 x:collection1 oasc.RequestHandlers.initHandlersFromConfig 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> 1398735 T7684 x:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1398735 T7684 x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1398737 T7684 x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1398737 T7684 x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 1398738 T7684 x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1398738 T7684 x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1398738 T7684 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=21, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=69.5009765625, floorSegmentMB=0.3330078125, forceMergeDeletesPctAllowed=2.5883812888912985, segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1398739 T7684 x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@123d1d3b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4190777e),segFN=segments_1,generation=1} [junit4] 2> 1398739 T7684 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1398739 T7684 x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@22817efb[collection1] main [junit4] 2> 1398740 T7684 x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1398740 T7684 x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1398740 T7684 x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1398740 T7684 x:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 1398744 T7684 x:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1398772 T7684 x:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1398773 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 1398774 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 1398774 T7684 x:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1398774 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 1398774 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 1398774 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 1398775 T7672 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0 [junit4] 2> 1398775 T7672 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1398775 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 1398778 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 1398778 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 1398779 T7685 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 1398779 T7685 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@22817efb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1399464 T7672 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 1399468 T7672 oejs.Server.doStart jetty-9.2.10.v20150310 [junit4] 2> 1399473 T7672 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@2916e041{/kp_dt/sb,null,AVAILABLE} [junit4] 2> 1399483 T7672 oejs.AbstractConnector.doStart Started ServerConnector@6c0b2c5f{SSL-http/1.1}{127.0.0.1:64988} [junit4] 2> 1399484 T7672 oejs.Server.doStart Started @1402056ms [junit4] 2> 1399484 T7672 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/kp_dt/sb, hostPort=64988, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores} [junit4] 2> 1399487 T7672 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@74a14482 [junit4] 2> 1399488 T7672 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/' [junit4] 2> 1399534 T7672 oasc.SolrXmlConfig.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/solr.xml [junit4] 2> 1399543 T7672 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores [junit4] 2> 1399543 T7672 oasc.CoreContainer.<init> New CoreContainer 1914704164 [junit4] 2> 1399543 T7672 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/] [junit4] 2> 1399544 T7672 oasc.CoreContainer.load loading shared library: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/lib [junit4] 2> 1399545 T7672 oasc.SolrResourceLoader.addToClassLoader WARN 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/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/lib). [junit4] 2> 1399555 T7672 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1399560 T7672 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1399562 T7672 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1399562 T7672 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1399562 T7672 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 1399562 T7672 oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used. [junit4] 2> 1399564 T7672 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores [junit4] 2> 1399565 T7672 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores/collection1, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores/collection1/, configSet=collection1, dataDir=data/} [junit4] 2> 1399566 T7672 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores/collection1/ [junit4] 2> 1399566 T7672 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1399567 T7698 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1399568 T7698 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1399568 T7698 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1399596 T7698 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1399603 T7698 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1399621 T7698 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1399621 T7698 oass.IndexSchema.readSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1399626 T7698 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1399778 T7698 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1399792 T7698 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1399794 T7698 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1399802 T7698 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1399805 T7698 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1399807 T7698 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1399809 T7698 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1399809 T7698 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1399810 T7698 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1399811 T7698 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1399811 T7698 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1399812 T7698 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1 [junit4] 2> 1399812 T7698 x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1399812 T7698 x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/], dataDir=[null] [junit4] 2> 1399813 T7698 x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7469fc18 [junit4] 2> 1399813 T7698 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores/collection1/data [junit4] 2> 1399814 T7698 x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores/collection1/data/index/ [junit4] 2> 1399814 T7698 x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1399814 T7698 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001/tempDir-001/shard0/cores/collection1/data/index [junit4] 2> 1399815 T7698 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=49, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=53.689453125, floorSegmentMB=1.9375, forceMergeDeletesPctAllowed=29.237363255377705, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5662993835307087 [junit4] 2> 1399815 T7698 x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c441dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3311f9cf),segFN=segments_1,generation=1} [junit4] 2> 1399815 T7698 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1399823 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 1399824 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1399824 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1399824 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1399824 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1399825 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1399825 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1399825 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1399825 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1399825 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1399826 T7698 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1399826 T7698 x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1399834 T7698 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1399836 T7698 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1399840 T7698 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1399842 T7698 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1399852 T7698 x:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1399857 T7698 x:collection1 oasc.RequestHandlers.initHandlersFromConfig 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> 1399858 T7698 x:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1399859 T7698 x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1399861 T7698 x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1399861 T7698 x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 1399863 T7698 x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1399863 T7698 x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1399864 T7698 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=21, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=69.5009765625, floorSegmentMB=0.3330078125, forceMergeDeletesPctAllowed=2.5883812888912985, segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1399865 T7698 x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c441dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3311f9cf),segFN=segments_1,generation=1} [junit4] 2> 1399865 T7698 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1399865 T7698 x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@265e1b41[collection1] main [junit4] 2> 1399866 T7698 x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1399867 T7698 x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1399867 T7698 x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1399867 T7698 x:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 1399876 T7698 x:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1399925 T7698 x:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1399926 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 1399927 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 1399927 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 1399928 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 1399928 T7698 x:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1399929 T7672 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0 [junit4] 2> 1399930 T7672 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1399929 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 1399931 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 1399932 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 1399934 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 1399934 T7672 oas.SolrTestCaseJ4.setUp ###Starting test [junit4] 2> 1399935 T7699 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 1399938 T7699 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@265e1b41[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> ASYNC NEW_CORE C769 name=collection1 org.apache.solr.core.SolrCore@422ef02 [junit4] 2> 1400005 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1501665144787173376)} 0 4 [junit4] 2> ASYNC NEW_CORE C770 name=collection1 org.apache.solr.core.SolrCore@50124550 [junit4] 2> 1400060 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1501665144846942208)} 0 2 [junit4] 2> 1400066 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[1 (1501665144853233664)]} 0 2 [junit4] 2> 1400073 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[1 (1501665144860573696)]} 0 2 [junit4] 2> 1400078 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[2 (1501665144867913728)]} 0 1 [junit4] 2> 1400084 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[2 (1501665144873156608)]} 0 1 [junit4] 2> 1400088 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[3 (1501665144878399488)]} 0 1 [junit4] 2> 1400094 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[3 (1501665144883642368)]} 0 1 [junit4] 2> 1400099 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[4 (1501665144888885248)]} 0 1 [junit4] 2> 1400103 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[4 (1501665144893079552)]} 0 1 [junit4] 2> 1400108 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[5 (1501665144899371008)]} 0 1 [junit4] 2> 1400112 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[5 (1501665144902516736)]} 0 1 [junit4] 2> 1400116 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[6 (1501665144906711040)]} 0 1 [junit4] 2> 1400119 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[6 (1501665144910905344)]} 0 0 [junit4] 2> 1400123 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[7 (1501665144914051072)]} 0 1 [junit4] 2> 1400126 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[7 (1501665144917196800)]} 0 1 [junit4] 2> 1400130 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[8 (1501665144921391104)]} 0 2 [junit4] 2> 1400134 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[8 (1501665144925585408)]} 0 1 [junit4] 2> 1400139 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[9 (1501665144930828288)]} 0 1 [junit4] 2> 1400142 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[9 (1501665144935022592)]} 0 0 [junit4] 2> 1400145 T7676 x:collection1 C769 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1400158 T7676 x:collection1 C769 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@123d1d3b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4190777e),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@123d1d3b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4190777e),segFN=segments_2,generation=2} [junit4] 2> 1400160 T7676 x:collection1 C769 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 1400171 T7676 x:collection1 C769 oass.SolrIndexSearcher.<init> Opening Searcher@1784e11c[collection1] main [junit4] 2> 1400172 T7676 x:collection1 C769 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1400173 T7685 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1784e11c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C9)))} [junit4] 2> 1400173 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 28 [junit4] 2> 1400177 T7690 x:collection1 C770 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1400193 T7690 x:collection1 C770 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c441dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3311f9cf),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c441dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3311f9cf),segFN=segments_2,generation=2} [junit4] 2> 1400194 T7690 x:collection1 C770 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 1400197 T7690 x:collection1 C770 oass.SolrIndexSearcher.<init> Opening Searcher@4d951717[collection1] main [junit4] 2> 1400198 T7690 x:collection1 C770 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1400200 T7699 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4d951717[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C9)))} [junit4] 2> 1400201 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 24 [junit4] 2> 1400208 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[10 (1501665145000034304)]} 0 4 [junit4] 2> 1400214 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[10 (1501665145007374336)]} 0 3 [junit4] 2> 1400217 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[11 (1501665145013665792)]} 0 0 [junit4] 2> 1400222 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[11 (1501665145017860096)]} 0 2 [junit4] 2> 1400226 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[12 (1501665145022054400)]} 0 1 [junit4] 2> 1400229 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[12 (1501665145026248704)]} 0 0 [junit4] 2> 1400233 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[13 (1501665145030443008)]} 0 1 [junit4] 2> 1400238 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[13 (1501665145034637312)]} 0 1 [junit4] 2> 1400242 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[1001 (1501665145039880192)]} 0 0 [junit4] 2> 1400247 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[1001 (1501665145044074496)]} 0 1 [junit4] 2> 1400251 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[14 (1501665145048268800)]} 0 1 [junit4] 2> 1400255 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[14 (1501665145052463104)]} 0 1 [junit4] 2> 1400258 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[15 (1501665145055608832)]} 0 1 [junit4] 2> 1400262 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[15 (1501665145059803136)]} 0 1 [junit4] 2> 1400266 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[16 (1501665145063997440)]} 0 1 [junit4] 2> 1400270 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[16 (1501665145069240320)]} 0 0 [junit4] 2> 1400277 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[17 (1501665145075531776)]} 0 2 [junit4] 2> 1400283 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[17 (1501665145081823232)]} 0 2 [junit4] 2> 1400287 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[100 (1501665145087066112)]} 0 0 [junit4] 2> 1400291 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[100 (1501665145090211840)]} 0 1 [junit4] 2> 1400294 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[101 (1501665145094406144)]} 0 0 [junit4] 2> 1400298 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[101 (1501665145097551872)]} 0 1 [junit4] 2> 1400302 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[102 (1501665145102794752)]} 0 1 [junit4] 2> 1400306 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[102 (1501665145106989056)]} 0 0 [junit4] 2> 1400309 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[103 (1501665145110134784)]} 0 0 [junit4] 2> 1400313 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[103 (1501665145113280512)]} 0 1 [junit4] 2> 1400316 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[104 (1501665145117474816)]} 0 0 [junit4] 2> 1400319 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[104 (1501665145120620544)]} 0 0 [junit4] 2> 1400322 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[105 (1501665145123766272)]} 0 0 [junit4] 2> 1400326 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[105 (1501665145127960576)]} 0 0 [junit4] 2> 1400329 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[106 (1501665145131106304)]} 0 0 [junit4] 2> 1400332 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[106 (1501665145134252032)]} 0 1 [junit4] 2> 1400336 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[107 (1501665145137397760)]} 0 1 [junit4] 2> 1400339 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[107 (1501665145141592064)]} 0 0 [junit4] 2> 1400343 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[108 (1501665145145786368)]} 0 1 [junit4] 2> 1400347 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[108 (1501665145149980672)]} 0 1 [junit4] 2> 1400350 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[109 (1501665145153126400)]} 0 0 [junit4] 2> 1400354 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[109 (1501665145156272128)]} 0 1 [junit4] 2> 1400358 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[110 (1501665145160466432)]} 0 1 [junit4] 2> 1400361 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[110 (1501665145163612160)]} 0 1 [junit4] 2> 1400364 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[111 (1501665145167806464)]} 0 0 [junit4] 2> 1400368 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[111 (1501665145170952192)]} 0 1 [junit4] 2> 1400371 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[112 (1501665145175146496)]} 0 0 [junit4] 2> 1400374 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[112 (1501665145178292224)]} 0 0 [junit4] 2> 1400378 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[113 (1501665145182486528)]} 0 0 [junit4] 2> 1400382 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[113 (1501665145185632256)]} 0 1 [junit4] 2> 1400385 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[114 (1501665145188777984)]} 0 1 [junit4] 2> 1400388 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[114 (1501665145192972288)]} 0 0 [junit4] 2> 1400392 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[115 (1501665145196118016)]} 0 0 [junit4] 2> 1400395 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[115 (1501665145200312320)]} 0 0 [junit4] 2> 1400398 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[116 (1501665145203458048)]} 0 0 [junit4] 2> 1400401 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[116 (1501665145206603776)]} 0 0 [junit4] 2> 1400406 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[117 (1501665145210798080)]} 0 1 [junit4] 2> 1400410 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[117 (1501665145214992384)]} 0 1 [junit4] 2> 1400414 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[118 (1501665145219186688)]} 0 1 [junit4] 2> 1400417 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[118 (1501665145222332416)]} 0 1 [junit4] 2> 1400420 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[119 (1501665145226526720)]} 0 1 [junit4] 2> 1400429 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[119 (1501665145234915328)]} 0 1 [junit4] 2> 1400433 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[120 (1501665145240158208)]} 0 0 [junit4] 2> 1400438 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[120 (1501665145244352512)]} 0 1 [junit4] 2> 1400443 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[121 (1501665145250643968)]} 0 0 [junit4] 2> 1400447 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[121 (1501665145254838272)]} 0 0 [junit4] 2> 1400451 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[122 (1501665145259032576)]} 0 0 [junit4] 2> 1400455 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[122 (1501665145262178304)]} 0 1 [junit4] 2> 1400458 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[123 (1501665145266372608)]} 0 0 [junit4] 2> 1400462 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[123 (1501665145269518336)]} 0 1 [junit4] 2> 1400465 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[124 (1501665145272664064)]} 0 1 [junit4] 2> 1400469 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[124 (1501665145276858368)]} 0 1 [junit4] 2> 1400473 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[125 (1501665145282101248)]} 0 0 [junit4] 2> 1400478 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[125 (1501665145286295552)]} 0 1 [junit4] 2> 1400481 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[126 (1501665145290489856)]} 0 0 [junit4] 2> 1400485 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[126 (1501665145293635584)]} 0 1 [junit4] 2> 1400490 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[127 (1501665145299927040)]} 0 0 [junit4] 2> 1400495 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[127 (1501665145304121344)]} 0 1 [junit4] 2> 1400499 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[128 (1501665145308315648)]} 0 1 [junit4] 2> 1400502 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[128 (1501665145312509952)]} 0 1 [junit4] 2> 1400507 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[129 (1501665145316704256)]} 0 1 [junit4] 2> 1400511 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[129 (1501665145321947136)]} 0 0 [junit4] 2> 1400516 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[130 (1501665145327190016)]} 0 0 [junit4] 2> 1400520 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[130 (1501665145330335744)]} 0 1 [junit4] 2> 1400527 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[131 (1501665145338724352)]} 0 0 [junit4] 2> 1400531 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[131 (1501665145342918656)]} 0 0 [junit4] 2> 1400535 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[132 (1501665145347112960)]} 0 0 [junit4] 2> 1400538 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[132 (1501665145350258688)]} 0 0 [junit4] 2> 1400541 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[133 (1501665145353404416)]} 0 0 [junit4] 2> 1400545 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[133 (1501665145356550144)]} 0 1 [junit4] 2> 1400548 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[134 (1501665145360744448)]} 0 0 [junit4] 2> 1400551 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[134 (1501665145363890176)]} 0 0 [junit4] 2> 1400557 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[135 (1501665145370181632)]} 0 1 [junit4] 2> 1400561 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[135 (1501665145374375936)]} 0 0 [junit4] 2> 1400565 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[136 (1501665145378570240)]} 0 1 [junit4] 2> 1400569 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[136 (1501665145381715968)]} 0 1 [junit4] 2> 1400572 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[137 (1501665145385910272)]} 0 0 [junit4] 2> 1400576 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[137 (1501665145390104576)]} 0 0 [junit4] 2> 1400581 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[138 (1501665145394298880)]} 0 1 [junit4] 2> 1400584 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[138 (1501665145398493184)]} 0 0 [junit4] 2> 1400588 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[139 (1501665145401638912)]} 0 1 [junit4] 2> 1400591 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[139 (1501665145405833216)]} 0 0 [junit4] 2> 1400595 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[140 (1501665145408978944)]} 0 1 [junit4] 2> 1400603 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[140 (1501665145416318976)]} 0 2 [junit4] 2> 1400608 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[141 (1501665145423659008)]} 0 1 [junit4] 2> 1400612 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[141 (1501665145426804736)]} 0 1 [junit4] 2> 1400616 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[142 (1501665145430999040)]} 0 1 [junit4] 2> 1400619 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[142 (1501665145435193344)]} 0 1 [junit4] 2> 1400622 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[143 (1501665145438339072)]} 0 0 [junit4] 2> 1400625 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[143 (1501665145441484800)]} 0 0 [junit4] 2> 1400629 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[144 (1501665145445679104)]} 0 0 [junit4] 2> 1400634 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[144 (1501665145450921984)]} 0 0 [junit4] 2> 1400644 T7677 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[145 (1501665145460359168)]} 0 5 [junit4] 2> 1400648 T7691 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[145 (1501665145464553472)]} 0 1 [junit4] 2> 1400652 T7678 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[146 (1501665145469796352)]} 0 0 [junit4] 2> 1400656 T7692 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[146 (1501665145472942080)]} 0 1 [junit4] 2> 1400661 T7679 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[147 (1501665145477136384)]} 0 2 [junit4] 2> 1400666 T7693 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[147 (1501665145483427840)]} 0 1 [junit4] 2> 1400671 T7680 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[148 (1501665145488670720)]} 0 1 [junit4] 2> 1400675 T7694 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[148 (1501665145493913600)]} 0 1 [junit4] 2> 1400679 T7681 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[149 (1501665145498107904)]} 0 1 [junit4] 2> 1400684 T7695 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={wt=javabin&version=2} {add=[149 (1501665145502302208)]} 0 1 [junit4] 2> 1400692 T7676 x:collection1 C769 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1400742 T7676 x:collection1 C769 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@123d1d3b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4190777e),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@123d1d3b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4190777e),segFN=segments_3,generation=3} [junit4] 2> 1400743 T7676 x:collection1 C769 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 1400744 T7676 x:collection1 C769 oass.SolrIndexSearcher.<init> Opening Searcher@43d2e62c[collection1] main [junit4] 2> 1400745 T7676 x:collection1 C769 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1400746 T7685 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@43d2e62c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C9) Uninverting(_1(6.0.0):C59)))} [junit4] 2> 1400747 T7676 x:collection1 C769 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 55 [junit4] 2> 1400750 T7690 x:collection1 C770 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1400815 T7690 x:collection1 C770 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c441dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3311f9cf),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c441dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3311f9cf),segFN=segments_3,generation=3} [junit4] 2> 1400816 T7690 x:collection1 C770 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 1400817 T7690 x:collection1 C770 oass.SolrIndexSearcher.<init> Opening Searcher@22319d9a[collection1] main [junit4] 2> 1400818 T7690 x:collection1 C770 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1400819 T7699 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@22319d9a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C9) Uninverting(_1(6.0.0):C59)))} [junit4] 2> 1400819 T7690 x:collection1 C770 oasup.LogUpdateProcessor.finish [collection1] webapp=/kp_dt/sb path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 69 [junit4] 2> 1400825 T7677 x:collection1 C769 oasc.SolrException.log Ignoring exception matching parameter cannot be negative [junit4] 2> 1400826 T7677 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=2 [junit4] 2> 1400838 T7678 x:collection1 C769 oasc.SolrException.log Ignoring exception matching parameter cannot be negative [junit4] 2> 1400839 T7678 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 QTime=1 [junit4] 2> 1400844 T7679 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 [junit4] 2> 1400958 T7694 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/kp_dt/sb|[ff01::213]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&rows=10&version=2&q=*:*&NOW=1432099481274&isShard=true&wt=javabin} hits=68 status=0 QTime=2 [junit4] 2> 1400998 T7695 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1432099481274&ids=1,145,123,138,8,108,109,140,130,131&isShard=true&shard.url=[ff01::114]:33332/kp_dt/sb|[ff01::213]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 1401003 T7691 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&shards=[ff01::114]:33332/kp_dt/sb|[ff01::213]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=154 [junit4] 2> 1401010 T7680 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=1 [junit4] 2> 1401018 T7692 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1|[ff01::083]:33332/kp_dt/sb|[ff01::213]:33332/kp_dt/sb&rows=10&version=2&q=*:*&NOW=1432099481439&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1401026 T7693 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1432099481439&ids=12,13,14,125,15,126,6,17,1001,142&isShard=true&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1|[ff01::083]:33332/kp_dt/sb|[ff01::213]:33332/kp_dt/sb&wt=javabin&version=2} status=0 QTime=4 [junit4] 2> 1401030 T7690 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&shards=https://127.0.0.1:64988/kp_dt/sb/collection1|[ff01::083]:33332/kp_dt/sb|[ff01::213]:33332/kp_dt/sb&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=16 [junit4] 2> 1401035 T7681 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 [junit4] 2> 1401043 T7695 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=[ff01::114]:33332/kp_dt/sb|[ff01::083]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&rows=10&version=2&q=*:*&NOW=1432099481465&isShard=true&wt=javabin} hits=68 status=0 QTime=1 [junit4] 2> 1401050 T7691 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1432099481465&ids=110,2,3,147,103,148,6,8,107,130&isShard=true&shard.url=[ff01::114]:33332/kp_dt/sb|[ff01::083]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&wt=javabin&version=2} status=0 QTime=3 [junit4] 2> 1401053 T7694 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&shards=[ff01::114]:33332/kp_dt/sb|[ff01::083]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=14 [junit4] 2> 1401056 T7676 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1401062 T7693 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=[ff01::083]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&rows=10&version=2&q=*:*&NOW=1432099481485&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1401065 T7690 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1432099481485&ids=11,123,138,117,139,7,118,119,109,140&isShard=true&shard.url=[ff01::083]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1401066 T7692 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&shards=[ff01::083]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=6 [junit4] 2> 1401070 T7677 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1401078 T7691 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1|[ff01::114]:33332/kp_dt/sb&rows=10&version=2&q=*:*&NOW=1432099481498&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1401083 T7694 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1432099481498&ids=12,101,3,137,127,138,106,119,108,142&isShard=true&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1|[ff01::114]:33332/kp_dt/sb&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1401084 T7695 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&shards=https://127.0.0.1:64988/kp_dt/sb/collection1|[ff01::114]:33332/kp_dt/sb&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=11 [junit4] 2> 1401087 T7678 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=1 [junit4] 2> 1401093 T7690 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1&rows=10&version=2&q=*:*&NOW=1432099481515&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1401097 T7692 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1432099481515&ids=112,14,124,135,103,15,115,5,16,109&isShard=true&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 1401101 T7693 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&shards=https://127.0.0.1:64988/kp_dt/sb/collection1&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=11 [junit4] 2> 1401112 T7679 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=2 [junit4] 2> 1401126 T7694 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=[ff01::213]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&rows=10&version=2&q=*:*&NOW=1432099481545&isShard=true&wt=javabin} hits=68 status=0 QTime=1 [junit4] 2> 1401130 T7695 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1432099481545&ids=111,12,146,104,115,16,130,141,120,10&isShard=true&shard.url=[ff01::213]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 1401131 T7691 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&shards=[ff01::213]:33332/kp_dt/sb|https://127.0.0.1:64988/kp_dt/sb/collection1&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=12 [junit4] 2> 1401135 T7680 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1401141 T7692 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1&rows=10&version=2&q=*:*&NOW=1432099481563&isShard=true&wt=javabin} hits=68 status=0 QTime=1 [junit4] 2> 1401144 T7693 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1432099481563&ids=133,145,113,148,137,106,119,9,140,131&isShard=true&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1401145 T7690 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&shards=https://127.0.0.1:64988/kp_dt/sb/collection1&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=7 [junit4] 2> 1401148 T7681 x:collection1 C769 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1401155 T7695 x:collection1 C770 oasc.SolrCore.execute [collection1] webapp=/kp_dt/sb path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=https://127.0.0.1:64988/kp_dt/sb/collection1|[ff01::083]:33332/kp_dt/sb&rows=10&version=2&q=* [...truncated too long message...] [junit4] > at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) [junit4] > at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585) [junit4] > at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221) [junit4] > at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127) [junit4] > at org.eclipse.jetty.servlet.ServletHandler.doScope(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:497) [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([728D1C3A8A1364A7:FAD923E024EF095F]: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:235) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227) [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:982) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 1560563 T7672 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch 728D1C3A8A1364A7-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {other_tl1=PostingsFormat(name=Memory doPackFST= true), range_facet_l_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), SubjectTerms_mfacet=PostingsFormat(name=Memory doPackFST= true), n_l1=PostingsFormat(name=LuceneVarGapFixedInterval), a_n_tdt=PostingsFormat(name=MockRandom), multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), intDefault=PostingsFormat(name=Memory doPackFST= true), n_td1=PostingsFormat(name=Memory doPackFST= true), n_d1=PostingsFormat(name=LuceneVarGapFixedInterval), n_f1=PostingsFormat(name=Memory doPackFST= true), range_facet_l=PostingsFormat(name=LuceneVarGapFixedInterval), n_tl1=PostingsFormat(name=Memory doPackFST= true), oddField_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), n_tf1=PostingsFormat(name=LuceneVarGapFixedInterval), lowerfilt1and2=PostingsFormat(name=LuceneVarGapFixedInterval), a_t=PostingsFormat(name=LuceneVarGapFixedInterval), lowerfilt=PostingsFormat(name=LuceneVarGapFixedInterval), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), text=PostingsFormat(name=MockRandom), timestamp=PostingsFormat(name=LuceneVarGapFixedInterval), severity=PostingsFormat(name=MockRandom), foo_sev_enum=PostingsFormat(name=MockRandom), n_dt1=PostingsFormat(name=Memory doPackFST= true), a_i1=PostingsFormat(name=LuceneVarGapFixedInterval), b_n_tdt=PostingsFormat(name=Memory doPackFST= true), n_ti1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), rnd_b=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), _version_=PostingsFormat(name=Memory doPackFST= true), foo_b=PostingsFormat(name=MockRandom), n_tdt1=PostingsFormat(name=Memory doPackFST= true), foo_d=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_i_dv=PostingsFormat(name=LuceneVarGapFixedInterval), foo_f=PostingsFormat(name=MockRandom)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), foo_sev_enum=DocValuesFormat(name=Lucene50), range_facet_i_dv=DocValuesFormat(name=Memory), timestamp=DocValuesFormat(name=Memory)}, sim=DefaultSimilarity, locale=pl_PL, timezone=Indian/Mauritius [junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=3,threads=1,free=121558240,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [TestCollectionAPI, AddBlockUpdateTest, ExternalCollectionsTest, TestArbitraryIndexDir, TestDynamicFieldCollectionResource, ConcurrentDeleteAndCreateCollectionTest, DistributedQueueTest, TestXIncludeConfig, HdfsThreadLeakTest, JSONWriterTest, BlockDirectoryTest, NoCacheHeaderTest, SortByFunctionTest, TestExactSharedStatsCache, AlternateDirectoryTest, TestJmxMonitoredMap, SystemInfoHandlerTest, HdfsRecoverLeaseTest, RequestHandlersTest, TestLRUCache, TestManagedStopFilterFactory, TestCSVLoader, TestJmxIntegration, TestGroupingSearch, UUIDUpdateProcessorFallbackTest, ShowFileRequestHandlerTest, ResponseHeaderTest, DOMUtilTest, RollingRestartTest, TestShortCircuitedRequests, CircularListTest, HdfsChaosMonkeySafeLeaderTest, TestMissingGroups, TestAtomicUpdateErrorCases, ScriptEngineTest, SolrPluginUtilsTest, DistributedFacetPivotLongTailTest, ResponseLogComponentTest, TestFieldTypeResource, HdfsUnloadDistributedZkTest, AnalysisAfterCoreReloadTest, TestBM25SimilarityFactory, SimpleFacetsTest, TestWriterPerf, TestCoreContainer, AsyncMigrateRouteKeyTest, CachingDirectoryFactoryTest, TestDistributedMissingSort, DistributedQueryComponentOptimizationTest, TestSolr4Spatial2, TestPartialUpdateDeduplication, TestBinaryField, TestRandomMergePolicy, PrimUtilsTest, CoreAdminHandlerTest, TestIBSimilarityFactory, TestCryptoKeys, TestSchemaNameResource, TestPhraseSuggestions, SynonymTokenizerTest, TestOmitPositions, SpatialRPTFieldTypeTest, ShardRoutingTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, DirectUpdateHandlerTest, CursorPagingTest, HdfsDirectoryFactoryTest, DocValuesTest, TestSimpleTrackingShardHandler, TestManagedResource, BadCopyFieldTest, TestSurroundQueryParser, TestElisionMultitermQuery, TestInitParams, HttpPartitionTest, TestLFUCache, TestDefaultSearchFieldResource, JavabinLoaderTest, SuggesterWFSTTest, SegmentsInfoRequestHandlerTest, TestTrackingShardHandlerFactory, AssignTest, SyncSliceTest, RecoveryAfterSoftCommitTest, TestLRUStatsCache, SoftAutoCommitTest, SliceStateTest, DistanceFunctionTest, TestBulkSchemaConcurrent, TestReqParamsAPI, TestNonDefinedSimilarityFactory, RecoveryZkTest, TestPostingsSolrHighlighter, RequestLoggingTest, TestBulkSchemaAPI, TestReplicationHandler, LeaderElectionTest, HdfsCollectionsAPIDistributedZkTest, PreAnalyzedUpdateProcessorTest, TestStressRecovery, TestIndexSearcher, TestWordDelimiterFilterFactory, CacheHeaderTest, BlockCacheTest, TestHashPartitioner, TestSimpleQParserPlugin, TestSolrDynamicMBean, LeaderInitiatedRecoveryOnCommitTest, HdfsBasicDistributedZkTest, DocValuesMultiTest, VMParamsZkACLAndCredentialsProvidersTest, TestSweetSpotSimilarityFactory, SolrXmlInZkTest, TestExtendedDismaxParser, SOLR749Test, PreAnalyzedFieldTest, IndexSchemaRuntimeFieldTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, OverseerTest, BasicZkTest, ClusterStateUpdateTest, TestRandomFaceting, ZkSolrClientTest, TestRandomDVFaceting, ShardRoutingCustomTest, TestDistributedSearch] [junit4] Completed [269/492] on J0 in 162.80s, 1 test, 1 error <<< FAILURES! [...truncated 695 lines...] BUILD FAILED /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:526: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:474: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:61: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:39: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:229: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:512: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1415: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:973: There were test failures: 492 suites, 1963 tests, 1 error, 62 ignored (24 assumptions) Total time: 73 minutes 25 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts 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]
