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

4 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.lucene.store.TestRAFDirectory

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001\testThreadSafety-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001\testThreadSafety-001
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-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\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001\testThreadSafety-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001\testThreadSafety-001
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001

        at __randomizedtesting.SeedInfo.seed([DB0FE0A19E2A5344]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        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)


FAILED:  
junit.framework.TestSuite.org.apache.lucene.codecs.compressing.TestCompressingTermVectorsFormat

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001\index-NIOFSDirectory-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001\index-NIOFSDirectory-001
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-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\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001\index-NIOFSDirectory-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001\index-NIOFSDirectory-001
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001

        at __randomizedtesting.SeedInfo.seed([DC44ECAE716A27B5]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        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)


FAILED:  
junit.framework.TestSuite.org.apache.solr.ltr.feature.TestUserTermScorerQuery

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\init-core-data-001:
 java.nio.file.NoSuchFileException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\init-core-data-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\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\init-core-data-001:
 java.nio.file.NoSuchFileException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\init-core-data-001

        at __randomizedtesting.SeedInfo.seed([2A93D66B0953E0FD]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        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)


FAILED:  
junit.framework.TestSuite.org.apache.solr.ltr.feature.TestUserTermScorerQuery

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data\tlog:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data\tlog
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-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\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data\tlog:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data\tlog
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001

        at __randomizedtesting.SeedInfo.seed([2A93D66B0953E0FD]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        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 2024 lines...]
   [junit4] Suite: 
org.apache.lucene.codecs.compressing.TestCompressingTermVectorsFormat
   [junit4]   2> NOTE: test params are: 
codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
 chunkSize=8, maxDocsPerChunk=107, blockSize=5), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, 
chunkSize=8, blockSize=5)), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@2855b84c),
 locale=kn, timezone=Asia/Sakhalin
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=3,threads=1,free=59874944,total=97386496
   [junit4]   2> NOTE: All tests run in this JVM: [Nested, Nested, Nested, 
Nested, Nested, Nested, Nested, Nested, Nested, Nested, Nested, Nested, Nested, 
Nested, Nested, Nested, Nested, Nested, Nested, Nested, Nested, Nested, 
TestLeakFS, Before3, Before3, TestDisableFsyncFS, TestVerboseFS, 
TestCompressingTermVectorsFormat]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestCompressingTermVectorsFormat -Dtests.seed=DC44ECAE716A27B5 
-Dtests.slow=true -Dtests.locale=kn -Dtests.timezone=Asia/Sakhalin 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J0 | TestCompressingTermVectorsFormat (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\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001\index-NIOFSDirectory-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001\index-NIOFSDirectory-001
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\test-framework\test\J0\temp\lucene.codecs.compressing.TestCompressingTermVectorsFormat_DC44ECAE716A27B5-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([DC44ECAE716A27B5]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [7/41 (1!)] on J0 in 11.04s, 19 tests, 1 error <<< 
FAILURES!

[...truncated 6416 lines...]
   [junit4] Suite: org.apache.lucene.store.TestRAFDirectory
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@8a0d002),
 locale=te-IN, timezone=America/Detroit
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=3,threads=1,free=65065368,total=97320960
   [junit4]   2> NOTE: All tests run in this JVM: [TestMultiPassIndexSplitter, 
TestHighFreqTerms, TestFSTsMisc, TestRAFDirectory]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestRAFDirectory 
-Dtests.seed=DB0FE0A19E2A5344 -Dtests.slow=true -Dtests.locale=te-IN 
-Dtests.timezone=America/Detroit -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J0 | TestRAFDirectory (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\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001\testThreadSafety-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001\testThreadSafety-001
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp\lucene.store.TestRAFDirectory_DB0FE0A19E2A5344-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([DB0FE0A19E2A5344]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [5/13 (1!)] on J0 in 2.31s, 42 tests, 1 error <<< 
FAILURES!

[...truncated 13849 lines...]
   [junit4] Suite: org.apache.solr.ltr.feature.TestUserTermScorerQuery
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\init-core-data-001
   [junit4]   2> 31150 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
   [junit4]   2> 31150 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 31152 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 31152 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 31152 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 31158 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.SolrConfig Couldn't add files from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\models
 filtered by null to classpath: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\models
   [junit4]   2> 31160 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 31171 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=example
   [junit4]   2> 31181 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
   [junit4]   2> 31211 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 31211 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 31211 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 31212 INFO  (coreLoadExecutor-164-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 31219 WARN  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\models
 filtered by null to classpath: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\models
   [junit4]   2> 31225 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 31232 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 31244 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid 
field id
   [junit4]   2> 31247 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 31247 WARN  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr 
metrics via JMX.
   [junit4]   2> 31247 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 31247 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\init-core-data-001\]
   [junit4]   2> 31333 WARN  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers no default request handler is registered 
(either '/select' or 'standard')
   [junit4]   2> 31334 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 31334 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 31335 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
15000ms; 
   [junit4]   2> 31335 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 31338 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1c96691c[collection1] main]
   [junit4]   2> 31339 WARN  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\collection1\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 31339 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedFeatureStore for path 
/schema/feature-store
   [junit4]   2> 31339 WARN  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.ManagedResource No stored data found for 
/schema/feature-store
   [junit4]   2> 31339 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading 
------
   [junit4]   2> 31339 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 1 observers of 
/schema/feature-store
   [junit4]   2> 31339 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered new managed resource 
/schema/feature-store
   [junit4]   2> 31339 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedModelStore for path /schema/model-store
   [junit4]   2> 31340 WARN  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.ManagedResource No stored data found for 
/schema/model-store
   [junit4]   2> 31340 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 31340 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading 
------
   [junit4]   2> 31340 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 1 observers of 
/schema/model-store
   [junit4]   2> 31340 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered new managed resource 
/schema/model-store
   [junit4]   2> 31340 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 31340 INFO  
(searcherExecutor-165-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1c96691c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 31340 INFO  (coreLoadExecutor-164-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1594345991608205312
   [junit4]   2> 31344 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 31354 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 31354 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 31355 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core
   [junit4]   2> 31358 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 31359 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 31359 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 31359 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 31359 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5ebb3269{/solr,null,AVAILABLE}
   [junit4]   2> 31360 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@101f33e4{HTTP/1.1,[http/1.1]}{127.0.0.1:56747}
   [junit4]   2> 31360 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.Server Started @32817ms
   [junit4]   2> 31360 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
configSetBaseDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001,
 hostPort=56747, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores}
   [junit4]   2> 31361 ERROR 
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 31361 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 31361 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 31361 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 31361 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-08T05:27:03.683864500Z
   [junit4]   2> 31361 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\solr.xml
   [junit4]   2> 31415 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores
   [junit4]   2> 31416 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 31464 INFO  (coreLoadExecutor-175-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 31470 WARN  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\models
 filtered by null to classpath: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\models
   [junit4]   2> 31471 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 31480 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 31487 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid 
field id
   [junit4]   2> 31490 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1,
 trusted=true
   [junit4]   2> 31490 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 31491 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data\]
   [junit4]   2> 31613 WARN  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers no default request handler is registered 
(either '/select' or 'standard')
   [junit4]   2> 31615 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 31615 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 31635 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
15000ms; 
   [junit4]   2> 31635 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 31637 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@26addad2[collection1] main]
   [junit4]   2> 31638 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1\conf
   [junit4]   2> 31638 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedFeatureStore for path 
/schema/feature-store
   [junit4]   2> 31638 WARN  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.ManagedResource No stored data found for 
/schema/feature-store
   [junit4]   2> 31638 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading 
------
   [junit4]   2> 31638 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 1 observers of 
/schema/feature-store
   [junit4]   2> 31638 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered new managed resource 
/schema/feature-store
   [junit4]   2> 31639 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedModelStore for path /schema/model-store
   [junit4]   2> 31639 WARN  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.ManagedResource No stored data found for 
/schema/model-store
   [junit4]   2> 31639 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 31639 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading 
------
   [junit4]   2> 31639 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 1 observers of 
/schema/model-store
   [junit4]   2> 31639 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered new managed resource 
/schema/model-store
   [junit4]   2> 31640 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 31640 INFO  
(searcherExecutor-176-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@26addad2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 31640 INFO  (coreLoadExecutor-175-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1594345991922778112
   [junit4]   2> 32151 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#56747
   [junit4]   2> 32192 INFO  (qtp1861676198-295) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">1</field><field+name%3D"title">w1</field><field+name%3D"description">w1</field><field+name%3D"popularity">1</field></doc></add>}{add=[1
 (1594345992468037632)]} 0 32
   [junit4]   2> 32201 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">2</field><field+name%3D"title">w2+2asd+asdd+didid</field><field+name%3D"description">w2+2asd+asdd+didid</field><field+name%3D"popularity">2</field></doc></add>}{add=[2
 (1594345992506834944)]} 0 4
   [junit4]   2> 32203 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">3</field><field+name%3D"title">w3</field><field+name%3D"description">w3</field><field+name%3D"popularity">3</field></doc></add>}{add=[3
 (1594345992512077824)]} 0 0
   [junit4]   2> 32205 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">4</field><field+name%3D"title">w4</field><field+name%3D"description">w4</field><field+name%3D"popularity">4</field></doc></add>}{add=[4
 (1594345992515223552)]} 0 0
   [junit4]   2> 32208 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">5</field><field+name%3D"title">w5</field><field+name%3D"description">w5</field><field+name%3D"popularity">5</field></doc></add>}{add=[5
 (1594345992517320704)]} 0 1
   [junit4]   2> 32213 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">6</field><field+name%3D"title">w1+w2</field><field+name%3D"description">w1+w2</field><field+name%3D"popularity">6</field></doc></add>}{add=[6
 (1594345992521515008)]} 0 3
   [junit4]   2> 32216 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">7</field><field+name%3D"title">w1+w2+w3+w4+w5</field><field+name%3D"description">w1+w2+w3+w4+w5+w8</field><field+name%3D"popularity">7</field></doc></add>}{add=[7
 (1594345992525709312)]} 0 1
   [junit4]   2> 32218 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">8</field><field+name%3D"title">w1+w1+w1+w2+w2+w8</field><field+name%3D"description">w1+w1+w1+w2+w2</field><field+name%3D"popularity">8</field></doc></add>}{add=[8
 (1594345992528855040)]} 0 0
   [junit4]   2> 32220 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594345992530952192,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 32221 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2f0857c6 
commitCommandVersion:1594345992530952192
   [junit4]   2> 32242 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2564498c[collection1] main]
   [junit4]   2> 32243 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 32243 INFO  
(searcherExecutor-176-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2564498c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C8)))}
   [junit4]   2> 32243 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<commit/>}{commit=} 0 22
   [junit4]   2> 32249 INFO  
(TEST-TestUserTermScorerQuery.testUserTermScorerQuery-seed#[2A93D66B0953E0FD]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testUserTermScorerQuery
   [junit4]   2> 32249 INFO  
(TEST-TestUserTermScorerQuery.testUserTermScorerQuery-seed#[2A93D66B0953E0FD]) 
[    ] o.a.s.l.TestRerankBase loading feauture 
   [junit4]   2> {
   [junit4]   2> "name":"matchedTitleDFExt",
   [junit4]   2> "store":"test",
   [junit4]   2> "class":"org.apache.solr.ltr.feature.SolrFeature",
   [junit4]   2> "params":{"q":"${user_query}","df":"title"}
   [junit4]   2> }
   [junit4]   2>  
   [junit4]   2> 32251 INFO  (qtp1861676198-292) [    x:collection1] 
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] ServerServlet: component class is 
null
   [junit4]   2> 32251 INFO  (qtp1861676198-292) [    x:collection1] 
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] Attaching application: 
org.apache.solr.rest.SolrSchemaRestApi@77ee2520 to URI: /solr/schema
   [junit4]   2> mar. 07, 2018 10:27:04 PM org.restlet.Application start
   [junit4]   2> INFO: Starting org.apache.solr.rest.SolrSchemaRestApi 
application
   [junit4]   2> 32261 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.SolrSchemaRestApi createInboundRoot started for /schema
   [junit4]   2> 32261 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /feature-store
   [junit4]   2> 32261 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /managed
   [junit4]   2> 32261 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /model-store
   [junit4]   2> 32261 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.RestManager Attached 3 ManagedResource endpoints to Restlet router: 
/schema
   [junit4]   2> 32261 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.SolrSchemaRestApi createInboundRoot complete for /schema
   [junit4]   2> 32262 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.RestManager Found ManagedResource 
[org.apache.solr.ltr.store.rest.ManagedFeatureStore@477a99d4] for 
/schema/feature-store
   [junit4]   2> 32262 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.ManagedResource Processing update to /schema/feature-store: 
{name=matchedTitleDFExt, store=test, 
class=org.apache.solr.ltr.feature.SolrFeature, params={q=${user_query}, 
df=title}} is a java.util.LinkedHashMap
   [junit4]   2> 32262 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitleDFExt, store=test, 
class=org.apache.solr.ltr.feature.SolrFeature, params={q=${user_query}, 
df=title}}
   [junit4]   2> 32267 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using 
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1\conf
   [junit4]   2> 32268 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.r.RestManager [collection1]  webapp=/solr path=/schema/feature-store 
params={indent=on&wt=json} status=0 QTime=17
   [junit4]   2> mar. 07, 2018 10:27:04 PM org.restlet.engine.log.LogFilter 
afterHandle
   [junit4]   2> INFO: 2018-03-07       22:27:04        127.0.0.1       -       
127.0.0.1       56747   PUT     /solr/schema/feature-store      
wt=json&indent=on       200     -       143     10      http://127.0.0.1:56747  
Apache-HttpClient/4.5.3 (Java/9.0.1)    -
   [junit4]   2> 32269 INFO  
(TEST-TestUserTermScorerQuery.testUserTermScorerQuery-seed#[2A93D66B0953E0FD]) 
[    ] o.a.s.l.TestRerankBase loading model 
   [junit4]   2> {
   [junit4]   2> "name":"Term-matchedTitleDFExt",
   [junit4]   2> "store":"test",
   [junit4]   2> "class":"org.apache.solr.ltr.model.LinearModel",
   [junit4]   2> "features":[
   [junit4]   2>        { "name":"matchedTitleDFExt"}
   [junit4]   2> ]
   [junit4]   2> ,
   [junit4]   2> "params":{"weights":{"matchedTitleDFExt":1.1}}
   [junit4]   2> }
   [junit4]   2>  
   [junit4]   2> 32270 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.r.RestManager Found ManagedResource [ManagedModelStore [store=ModelStore 
[availableModels=[]], 
featureStores=org.apache.solr.ltr.store.rest.ManagedFeatureStore@477a99d4]] for 
/schema/model-store
   [junit4]   2> 32270 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.r.ManagedResource Processing update to /schema/model-store: 
{name=Term-matchedTitleDFExt, store=test, 
class=org.apache.solr.ltr.model.LinearModel, 
features=[{name=matchedTitleDFExt}], params={weights={matchedTitleDFExt=1.1}}} 
is a java.util.LinkedHashMap
   [junit4]   2> 32274 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore adding model Term-matchedTitleDFExt
   [junit4]   2> 32274 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_model-store.json using 
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1\conf
   [junit4]   2> 32274 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.r.RestManager [collection1]  webapp=/solr path=/schema/model-store 
params={indent=on&wt=json} status=0 QTime=4
   [junit4]   2> mar. 07, 2018 10:27:04 PM org.restlet.engine.log.LogFilter 
afterHandle
   [junit4]   2> INFO: 2018-03-07       22:27:04        127.0.0.1       -       
127.0.0.1       56747   PUT     /solr/schema/model-store        
wt=json&indent=on       200     -       197     5       http://127.0.0.1:56747  
Apache-HttpClient/4.5.3 (Java/9.0.1)    -
   [junit4]   2> 32278 INFO  (qtp1861676198-292) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=title:w1&indent=on&fl=*,+score&rows=4&wt=json&rq={!ltr+model%3DTerm-matchedTitleDFExt+reRankDocs%3D4+efi.user_query%3Dw8}}
 hits=4 status=0 QTime=1
   [junit4]   2> 32282 INFO  (qtp1861676198-290) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=title:w1&indent=on&fl=*,+score&rows=4&wt=json&rq={!ltr+model%3DTerm-matchedTitleDFExt+reRankDocs%3D4+efi.user_query%3Dw8}}
 hits=4 status=0 QTime=1
   [junit4]   2> 32283 INFO  
(TEST-TestUserTermScorerQuery.testUserTermScorerQuery-seed#[2A93D66B0953E0FD]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testUserTermScorerQuery
   [junit4]   2> 32286 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@101f33e4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 32286 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=147057714
   [junit4]   2> 32287 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 32287 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 32287 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 32288 INFO  (coreCloseExecutor-181-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@15784d8b
   [junit4]   2> 32288 INFO  (coreCloseExecutor-181-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=360205707
   [junit4]   2> 32291 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5ebb3269{/solr,null,UNAVAILABLE}
   [junit4]   2> 32291 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 32296 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 32296 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1622081241
   [junit4]   2> 32296 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 32296 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3b450bd5: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ null
   [junit4]   2> 32296 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 32296 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7fa2bdbb: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
null
   [junit4]   2> 32296 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 32296 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2f1eeff3: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / null
   [junit4]   2> 32305 INFO  (coreCloseExecutor-183-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1020bd7e
   [junit4]   2> 32305 INFO  (coreCloseExecutor-183-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=270581118
   [junit4]   2> 32305 INFO  (coreCloseExecutor-183-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3ab2f22f: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / null
   [junit4]   2> 32307 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@25062ada),
 locale=fo-FO, timezone=America/Shiprock
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=3,threads=1,free=14737736,total=97452032
   [junit4]   2> NOTE: All tests run in this JVM: [TestModelManager, 
TestMultipleAdditiveTreesModel, TestFilterSolrFeature, 
TestParallelWeightCreation, TestWrapperModel, 
TestFeatureExtractionFromMultipleSegments, TestRankingFeature, 
TestUserTermScorerQuery]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestUserTermScorerQuery -Dtests.seed=2A93D66B0953E0FD 
-Dtests.slow=true -Dtests.locale=fo-FO -Dtests.timezone=America/Shiprock 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestUserTermScorerQuery (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\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data\tlog:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data\tlog
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J1\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([2A93D66B0953E0FD]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [26/37 (1!)] on J1 in 1.19s, 1 test, 1 error <<< FAILURES!

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

[repro] Revision: ee1c742c199c47894396c2e614a076d971e2d1df

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

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    lucene\test-framework
[repro]       TestCompressingTermVectorsFormat
[repro]    solr\contrib\ltr
[repro]       TestUserTermScorerQuery
[repro]    lucene\misc
[repro]       TestRAFDirectory
[repro] ant compile-test

[...truncated 142 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestCompressingTermVectorsFormat" -Dtests.showOutput=onerror 
"-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=DC44ECAE716A27B5 
-Dtests.slow=true -Dtests.locale=kn -Dtests.timezone=Asia/Sakhalin 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[...truncated 164 lines...]
[repro] ant compile-test

[...truncated 2534 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestUserTermScorerQuery" -Dtests.showOutput=onerror 
"-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=2A93D66B0953E0FD 
-Dtests.slow=true -Dtests.locale=fo-FO -Dtests.timezone=America/Shiprock 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8

[...truncated 41 lines...]
   [junit4] Suite: org.apache.solr.ltr.feature.TestUserTermScorerQuery
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\init-core-data-001
   [junit4]   2> 17168 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
   [junit4]   2> 17170 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 17179 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 17179 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 17180 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 17194 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.SolrConfig Couldn't add files from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\models
 filtered by null to classpath: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\models
   [junit4]   2> 17219 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 17315 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=example
   [junit4]   2> 17340 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
   [junit4]   2> 17480 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 17480 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 17480 WARN  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 17491 INFO  (coreLoadExecutor-32-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 17531 WARN  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\models
 filtered by null to classpath: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\models
   [junit4]   2> 17534 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 17602 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 17662 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
   [junit4]   2> 17668 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 17673 WARN  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 17673 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 17673 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\init-core-data-001\]
   [junit4]   2> 17853 WARN  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.c.RequestHandlers no default request handler is registered (either 
'/select' or 'standard')
   [junit4]   2> 17854 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 17859 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 17862 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 17862 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 17929 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1c32faf4[collection1] main]
   [junit4]   2> 17930 WARN  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\contrib\ltr\src\test-files\solr\collection1\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedFeatureStore for path 
/schema/feature-store
   [junit4]   2> 17930 WARN  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource No stored data found for /schema/feature-store
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading ------
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 1 observers of /schema/feature-store
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered new managed resource /schema/feature-store
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedModelStore for path /schema/model-store
   [junit4]   2> 17930 WARN  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource No stored data found for /schema/model-store
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading ------
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 1 observers of /schema/model-store
   [junit4]   2> 17930 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered new managed resource /schema/model-store
   [junit4]   2> 17931 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 17932 INFO  
(searcherExecutor-33-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1c32faf4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 17933 INFO  (coreLoadExecutor-32-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1594346526772035584
   [junit4]   2> 17937 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 17957 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 17957 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 17959 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core
   [junit4]   2> 17963 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T14:27:37-07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 17964 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 17964 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 17964 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 17965 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@e4b6f6a{/solr,null,AVAILABLE}
   [junit4]   2> 17966 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@2d2197c{HTTP/1.1,[http/1.1]}{127.0.0.1:56991}
   [junit4]   2> 17967 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.Server Started @19910ms
   [junit4]   2> 17967 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
configSetBaseDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001,
 hostPort=56991, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores}
   [junit4]   2> 17968 ERROR 
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 17968 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 17968 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 17968 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 17968 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-08T05:35:34.069350200Z
   [junit4]   2> 17969 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\solr.xml
   [junit4]   2> 18144 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores
   [junit4]   2> 18145 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 18156 INFO  (coreLoadExecutor-43-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 18192 WARN  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\models
 filtered by null to classpath: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\models
   [junit4]   2> 18194 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 18225 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 18261 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
   [junit4]   2> 18267 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1,
 trusted=true
   [junit4]   2> 18267 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 18269 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-003\cores\core\data\]
   [junit4]   2> 18589 WARN  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.c.RequestHandlers no default request handler is registered (either 
'/select' or 'standard')
   [junit4]   2> 18591 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 18591 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 18595 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 18595 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 18722 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@71edb3c[collection1] main]
   [junit4]   2> 18723 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1\conf
   [junit4]   2> 18725 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedFeatureStore for path 
/schema/feature-store
   [junit4]   2> 18725 WARN  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource No stored data found for /schema/feature-store
   [junit4]   2> 18725 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading ------
   [junit4]   2> 18725 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 1 observers of /schema/feature-store
   [junit4]   2> 18725 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered new managed resource /schema/feature-store
   [junit4]   2> 18725 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedModelStore for path /schema/model-store
   [junit4]   2> 18725 WARN  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource No stored data found for /schema/model-store
   [junit4]   2> 18727 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 18727 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading ------
   [junit4]   2> 18727 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 1 observers of /schema/model-store
   [junit4]   2> 18728 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered new managed resource /schema/model-store
   [junit4]   2> 18728 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 18737 INFO  (coreLoadExecutor-43-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1594346527615090688
   [junit4]   2> 18741 INFO  
(searcherExecutor-44-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@71edb3c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 18742 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#56991
   [junit4]   2> 18773 INFO  (qtp369881706-115) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">1</field><field+name%3D"title">w1</field><field+name%3D"description">w1</field><field+name%3D"popularity">1</field></doc></add>}{add=[1
 (1594346527638159360)]} 0 18
   [junit4]   2> 18856 INFO  (qtp369881706-115) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">2</field><field+name%3D"title">w2+2asd+asdd+didid</field><field+name%3D"description">w2+2asd+asdd+didid</field><field+name%3D"popularity">2</field></doc></add>}{add=[2
 (1594346527735676928)]} 0 71
   [junit4]   2> 18876 INFO  (qtp369881706-115) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">3</field><field+name%3D"title">w3</field><field+name%3D"description">w3</field><field+name%3D"popularity">3</field></doc></add>}{add=[3
 (1594346527758745600)]} 0 2
   [junit4]   2> 18890 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">4</field><field+name%3D"title">w4</field><field+name%3D"description">w4</field><field+name%3D"popularity">4</field></doc></add>}{add=[4
 (1594346527768182784)]} 0 8
   [junit4]   2> 18894 INFO  (qtp369881706-110) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">5</field><field+name%3D"title">w5</field><field+name%3D"description">w5</field><field+name%3D"popularity">5</field></doc></add>}{add=[5
 (1594346527779717120)]} 0 1
   [junit4]   2> 18908 INFO  (qtp369881706-110) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">6</field><field+name%3D"title">w1+w2</field><field+name%3D"description">w1+w2</field><field+name%3D"popularity">6</field></doc></add>}{add=[6
 (1594346527794397184)]} 0 1
   [junit4]   2> 18926 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">7</field><field+name%3D"title">w1+w2+w3+w4+w5</field><field+name%3D"description">w1+w2+w3+w4+w5+w8</field><field+name%3D"popularity">7</field></doc></add>}{add=[7
 (1594346527812222976)]} 0 4
   [junit4]   2> 18933 INFO  (qtp369881706-110) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">8</field><field+name%3D"title">w1+w1+w1+w2+w2+w8</field><field+name%3D"description">w1+w1+w1+w2+w2</field><field+name%3D"popularity">8</field></doc></add>}{add=[8
 (1594346527818514432)]} 0 3
   [junit4]   2> 18939 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594346527826903040,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 18940 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@26113aca 
commitCommandVersion:1594346527826903040
   [junit4]   2> 18985 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@664b7c74[collection1] main]
   [junit4]   2> 18994 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 18995 INFO  
(searcherExecutor-44-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@664b7c74[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C8)))}
   [junit4]   2> 18995 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<commit/>}{commit=} 0 57
   [junit4]   2> 19006 INFO  
(TEST-TestUserTermScorerQuery.testUserTermScorerQuery-seed#[2A93D66B0953E0FD]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testUserTermScorerQuery
   [junit4]   2> 19006 INFO  
(TEST-TestUserTermScorerQuery.testUserTermScorerQuery-seed#[2A93D66B0953E0FD]) 
[    ] o.a.s.l.TestRerankBase loading feauture 
   [junit4]   2> {
   [junit4]   2> "name":"matchedTitleDFExt",
   [junit4]   2> "store":"test",
   [junit4]   2> "class":"org.apache.solr.ltr.feature.SolrFeature",
   [junit4]   2> "params":{"q":"${user_query}","df":"title"}
   [junit4]   2> }
   [junit4]   2>  
   [junit4]   2> 19016 INFO  (qtp369881706-112) [    x:collection1] 
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] ServerServlet: component class is 
null
   [junit4]   2> 19028 INFO  (qtp369881706-112) [    x:collection1] 
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] Attaching application: 
org.apache.solr.rest.SolrSchemaRestApi@ec86f79 to URI: /solr/schema
   [junit4]   2> mar. 07, 2018 10:35:35 PM org.restlet.Application start
   [junit4]   2> INFO: Starting org.apache.solr.rest.SolrSchemaRestApi 
application
   [junit4]   2> 19052 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.SolrSchemaRestApi createInboundRoot started for /schema
   [junit4]   2> 19052 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /feature-store
   [junit4]   2> 19052 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /managed
   [junit4]   2> 19052 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /model-store
   [junit4]   2> 19052 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.RestManager Attached 3 ManagedResource endpoints to Restlet router: 
/schema
   [junit4]   2> 19052 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.SolrSchemaRestApi createInboundRoot complete for /schema
   [junit4]   2> 19054 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.RestManager Found ManagedResource 
[org.apache.solr.ltr.store.rest.ManagedFeatureStore@7908abfb] for 
/schema/feature-store
   [junit4]   2> 19055 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.ManagedResource Processing update to /schema/feature-store: 
{name=matchedTitleDFExt, store=test, 
class=org.apache.solr.ltr.feature.SolrFeature, params={q=${user_query}, 
df=title}} is a java.util.LinkedHashMap
   [junit4]   2> 19055 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitleDFExt, store=test, 
class=org.apache.solr.ltr.feature.SolrFeature, params={q=${user_query}, 
df=title}}
   [junit4]   2> 19084 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using 
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1\conf
   [junit4]   2> 19085 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.RestManager [collection1]  webapp=/solr path=/schema/feature-store 
params={indent=on&wt=json} status=0 QTime=76
   [junit4]   2> mar. 07, 2018 10:35:35 PM org.restlet.engine.log.LogFilter 
afterHandle
   [junit4]   2> INFO: 2018-03-07       22:35:35        127.0.0.1       -       
127.0.0.1       56991   PUT     /solr/schema/feature-store      
wt=json&indent=on       200     -       143     57      http://127.0.0.1:56991  
Apache-HttpClient/4.5.3 (Java/9.0.1)    -
   [junit4]   2> 19091 INFO  
(TEST-TestUserTermScorerQuery.testUserTermScorerQuery-seed#[2A93D66B0953E0FD]) 
[    ] o.a.s.l.TestRerankBase loading model 
   [junit4]   2> {
   [junit4]   2> "name":"Term-matchedTitleDFExt",
   [junit4]   2> "store":"test",
   [junit4]   2> "class":"org.apache.solr.ltr.model.LinearModel",
   [junit4]   2> "features":[
   [junit4]   2>        { "name":"matchedTitleDFExt"}
   [junit4]   2> ]
   [junit4]   2> ,
   [junit4]   2> "params":{"weights":{"matchedTitleDFExt":1.1}}
   [junit4]   2> }
   [junit4]   2>  
   [junit4]   2> 19095 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.RestManager Found ManagedResource [ManagedModelStore [store=ModelStore 
[availableModels=[]], 
featureStores=org.apache.solr.ltr.store.rest.ManagedFeatureStore@7908abfb]] for 
/schema/model-store
   [junit4]   2> 19095 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.ManagedResource Processing update to /schema/model-store: 
{name=Term-matchedTitleDFExt, store=test, 
class=org.apache.solr.ltr.model.LinearModel, 
features=[{name=matchedTitleDFExt}], params={weights={matchedTitleDFExt=1.1}}} 
is a java.util.LinkedHashMap
   [junit4]   2> 19108 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore adding model Term-matchedTitleDFExt
   [junit4]   2> 19109 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_model-store.json using 
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-ltr\test\J0\temp\solr.ltr.feature.TestUserTermScorerQuery_2A93D66B0953E0FD-001\tempDir-001\collection1\conf
   [junit4]   2> 19109 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.r.RestManager [collection1]  webapp=/solr path=/schema/model-store 
params={indent=on&wt=json} status=0 QTime=15
   [junit4]   2> mar. 07, 2018 10:35:35 PM org.restlet.engine.log.LogFilter 
afterHandle
   [junit4]   2> INFO: 2018-03-07       22:35:35        127.0.0.1       -       
127.0.0.1       56991   PUT     /solr/schema/model-store        
wt=json&indent=on       200     -       197     15      http://127.0.0.1:56991  
Apache-HttpClient/4.5.3 (Java/9.0.1)    -
   [junit4]   2> 19119 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=title:w1&indent=on&fl=*,+score&rows=4&wt=json&rq={!ltr+model%3DTerm-matchedTitleDFExt+reRankDocs%3D4+efi.user_query%3Dw8}}
 hits=4 status=0 QTime=3
   [junit4]   2> 19127 INFO  (qtp369881706-112) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=title:w1&indent=on&fl=*,+score&rows=4&wt=json&rq={!ltr+model%3DTerm-matchedTitleDFExt+reRankDocs%3D4+efi.user_query%3Dw8}}
 hits=4 status=0 QTime=2
   [junit4]   2> 19132 INFO  
(TEST-TestUserTermScorerQuery.testUserTermScorerQuery-seed#[2A93D66B0953E0FD]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testUserTermScorerQuery
   [junit4] OK      0.14s J0 | TestUserTermScorerQuery.testUserTermScorerQuery
   [junit4]   2> 19137 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@2d2197c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 19137 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=353515945
   [junit4]   2> 19138 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 19138 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 19138 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 19140 INFO  (coreCloseExecutor-49-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@49dc5bf3
   [junit4]   2> 19140 INFO  (coreCloseExecutor-49-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1239178227
   [junit4]   2> 19147 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@e4b6f6a{/solr,null,UNAVAILABLE}
   [junit4]   2> 19147 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 19157 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 19157 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1128751325
   [junit4]   2> 19158 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 19160 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@35783bd: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ null
   [junit4]   2> 19160 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 19160 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3633b5bd: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
null
   [junit4]   2> 19160 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 19162 INFO  
(SUITE-TestUserTermScorerQuery-seed#[2A93D66B0953E0FD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxR

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

tory.testSeekBeyondEndOfFile
   [junit4] OK      0.02s J0 | TestRAFDirectory.testRandomLong
   [junit4] OK      0.01s J0 | TestRAFDirectory.testByte
   [junit4] Completed [3/5] on J0 in 3.84s, 42 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestRAFDirectory
   [junit4] OK      0.11s J1 | TestRAFDirectory.testSeekToEndOfFile
   [junit4] OK      0.00s J1 | TestRAFDirectory.testDoubleCloseDirectory
   [junit4] OK      0.00s J1 | TestRAFDirectory.testVInt
   [junit4] OK      1.45s J1 | TestRAFDirectory.testThreadSafety
   [junit4] OK      0.01s J1 | TestRAFDirectory.testLargeWrites
   [junit4] OK      0.00s J1 | TestRAFDirectory.testSetOfStrings
   [junit4] OK      0.04s J1 | TestRAFDirectory.testRandomByte
   [junit4] OK      0.01s J1 | TestRAFDirectory.testRename
   [junit4] OK      0.01s J1 | TestRAFDirectory.testShort
   [junit4] OK      0.09s J1 | TestRAFDirectory.testCopyBytes
   [junit4] OK      0.27s J1 | TestRAFDirectory.testCopyBytesWithThreads
   [junit4] OK      0.01s J1 | TestRAFDirectory.testSliceOfSlice
   [junit4] OK      0.10s J1 | TestRAFDirectory.testCopyFrom
   [junit4] OK      0.00s J1 | TestRAFDirectory.testDetectClose
   [junit4] OK      0.00s J1 | TestRAFDirectory.testZLong
   [junit4] OK      0.01s J1 | TestRAFDirectory.testVLong
   [junit4] OK      0.14s J1 | TestRAFDirectory.testPendingDeletions
   [junit4] OK      0.01s J1 | TestRAFDirectory.testString
   [junit4] OK      0.00s J1 | TestRAFDirectory.testSeekToEOFThenBack
   [junit4] OK      0.15s J1 | TestRAFDirectory.testRandomInt
   [junit4] OK      0.02s J1 | TestRAFDirectory.testListAllIsSorted
   [junit4] OK      0.00s J1 | TestRAFDirectory.testDoubleCloseOutput
   [junit4] OK      0.04s J1 | TestRAFDirectory.testCreateTempOutput
   [junit4] OK      0.00s J1 | TestRAFDirectory.testZInt
   [junit4] OK      0.00s J1 | TestRAFDirectory.testInt
   [junit4] OK      0.06s J1 | TestRAFDirectory.testRandomShort
   [junit4] OK      0.00s J1 | TestRAFDirectory.testIndexOutputToString
   [junit4] OK      0.00s J1 | TestRAFDirectory.testDirectoryFilter
   [junit4] OK      0.00s J1 | TestRAFDirectory.testDoubleCloseInput
   [junit4] OK      0.01s J1 | TestRAFDirectory.testCopyFromDestination
   [junit4] OK      0.00s J1 | TestRAFDirectory.testMapOfStrings
   [junit4] OK      0.00s J1 | TestRAFDirectory.testChecksum
   [junit4] OK      0.00s J1 | TestRAFDirectory.testSeekPastEOF
   [junit4] OK      0.00s J1 | TestRAFDirectory.testLong
   [junit4] OK      0.01s J1 | TestRAFDirectory.testSliceOutOfBounds
   [junit4] OK      0.00s J1 | TestRAFDirectory.testDeleteFile
   [junit4] OK      0.00s J1 | TestRAFDirectory.testNoDir
   [junit4] OK      0.00s J1 | TestRAFDirectory.testIllegalEOF
   [junit4] OK      0.01s J1 | TestRAFDirectory.testFsyncDoesntCreateNewFiles
   [junit4] OK      0.00s J1 | TestRAFDirectory.testSeekBeyondEndOfFile
   [junit4] OK      0.03s J1 | TestRAFDirectory.testRandomLong
   [junit4] OK      0.00s J1 | TestRAFDirectory.testByte
   [junit4] Completed [4/5] on J1 in 4.42s, 42 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestRAFDirectory
   [junit4] OK      0.01s J0 | TestRAFDirectory.testSeekToEndOfFile
   [junit4] OK      0.00s J0 | TestRAFDirectory.testDoubleCloseDirectory
   [junit4] OK      0.00s J0 | TestRAFDirectory.testVInt
   [junit4] OK      1.59s J0 | TestRAFDirectory.testThreadSafety
   [junit4] OK      0.00s J0 | TestRAFDirectory.testLargeWrites
   [junit4] OK      0.00s J0 | TestRAFDirectory.testSetOfStrings
   [junit4] OK      0.02s J0 | TestRAFDirectory.testRandomByte
   [junit4] OK      0.01s J0 | TestRAFDirectory.testRename
   [junit4] OK      0.00s J0 | TestRAFDirectory.testShort
   [junit4] OK      0.03s J0 | TestRAFDirectory.testCopyBytes
   [junit4] OK      0.03s J0 | TestRAFDirectory.testCopyBytesWithThreads
   [junit4] OK      0.00s J0 | TestRAFDirectory.testSliceOfSlice
   [junit4] OK      0.01s J0 | TestRAFDirectory.testCopyFrom
   [junit4] OK      0.00s J0 | TestRAFDirectory.testDetectClose
   [junit4] OK      0.00s J0 | TestRAFDirectory.testZLong
   [junit4] OK      0.00s J0 | TestRAFDirectory.testVLong
   [junit4] OK      0.05s J0 | TestRAFDirectory.testPendingDeletions
   [junit4] OK      0.00s J0 | TestRAFDirectory.testString
   [junit4] OK      0.00s J0 | TestRAFDirectory.testSeekToEOFThenBack
   [junit4] OK      0.12s J0 | TestRAFDirectory.testRandomInt
   [junit4] OK      0.01s J0 | TestRAFDirectory.testListAllIsSorted
   [junit4] OK      0.00s J0 | TestRAFDirectory.testDoubleCloseOutput
   [junit4] OK      0.03s J0 | TestRAFDirectory.testCreateTempOutput
   [junit4] OK      0.00s J0 | TestRAFDirectory.testZInt
   [junit4] OK      0.00s J0 | TestRAFDirectory.testInt
   [junit4] OK      0.06s J0 | TestRAFDirectory.testRandomShort
   [junit4] OK      0.00s J0 | TestRAFDirectory.testIndexOutputToString
   [junit4] OK      0.00s J0 | TestRAFDirectory.testDirectoryFilter
   [junit4] OK      0.00s J0 | TestRAFDirectory.testDoubleCloseInput
   [junit4] OK      0.00s J0 | TestRAFDirectory.testCopyFromDestination
   [junit4] OK      0.01s J0 | TestRAFDirectory.testMapOfStrings
   [junit4] OK      0.00s J0 | TestRAFDirectory.testChecksum
   [junit4] OK      0.00s J0 | TestRAFDirectory.testSeekPastEOF
   [junit4] OK      0.00s J0 | TestRAFDirectory.testLong
   [junit4] OK      0.00s J0 | TestRAFDirectory.testSliceOutOfBounds
   [junit4] OK      0.00s J0 | TestRAFDirectory.testDeleteFile
   [junit4] OK      0.00s J0 | TestRAFDirectory.testNoDir
   [junit4] OK      0.00s J0 | TestRAFDirectory.testIllegalEOF
   [junit4] OK      0.00s J0 | TestRAFDirectory.testFsyncDoesntCreateNewFiles
   [junit4] OK      0.00s J0 | TestRAFDirectory.testSeekBeyondEndOfFile
   [junit4] OK      0.02s J0 | TestRAFDirectory.testRandomLong
   [junit4] OK      0.00s J0 | TestRAFDirectory.testByte
   [junit4] Completed [5/5] on J0 in 2.97s, 42 tests
   [junit4] 
   [junit4] JVM J0:     1.10 ..    13.76 =    12.66s
   [junit4] JVM J1:     1.10 ..    12.75 =    11.65s
   [junit4] Execution time total: 13 seconds
   [junit4] Tests summary: 5 suites, 210 tests
   [junit4] Could not remove temporary path: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0 
(java.nio.file.DirectoryNotEmptyException: Remaining files: 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J0\temp])
   [junit4] Could not remove temporary path: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J1 
(java.nio.file.DirectoryNotEmptyException: Remaining files: 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\misc\test\J1\temp])
     [echo] 5 slowest tests:
[junit4:tophints]  10.07s | org.apache.lucene.misc.SweetSpotSimilarityTest
[junit4:tophints]   8.68s | 
org.apache.lucene.store.TestHardLinkCopyDirectoryWrapper
[junit4:tophints]   7.80s | org.apache.lucene.search.TestInetAddressRangeQueries
[junit4:tophints]   4.12s | org.apache.lucene.store.TestRAFDirectory
[junit4:tophints]   1.84s | org.apache.lucene.util.fst.TestFSTsMisc

-check-totals:
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by 
org.codehaus.groovy.reflection.CachedClass 
(file:/C:/Users/jenkins/.ivy2/cache/org.codehaus.groovy/groovy-all/jars/groovy-all-2.4.13.jar)
 to method java.lang.Object.finalize()
WARNING: Please consider reporting this to the maintainers of 
org.codehaus.groovy.reflection.CachedClass
WARNING: Use --illegal-access=warn to enable warnings of further illegal 
reflective access operations
WARNING: All illegal access operations will be denied in a future release

test-nocompile:

BUILD SUCCESSFUL
Total time: 17 seconds
[repro] Failures:
[repro]   0/5 failed: 
org.apache.lucene.codecs.compressing.TestCompressingTermVectorsFormat
[repro]   0/5 failed: org.apache.lucene.store.TestRAFDirectory
[repro]   1/5 failed: org.apache.solr.ltr.feature.TestUserTermScorerQuery
[repro] Exiting with code 1

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST lucene\build 
move /y lucene\build lucene\build.repro 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST solr\build move 
/y solr\build solr\build.repro 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST 
lucene\build.orig move /y lucene\build.orig lucene\build 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST solr\build.orig 
move /y solr\build.orig solr\build 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>exit 0 
Archiving artifacts
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all 
warnings.
<Git Blamer> GIT_COMMIT=ee1c742c199c47894396c2e614a076d971e2d1df, 
workspace=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows
[WARNINGS] Computing warning deltas based on reference build #7207
Recording test results
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting 
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to