You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/07/02 04:50:13 UTC
[JENKINS] Lucene-Solr-NightlyTests-8.1 - Build # 49 - Failure
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-8.1/49/
8 tests failed.
FAILED: org.apache.lucene.index.TestIndexWriterThreadsToSegments.testSegmentCountOnFlushRandom
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
FAILED: junit.framework.TestSuite.org.apache.lucene.index.TestIndexWriterThreadsToSegments
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
FAILED: junit.framework.TestSuite.org.apache.lucene.index.TestIndexWriterThreadsToSegments
Error Message:
Captured an uncaught exception in thread: Thread[id=4748, name=Thread-4262, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4748, name=Thread-4262, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Caused by: java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:681)
at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:695)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1591)
at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
... 2 more
FAILED: junit.framework.TestSuite.org.apache.lucene.index.TestIndexWriterThreadsToSegments
Error Message:
Captured an uncaught exception in thread: Thread[id=4745, name=Thread-4259, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4745, name=Thread-4259, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
FAILED: junit.framework.TestSuite.org.apache.lucene.index.TestIndexWriterThreadsToSegments
Error Message:
Captured an uncaught exception in thread: Thread[id=4746, name=Thread-4260, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4746, name=Thread-4260, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at java.io.BufferedOutputStream.<init>(BufferedOutputStream.java:76)
at org.apache.lucene.store.OutputStreamIndexOutput.<init>(OutputStreamIndexOutput.java:42)
at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:411)
at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:407)
at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:255)
at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:667)
at org.apache.lucene.store.LockValidatingDirectoryWrapper.createOutput(LockValidatingDirectoryWrapper.java:44)
at org.apache.lucene.store.TrackingDirectoryWrapper.createOutput(TrackingDirectoryWrapper.java:43)
at org.apache.lucene.codecs.compressing.CompressingStoredFieldsWriter.<init>(CompressingStoredFieldsWriter.java:115)
at org.apache.lucene.codecs.compressing.CompressingStoredFieldsFormat.fieldsWriter(CompressingStoredFieldsFormat.java:128)
at org.apache.lucene.codecs.lucene50.Lucene50StoredFieldsFormat.fieldsWriter(Lucene50StoredFieldsFormat.java:183)
at org.apache.lucene.codecs.asserting.AssertingStoredFieldsFormat.fieldsWriter(AssertingStoredFieldsFormat.java:48)
at org.apache.lucene.index.StoredFieldsConsumer.initStoredFieldsWriter(StoredFieldsConsumer.java:39)
at org.apache.lucene.index.StoredFieldsConsumer.startDocument(StoredFieldsConsumer.java:46)
at org.apache.lucene.index.DefaultIndexingChain.startStoredFields(DefaultIndexingChain.java:367)
at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:403)
at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
FAILED: junit.framework.TestSuite.org.apache.lucene.index.TestIndexWriterThreadsToSegments
Error Message:
Captured an uncaught exception in thread: Thread[id=4744, name=Thread-4258, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4744, name=Thread-4258, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Caused by: java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:681)
at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:695)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1591)
at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
... 2 more
FAILED: junit.framework.TestSuite.org.apache.lucene.index.TestIndexWriterThreadsToSegments
Error Message:
Captured an uncaught exception in thread: Thread[id=4742, name=Thread-4256, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4742, name=Thread-4256, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at sun.nio.fs.UnixPath.encode(UnixPath.java:132)
at sun.nio.fs.UnixPath.<init>(UnixPath.java:71)
at sun.nio.fs.UnixFileSystem.getPath(UnixFileSystem.java:281)
at sun.nio.fs.AbstractPath.resolve(AbstractPath.java:53)
at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:411)
at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:407)
at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:255)
at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:667)
at org.apache.lucene.store.LockValidatingDirectoryWrapper.createOutput(LockValidatingDirectoryWrapper.java:44)
at org.apache.lucene.store.TrackingDirectoryWrapper.createOutput(TrackingDirectoryWrapper.java:43)
at org.apache.lucene.codecs.compressing.CompressingStoredFieldsWriter.<init>(CompressingStoredFieldsWriter.java:115)
at org.apache.lucene.codecs.compressing.CompressingStoredFieldsFormat.fieldsWriter(CompressingStoredFieldsFormat.java:128)
at org.apache.lucene.codecs.lucene50.Lucene50StoredFieldsFormat.fieldsWriter(Lucene50StoredFieldsFormat.java:183)
at org.apache.lucene.codecs.asserting.AssertingStoredFieldsFormat.fieldsWriter(AssertingStoredFieldsFormat.java:48)
at org.apache.lucene.index.StoredFieldsConsumer.initStoredFieldsWriter(StoredFieldsConsumer.java:39)
at org.apache.lucene.index.StoredFieldsConsumer.startDocument(StoredFieldsConsumer.java:46)
at org.apache.lucene.index.DefaultIndexingChain.startStoredFields(DefaultIndexingChain.java:367)
at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:403)
at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
FAILED: junit.framework.TestSuite.org.apache.lucene.index.TestIndexWriterThreadsToSegments
Error Message:
Captured an uncaught exception in thread: Thread[id=4741, name=Thread-4255, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4741, name=Thread-4255, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
Caused by: java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:681)
at org.apache.lucene.index.IndexWriter.ensureOpen(IndexWriter.java:695)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1591)
at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
... 2 more
Build Log:
[...truncated 2488 lines...]
[junit4] Suite: org.apache.lucene.index.TestIndexWriterThreadsToSegments
[junit4] 2> Ιουλ 01, 2019 3:41:55 ΜΜ com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-4260,5,TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at java.io.BufferedOutputStream.<init>(BufferedOutputStream.java:76)
[junit4] 2> at org.apache.lucene.store.OutputStreamIndexOutput.<init>(OutputStreamIndexOutput.java:42)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:411)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:407)
[junit4] 2> at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:255)
[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.compressing.CompressingStoredFieldsWriter.<init>(CompressingStoredFieldsWriter.java:115)
[junit4] 2> at org.apache.lucene.codecs.compressing.CompressingStoredFieldsFormat.fieldsWriter(CompressingStoredFieldsFormat.java:128)
[junit4] 2> at org.apache.lucene.codecs.lucene50.Lucene50StoredFieldsFormat.fieldsWriter(Lucene50StoredFieldsFormat.java:183)
[junit4] 2> at org.apache.lucene.codecs.asserting.AssertingStoredFieldsFormat.fieldsWriter(AssertingStoredFieldsFormat.java:48)
[junit4] 2> at org.apache.lucene.index.StoredFieldsConsumer.initStoredFieldsWriter(StoredFieldsConsumer.java:39)
[junit4] 2> at org.apache.lucene.index.StoredFieldsConsumer.startDocument(StoredFieldsConsumer.java:46)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.startStoredFields(DefaultIndexingChain.java:367)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:403)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] 2> at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] 2> at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] 2>
[junit4] 2> Ιουλ 01, 2019 3:41:55 ΜΜ com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-4255,5,TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
[junit4] 2> Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[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.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] 2> Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
[junit4] 2> at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
[junit4] 2> at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] 2> at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] 2> ... 2 more
[junit4] 2>
[junit4] 2> Ιουλ 01, 2019 3:41:55 ΜΜ com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-4258,5,TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
[junit4] 2> Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[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.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] 2> Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
[junit4] 2> at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
[junit4] 2> at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] 2> at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] 2> ... 2 more
[junit4] 2>
[junit4] 2> Ιουλ 01, 2019 3:41:55 ΜΜ com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-4256,5,TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at sun.nio.fs.UnixPath.encode(UnixPath.java:132)
[junit4] 2> at sun.nio.fs.UnixPath.<init>(UnixPath.java:71)
[junit4] 2> at sun.nio.fs.UnixFileSystem.getPath(UnixFileSystem.java:281)
[junit4] 2> at sun.nio.fs.AbstractPath.resolve(AbstractPath.java:53)
[junit4] 2> at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] 2> at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] 2> at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] 2> at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] 2> at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:411)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:407)
[junit4] 2> at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:255)
[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.compressing.CompressingStoredFieldsWriter.<init>(CompressingStoredFieldsWriter.java:115)
[junit4] 2> at org.apache.lucene.codecs.compressing.CompressingStoredFieldsFormat.fieldsWriter(CompressingStoredFieldsFormat.java:128)
[junit4] 2> at org.apache.lucene.codecs.lucene50.Lucene50StoredFieldsFormat.fieldsWriter(Lucene50StoredFieldsFormat.java:183)
[junit4] 2> at org.apache.lucene.codecs.asserting.AssertingStoredFieldsFormat.fieldsWriter(AssertingStoredFieldsFormat.java:48)
[junit4] 2> at org.apache.lucene.index.StoredFieldsConsumer.initStoredFieldsWriter(StoredFieldsConsumer.java:39)
[junit4] 2> at org.apache.lucene.index.StoredFieldsConsumer.startDocument(StoredFieldsConsumer.java:46)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.startStoredFields(DefaultIndexingChain.java:367)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:403)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] 2> at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] 2> at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] 2>
[junit4] 2> Ιουλ 01, 2019 3:41:55 ΜΜ com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-4262,5,TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
[junit4] 2> Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[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.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] 2> Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
[junit4] 2> at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
[junit4] 2> at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] 2> at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] 2> ... 2 more
[junit4] 2>
[junit4] 2> Ιουλ 01, 2019 3:41:55 ΜΜ com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Thread-4259,5,TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] 2> at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
[junit4] 2> at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
[junit4] 2> at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
[junit4] 2> at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
[junit4] 2> at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] 2> at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] 2> at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] 2>
[junit4] 2> Ιουλ 01, 2019 5:32:10 ΜΜ com.carrotsearch.randomizedtesting.ThreadLeakControl$2 evaluate
[junit4] 2> WARNING: Suite execution timed out: org.apache.lucene.index.TestIndexWriterThreadsToSegments
[junit4] 2> 1) Thread[id=4749, name=Thread-4263, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.CyclicBarrier.dowait(CyclicBarrier.java:234)
[junit4] 2> at java.util.concurrent.CyclicBarrier.await(CyclicBarrier.java:362)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:217)
[junit4] 2> 2) Thread[id=4729, name=SUITE-TestIndexWriterThreadsToSegments-seed#[D563D606E1A2C66F], state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at java.lang.Thread.getStackTrace(Thread.java:1559)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:696)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:693)
[junit4] 2> at java.security.AccessController.doPrivileged(Native Method)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.getStackTrace(ThreadLeakControl.java:693)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.getThreadsWithTraces(ThreadLeakControl.java:709)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.formatThreadStacksFull(ThreadLeakControl.java:689)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.access$1000(ThreadLeakControl.java:65)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$2.evaluate(ThreadLeakControl.java:415)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:708)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$200(RandomizedRunner.java:138)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:629)
[junit4] 2> 3) Thread[id=1, name=main, state=WAITING, group=main]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Thread.join(Thread.java:1252)
[junit4] 2> at java.lang.Thread.join(Thread.java:1326)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:639)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:496)
[junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:269)
[junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:394)
[junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:13)
[junit4] 2> 4) Thread[id=4747, name=Thread-4261, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.CyclicBarrier.dowait(CyclicBarrier.java:234)
[junit4] 2> at java.util.concurrent.CyclicBarrier.await(CyclicBarrier.java:362)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:217)
[junit4] 2> 5) Thread[id=9, name=JUnit4-serializer-daemon, state=TIMED_WAITING, group=main]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at com.carrotsearch.ant.tasks.junit4.events.Serializer$1.run(Serializer.java:50)
[junit4] 2> 6) Thread[id=4740, name=Thread-4254, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.CyclicBarrier.dowait(CyclicBarrier.java:234)
[junit4] 2> at java.util.concurrent.CyclicBarrier.await(CyclicBarrier.java:362)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:217)
[junit4] 2> 7) Thread[id=4730, name=TEST-TestIndexWriterThreadsToSegments.testSegmentCountOnFlushRandom-seed#[D563D606E1A2C66F], state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Thread.join(Thread.java:1252)
[junit4] 2> at java.lang.Thread.join(Thread.java:1326)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments.testSegmentCountOnFlushRandom(TestIndexWriterThreadsToSegments.java:228)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 8) Thread[id=4743, name=Thread-4257, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.CyclicBarrier.dowait(CyclicBarrier.java:234)
[junit4] 2> at java.util.concurrent.CyclicBarrier.await(CyclicBarrier.java:362)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:217)
[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=TestIndexWriterThreadsToSegments -Dtests.method=testSegmentCountOnFlushRandom -Dtests.seed=D563D606E1A2C66F -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/test-data/enwiki.random.lines.txt -Dtests.locale=el-CY -Dtests.timezone=America/North_Dakota/Beulah -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 7198s J2 | TestIndexWriterThreadsToSegments.testSegmentCountOnFlushRandom <<<
[junit4] > Throwable #1: java.lang.Exception: Test abandoned because suite timeout was reached.
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] 2> Ιουλ 01, 2019 5:32:10 ΜΜ com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 5 leaked thread(s).
[junit4] 2> Ιουλ 01, 2019 5:32:30 ΜΜ com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 5 threads leaked from SUITE scope at org.apache.lucene.index.TestIndexWriterThreadsToSegments:
[junit4] 2> 1) Thread[id=4749, name=Thread-4263, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.CyclicBarrier.dowait(CyclicBarrier.java:234)
[junit4] 2> at java.util.concurrent.CyclicBarrier.await(CyclicBarrier.java:362)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:217)
[junit4] 2> 2) Thread[id=4747, name=Thread-4261, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.CyclicBarrier.dowait(CyclicBarrier.java:234)
[junit4] 2> at java.util.concurrent.CyclicBarrier.await(CyclicBarrier.java:362)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:217)
[junit4] 2> 3) Thread[id=4740, name=Thread-4254, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.CyclicBarrier.dowait(CyclicBarrier.java:234)
[junit4] 2> at java.util.concurrent.CyclicBarrier.await(CyclicBarrier.java:362)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:217)
[junit4] 2> 4) Thread[id=4730, name=TEST-TestIndexWriterThreadsToSegments.testSegmentCountOnFlushRandom-seed#[D563D606E1A2C66F], state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Thread.join(Thread.java:1252)
[junit4] 2> at java.lang.Thread.join(Thread.java:1326)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments.testSegmentCountOnFlushRandom(TestIndexWriterThreadsToSegments.java:228)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 5) Thread[id=4743, name=Thread-4257, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.CyclicBarrier.dowait(CyclicBarrier.java:234)
[junit4] 2> at java.util.concurrent.CyclicBarrier.await(CyclicBarrier.java:362)
[junit4] 2> at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:217)
[junit4] 2> Ιουλ 01, 2019 5:32:30 ΜΜ com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=4749, name=Thread-4263, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> 2) Thread[id=4747, name=Thread-4261, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> 3) Thread[id=4740, name=Thread-4254, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> 4) Thread[id=4730, name=TEST-TestIndexWriterThreadsToSegments.testSegmentCountOnFlushRandom-seed#[D563D606E1A2C66F], state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> 5) Thread[id=4743, name=Thread-4257, state=WAITING, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/build/core/test/J2/temp/lucene.index.TestIndexWriterThreadsToSegments_D563D606E1A2C66F-001
[junit4] 2> Jul 01, 2019 10:32:31 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene80): {field=PostingsFormat(name=Direct)}, docValues:{}, maxPointsInLeafNode=1189, maxMBSortInHeap=6.365393374498929, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7be20d81), locale=el-CY, timezone=America/North_Dakota/Beulah
[junit4] 2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=4,threads=1,free=16185688,total=520617984
[junit4] 2> NOTE: All tests run in this JVM: [TestBlockPostingsFormat3, TestSimpleFSLockFactory, TestSimpleExplanationsWithFillerDocs, TestIndexWriterCommit, TestBasicModelIn, TestTragicIndexWriterDeadlock, TestBytesRefAttImpl, TestFixedBitSet, TestSpanNearQuery, TestSloppyPhraseQuery2, TestRollingUpdates, TestBinaryTerms, TestTimSorter, TestLucene50StoredFieldsFormatMergeInstance, TestConjunctionDISI, TestNIOFSDirectory, TestPhrasePrefixQuery, TestPagedBytes, TestNumericDocValuesUpdates, TestHighCompressionMode, TestAllFilesHaveChecksumFooter, TestLatLonDocValuesQueries, TestSortedSetSortField, TestRAMDirectory, TestNRTReaderCleanup, TestClassicSimilarity, TestPrefixCodedTerms, TestPolygon2D, TestSpanExplanationsOfNonMatches, TestSameScoresWithThreads, TestWildcard, TestForTooMuchCloning, TestDemoParallelLeafReader, TestSegmentMerger, Test2BPostings, TestLMDirichletSimilarity, TestTryDelete, TestAxiomaticF1LOG, TestLatLonPointDistanceSort, TestSpansEnum, TestMutableValues, TestTermsEnum2, TestAutomatonQueryUnicode, TestFutureArrays, Test2BSortedDocValuesOrds, TestTermVectors, TestFilterDirectory, TestIndexManyDocuments, TestIndexableField, TestBM25Similarity, TestSimpleAttributeImpl, TestSegmentCacheables, TestMultiFields, TestIndexWriterForceMerge, TestVersion, TestIndexWriterNRTIsCurrent, TestSpanSearchEquivalence, TestMultiPhraseQuery, TestIndependenceChiSquared, TestRadixSelector, Test2BNumericDocValues, TestMinShouldMatch2, TestInPlaceMergeSorter, TestCustomNorms, TestExitableDirectoryReader, TestCharArrayMap, TestLongRangeFieldQueries, TestByteArrayDataInput, TestDoc, TestMathUtil, TestNeverDelete, TestIndexWriterOnVMError, TestSloppyMath, TestToken, TestSpanCollection, TestDocValuesIndexing, TestSortRescorer, TestSPIClassIterator, TestBoolean2, TestLucene50LiveDocsFormat, TestConstantScoreScorer, TestDocValuesQueries, TestIndexSorting, TestCharsRefBuilder, TestStressIndexing2, TestConsistentFieldNumbers, TestAttributeSource, TestIndexWriterDeleteByQuery, TestIndexWriterFromReader, TestIndexWriterLockRelease, TestIndexWriterMaxDocs, TestIndexWriterOutOfFileDescriptors, TestIndexWriterReader, TestIndexWriterThreadsToSegments]
[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=TestIndexWriterThreadsToSegments -Dtests.seed=D563D606E1A2C66F -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/test-data/enwiki.random.lines.txt -Dtests.locale=el-CY -Dtests.timezone=America/North_Dakota/Beulah -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J2 | TestIndexWriterThreadsToSegments (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)Throwable #2: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4748, name=Thread-4262, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] > Caused by: java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
[junit4] > Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[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.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] > Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
[junit4] > at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
[junit4] > at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
[junit4] > at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] > at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] > at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] > ... 2 moreThrowable #3: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4745, name=Thread-4259, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] > Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
[junit4] > at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
[junit4] > at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
[junit4] > at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] > at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] > at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] > at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
[junit4] > at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)Throwable #4: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4746, name=Thread-4260, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] > Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at java.io.BufferedOutputStream.<init>(BufferedOutputStream.java:76)
[junit4] > at org.apache.lucene.store.OutputStreamIndexOutput.<init>(OutputStreamIndexOutput.java:42)
[junit4] > at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:411)
[junit4] > at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:407)
[junit4] > at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:255)
[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.compressing.CompressingStoredFieldsWriter.<init>(CompressingStoredFieldsWriter.java:115)
[junit4] > at org.apache.lucene.codecs.compressing.CompressingStoredFieldsFormat.fieldsWriter(CompressingStoredFieldsFormat.java:128)
[junit4] > at org.apache.lucene.codecs.lucene50.Lucene50StoredFieldsFormat.fieldsWriter(Lucene50StoredFieldsFormat.java:183)
[junit4] > at org.apache.lucene.codecs.asserting.AssertingStoredFieldsFormat.fieldsWriter(AssertingStoredFieldsFormat.java:48)
[junit4] > at org.apache.lucene.index.StoredFieldsConsumer.initStoredFieldsWriter(StoredFieldsConsumer.java:39)
[junit4] > at org.apache.lucene.index.StoredFieldsConsumer.startDocument(StoredFieldsConsumer.java:46)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.startStoredFields(DefaultIndexingChain.java:367)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:403)
[junit4] > at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] > at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] > at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] > at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
[junit4] > at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)Throwable #5: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4744, name=Thread-4258, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] > Caused by: java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
[junit4] > Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[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.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] > Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
[junit4] > at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
[junit4] > at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
[junit4] > at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] > at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] > at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] > ... 2 moreThrowable #6: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4742, name=Thread-4256, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] > Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at sun.nio.fs.UnixPath.encode(UnixPath.java:132)
[junit4] > at sun.nio.fs.UnixPath.<init>(UnixPath.java:71)
[junit4] > at sun.nio.fs.UnixFileSystem.getPath(UnixFileSystem.java:281)
[junit4] > at sun.nio.fs.AbstractPath.resolve(AbstractPath.java:53)
[junit4] > at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] > at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] > at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] > at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] > at org.apache.lucene.mockfile.FilterPath.resolve(FilterPath.java:155)
[junit4] > at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:411)
[junit4] > at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:407)
[junit4] > at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:255)
[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.compressing.CompressingStoredFieldsWriter.<init>(CompressingStoredFieldsWriter.java:115)
[junit4] > at org.apache.lucene.codecs.compressing.CompressingStoredFieldsFormat.fieldsWriter(CompressingStoredFieldsFormat.java:128)
[junit4] > at org.apache.lucene.codecs.lucene50.Lucene50StoredFieldsFormat.fieldsWriter(Lucene50StoredFieldsFormat.java:183)
[junit4] > at org.apache.lucene.codecs.asserting.AssertingStoredFieldsFormat.fieldsWriter(AssertingStoredFieldsFormat.java:48)
[junit4] > at org.apache.lucene.index.StoredFieldsConsumer.initStoredFieldsWriter(StoredFieldsConsumer.java:39)
[junit4] > at org.apache.lucene.index.StoredFieldsConsumer.startDocument(StoredFieldsConsumer.java:46)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.startStoredFields(DefaultIndexingChain.java:367)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:403)
[junit4] > at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] > at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] > at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] > at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
[junit4] > at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)Throwable #7: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=4741, name=Thread-4255, state=RUNNABLE, group=TGRP-TestIndexWriterThreadsToSegments]
[junit4] > Caused by: java.lang.RuntimeException: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at org.apache.lucene.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:220)
[junit4] > Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexWriter is closed
[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.index.TestIndexWriterThreadsToSegments$2.run(TestIndexWriterThreadsToSegments.java:209)
[junit4] > Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] > at __randomizedtesting.SeedInfo.seed([D563D606E1A2C66F]:0)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.readChar(MockTokenizer.java:237)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.readCodePoint(MockTokenizer.java:203)
[junit4] > at org.apache.lucene.analysis.MockTokenizer.incrementToken(MockTokenizer.java:164)
[junit4] > at org.apache.lucene.analysis.MockTokenFilter.incrementToken(MockTokenFilter.java:80)
[junit4] > at org.apache.lucene.analysis.MockVariableLengthPayloadFilter.incrementToken(MockVariableLengthPayloadFilter.java:44)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain$PerField.invert(DefaultIndexingChain.java:812)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:442)
[junit4] > at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:406)
[junit4] > at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:250)
[junit4] > at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:494)
[junit4] > at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1594)
[junit4] > ... 2 more
[junit4] Completed [519/519 (1!)] on J2 in 7220.96s, 4 tests, 8 errors <<< FAILURES!
[...truncated 1 lines...]
[junit4] JVM J2: stdout was not empty, see: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/build/core/test/temp/junit4-J2-20190701_180532_1035404205622535355137.sysout
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] Dumping heap to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/heapdumps/java_pid1945.hprof ...
[junit4] Heap dump file created [562695245 bytes in 20.113 secs]
[junit4] <<< JVM J2: EOF ----
[...truncated 23274 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/build.xml:652: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/build.xml:586: Some of the tests produced a heap dump, but did not fail. Maybe a suppressed OutOfMemoryError? Dumps created:
* java_pid1945.hprof
Total time: 644 minutes 57 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.1 - Build # 50 - Still
unstable
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-8.1/50/
1 tests failed.
FAILED: org.apache.solr.update.PeerSyncTest.test
Error Message:
.response[0][id][0]:1!=2
Stack Trace:
junit.framework.AssertionFailedError: .response[0][id][0]:1!=2
at __randomizedtesting.SeedInfo.seed([8221CF0205D372F8:A75F0D8AB2F1F00]:0)
at junit.framework.Assert.fail(Assert.java:57)
at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:999)
at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1026)
at org.apache.solr.BaseDistributedSearchTestCase.queryAndCompare(BaseDistributedSearchTestCase.java:723)
at org.apache.solr.BaseDistributedSearchTestCase.queryAndCompare(BaseDistributedSearchTestCase.java:714)
at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:104)
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 org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
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 14441 lines...]
[junit4] Suite: org.apache.solr.update.PeerSyncTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/init-core-data-001
[junit4] 2> 1279489 WARN (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
[junit4] 2> 1279489 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1279491 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 1279491 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1279492 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1279492 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1279493 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1279531 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1279572 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1279767 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1279872 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1279875 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1fff30db[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1279880 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4102c1e1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1279932 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1279932 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1280019 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280044 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280044 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280050 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1280113 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1280133 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1280250 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1280266 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1280266 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280267 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/init-core-data-001/]
[junit4] 2> 1280269 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1280285 WARN (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1280349 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1280350 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1280351 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1280351 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1280352 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@4eeb431c
[junit4] 2> 1280353 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@390c13b8[collection1] main]
[junit4] 2> 1280353 WARN (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1280360 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1280360 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999537582768128
[junit4] 2> 1280368 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1280390 INFO (searcherExecutor-4868-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@390c13b8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1280614 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/cores/collection1
[junit4] 2> 1280615 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1280616 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1280616 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1280616 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1280617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1280617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1280617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1280617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@238f1008{/,null,AVAILABLE}
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@24f8dca3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:37841}
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server Started @1280679ms
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=37841, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/cores}
[junit4] 2> 1280618 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.2
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-07-03T01:41:29.536Z
[junit4] 2> 1280619 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/solr.xml
[junit4] 2> 1280623 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1280623 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1280625 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1280737 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1280749 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6e205e95[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1280753 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6cbd235d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1280781 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1280781 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1280813 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280830 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280830 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280833 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/cores
[junit4] 2> 1280833 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1280834 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1280890 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1280910 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1281351 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1281362 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1281363 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1281363 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 1281366 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1281375 WARN (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1281457 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1281457 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1281460 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1281460 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1281463 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@891b3db
[junit4] 2> 1281466 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@57c0b567[collection1] main]
[junit4] 2> 1281466 WARN (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1281471 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1281474 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999538750881792
[junit4] 2> 1281478 INFO (searcherExecutor-4882-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@57c0b567[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1282163 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 1282164 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1282165 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1282165 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1282165 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1282166 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1282166 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1282166 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1282167 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2aa76dff{/,null,AVAILABLE}
[junit4] 2> 1282167 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@734aec5{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:34449}
[junit4] 2> 1282167 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server Started @1282228ms
[junit4] 2> 1282167 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=34449, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/cores}
[junit4] 2> 1282168 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.2
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-07-03T01:41:31.086Z
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/solr.xml
[junit4] 2> 1282173 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1282173 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1282175 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1282515 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1282516 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7f9ff24[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1282521 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@24343ce4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1282549 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1282549 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1282588 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1282612 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1282612 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1282617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/cores
[junit4] 2> 1282617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1282618 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1282685 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1282721 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1282992 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1283002 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1283003 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1283006 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 1283010 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1283036 WARN (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1283114 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1283114 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1283116 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1283116 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1283118 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@28da7d6a
[junit4] 2> 1283119 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a4628e7[collection1] main]
[junit4] 2> 1283119 WARN (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1283120 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1283121 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999540477886464
[junit4] 2> 1283125 INFO (searcherExecutor-4896-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a4628e7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1283798 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/cores/collection1
[junit4] 2> 1283799 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1283799 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1283799 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1283799 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1283800 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1283800 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1283801 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1283801 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@138c5be5{/,null,AVAILABLE}
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3eb3a9d2{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:36906}
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server Started @1283863ms
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=36906, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/cores}
[junit4] 2> 1283802 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.2
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-07-03T01:41:32.720Z
[junit4] 2> 1283803 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/solr.xml
[junit4] 2> 1283807 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1283807 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1283809 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1284016 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1284018 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@50fdaeae[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1284023 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@46615e3b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1284051 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1284051 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1284082 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1284100 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1284100 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1284103 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/cores
[junit4] 2> 1284103 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1284106 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1284144 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1284166 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1284296 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1284305 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1284306 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1284306 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/cores/collection1/data/]
[junit4] 2> 1284309 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1284315 WARN (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1284375 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1284375 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1284377 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1284377 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1284378 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@3acb9b58
[junit4] 2> 1284379 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@515e757a[collection1] main]
[junit4] 2> 1284380 WARN (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1284380 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1284380 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999541798043648
[junit4] 2> 1284397 INFO (searcherExecutor-4910-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@515e757a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1285070 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/cores/collection1
[junit4] 2> 1285071 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1285072 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1285072 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1285072 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1285074 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1285074 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1285074 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1285074 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@69cee1f4{/,null,AVAILABLE}
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@53b8c156{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:46016}
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server Started @1285136ms
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=46016, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/cores}
[junit4] 2> 1285075 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.2
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-07-03T01:41:33.993Z
[junit4] 2> 1285076 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/solr.xml
[junit4] 2> 1285080 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1285080 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1285082 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1285392 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1285393 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6e7e5fc9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1285398 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@436cca9a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1285429 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1285429 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1285459 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1285476 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1285476 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1285479 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/cores
[junit4] 2> 1285479 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1285480 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1285561 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1285606 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1285799 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1285808 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1285809 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1285812 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/cores/collection1/data/]
[junit4] 2> 1285817 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1285823 WARN (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1285962 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1285962 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1285964 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1285964 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1285965 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@20ddf8b9
[junit4] 2> 1285966 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5c1ff538[collection1] main]
[junit4] 2> 1285967 WARN (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1285967 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1285967 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999543462133760
[junit4] 2> 1285970 INFO (searcherExecutor-4924-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5c1ff538[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1285981 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1285987 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[1 (1)]} 0 3
[junit4] 2> 1286006 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:34449/collection1] nUpdates=100
[junit4] 2> 1286043 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3b756e40[collection1] realtime]
[junit4] 2> 1286043 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:32.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286043 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2} status=0 QTime=32
[junit4] 2> 1286045 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:1.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=0, maxInHash=0, versionsHash=0, numVersions=0, numDocs=0, maxDoc=0}
[junit4] 2> 1286045 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= DONE. We have no versions. sync failed.
[junit4] 2> 1286047 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286047 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&fingerprint=true&getVersions=100&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1286047 INFO (qtp329220070-19453) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:34449/collection1&wt=javabin&version=2} status=0 QTime=41
[junit4] 2> 1286052 INFO (qtp329220070-19454) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[1 (1)]} 0 3
[junit4] 2> 1286053 INFO (qtp329220070-19455) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:34449/collection1] nUpdates=100
[junit4] 2> 1286053 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286054 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1286076 INFO (qtp329220070-19455) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1131bbf0[collection1] realtime]
[junit4] 2> 1286076 INFO (qtp329220070-19455) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:22.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286076 INFO (qtp329220070-19455) [ x:collection1] o.a.s.u.PeerSync We are already in sync. No need to do a PeerSync
[junit4] 2> 1286076 INFO (qtp329220070-19455) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:34449/collection1&wt=javabin&version=2} status=0 QTime=23
[junit4] 2> 1286077 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1637999543577477120,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1286077 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18b1aea5 commitCommandVersion:1637999543577477120
[junit4] 2> 1286080 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4f19d250[collection1] main]
[junit4] 2> 1286081 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1286083 INFO (searcherExecutor-4896-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4f19d250[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.2):c1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.2, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1562118094939}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
[junit4] 2> 1286083 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 6
[junit4] 2> 1286087 INFO (qtp329220070-19456) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1637999543586914304,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1286087 INFO (qtp329220070-19456) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@41a9f6c2 commitCommandVersion:1637999543586914304
[junit4] 2> 1286119 INFO (qtp329220070-19456) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1cc5d429[collection1] main]
[junit4] 2> 1286119 INFO (qtp329220070-19456) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1286121 INFO (searcherExecutor-4910-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1cc5d429[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.2):c1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.2, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1562118094977}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
[junit4] 2> 1286122 INFO (qtp329220070-19456) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 37
[junit4] 2> 1286123 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 1286137 INFO (qtp329220070-19456) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 1286142 INFO (qtp1399230698-19433) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[2 (2)]} 0 3
[junit4] 2> 1286143 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:34449/collection1] nUpdates=100
[junit4] 2> 1286199 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@702a28a8[collection1] realtime]
[junit4] 2> 1286199 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:55.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286199 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2} status=0 QTime=55
[junit4] 2> 1286200 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286202 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4c991e68[collection1] realtime]
[junit4] 2> 1286203 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286203 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&fingerprint=true&getVersions=100&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1286203 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= Received 2 versions from http://127.0.0.1:34449/collection1 fingerprint:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286203 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= Requesting updates from http://127.0.0.1:34449/collection1n=1 versions=2
[junit4] 2> 1286205 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=2, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286205 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={getUpdates=2&distrib=false&qt=/get&fingerprint=true&onlyIfActive=false&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1286223 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (2)]} 0 17
[junit4] 2> 1286243 INFO (qtp329220070-19452) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@225b1ab5[collection1] realtime]
[junit4] 2> 1286244 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:20.0 result:{maxVersionSpecified=2, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286244 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync Fingerprint comparison: 0
[junit4] 2> 1286244 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4] 2> 1286244 INFO (qtp329220070-19452) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:34449/collection1&wt=javabin&version=2} status=0 QTime=101
[junit4] 2> 1286245 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1637999543753637888,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1286255 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18b1aea5 commitCommandVersion:1637999543753637888
[junit4] 2> 1286270 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@53068224[collection1] main]
[junit4] 2> 1286275 INFO (searcherExecutor-4896-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@53068224[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.2):c1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.2, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1562118094939}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}]) Uninverting(_1(8.1.2):c1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.2, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1562118095068}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
[junit4] 2> 1286275 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1286275 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 30
[junit4] 2> 1286276 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1637999543786143744,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1286277 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@41a9f6c2 commitCommandVersion:1637999543786143744
[junit4] 2> 1286283 INFO (qtp329220070-19453) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@63ab5c2e[collection1] main]
[junit4] 2> 1286284 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1286287 INFO (searcherExecutor-4910-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@63ab5c2e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.1.2):c2:[diagnostics={os=Linux, java.version=1.8.0_191, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=merge, os.version=4.4.0-137-generic, java.vendor=Oracle Corporation, java.vm.version=25.191-b12, lucene.version=8.1.2, mergeMaxNumSegments=-1, mergeFactor=2, timestamp=1562118095179}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
[junit4] 2> 1286288 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 12
[junit4] 2> 1286289 INFO (qtp1399230698-19433) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 1286290 INFO (qtp329220070-19454) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 1286292 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.BaseDistributedSearchTestCase Mismatched responses:
[junit4] 2> {responseHeader={status=0,QTime=0},response={numFound=2,start=0,docs=[SolrDocument{id=1, range_facet_l=[1], id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], multiDefault=[muLti-Default], intDefault=42, timestamp=Wed Jul 03 03:41:34 CEST 2019, _version_=1, intDvoDefault=42}, SolrDocument{id=2, range_facet_l=[2], id_i1=2, range_facet_l_dv=[2], range_facet_i_dv=[2], n_ti1=-690635325, n_f1=0.34940243, n_tf1=0.040914476, n_d1=0.089648886088605, n_td1=0.9231459813696291, n_l1=6296583917980809237, n_tl1=-1087821682597930894, n_dt1=Tue Aug 27 12:11:59 CET 47180983, n_tdt1=Sat Mar 03 19:10:42 CET 114208140, multiDefault=[muLti-Default], intDefault=42, timestamp=Wed Jul 03 03:41:35 CEST 2019, _version_=2, intDvoDefault=42}]}}
[junit4] 2> {responseHeader={status=0,QTime=0},response={numFound=2,start=0,docs=[SolrDocument{id=2, range_facet_l=[2], id_i1=2, range_facet_l_dv=[2], range_facet_i_dv=[2], n_ti1=-690635325, n_f1=0.34940243, n_tf1=0.040914476, n_d1=0.089648886088605, n_td1=0.9231459813696291, n_l1=6296583917980809237, n_tl1=-1087821682597930894, n_dt1=Tue Aug 27 12:11:59 CET 47180983, n_tdt1=Sat Mar 03 19:10:42 CET 114208140, multiDefault=[muLti-Default], intDefault=42, timestamp=Wed Jul 03 03:41:35 CEST 2019, _version_=2, intDvoDefault=42}, SolrDocument{id=1, range_facet_l=[1], id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], multiDefault=[muLti-Default], intDefault=42, timestamp=Wed Jul 03 03:41:34 CEST 2019, _version_=1, intDvoDefault=42}]}}
[junit4] 2> 1286293 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 1286303 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1230392284
[junit4] 2> 1286325 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=219235192
[junit4] 2> 1286325 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=744613716
[junit4] 2> 1286341 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=328030472
[junit4] 2> 1286347 INFO (coreCloseExecutor-4929-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@472535de
[junit4] 2> 1286347 INFO (coreCloseExecutor-4929-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=472535de
[junit4] 2> 1286347 INFO (coreCloseExecutor-4929-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3dcd10f5: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1c434ef2
[junit4] 2> 1286357 INFO (coreCloseExecutor-4931-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@229aa3b8
[junit4] 2> 1286358 INFO (coreCloseExecutor-4931-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=229aa3b8
[junit4] 2> 1286358 INFO (coreCloseExecutor-4931-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@71e62c06: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@5807f54c
[junit4] 2> 1286375 INFO (coreCloseExecutor-4930-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7793afa2
[junit4] 2> 1286376 INFO (coreCloseExecutor-4930-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=7793afa2
[junit4] 2> 1286376 INFO (coreCloseExecutor-4930-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3bacf07d: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@3d192e25
[junit4] 2> 1286386 INFO (coreCloseExecutor-4932-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@585de6f2
[junit4] 2> 1286386 INFO (coreCloseExecutor-4932-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=585de6f2
[junit4] 2> 1286386 INFO (coreCloseExecutor-4932-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5a02fe00: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@64f899fd
[junit4] 2> 1286397 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286397 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1bb38055: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@28684452
[junit4] 2> 1286401 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286401 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7d4a9673: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1064ed1a
[junit4] 2> 1286403 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1286403 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6102f09e: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43bf7cc7
[junit4] 2> 1286406 INFO (closeThreadPool-5229-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@24f8dca3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 1286407 INFO (closeThreadPool-5229-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@238f1008{/,null,UNAVAILABLE}
[junit4] 2> 1286409 INFO (closeThreadPool-5229-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1286410 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286410 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7f8dda69: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@a1dc9bd
[junit4] 2> 1286413 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286413 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5b660e32: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1064ed1a
[junit4] 2> 1286415 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1286415 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@45df24d2: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43bf7cc7
[junit4] 2> 1286473 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286473 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@29285f40: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@37f918f4
[junit4] 2> 1286476 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286476 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@508d5070: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1064ed1a
[junit4] 2> 1286477 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286477 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@267a9ebf: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1866e4f
[junit4] 2> 1286485 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1286485 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5562654: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43bf7cc7
[junit4] 2> 1286485 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286485 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@9341034: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1064ed1a
[junit4] 2> 1286488 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1286488 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@49b6b588: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43bf7cc7
[junit4] 2> 1286523 INFO (closeThreadPool-5229-thread-6) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@734aec5{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 1286551 INFO (closeThreadPool-5229-thread-6) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2aa76dff{/,null,UNAVAILABLE}
[junit4] 2> 1286551 INFO (closeThreadPool-5229-thread-6) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1286554 INFO (closeThreadPool-5229-thread-8) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@53b8c156{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 1286556 INFO (closeThreadPool-5229-thread-8) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@69cee1f4{/,null,UNAVAILABLE}
[junit4] 2> 1286557 INFO (closeThreadPool-5229-thread-8) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1286563 INFO (closeThreadPool-5229-thread-7) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3eb3a9d2{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 1286564 INFO (closeThreadPool-5229-thread-7) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@138c5be5{/,null,UNAVAILABLE}
[junit4] 2> 1286564 INFO (closeThreadPool-5229-thread-7) [ ] o.e.j.s.session node0 Stopped scavenging
[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=PeerSyncTest -Dtests.method=test -Dtests.seed=8221CF0205D372F8 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/test-data/enwiki.random.lines.txt -Dtests.locale=da-DK -Dtests.timezone=Europe/Zurich -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 7.08s J2 | PeerSyncTest.test <<<
[junit4] > Throwable #1: junit.framework.AssertionFailedError: .response[0][id][0]:1!=2
[junit4] > at __randomizedtesting.SeedInfo.seed([8221CF0205D372F8:A75F0D8AB2F1F00]:0)
[junit4] > at junit.framework.Assert.fail(Assert.java:57)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:999)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1026)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryAndCompare(BaseDistributedSearchTestCase.java:723)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryAndCompare(BaseDistributedSearchTestCase.java:714)
[junit4] > at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:104)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1286572 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1286572 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=199314562
[junit4] 2> 1286581 INFO (coreCloseExecutor-4937-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5ec90710
[junit4] 2> 1286581 INFO (coreCloseExecutor-4937-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=5ec90710
[junit4] 2> 1286581 INFO (coreCloseExecutor-4937-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1c42c1fe: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@616abc19
[junit4] 2> 1286600 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286600 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@716bcf8f: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@6596b8d4
[junit4] 2> 1286601 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286601 INFO (SUITE-PeerSyncTest
[...truncated too long message...]
y-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1558271355
[copy] Copying 239 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1558271355
[delete] Deleting directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1558271355
check-working-copy:
[ivy:cachepath] :: resolving dependencies :: #;working@lucene1-us-west
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;5.3.0.201903130848-r in public
[ivy:cachepath] found com.jcraft#jsch;0.1.54 in public
[ivy:cachepath] found com.jcraft#jzlib;1.1.1 in public
[ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] found org.bouncycastle#bcpg-jdk15on;1.60 in public
[ivy:cachepath] found org.bouncycastle#bcprov-jdk15on;1.60 in public
[ivy:cachepath] found org.bouncycastle#bcpkix-jdk15on;1.60 in public
[ivy:cachepath] found org.slf4j#slf4j-nop;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 51ms :: artifacts dl 5ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 9 | 0 | 0 | 0 || 9 | 0 |
---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] Checking working copy status...
-jenkins-base:
BUILD SUCCESSFUL
Total time: 277 minutes 23 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2847)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2726)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2707)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1072)
at hudson.FilePath.act(FilePath.java:1061)
at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1835)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3088)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1074)
at hudson.FilePath.act(FilePath.java:1061)
at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1835)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)