Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.2-Windows/25/
Java: 32bit/jdk1.8.0_144 -client -XX:+UseParallelGC

3 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.lucene.store.TestFileSwitchDirectory

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_174B936D7F1638F4-001\foo-008:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_174B936D7F1638F4-001\foo-008
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_174B936D7F1638F4-001\foo-008:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_174B936D7F1638F4-001\foo-008

        at __randomizedtesting.SeedInfo.seed([174B936D7F1638F4]: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.lang.Thread.run(Thread.java:748)


FAILED:  
junit.framework.TestSuite.org.apache.lucene.store.TestSimpleFSLockFactory

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007
    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007\extra0:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007\extra0
    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007
   
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007\extra0:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007\extra0
   
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001

        at __randomizedtesting.SeedInfo.seed([174B936D7F1638F4]: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.lang.Thread.run(Thread.java:748)


FAILED:  junit.framework.TestSuite.org.apache.solr.search.TestPseudoReturnFields

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog
    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001
    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog\tlog.0000000000000000000:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog\tlog.0000000000000000000
    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog
   
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001
   
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog\tlog.0000000000000000000:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog\tlog.0000000000000000000
   
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001

        at __randomizedtesting.SeedInfo.seed([BD018FE78F815C8E]: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.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 884 lines...]
   [junit4] Suite: org.apache.lucene.store.TestSimpleFSLockFactory
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{content=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
 docValues:{}, maxPointsInLeafNode=717, maxMBSortInHeap=7.802999260098814, 
sim=RandomSimilarity(queryNorm=true): {content=DFR I(n)B2}, locale=et-EE, 
timezone=Europe/London
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 
(32-bit)/cpus=3,threads=1,free=193312400,total=293076992
   [junit4]   2> NOTE: All tests run in this JVM: [TestSpanNotQuery, 
TestBM25Similarity, TestFlex, TestBasics, TestUsageTrackingFilterCachingPolicy, 
TestPerFieldPostingsFormat2, TestEarlyTerminatingSortingCollector, 
TestBoolean2, TestTermVectorsReader, TestTermsEnum, TestSortRandom, 
TestDelegatingAnalyzerWrapper, TestFixedLengthBytesRefArray, TestDateTools, 
TestAllFilesHaveChecksumFooter, TestGeoUtils, TestPayloads, TestCustomTermFreq, 
TestIndexWriterLockRelease, TestBytesRefArray, TestDirectMonotonic, 
TestCharTermAttributeImpl, TestQueryBuilder, TestLongValuesSource, 
TestPagedBytes, TestSearchAfter, TestDemo, TestNIOFSDirectory, 
TestIndexWriterNRTIsCurrent, TestReadOnlyIndex, TestBlockPostingsFormat, 
TestRateLimiter, TestBlendedTermQuery, TestMultiTermsEnum, Test2BBKDPoints, 
TestBooleanScorer, TestSpanMultiTermQueryWrapper, TestReaderClosed, 
TestIndexTooManyDocs, TestNRTCachingDirectory, TestShardSearching, 
TestDocumentWriter, TestTermVectorsWriter, TestAutomatonQuery, 
TestIntroSelector, TestPositiveScoresOnlyCollector, TestSimilarityBase, 
TestMultiLevelSkipList, TestLongPostings, TestGraphTokenStreamFiniteStrings, 
TestSegmentTermDocs, TestTransactions, TestFuzzyQuery, TestFieldValueQuery, 
TestNoMergeScheduler, TestPointQueries, TestNRTThreads, TestStressDeletes, 
TestForTooMuchCloning, TestNGramPhraseQuery, TestBooleanRewrites, 
TestPrefixCodedTerms, TestIndexWriterOutOfFileDescriptors, 
TestIndexWriterDelete, TestPerFieldPostingsFormat, TestSpanFirstQuery, 
TestSizeBoundedForceMerge, TestLucene50StoredFieldsFormatHighCompression, 
TestDocIdsWriter, TestSimpleFSLockFactory]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestSimpleFSLockFactory -Dtests.seed=174B936D7F1638F4 
-Dtests.slow=true -Dtests.locale=et-EE -Dtests.timezone=Europe/London 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J1 | TestSimpleFSLockFactory (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-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007\extra0:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001\tempDir-007\extra0
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_174B936D7F1638F4-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([174B936D7F1638F4]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] Completed [200/458 (1!)] on J1 in 7.25s, 7 tests, 1 error <<< 
FAILURES!

[...truncated 360 lines...]
   [junit4] Suite: org.apache.lucene.store.TestFileSwitchDirectory
   [junit4] IGNOR/A 0.01s J1 | 
TestFileSwitchDirectory.testFsyncDoesntCreateNewFiles
   [junit4]    > Assumption #1: test only works for FSDirectory subclasses
   [junit4] IGNOR/A 0.01s J1 | TestFileSwitchDirectory.testPendingDeletions
   [junit4]    > Assumption #1: we can only install VirusCheckingFS on an 
FSDirectory
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=RandomSimilarity(queryNorm=false): {}, locale=ar-LY, 
timezone=America/Guadeloupe
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 
(32-bit)/cpus=3,threads=1,free=54058544,total=265027584
   [junit4]   2> NOTE: All tests run in this JVM: [TestSpanNotQuery, 
TestBM25Similarity, TestFlex, TestBasics, TestUsageTrackingFilterCachingPolicy, 
TestPerFieldPostingsFormat2, TestEarlyTerminatingSortingCollector, 
TestBoolean2, TestTermVectorsReader, TestTermsEnum, TestSortRandom, 
TestDelegatingAnalyzerWrapper, TestFixedLengthBytesRefArray, TestDateTools, 
TestAllFilesHaveChecksumFooter, TestGeoUtils, TestPayloads, TestCustomTermFreq, 
TestIndexWriterLockRelease, TestBytesRefArray, TestDirectMonotonic, 
TestCharTermAttributeImpl, TestQueryBuilder, TestLongValuesSource, 
TestPagedBytes, TestSearchAfter, TestDemo, TestNIOFSDirectory, 
TestIndexWriterNRTIsCurrent, TestReadOnlyIndex, TestBlockPostingsFormat, 
TestRateLimiter, TestBlendedTermQuery, TestMultiTermsEnum, Test2BBKDPoints, 
TestBooleanScorer, TestSpanMultiTermQueryWrapper, TestReaderClosed, 
TestIndexTooManyDocs, TestNRTCachingDirectory, TestShardSearching, 
TestDocumentWriter, TestTermVectorsWriter, TestAutomatonQuery, 
TestIntroSelector, TestPositiveScoresOnlyCollector, TestSimilarityBase, 
TestMultiLevelSkipList, TestLongPostings, TestGraphTokenStreamFiniteStrings, 
TestSegmentTermDocs, TestTransactions, TestFuzzyQuery, TestFieldValueQuery, 
TestNoMergeScheduler, TestPointQueries, TestNRTThreads, TestStressDeletes, 
TestForTooMuchCloning, TestNGramPhraseQuery, TestBooleanRewrites, 
TestPrefixCodedTerms, TestIndexWriterOutOfFileDescriptors, 
TestIndexWriterDelete, TestPerFieldPostingsFormat, TestSpanFirstQuery, 
TestSizeBoundedForceMerge, TestLucene50StoredFieldsFormatHighCompression, 
TestDocIdsWriter, TestSimpleFSLockFactory, TestDirectoryReaderReopen, 
TestConcurrentMergeScheduler, TestMultiFields, TestCharsRef, 
TestNRTReaderWithThreads, TestMaxTermFrequency, TestMinShouldMatch2, 
TestLSBRadixSorter, TestReqExclBulkScorer, TestStressIndexing, 
TestNumericUtils, TestDirectory, TestMultiTermConstantScore, TestTermdocPerf, 
TestTermVectors, TestTermRangeQuery, TestIndexWriterForceMerge, 
TestIndexReaderClose, TestMultiPhraseEnum, TestRollingBuffer, 
TestSentinelIntSet, TestTransactionRollback, TestParallelTermEnum, 
TestIndexWriterMaxDocs, TestLucene70NormsFormat, TestDoubleRangeFieldQueries, 
TestDocValuesQueries, TestStopFilter, TestTotalHitCountCollector, 
TestSpanTermQuery, TestIndexWriterExceptions2, TestCompiledAutomaton, 
TestPolygon2D, TestExitableDirectoryReader, TestIndexWriterOnJRECrash, TestNot, 
TestLucene60FieldInfoFormat, TestCustomSearcherSort, TestIndexWriterReader, 
Test2BPostings, TestBytesRefHash, TestUpgradeIndexMergePolicy, TestDeterminism, 
TestPrefixInBooleanQuery, TestFastDecompressionMode, 
TestMultiThreadTermVectors, TestSimpleSearchEquivalence, 
TestDeterminizeLexicon, TestIndexWriterOnDiskFull, TestMixedCodecs, 
TestSpanExplanations, TestFastCompressionMode, TestStressIndexing2, 
TestLazyProxSkipping, TestMergeSchedulerExternal, TestIndexInput, 
TestDisjunctionMaxQuery, TestNearSpansOrdered, TestSameScoresWithThreads, 
TestLiveFieldValues, TestSpanSearchEquivalence, TestDoc, TestNoDeletionPolicy, 
TestPerSegmentDeletes, TestUniqueTermCount, TestAllFilesHaveCodecHeader, 
TestTermScorer, TestFileSwitchDirectory]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestFileSwitchDirectory -Dtests.seed=174B936D7F1638F4 
-Dtests.slow=true -Dtests.locale=ar-LY -Dtests.timezone=America/Guadeloupe 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J1 | TestFileSwitchDirectory (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-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_174B936D7F1638F4-001\foo-008:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_174B936D7F1638F4-001\foo-008
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([174B936D7F1638F4]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] Completed [313/458 (2!)] on J1 in 1.83s, 43 tests, 1 error, 2 
skipped <<< FAILURES!

[...truncated 11105 lines...]
   [junit4] Suite: org.apache.solr.search.TestPseudoReturnFields
   [junit4]   2> 1037597 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001
   [junit4]   2> 1037598 WARN  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=8 numCloses=8
   [junit4]   2> 1037598 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1037604 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1037606 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1037607 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-7.2-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-7.2-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1037659 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 1037675 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1037682 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
   [junit4]   2> 1037771 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1891979
   [junit4]   2> 1037781 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1891979
   [junit4]   2> 1037781 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1891979
   [junit4]   2> 1037783 INFO  (coreLoadExecutor-3601-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1037784 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-7.2-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-7.2-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1037845 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 1037856 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1037863 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
   [junit4]   2> 1037865 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 1037865 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1891979
   [junit4]   2> 1037866 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1037866 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\]
   [junit4]   2> 1037868 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7333941606540909]
   [junit4]   2> 1037871 WARN  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1037956 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1037956 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1037957 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1037957 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1037958 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=36.5146484375, 
floorSegmentMB=1.2392578125, forceMergeDeletesPctAllowed=6.590052646463342, 
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4227531346210215
   [junit4]   2> 1037958 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3d2b55[collection1] 
main]
   [junit4]   2> 1037959 WARN  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\core\src\test-files\solr\collection1\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1037959 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1037960 INFO  (coreLoadExecutor-3601-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1587293395059998720
   [junit4]   2> 1037962 INFO  
(searcherExecutor-3602-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3d2b55[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1037962 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1037966 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[42 (1587293395063144448)]} 0 3
   [junit4]   2> 1037972 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[43 (1587293395071533056)]} 0 0
   [junit4]   2> 1037973 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[44 (1587293395073630208)]} 0 0
   [junit4]   2> 1037974 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[45 (1587293395074678784)]} 0 0
   [junit4]   2> 1037975 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[46 (1587293395074678785)]} 0 0
   [junit4]   2> 1037975 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1587293395075727360,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1037975 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@23a96f 
commitCommandVersion:1587293395075727360
   [junit4]   2> 1037982 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@af1a69[collection1] main]
   [junit4]   2> 1037983 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1037989 INFO  (searcherExecutor-3602-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@af1a69[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C5)))}
   [junit4]   2> 1037989 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 13
   [junit4]   2> 1037991 INFO  
(TEST-TestPseudoReturnFields.testScoreAndAllRealFields-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testScoreAndAllRealFields
   [junit4]   2> 1037993 INFO  
(TEST-TestPseudoReturnFields.testScoreAndAllRealFields-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395093553152)]} 0 2
   [junit4]   2> 1037994 INFO  
(TEST-TestPseudoReturnFields.testScoreAndAllRealFields-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=score,*&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1037996 INFO  
(TEST-TestPseudoReturnFields.testScoreAndAllRealFields-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=*,score&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1037996 INFO  
(TEST-TestPseudoReturnFields.testScoreAndAllRealFields-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testScoreAndAllRealFields
   [junit4]   2> 1037999 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScore-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testGlobsAndScore
   [junit4]   2> 1038000 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScore-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395101941760)]} 0 0
   [junit4]   2> 1038001 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScore-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&indent=true&fl=val_*,score&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038002 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScore-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,subj*,score&q=*:*&rows=1} hits=5 status=0 QTime=0
   [junit4]   2> 1038002 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScore-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*&fl=score&q=*:*&rows=1} hits=5 status=0 QTime=0
   [junit4]   2> 1038004 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScore-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*,score&q=*:*&rows=1} hits=5 status=0 QTime=0
   [junit4]   2> 1038005 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScore-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testGlobsAndScore
   [junit4]   2> 1038007 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testAugmentersGlobsExplicitAndScoreOhMy
   [junit4]   2> 1038009 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[99 (1587293395109281792)]} 0 0
   [junit4]   2> 1038010 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id,subj*,val_*,[explain],score,[docid]} hits=5 status=0 
QTime=0
   [junit4]   2> 1038015 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id&fl=subj*&fl=val_*&fl=[explain]&fl=score&fl=[docid]} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038016 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=[docid],subj*,id,val_*,score,[explain]} hits=5 status=0 
QTime=0
   [junit4]   2> 1038019 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=[docid]&fl=subj*&fl=id&fl=val_*&fl=score&fl=[explain]} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038020 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id,subj*,score,[explain],val_*,[docid]} hits=5 status=0 
QTime=0
   [junit4]   2> 1038021 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id&fl=subj*&fl=score&fl=[explain]&fl=val_*&fl=[docid]} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038022 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id,subj*,val_*,[explain],[docid],score} hits=5 status=0 
QTime=0
   [junit4]   2> 1038024 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id&fl=subj*&fl=val_*&fl=[explain]&fl=[docid]&fl=score} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038033 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=[docid],[explain],id,val_*,subj*,score} hits=5 status=0 
QTime=0
   [junit4]   2> 1038035 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=[docid]&fl=[explain]&fl=id&fl=val_*&fl=subj*&fl=score} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038036 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=[docid],subj*,score,val_*,id,[explain]} hits=5 status=0 
QTime=0
   [junit4]   2> 1038038 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=[docid]&fl=subj*&fl=score&fl=val_*&fl=id&fl=[explain]} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038040 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=[explain],id,[docid],score,subj*,val_*} hits=5 status=0 
QTime=0
   [junit4]   2> 1038042 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=[explain]&fl=id&fl=[docid]&fl=score&fl=subj*&fl=val_*} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038044 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=val_*,[docid],id,subj*,[explain],score} hits=5 status=0 
QTime=0
   [junit4]   2> 1038047 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=val_*&fl=[docid]&fl=id&fl=subj*&fl=[explain]&fl=score} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038048 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=val_*,[explain],subj*,score,id,[docid]} hits=5 status=0 
QTime=0
   [junit4]   2> 1038049 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=val_*&fl=[explain]&fl=subj*&fl=score&fl=id&fl=[docid]} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038051 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id,[docid],subj*,[explain],score,val_*} hits=5 status=0 
QTime=0
   [junit4]   2> 1038053 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id&fl=[docid]&fl=subj*&fl=[explain]&fl=score&fl=val_*} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038054 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=subj*,[explain],[docid],score,id,val_*} hits=5 status=0 
QTime=0
   [junit4]   2> 1038056 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=subj*&fl=[explain]&fl=[docid]&fl=score&fl=id&fl=val_*} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038057 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id,[docid],val_*,[explain],score,subj*} hits=5 status=0 
QTime=0
   [junit4]   2> 1038059 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=id&fl=[docid]&fl=val_*&fl=[explain]&fl=score&fl=subj*} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038061 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMy-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testAugmentersGlobsExplicitAndScoreOhMy
   [junit4]   2> 1038064 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndScore-seed#[BD018FE78F815C8E]) [  
  ] o.a.s.SolrTestCaseJ4 ###Starting testAugmentersAndScore
   [junit4]   2> 1038065 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndScore-seed#[BD018FE78F815C8E]) [  
  ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395170099200)]} 0 0
   [junit4]   2> 1038067 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndScore-seed#[BD018FE78F815C8E]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=[docid],x_alias:[value+v%3D10+t%3Dint],score&rows=1&wt=xml} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038068 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndScore-seed#[BD018FE78F815C8E]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],x_alias:[value+v%3D10+t%3Dint],[explain],score&q=*:*&rows=1} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038070 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndScore-seed#[BD018FE78F815C8E]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=x_alias:[value+v%3D10+t%3Dint],[explain]&fl=score&q=*:*&rows=1}
 hits=5 status=0 QTime=0
   [junit4]   2> 1038071 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndScore-seed#[BD018FE78F815C8E]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=x_alias:[value+v%3D10+t%3Dint]&fl=[explain]&fl=score&q=*:*&rows=1}
 hits=5 status=0 QTime=0
   [junit4]   2> 1038074 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndScore-seed#[BD018FE78F815C8E]) [  
  ] o.a.s.SolrTestCaseJ4 ###Ending testAugmentersAndScore
   [junit4]   2> 1038076 INFO  
(TEST-TestPseudoReturnFields.testAllRealFieldsRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testAllRealFieldsRTG
   [junit4]   2> 1038077 INFO  
(TEST-TestPseudoReturnFields.testAllRealFieldsRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395182682112)]} 0 0
   [junit4]   2> 1038078 INFO  
(TEST-TestPseudoReturnFields.testAllRealFieldsRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038079 INFO  
(TEST-TestPseudoReturnFields.testAllRealFieldsRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038080 INFO  
(TEST-TestPseudoReturnFields.testAllRealFieldsRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=*&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038081 INFO  
(TEST-TestPseudoReturnFields.testAllRealFieldsRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=*&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038082 INFO  
(TEST-TestPseudoReturnFields.testAllRealFieldsRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testAllRealFieldsRTG
   [junit4]   2> 1038085 INFO  
(TEST-TestPseudoReturnFields.testAllRealFields-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testAllRealFields
   [junit4]   2> 1038086 INFO  
(TEST-TestPseudoReturnFields.testAllRealFields-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395191070720)]} 0 0
   [junit4]   2> 1038087 INFO  
(TEST-TestPseudoReturnFields.testAllRealFields-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038089 INFO  
(TEST-TestPseudoReturnFields.testAllRealFields-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=*&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038090 INFO  
(TEST-TestPseudoReturnFields.testAllRealFields-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testAllRealFields
   [junit4]   2> 1038092 INFO  
(TEST-TestPseudoReturnFields.testGlobs-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testGlobs
   [junit4]   2> 1038094 INFO  
(TEST-TestPseudoReturnFields.testGlobs-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395200507904)]} 0 0
   [junit4]   2> 1038094 INFO  
(TEST-TestPseudoReturnFields.testGlobs-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=val_*&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038095 INFO  
(TEST-TestPseudoReturnFields.testGlobs-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=val_*,subj*,ss*} hits=5 status=0 QTime=0
   [junit4]   2> 1038096 INFO  
(TEST-TestPseudoReturnFields.testGlobs-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=val_*&fl=subj*,ss*} hits=5 status=0 QTime=0
   [junit4]   2> 1038097 INFO  
(TEST-TestPseudoReturnFields.testGlobs-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&rows=1&fl=val_*&fl=subj*&fl=ss*} hits=5 status=0 QTime=0
   [junit4]   2> 1038098 INFO  
(TEST-TestPseudoReturnFields.testGlobs-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testGlobs
   [junit4]   2> 1038101 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testGlobsAndScoreRTG
   [junit4]   2> 1038102 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395208896512)]} 0 1
   [junit4]   2> 1038104 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=val_*,score&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038105 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,subj*,score&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038106 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*&fl=score&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038107 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*,score&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038109 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=val_*,score&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038109 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,subj*,score&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038110 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*&fl=score&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038111 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*,score&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038112 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndScoreRTG-seed#[BD018FE78F815C8E]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testGlobsAndScoreRTG
   [junit4]   2> 1038114 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testAugmentersAndExplicit
   [junit4]   2> 1038116 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395221479424)]} 0 0
   [junit4]   2> 1038117 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id,[docid],[explain],x_alias:[value+v%3D10+t%3Dint]&q=*:*&rows=1} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038118 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id&fl=[docid],[explain],x_alias:[value+v%3D10+t%3Dint]&q=*:*&rows=1} 
hits=5 status=0 QTime=0
   [junit4]   2> 1038119 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id&fl=[docid]&fl=[explain]&fl=x_alias:[value+v%3D10+t%3Dint]&q=*:*&rows=1}
 hits=5 status=0 QTime=0
   [junit4]   2> 1038120 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testAugmentersAndExplicit
   [junit4]   2> 1038123 INFO  
(TEST-TestPseudoReturnFields.testMultiValued-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMultiValued
   [junit4]   2> 1038124 INFO  
(TEST-TestPseudoReturnFields.testMultiValued-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395230916608)]} 0 0
   [junit4]   2> 1038125 INFO  
(TEST-TestPseudoReturnFields.testMultiValued-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=id,score&fq=id:42&wt=xml} hits=1 status=0 QTime=0
   [junit4]   2> 1038126 INFO  
(TEST-TestPseudoReturnFields.testMultiValued-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:42&fl=val_ss:val_i,+val2_ss:10&wt=xml} hits=1 status=0 QTime=0
   [junit4]   2> 1038127 INFO  
(TEST-TestPseudoReturnFields.testMultiValued-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=val_ss:val_i,+val2_ss:10&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038127 INFO  
(TEST-TestPseudoReturnFields.testMultiValued-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testMultiValued
   [junit4]   2> 1038130 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testAugmentersRTG
   [junit4]   2> 1038131 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395238256640)]} 0 0
   [junit4]   2> 1038136 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[shard],[explain],x_alias:[value+v%3D10+t%3Dint],abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=5
   [junit4]   2> 1038137 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[shard],abs(val_i)&fl=[explain],x_alias:[value+v%3D10+t%3Dint]&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038140 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[shard]&fl=[explain],x_alias:[value+v%3D10+t%3Dint]&fl=abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038141 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=[shard]&fl=[explain]&fl=x_alias:[value+v%3D10+t%3Dint]&fl=abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038147 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@9329ac[collection1] realtime]
   [junit4]   2> 1038148 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[shard],[explain],x_alias:[value+v%3D10+t%3Dint],abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=6
   [junit4]   2> 1038150 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[shard],abs(val_i)&fl=[explain],x_alias:[value+v%3D10+t%3Dint]&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038151 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[shard]&fl=[explain],x_alias:[value+v%3D10+t%3Dint]&fl=abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038154 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=[shard]&fl=[explain]&fl=x_alias:[value+v%3D10+t%3Dint]&fl=abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038155 INFO  
(TEST-TestPseudoReturnFields.testAugmentersRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testAugmentersRTG
   [junit4]   2> 1038157 INFO  
(TEST-TestPseudoReturnFields.testFunctionsRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testFunctionsRTG
   [junit4]   2> 1038159 INFO  
(TEST-TestPseudoReturnFields.testFunctionsRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395267616768)]} 0 1
   [junit4]   2> 1038163 INFO  
(TEST-TestPseudoReturnFields.testFunctionsRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&id=42&wt=xml&fl=log(val_i),abs(val_i)} status=0 QTime=3
   [junit4]   2> 1038164 INFO  
(TEST-TestPseudoReturnFields.testFunctionsRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&id=42&wt=xml&fl=log(val_i)&fl=abs(val_i)} status=0 QTime=0
   [junit4]   2> 1038170 INFO  
(TEST-TestPseudoReturnFields.testFunctionsRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1a2cc15[collection1] realtime]
   [junit4]   2> 1038171 INFO  
(TEST-TestPseudoReturnFields.testFunctionsRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&id=99&wt=xml&fl=log(val_i),abs(val_i)} status=0 QTime=5
   [junit4]   2> 1038172 INFO  
(TEST-TestPseudoReturnFields.testFunctionsRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&id=99&wt=xml&fl=log(val_i)&fl=abs(val_i)} status=0 QTime=0
   [junit4]   2> 1038174 INFO  
(TEST-TestPseudoReturnFields.testFunctionsRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testFunctionsRTG
   [junit4]   2> 1038176 INFO  
(TEST-TestPseudoReturnFields.testFunctions-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testFunctions
   [junit4]   2> 1038177 INFO  
(TEST-TestPseudoReturnFields.testFunctions-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395286491136)]} 0 0
   [junit4]   2> 1038178 INFO  
(TEST-TestPseudoReturnFields.testFunctions-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=log(val_i)&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038179 INFO  
(TEST-TestPseudoReturnFields.testFunctions-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=log(val_i),abs(val_i)&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038180 INFO  
(TEST-TestPseudoReturnFields.testFunctions-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=log(val_i)&fl=abs(val_i)&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038181 INFO  
(TEST-TestPseudoReturnFields.testFunctions-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testFunctions
   [junit4]   2> 1038184 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFieldsRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testScoreAndExplicitRealFieldsRTG
   [junit4]   2> 1038185 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFieldsRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[99 (1587293395294879744)]} 0 0
   [junit4]   2> 1038186 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFieldsRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=score,val_i&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038187 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFieldsRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=score,val_i&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038188 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFieldsRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testScoreAndExplicitRealFieldsRTG
   [junit4]   2> 1038191 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicit-seed#[BD018FE78F815C8E]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testGlobsAndExplicit
   [junit4]   2> 1038192 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicit-seed#[BD018FE78F815C8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395302219776)]} 0 0
   [junit4]   2> 1038192 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicit-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=val_*,id&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038194 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicit-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,subj*,id&q=*:*&rows=1} hits=5 status=0 QTime=0
   [junit4]   2> 1038195 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicit-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*&fl=id&q=*:*&rows=1} hits=5 status=0 QTime=0
   [junit4]   2> 1038196 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicit-seed#[BD018FE78F815C8E]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*,id&q=*:*&rows=1} hits=5 status=0 QTime=0
   [junit4]   2> 1038197 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicit-seed#[BD018FE78F815C8E]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testGlobsAndExplicit
   [junit4]   2> 1038201 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testAugmentersAndExplicitRTG
   [junit4]   2> 1038202 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[99 (1587293395313754112)]} 0 1
   [junit4]   2> 1038203 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id,[docid],[explain],x_alias:[value+v%3D10+t%3Dint],abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038205 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id,[docid],abs(val_i)&fl=[explain],x_alias:[value+v%3D10+t%3Dint]&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038206 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id&fl=[docid]&fl=[explain]&fl=x_alias:[value+v%3D10+t%3Dint]&fl=abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038217 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a3d46c[collection1] 
realtime]
   [junit4]   2> 1038219 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id,[docid],[explain],x_alias:[value+v%3D10+t%3Dint],abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=11
   [junit4]   2> 1038221 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id,[docid],abs(val_i)&fl=[explain],x_alias:[value+v%3D10+t%3Dint]&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038223 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id&fl=[docid]&fl=[explain]&fl=x_alias:[value+v%3D10+t%3Dint]&fl=abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038226 INFO  
(TEST-TestPseudoReturnFields.testAugmentersAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testAugmentersAndExplicitRTG
   [junit4]   2> 1038228 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting testGlobsAndExplicitRTG
   [junit4]   2> 1038232 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395343114240)]} 0 3
   [junit4]   2> 1038232 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=val_*,id&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038233 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,subj*,id&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038236 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*&fl=id&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038237 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*,id&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038238 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=val_*,id&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038239 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,subj*,id&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038240 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*&fl=id&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038242 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=subj*,id&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038242 INFO  
(TEST-TestPseudoReturnFields.testGlobsAndExplicitRTG-seed#[BD018FE78F815C8E]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Ending testGlobsAndExplicitRTG
   [junit4]   2> 1038245 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testAugmentersGlobsExplicitAndScoreOhMyRTG
   [junit4]   2> 1038248 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[99 (1587293395360940032)]} 0 2
   [junit4]   2> 1038248 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,[docid],[explain],abs(val_i),id,subj*,score&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038251 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=[docid]&fl=[explain]&fl=abs(val_i)&fl=id&fl=subj*&fl=score&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038257 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@582c1[collection1] realtime]
   [junit4]   2> 1038258 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,[docid],[explain],abs(val_i),id,subj*,score&qt=/get&id=99&wt=xml}
 status=0 QTime=5
   [junit4]   2> 1038259 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=[docid]&fl=[explain]&fl=abs(val_i)&fl=id&fl=subj*&fl=score&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038261 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[explain],[docid],abs(val_i),score,id,subj*,val_*&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038264 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[explain]&fl=[docid]&fl=abs(val_i)&fl=score&fl=id&fl=subj*&fl=val_*&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038268 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[explain],[docid],abs(val_i),score,id,subj*,val_*&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038270 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[explain]&fl=[docid]&fl=abs(val_i)&fl=score&fl=id&fl=subj*&fl=val_*&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038280 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,id,score,[explain],abs(val_i),subj*,[docid]&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038286 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=id&fl=score&fl=[explain]&fl=abs(val_i)&fl=subj*&fl=[docid]&qt=/get&id=42&wt=xml}
 status=0 QTime=2
   [junit4]   2> 1038287 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*,id,score,[explain],abs(val_i),subj*,[docid]&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038289 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=val_*&fl=id&fl=score&fl=[explain]&fl=abs(val_i)&fl=subj*&fl=[docid]&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038291 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=abs(val_i),[docid],[explain],score,val_*,subj*,id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038294 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=abs(val_i)&fl=[docid]&fl=[explain]&fl=score&fl=val_*&fl=subj*&fl=id&qt=/get&id=42&wt=xml}
 status=0 QTime=1
   [junit4]   2> 1038296 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=abs(val_i),[docid],[explain],score,val_*,subj*,id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038298 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=abs(val_i)&fl=[docid]&fl=[explain]&fl=score&fl=val_*&fl=subj*&fl=id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038300 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[explain],id,[docid],abs(val_i),subj*,score,val_*&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038302 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[explain]&fl=id&fl=[docid]&fl=abs(val_i)&fl=subj*&fl=score&fl=val_*&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038303 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[explain],id,[docid],abs(val_i),subj*,score,val_*&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038305 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[explain]&fl=id&fl=[docid]&fl=abs(val_i)&fl=subj*&fl=score&fl=val_*&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038307 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],subj*,score,val_*,abs(val_i),[explain],id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038309 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=subj*&fl=score&fl=val_*&fl=abs(val_i)&fl=[explain]&fl=id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038312 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],subj*,score,val_*,abs(val_i),[explain],id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038313 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=subj*&fl=score&fl=val_*&fl=abs(val_i)&fl=[explain]&fl=id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038314 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=subj*,id,score,val_*,[docid],[explain],abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038316 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=subj*&fl=id&fl=score&fl=val_*&fl=[docid]&fl=[explain]&fl=abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038318 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=subj*,id,score,val_*,[docid],[explain],abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038319 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=subj*&fl=id&fl=score&fl=val_*&fl=[docid]&fl=[explain]&fl=abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038321 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],subj*,abs(val_i),val_*,[explain],score,id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038322 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=subj*&fl=abs(val_i)&fl=val_*&fl=[explain]&fl=score&fl=id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038325 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],subj*,abs(val_i),val_*,[explain],score,id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038327 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=subj*&fl=abs(val_i)&fl=val_*&fl=[explain]&fl=score&fl=id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038329 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[explain],subj*,score,abs(val_i),val_*,id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038329 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=[explain]&fl=subj*&fl=score&fl=abs(val_i)&fl=val_*&fl=id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038331 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[explain],subj*,score,abs(val_i),val_*,id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038334 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=[explain]&fl=subj*&fl=score&fl=abs(val_i)&fl=val_*&fl=id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038334 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score,[docid],abs(val_i),val_*,subj*,[explain],id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038336 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score&fl=[docid]&fl=abs(val_i)&fl=val_*&fl=subj*&fl=[explain]&fl=id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038337 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score,[docid],abs(val_i),val_*,subj*,[explain],id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038339 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score&fl=[docid]&fl=abs(val_i)&fl=val_*&fl=subj*&fl=[explain]&fl=id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038341 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=subj*,id,[explain],score,val_*,[docid],abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038342 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=subj*&fl=id&fl=[explain]&fl=score&fl=val_*&fl=[docid]&fl=abs(val_i)&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038344 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=subj*,id,[explain],score,val_*,[docid],abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038346 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=subj*&fl=id&fl=[explain]&fl=score&fl=val_*&fl=[docid]&fl=abs(val_i)&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038347 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=abs(val_i),val_*,[explain],subj*,[docid],score,id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038349 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=abs(val_i)&fl=val_*&fl=[explain]&fl=subj*&fl=[docid]&fl=score&fl=id&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038350 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=abs(val_i),val_*,[explain],subj*,[docid],score,id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038352 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=abs(val_i)&fl=val_*&fl=[explain]&fl=subj*&fl=[docid]&fl=score&fl=id&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038353 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id,val_*,subj*,[docid],score,abs(val_i),[explain]&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038355 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id&fl=val_*&fl=subj*&fl=[docid]&fl=score&fl=abs(val_i)&fl=[explain]&qt=/get&id=42&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038356 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id,val_*,subj*,[docid],score,abs(val_i),[explain]&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038357 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=id&fl=val_*&fl=subj*&fl=[docid]&fl=score&fl=abs(val_i)&fl=[explain]&qt=/get&id=99&wt=xml}
 status=0 QTime=0
   [junit4]   2> 1038359 INFO  
(TEST-TestPseudoReturnFields.testAugmentersGlobsExplicitAndScoreOhMyRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testAugmentersGlobsExplicitAndScoreOhMyRTG
   [junit4]   2> 1038363 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testFunctionsAndExplicit
   [junit4]   2> 1038364 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395482574848)]} 0 1
   [junit4]   2> 1038365 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=log(val_i),val_i&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038367 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=log(val_i)&fl=val_i&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038367 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicit-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testFunctionsAndExplicit
   [junit4]   2> 1038373 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFields-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testScoreAndExplicitRealFields
   [junit4]   2> 1038374 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFields-seed#[BD018FE78F815C8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[99 (1587293395494109184)]} 0 0
   [junit4]   2> 1038375 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFields-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=score,val_i&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038376 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFields-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=score&fl=val_i&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038377 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFields-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=val_i&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038379 INFO  
(TEST-TestPseudoReturnFields.testScoreAndExplicitRealFields-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testScoreAndExplicitRealFields
   [junit4]   2> 1038381 INFO  
(TEST-TestPseudoReturnFields.testAugmenters-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testAugmenters
   [junit4]   2> 1038382 INFO  
(TEST-TestPseudoReturnFields.testAugmenters-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395501449216)]} 0 0
   [junit4]   2> 1038382 INFO  
(TEST-TestPseudoReturnFields.testAugmenters-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=[docid]&rows=1&wt=xml} hits=5 status=0 QTime=0
   [junit4]   2> 1038384 INFO  
(TEST-TestPseudoReturnFields.testAugmenters-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[shard],[explain],x_alias:[value+v%3D10+t%3Dint]&q=*:*&rows=1}
 hits=5 status=0 QTime=0
   [junit4]   2> 1038385 INFO  
(TEST-TestPseudoReturnFields.testAugmenters-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid],[shard]&fl=[explain],x_alias:[value+v%3D10+t%3Dint]&q=*:*&rows=1}
 hits=5 status=0 QTime=0
   [junit4]   2> 1038389 INFO  
(TEST-TestPseudoReturnFields.testAugmenters-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=[docid]&fl=[shard]&fl=[explain]&fl=x_alias:[value+v%3D10+t%3Dint]&q=*:*&rows=1}
 hits=5 status=0 QTime=0
   [junit4]   2> 1038390 INFO  
(TEST-TestPseudoReturnFields.testAugmenters-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testAugmenters
   [junit4]   2> 1038393 INFO  
(TEST-TestPseudoReturnFields.testDocIdAugmenterRTG-seed#[BD018FE78F815C8E]) [   
 ] o.a.s.SolrTestCaseJ4 ###Starting testDocIdAugmenterRTG
   [junit4]   2> 1038394 INFO  
(TEST-TestPseudoReturnFields.testDocIdAugmenterRTG-seed#[BD018FE78F815C8E]) [   
 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395514032128)]} 0 0
   [junit4]   2> 1038395 INFO  
(TEST-TestPseudoReturnFields.testDocIdAugmenterRTG-seed#[BD018FE78F815C8E]) [   
 ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=[docid]&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038396 INFO  
(TEST-TestPseudoReturnFields.testDocIdAugmenterRTG-seed#[BD018FE78F815C8E]) [   
 ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=[docid]&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038397 INFO  
(TEST-TestPseudoReturnFields.testDocIdAugmenterRTG-seed#[BD018FE78F815C8E]) [   
 ] o.a.s.SolrTestCaseJ4 ###Ending testDocIdAugmenterRTG
   [junit4]   2> 1038403 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testFunctionsAndScoreRTG
   [junit4]   2> 1038404 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395525566464)]} 0 0
   [junit4]   2> 1038406 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score&fl=log(val_i)&fl=abs(val_i)&qt=/get&id=42&wt=xml} status=0 
QTime=0
   [junit4]   2> 1038407 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score&fl=log(val_i),abs(val_i)&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038407 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score,log(val_i)&fl=abs(val_i)&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038409 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score,log(val_i),abs(val_i)&qt=/get&id=42&wt=xml} status=0 QTime=0
   [junit4]   2> 1038430 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c492a3[collection1] 
realtime]
   [junit4]   2> 1038437 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score&fl=log(val_i)&fl=abs(val_i)&qt=/get&id=99&wt=xml} status=0 
QTime=27
   [junit4]   2> 1038438 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score&fl=log(val_i),abs(val_i)&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038439 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score,log(val_i)&fl=abs(val_i)&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038440 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=score,log(val_i),abs(val_i)&qt=/get&id=99&wt=xml} status=0 QTime=0
   [junit4]   2> 1038440 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndScoreRTG-seed#[BD018FE78F815C8E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testFunctionsAndScoreRTG
   [junit4]   2> 1038442 INFO  
(TEST-TestPseudoReturnFields.testMultiValuedRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMultiValuedRTG
   [junit4]   2> 1038445 INFO  
(TEST-TestPseudoReturnFields.testMultiValuedRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[99 (1587293395566460928)]} 0 2
   [junit4]   2> 1038446 INFO  
(TEST-TestPseudoReturnFields.testMultiValuedRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=val_ss:val_i,+val2_ss:10,+subject&id=42&wt=xml} status=0 
QTime=0
   [junit4]   2> 1038454 INFO  
(TEST-TestPseudoReturnFields.testMultiValuedRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@195a2ec[collection1] realtime]
   [junit4]   2> 1038457 INFO  
(TEST-TestPseudoReturnFields.testMultiValuedRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={qt=/get&fl=val_ss:val_i,+val2_ss:10,+subject&id=99&wt=xml} status=0 
QTime=10
   [junit4]   2> 1038457 INFO  
(TEST-TestPseudoReturnFields.testMultiValuedRTG-seed#[BD018FE78F815C8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testMultiValuedRTG
   [junit4]   2> 1038462 INFO  
(TEST-TestPseudoReturnFields.testFilterAndOneRealFieldRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testFilterAndOneRealFieldRTG
   [junit4]   2> 1038471 INFO  
(TEST-TestPseudoReturnFields.testFilterAndOneRealFieldRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[99 (1587293395588481024)]} 0 7
   [junit4]   2> 1038479 INFO  
(TEST-TestPseudoReturnFields.testFilterAndOneRealFieldRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@113c821[coll

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

###Starting testFunctionsAndExplicitRTG
   [junit4]   2> 1038550 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[99 (1587293395677609984)]} 0 1
   [junit4]   2> 1038551 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=log(val_i),val_i&qt=/get&wt=xml&id=42} status=0 QTime=0
   [junit4]   2> 1038559 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=log(val_i)&fl=val_i&qt=/get&wt=xml&id=42} status=0 QTime=0
   [junit4]   2> 1038566 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1265805[collection1] 
realtime]
   [junit4]   2> 1038568 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=log(val_i),val_i&qt=/get&wt=xml&id=99} status=0 QTime=7
   [junit4]   2> 1038570 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={fl=log(val_i)&fl=val_i&qt=/get&wt=xml&id=99} status=0 QTime=0
   [junit4]   2> 1038571 INFO  
(TEST-TestPseudoReturnFields.testFunctionsAndExplicitRTG-seed#[BD018FE78F815C8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testFunctionsAndExplicitRTG
   [junit4]   2> 1038572 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1038572 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=15317367
   [junit4]   2> 1038572 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1038572 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3dfbde: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@15b7fa7
   [junit4]   2> 1038584 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1038584 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@85b9f6: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@fe3ea1
   [junit4]   2> 1038592 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1038592 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e31039: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@125fe52
   [junit4]   2> 1038593 INFO  (coreCloseExecutor-3607-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@17b1998
   [junit4]   2> 1038593 INFO  (coreCloseExecutor-3607-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=24844696
   [junit4]   2> 1038593 INFO  (coreCloseExecutor-3607-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7d59f9: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@a136af
   [junit4]   2> 1038605 INFO  (coreCloseExecutor-3607-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1038605 INFO  (coreCloseExecutor-3607-thread-1) [    
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@23a96f commitCommandVersion:0
   [junit4]   2> 1038609 INFO  
(SUITE-TestPseudoReturnFields-seed#[BD018FE78F815C8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), 
sim=RandomSimilarity(queryNorm=true): {}, locale=zh-CN, 
timezone=America/Blanc-Sablon
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 
(32-bit)/cpus=3,threads=1,free=188270608,total=395575296
   [junit4]   2> NOTE: All tests run in this JVM: [TestStressInPlaceUpdates, 
ClusterStateTest, TestZkAclsWithHadoopAuth, DeleteNodeTest, 
UnloadDistributedZkTest, TestXmlQParserPlugin, TestLazyCores, 
TestRandomRequestDistribution, MultiTermTest, TestSegmentSorting, 
TestLMDirichletSimilarityFactory, PrimUtilsTest, TestNumericTokenStream, 
SortByFunctionTest, LeaderElectionTest, TestHalfAndHalfDocValues, 
TestPushWriter, ConfigSetsAPITest, TriggerIntegrationTest, DateFieldTest, 
TestExportWriter, TestRangeQuery, TestFieldCacheVsDocValues, TestCoreDiscovery, 
TestBinaryResponseWriter, TestSolr4Spatial, SolrMetricReporterTest, 
XmlUpdateRequestHandlerTest, TestTolerantSearch, DistribJoinFromCollectionTest, 
PeerSyncReplicationTest, TestLegacyNumericRangeQueryBuilder, 
TestDownShardTolerantSearch, TestManagedResourceStorage, TestPivotHelperCode, 
ConnectionReuseTest, TestLegacyFieldReuse, DistribCursorPagingTest, 
DistanceUnitsTest, TestHighlightDedupGrouping, BadIndexSchemaTest, 
SearchHandlerTest, TestRandomDVFaceting, MinimalSchemaTest, TestNestedDocsSort, 
TestQueryWrapperFilter, TestCloudSchemaless, TestStandardQParsers, 
NodeLostTriggerTest, HdfsRestartWhileUpdatingTest, TimeZoneUtilsTest, 
FastVectorHighlighterTest, ManagedSchemaRoundRobinCloudTest, 
RequiredFieldsTest, SolrXmlInZkTest, TestSolrCoreSnapshots, 
TestMiniSolrCloudClusterSSL, TestRecoveryHdfs, ExecutePlanActionTest, 
ClassificationUpdateProcessorTest, SpellCheckCollatorTest, SyncSliceTest, 
HdfsCollectionsAPIDistributedZkTest, TestCustomStream, TestAddFieldRealTimeGet, 
ConfigureRecoveryStrategyTest, DistanceFunctionTest, TestIndexingPerformance, 
LeaderInitiatedRecoveryOnShardRestartTest, 
OverriddenZkACLAndCredentialsProvidersTest, RankQueryTest, 
TestQuerySenderListener, MetricsHandlerTest, DistributedTermsComponentTest, 
TestFieldCacheSort, TestFilteredDocIdSet, TestPointFields, 
DirectoryFactoryTest, PathHierarchyTokenizerFactoryTest, HdfsThreadLeakTest, 
SuggesterWFSTTest, DateMathParserTest, TestPHPSerializedResponseWriter, 
BasicAuthIntegrationTest, ClusterStateUpdateTest, TestStressRecovery, 
JSONWriterTest, SolrCoreMetricManagerTest, BJQParserTest, TestRTimerTree, 
HdfsDirectoryFactoryTest, TestLFUCache, CollectionTooManyReplicasTest, 
TestMissingGroups, RecoveryZkTest, TestSolrCloudWithDelegationTokens, 
TestSimpleTextCodec, NotRequiredUniqueKeyTest, XsltUpdateRequestHandlerTest, 
ZkStateReaderTest, TestSolrDeletionPolicy2, TestUpdate, 
TestCloudSearcherWarming, TestExpandComponent, SolrSlf4jReporterTest, 
CSVRequestHandlerTest, SolrJmxReporterCloudTest, TestPseudoReturnFields]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestPseudoReturnFields -Dtests.seed=BD018FE78F815C8E 
-Dtests.slow=true -Dtests.locale=zh-CN -Dtests.timezone=America/Blanc-Sablon 
-Dtests.asserts=true -Dtests.file.encoding=Cp1252
   [junit4] ERROR   0.00s J0 | TestPseudoReturnFields (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-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog\tlog.0000000000000000000:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001\init-core-data-001\tlog\tlog.0000000000000000000
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestPseudoReturnFields_BD018FE78F815C8E-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([BD018FE78F815C8E]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] Completed [236/751 (1!)] on J0 in 1.04s, 30 tests, 1 error <<< 
FAILURES!

[...truncated 44905 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to