lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+155) - Build # 18975 - Still Unstable!
Date Thu, 16 Feb 2017 08:57:02 GMT
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...]


Mime
View raw message