Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18975/
Java: 32bit/jdk-9-ea+155 -client -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.search.TestRecovery.testCorruptLog

Error Message:
mismatch: '3'!='0' @ response/numFound

Stack Trace:
java.lang.RuntimeException: mismatch: '3'!='0' @ response/numFound
        at 
__randomizedtesting.SeedInfo.seed([87E0BD7E2E527DCE:753D09ADD46A2C12]:0)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1006)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:953)
        at 
org.apache.solr.search.TestRecovery.testCorruptLog(TestRecovery.java:1274)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:543)
        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 
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 
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.base/java.lang.Thread.run(Thread.java:844)


FAILED:  org.apache.solr.handler.admin.TestApiFramework.testFramework

Error Message:


Stack Trace:
java.lang.ExceptionInInitializerError
        at 
__randomizedtesting.SeedInfo.seed([87E0BD7E2E527DCE:90967759288691F3]:0)
        at 
net.sf.cglib.core.KeyFactory$Generator.generateClass(KeyFactory.java:166)
        at 
net.sf.cglib.core.DefaultGeneratorStrategy.generate(DefaultGeneratorStrategy.java:25)
        at 
net.sf.cglib.core.AbstractClassGenerator.create(AbstractClassGenerator.java:216)
        at net.sf.cglib.core.KeyFactory$Generator.create(KeyFactory.java:144)
        at net.sf.cglib.core.KeyFactory.create(KeyFactory.java:116)
        at net.sf.cglib.core.KeyFactory.create(KeyFactory.java:108)
        at net.sf.cglib.core.KeyFactory.create(KeyFactory.java:104)
        at net.sf.cglib.proxy.Enhancer.<clinit>(Enhancer.java:69)
        at 
org.easymock.internal.ClassProxyFactory.createEnhancer(ClassProxyFactory.java:259)
        at 
org.easymock.internal.ClassProxyFactory.createProxy(ClassProxyFactory.java:174)
        at org.easymock.internal.MocksControl.createMock(MocksControl.java:60)
        at org.easymock.EasyMock.createMock(EasyMock.java:104)
        at 
org.apache.solr.handler.admin.TestCoreAdminApis.getCoreContainerMock(TestCoreAdminApis.java:83)
        at 
org.apache.solr.handler.admin.TestApiFramework.testFramework(TestApiFramework.java:59)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:543)
        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 
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 
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.base/java.lang.Thread.run(Thread.java:844)
Caused by: java.lang.reflect.InaccessibleObjectException: Unable to make 
protected final java.lang.Class 
java.lang.ClassLoader.defineClass(java.lang.String,byte[],int,int,java.security.ProtectionDomain)
 throws java.lang.ClassFormatError accessible: module java.base does not "opens 
java.lang" to unnamed module @12a1c1f
        at 
java.base/java.lang.reflect.AccessibleObject.checkCanSetAccessible(AccessibleObject.java:207)
        at 
java.base/java.lang.reflect.Method.checkCanSetAccessible(Method.java:192)
        at java.base/java.lang.reflect.Method.setAccessible(Method.java:186)
        at net.sf.cglib.core.ReflectUtils$2.run(ReflectUtils.java:56)
        at java.base/java.security.AccessController.doPrivileged(Native Method)
        at net.sf.cglib.core.ReflectUtils.<clinit>(ReflectUtils.java:46)
        ... 52 more




Build Log:
[...truncated 11972 lines...]
   [junit4] Suite: org.apache.solr.search.TestRecovery
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001
   [junit4]   2> 1425003 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] o.a.s.SolrTestCaseJ4 
Using TrieFields
   [junit4]   2> 1425005 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] o.a.s.SolrTestCaseJ4 
Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1425007 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore
   [junit4]   2> 1425008 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1425065 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1425076 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] o.a.s.s.IndexSchema 
[null] Schema name=test
   [junit4]   2> 1425127 WARN  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] o.a.s.s.IndexSchema 
[null] default search field in schema is text. WARNING: Deprecated, please use 
'df' on request instead.
   [junit4]   2> 1425129 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1425224 WARN  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1425227 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1425227 WARN  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1425231 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1425231 WARN  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1425231 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1425233 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1425294 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1425303 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1425345 WARN  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1425347 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1425370 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1425371 WARN  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1425371 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1425371 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/]
   [junit4]   2> 1425371 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1425376 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.29340459390992035]
   [junit4]   2> 1425427 WARN  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1425534 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1425534 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1425535 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1425535 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1425536 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=38, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.69140625, 
floorSegmentMB=0.6123046875, forceMergeDeletesPctAllowed=19.83259541669657, 
segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1425538 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@193dcdf[collection1] main]
   [junit4]   2> 1425539 WARN  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1425539 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1425540 INFO  (searcherExecutor-3668-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@193dcdf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1425541 INFO  (coreLoadExecutor-3667-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1559477631116640256
   [junit4]   2> 1425543 INFO  
(SUITE-TestRecovery-seed#[87E0BD7E2E527DCE]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore end
   [junit4]   2> 1425545 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testLogReplayWithReorderedDBQUpdateWithDifferentChildCount
   [junit4]   2> 1425546 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM 
INDEX
   [junit4]   2> 1425547 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@eea3ab[collection1] 
realtime]
   [junit4]   2> 1425547 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 1
   [junit4]   2> 1425547 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1425547 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1ae097c
   [junit4]   2> 1425567 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@939d9d[collection1] main]
   [junit4]   2> 1425567 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1425568 INFO  (searcherExecutor-3668-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@939d9d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1425568 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 21
   [junit4]   2> 1425572 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B1 
(1011)]} 0 3
   [junit4]   2> 1425573 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B1 
(1012)]} 0 0
   [junit4]   2> 1425573 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B2 
(1013)]} 0 0
   [junit4]   2> 1425610 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3016b8[collection1] 
realtime]
   [junit4]   2> 1425611 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null 
params={update.distrib=FROMLEADER&_version_=-1019&wt=json&indent=true}{deleteByQuery=id:B3
 (-1019)} 0 38
   [junit4]   2> 1425611 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{_version_=1018,id=B2} DBQs=[DBQ{version=1019,q=id:B3}]
   [junit4]   2> 1425645 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@962ea9[collection1] 
realtime]
   [junit4]   2> 1425645 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[B2 
(1018)]} 0 33
   [junit4]   2> 1425645 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 1425646 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=4312147
   [junit4]   2> 1425646 INFO  (coreCloseExecutor-3673-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@12bcd33
   [junit4]   2> 1425773 INFO  (coreCloseExecutor-3673-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1425805 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1425807 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from 
paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1425872 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1425882 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1425924 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.s.IndexSchema [null] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1425925 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1426034 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, 
using first MBeanServer.
   [junit4]   2> 1426036 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1426036 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, 
using first MBeanServer.
   [junit4]   2> 1426041 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1426041 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, 
using first MBeanServer.
   [junit4]   2> 1426041 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1426043 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1426100 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1426111 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1426163 WARN  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1426164 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1426189 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1426189 WARN  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1426189 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1426189 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/]
   [junit4]   2> 1426189 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1426196 WARN  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1426344 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1426345 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1426347 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1426347 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1426351 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.29340459390992035]
   [junit4]   2> 1426361 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@501d54[collection1] main]
   [junit4]   2> 1426362 WARN  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1426362 INFO  (coreLoadExecutor-3680-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1426363 INFO  (searcherExecutor-3681-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@501d54[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1426366 WARN  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.u.UpdateLog Starting log replay 
tlog{file=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/tlog/tlog.0000000000000000001
 refcount=2} active=false starting pos=0
   [junit4]   2> 1426367 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 1426412 INFO  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2b1699[collection1] realtime]
   [junit4]   2> 1426413 INFO  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{flags=a,_version_=1018,id=B2} DBQs=[DBQ{version=1019,q=id:B3}]
   [junit4]   2> 1426434 INFO  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@9b8c1d[collection1] realtime]
   [junit4]   2> 1426434 INFO  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1426434 INFO  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2dccb4
   [junit4]   2> 1426690 INFO  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@13781a8[collection1] main]
   [junit4]   2> 1426690 INFO  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1426691 INFO  (searcherExecutor-3681-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@13781a8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):C10/6:delGen=2)
 Uninverting(_3(7.0.0):C4)))}
   [junit4]   2> 1426691 INFO  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[B1 (1011), B1 (1012), 
B2 (1013), B2 (1018)],deleteByQuery=id:B3 (-1019)} 0 325
   [junit4]   2> 1426692 WARN  (recoveryExecutor-3683-thread-1) [    ] 
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=4 
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
   [junit4]   2> 1426692 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&wt=xml} hits=8 status=0 QTime=0
   [junit4]   2> 1426692 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount-seed#[87E0BD7E2E527DCE])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testLogReplayWithReorderedDBQUpdateWithDifferentChildCount
   [junit4]   2> 1426694 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testBufferingFlags
   [junit4]   2> 1426695 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1426695 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5e97c8[collection1] realtime]
   [junit4]   2> 1426695 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 0
   [junit4]   2> 1426696 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1426696 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2dccb4
   [junit4]   2> 1426709 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2b692a[collection1] main]
   [junit4]   2> 1426712 INFO  (searcherExecutor-3681-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2b692a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1426717 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1426725 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 29
   [junit4]   2> 1426725 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, 
tlog=null}
   [junit4]   2> 1426727 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[Q1 (101)]} 0 1
   [junit4]   2> 1426727 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[Q2 (102)]} 0 0
   [junit4]   2> 1426727 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[Q3 (103)]} 0 0
   [junit4]   2> 1426727 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=31886395
   [junit4]   2> 1426728 INFO  (coreCloseExecutor-3686-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@ff50c5
   [junit4]   2> 1426765 INFO  (coreCloseExecutor-3686-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1426770 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1426772 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1426838 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1426848 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1426928 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 1426929 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1427035 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1427037 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427038 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1427041 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427041 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1427042 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427043 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1427095 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1427104 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1427144 WARN  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1427145 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1427167 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1427167 WARN  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1427168 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427168 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/]
   [junit4]   2> 1427168 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427174 WARN  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1427285 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1427285 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1427288 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1427288 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1427291 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.29340459390992035]
   [junit4]   2> 1427293 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6c4a32[collection1] main]
   [junit4]   2> 1427293 WARN  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1427293 INFO  (coreLoadExecutor-3693-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1427295 INFO  (searcherExecutor-3694-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6c4a32[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1427297 WARN  (recoveryExecutor-3696-thread-1) [    ] 
o.a.s.u.UpdateLog Starting log replay 
tlog{file=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/tlog/tlog.0000000000000000004
 refcount=2} active=false starting pos=0
   [junit4]   2> 1427299 INFO  (recoveryExecutor-3696-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1427300 INFO  (recoveryExecutor-3696-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@12e01
   [junit4]   2> 1427458 INFO  (recoveryExecutor-3696-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b51d3a[collection1] main]
   [junit4]   2> 1427458 INFO  (recoveryExecutor-3696-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1427459 INFO  (searcherExecutor-3694-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1b51d3a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C3)))}
   [junit4]   2> 1427459 INFO  (recoveryExecutor-3696-thread-1) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[Q1 (101), Q2 (102), Q3 
(103)]} 0 161
   [junit4]   2> 1427459 WARN  (recoveryExecutor-3696-thread-1) [    ] 
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=3 
deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
   [junit4]   2> 1427459 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=13960114
   [junit4]   2> 1427459 INFO  (coreCloseExecutor-3699-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1967680
   [junit4]   2> 1427527 INFO  (coreCloseExecutor-3699-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1427541 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1427543 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1427610 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1427619 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1427663 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 1427664 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1427773 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1427775 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427776 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1427780 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427781 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1427781 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427782 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1427878 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1427887 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1427930 WARN  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1427931 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1427956 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1427956 WARN  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1427956 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427956 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/]
   [junit4]   2> 1427956 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1427964 WARN  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1428081 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1428081 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1428084 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1428084 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1428087 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.29340459390992035]
   [junit4]   2> 1428097 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1bcecc3[collection1] main]
   [junit4]   2> 1428098 WARN  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1428098 INFO  (coreLoadExecutor-3706-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1428099 INFO  (searcherExecutor-3707-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1bcecc3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C3)))}
   [junit4]   2> 1428108 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{_version_=114,id=Q4} DBQs=[DBQ{version=1019,q=id:B3}]
   [junit4]   2> 1428137 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@181760[collection1] realtime]
   [junit4]   2> 1428137 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[Q4 (114)]} 0 29
   [junit4]   2> 1428138 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{_version_=115,id=Q5} DBQs=[DBQ{version=1019,q=id:B3}]
   [junit4]   2> 1428156 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d53888[collection1] realtime]
   [junit4]   2> 1428156 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[Q5 (115)]} 0 18
   [junit4]   2> 1428156 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{_version_=116,id=Q6} DBQs=[DBQ{version=1019,q=id:B3}]
   [junit4]   2> 1428174 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@c909cf[collection1] realtime]
   [junit4]   2> 1428174 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[Q6 (116)]} 0 17
   [junit4]   2> 1428174 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1428174 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1495729
   [junit4]   2> 1428461 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@72cfa8[collection1] main]
   [junit4]   2> 1428461 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1428462 INFO  (searcherExecutor-3707-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@72cfa8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C3)
 Uninverting(_5(7.0.0):C1) Uninverting(_6(7.0.0):C1) 
Uninverting(_7(7.0.0):C1)))}
   [junit4]   2> 1428462 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 288
   [junit4]   2> 1428463 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=32795376
   [junit4]   2> 1428463 INFO  (coreCloseExecutor-3712-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@3ab053
   [junit4]   2> 1428632 INFO  (coreCloseExecutor-3712-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1428672 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1428674 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1428738 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1428748 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1428790 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 1428792 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1428894 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1428896 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1428896 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1428900 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1428900 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1428900 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1428902 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1428956 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1428976 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1429043 WARN  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1429045 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1429066 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1429067 WARN  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1429067 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1429067 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/]
   [junit4]   2> 1429067 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1429073 WARN  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1429203 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1429203 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1429207 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1429207 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1429211 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.29340459390992035]
   [junit4]   2> 1429252 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b52f48[collection1] main]
   [junit4]   2> 1429253 WARN  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1429253 INFO  (coreLoadExecutor-3719-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1429255 INFO  (searcherExecutor-3720-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1b52f48[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C3)
 Uninverting(_5(7.0.0):C1) Uninverting(_6(7.0.0):C1) 
Uninverting(_7(7.0.0):C1)))}
   [junit4]   2> 1429285 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, 
tlog=null}
   [junit4]   2> 1429285 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{_version_=117,id=Q7} DBQs=[DBQ{version=1019,q=id:B3}]
   [junit4]   2> 1429323 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2abeff[collection1] realtime]
   [junit4]   2> 1429323 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[Q7 (117)]} 0 37
   [junit4]   2> 1429323 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=7412268
   [junit4]   2> 1429324 INFO  (coreCloseExecutor-3725-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@13db52c
   [junit4]   2> 1429530 INFO  (coreCloseExecutor-3725-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1429578 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1429581 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1429647 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1429657 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1429707 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 1429709 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1429856 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1429859 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1429859 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1429864 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1429864 WARN  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1429865 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1429868 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1429970 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1429987 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1430084 WARN  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1430086 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1430130 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1430130 WARN  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1430131 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1430131 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/]
   [junit4]   2> 1430132 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1430143 WARN  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1430360 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1430360 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1430367 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1430367 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1430374 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.29340459390992035]
   [junit4]   2> 1430443 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ee3708[collection1] main]
   [junit4]   2> 1430444 WARN  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1430444 INFO  (coreLoadExecutor-3732-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1430447 INFO  (searcherExecutor-3733-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1ee3708[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C3)
 Uninverting(_5(7.0.0):C1) Uninverting(_6(7.0.0):C1) 
Uninverting(_7(7.0.0):C1)))}
   [junit4]   2> 1430487 WARN  (recoveryExecutor-3735-thread-1) [    ] 
o.a.s.u.UpdateLog Starting log replay 
tlog{file=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/tlog/tlog.0000000000000000006
 refcount=2} active=false starting pos=0
   [junit4]   2> 1430490 INFO  (recoveryExecutor-3735-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1430490 INFO  (recoveryExecutor-3735-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@19296ee
   [junit4]   2> 1430717 INFO  (recoveryExecutor-3735-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@bd2a0b[collection1] main]
   [junit4]   2> 1430717 INFO  (recoveryExecutor-3735-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1430720 INFO  (searcherExecutor-3733-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@bd2a0b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C3)
 Uninverting(_5(7.0.0):C1) Uninverting(_6(7.0.0):C1) Uninverting(_7(7.0.0):C1) 
Uninverting(_9(7.0.0):C1)))}
   [junit4]   2> 1430720 INFO  (recoveryExecutor-3735-thread-1) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[Q7 (117)]} 0 233
   [junit4]   2> 1430720 WARN  (recoveryExecutor-3735-thread-1) [    ] 
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=1 
deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
   [junit4]   2> 1430720 INFO  
(TEST-TestRecovery.testBufferingFlags-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testBufferingFlags
   [junit4]   2> 1430722 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testLogReplay
   [junit4]   2> 1430723 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1430724 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b8cd69[collection1] realtime]
   [junit4]   2> 1430724 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 1
   [junit4]   2> 1430724 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1430725 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@19296ee
   [junit4]   2> 1430763 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@c4fdad[collection1] main]
   [junit4]   2> 1430764 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1430765 INFO  (searcherExecutor-3733-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@c4fdad[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1430790 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 65
   [junit4]   2> 1430795 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[A1 (1559477636621664256)]} 0 3
   [junit4]   2> 1430795 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[A11 (1559477636625858560)]} 0 0
   [junit4]   2> 1430795 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[A12 (1559477636625858561)]} 0 0
   [junit4]   2> 1430819 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1fb02ad[collection1] realtime]
   [junit4]   2> 1430820 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1491481[collection1] realtime]
   [junit4]   2> 1430820 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{deleteByQuery=id:A11 
(-1559477636625858562)} 0 24
   [junit4]   2> 1430822 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[A13 (1559477636652072960)]} 0 1
   [junit4]   2> 1430823 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[A12 (1559477636655218688)]} 0 1
   [junit4]   2> 1430827 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[A12 (1559477636656267264)]} 0 3
   [junit4]   2> 1430827 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=0 status=0 QTime=0
   [junit4]   2> 1430828 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=7&wt=xml} status=0 QTime=0
   [junit4]   2> 1430828 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=25924493
   [junit4]   2> 1430828 INFO  (coreCloseExecutor-3738-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1d2e1e7
   [junit4]   2> 1430932 INFO  (coreCloseExecutor-3738-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1430949 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1430952 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1431044 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1431068 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1431117 WARN  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 1431118 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1431265 WARN  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1431268 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1431268 WARN  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1431274 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1431274 WARN  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1431274 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1431276 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1431376 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1431393 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1431492 WARN  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1431494 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1431564 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1431564 WARN  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first 
MBeanServer.
   [junit4]   2> 1431564 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1431564 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/]
   [junit4]   2> 1431565 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@113dc5c
   [junit4]   2> 1431574 WARN  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1431708 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1431708 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1431713 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1431713 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1431719 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.29340459390992035]
   [junit4]   2> 1431724 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@da8f63[collection1] main]
   [junit4]   2> 1431725 WARN  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1431725 INFO  (coreLoadExecutor-3745-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1431728 INFO  (searcherExecutor-3746-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@da8f63[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1431731 WARN  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.u.UpdateLog Starting log replay 
tlog{file=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_87E0BD7E2E527DCE-001/init-core-data-001/tlog/tlog.0000000000000000009
 refcount=2} active=false starting pos=0
   [junit4]   2> 1431732 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=0 status=0 QTime=0
   [junit4]   2> 1431732 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=7&wt=xml} status=0 QTime=0
   [junit4]   2> 1431734 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=7&wt=xml} status=0 QTime=0
   [junit4]   2> 1431766 INFO  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@18d3b32[collection1] realtime]
   [junit4]   2> 1431767 INFO  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@19b20e0[collection1] realtime]
   [junit4]   2> 1431769 INFO  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1431769 INFO  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@15697ac
   [junit4]   2> 1432666 INFO  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@138ef62[collection1] main]
   [junit4]   2> 1432667 INFO  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1432668 INFO  (searcherExecutor-3746-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@138ef62[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(7.0.0):C3/2:delGen=1:fieldInfosGen=1:dvGen=2)
 Uninverting(_c(7.0.0):C2:fieldInfosGen=1:dvGen=2)))}
   [junit4]   2> 1432668 INFO  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[A1 
(1559477636621664256), A11 (1559477636625858560), A12 (1559477636625858561), 
A13 (1559477636652072960), A12 (1559477636655218688), A12 
(1559477636656267264)],deleteByQuery=id:A11 (-1559477636625858562)} 0 937
   [junit4]   2> 1432668 WARN  (recoveryExecutor-3748-thread-1) [    ] 
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=6 
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
   [junit4]   2> 1432669 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=val_i_dvo:2&wt=xml} hits=1 status=0 QTime=0
   [junit4]   2> 1432670 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=3 status=0 QTime=0
   [junit4]   2> 1432670 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&getVersions=7&wt=xml} status=0 QTime=0
   [junit4]   2> 1432674 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[A2 (1559477638591938560)]} 0 3
   [junit4]   2> 1432674 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[A3 (1559477638596132864)]} 0 0
   [junit4]   2> 1432675 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{delete=[A2 (-1559477638597181440)]} 0 0
   [junit4]   2> 1432676 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[A4 (1559477638597181441)]} 0 0
   [junit4]   2> 1432676 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=3 status=0 QTime=0
   [junit4]   2> 1432676 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=val_i_dvo:2&wt=xml} hits=1 status=0 QTime=0
   [junit4]   2> 1432676 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=15643161
   [junit4]   2> 1432677 INFO  (coreCloseExecutor-3751-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7074d0
   [junit4]   2> 1432859 INFO  (coreCloseExecutor-3751-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1432895 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1432898 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1432988 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1433003 INFO  
(TEST-TestRecovery.testLogReplay-seed#[87E0BD7E2E527DCE]) [    ] o.a.s.s.I

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

.admin.TestApiFramework
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.TestApiFramework_87E0BD7E2E527DCE-001/init-core-data-001
   [junit4]   2> 2169819 INFO  
(SUITE-TestApiFramework-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields
   [junit4]   2> 2169820 INFO  
(SUITE-TestApiFramework-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 2169822 INFO  
(TEST-TestApiFramework.testTrailingTemplatePaths-seed#[87E0BD7E2E527DCE]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testTrailingTemplatePaths
   [junit4]   2> 2169823 INFO  
(TEST-TestApiFramework.testTrailingTemplatePaths-seed#[87E0BD7E2E527DCE]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testTrailingTemplatePaths
   [junit4]   2> 2169824 INFO  
(TEST-TestApiFramework.testFramework-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testFramework
   [junit4]   2> 2169864 INFO  
(TEST-TestApiFramework.testFramework-seed#[87E0BD7E2E527DCE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testFramework
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestApiFramework 
-Dtests.method=testFramework -Dtests.seed=87E0BD7E2E527DCE -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=en-BI -Dtests.timezone=Europe/Dublin 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.04s J1 | TestApiFramework.testFramework <<<
   [junit4]    > Throwable #1: java.lang.ExceptionInInitializerError
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([87E0BD7E2E527DCE:90967759288691F3]:0)
   [junit4]    >        at 
net.sf.cglib.core.KeyFactory$Generator.generateClass(KeyFactory.java:166)
   [junit4]    >        at 
net.sf.cglib.core.DefaultGeneratorStrategy.generate(DefaultGeneratorStrategy.java:25)
   [junit4]    >        at 
net.sf.cglib.core.AbstractClassGenerator.create(AbstractClassGenerator.java:216)
   [junit4]    >        at 
net.sf.cglib.core.KeyFactory$Generator.create(KeyFactory.java:144)
   [junit4]    >        at 
net.sf.cglib.core.KeyFactory.create(KeyFactory.java:116)
   [junit4]    >        at 
net.sf.cglib.core.KeyFactory.create(KeyFactory.java:108)
   [junit4]    >        at 
net.sf.cglib.core.KeyFactory.create(KeyFactory.java:104)
   [junit4]    >        at 
net.sf.cglib.proxy.Enhancer.<clinit>(Enhancer.java:69)
   [junit4]    >        at 
org.easymock.internal.ClassProxyFactory.createEnhancer(ClassProxyFactory.java:259)
   [junit4]    >        at 
org.easymock.internal.ClassProxyFactory.createProxy(ClassProxyFactory.java:174)
   [junit4]    >        at 
org.easymock.internal.MocksControl.createMock(MocksControl.java:60)
   [junit4]    >        at org.easymock.EasyMock.createMock(EasyMock.java:104)
   [junit4]    >        at 
org.apache.solr.handler.admin.TestCoreAdminApis.getCoreContainerMock(TestCoreAdminApis.java:83)
   [junit4]    >        at 
org.apache.solr.handler.admin.TestApiFramework.testFramework(TestApiFramework.java:59)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:543)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]    > Caused by: java.lang.reflect.InaccessibleObjectException: 
Unable to make protected final java.lang.Class 
java.lang.ClassLoader.defineClass(java.lang.String,byte[],int,int,java.security.ProtectionDomain)
 throws java.lang.ClassFormatError accessible: module java.base does not "opens 
java.lang" to unnamed module @12a1c1f
   [junit4]    >        at 
java.base/java.lang.reflect.AccessibleObject.checkCanSetAccessible(AccessibleObject.java:207)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.checkCanSetAccessible(Method.java:192)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.setAccessible(Method.java:186)
   [junit4]    >        at 
net.sf.cglib.core.ReflectUtils$2.run(ReflectUtils.java:56)
   [junit4]    >        at 
java.base/java.security.AccessController.doPrivileged(Native Method)
   [junit4]    >        at 
net.sf.cglib.core.ReflectUtils.<clinit>(ReflectUtils.java:46)
   [junit4]    >        ... 52 more
   [junit4]   2> 2169865 INFO  
(SUITE-TestApiFramework-seed#[87E0BD7E2E527DCE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.TestApiFramework_87E0BD7E2E527DCE-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1063, maxMBSortInHeap=5.003418217614697, 
sim=RandomSimilarity(queryNorm=true): {}, locale=en-BI, timezone=Europe/Dublin
   [junit4]   2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation 9-ea 
(32-bit)/cpus=12,threads=1,free=200346688,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [AlternateDirectoryTest, 
TestWordDelimiterFilterFactory, TestBulkSchemaConcurrent, 
CollectionTooManyReplicasTest, TimeZoneUtilsTest, 
SuggestComponentContextFilterQueryTest, TestPostingsSolrHighlighter, 
DistributedIntervalFacetingTest, ActionThrottleTest, TestBM25SimilarityFactory, 
TestInfoStreamLogging, TestUniqueKeyFieldResource, CdcrUpdateLogTest, 
UpdateLogTest, TestAnalyzeInfixSuggestions, ShardRoutingCustomTest, 
ConcurrentDeleteAndCreateCollectionTest, TestManagedSchemaAPI, 
CoreAdminRequestStatusTest, DistribDocExpirationUpdateProcessorTest, 
RestartWhileUpdatingTest, DocumentBuilderTest, TestCollectionAPI, TestUpdate, 
TestQueryTypes, TestCloudPseudoReturnFields, ExplicitHLLTest, 
BlockJoinFacetSimpleTest, SharedFSAutoReplicaFailoverUtilsTest, 
TermsComponentTest, TestChildDocTransformer, TestStressRecovery, 
TestReloadAndDeleteDocs, TestSystemIdResolver, SortByFunctionTest, 
ClassificationUpdateProcessorTest, AtomicUpdatesTest, SolrCloudExampleTest, 
TestFuzzyAnalyzedSuggestions, TestCoreContainer, BasicAuthStandaloneTest, 
SolrIndexMetricsTest, TestTrie, QueryParsingTest, TestUninvertingReader, 
DistributedFacetPivotLongTailTest, BlockDirectoryTest, TermVectorComponentTest, 
TestCustomSort, SchemaVersionSpecificBehaviorTest, CreateCollectionCleanupTest, 
SpellCheckComponentTest, TestIntervalFaceting, SolrMetricManagerTest, 
DistributedMLTComponentTest, TestXIncludeConfig, RulesTest, TestReqParamsAPI, 
TestPKIAuthenticationPlugin, SoftAutoCommitTest, SOLR749Test, 
TestLegacyNumericRangeQueryBuilder, HdfsNNFailoverTest, 
TestFreeTextSuggestions, UpdateRequestProcessorFactoryTest, 
TestRandomCollapseQParserPlugin, TestCollapseQParserPlugin, ZkControllerTest, 
DistanceFunctionTest, IndexSchemaRuntimeFieldTest, SolrGangliaReporterTest, 
BadComponentTest, SaslZkACLProviderTest, TestSolrCoreSnapshots, 
TestRebalanceLeaders, ChaosMonkeyNothingIsSafeTest, 
TestSimpleTrackingShardHandler, HighlighterTest, 
TestTolerantUpdateProcessorRandomCloud, DistributedExpandComponentTest, 
TestHashPartitioner, CachingDirectoryFactoryTest, 
LeaderFailureAfterFreshStartTest, ManagedSchemaRoundRobinCloudTest, 
TestConfigsApi, TestSubQueryTransformerDistrib, 
DeleteLastCustomShardedReplicaTest, DistributedFacetPivotWhiteBoxTest, 
MoreLikeThisHandlerTest, ConvertedLegacyTest, TestConfigSetProperties, 
TestLeaderInitiatedRecoveryThread, TestFieldCacheSortRandom, 
CdcrVersionReplicationTest, HLLUtilTest, TestSolrIndexConfig, 
DistributedTermsComponentTest, TestSimpleQParserPlugin, ZkStateWriterTest, 
SuggesterFSTTest, DirectSolrConnectionTest, JsonLoaderTest, BadCopyFieldTest, 
TestExpandComponent, SolrCmdDistributorTest, TestCursorMarkWithoutUniqueKey, 
TestBackupRepositoryFactory, ClusterStateUpdateTest, TestElisionMultitermQuery, 
TestFiltering, SimpleMLTQParserTest, TestOnReconnectListenerSupport, 
CdcrReplicationDistributedZkTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, OpenCloseCoreStressTest, 
OverseerTest, BasicZkTest, RecoveryZkTest, TestRandomFaceting, ZkCLITest, 
TestRecovery, TestRangeQuery, BasicFunctionalityTest, TestBadConfig, 
CurrencyFieldXmlFileTest, SimplePostToolTest, TestCoreDiscovery, 
SuggesterTSTTest, SuggesterTest, SuggesterWFSTTest, QueryEqualityTest, 
DocValuesMultiTest, SolrInfoMBeanTest, IndexBasedSpellCheckerTest, 
TestWriterPerf, TestReversedWildcardFilterFactory, TestValueSourceCache, 
LoggingHandlerTest, IndexSchemaTest, BinaryUpdateRequestHandlerTest, 
CSVRequestHandlerTest, CopyFieldTest, SampleTest, NumericFieldsTest, 
MinimalSchemaTest, TestLuceneMatchVersion, TestCodecSupport, 
TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TestFastWriter, 
TestFastOutputStream, OpenExchangeRatesOrgProviderTest, 
URLClassifyProcessorTest, TestPathTrie, TestEmbeddedSolrServerConstructors, 
AsyncCallRequestStatusResponseTest, CdcrReplicationHandlerTest, 
CloudExitableDirectoryReaderTest, CollectionStateFormat2Test, 
ConnectionManagerTest, DeleteNodeTest, DeleteShardTest, DistributedQueueTest, 
ForceLeaderTest, OverseerTaskQueueTest, RollingRestartTest, SolrCLIZkUtilsTest, 
TestAuthenticationFramework, TestClusterProperties, 
TestConfigSetsAPIExclusivity, TestConfigSetsAPIZkFailure, 
TestDeleteCollectionOnDownNodes, TestDownShardTolerantSearch, 
TestHdfsCloudBackupRestore, TestLockTree, TestMiniSolrCloudCluster, 
TestRequestForwarding, TestSSLRandomization, TestSegmentSorting, 
TestSolrCloudWithDelegationTokens, TestSolrCloudWithKerberosAlt, 
TestSolrCloudWithSecureImpersonation, TestStressInPlaceUpdates, 
TestImplicitCoreProperties, TestShardHandlerFactory, TestSolrDynamicMBean, 
TestConfigReload, CoreMergeIndexesAdminHandlerTest, MetricsHandlerTest, 
SecurityConfHandlerTest, SegmentsInfoRequestHandlerTest, StatsReloadRaceTest, 
TestApiFramework]
   [junit4] Completed [564/694 (2!)] on J1 in 0.06s, 2 tests, 1 error <<< 
FAILURES!

[...truncated 52039 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to