Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7384/
Java: 64bit/jdk-10 -XX:-UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.client.solrj.embedded.MergeIndexesEmbeddedTest

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-006:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-006
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-006:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-006
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001

        at __randomizedtesting.SeedInfo.seed([11D9DC41604C7670]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:318)
        at 
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
        at 
com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
        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)




Build Log:
[...truncated 16141 lines...]
   [junit4] Suite: 
org.apache.solr.client.solrj.embedded.MergeIndexesEmbeddedTest
   [junit4]   2> 153235 INFO  
(SUITE-MergeIndexesEmbeddedTest-seed#[11D9DC41604C7670]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\init-core-data-001
   [junit4]   2> 153236 WARN  
(SUITE-MergeIndexesEmbeddedTest-seed#[11D9DC41604C7670]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
   [junit4]   2> 153236 INFO  
(SUITE-MergeIndexesEmbeddedTest-seed#[11D9DC41604C7670]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 153237 INFO  
(SUITE-MergeIndexesEmbeddedTest-seed#[11D9DC41604C7670]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) 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> 153238 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testMergeIndexesByCoreName
   [junit4]   2> 153239 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\solr.xml
   [junit4]   2> 153242 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 153436 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 153436 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 153449 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 153454 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 153455 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 153459 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.CorePropertiesLocator Found 2 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore
   [junit4]   2> 153459 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [core0, core1]
   [junit4]   2> 153476 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 153482 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.s.IndexSchema [core0] Schema name=example core zero
   [junit4]   2> 153483 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.s.IndexSchema Loaded schema example core zero/1.1 with uniqueid field id
   [junit4]   2> 153483 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.c.CoreContainer Creating SolrCore 'core0' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0,
 trusted=true
   [junit4]   2> 153483 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.core0' (registry 
'solr.core.core0') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 153487 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 153487 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.c.SolrCore [[core0] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-001\]
   [junit4]   2> 153504 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 153509 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.s.IndexSchema [core1] Schema name=example core one
   [junit4]   2> 153511 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.s.IndexSchema Loaded schema example core one/1.1 with uniqueid field id
   [junit4]   2> 153511 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.c.CoreContainer Creating SolrCore 'core1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1,
 trusted=true
   [junit4]   2> 153512 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.core1' (registry 
'solr.core.core1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 153512 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 153512 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.c.SolrCore [[core1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-002\]
   [junit4]   2> 153900 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 153900 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-002
 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 153902 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 153902 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 153902 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 153902 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-001
 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 153904 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3d25ea21[core1] main]
   [junit4]   2> 153905 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 153905 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 153905 WARN  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 153907 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 153907 INFO  (coreLoadExecutor-501-thread-2) [    x:core1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1604447385221595136
   [junit4]   2> 153909 INFO  
(searcherExecutor-503-thread-1-processing-x:core1) [    x:core1] 
o.a.s.c.SolrCore [core1] Registered new searcher Searcher@3d25ea21[core1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 153909 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3e5b138f[core0] main]
   [junit4]   2> 153909 WARN  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 153910 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 153910 INFO  (coreLoadExecutor-501-thread-1) [    x:core0] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1604447385224740864
   [junit4]   2> 153910 INFO  
(searcherExecutor-502-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0] Registered new searcher Searcher@3e5b138f[core0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 153911 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.s.MergeIndexesExampleTestBase 
CORES=org.apache.solr.core.CoreContainer@7b1755f5 : [core0, core1]
   [junit4]   2> 153914 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447385228935168,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 153914 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 153915 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 153915 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [core0]  webapp=null path=/update 
params={commit=true&softCommit=false&waitSearcher=true}{deleteByQuery=*:* 
(-1604447385225789440),commit=} 0 3
   [junit4]   2> 153917 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447385232080896,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 153917 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 153917 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 153917 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [core1]  webapp=null path=/update 
params={commit=true&softCommit=false&waitSearcher=true}{deleteByQuery=*:* 
(-1604447385229983744),commit=} 0 2
   [junit4]   2> 153919 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447385234178048,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 153919 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@5416ea2e 
commitCommandVersion:1604447385234178048
   [junit4]   2> 153974 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6917a992[core0] main]
   [junit4]   2> 153975 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 153975 INFO  (searcherExecutor-502-thread-1) [    ] 
o.a.s.c.SolrCore [core0] Registered new searcher Searcher@6917a992[core0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
   [junit4]   2> 153975 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [core0]  webapp=null path=/update 
params={commit=true&softCommit=false&waitSearcher=true}{add=[AAA 
(1604447385233129472)],commit=} 0 58
   [junit4]   2> 153977 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447385294995456,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 153977 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@a1e7e0b 
commitCommandVersion:1604447385294995456
   [junit4]   2> 154029 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3a85ee2c[core1] main]
   [junit4]   2> 154029 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 154030 INFO  (searcherExecutor-503-thread-1) [    ] 
o.a.s.c.SolrCore [core1] Registered new searcher Searcher@3a85ee2c[core1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
   [junit4]   2> 154030 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [core1]  webapp=null path=/update 
params={commit=true&softCommit=false&waitSearcher=true}{add=[BBB 
(1604447385293946880)],commit=} 0 54
   [junit4]   2> 154030 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.S.Request [core0]  webapp=null path=/select params={q=id:AAA} 
hits=1 status=0 QTime=0
   [junit4]   2> 154031 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.S.Request [core1]  webapp=null path=/select params={q=id:AAA} 
hits=0 status=0 QTime=0
   [junit4]   2> 154031 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.S.Request [core0]  webapp=null path=/select params={q=id:AAA} 
hits=1 status=0 QTime=0
   [junit4]   2> 154031 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.S.Request [core0]  webapp=null path=/select params={q=id:BBB} 
hits=0 status=0 QTime=0
   [junit4]   2> 154031 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.S.Request [core1]  webapp=null path=/select params={q=id:AAA} 
hits=0 status=0 QTime=0
   [junit4]   2> 154031 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    ] o.a.s.c.S.Request [core1]  webapp=null path=/select params={q=id:BBB} 
hits=1 status=0 QTime=0
   [junit4]   2> 154035 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 start 
mergeIndexes{MMapDirectory@C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-002\index
 lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c4385eb}
   [junit4]   2> 154052 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 end_mergeIndexes
   [junit4]   2> 154052 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447385373638656,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154052 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@5416ea2e 
commitCommandVersion:1604447385373638656
   [junit4]   2> 154140 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.s.SolrIndexSearcher Opening [Searcher@256de3b6[core0] main]
   [junit4]   2> 154140 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 154141 INFO  
(searcherExecutor-502-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0] Registered new searcher Searcher@256de3b6[core0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
 Uninverting(_1(8.0.0):C1)))}
   [junit4]   2> 154141 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.p.LogUpdateProcessorFactory [core0]  webapp=null 
path=/update params={commit=true&softCommit=false&waitSearcher=true}{commit=} 0 
88
   [junit4]   2> 154141 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core0]  webapp=null path=/select 
params={q=id:AAA} hits=1 status=0 QTime=0
   [junit4]   2> 154142 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core0]  webapp=null path=/select 
params={q=id:BBB} hits=1 status=0 QTime=0
   [junit4]   2> 154142 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.SolrTestCaseJ4 ###Ending testMergeIndexesByCoreName
   [junit4]   2> 154142 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.CoreContainer Shutting down CoreContainer 
instance=2065126901
   [junit4]   2> 154142 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 154142 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b4a9f4b: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@64300d81
   [junit4]   2> 154146 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 154146 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@20468a61: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@5273b0c8
   [junit4]   2> 154148 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 154148 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@493f00ef: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@58f2429
   [junit4]   2> 154149 INFO  
(coreCloseExecutor-512-thread-1-processing-x:core0) [    x:core1] 
o.a.s.c.SolrCore [core1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6f05b48b
   [junit4]   2> 154149 INFO  
(coreCloseExecutor-512-thread-1-processing-x:core0) [    x:core1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.core1, tag=6f05b48b
   [junit4]   2> 154149 INFO  
(coreCloseExecutor-512-thread-2-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4be024fa
   [junit4]   2> 154149 INFO  
(coreCloseExecutor-512-thread-1-processing-x:core0) [    x:core1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5dbf81fa: rootName = null, 
domain = solr.core.core1, service url = null, agent id = null] for registry 
solr.core.core1 / com.codahale.metrics.MetricRegistry@37a03670
   [junit4]   2> 154154 INFO  
(coreCloseExecutor-512-thread-2-processing-x:core0) [    x:core0] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.core0, tag=4be024fa
   [junit4]   2> 154154 INFO  
(coreCloseExecutor-512-thread-2-processing-x:core0) [    x:core0] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7110ab06: rootName = null, 
domain = solr.core.core0, service url = null, agent id = null] for registry 
solr.core.core0 / com.codahale.metrics.MetricRegistry@72c945e7
   [junit4]   2> 154166 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.SolrTestCaseJ4 ###Starting testMergeIndexesByDirName
   [junit4]   2> 154168 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\solr.xml
   [junit4]   2> 154172 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 154287 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache 
for 2147483647 transient cores
   [junit4]   2> 154287 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping 
metrics history in memory.
   [junit4]   2> 154304 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' 
(registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 154313 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' 
(registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 154313 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' 
(registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 154396 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.CorePropertiesLocator Found 2 core definitions 
underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore
   [junit4]   2> 154396 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.CorePropertiesLocator Cores are: [core0, core1]
   [junit4]   2> 154424 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 154449 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.s.IndexSchema [core0] Schema name=example core zero
   [junit4]   2> 154466 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 154486 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.s.IndexSchema Loaded schema example core zero/1.1 with uniqueid field id
   [junit4]   2> 154486 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.CoreContainer Creating SolrCore 'core0' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0,
 trusted=true
   [junit4]   2> 154487 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.core0' (registry 
'solr.core.core0') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 154487 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 154487 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [[core0] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-003\]
   [junit4]   2> 154496 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.s.IndexSchema [core1] Schema name=example core one
   [junit4]   2> 154497 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.s.IndexSchema Loaded schema example core one/1.1 with uniqueid field id
   [junit4]   2> 154497 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.CoreContainer Creating SolrCore 'core1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1,
 trusted=true
   [junit4]   2> 154498 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.core1' (registry 
'solr.core.core1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 154498 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 154498 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.SolrCore [[core1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-004\]
   [junit4]   2> 154610 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 154610 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-004
 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 154610 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 154610 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-003
 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 154611 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 154611 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 154611 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 154611 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 154614 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@31d54c20[core1] main]
   [junit4]   2> 154614 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@78eb8ded[core0] main]
   [junit4]   2> 154614 WARN  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 154614 WARN  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 154615 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 154615 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 154615 INFO  
(coreLoadExecutor-522-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1604447385963986944
   [junit4]   2> 154615 INFO  
(coreLoadExecutor-522-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1604447385963986944
   [junit4]   2> 154615 INFO  
(searcherExecutor-523-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0] Registered new searcher Searcher@78eb8ded[core0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 154616 INFO  
(searcherExecutor-524-thread-1-processing-x:core1) [    x:core1] 
o.a.s.c.SolrCore [core1] Registered new searcher Searcher@31d54c20[core1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 154617 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.s.MergeIndexesExampleTestBase 
CORES=org.apache.solr.core.CoreContainer@2487f1f5 : [core0, core1]
   [junit4]   2> 154619 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447385968181248,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154619 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping 
IW.commit.
   [junit4]   2> 154620 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 154620 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.p.LogUpdateProcessorFactory [core0]  webapp=null 
path=/update 
params={commit=true&softCommit=false&waitSearcher=true}{deleteByQuery=*:* 
(-1604447385966084096),commit=} 0 2
   [junit4]   2> 154622 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447385971326976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154622 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping 
IW.commit.
   [junit4]   2> 154623 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 154623 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.p.LogUpdateProcessorFactory [core1]  webapp=null 
path=/update 
params={commit=true&softCommit=false&waitSearcher=true}{deleteByQuery=*:* 
(-1604447385969229824),commit=} 0 2
   [junit4]   2> 154624 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447385973424128,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154624 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2236240e 
commitCommandVersion:1604447385973424128
   [junit4]   2> 154695 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.s.SolrIndexSearcher Opening [Searcher@46e51bd7[core0] main]
   [junit4]   2> 154697 INFO  
(searcherExecutor-523-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0] Registered new searcher Searcher@46e51bd7[core0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
   [junit4]   2> 154697 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 154697 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.p.LogUpdateProcessorFactory [core0]  webapp=null 
path=/update params={commit=true&softCommit=false&waitSearcher=true}{add=[AAA 
(1604447385972375552)],commit=} 0 75
   [junit4]   2> 154700 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447386053115904,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154700 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@18a84a51 
commitCommandVersion:1604447386053115904
   [junit4]   2> 154802 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.s.SolrIndexSearcher Opening [Searcher@65effeee[core1] main]
   [junit4]   2> 154804 INFO  
(searcherExecutor-524-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core1] Registered new searcher Searcher@65effeee[core1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
   [junit4]   2> 154804 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 154804 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.p.LogUpdateProcessorFactory [core1]  webapp=null 
path=/update params={commit=true&softCommit=false&waitSearcher=true}{add=[BBB 
(1604447386051018752)],commit=} 0 106
   [junit4]   2> 154805 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core0]  webapp=null path=/select 
params={q=id:AAA} hits=1 status=0 QTime=0
   [junit4]   2> 154805 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core1]  webapp=null path=/select 
params={q=id:AAA} hits=0 status=0 QTime=0
   [junit4]   2> 154805 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core0]  webapp=null path=/select 
params={q=id:AAA} hits=1 status=0 QTime=0
   [junit4]   2> 154805 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core0]  webapp=null path=/select 
params={q=id:BBB} hits=0 status=0 QTime=0
   [junit4]   2> 154806 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core1]  webapp=null path=/select 
params={q=id:AAA} hits=0 status=0 QTime=0
   [junit4]   2> 154806 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core1]  webapp=null path=/select 
params={q=id:BBB} hits=1 status=0 QTime=0
   [junit4]   2> 154820 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 start 
mergeIndexes{MMapDirectory@C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-004\index
 lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c4385eb}
   [junit4]   2> 154839 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 end_mergeIndexes
   [junit4]   2> 154839 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1604447386198867968,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154839 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2236240e 
commitCommandVersion:1604447386198867968
   [junit4]   2> 154934 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.s.SolrIndexSearcher Opening [Searcher@52815baf[core0] main]
   [junit4]   2> 154934 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 154935 INFO  
(searcherExecutor-523-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0] Registered new searcher Searcher@52815baf[core0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)
 Uninverting(_1(8.0.0):C1)))}
   [junit4]   2> 154935 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.u.p.LogUpdateProcessorFactory [core0]  webapp=null 
path=/update params={commit=true&softCommit=false&waitSearcher=true}{commit=} 0 
96
   [junit4]   2> 154936 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core0]  webapp=null path=/select 
params={q=id:AAA} hits=1 status=0 QTime=0
   [junit4]   2> 154936 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.S.Request [core0]  webapp=null path=/select 
params={q=id:BBB} hits=1 status=0 QTime=0
   [junit4]   2> 154937 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.SolrTestCaseJ4 ###Ending testMergeIndexesByDirName
   [junit4]   2> 154937 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.CoreContainer Shutting down CoreContainer 
instance=612889077
   [junit4]   2> 154937 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 154937 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3fa3174b: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@3b068dc0
   [junit4]   2> 154941 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 154941 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@65873ad8: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@5273b0c8
   [junit4]   2> 154942 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 154942 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5391b641: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@58f2429
   [junit4]   2> 154945 INFO  
(coreCloseExecutor-533-thread-1-processing-x:core0) [    x:core1] 
o.a.s.c.SolrCore [core1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@17f18c22
   [junit4]   2> 154945 INFO  
(coreCloseExecutor-533-thread-1-processing-x:core0) [    x:core1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.core1, tag=17f18c22
   [junit4]   2> 154945 INFO  
(coreCloseExecutor-533-thread-1-processing-x:core0) [    x:core1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7cdbf065: rootName = null, 
domain = solr.core.core1, service url = null, agent id = null] for registry 
solr.core.core1 / com.codahale.metrics.MetricRegistry@4b328644
   [junit4]   2> 154948 INFO  
(coreCloseExecutor-533-thread-2-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@551a3ca4
   [junit4]   2> 154950 INFO  
(coreCloseExecutor-533-thread-2-processing-x:core0) [    x:core0] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.core0, tag=551a3ca4
   [junit4]   2> 154950 INFO  
(coreCloseExecutor-533-thread-2-processing-x:core0) [    x:core0] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@21020505: rootName = null, 
domain = solr.core.core0, service url = null, agent id = null] for registry 
solr.core.core0 / com.codahale.metrics.MetricRegistry@33485837
   [junit4]   2> 154962 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.SolrTestCaseJ4 ###Starting testMergeMultipleRequest
   [junit4]   2> 154964 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\solr.xml
   [junit4]   2> 154967 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 155404 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache 
for 2147483647 transient cores
   [junit4]   2> 155405 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping 
metrics history in memory.
   [junit4]   2> 155429 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' 
(registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 155439 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' 
(registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 155439 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' 
(registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 155445 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.CorePropertiesLocator Found 2 core definitions 
underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore
   [junit4]   2> 155446 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.CorePropertiesLocator Cores are: [core0, core1]
   [junit4]   2> 155462 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 155485 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 155490 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.s.IndexSchema [core1] Schema name=example core one
   [junit4]   2> 155491 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.s.IndexSchema [core0] Schema name=example core zero
   [junit4]   2> 155493 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.s.IndexSchema Loaded schema example core zero/1.1 with uniqueid field id
   [junit4]   2> 155493 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.CoreContainer Creating SolrCore 'core0' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0,
 trusted=true
   [junit4]   2> 155494 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.core0' (registry 
'solr.core.core0') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 155494 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 155494 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [[core0] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-005\]
   [junit4]   2> 155500 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.s.IndexSchema Loaded schema example core one/1.1 with uniqueid field id
   [junit4]   2> 155500 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.CoreContainer Creating SolrCore 'core1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1,
 trusted=true
   [junit4]   2> 155500 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.core1' (registry 
'solr.core.core1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63225847
   [junit4]   2> 155500 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 155502 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.SolrCore [[core1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-006\]
   [junit4]   2> 155689 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 155689 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-005
 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 155691 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 155691 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 155693 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 155693 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-006
 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 155693 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d5d37e9[core0] main]
   [junit4]   2> 155694 WARN  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 155694 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 155694 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 155694 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 155694 INFO  
(coreLoadExecutor-543-thread-1-processing-x:core0) [    x:core0] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1604447387095400448
   [junit4]   2> 155696 INFO  
(searcherExecutor-544-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0] Registered new searcher Searcher@1d5d37e9[core0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 155697 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5285141[core1] main]
   [junit4]   2> 155697 WARN  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 155698 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 155699 INFO  
(coreLoadExecutor-543-thread-2-processing-x:core0) [    x:core1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1604447387100643328
   [junit4]   2> 155699 INFO  
(searcherExecutor-545-thread-1-processing-x:core1) [    x:core1] 
o.a.s.c.SolrCore [core1] Registered new searcher Searcher@5285141[core1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 155700 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.s.MergeIndexesExampleTestBase 
CORES=org.apache.solr.core.CoreContainer@ac52cd1 : [core0, core1]
   [junit4]   2> 155701 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.SolrTestCaseJ4 ###Ending testMergeMultipleRequest
   [junit4]   2> 155701 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.c.CoreContainer Shutting down CoreContainer 
instance=180694225
   [junit4]   2> 155701 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 155701 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@87e45ca: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@306c0cc7
   [junit4]   2> 155705 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 155705 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@36cd0743: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@5273b0c8
   [junit4]   2> 155707 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 155707 INFO  
(TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[11D9DC41604C7670])
 [    x:core0] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@f557c44: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@58f2429
   [junit4]   2> 155708 INFO  
(coreCloseExecutor-554-thread-1-processing-x:core0) [    x:core0] 
o.a.s.c.SolrCore [core0]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7e6bae66
   [junit4]   2> 155708 INFO  
(coreCloseExecutor-554-thread-1-processing-x:core0) [    x:core0] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.core0, tag=7e6bae66
   [junit4]   2> 155708 INFO  
(coreCloseExecutor-554-thread-1-processing-x:core0) [    x:core0] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2d1829e2: rootName = null, 
domain = solr.core.core0, service url = null, agent id = null] for registry 
solr.core.core0 / com.codahale.metrics.MetricRegistry@65255e1f
   [junit4]   2> 155722 INFO  
(coreCloseExecutor-554-thread-2-processing-x:core0) [    x:core1] 
o.a.s.c.SolrCore [core1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@20e83f6d
   [junit4]   2> 155722 INFO  
(coreCloseExecutor-554-thread-2-processing-x:core0) [    x:core1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.core1, tag=20e83f6d
   [junit4]   2> 155722 INFO  
(coreCloseExecutor-554-thread-2-processing-x:core0) [    x:core1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@318ca4a0: rootName = null, 
domain = solr.core.core1, service url = null, agent id = null] for registry 
solr.core.core1 / com.codahale.metrics.MetricRegistry@2b3956e
   [junit4]   2> 155733 INFO  
(SUITE-MergeIndexesEmbeddedTest-seed#[11D9DC41604C7670]-worker) [    x:core0] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> Jun 27, 2018 5:24:25 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{name=PostingsFormat(name=LuceneVarGapFixedInterval), 
id=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{_version_=DocValuesFormat(name=Lucene70), 
name=DocValuesFormat(name=Lucene70), id=DocValuesFormat(name=Lucene70)}, 
maxPointsInLeafNode=993, maxMBSortInHeap=7.547559267518842, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@116893e3),
 locale=yo-NG, timezone=Canada/Mountain
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 10 
(64-bit)/cpus=3,threads=1,free=87402008,total=386195456
   [junit4]   2> NOTE: All tests run in this JVM: [LargeVolumeBinaryJettyTest, 
TestUpdateRequestCodec, StreamExpressionParserTest, NaturalLogEvaluatorTest, 
TestToleratedUpdateError, SolrExampleStreamingBinaryTest, 
CloudSolrClientCacheTest, TestNamedListCodec, LessThanEqualToEvaluatorTest, 
TangentEvaluatorTest, CloudSolrClientTest, TestXMLEscaping, 
StreamExpressionTest, ShardParamsTest, OperationsTest, 
ConcurrentUpdateSolrClientTest, HyperbolicCosineEvaluatorTest, 
AbsoluteValueEvaluatorTest, TestCloudSolrClientConnections, 
SquareRootEvaluatorTest, RawValueEvaluatorTest, TestBatchUpdate, 
CubedRootEvaluatorTest, SolrQueryTest, ArcTangentEvaluatorTest, 
DocumentAnalysisResponseTest, TestTimeSource, ClientUtilsTest, JdbcDriverTest, 
EqualToEvaluatorTest, AndEvaluatorTest, DivideEvaluatorTest, JDBCStreamTest, 
TestZkConfigManager, TestConfigSetAdminRequest, SolrExampleEmbeddedTest, 
GreaterThanEqualToEvaluatorTest, CorrelationEvaluatorTest, CommonParamsTest, 
UsingSolrJRefGuideExamplesTest, SolrExampleXMLTest, TestDocumentObjectBinder, 
TestPolicy, JettyWebappTest, LargeVolumeJettyTest, MergeIndexesEmbeddedTest]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=MergeIndexesEmbeddedTest -Dtests.seed=11D9DC41604C7670 
-Dtests.slow=true -Dtests.locale=yo-NG -Dtests.timezone=Canada/Mountain 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J0 | MergeIndexesEmbeddedTest (suite) <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the 
following files (in the order of attempts):
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-006:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001\tempDir-006
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_11D9DC41604C7670-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([11D9DC41604C7670]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:318)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [90/154 (1!)] on J0 in 2.79s, 3 tests, 1 error <<< 
FAILURES!

[...truncated 43047 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7384/consoleText

[repro] Revision: 39fb4b8a189e2d72f2cedf0d5c9ff15db7153085

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC"

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr\solrj
[repro]       MergeIndexesEmbeddedTest
[repro] ant compile-test

[...truncated 2476 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.MergeIndexesEmbeddedTest" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=11D9DC41604C7670 
-Dtests.slow=true -Dtests.locale=yo-NG -Dtests.timezone=Canada/Mountain 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[...truncated 84 lines...]
[repro] Failures:
[repro]   0/5 failed: 
org.apache.solr.client.solrj.embedded.MergeIndexesEmbeddedTest
[repro] Exiting with code 0

[...truncated 75 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to