You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/03/02 04:59:19 UTC
[JENKINS] Lucene-Solr-6.x-Linux (32bit/jdk1.8.0_121) - Build # 2976
- Unstable!
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...]