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 (32bit/jdk1.8.0_121) - Build # 2976 - Unstable!
Date Thu, 02 Mar 2017 04:59:19 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/2976/
Java: 32bit/jdk1.8.0_121 -server -XX:+UseSerialGC

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

Error Message:
Timeout occured while waiting response from server at: http://127.0.0.1:37002/aeoo/collection1

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:37002/aeoo/collection1
	at __randomizedtesting.SeedInfo.seed([540414553544FB1C:DC502B8F9BB896E4]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:621)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
	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:1153)
	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1115)
	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:959)
	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:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	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:368)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.net.SocketTimeoutException: Read timed out
	at java.net.SocketInputStream.socketRead0(Native Method)
	at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
	at java.net.SocketInputStream.read(SocketInputStream.java:171)
	at java.net.SocketInputStream.read(SocketInputStream.java:141)
	at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
	at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
	at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
	at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
	at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
	at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
	at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
	at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
	at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:515)
	... 49 more




Build Log:
[...truncated 12505 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/init-core-data-001
   [junit4]   2> 1314750 INFO  (SUITE-TestDistributedSearch-seed#[540414553544FB1C]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields
   [junit4]   2> 1314751 INFO  (SUITE-TestDistributedSearch-seed#[540414553544FB1C]-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> 1314752 INFO  (SUITE-TestDistributedSearch-seed#[540414553544FB1C]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /aeoo/
   [junit4]   2> 1315134 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1315135 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1315136 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a6bcde{/aeoo,null,AVAILABLE}
   [junit4]   2> 1315136 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@a09449{HTTP/1.1,[http/1.1]}{127.0.0.1:34797}
   [junit4]   2> 1315137 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.Server Started @1317022ms
   [junit4]   2> 1315137 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/aeoo, hostPort=34797, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/control/cores}
   [junit4]   2> 1315137 ERROR (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1315137 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.5.0
   [junit4]   2> 1315137 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 1315137 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1315137 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-03-02T04:34:12.352Z
   [junit4]   2> 1315137 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/control/solr.xml
   [junit4]   2> 1315149 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1315174 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/control/cores
   [junit4]   2> 1315174 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1315175 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] 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> 1315215 WARN  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1315216 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 1315235 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1315301 WARN  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1315303 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1315319 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] 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> 1315319 INFO  (coreLoadExecutor-4662-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/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1315319 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5c789d
   [junit4]   2> 1315320 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@92ddf5
   [junit4]   2> 1315355 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1315355 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1315356 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1315356 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1315356 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=30.787109375, floorSegmentMB=1.2802734375, forceMergeDeletesPctAllowed=0.1250483821548487, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5698579827617651
   [junit4]   2> 1315356 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e797ca[collection1] main]
   [junit4]   2> 1315357 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1315826 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1316214 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1316214 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1316214 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1316214 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1316214 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1316214 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1316215 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1316215 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1316215 INFO  (coreLoadExecutor-4662-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1560731192844615680
   [junit4]   2> 1316215 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1316215 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1316217 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e797ca[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316536 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 1316536 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1316537 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3b5d03{/aeoo,null,AVAILABLE}
   [junit4]   2> 1316537 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1212465{HTTP/1.1,[http/1.1]}{127.0.0.1:45169}
   [junit4]   2> 1316538 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.Server Started @1318423ms
   [junit4]   2> 1316538 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/aeoo, hostPort=45169, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/shard0/cores}
   [junit4]   2> 1316538 ERROR (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1316538 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.5.0
   [junit4]   2> 1316538 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 1316538 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1316538 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-03-02T04:34:13.753Z
   [junit4]   2> 1316539 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 1316544 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1316562 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/shard0/cores
   [junit4]   2> 1316562 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1316563 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] 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> 1316584 WARN  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1316585 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 1316614 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1316739 WARN  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1316742 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1316749 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] 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> 1316750 INFO  (coreLoadExecutor-4673-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/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 1316750 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5c789d
   [junit4]   2> 1316751 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@d333e0
   [junit4]   2> 1316810 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1316810 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1316810 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1316810 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1316811 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=30.787109375, floorSegmentMB=1.2802734375, forceMergeDeletesPctAllowed=0.1250483821548487, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5698579827617651
   [junit4]   2> 1316811 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6d9e48[collection1] main]
   [junit4]   2> 1316811 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1316836 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1316973 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1316974 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1316974 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1316974 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1316974 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1316974 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1316974 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1316974 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1316975 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1316975 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1316975 INFO  (coreLoadExecutor-4673-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1560731193641533440
   [junit4]   2> 1316978 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6d9e48[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1317492 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1317495 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1560731194184695808)} 0 1
   [junit4]   2> 1317497 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1560731194186792960)} 0 1
   [junit4]   2> 1317500 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[1 (1560731194189938688)]} 0 1
   [junit4]   2> 1317502 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[1 (1560731194193084416)]} 0 0
   [junit4]   2> 1317504 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[2 (1560731194195181568)]} 0 0
   [junit4]   2> 1317506 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[2 (1560731194197278720)]} 0 0
   [junit4]   2> 1317507 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[3 (1560731194199375872)]} 0 0
   [junit4]   2> 1317509 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[3 (1560731194201473024)]} 0 0
   [junit4]   2> 1317511 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[4 (1560731194202521600)]} 0 0
   [junit4]   2> 1317513 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[4 (1560731194205667328)]} 0 0
   [junit4]   2> 1317515 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[5 (1560731194207764480)]} 0 0
   [junit4]   2> 1317517 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[5 (1560731194208813056)]} 0 0
   [junit4]   2> 1317518 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[6 (1560731194210910208)]} 0 0
   [junit4]   2> 1317520 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[6 (1560731194213007360)]} 0 0
   [junit4]   2> 1317521 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[7 (1560731194214055936)]} 0 0
   [junit4]   2> 1317523 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[7 (1560731194216153088)]} 0 0
   [junit4]   2> 1317525 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[8 (1560731194218250240)]} 0 0
   [junit4]   2> 1317527 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[8 (1560731194220347392)]} 0 0
   [junit4]   2> 1317529 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[9 (1560731194222444544)]} 0 0
   [junit4]   2> 1317531 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[9 (1560731194223493120)]} 0 0
   [junit4]   2> 1317532 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1317532 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1bd9132
   [junit4]   2> 1317541 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@180eb0[collection1] main]
   [junit4]   2> 1317541 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1317542 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@180eb0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):C9)))}
   [junit4]   2> 1317542 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 10
   [junit4]   2> 1317544 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1317544 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@131e98a
   [junit4]   2> 1317550 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@15f82c2[collection1] main]
   [junit4]   2> 1317551 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1317552 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15f82c2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):C9)))}
   [junit4]   2> 1317553 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 8
   [junit4]   2> 1317557 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[10 (1560731194248658944)]} 0 2
   [junit4]   2> 1317560 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[10 (1560731194252853248)]} 0 1
   [junit4]   2> 1317562 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[11 (1560731194255998976)]} 0 1
   [junit4]   2> 1317564 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[11 (1560731194259144704)]} 0 0
   [junit4]   2> 1317566 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[12 (1560731194261241856)]} 0 0
   [junit4]   2> 1317568 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[12 (1560731194263339008)]} 0 0
   [junit4]   2> 1317570 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[13 (1560731194265436160)]} 0 0
   [junit4]   2> 1317572 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[13 (1560731194267533312)]} 0 0
   [junit4]   2> 1317574 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[1001 (1560731194269630464)]} 0 0
   [junit4]   2> 1317577 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[1001 (1560731194271727616)]} 0 0
   [junit4]   2> 1317578 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[14 (1560731194273824768)]} 0 0
   [junit4]   2> 1317580 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[14 (1560731194275921920)]} 0 0
   [junit4]   2> 1317582 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[15 (1560731194278019072)]} 0 0
   [junit4]   2> 1317583 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[15 (1560731194279067648)]} 0 0
   [junit4]   2> 1317585 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[16 (1560731194281164800)]} 0 0
   [junit4]   2> 1317586 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[16 (1560731194282213376)]} 0 0
   [junit4]   2> 1317589 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[17 (1560731194284310528)]} 0 0
   [junit4]   2> 1317591 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[17 (1560731194286407680)]} 0 0
   [junit4]   2> 1317592 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[100 (1560731194288504832)]} 0 0
   [junit4]   2> 1317594 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[100 (1560731194290601984)]} 0 0
   [junit4]   2> 1317595 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[101 (1560731194291650560)]} 0 0
   [junit4]   2> 1317598 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[101 (1560731194293747712)]} 0 0
   [junit4]   2> 1317599 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[102 (1560731194295844864)]} 0 0
   [junit4]   2> 1317601 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[102 (1560731194297942016)]} 0 0
   [junit4]   2> 1317603 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[103 (1560731194298990592)]} 0 0
   [junit4]   2> 1317604 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[103 (1560731194301087744)]} 0 0
   [junit4]   2> 1317606 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[104 (1560731194303184896)]} 0 0
   [junit4]   2> 1317608 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[104 (1560731194304233472)]} 0 0
   [junit4]   2> 1317610 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[105 (1560731194306330624)]} 0 0
   [junit4]   2> 1317611 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[105 (1560731194308427776)]} 0 0
   [junit4]   2> 1317613 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[106 (1560731194310524928)]} 0 0
   [junit4]   2> 1317615 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[106 (1560731194311573504)]} 0 0
   [junit4]   2> 1317616 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[107 (1560731194313670656)]} 0 0
   [junit4]   2> 1317618 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[107 (1560731194315767808)]} 0 0
   [junit4]   2> 1317619 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[108 (1560731194316816384)]} 0 0
   [junit4]   2> 1317622 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[108 (1560731194318913536)]} 0 0
   [junit4]   2> 1317623 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[109 (1560731194321010688)]} 0 0
   [junit4]   2> 1317625 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[109 (1560731194323107840)]} 0 0
   [junit4]   2> 1317626 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[110 (1560731194324156416)]} 0 0
   [junit4]   2> 1317628 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[110 (1560731194326253568)]} 0 0
   [junit4]   2> 1317630 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[111 (1560731194328350720)]} 0 0
   [junit4]   2> 1317631 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[111 (1560731194329399296)]} 0 0
   [junit4]   2> 1317634 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[112 (1560731194331496448)]} 0 0
   [junit4]   2> 1317635 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[112 (1560731194333593600)]} 0 0
   [junit4]   2> 1317637 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[113 (1560731194335690752)]} 0 0
   [junit4]   2> 1317638 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[113 (1560731194336739328)]} 0 0
   [junit4]   2> 1317640 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[114 (1560731194338836480)]} 0 0
   [junit4]   2> 1317642 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[114 (1560731194339885056)]} 0 0
   [junit4]   2> 1317643 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[115 (1560731194341982208)]} 0 0
   [junit4]   2> 1317645 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[115 (1560731194344079360)]} 0 0
   [junit4]   2> 1317647 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[116 (1560731194345127936)]} 0 0
   [junit4]   2> 1317648 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[116 (1560731194347225088)]} 0 0
   [junit4]   2> 1317650 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[117 (1560731194349322240)]} 0 0
   [junit4]   2> 1317652 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[117 (1560731194351419392)]} 0 0
   [junit4]   2> 1317653 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[118 (1560731194352467968)]} 0 0
   [junit4]   2> 1317655 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[118 (1560731194354565120)]} 0 0
   [junit4]   2> 1317658 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[119 (1560731194356662272)]} 0 0
   [junit4]   2> 1317659 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[119 (1560731194358759424)]} 0 0
   [junit4]   2> 1317661 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[120 (1560731194360856576)]} 0 0
   [junit4]   2> 1317662 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[120 (1560731194361905152)]} 0 0
   [junit4]   2> 1317664 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[121 (1560731194364002304)]} 0 0
   [junit4]   2> 1317666 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[121 (1560731194365050880)]} 0 0
   [junit4]   2> 1317667 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[122 (1560731194367148032)]} 0 0
   [junit4]   2> 1317670 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[122 (1560731194369245184)]} 0 0
   [junit4]   2> 1317671 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[123 (1560731194371342336)]} 0 0
   [junit4]   2> 1317678 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[123 (1560731194377633792)]} 0 0
   [junit4]   2> 1317679 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[124 (1560731194379730944)]} 0 0
   [junit4]   2> 1317682 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[124 (1560731194381828096)]} 0 0
   [junit4]   2> 1317683 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[125 (1560731194383925248)]} 0 0
   [junit4]   2> 1317685 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[125 (1560731194386022400)]} 0 0
   [junit4]   2> 1317686 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[126 (1560731194387070976)]} 0 0
   [junit4]   2> 1317688 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[126 (1560731194389168128)]} 0 0
   [junit4]   2> 1317689 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[127 (1560731194390216704)]} 0 0
   [junit4]   2> 1317691 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[127 (1560731194392313856)]} 0 0
   [junit4]   2> 1317693 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[128 (1560731194393362432)]} 0 1
   [junit4]   2> 1317695 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[128 (1560731194396508160)]} 0 0
   [junit4]   2> 1317697 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[129 (1560731194397556736)]} 0 0
   [junit4]   2> 1317698 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[129 (1560731194399653888)]} 0 0
   [junit4]   2> 1317700 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[130 (1560731194401751040)]} 0 0
   [junit4]   2> 1317701 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[130 (1560731194402799616)]} 0 0
   [junit4]   2> 1317703 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[131 (1560731194404896768)]} 0 0
   [junit4]   2> 1317706 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[131 (1560731194406993920)]} 0 0
   [junit4]   2> 1317707 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[132 (1560731194409091072)]} 0 0
   [junit4]   2> 1317709 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[132 (1560731194411188224)]} 0 0
   [junit4]   2> 1317711 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[133 (1560731194412236800)]} 0 0
   [junit4]   2> 1317712 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[133 (1560731194414333952)]} 0 0
   [junit4]   2> 1317714 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[134 (1560731194416431104)]} 0 0
   [junit4]   2> 1317715 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[134 (1560731194417479680)]} 0 0
   [junit4]   2> 1317717 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[135 (1560731194419576832)]} 0 0
   [junit4]   2> 1317719 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[135 (1560731194421673984)]} 0 0
   [junit4]   2> 1317720 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[136 (1560731194422722560)]} 0 0
   [junit4]   2> 1317722 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[136 (1560731194424819712)]} 0 0
   [junit4]   2> 1317724 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[137 (1560731194426916864)]} 0 0
   [junit4]   2> 1317726 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[137 (1560731194427965440)]} 0 0
   [junit4]   2> 1317727 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[138 (1560731194430062592)]} 0 0
   [junit4]   2> 1317729 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[138 (1560731194432159744)]} 0 0
   [junit4]   2> 1317731 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[139 (1560731194434256896)]} 0 0
   [junit4]   2> 1317733 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[139 (1560731194435305472)]} 0 0
   [junit4]   2> 1317734 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[140 (1560731194437402624)]} 0 0
   [junit4]   2> 1317736 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[140 (1560731194439499776)]} 0 0
   [junit4]   2> 1317738 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[141 (1560731194440548352)]} 0 0
   [junit4]   2> 1317739 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[141 (1560731194442645504)]} 0 0
   [junit4]   2> 1317741 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[142 (1560731194444742656)]} 0 0
   [junit4]   2> 1317743 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[142 (1560731194446839808)]} 0 0
   [junit4]   2> 1317745 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[143 (1560731194447888384)]} 0 0
   [junit4]   2> 1317746 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[143 (1560731194449985536)]} 0 0
   [junit4]   2> 1317748 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[144 (1560731194452082688)]} 0 0
   [junit4]   2> 1317749 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[144 (1560731194453131264)]} 0 0
   [junit4]   2> 1317751 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[145 (1560731194455228416)]} 0 0
   [junit4]   2> 1317753 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[145 (1560731194457325568)]} 0 0
   [junit4]   2> 1317755 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[146 (1560731194459422720)]} 0 0
   [junit4]   2> 1317758 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[146 (1560731194462568448)]} 0 0
   [junit4]   2> 1317760 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[147 (1560731194464665600)]} 0 0
   [junit4]   2> 1317762 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[147 (1560731194465714176)]} 0 0
   [junit4]   2> 1317763 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[148 (1560731194467811328)]} 0 0
   [junit4]   2> 1317765 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[148 (1560731194469908480)]} 0 0
   [junit4]   2> 1317767 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[149 (1560731194472005632)]} 0 0
   [junit4]   2> 1317768 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={wt=javabin&version=2}{add=[149 (1560731194473054208)]} 0 0
   [junit4]   2> 1317770 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1317770 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1bd9132
   [junit4]   2> 1317783 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3e152d[collection1] main]
   [junit4]   2> 1317784 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1317786 INFO  (searcherExecutor-4663-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3e152d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):C9) Uninverting(_1(6.5.0):C59)))}
   [junit4]   2> 1317786 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 16
   [junit4]   2> 1317788 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1317788 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@131e98a
   [junit4]   2> 1317816 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@514c71[collection1] main]
   [junit4]   2> 1317818 INFO  (searcherExecutor-4674-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@514c71[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):C9) Uninverting(_1(6.5.0):C59)))}
   [junit4]   2> 1317819 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1317819 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aeoo path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 31
   [junit4]   2> 1317821 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 1317821 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 1317823 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 1317823 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 1317825 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317830 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo&rows=10&version=2&q=*:*&NOW=1488429255043&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317832 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255043&ids=110,1,134,124,14,5,7,117,140,130&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317833 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 1317835 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317841 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo&rows=10&version=2&q=*:*&NOW=1488429255052&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317844 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255052&ids=122,112,146,102,3,114,115,105,127,1001&isShard=true&shard.url=[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317844 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=6
   [junit4]   2> 1317846 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317850 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo 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:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255063&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317852 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255063&ids=132,110,125,104,16,115,7,1001,107,119&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317853 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317855 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317863 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255072&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317866 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255072&ids=111,133,102,113,136,148,8,141,120,142&isShard=true&shard.url=[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317867 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=10
   [junit4]   2> 1317869 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317873 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255086&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317875 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255086&ids=132,100,1,123,145,113,102,148,117,140&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317876 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317878 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317881 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=[ff01::083]:33332/aeoo|[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255095&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317883 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255095&ids=143,12,146,4,15,104,138,116,9,120&isShard=true&shard.url=[ff01::083]:33332/aeoo|[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317884 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::083]:33332/aeoo|[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317886 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317891 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo 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:45169/aeoo/collection1|[ff01::213]:33332/aeoo&rows=10&version=2&q=*:*&NOW=1488429255103&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317892 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255103&ids=11,102,15,148,116,7,106,117,108,141&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317893 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 1317895 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317899 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255112&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317901 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255112&ids=12,123,145,13,124,137,115,1001,128,118&isShard=true&shard.url=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317902 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317904 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317907 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo&rows=10&version=2&q=*:*&NOW=1488429255121&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317909 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255121&ids=121,144,134,113,15,136,104,139,129,9&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317931 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo|[ff01::213]:33332/aeoo&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=25
   [junit4]   2> 1317933 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317937 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=[ff01::213]:33332/aeoo|[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::114]:33332/aeoo&rows=10&version=2&q=*:*&NOW=1488429255150&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317938 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255150&ids=122,112,135,114,126,16,128,108,140,141&isShard=true&shard.url=[ff01::213]:33332/aeoo|[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::114]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317939 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::213]:33332/aeoo|[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::114]:33332/aeoo&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317941 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317945 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[ff01::083]:33332/aeoo|[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255158&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317947 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255158&ids=122,101,13,14,116,149,127,117,130,10&isShard=true&shard.url=[ff01::083]:33332/aeoo|[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317948 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::083]:33332/aeoo|[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 1317950 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317953 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+asc&shard.url=[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255167&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317955 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255167&ids=132,112,146,3,136,103,15,16,126,17&isShard=true&shard.url=[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317956 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317958 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317962 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255175&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317964 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255175&ids=144,122,13,148,6,107,108,140,130,131&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317965 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317967 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317971 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo&rows=10&version=2&q=*:*&NOW=1488429255184&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317972 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255184&ids=11,133,102,3,15,137,7,139,118,129&isShard=true&shard.url=[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317973 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::083]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317975 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317979 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo 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:45169/aeoo/collection1|[ff01::114]:33332/aeoo&rows=10&version=2&q=*:*&NOW=1488429255192&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317981 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255192&ids=143,144,2,101,135,115,104,149,6,128&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1|[ff01::114]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317982 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1|[ff01::114]:33332/aeoo&sort=n_dt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 1317985 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317988 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255202&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317990 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255202&ids=102,103,15,136,17,117,1001,118,108,140&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317991 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1&sort=n_dt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1317993 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1317997 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo 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:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255210&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1317999 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255210&ids=132,111,13,104,126,17,127,128,108,9&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1317999 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1318001 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1318005 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+asc&shard.url=[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255218&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1318007 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255218&ids=102,146,124,4,148,137,6,1001,140,130&isShard=true&shard.url=[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1318008 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::114]:33332/aeoo|[ff01::213]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1318010 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=a_i_ni_p+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1318014 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_ni_p+desc&shard.url=[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255227&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1318016 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255227&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1318017 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::213]:33332/aeoo|[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&sort=a_i_ni_p+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1318020 INFO  (qtp15105467-9267) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort={!func}testfunc(add(a_i_ni_p,5))+desc&wt=javabin&version=2} hits=68 status=0 QTime=1
   [junit4]   2> 1318024 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort={!func}testfunc(add(a_i_ni_p,5))+desc&shard.url=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo&rows=10&version=2&q=*:*&NOW=1488429255237&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1318026 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255237&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1318026 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=http://127.0.0.1:45169/aeoo/collection1|[ff01::083]:33332/aeoo&sort={!func}testfunc(add(a_i_ni_p,5))+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 1318036 INFO  (qtp15105467-9272) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=a_i_ni_p[*+TO+*]&distrib=false&sort=a_i_ni_p+asc&wt=javabin&version=2} hits=13 status=0 QTime=6
   [junit4]   2> 1318041 INFO  (qtp1732998-9285) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_ni_p+asc&shard.url=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo&rows=10&version=2&q=a_i_ni_p[*+TO+*]&NOW=1488429255253&isShard=true&wt=javabin} hits=13 status=0 QTime=1
   [junit4]   2> 1318044 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=a_i_ni_p[*+TO+*]&distrib=false&shards.purpose=64&NOW=1488429255253&ids=11,12,1,13,2,3,4,6,7,9&isShard=true&shard.url=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1318044 INFO  (qtp1732998-9284) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=a_i_ni_p[*+TO+*]&shards=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1|[ff01::213]:33332/aeoo&sort=a_i_ni_p+asc&wt=javabin&version=2} hits=13 status=0 QTime=6
   [junit4]   2> 1318048 INFO  (qtp15105467-9274) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&sort=a_i_ni_p+asc,+id+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 1318052 INFO  (qtp1732998-9290) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_ni_p+asc,+id+desc&shard.url=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&rows=10&version=2&q=*:*&NOW=1488429255265&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 1318055 INFO  (qtp1732998-9291) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1488429255265&ids=11,144,145,146,147,4,148,149,6,1001&isShard=true&shard.url=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1318055 INFO  (qtp1732998-9289) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&shards=[ff01::114]:33332/aeoo|http://127.0.0.1:45169/aeoo/collection1&sort=a_i_ni_p+asc,+id+desc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 1318058 INFO  (qtp15105467-9273) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/aeoo path=/select params={q=*:*&distrib=false&fl=*,score&

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

ric reporters for: solr.node
   [junit4]   2> 1515057 INFO  (TEST-TestDistributedSearch.test-seed#[540414553544FB1C]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@19de0d0{/aeoo,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedSearch -Dtests.method=test -Dtests.seed=540414553544FB1C -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr -Dtests.timezone=America/Yakutat -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR    200s J2 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:37002/aeoo/collection1
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([540414553544FB1C:DC502B8F9BB896E4]:0)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:621)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
   [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:1153)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1115)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:959)
   [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]    > Caused by: java.net.SocketTimeoutException: Read timed out
   [junit4]    > 	at java.net.SocketInputStream.socketRead0(Native Method)
   [junit4]    > 	at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
   [junit4]    > 	at java.net.SocketInputStream.read(SocketInputStream.java:171)
   [junit4]    > 	at java.net.SocketInputStream.read(SocketInputStream.java:141)
   [junit4]    > 	at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
   [junit4]    > 	at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
   [junit4]    > 	at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
   [junit4]    > 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
   [junit4]    > 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
   [junit4]    > 	at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
   [junit4]    > 	at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
   [junit4]    > 	at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
   [junit4]    > 	at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
   [junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
   [junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
   [junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
   [junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
   [junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
   [junit4]    > 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]    > 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:515)
   [junit4]    > 	... 49 more
   [junit4]   2> 1515061 INFO  (SUITE-TestDistributedSearch-seed#[540414553544FB1C]-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/J2/temp/solr.TestDistributedSearch_540414553544FB1C-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): {severity=PostingsFormat(name=MockRandom), other_tl1=PostingsFormat(name=Direct), foo_sev_enum=PostingsFormat(name=MockRandom), SubjectTerms_mfacet=PostingsFormat(name=Direct), a_n_tdt=PostingsFormat(name=MockRandom), multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), n_dt1=PostingsFormat(name=Direct), n_td1=PostingsFormat(name=Direct), b_n_tdt=PostingsFormat(name=Direct), n_ti1=Lucene50(blocksize=128), rnd_b=Lucene50(blocksize=128), n_tl1=PostingsFormat(name=Direct), a_s=PostingsFormat(name=MockRandom), oddField_s=Lucene50(blocksize=128), n_tf1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), lowerfilt1and2=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), a_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), foo_b=PostingsFormat(name=MockRandom), n_tdt1=PostingsFormat(name=Direct), lowerfilt=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), id=Lucene50(blocksize=128), text=PostingsFormat(name=MockRandom), timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54), foo_sev_enum=DocValuesFormat(name=Lucene54), n_l1=DocValuesFormat(name=Direct), intDefault=DocValuesFormat(name=Asserting), n_d1=DocValuesFormat(name=Direct), range_facet_l=DocValuesFormat(name=Direct), n_f1=DocValuesFormat(name=Asserting), _version_=DocValuesFormat(name=Asserting), foo_d=DocValuesFormat(name=Lucene54), range_facet_i_dv=DocValuesFormat(name=Direct), foo_f=DocValuesFormat(name=Lucene54), intDvoDefault=DocValuesFormat(name=Lucene54), a_i_ni_p=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1238, maxMBSortInHeap=7.225931616340011, sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=fr, timezone=America/Yakutat
   [junit4]   2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation 1.8.0_121 (32-bit)/cpus=12,threads=1,free=65309648,total=356548608
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrCoreSnapshots, TestFreeTextSuggestions, TestWriterPerf, BadComponentTest, RequestHandlersTest, MinimalSchemaTest, HdfsRestartWhileUpdatingTest, DeleteShardTest, CdcrVersionReplicationTest, TestEmbeddedSolrServerSchemaAPI, PingRequestHandlerTest, OpenExchangeRatesOrgProviderTest, ZkStateWriterTest, TestSolrJ, CircularListTest, CreateCollectionCleanupTest, TestSolrDeletionPolicy1, GraphQueryTest, TestDFRSimilarityFactory, HdfsChaosMonkeyNothingIsSafeTest, TestSQLHandlerNonCloud, CdcrUpdateLogTest, TestCloudDeleteByQuery, DocValuesMultiTest, BlockDirectoryTest, SolrCloudExampleTest, DistributedFacetPivotLongTailTest, TestReqParamsAPI, TestDistributedMissingSort, ClassificationUpdateProcessorTest, TestJmxMonitoredMap, AtomicUpdatesTest, DirectUpdateHandlerOptimizeTest, TestPostingsSolrHighlighter, TestSolrDynamicMBean, DirectUpdateHandlerTest, TestShortCircuitedRequests, SpatialRPTFieldTypeTest, HttpPartitionTest, TestRecovery, TestOnReconnectListenerSupport, SuggestComponentContextFilterQueryTest, UpdateLogTest, TestUtils, TimeZoneUtilsTest, TestTolerantSearch, DOMUtilTest, TestPKIAuthenticationPlugin, TestSolrCloudWithKerberosAlt, TestCollectionAPI, TestClassNameShortening, CdcrReplicationDistributedZkTest, QueryParsingTest, CloudExitableDirectoryReaderTest, TestManagedSchema, TestAnalyzeInfixSuggestions, TestSubQueryTransformerCrossCore, TestSolrFieldCacheMBean, TestZkChroot, CurrencyFieldXmlFileTest, TestConfigsApi, HdfsLockFactoryTest, TestLegacyFieldCache, TestGraphTermsQParserPlugin, TestTrieFacet, TestHdfsCloudBackupRestore, TestSmileRequest, LukeRequestHandlerTest, PrimUtilsTest, TestExpandComponent, LeaderFailureAfterFreshStartTest, SuggesterWFSTTest, PluginInfoTest, TestSystemCollAutoCreate, ShowFileRequestHandlerTest, TestMergePolicyConfig, TestOverriddenPrefixQueryForCustomFieldType, TestTolerantUpdateProcessorRandomCloud, TestReloadDeadlock, TestSolrCLIRunExample, TestSchemaVersionResource, MigrateRouteKeyTest, TestOrdValues, SolrSlf4jReporterTest, SolrGangliaReporterTest, RulesTest, TestSchemaNameResource, SuggesterTSTTest, TestGeoJSONResponseWriter, TestCollationField, SaslZkACLProviderTest, AutoCommitTest, TestJsonRequest, TestPushWriter, TestCollapseQParserPlugin, FieldMutatingUpdateProcessorTest, NoCacheHeaderTest, DistributedSuggestComponentTest, TestFieldCacheReopen, SuggesterTest, TestUseDocValuesAsStored, StatelessScriptUpdateProcessorFactoryTest, SOLR749Test, SharedFSAutoReplicaFailoverUtilsTest, StatsReloadRaceTest, HLLUtilTest, TestReload, DistribDocExpirationUpdateProcessorTest, CoreAdminHandlerTest, AnalyticsQueryTest, EnumFieldTest, TestFieldCacheSortRandom, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, ClusterStateUpdateTest, ZkSolrClientTest, TestDistributedSearch]
   [junit4] Completed [482/697 (1!)] on J2 in 200.32s, 1 test, 1 error <<< FAILURES!

[...truncated 55589 lines...]


Mime
View raw message