You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/11/21 13:22:51 UTC
[JENKINS] Lucene-Solr-NightlyTests-8.x - Build # 275 - Unstable
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-8.x/275/
2 tests failed.
FAILED: org.apache.lucene.search.TestSearcherManager.testConcurrentIndexCloseSearchAndRefresh
Error Message:
Captured an uncaught exception in thread: Thread[id=19849, name=Thread-18619, state=RUNNABLE, group=TGRP-TestSearcherManager]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=19849, name=Thread-18619, state=RUNNABLE, group=TGRP-TestSearcherManager]
Caused by: java.lang.RuntimeException: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4n_Lucene84_0.tip: Too many open files
at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
at org.apache.lucene.search.TestSearcherManager$10.run(TestSearcherManager.java:647)
Caused by: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4n_Lucene84_0.tip: Too many open files
at org.apache.lucene.mockfile.HandleLimitFS.onOpen(HandleLimitFS.java:48)
at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:81)
at org.apache.lucene.mockfile.HandleTrackingFS.newByteChannel(HandleTrackingFS.java:271)
at org.apache.lucene.mockfile.FilterFileSystemProvider.newByteChannel(FilterFileSystemProvider.java:212)
at java.nio.file.Files.newByteChannel(Files.java:361)
at java.nio.file.Files.newByteChannel(Files.java:407)
at org.apache.lucene.store.SimpleFSDirectory.openInput(SimpleFSDirectory.java:77)
at org.apache.lucene.util.LuceneTestCase.slowFileExists(LuceneTestCase.java:2862)
at org.apache.lucene.store.MockDirectoryWrapper.openInput(MockDirectoryWrapper.java:747)
at org.apache.lucene.codecs.blocktree.BlockTreeTermsReader.<init>(BlockTreeTermsReader.java:176)
at org.apache.lucene.codecs.lucene84.Lucene84PostingsFormat.fieldsProducer(Lucene84PostingsFormat.java:442)
at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat$FieldsReader.<init>(PerFieldPostingsFormat.java:288)
at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat.fieldsProducer(PerFieldPostingsFormat.java:368)
at org.apache.lucene.index.SegmentCoreReaders.<init>(SegmentCoreReaders.java:114)
at org.apache.lucene.index.SegmentReader.<init>(SegmentReader.java:84)
at org.apache.lucene.index.ReadersAndUpdates.getReader(ReadersAndUpdates.java:177)
at org.apache.lucene.index.ReadersAndUpdates.getReadOnlyClone(ReadersAndUpdates.java:219)
at org.apache.lucene.index.StandardDirectoryReader.open(StandardDirectoryReader.java:109)
at org.apache.lucene.index.IndexWriter.getReader(IndexWriter.java:526)
at org.apache.lucene.index.StandardDirectoryReader.doOpenFromWriter(StandardDirectoryReader.java:297)
at org.apache.lucene.index.StandardDirectoryReader.doOpenIfChanged(StandardDirectoryReader.java:272)
at org.apache.lucene.index.StandardDirectoryReader.doOpenIfChanged(StandardDirectoryReader.java:262)
at org.apache.lucene.index.DirectoryReader.openIfChanged(DirectoryReader.java:165)
at org.apache.lucene.search.SearcherManager.refreshIfNeeded(SearcherManager.java:156)
at org.apache.lucene.search.SearcherManager.refreshIfNeeded(SearcherManager.java:58)
at org.apache.lucene.search.ReferenceManager.doMaybeRefresh(ReferenceManager.java:176)
at org.apache.lucene.search.ReferenceManager.maybeRefreshBlocking(ReferenceManager.java:253)
at org.apache.lucene.search.TestSearcherManager$10.run(TestSearcherManager.java:635)
FAILED: junit.framework.TestSuite.org.apache.lucene.search.TestSearcherManager
Error Message:
The test or suite printed 10232 bytes to stdout and stderr, even though the limit was set to 8192 bytes. Increase the limit with @Limit, ignore it completely with @SuppressSysoutChecks or run with -Dtests.verbose=true
Stack Trace:
java.lang.AssertionError: The test or suite printed 10232 bytes to stdout and stderr, even though the limit was set to 8192 bytes. Increase the limit with @Limit, ignore it completely with @SuppressSysoutChecks or run with -Dtests.verbose=true
at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
at org.apache.lucene.util.TestRuleLimitSysouts.afterIfSuccessful(TestRuleLimitSysouts.java:282)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterIfSuccessful(TestRuleAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:37)
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 1989 lines...]
[junit4] Suite: org.apache.lucene.search.TestSearcherManager
[junit4] 2> nov. 21, 2019 4:35:04 AM com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-18619,5,TGRP-TestSearcherManager]
[junit4] 2> java.lang.RuntimeException: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4n_Lucene84_0.tip: Too many open files
[junit4] 2> at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
[junit4] 2> at org.apache.lucene.search.TestSearcherManager$10.run(TestSearcherManager.java:647)
[junit4] 2> Caused by: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4n_Lucene84_0.tip: Too many open files
[junit4] 2> at org.apache.lucene.mockfile.HandleLimitFS.onOpen(HandleLimitFS.java:48)
[junit4] 2> at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:81)
[junit4] 2> at org.apache.lucene.mockfile.HandleTrackingFS.newByteChannel(HandleTrackingFS.java:271)
[junit4] 2> at org.apache.lucene.mockfile.FilterFileSystemProvider.newByteChannel(FilterFileSystemProvider.java:212)
[junit4] 2> at java.nio.file.Files.newByteChannel(Files.java:361)
[junit4] 2> at java.nio.file.Files.newByteChannel(Files.java:407)
[junit4] 2> at org.apache.lucene.store.SimpleFSDirectory.openInput(SimpleFSDirectory.java:77)
[junit4] 2> at org.apache.lucene.util.LuceneTestCase.slowFileExists(LuceneTestCase.java:2862)
[junit4] 2> at org.apache.lucene.store.MockDirectoryWrapper.openInput(MockDirectoryWrapper.java:747)
[junit4] 2> at org.apache.lucene.codecs.blocktree.BlockTreeTermsReader.<init>(BlockTreeTermsReader.java:176)
[junit4] 2> at org.apache.lucene.codecs.lucene84.Lucene84PostingsFormat.fieldsProducer(Lucene84PostingsFormat.java:442)
[junit4] 2> at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat$FieldsReader.<init>(PerFieldPostingsFormat.java:288)
[junit4] 2> at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat.fieldsProducer(PerFieldPostingsFormat.java:368)
[junit4] 2> at org.apache.lucene.index.SegmentCoreReaders.<init>(SegmentCoreReaders.java:114)
[junit4] 2> at org.apache.lucene.index.SegmentReader.<init>(SegmentReader.java:84)
[junit4] 2> at org.apache.lucene.index.ReadersAndUpdates.getReader(ReadersAndUpdates.java:177)
[junit4] 2> at org.apache.lucene.index.ReadersAndUpdates.getReadOnlyClone(ReadersAndUpdates.java:219)
[junit4] 2> at org.apache.lucene.index.StandardDirectoryReader.open(StandardDirectoryReader.java:109)
[junit4] 2> at org.apache.lucene.index.IndexWriter.getReader(IndexWriter.java:526)
[junit4] 2> at org.apache.lucene.index.StandardDirectoryReader.doOpenFromWriter(StandardDirectoryReader.java:297)
[junit4] 2> at org.apache.lucene.index.StandardDirectoryReader.doOpenIfChanged(StandardDirectoryReader.java:272)
[junit4] 2> at org.apache.lucene.index.StandardDirectoryReader.doOpenIfChanged(StandardDirectoryReader.java:262)
[junit4] 2> at org.apache.lucene.index.DirectoryReader.openIfChanged(DirectoryReader.java:165)
[junit4] 2> at org.apache.lucene.search.SearcherManager.refreshIfNeeded(SearcherManager.java:156)
[junit4] 2> at org.apache.lucene.search.SearcherManager.refreshIfNeeded(SearcherManager.java:58)
[junit4] 2> at org.apache.lucene.search.ReferenceManager.doMaybeRefresh(ReferenceManager.java:176)
[junit4] 2> at org.apache.lucene.search.ReferenceManager.maybeRefreshBlocking(ReferenceManager.java:253)
[junit4] 2> at org.apache.lucene.search.TestSearcherManager$10.run(TestSearcherManager.java:635)
[junit4] 2>
[junit4] 2> nov. 21, 2019 4:35:04 AM com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-18620,5,TGRP-TestSearcherManager]
[junit4] 2> java.lang.RuntimeException: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4r_Asserting_0.tip: Too many open files
[junit4] 2> at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
[junit4] 2> at org.apache.lucene.search.TestSearcherManager$11.run(TestSearcherManager.java:677)
[junit4] 2> Caused by: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4r_Asserting_0.tip: Too many open files
[junit4] 2> at org.apache.lucene.mockfile.HandleLimitFS.onOpen(HandleLimitFS.java:48)
[junit4] 2> at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:81)
[junit4] 2> at org.apache.lucene.mockfile.HandleTrackingFS.newOutputStream(HandleTrackingFS.java:160)
[junit4] 2> at org.apache.lucene.mockfile.FilterFileSystemProvider.newOutputStream(FilterFileSystemProvider.java:197)
[junit4] 2> at java.nio.file.Files.newOutputStream(Files.java:216)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:410)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:406)
[junit4] 2> at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:254)
[junit4] 2> at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:667)
[junit4] 2> at org.apache.lucene.store.LockValidatingDirectoryWrapper.createOutput(LockValidatingDirectoryWrapper.java:44)
[junit4] 2> at org.apache.lucene.store.TrackingDirectoryWrapper.createOutput(TrackingDirectoryWrapper.java:43)
[junit4] 2> at org.apache.lucene.codecs.blocktree.BlockTreeTermsWriter.<init>(BlockTreeTermsWriter.java:278)
[junit4] 2> at org.apache.lucene.codecs.lucene84.Lucene84PostingsFormat.fieldsConsumer(Lucene84PostingsFormat.java:424)
[junit4] 2> at org.apache.lucene.codecs.asserting.AssertingPostingsFormat.fieldsConsumer(AssertingPostingsFormat.java:54)
[junit4] 2> at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat$FieldsWriter.write(PerFieldPostingsFormat.java:140)
[junit4] 2> at org.apache.lucene.index.FreqProxTermsWriter.flush(FreqProxTermsWriter.java:97)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.flush(DefaultIndexingChain.java:177)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.flush(DocumentsWriterPerThread.java:468)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:555)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.flushAllThreads(DocumentsWriter.java:722)
[junit4] 2> at org.apache.lucene.index.IndexWriter.getReader(IndexWriter.java:494)
[junit4] 2> at org.apache.lucene.index.DirectoryReader.open(DirectoryReader.java:116)
[junit4] 2> at org.apache.lucene.search.SearcherManager.<init>(SearcherManager.java:108)
[junit4] 2> at org.apache.lucene.search.SearcherManager.<init>(SearcherManager.java:76)
[junit4] 2> at org.apache.lucene.search.TestSearcherManager$11.run(TestSearcherManager.java:665)
[junit4] 2>
[junit4] 2> nov. 21, 2019 4:35:04 AM com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-18617,5,TGRP-TestSearcherManager]
[junit4] 2> org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[junit4] 2> at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
[junit4] 2> at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:681)
[junit4] 2> at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:695)
[junit4] 2> at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1591)
[junit4] 2> at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
[junit4] 2> at org.apache.lucene.search.TestSearcherManager$8.run(TestSearcherManager.java:574)
[junit4] 2> Caused by: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4r_Asserting_0.tip: Too many open files
[junit4] 2> at org.apache.lucene.mockfile.HandleLimitFS.onOpen(HandleLimitFS.java:48)
[junit4] 2> at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:81)
[junit4] 2> at org.apache.lucene.mockfile.HandleTrackingFS.newOutputStream(HandleTrackingFS.java:160)
[junit4] 2> at org.apache.lucene.mockfile.FilterFileSystemProvider.newOutputStream(FilterFileSystemProvider.java:197)
[junit4] 2> at java.nio.file.Files.newOutputStream(Files.java:216)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:410)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:406)
[junit4] 2> at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:254)
[junit4] 2> at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:667)
[junit4] 2> at org.apache.lucene.store.LockValidatingDirectoryWrapper.createOutput(LockValidatingDirectoryWrapper.java:44)
[junit4] 2> at org.apache.lucene.store.TrackingDirectoryWrapper.createOutput(TrackingDirectoryWrapper.java:43)
[junit4] 2> at org.apache.lucene.codecs.blocktree.BlockTreeTermsWriter.<init>(BlockTreeTermsWriter.java:278)
[junit4] 2> at org.apache.lucene.codecs.lucene84.Lucene84PostingsFormat.fieldsConsumer(Lucene84PostingsFormat.java:424)
[junit4] 2> at org.apache.lucene.codecs.asserting.AssertingPostingsFormat.fieldsConsumer(AssertingPostingsFormat.java:54)
[junit4] 2> at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat$FieldsWriter.write(PerFieldPostingsFormat.java:140)
[junit4] 2> at org.apache.lucene.index.FreqProxTermsWriter.flush(FreqProxTermsWriter.java:97)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.flush(DefaultIndexingChain.java:177)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.flush(DocumentsWriterPerThread.java:468)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:555)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.flushAllThreads(DocumentsWriter.java:722)
[junit4] 2> at org.apache.lucene.index.IndexWriter.getReader(IndexWriter.java:494)
[junit4] 2> at org.apache.lucene.index.DirectoryReader.open(DirectoryReader.java:116)
[junit4] 2> at org.apache.lucene.search.SearcherManager.<init>(SearcherManager.java:108)
[junit4] 2> at org.apache.lucene.search.SearcherManager.<init>(SearcherManager.java:76)
[junit4] 2> at org.apache.lucene.search.TestSearcherManager$11.run(TestSearcherManager.java:665)
[junit4] 2>
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSearcherManager -Dtests.method=testConcurrentIndexCloseSearchAndRefresh -Dtests.seed=9882EB3CBB5D8DFB -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=lv-LV -Dtests.timezone=US/Michigan -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 16.7s J2 | TestSearcherManager.testConcurrentIndexCloseSearchAndRefresh <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=19849, name=Thread-18619, state=RUNNABLE, group=TGRP-TestSearcherManager]
[junit4] > Caused by: java.lang.RuntimeException: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4n_Lucene84_0.tip: Too many open files
[junit4] > at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
[junit4] > at org.apache.lucene.search.TestSearcherManager$10.run(TestSearcherManager.java:647)
[junit4] > Caused by: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4n_Lucene84_0.tip: Too many open files
[junit4] > at org.apache.lucene.mockfile.HandleLimitFS.onOpen(HandleLimitFS.java:48)
[junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:81)
[junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.newByteChannel(HandleTrackingFS.java:271)
[junit4] > at org.apache.lucene.mockfile.FilterFileSystemProvider.newByteChannel(FilterFileSystemProvider.java:212)
[junit4] > at java.nio.file.Files.newByteChannel(Files.java:361)
[junit4] > at java.nio.file.Files.newByteChannel(Files.java:407)
[junit4] > at org.apache.lucene.store.SimpleFSDirectory.openInput(SimpleFSDirectory.java:77)
[junit4] > at org.apache.lucene.util.LuceneTestCase.slowFileExists(LuceneTestCase.java:2862)
[junit4] > at org.apache.lucene.store.MockDirectoryWrapper.openInput(MockDirectoryWrapper.java:747)
[junit4] > at org.apache.lucene.codecs.blocktree.BlockTreeTermsReader.<init>(BlockTreeTermsReader.java:176)
[junit4] > at org.apache.lucene.codecs.lucene84.Lucene84PostingsFormat.fieldsProducer(Lucene84PostingsFormat.java:442)
[junit4] > at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat$FieldsReader.<init>(PerFieldPostingsFormat.java:288)
[junit4] > at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat.fieldsProducer(PerFieldPostingsFormat.java:368)
[junit4] > at org.apache.lucene.index.SegmentCoreReaders.<init>(SegmentCoreReaders.java:114)
[junit4] > at org.apache.lucene.index.SegmentReader.<init>(SegmentReader.java:84)
[junit4] > at org.apache.lucene.index.ReadersAndUpdates.getReader(ReadersAndUpdates.java:177)
[junit4] > at org.apache.lucene.index.ReadersAndUpdates.getReadOnlyClone(ReadersAndUpdates.java:219)
[junit4] > at org.apache.lucene.index.StandardDirectoryReader.open(StandardDirectoryReader.java:109)
[junit4] > at org.apache.lucene.index.IndexWriter.getReader(IndexWriter.java:526)
[junit4] > at org.apache.lucene.index.StandardDirectoryReader.doOpenFromWriter(StandardDirectoryReader.java:297)
[junit4] > at org.apache.lucene.index.StandardDirectoryReader.doOpenIfChanged(StandardDirectoryReader.java:272)
[junit4] > at org.apache.lucene.index.StandardDirectoryReader.doOpenIfChanged(StandardDirectoryReader.java:262)
[junit4] > at org.apache.lucene.index.DirectoryReader.openIfChanged(DirectoryReader.java:165)
[junit4] > at org.apache.lucene.search.SearcherManager.refreshIfNeeded(SearcherManager.java:156)
[junit4] > at org.apache.lucene.search.SearcherManager.refreshIfNeeded(SearcherManager.java:58)
[junit4] > at org.apache.lucene.search.ReferenceManager.doMaybeRefresh(ReferenceManager.java:176)
[junit4] > at org.apache.lucene.search.ReferenceManager.maybeRefreshBlocking(ReferenceManager.java:253)
[junit4] > at org.apache.lucene.search.TestSearcherManager$10.run(TestSearcherManager.java:635)Throwable #2: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=19850, name=Thread-18620, state=RUNNABLE, group=TGRP-TestSearcherManager]
[junit4] > Caused by: java.lang.RuntimeException: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4r_Asserting_0.tip: Too many open files
[junit4] > at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
[junit4] > at org.apache.lucene.search.TestSearcherManager$11.run(TestSearcherManager.java:677)
[junit4] > Caused by: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4r_Asserting_0.tip: Too many open files
[junit4] > at org.apache.lucene.mockfile.HandleLimitFS.onOpen(HandleLimitFS.java:48)
[junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:81)
[junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.newOutputStream(HandleTrackingFS.java:160)
[junit4] > at org.apache.lucene.mockfile.FilterFileSystemProvider.newOutputStream(FilterFileSystemProvider.java:197)
[junit4] > at java.nio.file.Files.newOutputStream(Files.java:216)
[junit4] > at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:410)
[junit4] > at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:406)
[junit4] > at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:254)
[junit4] > at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:667)
[junit4] > at org.apache.lucene.store.LockValidatingDirectoryWrapper.createOutput(LockValidatingDirectoryWrapper.java:44)
[junit4] > at org.apache.lucene.store.TrackingDirectoryWrapper.createOutput(TrackingDirectoryWrapper.java:43)
[junit4] > at org.apache.lucene.codecs.blocktree.BlockTreeTermsWriter.<init>(BlockTreeTermsWriter.java:278)
[junit4] > at org.apache.lucene.codecs.lucene84.Lucene84PostingsFormat.fieldsConsumer(Lucene84PostingsFormat.java:424)
[junit4] > at org.apache.lucene.codecs.asserting.AssertingPostingsFormat.fieldsConsumer(AssertingPostingsFormat.java:54)
[junit4] > at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat$FieldsWriter.write(PerFieldPostingsFormat.java:140)
[junit4] > at org.apache.lucene.index.FreqProxTermsWriter.flush(FreqProxTermsWriter.java:97)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.flush(DefaultIndexingChain.java:177)
[junit4] > at org.apache.lucene.index.DocumentsWriterPerThread.flush(DocumentsWriterPerThread.java:468)
[junit4] > at org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:555)
[junit4] > at org.apache.lucene.index.DocumentsWriter.flushAllThreads(DocumentsWriter.java:722)
[junit4] > at org.apache.lucene.index.IndexWriter.getReader(IndexWriter.java:494)
[junit4] > at org.apache.lucene.index.DirectoryReader.open(DirectoryReader.java:116)
[junit4] > at org.apache.lucene.search.SearcherManager.<init>(SearcherManager.java:108)
[junit4] > at org.apache.lucene.search.SearcherManager.<init>(SearcherManager.java:76)
[junit4] > at org.apache.lucene.search.TestSearcherManager$11.run(TestSearcherManager.java:665)Throwable #3: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=19847, name=Thread-18617, state=RUNNABLE, group=TGRP-TestSearcherManager]
[junit4] > Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[junit4] > at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
[junit4] > at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:681)
[junit4] > at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:695)
[junit4] > at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1591)
[junit4] > at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
[junit4] > at org.apache.lucene.search.TestSearcherManager$8.run(TestSearcherManager.java:574)
[junit4] > Caused by: java.nio.file.FileSystemException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/core/test/J2/temp/lucene.search.TestSearcherManager_9882EB3CBB5D8DFB-001/tempDir-001/_4r_Asserting_0.tip: Too many open files
[junit4] > at org.apache.lucene.mockfile.HandleLimitFS.onOpen(HandleLimitFS.java:48)
[junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:81)
[junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.newOutputStream(HandleTrackingFS.java:160)
[junit4] > at org.apache.lucene.mockfile.FilterFileSystemProvider.newOutputStream(FilterFileSystemProvider.java:197)
[junit4] > at java.nio.file.Files.newOutputStream(Files.java:216)
[junit4] > at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:410)
[junit4] > at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:406)
[junit4] > at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:254)
[junit4] > at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:667)
[junit4] > at org.apache.lucene.store.LockValidatingDirectoryWrapper.createOutput(LockValidatingDirectoryWrapper.java:44)
[junit4] > at org.apache.lucene.store.TrackingDirectoryWrapper.createOutput(TrackingDirectoryWrapper.java:43)
[junit4] > at org.apache.lucene.codecs.blocktree.BlockTreeTermsWriter.<init>(BlockTreeTermsWriter.java:278)
[junit4] > at org.apache.lucene.codecs.lucene84.Lucene84PostingsFormat.fieldsConsumer(Lucene84PostingsFormat.java:424)
[junit4] > at org.apache.lucene.codecs.asserting.AssertingPostingsFormat.fieldsConsumer(AssertingPostingsFormat.java:54)
[junit4] > at org.apache.lucene.codecs.perfield.PerFieldPostingsFormat$FieldsWriter.write(PerFieldPostingsFormat.java:140)
[junit4] > at org.apache.lucene.index.FreqProxTermsWriter.flush(FreqProxTermsWriter.java:97)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.flush(DefaultIndexingChain.java:177)
[junit4] > at org.apache.lucene.index.DocumentsWriterPerThread.flush(DocumentsWriterPerThread.java:468)
[junit4] > at org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:555)
[junit4] > at org.apache.lucene.index.DocumentsWriter.flushAllThreads(DocumentsWriter.java:722)
[junit4] > at org.apache.lucene.index.IndexWriter.getReader(IndexWriter.java:494)
[junit4] > at org.apache.lucene.index.DirectoryReader.open(DirectoryReader.java:116)
[junit4] > at org.apache.lucene.search.SearcherManager.<init>(SearcherManager.java:108)
[junit4] > at org.apache.lucene.search.SearcherManager.<init>(SearcherManager.java:76)
[junit4] > at org.apache.lucene.search.TestSearcherManager$11.run(TestSearcherManager.java:665)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {date=PostingsFormat(name=Asserting), extra13=PostingsFormat(name=Asserting), extra35=PostingsFormat(name=Asserting), extra14=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), extra36=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), extra11=Lucene84, extra33=Lucene84, extra8=Lucene84, extra12=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra34=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra9=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra39=PostingsFormat(name=Asserting), extra17=PostingsFormat(name=Asserting), extra18=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), extra15=Lucene84, extra37=Lucene84, extra38=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra16=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra2=PostingsFormat(name=Asserting), extra3=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), titleTokenized=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), extra0=Lucene84, extra19=Lucene84, extra1=PostingsFormat(name=LuceneVarGapDocFreqInterval), body=PostingsFormat(name=Asserting), title=Lucene84, extra6=PostingsFormat(name=Asserting), extra7=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), extra4=Lucene84, extra5=PostingsFormat(name=LuceneVarGapDocFreqInterval), packID=Lucene84, extra31=PostingsFormat(name=Asserting), extra10=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), extra32=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), extra30=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra24=PostingsFormat(name=Asserting), extra25=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), extra22=Lucene84, extra23=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra28=PostingsFormat(name=Asserting), extra29=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), docid=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra26=Lucene84, extra27=PostingsFormat(name=LuceneVarGapDocFreqInterval), extra20=PostingsFormat(name=Asserting), extra21=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84))}, docValues:{date=DocValuesFormat(name=Asserting), extra13=DocValuesFormat(name=Lucene80), extra14=DocValuesFormat(name=Lucene80), extra11=DocValuesFormat(name=Asserting), extra8=DocValuesFormat(name=Lucene80), extra12=DocValuesFormat(name=Lucene80), extra9=DocValuesFormat(name=Lucene80), extra17=DocValuesFormat(name=Asserting), extra18=DocValuesFormat(name=Lucene80), extra15=DocValuesFormat(name=Lucene80), extra16=DocValuesFormat(name=Asserting), extra2=DocValuesFormat(name=Lucene80), extra3=DocValuesFormat(name=Lucene80), titleTokenized=DocValuesFormat(name=Lucene80), extra0=DocValuesFormat(name=Asserting), extra19=DocValuesFormat(name=Lucene80), extra1=DocValuesFormat(name=Lucene80), body=DocValuesFormat(name=Lucene80), extra6=DocValuesFormat(name=Asserting), extra7=DocValuesFormat(name=Lucene80), extra4=DocValuesFormat(name=Lucene80), extra5=DocValuesFormat(name=Asserting), extra10=DocValuesFormat(name=Lucene80), extra35=DocValuesFormat(name=Lucene80), extra36=DocValuesFormat(name=Asserting), docid_int=DocValuesFormat(name=Asserting), extra33=DocValuesFormat(name=Lucene80), extra34=DocValuesFormat(name=Lucene80), extra39=DocValuesFormat(name=Lucene80), extra37=DocValuesFormat(name=Asserting), extra38=DocValuesFormat(name=Lucene80), title=DocValuesFormat(name=Asserting), packID=DocValuesFormat(name=Lucene80), docid_intDV=DocValuesFormat(name=Lucene80), extra31=DocValuesFormat(name=Lucene80), extra32=DocValuesFormat(name=Lucene80), extra30=DocValuesFormat(name=Lucene80), extra24=DocValuesFormat(name=Lucene80), extra25=DocValuesFormat(name=Lucene80), extra22=DocValuesFormat(name=Asserting), extra23=DocValuesFormat(name=Lucene80), extra28=DocValuesFormat(name=Asserting), extra29=DocValuesFormat(name=Lucene80), docid=DocValuesFormat(name=Lucene80), extra26=DocValuesFormat(name=Lucene80), extra27=DocValuesFormat(name=Asserting), extra20=DocValuesFormat(name=Asserting), extra21=DocValuesFormat(name=Lucene80), titleDV=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=281, maxMBSortInHeap=6.929436720842947, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@3a7ddbbe), locale=lv-LV, timezone=US/Michigan
[junit4] 2> NOTE: Linux 4.15.0-54-generic amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=4,threads=1,free=328558144,total=475529216
[junit4] 2> NOTE: All tests run in this JVM: [TestLucene80NormsFormat, TestNewestSegment, TestGeoUtils, TestMixedDocValuesUpdates, TestSameTokenSamePosition, TestLMJelinekMercerSimilarity, TestSort, TestIndexWriterOutOfFileDescriptors, TestRadixSelector, TestThreadedForceMerge, TestForUtil, FuzzyTermOnShortTermsTest, TestAllFilesHaveCodecHeader, TestIsCurrent, TestLongPostings, TestDoubleValuesSource, TestOperations, TestBasics, TestBlendedTermQuery, TestSimpleExplanations, TestSparseFixedBitSet, TestLongRangeFieldQueries, TestBinaryDocument, TestNRTReaderWithThreads, TestFeatureSort, TestFloatRange, TestSearchForDuplicates, TestFlex, TestSortedNumericSortField, TestDocIdSetBuilder, Test2BPagedBytes, TestSegmentReader, TestDirectory, TestSPIClassIterator, TestPerFieldDocValuesFormat, TestBoolean2ScorerSupplier, Test2BPostingsBytes, TestIndexWriterMergePolicy, TestMutableValues, TestIndexingSequenceNumbers, TestPendingSoftDeletes, TestIndexWriterOnDiskFull, TestPagedBytes, TestIndexTooManyDocs, TestBufferedChecksum, TestDistributionLL, TestDuelingCodecsAtNight, TestDocumentsWriterDeleteQueue, TestOmitNorms, TestBitUtil, TestTerm, TestTermVectorsReader, TestSpanFirstQuery, TestSearchWithThreads, TestTransactionRollback, TestSpanNotQuery, TestVersion, TestPayloads, TestCharArrayMap, TestControlledRealTimeReopenThread, TestMathUtil, TestReqExclBulkScorer, TestGrowableByteArrayDataOutput, TestMultiLevelSkipList, TestInPlaceMergeSorter, TestLongDistanceFeatureQuery, TestIndexWriterExceptions, TestNGramPhraseQuery, TestBytesRefArray, Test2BPoints, TestSoftDeletesRetentionMergePolicy, TestBytesRefAttImpl, TestDeterminizeLexicon, TestBasicModelG, TestIndexOptions, TestCodecs, TestPointValues, TestForceMergeForever, TestCompiledAutomaton, TestDocsAndPositions, TestCompetitiveFreqNormAccumulator, TestToken, TestLucene70SegmentInfoFormat, TestCharacterUtils, TestFstDirectAddressing, TestDisjunctionMaxQuery, TestAssertions, TestDemo, TestExternalCodecs, TestDelegatingAnalyzerWrapper, TestGraphTokenFilter, TestGraphTokenizers, TestCharTermAttributeImpl, TestPackedTokenAttributeImpl, TestSimpleAttributeImpl, TestFastCompressionMode, TestFastDecompressionMode, TestHighCompressionMode, TestLucene50CompoundFormat, TestLucene50LiveDocsFormat, TestLucene50StoredFieldsFormat, TestLucene50StoredFieldsFormatHighCompression, TestLucene50StoredFieldsFormatMergeInstance, TestLucene50TermVectorsFormat, TestDateTools, TestDocument, TestDoubleRange, TestIntRange, TestLatLonDocValuesField, TestLatLonPoint, TestPolygon, TestPolygon2D, Test2BBinaryDocValues, Test2BSortedDocValuesFixedSorted, Test2BSortedDocValuesOrds, Test2BTerms, Test4GBStoredFields, TestAddIndexes, TestAllFilesCheckIndexHeader, TestAtomicUpdate, TestBagOfPositions, TestBagOfPostings, TestBinaryDocValuesUpdates, TestDirectoryReader, TestDirectoryReaderReopen, TestDoc, TestDocCount, TestDocIDMerger, TestDocInverterPerFieldErrorInfo, TestDocValues, TestExceedMaxTermLength, TestExitableDirectoryReader, TestFieldInfos, TestFieldInvertState, TestFieldReuse, TestFieldUpdatesBuffer, TestFieldsReader, TestFilterCodecReader, TestFilterDirectoryReader, TestFrozenBufferedUpdates, TestIndexCommit, TestIndexFileDeleter, TestIndexWriter, TestIndexWriterCommit, TestIndexWriterConfig, TestIndexWriterExceptions2, TestIndexWriterForceMerge, TestIndexWriterFromReader, TestIndexWriterReader, TestIndexWriterThreadsToSegments, TestIndexWriterUnicode, TestManyFields, TestOmitPositions, TestOneMergeWrappingMergePolicy, TestOrdinalMap, TestParallelLeafReader, TestPrefixCodedTerms, TestReadOnlyIndex, TestReaderClosed, TestReaderPool, TestReaderWrapperDVTypeCheck, TestSegmentTermDocs, TestSegmentTermEnum, TestSortedSetDocValues, TestStressDeletes, TestStressIndexing, TestStressIndexing2, TestStressNRT, TestTermVectorsWriter, TestTerms, TestTryDelete, TestTwoPhaseCommitTool, MultiCollectorTest, TermInSetQueryTest, TestBooleanMinShouldMatch, TestBooleanOr, TestBooleanRewrites, TestBoostQuery, TestCachingCollector, TestComplexExplanations, TestComplexExplanationsOfNonMatches, TestConjunctionDISI, TestEarlyTermination, TestElevationComparator, TestFieldCacheRewriteMethod, TestFieldValueQuery, TestFuzzyQuery, TestIndexOrDocValuesQuery, TestIndexSearcher, TestIntRangeFieldQueries, TestLRUQueryCache, TestLongValuesSource, TestMatchAllDocsQuery, TestMatchNoDocsQuery, TestMatchesIterator, TestMaxScoreAccumulator, TestMaxScoreSumPropagator, TestMinShouldMatch2, TestMultiCollector, TestMultiPhraseEnum, TestMultiPhraseQuery, TestMultiTermConstantScore, TestMultiTermQueryRewrites, TestNeedsScores, TestNormsFieldExistsQuery, TestNot, TestPhrasePrefixQuery, TestPhraseQuery, TestPointQueries, TestPositionIncrement, TestPositiveScoresOnlyCollector, TestPrefixInBooleanQuery, TestPrefixQuery, TestPrefixRandom, TestQueryRescorer, TestQueryVisitor, TestRangeFieldsDocValuesQuery, TestRegexpQuery, TestReqOptSumScorer, TestSameScoresWithThreads, TestScoreCachingWrappingScorer, TestSearcherManager]
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSearcherManager -Dtests.seed=9882EB3CBB5D8DFB -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=lv-LV -Dtests.timezone=US/Michigan -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J2 | TestSearcherManager (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: The test or suite printed 10232 bytes to stdout and stderr, even though the limit was set to 8192 bytes. Increase the limit with @Limit, ignore it completely with @SuppressSysoutChecks or run with -Dtests.verbose=true
[junit4] > at __randomizedtesting.SeedInfo.seed([9882EB3CBB5D8DFB]:0)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [460/528 (1!)] on J2 in 471.16s, 11 tests, 1 failure, 1 error <<< FAILURES!
[...truncated 67505 lines...]
[JENKINS] Lucene-Solr-NightlyTests-8.x - Build # 278 - Still
unstable
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-8.x/278/
1 tests failed.
FAILED: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
Error Message:
took over 10 seconds after collection creation to update aliases
Stack Trace:
java.lang.AssertionError: took over 10 seconds after collection creation to update aliases
at __randomizedtesting.SeedInfo.seed([38E218DD8CB3CA79:11A596ECC928612]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.apache.solr.update.processor.RoutedAliasUpdateProcessorTest.waitColAndAlias(RoutedAliasUpdateProcessorTest.java:77)
at org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest.testTimeCat(DimensionalRoutedAliasUpdateProcessorTest.java:219)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at 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 16975 lines...]
[junit4] Suite: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4] 2> 7941219 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001
[junit4] 2> 7941220 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 7941220 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 7941220 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 7941320 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.ZkTestServer start zk server on port:43254
[junit4] 2> 7941320 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:43254
[junit4] 2> 7941320 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43254
[junit4] 2> 7941320 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 43254
[junit4] 2> 7941322 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941326 INFO (zkConnectionManagerCallback-17571-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941326 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7941330 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941331 INFO (zkConnectionManagerCallback-17573-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941331 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7941343 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941344 INFO (zkConnectionManagerCallback-17575-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941344 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7941448 WARN (jetty-launcher-17576-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 7941449 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 7941449 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 7941449 INFO (jetty-launcher-17576-thread-1) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_191-b12
[junit4] 2> 7941450 WARN (jetty-launcher-17576-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 7941450 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 7941450 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 7941450 INFO (jetty-launcher-17576-thread-2) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_191-b12
[junit4] 2> 7941451 WARN (jetty-launcher-17576-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 7941452 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 7941452 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 7941452 INFO (jetty-launcher-17576-thread-3) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_191-b12
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 7941465 INFO (jetty-launcher-17576-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 7941466 WARN (jetty-launcher-17576-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 7941466 INFO (jetty-launcher-17576-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2a9f1c4b{/solr,null,AVAILABLE}
[junit4] 2> 7941466 INFO (jetty-launcher-17576-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@51262474{/solr,null,AVAILABLE}
[junit4] 2> 7941466 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 7941466 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 7941466 INFO (jetty-launcher-17576-thread-4) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_191-b12
[junit4] 2> 7941466 INFO (jetty-launcher-17576-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@23b11def{/solr,null,AVAILABLE}
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@70b3fc92{SSL,[ssl, http/1.1]}{127.0.0.1:33636}
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-1) [ ] o.e.j.s.Server Started @7941526ms
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33636}
[junit4] 2> 7941467 ERROR (jetty-launcher-17576-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-24T17:53:00.249Z
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-4) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 7941467 INFO (jetty-launcher-17576-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6acdc7d0{/solr,null,AVAILABLE}
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@aaec7d5{SSL,[ssl, http/1.1]}{127.0.0.1:41801}
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-3) [ ] o.e.j.s.Server Started @7941527ms
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41801}
[junit4] 2> 7941468 ERROR (jetty-launcher-17576-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 7941468 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-24T17:53:00.250Z
[junit4] 2> 7941469 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941469 INFO (jetty-launcher-17576-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3a1c7ee6{SSL,[ssl, http/1.1]}{127.0.0.1:45099}
[junit4] 2> 7941469 INFO (jetty-launcher-17576-thread-2) [ ] o.e.j.s.Server Started @7941529ms
[junit4] 2> 7941469 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45099}
[junit4] 2> 7941470 ERROR (jetty-launcher-17576-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@42564360{SSL,[ssl, http/1.1]}{127.0.0.1:43008}
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-4) [ ] o.e.j.s.Server Started @7941529ms
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43008}
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-24T17:53:00.252Z
[junit4] 2> 7941470 ERROR (jetty-launcher-17576-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 7941470 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-24T17:53:00.252Z
[junit4] 2> 7941471 INFO (zkConnectionManagerCallback-17580-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941471 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7941471 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941471 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 7941472 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941472 INFO (zkConnectionManagerCallback-17584-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941472 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7941490 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 7941490 INFO (zkConnectionManagerCallback-17578-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941490 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7941490 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 7941491 INFO (zkConnectionManagerCallback-17582-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941493 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7941493 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 7941783 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 7941784 WARN (jetty-launcher-17576-thread-4) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 7941785 WARN (jetty-launcher-17576-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@44739735[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7941785 WARN (jetty-launcher-17576-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@44739735[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7941795 WARN (jetty-launcher-17576-thread-4) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 7941795 WARN (jetty-launcher-17576-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@994f23[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7941796 WARN (jetty-launcher-17576-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@994f23[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7941797 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43254/solr
[junit4] 2> 7941797 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941806 INFO (zkConnectionManagerCallback-17592-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941807 INFO (jetty-launcher-17576-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7941886 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 7941886 WARN (jetty-launcher-17576-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 7941899 WARN (jetty-launcher-17576-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2b4c4666[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7941899 WARN (jetty-launcher-17576-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2b4c4666[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7941901 WARN (jetty-launcher-17576-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 7941902 WARN (jetty-launcher-17576-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1c7413bc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7941902 WARN (jetty-launcher-17576-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1c7413bc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7941903 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43254/solr
[junit4] 2> 7941904 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7941905 INFO (zkConnectionManagerCallback-17599-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7941905 INFO (jetty-launcher-17576-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942045 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7942058 INFO (zkConnectionManagerCallback-17602-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7942058 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942145 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7942219 INFO (zkConnectionManagerCallback-17606-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7942219 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942243 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 7942257 WARN (jetty-launcher-17576-thread-3) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 7942261 WARN (jetty-launcher-17576-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@35d30e4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7942261 WARN (jetty-launcher-17576-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@35d30e4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7942262 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 7942262 WARN (jetty-launcher-17576-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 7942263 WARN (jetty-launcher-17576-thread-3) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 7942263 WARN (jetty-launcher-17576-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@a80d563[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7942263 WARN (jetty-launcher-17576-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@a80d563[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7942263 WARN (jetty-launcher-17576-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3059df43[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7942263 WARN (jetty-launcher-17576-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3059df43[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7942267 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43008_solr
[junit4] 2> 7942268 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.c.Overseer Overseer (id=75790221883277322-127.0.0.1:43008_solr-n_0000000000) starting
[junit4] 2> 7942277 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43254/solr
[junit4] 2> 7942277 WARN (jetty-launcher-17576-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 7942278 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7942278 WARN (jetty-launcher-17576-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1d3a427f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7942278 WARN (jetty-launcher-17576-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1d3a427f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7942279 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43254/solr
[junit4] 2> 7942279 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7942280 INFO (zkConnectionManagerCallback-17616-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7942280 INFO (jetty-launcher-17576-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942280 INFO (zkConnectionManagerCallback-17620-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7942280 INFO (jetty-launcher-17576-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942326 INFO (OverseerStateUpdate-75790221883277322-127.0.0.1:43008_solr-n_0000000000) [n:127.0.0.1:43008_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43008_solr
[junit4] 2> 7942326 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43008_solr
[junit4] 2> 7942328 INFO (OverseerStateUpdate-75790221883277322-127.0.0.1:43008_solr-n_0000000000) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 7942383 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 7942386 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:45099_solr as DOWN
[junit4] 2> 7942387 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 7942387 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45099_solr
[junit4] 2> 7942388 INFO (zkCallback-17601-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 7942395 INFO (zkCallback-17605-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 7942398 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 7942448 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7942448 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 7942483 INFO (zkConnectionManagerCallback-17625-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7942483 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942488 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 7942509 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7942512 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:33636_solr as DOWN
[junit4] 2> 7942525 INFO (zkConnectionManagerCallback-17630-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7942525 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942528 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 7942528 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33636_solr
[junit4] 2> 7942553 INFO (zkCallback-17624-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 7942553 INFO (zkCallback-17601-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 7942553 INFO (zkCallback-17605-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 7942555 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45099.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942558 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43008.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942574 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45099.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942575 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45099.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942582 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43008.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942582 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43008.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942586 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 7942586 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 7942586 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 7942587 INFO (jetty-launcher-17576-thread-2) [n:127.0.0.1:45099_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node2/.
[junit4] 2> 7942587 INFO (jetty-launcher-17576-thread-4) [n:127.0.0.1:43008_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node4/.
[junit4] 2> 7942612 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41801_solr as DOWN
[junit4] 2> 7942613 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 7942613 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 7942613 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41801_solr
[junit4] 2> 7942623 INFO (zkCallback-17629-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 7942623 INFO (zkCallback-17624-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 7942625 INFO (zkCallback-17605-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 7942647 INFO (zkCallback-17601-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 7942684 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 7942695 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33636.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942724 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33636.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942724 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33636.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942738 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 7942739 INFO (jetty-launcher-17576-thread-1) [n:127.0.0.1:33636_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/.
[junit4] 2> 7942753 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41801.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942773 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41801.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942773 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41801.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7942774 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 7942775 INFO (jetty-launcher-17576-thread-3) [n:127.0.0.1:41801_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node3/.
[junit4] 2> 7942963 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
[junit4] 2> 7942964 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7942965 INFO (zkConnectionManagerCallback-17641-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7942965 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942966 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 7942967 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43254/solr ready
[junit4] 2> 7942968 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.u.p.DimensionalRoutedAliasUpdateProcessorTest SolrClient: org.apache.solr.client.solrj.impl.CloudSolrClient@60682f25
[junit4] 2> 7942968 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.u.p.DimensionalRoutedAliasUpdateProcessorTest ClusterStateProvider 127.0.0.1:43254/solr
[junit4] 2> 7942969 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7942969 INFO (zkConnectionManagerCallback-17646-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 7942969 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7942970 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 7942971 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43254/solr ready
[junit4] 2> 7943013 INFO (qtp820254102-146596) [n:127.0.0.1:45099_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=_default&name=testTimeCat&action=CREATE&wt=javabin&version=2
[junit4] 2> 7943030 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"testTimeCat",
[junit4] 2> "baseConfigSet":"_default",
[junit4] 2> "immutable":"false",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 7943031 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/testTimeCat/protwords.txt
[junit4] 2> 7943032 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/testTimeCat/managed-schema
[junit4] 2> 7943042 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/testTimeCat/solrconfig.xml
[junit4] 2> 7943044 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/testTimeCat/synonyms.txt
[junit4] 2> 7943045 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/testTimeCat/stopwords.txt
[junit4] 2> 7943047 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/testTimeCat/params.json
[junit4] 2> 7943048 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/testTimeCat/lang/contractions_it.txt
[junit4] 2> 7943066 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/testTimeCat/lang/stopwords_no.txt
[junit4] 2> 7943068 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/testTimeCat/lang/stopwords_hy.txt
[junit4] 2> 7943069 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/testTimeCat/lang/stemdict_nl.txt
[junit4] 2> 7943072 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/testTimeCat/lang/contractions_ca.txt
[junit4] 2> 7943090 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/testTimeCat/lang/stopwords_id.txt
[junit4] 2> 7943092 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/testTimeCat/lang/stopwords_et.txt
[junit4] 2> 7943093 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/testTimeCat/lang/stopwords_ga.txt
[junit4] 2> 7943095 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/testTimeCat/lang/stopwords_da.txt
[junit4] 2> 7943096 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/testTimeCat/lang/stopwords_hi.txt
[junit4] 2> 7943106 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/testTimeCat/lang/stopwords_ja.txt
[junit4] 2> 7943108 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/testTimeCat/lang/stopwords_pt.txt
[junit4] 2> 7943109 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/testTimeCat/lang/stopwords_hu.txt
[junit4] 2> 7943110 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/testTimeCat/lang/stopwords_el.txt
[junit4] 2> 7943112 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/testTimeCat/lang/stopwords_ru.txt
[junit4] 2> 7943113 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/testTimeCat/lang/stopwords_tr.txt
[junit4] 2> 7943123 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/testTimeCat/lang/stopwords_ar.txt
[junit4] 2> 7943124 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/testTimeCat/lang/userdict_ja.txt
[junit4] 2> 7943126 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/testTimeCat/lang/stopwords_it.txt
[junit4] 2> 7943135 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/testTimeCat/lang/stopwords_eu.txt
[junit4] 2> 7943137 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/testTimeCat/lang/stopwords_cz.txt
[junit4] 2> 7943138 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/testTimeCat/lang/stoptags_ja.txt
[junit4] 2> 7943140 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/testTimeCat/lang/contractions_fr.txt
[junit4] 2> 7943141 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/testTimeCat/lang/stopwords_fa.txt
[junit4] 2> 7943151 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/testTimeCat/lang/stopwords_de.txt
[junit4] 2> 7943152 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/testTimeCat/lang/contractions_ga.txt
[junit4] 2> 7943153 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/testTimeCat/lang/stopwords_ca.txt
[junit4] 2> 7943155 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/testTimeCat/lang/stopwords_nl.txt
[junit4] 2> 7943156 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/testTimeCat/lang/stopwords_bg.txt
[junit4] 2> 7943158 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/testTimeCat/lang/stopwords_es.txt
[junit4] 2> 7943159 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/testTimeCat/lang/stopwords_en.txt
[junit4] 2> 7943160 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/testTimeCat/lang/stopwords_lv.txt
[junit4] 2> 7943162 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/testTimeCat/lang/stopwords_th.txt
[junit4] 2> 7943171 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/testTimeCat/lang/stopwords_ro.txt
[junit4] 2> 7943173 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/testTimeCat/lang/stopwords_fr.txt
[junit4] 2> 7943174 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/testTimeCat/lang/stopwords_sv.txt
[junit4] 2> 7943176 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/testTimeCat/lang/stopwords_fi.txt
[junit4] 2> 7943177 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/testTimeCat/lang/hyphenations_ga.txt
[junit4] 2> 7943178 INFO (OverseerThreadFactory-17455-thread-1-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/testTimeCat/lang/stopwords_gl.txt
[junit4] 2> 7943181 INFO (qtp820254102-146596) [n:127.0.0.1:45099_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/configs params={baseConfigSet=_default&name=testTimeCat&action=CREATE&wt=javabin&version=2} status=0 QTime=168
[junit4] 2> 7943182 INFO (qtp820254102-146598) [n:127.0.0.1:45099_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=testTimeCat&name=testTimeCat&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 7943197 INFO (OverseerThreadFactory-17455-thread-2-processing-n:127.0.0.1:43008_solr) [n:127.0.0.1:43008_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testTimeCat
[junit4] 2> 7943197 INFO (OverseerCollectionConfigSetProcessor-75790221883277322-127.0.0.1:43008_solr-n_0000000000) [n:127.0.0.1:43008_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 7943303 INFO (OverseerStateUpdate-75790221883277322-127.0.0.1:43008_solr-n_0000000000) [n:127.0.0.1:43008_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testTimeCat",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testTimeCat_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:33636/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 7943535 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=testTimeCat&newCollection=true&name=testTimeCat_shard1_replica_n1&action=CREATE&numShards=1&collection=testTimeCat&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 7944560 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 7944560 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 7944569 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 7944569 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7944569 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 7944570 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7944570 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 7944570 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7944570 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 7944570 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7944570 WARN (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7944570 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 7944607 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.s.IndexSchema [testTimeCat_shard1_replica_n1] Schema name=default-config
[junit4] 2> 7944876 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 7944955 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'testTimeCat_shard1_replica_n1' using configuration from collection testTimeCat, trusted=true
[junit4] 2> 7944955 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33636.solr.core.testTimeCat.shard1.replica_n1' (registry 'solr.core.testTimeCat.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
[junit4] 2> 7944955 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrCore [[testTimeCat_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/./testTimeCat_shard1_replica_n1/data/]
[junit4] 2> 7944970 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 7945063 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 7945063 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 7945065 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 7945065 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 7945078 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@79f8bb09[testTimeCat_shard1_replica_n1] main]
[junit4] 2> 7945080 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testTimeCat
[junit4] 2> 7945080 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testTimeCat
[junit4] 2> 7945080 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testTimeCat/managed-schema
[junit4] 2> 7945081 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 7945081 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 7945082 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 7945083 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 7945083 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1651106627049226240
[junit4] 2> 7945095 INFO (searcherExecutor-17472-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@79f8bb09[testTimeCat_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 7945095 INFO (searcherExecutor-17472-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 7945095 INFO (searcherExecutor-17472-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 7945096 INFO (searcherExecutor-17472-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SolrCore [testTimeCat_shard1_replica_n1] Registered new searcher Searcher@79f8bb09[testTimeCat_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 7945098 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testTimeCat/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 7945098 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/testTimeCat/leaders/shard1
[junit4] 2> 7945101 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 7945101 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 7945101 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:33636/solr/testTimeCat_shard1_replica_n1/
[junit4] 2> 7945101 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 7945101 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.SyncStrategy https://127.0.0.1:33636/solr/testTimeCat_shard1_replica_n1/ has no replicas
[junit4] 2> 7945101 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/testTimeCat/leaders/shard1/leader after winning as /collections/testTimeCat/leader_elect/shard1/election/75790221883277325-core_node2-n_0000000000
[junit4] 2> 7945103 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:33636/solr/testTimeCat_shard1_replica_n1/ shard1
[junit4] 2> 7945205 INFO (zkCallback-17624-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testTimeCat/state.json] for collection [testTimeCat] has occurred - updating... (live nodes size: [4])
[junit4] 2> 7945205 INFO (zkCallback-17624-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testTimeCat/state.json] for collection [testTimeCat] has occurred - updating... (live nodes size: [4])
[junit4] 2> 7945206 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 7945207 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=testTimeCat&newCollection=true&name=testTimeCat_shard1_replica_n1&action=CREATE&numShards=1&collection=testTimeCat&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1671
[junit4] 2> 7945225 INFO (qtp820254102-146598) [n:127.0.0.1:45099_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 7945308 INFO (zkCallback-17624-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testTimeCat/state.json] for collection [testTimeCat] has occurred - updating... (live nodes size: [4])
[junit4] 2> 7945308 INFO (zkCallback-17624-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testTimeCat/state.json] for collection [testTimeCat] has occurred - updating... (live nodes size: [4])
[junit4] 2> 7945308 INFO (zkCallback-17601-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testTimeCat/state.json] for collection [testTimeCat] has occurred - updating... (live nodes size: [4])
[junit4] 2> 7945308 INFO (zkCallback-17624-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testTimeCat/state.json] for collection [testTimeCat] has occurred - updating... (live nodes size: [4])
[junit4] 2> 7945309 INFO (qtp820254102-146598) [n:127.0.0.1:45099_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=testTimeCat&name=testTimeCat&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=2127
[junit4] 2> 7945309 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testTimeCat-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.SolrCloudTestCase waitForState (testTimeCat): waiting for collections to be created
[junit4] 2> 7945849 INFO (qtp2051774434-146604) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 1 replicas to set the property overlay to be of version 0 for collection testTimeCat
[junit4] 2> 7945867 INFO (Thread-97118) [ ] o.a.s.c.SolrCore config update listener called for core testTimeCat_shard1_replica_n1
[junit4] 2> 7945867 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 7945868 INFO (Thread-97118) [ ] o.a.s.c.SolrCore core reload testTimeCat_shard1_replica_n1
[junit4] 2> 7945897 INFO (Thread-97118) [ ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 7945897 INFO (Thread-97118) [ ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7945898 WARN (Thread-97118) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001/tempDir-001/node1/testTimeCat_shard1_replica_n1/../../../../dist
[junit4] 2> 7945899 INFO (Thread-97118) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 7945943 INFO (Thread-97118) [ ] o.a.s.s.IndexSchema [testTimeCat_shard1_replica_n1] Schema name=default-config
[junit4] 2> 7946002 INFO (qtp2051774434-146600) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 7946002 INFO (qtp2051774434-146600) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.S.Request [testTimeCat_shard1_replica_n1] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 7946002 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 7946002 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from https://127.0.0.1:33636/solr/testTimeCat_shard1_replica_n1/ for prop overlay after 1 attempts
[junit4] 2> 7946002 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 7946104 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 7946104 INFO (qtp2051774434-146602) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.S.Request [testTimeCat_shard1_replica_n1] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 7946104 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 7946104 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from https://127.0.0.1:33636/solr/testTimeCat_shard1_replica_n1/ for prop overlay after 2 attempts
[junit4] 2> 7946104 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 7946205 INFO (qtp2051774434-146595) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 7946206 INFO (qtp2051774434-146595) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.S.Request [testTimeCat_shard1_replica_n1] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 7946206 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 7946206 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from https://127.0.0.1:33636/solr/testTimeCat_shard1_replica_n1/ for prop overlay after 3 attempts
[junit4] 2> 7946206 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 7946265 INFO (Thread-97118) [ ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 7946311 INFO (qtp2051774434-146599) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 7946311 INFO (qtp2051774434-146599) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.c.S.Request [testTimeCat_shard1_replica_n1] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 7946311 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 7946327 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from https://127.0.0.1:33636/solr/testTimeCat_shard1_replica_n1/ for prop overlay after 4 attempts
[junit4] 2> 7946327 INFO (solrHandlerExecutor-17477-thread-1-processing-n:127.0.0.1:33636_solr x:testTimeCat_shard1_replica_n1 c:testTimeCat s:shard1 r:core_node2) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 7946373 INFO (Thread-97118) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'testTimeCat_shard1_replica_n1' using configuration from collection testTimeCat
[junit4] 2> 7946503 INFO (Thread-97118) [n:127.0.0.1:33636_solr c:testTimeCat s:shard1 r:core_node2 x:testTimeCat_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33636.solr.core.testTimeCat.shard1.replica_n1' (r
[...truncated too long message...]
-07-03/collectionprops.json
[junit4] 2> 5 /solr/collections/testCatTime__CRA__shorthair__TRA__2019-07-03/collectionprops.json
[junit4] 2> 5 /solr/collections/testCatTime__CRA__tabby__TRA__2019-07-01/collectionprops.json
[junit4] 2> 5 /solr/collections/testCatTime__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA_TEMP__TRA__2019-07-01/collectionprops.json
[junit4] 2> 4 /solr/collections/testCatTime__CRA__shorthair__TRA__2019-07-02/collectionprops.json
[junit4] 2> 4 /solr/collections/testCatTime__CRA__calico__TRA__2019-07-04/collectionprops.json
[junit4] 2> 4 /solr/collections/testCatTime__CRA__calico__TRA__2019-07-05/collectionprops.json
[junit4] 2> 4 /solr/collections/testCatTime__CRA__calico__TRA__2019-07-02/collectionprops.json
[junit4] 2> 4 /solr/collections/testCatTime__CRA__tabby__TRA__2019-07-02/collectionprops.json
[junit4] 2> 3 /solr/collections/testCatTime__CRA__calico__TRA__2019-07-06/collectionprops.json
[junit4] 2> 2 /solr/overseer_elect/election/75790230448635914-127.0.0.1:36498_solr-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 288 /solr/overseer/queue
[junit4] 2> 95 /solr/collections
[junit4] 2> 55 /solr/overseer/collection-queue-work
[junit4] 2> 24 /solr/live_nodes
[junit4] 2>
[junit4] 2> 8285004 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:34910
[junit4] 2> 8285004 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34910
[junit4] 2> 8285004 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[38E218DD8CB3CA79]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34910
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_38E218DD8CB3CA79-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {}, docValues:{}, maxPointsInLeafNode=735, maxMBSortInHeap=6.610945672887049, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@229e18cd), locale=tr, timezone=Atlantic/Cape_Verde
[junit4] 2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=4,threads=1,free=152022920,total=479723520
[junit4] 2> NOTE: All tests run in this JVM: [TestHalfAndHalfDocValues, PreAnalyzedUpdateProcessorTest, TestJettySolrRunner, HttpPartitionOnCommitTest, TestFieldCacheReopen, TestMinHashQParser, TestSlowCompositeReaderWrapper, MoveReplicaHDFSFailoverTest, ZkShardTermsTest, TestSimpleQParserPlugin, NodeAddedTriggerIntegrationTest, StatelessScriptUpdateProcessorFactoryTest, BufferStoreTest, TestCopyFieldCollectionResource, RegexBytesRefFilterTest, AnalyticsMergeStrategyTest, TestInPlaceUpdatesStandalone, TestSchemaManager, TestFieldTypeResource, TestCloudJSONFacetJoinDomain, TestPayloadScoreQParserPlugin, TestLRUStatsCache, UpdateParamsTest, CategoryRoutedAliasUpdateProcessorTest, ZkStateWriterTest, TestExpandComponent, TestSolrTestCaseJ4, TestDownShardTolerantSearch, QueryResultKeyTest, DistributedQueryElevationComponentTest, ShardsWhitelistTest, CustomCollectionTest, TestRequestForwarding, TestCustomStream, TestUseDocValuesAsStored, TestPullReplica, ExitableDirectoryReaderTest, TaggerTest, IndexSchemaTest, TestClusterStateMutator, DistributedFacetPivotSmallAdvancedTest, OverseerStatusTest, ExecutePlanActionTest, TestComponentsName, SSLMigrationTest, TestDynamicLoadingUrl, SplitShardTest, AutoscalingHistoryHandlerTest, TestWordDelimiterFilterFactory, BJQParserTest, TestDistributedSearch, TestDistributedTracing, MetricsHistoryWithAuthIntegrationTest, PreAnalyzedFieldManagedSchemaCloudTest, TestUpdate, TestRestoreCore, TestCollectionsAPIViaSolrCloudCluster, TestConfigsApi, SimplePostToolTest, NodeLostTriggerTest, TestCursorMarkWithoutUniqueKey, JSONWriterTest, DistributedTermsComponentTest, SecurityConfHandlerTest, TestReplicationHandlerBackup, TestZkChroot, TestQueryUtils, TestDistribIDF, SolrCoreMetricManagerTest, TestDeleteCollectionOnDownNodes, TestStressCloudBlindAtomicUpdates, TestReplicaProperties, TestWriterPerf, TestSolr4Spatial2, TestCoreBackup, TestCloudPseudoReturnFields, AsyncCallRequestStatusResponseTest, TestSolrJacksonAnnotation, BJQFilterAccessibleTest, CloudExitableDirectoryReaderTest, TestDeprecatedFilters, TestNoOpRegenerator, DistributedVersionInfoTest, TestRangeQuery, TestSchemaSimilarityResource, TestFacetMethods, SearchRateTriggerIntegrationTest, TriggerIntegrationTest, TestFieldCollectionResource, ConfigureRecoveryStrategyTest, PeerSyncWithIndexFingerprintCachingTest, TestCoreContainer, HDFSCollectionsAPITest, CheckHdfsIndexTest, CreateCollectionCleanupTest, TestNumericTerms32, SpellPossibilityIteratorTest, TestEmbeddedSolrServerAdminHandler, TestLeaderElectionWithEmptyReplica, AuthToolTest, TestFoldingMultitermQuery, TestBinaryField, FieldAnalysisRequestHandlerTest, PingRequestHandlerTest, LeaderFailoverAfterPartitionTest, TestAnalyzedSuggestions, ScheduledMaintenanceTriggerTest, MinimalSchemaTest, TestFieldCacheVsDocValues, TestBlobHandler, AtomicUpdateProcessorFactoryTest, TestRandomFaceting, RestartWhileUpdatingTest, TestUniqueKeyFieldResource, NoCacheHeaderTest, SolrInfoBeanTest, MetricsHandlerTest, TestRecovery, TestGraphMLResponseWriter, HighlighterTest, TestSort, DateMathParserTest, TestLazyCores, AddReplicaTest, TestFastOutputStream, IndexSizeTriggerTest, CollectionsAPIAsyncDistributedZkTest, TestConfigSetsAPIExclusivity, SolrLogAuditLoggerPluginTest, TestCloudSearcherWarming, TestCodecSupport, TestSimComputePlanAction, CacheHeaderTest, DebugComponentTest, TestNestedDocsSort, ReturnFieldsTest, DeleteShardTest, TestSimPolicyCloud, SpatialFilterTest, HdfsRecoverLeaseTest, MaxSizeAutoCommitTest, TestHighlightDedupGrouping, TestJoin, TestTrie, ProtectedTermFilterFactoryTest, BasicDistributedZk2Test, ChaosMonkeyNothingIsSafeWithPullReplicasTest, ChaosMonkeySafeLeaderWithPullReplicasTest, CollectionPropsTest, DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DistribDocExpirationUpdateProcessorTest, DistribJoinFromCollectionTest, ForceLeaderTest, FullSolrCloudDistribCmdsTest, HttpPartitionWithTlogReplicasTest, OverriddenZkACLAndCredentialsProvidersTest, PackageManagerCLITest, RecoveryAfterSoftCommitTest, ReindexCollectionTest, TestQueryingOnDownCollection, TestRandomRequestDistribution, TestSegmentSorting, TestSkipOverseerOperations, TestSolrCloudWithDelegationTokens, TestTlogReplica, TestTolerantUpdateProcessorCloud, TestTolerantUpdateProcessorRandomCloud, TestUtilizeNode, TriLevelCompositeIdRoutingTest, UnloadDistributedZkTest, ZkControllerTest, ShardSplitTest, CdcrReplicationHandlerTest, HdfsBasicDistributedZkTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, TestConfigSetImmutable, TestInitParams, TestQuerySenderNoQuery, TestShardHandlerFactory, TestSimpleTextCodec, TestSolrConfigHandler, TestSolrCoreSnapshots, TestDistribPackageStore, TestSolrConfigHandlerConcurrent, TestStressThreadBackup, V2StandaloneTest, XmlUpdateRequestHandlerTest, XsltUpdateRequestHandlerTest, CoreAdminOperationTest, CoreAdminRequestStatusTest, CoreMergeIndexesAdminHandlerTest, IndexSizeEstimatorTest, LoggingHandlerTest, StatsReloadRaceTest, DistributedExpandComponentTest, DistributedFacetPivotLargeTest, DistributedQueryComponentCustomSortTest, MoreLikeThisComponentTest, PhrasesIdentificationComponentTest, QueryElevationComponentTest, SuggestComponentContextFilterQueryTest, SuggestComponentTest, TermVectorComponentTest, TermsComponentTest, TestPivotHelperCode, TestTrackingShardHandlerFactory, HighlighterConfigTest, TestLegacyNumericUtils, TestNumericRangeQuery32, SolrShardReporterTest, TestIntervalFaceting, TestJsonFacetRefinement, TestJsonFacetsStatsParsing, TestJsonFacetsWithNestedObjects, SortByFunctionTest, TestFunctionQuery, TestMinMaxOnMultiValuedField, TestOrdValues, TestSortByMinMaxFunction, BlockJoinFacetRandomTest, BlockJoinFacetSimpleTest, GraphQueryTest, CloudMLTQParserTest, SimpleMLTQParserTest, TestBM25SimilarityFactory, TestClassicSimilarityFactory, TestDFISimilarityFactory, TestDFRSimilarityFactory, TestIBSimilarityFactory, TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestLegacyBM25SimilarityFactory, TestNonDefinedSimilarityFactory, TestPerFieldSimilarity, TestPerFieldSimilarityWithDefaultOverride, TestSweetSpotSimilarityFactory, AuditLoggerPluginTest, BasicAuthIntegrationTest, BasicAuthOnSingleNodeTest, BasicAuthStandaloneTest, JWTAuthPluginIntegrationTest, JWTAuthPluginTest, JWTVerificationkeyResolverTest, MultiDestinationAuditLoggerTest, TestPKIAuthenticationPlugin, TestRuleBasedAuthorizationPlugin, TestSha256AuthenticationProvider, TestDelegationWithHadoopAuth, TestImpersonationWithHadoopAuth, TestSolrCloudWithHadoopAuthPlugin, DirectSolrSpellCheckerTest, IndexBasedSpellCheckerTest, TestSuggestSpellingConverter, WordBreakSolrSpellCheckerTest, SuggesterTest, TestFileDictionaryLookup, TestFreeTextSuggestions, TestHighFrequencyDictionaryFactory, BlockCacheTest, TestDocTermOrds, TestDocTermOrdsUninvertLimit, DataDrivenBlockJoinTest, DirectUpdateHandlerTest, PeerSyncWithLeaderTest, SolrCmdDistributorTest, SolrIndexConfigTest, SolrIndexMetricsTest, SolrIndexSplitterTest, TestAtomicUpdateErrorCases, TestExceedMaxTermLength, TestHdfsUpdateLog, TestInPlaceUpdateWithRouteField, TestInPlaceUpdatesDistrib, ClassificationUpdateProcessorIntegrationTest, ClassificationUpdateProcessorTest, CloneFieldUpdateProcessorFactoryTest, DefaultValueUpdateProcessorTest, DimensionalRoutedAliasUpdateProcessorTest]
[junit4] Completed [885/885 (1!)] on J1 in 345.50s, 2 tests, 1 failure <<< FAILURES!
[...truncated 52881 lines...]
[JENKINS] Lucene-Solr-NightlyTests-8.x - Build # 277 - Still
Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-8.x/277/
1 tests failed.
FAILED: org.apache.lucene.document.TestXYPolygonShapeQueries.testRandomBig
Error Message:
Java heap space
Stack Trace:
java.lang.OutOfMemoryError: Java heap space
at __randomizedtesting.SeedInfo.seed([667AC0192FCB3FD4:E12DBD96BE924354]:0)
at org.apache.lucene.store.RAMFile.newBuffer(RAMFile.java:84)
at org.apache.lucene.store.RAMFile.addBuffer(RAMFile.java:57)
at org.apache.lucene.store.RAMOutputStream.switchCurrentBuffer(RAMOutputStream.java:168)
at org.apache.lucene.store.RAMOutputStream.writeBytes(RAMOutputStream.java:154)
at org.apache.lucene.store.MockIndexOutputWrapper.writeBytes(MockIndexOutputWrapper.java:141)
at org.apache.lucene.util.bkd.OfflinePointWriter.append(OfflinePointWriter.java:56)
at org.apache.lucene.util.bkd.BKDWriter.add(BKDWriter.java:247)
at org.apache.lucene.index.RandomCodec$1$1$1.visit(RandomCodec.java:129)
at org.apache.lucene.codecs.PointsWriter$1$1$1.visit(PointsWriter.java:117)
at org.apache.lucene.index.AssertingLeafReader$AssertingIntersectVisitor.visit(AssertingLeafReader.java:1171)
at org.apache.lucene.util.bkd.BKDReader.visitCompressedDocValues(BKDReader.java:735)
at org.apache.lucene.util.bkd.BKDReader.visitDocValuesWithCardinality(BKDReader.java:684)
at org.apache.lucene.util.bkd.BKDReader.visitDocValues(BKDReader.java:590)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:790)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:506)
at org.apache.lucene.index.AssertingLeafReader$AssertingPointValues.intersect(AssertingLeafReader.java:1052)
at org.apache.lucene.codecs.PointsWriter$1$1.intersect(PointsWriter.java:105)
at org.apache.lucene.index.RandomCodec$1$1.writeField(RandomCodec.java:122)
at org.apache.lucene.codecs.PointsWriter.mergeOneField(PointsWriter.java:62)
at org.apache.lucene.codecs.PointsWriter.merge(PointsWriter.java:191)
Build Log:
[...truncated 11035 lines...]
[junit4] Suite: org.apache.lucene.document.TestXYPolygonShapeQueries
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestXYPolygonShapeQueries -Dtests.method=testRandomBig -Dtests.seed=667AC0192FCB3FD4 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=et-EE -Dtests.timezone=America/Argentina/Rio_Gallegos -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 164s J0 | TestXYPolygonShapeQueries.testRandomBig <<<
[junit4] > Throwable #1: java.lang.OutOfMemoryError: Java heap space
[junit4] > at __randomizedtesting.SeedInfo.seed([667AC0192FCB3FD4:E12DBD96BE924354]:0)
[junit4] > at org.apache.lucene.store.RAMFile.newBuffer(RAMFile.java:84)
[junit4] > at org.apache.lucene.store.RAMFile.addBuffer(RAMFile.java:57)
[junit4] > at org.apache.lucene.store.RAMOutputStream.switchCurrentBuffer(RAMOutputStream.java:168)
[junit4] > at org.apache.lucene.store.RAMOutputStream.writeBytes(RAMOutputStream.java:154)
[junit4] > at org.apache.lucene.store.MockIndexOutputWrapper.writeBytes(MockIndexOutputWrapper.java:141)
[junit4] > at org.apache.lucene.util.bkd.OfflinePointWriter.append(OfflinePointWriter.java:56)
[junit4] > at org.apache.lucene.util.bkd.BKDWriter.add(BKDWriter.java:247)
[junit4] > at org.apache.lucene.index.RandomCodec$1$1$1.visit(RandomCodec.java:129)
[junit4] > at org.apache.lucene.codecs.PointsWriter$1$1$1.visit(PointsWriter.java:117)
[junit4] > at org.apache.lucene.index.AssertingLeafReader$AssertingIntersectVisitor.visit(AssertingLeafReader.java:1171)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.visitCompressedDocValues(BKDReader.java:735)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.visitDocValuesWithCardinality(BKDReader.java:684)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.visitDocValues(BKDReader.java:590)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:790)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:813)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:823)
[junit4] > at org.apache.lucene.util.bkd.BKDReader.intersect(BKDReader.java:506)
[junit4] > at org.apache.lucene.index.AssertingLeafReader$AssertingPointValues.intersect(AssertingLeafReader.java:1052)
[junit4] > at org.apache.lucene.codecs.PointsWriter$1$1.intersect(PointsWriter.java:105)
[junit4] > at org.apache.lucene.index.RandomCodec$1$1.writeField(RandomCodec.java:122)
[junit4] > at org.apache.lucene.codecs.PointsWriter.mergeOneField(PointsWriter.java:62)
[junit4] > at org.apache.lucene.codecs.PointsWriter.merge(PointsWriter.java:191)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/sandbox/test/J0/temp/lucene.document.TestXYPolygonShapeQueries_667AC0192FCB3FD4-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84))}, docValues:{shape=DocValuesFormat(name=Lucene80), id=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1298, maxMBSortInHeap=7.120886975137444, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@29f742e9), locale=et-EE, timezone=America/Argentina/Rio_Gallegos
[junit4] 2> NOTE: Linux 4.15.0-54-generic amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=4,threads=1,free=288528904,total=477626368
[junit4] 2> NOTE: All tests run in this JVM: [TestXYMultiPointShapeQueries, TestDocValuesTermsQuery, TestLatLonPointShapeQueries, TestIDVersionPostingsFormat, TestFloatPointNearestNeighbor, TestTessellator, TestLatLonMultiLineShapeQueries, TestLatLonLineShapeQueries, TestXYPolygonShapeQueries]
[junit4] Completed [31/38 (1!)] on J0 in 301.00s, 5 tests, 1 error <<< FAILURES!
[...truncated 1 lines...]
[junit4] JVM J0: stdout was not empty, see: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/lucene/build/sandbox/test/temp/junit4-J0-20191123_120344_1163774047011703071646.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: Java heap space
[junit4] Dumping heap to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/heapdumps/java_pid14822.hprof ...
[junit4] Heap dump file created [482008503 bytes in 0.509 secs]
[junit4] <<< JVM J0: EOF ----
[...truncated 15091 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/build.xml:652: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/build.xml:586: Some of the tests produced a heap dump, but did not fail. Maybe a suppressed OutOfMemoryError? Dumps created:
* java_pid14822.hprof
Total time: 273 minutes 41 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-NightlyTests-8.x - Build # 276 - Failure
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-8.x/276/
All tests passed
Build Log:
[...truncated 26137 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/build.xml:652: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.x/checkout/build.xml:128: Found 1 violations in source files (nocommit).
Total time: 273 minutes 23 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any