lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-6.x-Linux (64bit/jdk1.8.0_102) - Build # 2244 - Unstable!
Date Tue, 22 Nov 2016 21:11:23 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/2244/
Java: 64bit/jdk1.8.0_102 -XX:-UseCompressedOops -XX:+UseG1GC

1 tests failed.
FAILED:  org.apache.solr.TestDistributedSearch.test

Error Message:
Error from server at http://127.0.0.1:42276//collection1: java.lang.NullPointerException  at org.apache.solr.search.grouping.distributed.responseprocessor.StoredFieldsShardResponseProcessor.process(StoredFieldsShardResponseProcessor.java:41)  at org.apache.solr.handler.component.QueryComponent.handleGroupedResponses(QueryComponent.java:756)  at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:739)  at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:428)  at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)  at org.apache.solr.core.SolrCore.execute(SolrCore.java:2210)  at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)  at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:464)  at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)  at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)  at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)  at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)  at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)  at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)  at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)  at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160)  at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)  at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)  at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092)  at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)  at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)  at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)  at org.eclipse.jetty.server.Server.handle(Server.java:518)  at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308)  at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244)  at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)  at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)  at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)  at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246)  at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156)  at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)  at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)  at java.lang.Thread.run(Thread.java:745) 

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:42276//collection1: java.lang.NullPointerException
	at org.apache.solr.search.grouping.distributed.responseprocessor.StoredFieldsShardResponseProcessor.process(StoredFieldsShardResponseProcessor.java:41)
	at org.apache.solr.handler.component.QueryComponent.handleGroupedResponses(QueryComponent.java:756)
	at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:739)
	at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:428)
	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2210)
	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)
	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:464)
	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)
	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160)
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
	at org.eclipse.jetty.server.Server.handle(Server.java:518)
	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308)
	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244)
	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246)
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
	at java.lang.Thread.run(Thread.java:745)

	at __randomizedtesting.SeedInfo.seed([AA7F2E7453FBE71F:222B11AEFD078AE7]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:593)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:957)
	at org.apache.solr.TestDistributedSearch.queryRandomUpServer(TestDistributedSearch.java:1139)
	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1101)
	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:963)
	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:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1018)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	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:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	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:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11834 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/init-core-data-001
   [junit4]   2> 841684 INFO  (SUITE-TestDistributedSearch-seed#[AA7F2E7453FBE71F]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9061)
   [junit4]   2> 841685 INFO  (SUITE-TestDistributedSearch-seed#[AA7F2E7453FBE71F]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 841744 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/control/cores/collection1
   [junit4]   2> 841745 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 841746 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3ebbfc46{/,null,AVAILABLE}
   [junit4]   2> 841748 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.ServerConnector Started ServerConnector@50f57706{HTTP/1.1,[http/1.1]}{127.0.0.1:37810}
   [junit4]   2> 841748 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.Server Started @843911ms
   [junit4]   2> 841748 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=37810, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/control/cores}
   [junit4]   2> 841748 ERROR (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 841748 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.4.0
   [junit4]   2> 841748 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 841748 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 841748 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-11-22T20:33:33.321Z
   [junit4]   2> 841748 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/control/solr.xml
   [junit4]   2> 841753 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 841754 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/control/cores
   [junit4]   2> 841754 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 841754 INFO  (coreLoadExecutor-3406-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 841789 INFO  (coreLoadExecutor-3406-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 841806 INFO  (coreLoadExecutor-3406-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 841865 WARN  (coreLoadExecutor-3406-thread-1) [    ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 841867 INFO  (coreLoadExecutor-3406-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 841871 INFO  (coreLoadExecutor-3406-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 841872 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 841872 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1130bb99
   [junit4]   2> 841872 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=42, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=45.724609375, floorSegmentMB=1.17578125, forceMergeDeletesPctAllowed=29.33840914780554, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 841880 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 841880 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 841882 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 841882 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 841882 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7327497162230973]
   [junit4]   2> 841882 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2385f2c[collection1] main]
   [junit4]   2> 841882 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 841918 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 842032 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 842033 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 842033 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 842033 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 842033 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 842033 INFO  (coreLoadExecutor-3406-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1551731852423725056
   [junit4]   2> 842033 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 842033 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 842033 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 842033 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 842034 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 842034 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2385f2c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 842315 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 842316 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 842317 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2ecaf187{/,null,AVAILABLE}
   [junit4]   2> 842317 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.ServerConnector Started ServerConnector@26b343ca{HTTP/1.1,[http/1.1]}{127.0.0.1:38279}
   [junit4]   2> 842318 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.Server Started @844481ms
   [junit4]   2> 842318 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=38279, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/shard0/cores}
   [junit4]   2> 842318 ERROR (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 842318 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.4.0
   [junit4]   2> 842318 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 842318 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 842318 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-11-22T20:33:33.891Z
   [junit4]   2> 842318 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 842323 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 842324 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/shard0/cores
   [junit4]   2> 842324 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 842325 INFO  (coreLoadExecutor-3417-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 842354 INFO  (coreLoadExecutor-3417-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 842371 INFO  (coreLoadExecutor-3417-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 842435 WARN  (coreLoadExecutor-3417-thread-1) [    ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 842438 INFO  (coreLoadExecutor-3417-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 842445 INFO  (coreLoadExecutor-3417-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 842445 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 842445 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1130bb99
   [junit4]   2> 842446 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=42, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=45.724609375, floorSegmentMB=1.17578125, forceMergeDeletesPctAllowed=29.33840914780554, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 842462 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 842462 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 842464 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 842464 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 842465 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7327497162230973]
   [junit4]   2> 842465 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@38477e03[collection1] main]
   [junit4]   2> 842465 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 842513 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 842622 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 842622 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 842622 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 842622 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 842622 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 842623 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 842623 INFO  (coreLoadExecutor-3417-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1551731853042384896
   [junit4]   2> 842623 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 842623 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 842623 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 842623 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 842624 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@38477e03[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 842825 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 842828 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1551731853256294400)} 0 1
   [junit4]   2> 842829 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1551731853258391552)} 0 0
   [junit4]   2> 842833 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1 (1551731853260488704)]} 0 1
   [junit4]   2> 842834 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1 (1551731853263634432)]} 0 0
   [junit4]   2> 842837 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[2 (1551731853265731584)]} 0 0
   [junit4]   2> 842838 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[2 (1551731853267828736)]} 0 0
   [junit4]   2> 842840 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[3 (1551731853269925888)]} 0 0
   [junit4]   2> 842842 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[3 (1551731853270974464)]} 0 0
   [junit4]   2> 842843 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[4 (1551731853273071616)]} 0 0
   [junit4]   2> 842845 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[4 (1551731853275168768)]} 0 0
   [junit4]   2> 842846 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[5 (1551731853276217344)]} 0 0
   [junit4]   2> 842849 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[5 (1551731853278314496)]} 0 0
   [junit4]   2> 842850 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[6 (1551731853280411648)]} 0 0
   [junit4]   2> 842852 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[6 (1551731853282508800)]} 0 0
   [junit4]   2> 842853 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[7 (1551731853283557376)]} 0 0
   [junit4]   2> 842855 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[7 (1551731853285654528)]} 0 0
   [junit4]   2> 842857 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[8 (1551731853286703104)]} 0 0
   [junit4]   2> 842858 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[8 (1551731853288800256)]} 0 0
   [junit4]   2> 842860 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[9 (1551731853290897408)]} 0 0
   [junit4]   2> 842862 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[9 (1551731853292994560)]} 0 0
   [junit4]   2> 842864 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 842864 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1862b01
   [junit4]   2> 842867 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@410d4ff6[collection1] main]
   [junit4]   2> 842867 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 842867 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@410d4ff6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C9)))}
   [junit4]   2> 842867 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4
   [junit4]   2> 842869 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 842869 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3df9e5db
   [junit4]   2> 842871 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@330b46f[collection1] main]
   [junit4]   2> 842871 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 842872 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@330b46f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C9)))}
   [junit4]   2> 842873 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3
   [junit4]   2> 842875 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[10 (1551731853305577472)]} 0 1
   [junit4]   2> 842877 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[10 (1551731853308723200)]} 0 0
   [junit4]   2> 842879 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[11 (1551731853310820352)]} 0 0
   [junit4]   2> 842881 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[11 (1551731853312917504)]} 0 0
   [junit4]   2> 842882 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[12 (1551731853313966080)]} 0 0
   [junit4]   2> 842884 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[12 (1551731853316063232)]} 0 0
   [junit4]   2> 842886 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[13 (1551731853318160384)]} 0 0
   [junit4]   2> 842887 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[13 (1551731853319208960)]} 0 0
   [junit4]   2> 842902 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1001 (1551731853333889024)]} 0 12
   [junit4]   2> 842904 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1001 (1551731853335986176)]} 0 0
   [junit4]   2> 842905 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[14 (1551731853338083328)]} 0 0
   [junit4]   2> 842907 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[14 (1551731853340180480)]} 0 0
   [junit4]   2> 842909 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[15 (1551731853342277632)]} 0 0
   [junit4]   2> 842910 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[15 (1551731853343326208)]} 0 0
   [junit4]   2> 842912 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[16 (1551731853345423360)]} 0 0
   [junit4]   2> 842913 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[16 (1551731853346471936)]} 0 0
   [junit4]   2> 842915 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[17 (1551731853348569088)]} 0 0
   [junit4]   2> 842917 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[17 (1551731853350666240)]} 0 0
   [junit4]   2> 842918 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[100 (1551731853351714816)]} 0 0
   [junit4]   2> 842920 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[100 (1551731853353811968)]} 0 0
   [junit4]   2> 842922 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[101 (1551731853355909120)]} 0 0
   [junit4]   2> 842924 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[101 (1551731853356957696)]} 0 0
   [junit4]   2> 842925 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[102 (1551731853359054848)]} 0 0
   [junit4]   2> 842927 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[102 (1551731853360103424)]} 0 0
   [junit4]   2> 842928 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[103 (1551731853362200576)]} 0 0
   [junit4]   2> 842930 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[103 (1551731853363249152)]} 0 0
   [junit4]   2> 842931 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[104 (1551731853365346304)]} 0 0
   [junit4]   2> 842932 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[104 (1551731853366394880)]} 0 0
   [junit4]   2> 842934 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[105 (1551731853368492032)]} 0 0
   [junit4]   2> 842936 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[105 (1551731853369540608)]} 0 0
   [junit4]   2> 842937 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[106 (1551731853371637760)]} 0 0
   [junit4]   2> 842939 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[106 (1551731853372686336)]} 0 0
   [junit4]   2> 842940 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[107 (1551731853374783488)]} 0 0
   [junit4]   2> 842942 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[107 (1551731853375832064)]} 0 0
   [junit4]   2> 842943 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[108 (1551731853377929216)]} 0 0
   [junit4]   2> 842944 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[108 (1551731853378977792)]} 0 0
   [junit4]   2> 842946 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[109 (1551731853381074944)]} 0 0
   [junit4]   2> 842948 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[109 (1551731853382123520)]} 0 0
   [junit4]   2> 842949 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[110 (1551731853384220672)]} 0 0
   [junit4]   2> 842951 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[110 (1551731853385269248)]} 0 0
   [junit4]   2> 842952 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[111 (1551731853387366400)]} 0 0
   [junit4]   2> 842954 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[111 (1551731853389463552)]} 0 0
   [junit4]   2> 842955 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[112 (1551731853390512128)]} 0 0
   [junit4]   2> 842958 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[112 (1551731853393657856)]} 0 0
   [junit4]   2> 842959 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[113 (1551731853394706432)]} 0 0
   [junit4]   2> 842961 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[113 (1551731853396803584)]} 0 0
   [junit4]   2> 842962 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[114 (1551731853397852160)]} 0 0
   [junit4]   2> 842964 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[114 (1551731853399949312)]} 0 0
   [junit4]   2> 842965 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[115 (1551731853400997888)]} 0 0
   [junit4]   2> 842967 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[115 (1551731853403095040)]} 0 0
   [junit4]   2> 842969 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[116 (1551731853404143616)]} 0 0
   [junit4]   2> 842970 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[116 (1551731853406240768)]} 0 0
   [junit4]   2> 842972 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[117 (1551731853408337920)]} 0 0
   [junit4]   2> 842973 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[117 (1551731853409386496)]} 0 0
   [junit4]   2> 842975 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[118 (1551731853411483648)]} 0 0
   [junit4]   2> 842976 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[118 (1551731853412532224)]} 0 0
   [junit4]   2> 842978 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[119 (1551731853414629376)]} 0 0
   [junit4]   2> 842980 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[119 (1551731853415677952)]} 0 0
   [junit4]   2> 842982 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[120 (1551731853418823680)]} 0 0
   [junit4]   2> 842983 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[120 (1551731853419872256)]} 0 0
   [junit4]   2> 842985 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[121 (1551731853421969408)]} 0 0
   [junit4]   2> 842986 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[121 (1551731853423017984)]} 0 0
   [junit4]   2> 842988 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[122 (1551731853425115136)]} 0 0
   [junit4]   2> 842990 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[122 (1551731853426163712)]} 0 0
   [junit4]   2> 842991 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[123 (1551731853428260864)]} 0 0
   [junit4]   2> 842993 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[123 (1551731853430358016)]} 0 0
   [junit4]   2> 842994 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[124 (1551731853431406592)]} 0 0
   [junit4]   2> 842996 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[124 (1551731853433503744)]} 0 0
   [junit4]   2> 842997 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[125 (1551731853434552320)]} 0 0
   [junit4]   2> 842999 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[125 (1551731853436649472)]} 0 0
   [junit4]   2> 843000 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[126 (1551731853437698048)]} 0 0
   [junit4]   2> 843002 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[126 (1551731853439795200)]} 0 0
   [junit4]   2> 843004 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[127 (1551731853440843776)]} 0 0
   [junit4]   2> 843006 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[127 (1551731853443989504)]} 0 0
   [junit4]   2> 843007 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[128 (1551731853445038080)]} 0 0
   [junit4]   2> 843009 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[128 (1551731853447135232)]} 0 0
   [junit4]   2> 843010 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[129 (1551731853448183808)]} 0 0
   [junit4]   2> 843012 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[129 (1551731853450280960)]} 0 0
   [junit4]   2> 843014 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[130 (1551731853451329536)]} 0 0
   [junit4]   2> 843015 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[130 (1551731853453426688)]} 0 0
   [junit4]   2> 843017 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[131 (1551731853454475264)]} 0 0
   [junit4]   2> 843018 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[131 (1551731853456572416)]} 0 0
   [junit4]   2> 843020 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[132 (1551731853457620992)]} 0 0
   [junit4]   2> 843021 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[132 (1551731853459718144)]} 0 0
   [junit4]   2> 843023 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[133 (1551731853461815296)]} 0 0
   [junit4]   2> 843025 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[133 (1551731853462863872)]} 0 0
   [junit4]   2> 843026 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[134 (1551731853464961024)]} 0 0
   [junit4]   2> 843029 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[134 (1551731853468106752)]} 0 0
   [junit4]   2> 843030 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[135 (1551731853469155328)]} 0 0
   [junit4]   2> 843032 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[135 (1551731853471252480)]} 0 0
   [junit4]   2> 843033 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[136 (1551731853472301056)]} 0 0
   [junit4]   2> 843035 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[136 (1551731853474398208)]} 0 0
   [junit4]   2> 843036 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[137 (1551731853475446784)]} 0 0
   [junit4]   2> 843038 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[137 (1551731853477543936)]} 0 0
   [junit4]   2> 843040 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[138 (1551731853479641088)]} 0 0
   [junit4]   2> 843042 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[138 (1551731853481738240)]} 0 0
   [junit4]   2> 843044 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[139 (1551731853482786816)]} 0 0
   [junit4]   2> 843045 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[139 (1551731853484883968)]} 0 0
   [junit4]   2> 843047 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[140 (1551731853486981120)]} 0 0
   [junit4]   2> 843048 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[140 (1551731853488029696)]} 0 0
   [junit4]   2> 843050 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[141 (1551731853490126848)]} 0 0
   [junit4]   2> 843052 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[141 (1551731853491175424)]} 0 0
   [junit4]   2> 843054 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[142 (1551731853494321152)]} 0 0
   [junit4]   2> 843055 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[142 (1551731853495369728)]} 0 0
   [junit4]   2> 843057 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[143 (1551731853497466880)]} 0 0
   [junit4]   2> 843059 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[143 (1551731853498515456)]} 0 0
   [junit4]   2> 843060 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[144 (1551731853500612608)]} 0 0
   [junit4]   2> 843062 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[144 (1551731853502709760)]} 0 0
   [junit4]   2> 843063 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[145 (1551731853503758336)]} 0 0
   [junit4]   2> 843066 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[145 (1551731853505855488)]} 0 0
   [junit4]   2> 843067 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[146 (1551731853507952640)]} 0 0
   [junit4]   2> 843069 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[146 (1551731853510049792)]} 0 0
   [junit4]   2> 843070 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[147 (1551731853511098368)]} 0 0
   [junit4]   2> 843072 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[147 (1551731853513195520)]} 0 0
   [junit4]   2> 843073 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[148 (1551731853514244096)]} 0 0
   [junit4]   2> 843075 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[148 (1551731853516341248)]} 0 0
   [junit4]   2> 843077 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[149 (1551731853517389824)]} 0 0
   [junit4]   2> 843078 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[149 (1551731853519486976)]} 0 0
   [junit4]   2> 843079 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 843080 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1862b01
   [junit4]   2> 843084 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4d7ae0d[collection1] main]
   [junit4]   2> 843084 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 843084 INFO  (searcherExecutor-3407-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4d7ae0d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C9) Uninverting(_1(6.4.0):C59)))}
   [junit4]   2> 843084 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4
   [junit4]   2> 843086 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 843086 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3df9e5db
   [junit4]   2> 843090 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d567ee[collection1] main]
   [junit4]   2> 843090 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 843091 INFO  (searcherExecutor-3418-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1d567ee[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C9) Uninverting(_1(6.4.0):C59)))}
   [junit4]   2> 843091 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4
   [junit4]   2> 843093 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 843093 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 843094 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 843094 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 843096 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843102 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1|[ff01::114]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1479846814671&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843104 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814671&ids=13,102,125,5,148,16,139,10,142,131&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1|[ff01::114]:33332/|[ff01::083]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843105 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:38279//collection1|[ff01::114]:33332/|[ff01::083]:33332/&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=6
   [junit4]   2> 843107 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843110 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=http://127.0.0.1:38279//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1479846814681&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843112 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814681&ids=143,122,2,135,14,4,147,103,128,9&isShard=true&shard.url=http://127.0.0.1:38279//collection1|[ff01::213]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843113 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1|[ff01::213]:33332/&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843115 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843119 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814690&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843121 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814690&ids=132,133,100,125,5,104,107,130,142,131&isShard=true&shard.url=http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843121 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843123 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843127 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=http://127.0.0.1:38279//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1479846814699&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843129 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814699&ids=110,112,123,14,124,127,7,119,140,141&isShard=true&shard.url=http://127.0.0.1:38279//collection1|[ff01::083]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843130 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1|[ff01::083]:33332/&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843131 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843135 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814706&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843137 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814706&ids=121,12,16,137,138,17,116,1001,141,131&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843137 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843139 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843143 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814713&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843145 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814713&ids=132,100,136,103,147,115,127,7,107,120&isShard=true&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843146 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:38279//collection1&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 843147 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843151 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814723&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843153 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814723&ids=100,12,13,101,16,137,6,127,9,120&isShard=true&shard.url=http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843154 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843155 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843159 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=http://127.0.0.1:38279//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1479846814730&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843161 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814730&ids=110,114,17,105,139,1001,107,118,108,10&isShard=true&shard.url=http://127.0.0.1:38279//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843161 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1|[ff01::083]:33332/|[ff01::114]:33332/&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843163 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843166 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814737&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843168 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814737&ids=121,143,122,133,134,146,102,116,1001,139&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843169 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843170 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843174 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814745&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843176 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814745&ids=110,114,4,147,126,149,129,119,130,142&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843176 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843178 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843181 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814753&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843183 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814753&ids=143,122,124,103,114,136,104,126,17,138&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843183 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:38279//collection1&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843186 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843189 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+asc&shard.url=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1479846814761&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843191 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814761&ids=2,112,102,125,139,1001,8,130,120,142&isShard=true&shard.url=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843191 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843193 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843199 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814768&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843201 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814768&ids=110,135,14,137,6,17,149,108,119,141&isShard=true&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843201 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:38279//collection1&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=6
   [junit4]   2> 843203 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843206 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=[ff01::114]:33332/|http://127.0.0.1:38279//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1479846814778&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843208 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814778&ids=11,1,122,134,136,103,126,139,118,140&isShard=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:38279//collection1|[ff01::083]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843209 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|http://127.0.0.1:38279//collection1|[ff01::083]:33332/&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843211 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843214 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+desc&shard.url=http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814785&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843216 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814785&ids=121,133,5,104,127,106,8,9,119,141&isShard=true&shard.url=http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843216 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1&sort=n_dt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843218 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843222 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=[ff01::083]:33332/|http://127.0.0.1:38279//collection1|[ff01::213]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1479846814793&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843223 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814793&ids=143,110,111,100,146,102,136,126,1001,7&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:38279//collection1|[ff01::213]:33332/|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843224 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:38279//collection1|[ff01::213]:33332/|[ff01::114]:33332/&sort=n_dt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843226 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843229 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+desc&shard.url=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1479846814801&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843231 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814801&ids=110,3,104,105,149,1001,128,129,140,142&isShard=true&shard.url=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843232 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843234 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843237 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+asc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814809&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843239 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814809&ids=143,122,144,2,134,113,136,148,117,120&isShard=true&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843240 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:38279//collection1&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843242 INFO  (qtp1957155870-7317) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=a_i1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843245 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i1+desc&shard.url=http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814817&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843247 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814817&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843248 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1&sort=a_i1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843251 INFO  (qtp1957155870-7322) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort={!func}testfunc(add(a_i1,5))+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843254 INFO  (qtp11517917-7339) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort={!func}testfunc(add(a_i1,5))+desc&shard.url=http://127.0.0.1:38279//collection1&rows=10&version=2&q=*:*&NOW=1479846814825&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843256 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814825&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=http://127.0.0.1:38279//collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843256 INFO  (qtp11517917-7335) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1&sort={!func}testfunc(add(a_i1,5))+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 843258 INFO  (qtp1957155870-7323) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=a_i1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 843262 INFO  (qtp11517917-7340) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i1+asc&shard.url=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1479846814833&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 843263 INFO  (qtp11517917-7341) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1479846814833&ids=11,12,1,13,2,3,4,6,7,9&isShard=true&shard.url=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 843264 INFO  (qtp11517917-7334) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:38279//collection1|[ff01::114]:33332/&sort=a_i1+asc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 843266 INFO  (qtp1957155870-7324) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&fl=*,score&sort=a_i1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   

[...truncated too long message...]

53FBE71F]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1482693342
   [junit4]   2> 908802 INFO  (coreCloseExecutor-3462-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@994ed5c
   [junit4]   2> 908813 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4bec4864{/,null,UNAVAILABLE}
   [junit4]   2> 908814 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@1ec98890{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 908814 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=370741651
   [junit4]   2> 908815 INFO  (coreCloseExecutor-3464-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4c0c95b6
   [junit4]   2> 908825 INFO  (TEST-TestDistributedSearch.test-seed#[AA7F2E7453FBE71F]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@61b56c54{/,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedSearch -Dtests.method=test -Dtests.seed=AA7F2E7453FBE71F -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=pt-PT -Dtests.timezone=Europe/Ljubljana -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   67.1s J1 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:42276//collection1: java.lang.NullPointerException
   [junit4]    > 	at org.apache.solr.search.grouping.distributed.responseprocessor.StoredFieldsShardResponseProcessor.process(StoredFieldsShardResponseProcessor.java:41)
   [junit4]    > 	at org.apache.solr.handler.component.QueryComponent.handleGroupedResponses(QueryComponent.java:756)
   [junit4]    > 	at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:739)
   [junit4]    > 	at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:428)
   [junit4]    > 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
   [junit4]    > 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2210)
   [junit4]    > 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)
   [junit4]    > 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:464)
   [junit4]    > 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
   [junit4]    > 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
   [junit4]    > 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)
   [junit4]    > 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
   [junit4]    > 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)
   [junit4]    > 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
   [junit4]    > 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]    > 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160)
   [junit4]    > 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
   [junit4]    > 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]    > 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092)
   [junit4]    > 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]    > 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)
   [junit4]    > 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]    > 	at org.eclipse.jetty.server.Server.handle(Server.java:518)
   [junit4]    > 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308)
   [junit4]    > 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244)
   [junit4]    > 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]    > 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]    > 	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]    > 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246)
   [junit4]    > 	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156)
   [junit4]    > 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
   [junit4]    > 	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([AA7F2E7453FBE71F:222B11AEFD078AE7]:0)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:593)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:957)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.queryRandomUpServer(TestDistributedSearch.java:1139)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1101)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:963)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1018)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 908828 INFO  (SUITE-TestDistributedSearch-seed#[AA7F2E7453FBE71F]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_AA7F2E7453FBE71F-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=pt-PT, timezone=Europe/Ljubljana
   [junit4]   2> NOTE: Linux 4.4.0-47-generic amd64/Oracle Corporation 1.8.0_102 (64-bit)/cpus=12,threads=1,free=187335584,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestLRUCache, DeleteStatusTest, TestCursorMarkWithoutUniqueKey, HdfsCollectionsAPIDistributedZkTest, SearchHandlerTest, TestTrie, TestTolerantUpdateProcessorCloud, SimpleMLTQParserTest, TestDocBasedVersionConstraints, BJQParserTest, CursorMarkTest, SuggesterFSTTest, DateMathParserTest, TestSweetSpotSimilarityFactory, TestUniqueKeyFieldResource, SchemaVersionSpecificBehaviorTest, RAMDirectoryFactoryTest, SimplePostToolTest, DeleteNodeTest, RemoteQueryErrorTest, TestSerializedLuceneMatchVersion, TestSimpleTrackingShardHandler, TestSubQueryTransformerDistrib, CdcrReplicationHandlerTest, TestNonDefinedSimilarityFactory, TestNRTOpen, TestMacros, AliasIntegrationTest, HdfsLockFactoryTest, TestCorePropertiesReload, ConvertedLegacyTest, DocValuesTest, TestReRankQParserPlugin, ClusterStateUpdateTest, TestMinMaxOnMultiValuedField, ChaosMonkeySafeLeaderTest, TestSolr4Spatial2, TestHashQParserPlugin, QueryResultKeyTest, ZkSolrClientTest, SampleTest, TestDistributedGrouping, DistributedMLTComponentTest, TestFreeTextSuggestions, TestCSVResponseWriter, TestConfigSetsAPIZkFailure, HLLSerializationTest, ShardRoutingTest, DistributedFacetPivotLongTailTest, IndexBasedSpellCheckerTest, TestStressUserVersions, WordBreakSolrSpellCheckerTest, CollectionsAPIAsyncDistributedZkTest, SolrCmdDistributorTest, OutOfBoxZkACLAndCredentialsProvidersTest, PreAnalyzedFieldManagedSchemaCloudTest, IndexSchemaRuntimeFieldTest, DirectSolrSpellCheckerTest, HdfsThreadLeakTest, TestConfigSetImmutable, ZkControllerTest, MoreLikeThisHandlerTest, DocumentBuilderTest, TestQueryTypes, TestSchemaResource, TestMissingGroups, TestCollapseQParserPlugin, TestQueryUtils, CustomCollectionTest, SortByFunctionTest, SpellingQueryConverterTest, URLClassifyProcessorTest, SolrInfoMBeanTest, HighlighterMaxOffsetTest, LoggingHandlerTest, CdcrUpdateLogTest, TestPKIAuthenticationPlugin, BadCopyFieldTest, TestDistribDocBasedVersion, VersionInfoTest, CSVRequestHandlerTest, TestJettySolrRunner, TestImplicitCoreProperties, SpellCheckCollatorTest, LeaderInitiatedRecoveryOnShardRestartTest, OverseerModifyCollectionTest, TestDynamicFieldResource, TestFieldCacheReopen, CheckHdfsIndexTest, TestUninvertingReader, SaslZkACLProviderTest, HttpSolrCallGetCoreTest, CollectionsAPIDistributedZkTest, TestQuerySenderListener, ZkStateReaderTest, SpatialFilterTest, UtilsToolTest, TestSearchPerf, TestFastOutputStream, TestManagedSchemaThreadSafety, DistanceFunctionTest, SolrIndexSplitterTest, TestSolrCloudWithSecureImpersonation, TriLevelCompositeIdRoutingTest, TestSuggestSpellingConverter, TestFieldCacheSortRandom, BaseCdcrDistributedZkTest, BasicDistributedZkTest, UnloadDistributedZkTest, OpenCloseCoreStressTest, BasicZkTest, RecoveryZkTest, TestRandomFaceting, ZkCLITest, ShardRoutingCustomTest, TestDistributedSearch]
   [junit4] Completed [348/655 (1!)] on J1 in 67.16s, 1 test, 1 error <<< FAILURES!

[...truncated 61706 lines...]


Mime
View raw message