You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2019/05/02 05:53:26 UTC
[JENKINS-EA] Lucene-Solr-8.x-Windows (64bit/jdk-13-ea+18) - Build #
237 - Still Failing!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/237/
Java: 64bit/jdk-13-ea+18 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.update.PeerSyncWithLeaderTest.test
Error Message:
Unexpected exception type, expected SolrException but got org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:52496/collection1
Stack Trace:
junit.framework.AssertionFailedError: Unexpected exception type, expected SolrException but got org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:52496/collection1
at __randomizedtesting.SeedInfo.seed([BE1524C066D29295:36411B1AC82EFF6D]:0)
at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2700)
at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2689)
at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:279)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:567)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:835)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:52496/collection1
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:660)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224)
at org.apache.solr.BaseDistributedSearchTestCase.add(BaseDistributedSearchTestCase.java:576)
at org.apache.solr.update.PeerSyncTest.lambda$test$0(PeerSyncTest.java:281)
at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2695)
... 42 more
Caused by: java.net.SocketTimeoutException: Read timed out
at java.base/java.net.SocketInputStream.socketRead0(Native Method)
at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
at java.base/java.net.Socket$SocketInputStream.read(Socket.java:972)
at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:548)
... 49 more
FAILED: org.apache.solr.update.PeerSyncTest.test
Error Message:
Unexpected exception type, expected SolrException but got org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:51084/collection1
Stack Trace:
junit.framework.AssertionFailedError: Unexpected exception type, expected SolrException but got org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:51084/collection1
at __randomizedtesting.SeedInfo.seed([BE1524C066D29295:36411B1AC82EFF6D]:0)
at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2700)
at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2689)
at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:279)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:567)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:835)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:51084/collection1
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:660)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224)
at org.apache.solr.BaseDistributedSearchTestCase.add(BaseDistributedSearchTestCase.java:576)
at org.apache.solr.update.PeerSyncTest.lambda$test$0(PeerSyncTest.java:281)
at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2695)
... 42 more
Caused by: java.net.SocketTimeoutException: Read timed out
at java.base/java.net.SocketInputStream.socketRead0(Native Method)
at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
at java.base/java.net.Socket$SocketInputStream.read(Socket.java:972)
at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:548)
... 49 more
Build Log:
[...truncated 13949 lines...]
[junit4] Suite: org.apache.solr.update.PeerSyncTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\init-core-data-001
[junit4] 2> 1073407 WARN (SUITE-PeerSyncTest-seed#[BE1524C066D29295]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=16 numCloses=16
[junit4] 2> 1073407 INFO (SUITE-PeerSyncTest-seed#[BE1524C066D29295]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1073409 INFO (SUITE-PeerSyncTest-seed#[BE1524C066D29295]-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> 1073409 INFO (SUITE-PeerSyncTest-seed#[BE1524C066D29295]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1073409 INFO (SUITE-PeerSyncTest-seed#[BE1524C066D29295]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1073410 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1073410 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1073428 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 1073444 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1073521 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1073585 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1073589 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@64afb738[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1073593 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@35abc38c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1073615 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1073615 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1073631 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1073637 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1073637 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1073640 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1073661 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 1073680 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1073757 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1073770 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1073770 INFO (coreLoadExecutor-6185-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@23caba9f
[junit4] 2> 1073770 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\init-core-data-001\]
[junit4] 2> 1073770 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=96.74609375, floorSegmentMB=1.3818359375, forceMergeDeletesPctAllowed=26.2170774837334, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2042441906187519, deletesPctAllowed=20.032875142576426
[junit4] 2> 1073772 WARN (coreLoadExecutor-6185-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> 1073827 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1073827 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1073827 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1073827 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1073830 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=49.490234375, floorSegmentMB=0.8779296875, forceMergeDeletesPctAllowed=15.332129890048597, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8800935484127915, deletesPctAllowed=39.285389382364116
[junit4] 2> 1073830 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@59440d9d[collection1] main]
[junit4] 2> 1073830 WARN (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 1073831 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1073831 INFO (coreLoadExecutor-6185-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632394601115418624
[junit4] 2> 1073832 INFO (searcherExecutor-6186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@59440d9d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1073834 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1074199 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\control\cores\collection1
[junit4] 2> 1074200 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1074201 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1074201 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1074201 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18
[junit4] 2> 1074201 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1074201 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1074201 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1074202 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3c9c96ab{/,null,AVAILABLE}
[junit4] 2> 1074202 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4419e74c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:51077}
[junit4] 2> 1074202 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.Server Started @1074235ms
[junit4] 2> 1074202 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, hostPort=51077, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\control\cores}
[junit4] 2> 1074203 ERROR (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1074203 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1074203 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.2.0
[junit4] 2> 1074203 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1074203 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1074203 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-02T04:53:25.696811100Z
[junit4] 2> 1074203 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\control\solr.xml
[junit4] 2> 1074206 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1074206 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1074208 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1074351 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1074352 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4c50399e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1074356 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1d235901[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1074380 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1074380 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1074399 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1074403 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1074403 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1074408 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\control\cores
[junit4] 2> 1074408 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1074415 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1074434 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 1074446 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1074523 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1074534 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1074534 INFO (coreLoadExecutor-6199-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@23caba9f
[junit4] 2> 1074534 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\control\cores\collection1\data\]
[junit4] 2> 1074536 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=96.74609375, floorSegmentMB=1.3818359375, forceMergeDeletesPctAllowed=26.2170774837334, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2042441906187519, deletesPctAllowed=20.032875142576426
[junit4] 2> 1074536 WARN (coreLoadExecutor-6199-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> 1074592 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1074592 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1074593 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1074593 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1074594 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=49.490234375, floorSegmentMB=0.8779296875, forceMergeDeletesPctAllowed=15.332129890048597, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8800935484127915, deletesPctAllowed=39.285389382364116
[junit4] 2> 1074594 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d362d6b[collection1] main]
[junit4] 2> 1074594 WARN (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 1074594 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1074595 INFO (coreLoadExecutor-6199-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632394601916530688
[junit4] 2> 1074596 INFO (searcherExecutor-6200-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1d362d6b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1074950 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard0\cores\collection1
[junit4] 2> 1074951 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1074951 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1074951 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1074951 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18
[junit4] 2> 1074952 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1074952 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1074952 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1074952 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@46880ccd{/,null,AVAILABLE}
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@64d102fe{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:51084}
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.Server Started @1074986ms
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, hostPort=51084, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard0\cores}
[junit4] 2> 1074953 ERROR (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.2.0
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-02T04:53:26.446801400Z
[junit4] 2> 1074953 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard0\solr.xml
[junit4] 2> 1074956 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1074956 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1074962 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1075018 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1075020 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@630829ac[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1075024 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2b2bc86b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1075047 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1075047 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1075065 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1075073 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1075074 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1075076 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard0\cores
[junit4] 2> 1075076 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1075077 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1075105 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 1075118 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1075208 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1075219 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1075220 INFO (coreLoadExecutor-6213-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@23caba9f
[junit4] 2> 1075220 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard0\cores\collection1\data\]
[junit4] 2> 1075220 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=96.74609375, floorSegmentMB=1.3818359375, forceMergeDeletesPctAllowed=26.2170774837334, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2042441906187519, deletesPctAllowed=20.032875142576426
[junit4] 2> 1075222 WARN (coreLoadExecutor-6213-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> 1075272 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1075272 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1075274 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1075274 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1075275 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=49.490234375, floorSegmentMB=0.8779296875, forceMergeDeletesPctAllowed=15.332129890048597, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8800935484127915, deletesPctAllowed=39.285389382364116
[junit4] 2> 1075275 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@406a5593[collection1] main]
[junit4] 2> 1075275 WARN (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 1075276 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1075276 INFO (coreLoadExecutor-6213-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632394602630610944
[junit4] 2> 1075278 INFO (searcherExecutor-6214-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@406a5593[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1075642 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard1\cores\collection1
[junit4] 2> 1075643 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1075643 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1075643 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1075643 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18
[junit4] 2> 1075644 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1075644 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1075644 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1075644 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3ca07b85{/,null,AVAILABLE}
[junit4] 2> 1075645 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5bcb077b{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:51113}
[junit4] 2> 1075645 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.Server Started @1075678ms
[junit4] 2> 1075645 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, hostPort=51113, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard1\cores}
[junit4] 2> 1075645 ERROR (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1075645 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1075645 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.2.0
[junit4] 2> 1075645 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1075645 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1075645 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-02T04:53:27.138831200Z
[junit4] 2> 1075646 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard1\solr.xml
[junit4] 2> 1075648 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1075648 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1075649 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1075746 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1075748 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3f6250c0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1075751 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@205785b6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1075773 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1075773 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1075790 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1075797 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1075797 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1075799 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard1\cores
[junit4] 2> 1075799 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1075800 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1075819 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 1075839 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1075916 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1075926 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1075926 INFO (coreLoadExecutor-6227-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@23caba9f
[junit4] 2> 1075927 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard1\cores\collection1\data\]
[junit4] 2> 1075927 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=96.74609375, floorSegmentMB=1.3818359375, forceMergeDeletesPctAllowed=26.2170774837334, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2042441906187519, deletesPctAllowed=20.032875142576426
[junit4] 2> 1075928 WARN (coreLoadExecutor-6227-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> 1075978 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1075978 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1075978 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1075978 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1075980 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=49.490234375, floorSegmentMB=0.8779296875, forceMergeDeletesPctAllowed=15.332129890048597, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8800935484127915, deletesPctAllowed=39.285389382364116
[junit4] 2> 1075981 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@44f103a3[collection1] main]
[junit4] 2> 1075981 WARN (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 1075981 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1075982 INFO (coreLoadExecutor-6227-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632394603370905600
[junit4] 2> 1075984 INFO (searcherExecutor-6228-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@44f103a3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1076483 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard2\cores\collection1
[junit4] 2> 1076484 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1076485 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1076485 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1076485 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18
[junit4] 2> 1076485 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1076485 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1076485 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1076486 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6cb5025{/,null,AVAILABLE}
[junit4] 2> 1076487 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@536f0085{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:51120}
[junit4] 2> 1076487 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.s.Server Started @1076520ms
[junit4] 2> 1076487 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, hostPort=51120, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard2\cores}
[junit4] 2> 1076488 ERROR (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1076488 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1076488 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.2.0
[junit4] 2> 1076488 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1076488 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1076488 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-02T04:53:27.981848Z
[junit4] 2> 1076488 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard2\solr.xml
[junit4] 2> 1076492 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1076492 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1076492 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1076773 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1076776 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7b3132ed[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1076781 WARN (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1707ac37[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1076810 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1076810 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1076828 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1076836 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1076836 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@23caba9f
[junit4] 2> 1076838 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard2\cores
[junit4] 2> 1076838 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1076840 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1076864 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 1076876 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1076958 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1076969 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1076969 INFO (coreLoadExecutor-6241-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@23caba9f
[junit4] 2> 1076969 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.PeerSyncTest_BE1524C066D29295-001\tempDir-001\shard2\cores\collection1\data\]
[junit4] 2> 1076970 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=96.74609375, floorSegmentMB=1.3818359375, forceMergeDeletesPctAllowed=26.2170774837334, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2042441906187519, deletesPctAllowed=20.032875142576426
[junit4] 2> 1076972 WARN (coreLoadExecutor-6241-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> 1077027 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1077027 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1077029 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1077029 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1077030 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=49.490234375, floorSegmentMB=0.8779296875, forceMergeDeletesPctAllowed=15.332129890048597, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8800935484127915, deletesPctAllowed=39.285389382364116
[junit4] 2> 1077030 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3d25e105[collection1] main]
[junit4] 2> 1077030 WARN (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 1077030 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1077030 INFO (coreLoadExecutor-6241-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632394604469813248
[junit4] 2> 1077032 INFO (searcherExecutor-6242-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3d25e105[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1077033 INFO (TEST-PeerSyncTest.test-seed#[BE1524C066D29295]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1077037 INFO (qtp1106616738-19108) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[1 (1)]} 0 1
[junit4] 2> 1077039 INFO (qtp2127777786-19129) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:51084/collection1] nUpdates=100
[junit4] 2> 1077046 INFO (qtp1106616738-19111) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@f3dc88b[collection1] realtime]
[junit4] 2> 1077046 INFO (qtp1106616738-19111) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:4.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1077046 INFO (qtp1106616738-19111) [ 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=5
[junit4] 2> 1077046 INFO (qtp2127777786-19129) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=0, maxInHash=0, versionsHash=0, numVersions=0, numDocs=0, maxDoc=0}
[junit4] 2> 1077046 INFO (qtp2127777786-19129) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= DONE. We have no versions. sync failed.
[junit4] 2> 1077047 INFO (qtp1106616738-19110) [ 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> 1077047 INFO (qtp1106616738-19110) [ 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> 1077047 INFO (qtp2127777786-19129) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:51084/collection1&wt=javabin&version=2} status=0 QTime=8
[junit4] 2> 1077048 INFO (qtp2127777786-19130) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[1 (1)]} 0 1
[junit4] 2> 1077049 INFO (qtp2127777786-19131) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:51084/collection1] nUpdates=100
[junit4] 2> 1077050 INFO (qtp1106616738-19112) [ 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> 1077050 INFO (qtp1106616738-19112) [ 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> 1077052 INFO (qtp2127777786-19131) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2ff634d0[collection1] realtime]
[junit4] 2> 1077052 INFO (qtp2127777786-19131) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:2.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1077052 INFO (qtp2127777786-19131) [ x:collection1] o.a.s.u.PeerSync We are already in sync. No need to do a PeerSync
[junit4] 2> 1077052 INFO (qtp2127777786-19131) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:51084/collection1&wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 1077054 INFO (qtp1106616738-19107) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632394604494979072,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1077054 INFO (qtp1106616738-19107) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c04bf81 commitCommandVersion:1632394604494979072
[junit4] 2> 1077055 INFO (qtp1106616738-19107) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6d675aa2[collection1] main]
[junit4] 2> 1077055 INFO (qtp1106616738-19107) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1077056 INFO (searcherExecutor-6214-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6d675aa2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.2.0):C1:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+18, lucene.version=8.2.0, os.arch=amd64, java.runtime.version=13-ea+18, source=flush, os.version=10.0, timestamp=1556772808535}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 1077056 INFO (qtp1106616738-19107) [ 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 3
[junit4] 2> 1077057 INFO (qtp2127777786-19132) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632394604498124800,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1077057 INFO (qtp2127777786-19132) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@bfba200 commitCommandVersion:1632394604498124800
[junit4] 2> 1077058 INFO (qtp2127777786-19132) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@58fa0552[collection1] main]
[junit4] 2> 1077059 INFO (qtp2127777786-19132) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1077061 INFO (searcherExecutor-6228-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@58fa0552[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.2.0):C1:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+18, lucene.version=8.2.0, os.arch=amd64, java.runtime.version=13-ea+18, source=flush, os.version=10.0, timestamp=1556772808544}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 1077061 INFO (qtp2127777786-19132) [ 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 3
[junit4] 2> 1077061 INFO (qtp1106616738-19108) [ 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> 1077063 INFO (qtp2127777786-19133) [ 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> 1077066 INFO (qtp1106616738-19109) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[2 (2)]} 0 2
[junit4] 2> 1077067 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:51084/collection1] nUpdates=100
[junit4] 2> 1077069 INFO (qtp1106616738-19111) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1db0123e[collection1] realtime]
[junit4] 2> 1077069 INFO (qtp1106616738-19111) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:3.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1077070 INFO (qtp1106616738-19111) [ 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=3
[junit4] 2> 1077070 INFO (qtp2127777786-19128) [ 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> 1077071 INFO (qtp1106616738-19110) [ 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> 1077072 INFO (qtp1106616738-19110) [ 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> 1077072 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= Received 2 versions from http://127.0.0.1:51084/collection1 fingerprint:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1077072 INFO (qtp1106616738-19112) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&checkCanHandleVersionRanges=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1077073 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= Requesting updates from http://127.0.0.1:51084/collection1n=1 versions=2...2
[junit4] 2> 1077073 INFO (qtp1106616738-19107) [ 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> 1077073 INFO (qtp1106616738-19107) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={getUpdates=2...2&distrib=false&qt=/get&fingerprint=true&onlyIfActive=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1077075 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (2)]} 0 2
[junit4] 2> 1077078 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5c88348e[collection1] realtime]
[junit4] 2> 1077078 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:2.0 result:{maxVersionSpecified=2, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1077078 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.u.PeerSync Fingerprint comparison: 0
[junit4] 2> 1077078 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4] 2> 1077078 INFO (qtp2127777786-19128) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:51084/collection1&wt=javabin&version=2} status=0 QTime=12
[junit4] 2> 1077078 INFO (qtp1106616738-19108) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632394604520144896,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1077078 INFO (qtp1106616738-19108) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c04bf81 commitCommandVersion:1632394604520144896
[junit4] 2> 1077079 INFO (qtp1106616738-19108) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@65c638e4[collection1] main]
[junit4] 2> 1077079 INFO (qtp1106616738-19108) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1077080 INFO (searcherExecutor-6214-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@65c638e4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.2.0):C1:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+18, lucene.version=8.2.0, os.arch=amd64, java.runtime.version=13-ea+18, source=flush, os.version=10.0, timestamp=1556772808535}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.2.0):C1:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+18, lucene.version=8.2.0, os.arch=amd64, java.runtime.version=13-ea+18, source=flush, os.version=10.0, timestamp=1556772808561}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 1077080 INFO (qtp1106616738-19108) [ 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 2
[junit4] 2> 1077080 INFO (qtp2127777786-19129) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632394604522242048,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1077080 INFO (qtp2127777786-19129) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@bfba200 commitCommandVersion:1632394604522242048
[junit4] 2> 1077080 INFO (qtp2127777786-19129) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5afce152[collection1] main]
[junit4] 2> 1077080 INFO (qtp2127777786-19129) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1077080 INFO (searcherExecutor-6228-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5afce152[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.2.0):C1:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+18, lucene.version=8.2.0, os.arch=amd64, java.runtime.version=13-ea+18, source=flush, os.version=10.0, timestamp=1556772808544}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.2.0):C1:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+18, lucene.version=8.2.0, os.arch=amd64, java.runtime.version=13-ea+18, source=flush, os.version=10.0, timestamp=1556772808570}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 1077080 INFO (qtp2127777786-19129) [ 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 1
[junit4] 2> 1077084 INFO (qtp1106616738-19109) [ 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> 1077087 INFO (qtp2127777786-19130) [ 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> 1077092 INFO (qtp1106616738-19111) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[3 (3)]} 0 2
[junit4] 2> 1077094 INFO (qtp1106616738-19111) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[4 (4)]} 0 1
[junit4] 2> 1077095 INFO (qtp1106616738-19112) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[5 (5)]} 0 0
[junit4] 2> 1077095 INFO (qtp1106616738-19107) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[6 (6)]} 0 0
[junit4] 2> 1077096 INFO (qtp1106616738-19108) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[7 (7)]} 0 0
[junit4] 2> 1077096 INFO (qtp1106616738-19109) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[8 (8)]} 0 0
[junit4] 2> 1077098 INFO (qtp1106616738-19110) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[9 (9)]} 0 0
[junit4] 2> 1077098 INFO (qtp1106616738-19111) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[10 (10)]} 0 0
[junit4] 2> 1077098 INFO (qtp2127777786-19131) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:51084/collection1] nUpdates=100
[junit4] 2> 1077100 INFO (qtp1106616738-19112) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1dd1c2dc[collection1] realtime]
[junit4] 2> 1077100 INFO (qtp1106616738-19112) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:3.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=10, maxInHash=10, versionsHash=-5671163287542876028, numVersions=10, numDocs=10, maxDoc=8}
[junit4] 2> 1077100 INFO (qtp1106616738-19112) [ 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=3
[junit4] 2> 1077100 INFO (qtp2127777786-19131) [ 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> 1077104 INFO (qtp1106616738-19107) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=10, maxInHash=10, versionsHash=-5671163287542876028, numVersions=10, numDocs=10, maxDoc=8}
[junit4] 2> 1077104 INFO (qtp1106616738-19107) [ 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> 1077104 INFO (qtp2127777786-19131) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= Received 10 versions from http://127.0.0.1:51084/collection1 fingerprint:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=10, maxInHash=10, versionsHash=-5671163287542876028, numVersions=10, numDocs=10, maxDoc=8}
[junit4] 2> 1077104 INFO (qtp1106616738-19108) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&checkCanHandleVersionRanges=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1077104 INFO (qtp2127777786-19131) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= Requesting updates from http://127.0.0.1:51084/collection1n=8 versions=3...10
[junit4] 2> 1077104 INFO (qtp1106616738-19109) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=10, maxVersionEncountered=10, maxInHash=10, versionsHash=-5671163287542876028, numVersions=10, numDocs=10, maxDoc=8}
[junit4] 2> 1077104 INFO (qtp1106616738-19109) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={getUpdates=3...10&distrib=false&qt=/get&fingerprint=true&onlyIfActive=false&wt=javabin&ve
[...truncated too long message...]
QParserPlugin, TestImpersonationWithHadoopAuth, MissingSegmentRecoveryTest, TlogReplayBufferedWhileIndexingTest, CursorMarkTest, IndexBasedSpellCheckerTest, BJQParserTest, SolrMetricReporterTest, SmileWriterTest, TestSimGenericDistributedQueue, CdcrBootstrapTest, SOLR749Test, AutoAddReplicasPlanActionTest, TestDistribIDF, TestManagedSynonymFilterFactory, TestSolrCLIRunExample, SyncSliceTest, TestSizeLimitedDistributedMap, TestCoreBackup, TestUseDocValuesAsStored, ImplicitSnitchTest, RestartWhileUpdatingTest, TestSegmentSorting, IndexSizeTriggerTest, TestSha256AuthenticationProvider, CdcrUpdateLogTest, SolrGraphiteReporterTest, TestCloudJSONFacetJoinDomain, TestWordDelimiterFilterFactory, SSLMigrationTest, ShardRoutingCustomTest, DirectSolrConnectionTest, SparseHLLTest, TestSolr4Spatial2, SimpleCollectionCreateDeleteTest, TestMinMaxOnMultiValuedField, DistributedFacetPivotLargeTest, TestZkAclsWithHadoopAuth, UnloadDistributedZkTest, SuggesterTSTTest, NotRequiredUniqueKeyTest, PeerSyncWithBufferUpdatesTest, TestGraphTermsQParserPlugin, SolrCoreMetricManagerTest, AssignTest, SharedFSAutoReplicaFailoverTest, TriggerCooldownIntegrationTest, TestNumericRangeQuery32, TestMiniSolrCloudClusterSSL, SolrRrdBackendFactoryTest, CleanupOldIndexTest, RecoveryZkTest, ChaosMonkeySafeLeaderWithPullReplicasTest, TransactionLogTest, CustomHighlightComponentTest, ReturnFieldsTest, LegacyCloudClusterPropTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestStressUserVersions, TestCoreDiscovery, SolrCloudReportersTest, RangeFacetCloudTest, SolrRequestParserTest, WordBreakSolrSpellCheckerTest, AddBlockUpdateTest, DistribCursorPagingTest, TestCursorMarkWithoutUniqueKey, TestPayloadScoreQParserPlugin, TestSolrXml, DistributedQueryElevationComponentTest, TestRandomRequestDistribution, TestHashPartitioner, RemoteQueryErrorTest, CollectionPropsTest, TestSolrCloudWithSecureImpersonation, TestClusterProperties, DistributedVersionInfoTest, TestSchemalessBufferedUpdates, OpenExchangeRatesOrgProviderTest, TestPhraseSuggestions, SolrXmlInZkTest, HdfsRecoverLeaseTest, TestSearcherReuse, SuggesterWFSTTest, TestSortByMinMaxFunction, XmlInterpolationTest, MoreLikeThisHandlerTest, TestCryptoKeys, CoreAdminOperationTest, TestCharFilters, TestFieldSortValues, TestExactStatsCache, TestExtendedDismaxParser, TestBulkSchemaConcurrent, CloneFieldUpdateProcessorFactoryTest, TestConfig, TestDFISimilarityFactory, PrimitiveFieldTypeTest, SolrCLIZkUtilsTest, DirectUpdateHandlerTest, ConfigureRecoveryStrategyTest, TestTestInjection, ZookeeperStatusHandlerTest, AuthToolTest, CloudMLTQParserTest, DateFieldTest, ConcurrentDeleteAndCreateCollectionTest, TestNestedDocsSort, TestSubQueryTransformerCrossCore, BasicDistributedZk2Test, ShufflingReplicaListTransformerTest, HdfsRestartWhileUpdatingTest, SearchRateTriggerIntegrationTest, BlobRepositoryCloudTest, PeerSyncWithLeaderAndIndexFingerprintCachingTest, TestHdfsUpdateLog, SolrPluginUtilsTest, FullSolrCloudDistribCmdsTest, TestWriterPerf, TestLegacyTerms, TestFieldResource, CSVRequestHandlerTest, DistributedIntervalFacetingTest, XmlUpdateRequestHandlerTest, TestFileDictionaryLookup, TestLFUCache, TestNonDefinedSimilarityFactory, TestPerFieldSimilarityWithDefaultOverride, TimeZoneUtilsTest, TestMinHashQParser, SortSpecParsingTest, SpellingQueryConverterTest, PeerSyncReplicationTest, TestDynamicFieldResource, AnalysisAfterCoreReloadTest, CursorPagingTest, DisMaxRequestHandlerTest, OutputWriterTest, SampleTest, SolrTestCaseJ4Test, TestDistributedGrouping, TestDistributedMissingSort, TestDistributedSearch, TestDocumentBuilder, TestHighlightDedupGrouping, TestRandomDVFaceting, TestRandomFaceting, TestSimpleTrackingShardHandler, TestSolrCoreProperties, TestTolerantSearch, TestTrie, PathHierarchyTokenizerFactoryTest, TestLuceneMatchVersion, TokenizerChainTest, TestLuceneIndexBackCompat, TestJettySolrRunner, ConnectionReuseTest, ActionThrottleTest, AssignBackwardCompatibilityTest, BasicDistributedZkTest, BasicZkTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, ChaosMonkeySafeLeaderTest, CloudExitableDirectoryReaderTest, ClusterStateTest, CollectionStateFormat2Test, CollectionsAPISolrJTest, ForceLeaderTest, ForceLeaderWithTlogReplicasTest, HttpPartitionOnCommitTest, HttpPartitionWithTlogReplicasTest, LeaderFailureAfterFreshStartTest, MultiSolrCloudTestCaseTest, OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, OverseerRolesTest, OverseerTaskQueueTest, ReindexCollectionTest, TestCloudSearcherWarming, TestPullReplicaErrorHandling, TestSkipOverseerOperations, TestStressLiveNodes, TestTlogReplica, TestTolerantUpdateProcessorRandomCloud, ZkNodePropsTest, ZkShardTermsTest, ZkSolrClientTest, CollectionReloadTest, TestCollectionAPI, TestCollectionsAPIViaSolrCloudCluster, TestHdfsCloudBackupRestore, TestLocalFSCloudBackupRestore, TestReplicaProperties, AutoAddReplicasIntegrationTest, HdfsAutoAddReplicasIntegrationTest, MetricTriggerIntegrationTest, NodeAddedTriggerTest, RestoreTriggerStateTest, ScheduledTriggerIntegrationTest, ScheduledTriggerTest, SystemLogListenerTest, TestSimClusterStateProvider, TestSimDistribStateManager, TestSimNodeAddedTrigger, TestSimNodeLostTrigger, TestSimPolicyCloud, TestSimTriggerIntegration, BaseCdcrDistributedZkTest, CdcrBidirectionalTest, CdcrRequestHandlerTest, CdcrWithNodesRestartsTest, HDFSCollectionsAPITest, HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsChaosMonkeySafeLeaderTest, HdfsNNFailoverTest, HdfsThreadLeakTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsUnloadDistributedZkTest, TestClusterStateMutator, ZkStateReaderTest, ZkStateWriterTest, RulesTest, TestCodecSupport, TestConfigSetProperties, TestCustomStream, TestDynamicURP, TestInfoStreamLogging, TestInitParams, TestJmxIntegration, TestLazyCores, TestQuerySenderListener, TestShardHandlerFactory, TestSolrConfigHandler, BinaryUpdateRequestHandlerTest, DocumentAnalysisRequestHandlerTest, FieldAnalysisRequestHandlerTest, JsonLoaderTest, PingRequestHandlerTest, SearchHandlerTest, TestCSVLoader, TestReplicationHandler, TestSystemCollAutoCreate, InfoHandlerTest, MBeansHandlerTest, DistributedDebugComponentTest, DistributedExpandComponentTest, DistributedFacetPivotSmallAdvancedTest, DistributedFacetPivotWhiteBoxTest, DistributedQueryComponentOptimizationTest, DistributedSpellCheckComponentTest, SuggestComponentTest, TestDistributedStatsComponentCardinality, TestHttpShardHandlerFactory, TestPivotHelperCode, TestTrackingShardHandlerFactory, TestUnifiedSolrHighlighter, WrapperMergePolicyFactoryTest, TestLegacyFieldReuse, TestMultiValuedNumericRangeQuery, TestNumericTokenStream, JvmMetricsTest, SolrJmxReporterTest, TestIntervalFaceting, TestChildDocTransformerHierarchy, TestRestManager, TestCopyFieldCollectionResource, TestDynamicFieldCollectionResource, TestFieldCollectionResource, TestFieldTypeCollectionResource, TestSchemaSimilarityResource, TestSerializedLuceneMatchVersion, TestManagedStopFilterFactory, BooleanFieldTest, ChangedSchemaMergeTest, CurrencyFieldTypeTest, DocValuesMultiTest, ExternalFileFieldSortTest, IndexSchemaTest, ManagedSchemaRoundRobinCloudTest, NumericFieldsTest, PreAnalyzedFieldManagedSchemaCloudTest, SynonymTokenizerTest, TestCollationField, TestCollationFieldDocValues, TestHalfAndHalfDocValues, TestPointFields, QueryEqualityTest, TestCollapseQParserPlugin, TestDocSet, TestElisionMultitermQuery, TestFiltering, TestInitQParser, TestLRUCache, TestMultiWordSynonyms, TestPayloadCheckQParserPlugin, TestRTGBase, TestReRankQParserPlugin, TestRealTimeGet, TestRecoveryHdfs, TestReloadDeadlock, TestSimpleQParserPlugin, TestSmileRequest, TestSolrFieldCacheBean, TestSolrQueryParser, TestStandardQParsers, TestStressLucene, TestStressVersions, TestValueSourceCache, TestJsonFacetsStatsParsing, TestJsonFacetsWithNestedObjects, SortByFunctionTest, TestFunctionQuery, DistanceFunctionTest, BlockJoinFacetDistribTest, BlockJoinFacetRandomTest, BlockJoinFacetSimpleTest, GraphQueryTest, TestScoreJoinQPScore, TestJsonRequest, SimpleMLTQParserTest, TestBM25SimilarityFactory, TestClassicSimilarityFactory, TestIBSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestPerFieldSimilarity, TestExactSharedStatsCache, BasicAuthIntegrationTest, MultiDestinationAuditLoggerTest, SolrLogAuditLoggerPluginTest, TestAuthorizationFramework, ConjunctionSolrSpellCheckerTest, DirectSolrSpellCheckerTest, SpellCheckCollatorTest, TestAnalyzeInfixSuggestions, TestFuzzyAnalyzedSuggestions, BlockDirectoryTest, TestFieldCacheWithThreads, TestLegacyFieldCache, AnalysisErrorHandlingTest, DataDrivenBlockJoinTest, DocumentBuilderTest, PeerSyncWithLeaderTest]
[junit4] Completed [831/855 (2!)] on J1 in 141.76s, 1 test, 1 failure <<< FAILURES!
[...truncated 9053 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\build.xml:634: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\build.xml:128: Found 1 violations in source files (File uses Mockito but has no assumeWorkingMockito() call).
Total time: 108 minutes 54 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
[JENKINS] Lucene-Solr-8.x-Windows (64bit/jdk1.8.0_201) - Build #
238 - Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/238/
Java: 64bit/jdk1.8.0_201 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.core.ExitableDirectoryReaderTest.testCacheAssumptions
Error Message:
Should have fewer docs than 100
Stack Trace:
java.lang.AssertionError: Should have fewer docs than 100
at __randomizedtesting.SeedInfo.seed([E56131A8CF003EDF:921C8E8FA1F573FD]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.apache.solr.core.ExitableDirectoryReaderTest.testCacheAssumptions(ExitableDirectoryReaderTest.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 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)
FAILED: org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest.test
Error Message:
Error from server at http://127.0.0.1:65273/solr: no core retrieved for test
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException: Error from server at http://127.0.0.1:65273/solr: no core retrieved for test
at __randomizedtesting.SeedInfo.seed([E56131A8CF003EDF:6D350E7261FC5327]:0)
at org.apache.solr.client.solrj.impl.BaseHttpSolrClient$RemoteExecutionException.create(BaseHttpSolrClient.java:65)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:626)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1068)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:837)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:769)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1274)
at org.apache.solr.update.processor.RoutedAliasUpdateProcessorTest.createConfigSet(RoutedAliasUpdateProcessorTest.java:115)
at org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest.test(CategoryRoutedAliasUpdateProcessorTest.java:164)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 14959 lines...]
[junit4] Suite: org.apache.solr.core.ExitableDirectoryReaderTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.ExitableDirectoryReaderTest_E56131A8CF003EDF-001\init-core-data-001
[junit4] 2> 2779507 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2779634 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 2779653 ERROR (Finalizer) [ ] o.a.s.c.CoreContainer CoreContainer was not close prior to finalize(), indicates a bug -- POSSIBLE RESOURCE LEAK!!! instance=943214516
[junit4] 2> 2779653 ERROR (Finalizer) [ ] o.a.s.c.CoreContainer CoreContainer was not close prior to finalize(), indicates a bug -- POSSIBLE RESOURCE LEAK!!! instance=351033559
[junit4] 2> 2779653 ERROR (Finalizer) [ ] o.a.s.c.CoreContainer CoreContainer was not close prior to finalize(), indicates a bug -- POSSIBLE RESOURCE LEAK!!! instance=212727938
[junit4] 2> 2779653 ERROR (Finalizer) [ ] o.a.s.c.CoreContainer CoreContainer was not close prior to finalize(), indicates a bug -- POSSIBLE RESOURCE LEAK!!! instance=2059406417
[junit4] 2> 2779672 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=example
[junit4] 2> 2779816 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 2780294 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2780308 WARN (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7f881206[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2780319 WARN (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1f42e552[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2780483 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2780483 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2780520 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d6b760d
[junit4] 2> 2780527 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d6b760d
[junit4] 2> 2780527 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d6b760d
[junit4] 2> 2780529 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-8.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2780720 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 2780736 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 2780853 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 2780891 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 2780891 INFO (coreLoadExecutor-15650-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@3d6b760d
[junit4] 2> 2780891 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.ExitableDirectoryReaderTest_E56131A8CF003EDF-001\init-core-data-001\]
[junit4] 2> 2780896 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=9, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 2781089 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2781089 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2781092 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=28, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=65.89453125, floorSegmentMB=0.865234375, forceMergeDeletesPctAllowed=10.907728184415115, segmentsPerTier=8.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.19622999370760744, deletesPctAllowed=27.161332269164014
[junit4] 2> 2781092 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@48a1e5a7[collection1] main]
[junit4] 2> 2781098 WARN (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 2781098 INFO (coreLoadExecutor-15650-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2781098 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 2781109 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 2781111 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[10]} 0 0
[junit4] 2> 2781111 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[11]} 0 0
[junit4] 2> 2781119 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[12]} 0 7
[junit4] 2> 2781120 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[13]} 0 0
[junit4] 2> 2781120 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[14]} 0 0
[junit4] 2> 2781120 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[15]} 0 0
[junit4] 2> 2781121 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[16]} 0 0
[junit4] 2> 2781121 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[17]} 0 0
[junit4] 2> 2781121 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[18]} 0 0
[junit4] 2> 2781121 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[19]} 0 0
[junit4] 2> 2781122 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[20]} 0 0
[junit4] 2> 2781122 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[21]} 0 0
[junit4] 2> 2781122 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[22]} 0 0
[junit4] 2> 2781122 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[23]} 0 0
[junit4] 2> 2781123 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[24]} 0 0
[junit4] 2> 2781123 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[25]} 0 0
[junit4] 2> 2781123 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[26]} 0 0
[junit4] 2> 2781123 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[27]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[28]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[29]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[30]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[31]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[32]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[33]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[34]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[35]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[36]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[37]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[38]} 0 0
[junit4] 2> 2781124 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[39]} 0 0
[junit4] 2> 2781126 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[40]} 0 0
[junit4] 2> 2781126 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[41]} 0 0
[junit4] 2> 2781127 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[42]} 0 0
[junit4] 2> 2781127 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[43]} 0 0
[junit4] 2> 2781127 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[44]} 0 0
[junit4] 2> 2781127 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[45]} 0 0
[junit4] 2> 2781137 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[46]} 0 0
[junit4] 2> 2781137 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[47]} 0 0
[junit4] 2> 2781137 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[48]} 0 0
[junit4] 2> 2781137 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[49]} 0 0
[junit4] 2> 2781138 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[50]} 0 0
[junit4] 2> 2781138 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[51]} 0 0
[junit4] 2> 2781138 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[52]} 0 0
[junit4] 2> 2781139 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[53]} 0 0
[junit4] 2> 2781139 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[54]} 0 0
[junit4] 2> 2781139 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[55]} 0 0
[junit4] 2> 2781140 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[56]} 0 0
[junit4] 2> 2781140 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[57]} 0 0
[junit4] 2> 2781140 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[58]} 0 0
[junit4] 2> 2781140 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[59]} 0 0
[junit4] 2> 2781140 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[60]} 0 0
[junit4] 2> 2781140 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[61]} 0 0
[junit4] 2> 2781140 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[62]} 0 0
[junit4] 2> 2781140 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[63]} 0 0
[junit4] 2> 2781142 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[64]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[65]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[66]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[67]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[68]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[69]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[70]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[71]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[72]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[73]} 0 0
[junit4] 2> 2781144 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[74]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[75]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[76]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[77]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[78]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[79]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[80]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[81]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[82]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[83]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[84]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[85]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[86]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[87]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[88]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[89]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[90]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[91]} 0 0
[junit4] 2> 2781147 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[92]} 0 0
[junit4] 2> 2781150 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[93]} 0 0
[junit4] 2> 2781150 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[94]} 0 0
[junit4] 2> 2781150 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[95]} 0 0
[junit4] 2> 2781151 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[96]} 0 0
[junit4] 2> 2781151 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[97]} 0 0
[junit4] 2> 2781151 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[98]} 0 0
[junit4] 2> 2781152 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[99]} 0 4
[junit4] 2> 2781152 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2781152 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3ee49314 commitCommandVersion:0
[junit4] 2> 2781173 INFO (searcherExecutor-15651-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@48a1e5a7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2781194 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2064b2dc[collection1] main]
[junit4] 2> 2781197 INFO (searcherExecutor-15651-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2064b2dc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.2.0):c100:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.2.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=10.0, timestamp=1556897755405}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2781197 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2781197 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 40
[junit4] 2> 2781211 INFO (TEST-ExitableDirectoryReaderTest.testCacheAssumptions-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={sleep=2&q=*:*&indent=true&fq=name:d*&timeAllowed=1&wt=xml} hits=100 status=0 QTime=1
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ExitableDirectoryReaderTest -Dtests.method=testCacheAssumptions -Dtests.seed=E56131A8CF003EDF -Dtests.slow=true -Dtests.locale=es-DO -Dtests.timezone=Asia/Bahrain -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.03s J0 | ExitableDirectoryReaderTest.testCacheAssumptions <<<
[junit4] > Throwable #1: java.lang.AssertionError: Should have fewer docs than 100
[junit4] > at __randomizedtesting.SeedInfo.seed([E56131A8CF003EDF:921C8E8FA1F573FD]:0)
[junit4] > at org.apache.solr.core.ExitableDirectoryReaderTest.testCacheAssumptions(ExitableDirectoryReaderTest.java:104)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2781236 WARN (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.s.SolrIndexSearcher Query: [name:a*]; The request took too long to iterate over terms. Timeout: timeoutAt: 283096890873000 (System.nanoTime(): 283096892564300), TermsEnum=org.apache.lucene.codecs.blocktree.IntersectTermsEnum@12f30521
[junit4] 2> 2781236 INFO (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={sleep=2&q=name:a*&timeAllowed=1&wt=xml} hits=0 status=0 QTime=3
[junit4] 2> 2781237 INFO (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:a*&timeAllowed=10000&wt=xml} hits=100 status=0 QTime=0
[junit4] 2> 2781239 INFO (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={sleep=2&q=name:a*&timeAllowed=1&wt=xml} hits=100 status=0 QTime=2
[junit4] 2> 2781244 WARN (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.h.c.SearchHandler Query: sleep=2&q=*:*&fq=name:a*&timeAllowed=1&wt=xml; The request took too long to iterate over terms. Timeout: timeoutAt: 283096897010300 (System.nanoTime(): 283096901147500), TermsEnum=org.apache.lucene.codecs.blocktree.IntersectTermsEnum@465a7385
[junit4] 2> 2781244 INFO (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={sleep=2&q=*:*&fq=name:a*&timeAllowed=1&wt=xml} status=0 QTime=5
[junit4] 2> 2781246 INFO (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fq=name:a*&timeAllowed=10000&wt=xml} hits=100 status=0 QTime=0
[junit4] 2> 2781246 INFO (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:b*&timeAllowed=9223372036854775807&wt=xml} hits=100 status=0 QTime=0
[junit4] 2> 2781246 INFO (TEST-ExitableDirectoryReaderTest.testPrefixQuery-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:c*&timeAllowed=-7&wt=xml} hits=100 status=0 QTime=0
[junit4] 2> 2781308 WARN (TEST-ExitableDirectoryReaderTest.testQueryResults-seed#[E56131A8CF003EDF]) [ ] o.a.s.s.SolrIndexSearcher Query: [name:e*]; The request took too long to iterate over terms. Timeout: timeoutAt: 283096956488800 (System.nanoTime(): 283096964607600), TermsEnum=org.apache.lucene.codecs.blocktree.IntersectTermsEnum@570988bc
[junit4] 2> 2781308 INFO (TEST-ExitableDirectoryReaderTest.testQueryResults-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={sleep=2&q=name:e*&indent=true&timeAllowed=1&wt=xml} hits=0 status=0 QTime=9
[junit4] 2> 2781308 INFO (TEST-ExitableDirectoryReaderTest.testQueryResults-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:e*&indent=true&timeAllowed=10000&wt=xml} hits=100 status=0 QTime=0
[junit4] 2> 2781310 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1945835388
[junit4] 2> 2781310 INFO (coreCloseExecutor-15655-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@30d37da5
[junit4] 2> 2781310 INFO (coreCloseExecutor-15655-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=30d37da5
[junit4] 2> 2781310 INFO (coreCloseExecutor-15655-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5185d900: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@69cb6019
[junit4] 2> 2781321 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 2781321 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d9e9a63: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1d173462
[junit4] 2> 2781326 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 2781326 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@50a8a10f: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@67bdc22b
[junit4] 2> 2781328 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 2781328 INFO (SUITE-ExitableDirectoryReaderTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@16887cd9: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@6240da83
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.ExitableDirectoryReaderTest_E56131A8CF003EDF-001
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@426d564e), locale=es-DO, timezone=Asia/Bahrain
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_201 (64-bit)/cpus=3,threads=1,free=134135064,total=525860864
[junit4] 2> NOTE: All tests run in this JVM: [TestDeleteCollectionOnDownNodes, ConvertedLegacyTest, TestFieldCacheSortRandom, TestFieldCacheWithThreads, TestFoldingMultitermQuery, ResourceLoaderTest, RecoveryAfterSoftCommitTest, TestUnInvertedFieldException, SolrInfoBeanTest, TestSchemaManager, TestLegacyBM25SimilarityFactory, TestClusterStateMutator, TestCollectionAPI, TestGroupingSearch, TestSort, CreateRoutedAliasTest, LeaderVoteWaitTimeoutTest, TestJsonRequest, PreAnalyzedUpdateProcessorTest, RankQueryTest, TestPivotHelperCode, MetricsHistoryHandlerTest, OutputWriterTest, PreAnalyzedFieldTest, TestMultiValuedNumericRangeQuery, TestMacroExpander, SpatialFilterTest, CustomTermsComponentTest, ClassificationUpdateProcessorFactoryTest, SaslZkACLProviderTest, TestConfigSetsAPIZkFailure, ScheduledMaintenanceTriggerTest, TestRuleBasedAuthorizationPlugin, TestSuggestSpellingConverter, TestSolrCloudWithKerberosAlt, TestInfoStreamLogging, TestFieldCacheReopen, DocumentAnalysisRequestHandlerTest, TestStressLucene, ManagedSchemaRoundRobinCloudTest, TermVectorComponentDistributedTest, TestConfigOverlay, DistribDocExpirationUpdateProcessorTest, FastVectorHighlighterTest, TestComplexPhraseQParserPlugin, VersionInfoTest, TestDFRSimilarityFactory, HLLUtilTest, TestOrdValues, DateRangeFieldTest, TestFieldCollectionResource, TestSolrIndexConfig, ScheduledTriggerTest, SignificantTermsQParserPluginTest, DaemonStreamApiTest, DistributedMLTComponentTest, TestMergePolicyConfig, DistributedFacetPivotLongTailTest, XsltUpdateRequestHandlerTest, TestSolrConfigHandlerCloud, TestLRUCache, TestFieldTypeCollectionResource, ReindexCollectionTest, OverseerTest, TestChildDocTransformer, TestInPlaceUpdatesRequiredField, TestCrossCoreJoin, TestInitQParser, PluginInfoTest, CustomCollectionTest, TestDistributedSearch, TestCloudInspectUtil, SolrMetricManagerTest, CacheHeaderTest, TestXIncludeConfig, JSONWriterTest, BasicDistributedZkTest, EchoParamsTest, TestFastLRUCache, FullHLLTest, TestReload, TestLegacyField, TestTrieFacet, ChaosMonkeyNothingIsSafeTest, TestPerFieldSimilarity, RAMDirectoryFactoryTest, RuleEngineTest, DateMathParserTest, InfixSuggestersTest, TestSchemaNameResource, ResponseLogComponentTest, SolrSlf4jReporterTest, TestExpandComponent, DocExpirationUpdateProcessorFactoryTest, TestExclusionRuleCollectionAccess, DistributedDebugComponentTest, TestSQLHandler, DistributedTermsComponentTest, ZkControllerTest, TestExactSharedStatsCache, AutoAddReplicasIntegrationTest, SpellCheckCollatorTest, UUIDUpdateProcessorFallbackTest, TestSimTriggerIntegration, TestRandomFlRTGCloud, HdfsChaosMonkeyNothingIsSafeTest, HttpSolrCallGetCoreTest, TestDistributedMap, TestFreeTextSuggestions, BadIndexSchemaTest, CdcrRequestHandlerTest, AutoScalingHandlerTest, TestGraphMLResponseWriter, TestStressLiveNodes, DeleteReplicaTest, MetricsHistoryIntegrationTest, TestStressVersions, CurrencyFieldTypeTest, BlockCacheTest, TestDynamicURP, TestOmitPositions, HdfsNNFailoverTest, CdcrWithNodesRestartsTest, TestReRankQParserPlugin, TolerantUpdateProcessorTest, SoftAutoCommitTest, SystemCollectionCompatTest, TestElisionMultitermQuery, NestedAtomicUpdateTest, TestSkipOverseerOperations, TestSolr4Spatial, TestCloudConsistency, QueryEqualityTest, DocumentBuilderTest, TestPHPSerializedResponseWriter, MBeansHandlerTest, SpellCheckComponentTest, TestRandomCollapseQParserPlugin, DeleteLastCustomShardedReplicaTest, NodeLostTriggerIntegrationTest, ExecutePlanActionTest, CachingDirectoryFactoryTest, SplitShardTest, LeaderFailureAfterFreshStartTest, MetricsConfigTest, TestDistributedGrouping, TestConfigReload, TestFunctionQuery, SolrIndexSplitterTest, SearchRateTriggerTest, CoreAdminHandlerTest, MoveReplicaTest, EmbeddedSolrNoSerializeTest, TestEmbeddedSolrServerAdminHandler, TestBlendedInfixSuggestions, TestSolrJ, HdfsSyncSliceTest, TestBlobHandler, CollectionStateFormat2Test, TestManagedSynonymGraphFilterFactory, UpdateLogTest, TestTolerantUpdateProcessorCloud, TestCloudNestedDocsSort, TestTrie, ClusterStateUpdateTest, HdfsTlogReplayBufferedWhileIndexingTest, DocValuesNotIndexedTest, ClassificationUpdateProcessorTest, TestEmbeddedSolrServerSchemaAPI, TestSlowCompositeReaderWrapper, TestCodecSupport, TestSystemCollAutoCreate, UpdateRequestProcessorFactoryTest, BlockJoinFacetDistribTest, TestSimExtremeIndexing, CurrencyRangeFacetCloudTest, SolrCoreCheckLockOnStartupTest, TestPayloadCheckQParserPlugin, TestSSLRandomization, TestHdfsBackupRestoreCore, TestRetrieveFieldsOptimizer, V2StandaloneTest, BlockJoinFacetSimpleTest, AnalysisAfterCoreReloadTest, PeerSyncTest, HdfsLockFactoryTest, TestSubQueryTransformer, DistributedQueueTest, MultiThreadedOCPTest, TestNumericTerms32, TestReqParamsAPI, DeleteStatusTest, SignatureUpdateProcessorFactoryTest, AuditLoggerPluginTest, RequiredFieldsTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, ProtectedTermFilterFactoryTest, TestSolrCloudSnapshots, ShardRoutingTest, DisMaxRequestHandlerTest, LoggingHandlerTest, HttpPartitionTest, TestReplicaProperties, FileUtilsTest, UtilsToolTest, SuggesterTest, TestSimComputePlanAction, TestCustomSort, TestUninvertingReader, TestDocTermOrdsUninvertLimit, TestRemoteStreaming, TestSolrCloudWithHadoopAuthPlugin, TestInPlaceUpdateWithRouteField, TestJoin, TestRandomDVFaceting, TestSolrCoreProperties, TestCharFilters, TestDeprecatedFilters, TestReversedWildcardFilterFactory, ConnectionReuseTest, AliasIntegrationTest, ChaosMonkeySafeLeaderTest, ChaosMonkeySafeLeaderWithPullReplicasTest, CollectionsAPISolrJTest, LeaderElectionContextKeyTest, LeaderElectionTest, LeaderTragicEventTest, MigrateRouteKeyTest, RecoveryZkTest, ReplaceNodeNoTargetTest, ReplaceNodeTest, RollingRestartTest, SliceStateTest, SolrCloudExampleTest, SolrXmlInZkTest, TestAuthenticationFramework, TestCloudPivotFacet, TestCloudRecovery, TestCloudSearcherWarming, TestCryptoKeys, TestLockTree, TestOnReconnectListenerSupport, TestRebalanceLeaders, TestSizeLimitedDistributedMap, TestStressCloudBlindAtomicUpdates, TestTlogReplica, TestTolerantUpdateProcessorRandomCloud, TestUtilizeNode, TestZkChroot, ZkFailoverTest, AssignTest, AsyncCallRequestStatusResponseTest, CollectionTooManyReplicasTest, CollectionsAPIDistributedZkTest, TestCollectionsAPIViaSolrCloudCluster, TestHdfsCloudBackupRestore, HdfsAutoAddReplicasIntegrationTest, HttpTriggerListenerTest, IndexSizeTriggerTest, MetricTriggerIntegrationTest, NodeAddedTriggerIntegrationTest, NodeLostTriggerTest, NodeMarkersRegistrationTest, RestoreTriggerStateTest, SystemLogListenerTest, TestPolicyCloud, TriggerEventQueueTest, TriggerIntegrationTest, TestSimNodeLostTrigger, BaseCdcrDistributedZkTest, CdcrBidirectionalTest, CdcrBootstrapTest, CdcrOpsAndBoundariesTest, CdcrVersionReplicationTest, ZkStateWriterTest, AlternateDirectoryTest, CoreSorterTest, DirectoryFactoryTest, ExitableDirectoryReaderTest]
[junit4] Completed [561/855 (1!)] on J0 in 2.07s, 3 tests, 1 failure <<< FAILURES!
[...truncated 907 lines...]
[junit4] Suite: org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_E56131A8CF003EDF-001\init-core-data-001
[junit4] 2> 3546557 WARN (SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
[junit4] 2> 3546558 INFO (SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 3546562 INFO (SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 3546562 INFO (SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[E56131A8CF003EDF]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 3546565 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNonEnglish
[junit4] 2> 3546567 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_E56131A8CF003EDF-001\tempDir-001
[junit4] 2> 3546567 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 3546568 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3546568 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 3546669 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.ZkTestServer start zk server on port:64930
[junit4] 2> 3546669 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:64930
[junit4] 2> 3546669 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 64930
[junit4] 2> 3546677 INFO (zkConnectionManagerCallback-19700-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546682 INFO (zkConnectionManagerCallback-19702-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546686 INFO (zkConnectionManagerCallback-19704-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546687 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10010eb64e70002, likely client has closed socket
[junit4] 2> 3546689 WARN (jetty-launcher-19705-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 3546689 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 3546689 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 3546689 INFO (jetty-launcher-19705-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09
[junit4] 2> 3546690 INFO (jetty-launcher-19705-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3546690 INFO (jetty-launcher-19705-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3546690 INFO (jetty-launcher-19705-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 3546690 INFO (jetty-launcher-19705-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@18078f33{/solr,null,AVAILABLE}
[junit4] 2> 3546691 WARN (jetty-launcher-19705-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 3546691 WARN (jetty-launcher-19705-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09
[junit4] 2> 3546691 INFO (jetty-launcher-19705-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@952cdb2{/solr,null,AVAILABLE}
[junit4] 2> 3546692 INFO (jetty-launcher-19705-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3546692 INFO (jetty-launcher-19705-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3546692 INFO (jetty-launcher-19705-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 3546692 INFO (jetty-launcher-19705-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4e285afd{/solr,null,AVAILABLE}
[junit4] 2> 3546694 WARN (jetty-launcher-19705-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-4) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@26cd4220{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:64941}
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-2) [ ] o.e.j.s.Server Started @3546734ms
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=64941}
[junit4] 2> 3546694 ERROR (jetty-launcher-19705-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.2.0
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-03T15:48:40.942Z
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 3546694 INFO (jetty-launcher-19705-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4505d142{/solr,null,AVAILABLE}
[junit4] 2> 3546696 INFO (jetty-launcher-19705-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3ea10923{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:64944}
[junit4] 2> 3546696 INFO (jetty-launcher-19705-thread-1) [ ] o.e.j.s.Server Started @3546736ms
[junit4] 2> 3546696 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=64944}
[junit4] 2> 3546696 ERROR (jetty-launcher-19705-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3546696 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3546696 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.2.0
[junit4] 2> 3546696 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3546696 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3546696 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-03T15:48:40.944Z
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2825ed5d{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:64950}
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-4) [ ] o.e.j.s.Server Started @3546738ms
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=64950}
[junit4] 2> 3546698 ERROR (jetty-launcher-19705-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.2.0
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-03T15:48:40.946Z
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1e6fa003{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:64947}
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-3) [ ] o.e.j.s.Server Started @3546738ms
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=64947}
[junit4] 2> 3546698 ERROR (jetty-launcher-19705-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.2.0
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3546698 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-03T15:48:40.946Z
[junit4] 2> 3546704 INFO (zkConnectionManagerCallback-19707-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546704 INFO (zkConnectionManagerCallback-19709-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546705 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3546705 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3546706 INFO (zkConnectionManagerCallback-19713-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546710 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3546712 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10010eb64e70003, likely client has closed socket
[junit4] 2> 3546798 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 3546799 INFO (zkConnectionManagerCallback-19711-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546800 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3546832 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 3546850 WARN (jetty-launcher-19705-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@43f15cc0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3546854 WARN (jetty-launcher-19705-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@26438fd7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3546859 WARN (jetty-launcher-19705-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@22850eb6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3546860 INFO (jetty-launcher-19705-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64930/solr
[junit4] 2> 3546861 WARN (jetty-launcher-19705-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6f262e22[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3546862 INFO (jetty-launcher-19705-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64930/solr
[junit4] 2> 3546864 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 3546864 INFO (zkConnectionManagerCallback-19726-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546869 INFO (zkConnectionManagerCallback-19729-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546870 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10010eb64e70008, likely client has closed socket
[junit4] 2> 3546872 WARN (jetty-launcher-19705-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4cb81205[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3546877 WARN (jetty-launcher-19705-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2734bcfa[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3546878 INFO (jetty-launcher-19705-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64930/solr
[junit4] 2> 3546882 INFO (zkConnectionManagerCallback-19732-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546882 INFO (zkConnectionManagerCallback-19734-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546884 INFO (zkConnectionManagerCallback-19739-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546891 INFO (zkConnectionManagerCallback-19745-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546906 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:64950_solr
[junit4] 2> 3546907 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.c.Overseer Overseer (id=72076197234147340-127.0.0.1:64950_solr-n_0000000000) starting
[junit4] 2> 3546937 INFO (zkConnectionManagerCallback-19752-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3546940 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64930/solr ready
[junit4] 2> 3546940 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64950_solr
[junit4] 2> 3546942 INFO (OverseerStateUpdate-72076197234147340-127.0.0.1:64950_solr-n_0000000000) [n:127.0.0.1:64950_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:64950_solr
[junit4] 2> 3546947 INFO (zkCallback-19751-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 3546950 INFO (OverseerStateUpdate-72076197234147340-127.0.0.1:64950_solr-n_0000000000) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 3546972 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 3546982 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:64947_solr as DOWN
[junit4] 2> 3546983 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 3546983 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64947_solr
[junit4] 2> 3546985 INFO (zkCallback-19744-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 3546985 INFO (zkCallback-19751-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 3547030 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 3547033 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:64941_solr as DOWN
[junit4] 2> 3547033 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 3547033 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64941_solr
[junit4] 2> 3547034 INFO (zkCallback-19744-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 3547034 INFO (zkCallback-19751-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 3547057 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3547072 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 3547073 INFO (zkCallback-19733-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 3547077 INFO (zkCallback-19731-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 3547078 WARN (jetty-launcher-19705-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@39adf77[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3547087 WARN (jetty-launcher-19705-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@67876108[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3547087 INFO (jetty-launcher-19705-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64930/solr
[junit4] 2> 3547087 INFO (zkConnectionManagerCallback-19757-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3547087 INFO (zkConnectionManagerCallback-19762-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3547091 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 3547092 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 3547092 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64930/solr ready
[junit4] 2> 3547092 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3547100 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64930/solr ready
[junit4] 2> 3547100 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3547120 INFO (zkConnectionManagerCallback-19769-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3547132 INFO (zkConnectionManagerCallback-19773-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3547136 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 3547143 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64941.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547143 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64947.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547150 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64941.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547150 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64941.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547151 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64947.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547151 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64947.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547152 INFO (jetty-launcher-19705-thread-2) [n:127.0.0.1:64941_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_E56131A8CF003EDF-001\tempDir-001\node2\.
[junit4] 2> 3547153 INFO (jetty-launcher-19705-thread-3) [n:127.0.0.1:64947_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_E56131A8CF003EDF-001\tempDir-001\node3\.
[junit4] 2> 3547157 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:64944_solr as DOWN
[junit4] 2> 3547158 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 3547158 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64944_solr
[junit4] 2> 3547160 INFO (zkCallback-19744-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 3547160 INFO (zkCallback-19751-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 3547160 INFO (zkCallback-19731-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 3547160 INFO (zkCallback-19733-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 3547202 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64950.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547207 INFO (zkCallback-19761-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 3547208 INFO (zkCallback-19756-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 3547208 INFO (zkCallback-19772-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 3547222 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64950.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547223 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64950.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547225 INFO (jetty-launcher-19705-thread-4) [n:127.0.0.1:64950_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_E56131A8CF003EDF-001\tempDir-001\node4\.
[junit4] 2> 3547253 INFO (zkConnectionManagerCallback-19780-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3547254 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 3547254 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64930/solr ready
[junit4] 2> 3547254 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3547283 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64944.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547290 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64944.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547290 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64944.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@16aee29a
[junit4] 2> 3547292 INFO (jetty-launcher-19705-thread-1) [n:127.0.0.1:64944_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_E56131A8CF003EDF-001\tempDir-001\node1\.
[junit4] 2> 3547340 INFO (zkConnectionManagerCallback-19786-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3547341 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 3547342 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64930/solr ready
[junit4] 2> 3547342 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.u.p.CategoryRoutedAliasUpdateProcessorTest SolrClient: org.apache.solr.client.solrj.impl.CloudSolrClient@2a74ee5c
[junit4] 2> 3547342 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.u.p.CategoryRoutedAliasUpdateProcessorTest ClusterStateProvider 127.0.0.1:64930/solr
[junit4] 2> 3547348 INFO (zkConnectionManagerCallback-19791-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3547349 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 3547350 INFO (TEST-CategoryRoutedAliasUpdateProcessorTest.testNonEnglish-seed#[E56131A8CF003EDF]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64930/solr ready
[junit4] 2> 3547352 INFO (qtp183207285-56465) [n:127.0.0.1:64950_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=_default&name=testNonEnglish&action=CREATE&wt=javabin&version=2
[junit4] 2> 3547354 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"testNonEnglish",
[junit4] 2> "baseConfigSet":"_default",
[junit4] 2> "immutable":"false",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 3547354 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/testNonEnglish/managed-schema
[junit4] 2> 3547357 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/testNonEnglish/protwords.txt
[junit4] 2> 3547359 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/testNonEnglish/solrconfig.xml
[junit4] 2> 3547361 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/testNonEnglish/synonyms.txt
[junit4] 2> 3547362 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/testNonEnglish/stopwords.txt
[junit4] 2> 3547363 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/testNonEnglish/lang/contractions_it.txt
[junit4] 2> 3547363 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/testNonEnglish/lang/contractions_ca.txt
[junit4] 2> 3547366 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/testNonEnglish/lang/stemdict_nl.txt
[junit4] 2> 3547368 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/testNonEnglish/lang/stopwords_hy.txt
[junit4] 2> 3547369 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/testNonEnglish/lang/stopwords_no.txt
[junit4] 2> 3547370 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/testNonEnglish/lang/stopwords_id.txt
[junit4] 2> 3547371 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/testNonEnglish/lang/stopwords_da.txt
[junit4] 2> 3547372 INFO (OverseerThreadFactory-19061-thread-1-processing-n:127.0.0.1:64950_solr) [n:127.0.0.1:64950_solr ]
[...truncated too long message...]
[junit4] OK 18.2s J0 | CategoryRoutedAliasUpdateProcessorTest.testNonEnglish
[junit4] OK 19.1s J0 | CategoryRoutedAliasUpdateProcessorTest.testSliceRouting
[junit4] OK 22.6s J0 | CategoryRoutedAliasUpdateProcessorTest.test
[junit4] OK 7.31s J0 | CategoryRoutedAliasUpdateProcessorTest.testInvalidMustMatch
[junit4] OK 13.7s J0 | CategoryRoutedAliasUpdateProcessorTest.testMustMatch
[junit4] OK 12.2s J0 | CategoryRoutedAliasUpdateProcessorTest.testMaxCardinality
[junit4] Completed [5/10] on J0 in 93.44s, 6 tests
[junit4]
[junit4] Suite: org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest
[junit4] OK 18.0s J1 | CategoryRoutedAliasUpdateProcessorTest.testNonEnglish
[junit4] OK 18.4s J1 | CategoryRoutedAliasUpdateProcessorTest.testSliceRouting
[junit4] OK 23.0s J1 | CategoryRoutedAliasUpdateProcessorTest.test
[junit4] OK 7.22s J1 | CategoryRoutedAliasUpdateProcessorTest.testInvalidMustMatch
[junit4] OK 13.8s J1 | CategoryRoutedAliasUpdateProcessorTest.testMustMatch
[junit4] OK 12.5s J1 | CategoryRoutedAliasUpdateProcessorTest.testMaxCardinality
[junit4] Completed [6/10] on J1 in 93.20s, 6 tests
[junit4]
[junit4] Suite: org.apache.solr.core.ExitableDirectoryReaderTest
[junit4] OK 0.01s J1 | ExitableDirectoryReaderTest.testCacheAssumptions
[junit4] OK 0.02s J1 | ExitableDirectoryReaderTest.testPrefixQuery
[junit4] OK 0.01s J1 | ExitableDirectoryReaderTest.testQueryResults
[junit4] Completed [7/10] on J1 in 1.56s, 3 tests
[junit4]
[junit4] Suite: org.apache.solr.core.ExitableDirectoryReaderTest
[junit4] OK 0.01s J1 | ExitableDirectoryReaderTest.testCacheAssumptions
[junit4] OK 0.03s J1 | ExitableDirectoryReaderTest.testPrefixQuery
[junit4] OK 0.01s J1 | ExitableDirectoryReaderTest.testQueryResults
[junit4] Completed [8/10] on J1 in 1.29s, 3 tests
[junit4]
[junit4] Suite: org.apache.solr.core.ExitableDirectoryReaderTest
[junit4] OK 0.01s J1 | ExitableDirectoryReaderTest.testCacheAssumptions
[junit4] OK 0.02s J1 | ExitableDirectoryReaderTest.testPrefixQuery
[junit4] OK 0.01s J1 | ExitableDirectoryReaderTest.testQueryResults
[junit4] Completed [9/10] on J1 in 0.76s, 3 tests
[junit4]
[junit4] Suite: org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest
[junit4] OK 18.2s J0 | CategoryRoutedAliasUpdateProcessorTest.testNonEnglish
[junit4] OK 14.3s J0 | CategoryRoutedAliasUpdateProcessorTest.testSliceRouting
[junit4] OK 17.6s J0 | CategoryRoutedAliasUpdateProcessorTest.test
[junit4] OK 5.46s J0 | CategoryRoutedAliasUpdateProcessorTest.testInvalidMustMatch
[junit4] OK 11.9s J0 | CategoryRoutedAliasUpdateProcessorTest.testMustMatch
[junit4] OK 11.8s J0 | CategoryRoutedAliasUpdateProcessorTest.testMaxCardinality
[junit4] Completed [10/10] on J0 in 79.63s, 6 tests
[junit4]
[junit4] JVM J0: 0.91 .. 299.90 = 298.99s
[junit4] JVM J1: 0.92 .. 224.77 = 223.86s
[junit4] Execution time total: 4 minutes 59 seconds
[junit4] Tests summary: 10 suites, 45 tests
[junit4] Could not remove temporary path: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp])
[junit4] Could not remove temporary path: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J0\temp])
[echo] 5 slowest tests:
[junit4:tophints] 285.61s | org.apache.solr.cloud.api.collections.ShardSplitTest
[junit4:tophints] 123.39s | org.apache.solr.search.facet.TestJsonFacets
[junit4:tophints] 111.70s | org.apache.solr.cloud.ReplicationFactorTest
[junit4:tophints] 102.24s | org.apache.solr.cloud.CollectionsAPISolrJTest
[junit4:tophints] 100.32s | org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest
-check-totals:
test-nocompile:
BUILD SUCCESSFUL
Total time: 5 minutes 2 seconds
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.core.ExitableDirectoryReaderTest
[repro] 0/5 failed: org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest
[repro] Exiting with code 0
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST lucene\build move /y lucene\build lucene\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST solr\build move /y solr\build solr\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST lucene\build.orig move /y lucene\build.orig lucene\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST solr\build.orig move /y solr\build.orig solr\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>exit 0
Archiving artifacts
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2802)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2681)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2662)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3040)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to Windows VBOX
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1743)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:957)
at hudson.FilePath.act(FilePath.java:1069)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2660)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
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:1843)
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:3042)
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(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1071)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2660)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
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:1843)
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/**,**/*_pid*.log". Configuration error?
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
No credentials specified
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=c05501e5b279fad13f81279c341389ab7bebbff5, workspace=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows
[WARNINGS] Computing warning deltas based on reference build #233
Recording test results
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2