Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/358/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
4 tests failed.
FAILED: org.apache.solr.cloud.RecoveryZkTest.test
Error Message:
Stack Trace:
java.util.concurrent.TimeoutException
at
__randomizedtesting.SeedInfo.seed([15BD1115E22ED0EC:9DE92ECF4CD2BD14]:0)
at
org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1261)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.waitForState(CloudSolrClient.java:449)
at org.apache.solr.cloud.RecoveryZkTest.test(RecoveryZkTest.java:122)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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.cloud.autoscaling.sim.TestTriggerIntegration.testEventQueue
Error Message:
action wasn't interrupted
Stack Trace:
java.lang.AssertionError: action wasn't interrupted
at
__randomizedtesting.SeedInfo.seed([15BD1115E22ED0EC:DC0853BBEB491619]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testEventQueue(TestTriggerIntegration.java:638)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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.handler.TestSolrConfigHandlerCloud.test
Error Message:
Could not get expected value 'CY val modified' for path 'response/params/y/c'
full output: { "responseHeader":{ "status":0, "QTime":0},
"response":{ "znodeVersion":0, "params":{"x":{ "a":"A val",
"b":"B val", "":{"v":0}}}}}, from server:
http://127.0.0.1:45038/collection1_shard1_replica_n47
Stack Trace:
java.lang.AssertionError: Could not get expected value 'CY val modified' for
path 'response/params/y/c' full output: {
"responseHeader":{
"status":0,
"QTime":0},
"response":{
"znodeVersion":0,
"params":{"x":{
"a":"A val",
"b":"B val",
"":{"v":0}}}}}, from server:
http://127.0.0.1:45038/collection1_shard1_replica_n47
at
__randomizedtesting.SeedInfo.seed([15BD1115E22ED0EC:9DE92ECF4CD2BD14]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:557)
at
org.apache.solr.handler.TestSolrConfigHandlerCloud.testReqParams(TestSolrConfigHandlerCloud.java:222)
at
org.apache.solr.handler.TestSolrConfigHandlerCloud.test(TestSolrConfigHandlerCloud.java:50)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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.client.solrj.io.stream.StreamExpressionTest.testDistributions
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([41CB951D2F9039BA:FE34D4B7F16AD926]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testDistributions(StreamExpressionTest.java:6551)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 12349 lines...]
[junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4] 2> 1302292 INFO
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.RecoveryZkTest_15BD1115E22ED0EC-001/init-core-data-001
[junit4] 2> 1302292 WARN
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=18 numCloses=18
[junit4] 2> 1302293 INFO
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1302294 INFO
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1302295 INFO
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.RecoveryZkTest_15BD1115E22ED0EC-001/tempDir-001
[junit4] 2> 1302295 INFO
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1302295 INFO (Thread-3148) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1302295 INFO (Thread-3148) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1302297 ERROR (Thread-3148) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 1302395 INFO
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:64378
[junit4] 2> 1302399 INFO (zkConnectionManagerCallback-2234-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302405 INFO (jetty-launcher-2231-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1302407 INFO (jetty-launcher-2231-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@21b21f1f{/solr,null,AVAILABLE}
[junit4] 2> 1302407 INFO (jetty-launcher-2231-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2960b27f{SSL,[ssl,
http/1.1]}{127.0.0.1:48912}
[junit4] 2> 1302407 INFO (jetty-launcher-2231-thread-2) [ ]
o.e.j.s.Server Started @1305295ms
[junit4] 2> 1302407 INFO (jetty-launcher-2231-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=48912}
[junit4] 2> 1302407 ERROR (jetty-launcher-2231-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1302407 INFO (jetty-launcher-2231-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.0
[junit4] 2> 1302408 INFO (jetty-launcher-2231-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1302408 INFO (jetty-launcher-2231-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1302408 INFO (jetty-launcher-2231-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-12-28T16:27:45.653Z
[junit4] 2> 1302409 INFO (jetty-launcher-2231-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1302409 INFO (jetty-launcher-2231-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2e60310a{/solr,null,AVAILABLE}
[junit4] 2> 1302410 INFO (jetty-launcher-2231-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@35cc301a{SSL,[ssl,
http/1.1]}{127.0.0.1:62038}
[junit4] 2> 1302410 INFO (jetty-launcher-2231-thread-1) [ ]
o.e.j.s.Server Started @1305298ms
[junit4] 2> 1302410 INFO (jetty-launcher-2231-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=62038}
[junit4] 2> 1302410 ERROR (jetty-launcher-2231-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1302410 INFO (jetty-launcher-2231-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.0
[junit4] 2> 1302410 INFO (jetty-launcher-2231-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1302410 INFO (jetty-launcher-2231-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1302410 INFO (jetty-launcher-2231-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-12-28T16:27:45.655Z
[junit4] 2> 1302419 INFO (zkConnectionManagerCallback-2238-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302419 INFO (zkConnectionManagerCallback-2236-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302419 INFO (jetty-launcher-2231-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1302419 INFO (jetty-launcher-2231-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1302430 INFO (jetty-launcher-2231-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64378/solr
[junit4] 2> 1302430 INFO (jetty-launcher-2231-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64378/solr
[junit4] 2> 1302432 INFO (zkConnectionManagerCallback-2244-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302432 INFO (zkConnectionManagerCallback-2246-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302435 INFO
(zkConnectionManagerCallback-2248-thread-1-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302435 INFO
(zkConnectionManagerCallback-2250-thread-1-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302548 INFO (jetty-launcher-2231-thread-1)
[n:127.0.0.1:62038_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1302548 INFO (jetty-launcher-2231-thread-2)
[n:127.0.0.1:48912_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1302549 INFO (jetty-launcher-2231-thread-1)
[n:127.0.0.1:62038_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:62038_solr
[junit4] 2> 1302550 INFO (jetty-launcher-2231-thread-2)
[n:127.0.0.1:48912_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:48912_solr
[junit4] 2> 1302550 INFO (jetty-launcher-2231-thread-1)
[n:127.0.0.1:62038_solr ] o.a.s.c.Overseer Overseer
(id=99252860717694982-127.0.0.1:62038_solr-n_0000000000) starting
[junit4] 2> 1302551 INFO
(zkCallback-2249-thread-1-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1302561 INFO
(zkCallback-2247-thread-1-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1302571 INFO (jetty-launcher-2231-thread-1)
[n:127.0.0.1:62038_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:62038_solr
[junit4] 2> 1302573 INFO
(zkCallback-2249-thread-1-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1302573 INFO
(zkCallback-2247-thread-1-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1302641 INFO (jetty-launcher-2231-thread-2)
[n:127.0.0.1:48912_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_48912.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ac752ce
[junit4] 2> 1302647 INFO (jetty-launcher-2231-thread-2)
[n:127.0.0.1:48912_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_48912.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ac752ce
[junit4] 2> 1302647 INFO (jetty-launcher-2231-thread-2)
[n:127.0.0.1:48912_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_48912.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ac752ce
[junit4] 2> 1302648 INFO (jetty-launcher-2231-thread-2)
[n:127.0.0.1:48912_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.RecoveryZkTest_15BD1115E22ED0EC-001/tempDir-001/node2/.
[junit4] 2> 1302675 INFO (jetty-launcher-2231-thread-1)
[n:127.0.0.1:62038_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62038.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ac752ce
[junit4] 2> 1302680 INFO (jetty-launcher-2231-thread-1)
[n:127.0.0.1:62038_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62038.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ac752ce
[junit4] 2> 1302680 INFO (jetty-launcher-2231-thread-1)
[n:127.0.0.1:62038_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62038.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ac752ce
[junit4] 2> 1302681 INFO (jetty-launcher-2231-thread-1)
[n:127.0.0.1:62038_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.RecoveryZkTest_15BD1115E22ED0EC-001/tempDir-001/node1/.
[junit4] 2> 1302697 INFO (zkConnectionManagerCallback-2256-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302698 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1609df372050007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1302700 INFO (zkConnectionManagerCallback-2260-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1302701 INFO
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1302702 INFO
(SUITE-RecoveryZkTest-seed#[15BD1115E22ED0EC]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64378/solr ready
[junit4] 2> 1302724 INFO
(TEST-RecoveryZkTest.test-seed#[15BD1115E22ED0EC]) [ ] o.a.s.SolrTestCaseJ4
###Starting test
[junit4] 2> 1302749 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&maxShardsPerNode=1&name=recoverytest&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1302752 INFO
(OverseerThreadFactory-3885-thread-1-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.CreateCollectionCmd Create collection
recoverytest
[junit4] 2> 1302866 INFO
(OverseerStateUpdate-99252860717694982-127.0.0.1:62038_solr-n_0000000000)
[n:127.0.0.1:62038_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"recoverytest",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"recoverytest_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:48912/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1302868 INFO
(OverseerStateUpdate-99252860717694982-127.0.0.1:62038_solr-n_0000000000)
[n:127.0.0.1:62038_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"recoverytest",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"recoverytest_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:62038/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1303077 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica_n2&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1303077 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1303087 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica_n1&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1303088 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1303211 INFO
(zkCallback-2247-thread-1-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1303212 INFO
(zkCallback-2249-thread-1-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1303212 INFO
(zkCallback-2249-thread-2-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1303212 INFO
(zkCallback-2247-thread-2-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1304097 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 1304105 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.IndexSchema [recoverytest_shard1_replica_n2] Schema name=minimal
[junit4] 2> 1304106 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1304106 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore 'recoverytest_shard1_replica_n2' using
configuration from collection recoverytest, trusted=true
[junit4] 2> 1304107 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62038.solr.core.recoverytest.shard1.replica_n2' (registry
'solr.core.recoverytest.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ac752ce
[junit4] 2> 1304107 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1304107 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SolrCore [[recoverytest_shard1_replica_n2] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.RecoveryZkTest_15BD1115E22ED0EC-001/tempDir-001/node1/recoverytest_shard1_replica_n2],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.RecoveryZkTest_15BD1115E22ED0EC-001/tempDir-001/node1/./recoverytest_shard1_replica_n2/data/]
[junit4] 2> 1304141 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 1304146 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.IndexSchema [recoverytest_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1304151 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1304152 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'recoverytest_shard1_replica_n1' using
configuration from collection recoverytest, trusted=true
[junit4] 2> 1304152 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_48912.solr.core.recoverytest.shard1.replica_n1' (registry
'solr.core.recoverytest.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ac752ce
[junit4] 2> 1304152 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1304152 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.SolrCore [[recoverytest_shard1_replica_n1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.RecoveryZkTest_15BD1115E22ED0EC-001/tempDir-001/node2/recoverytest_shard1_replica_n1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.RecoveryZkTest_15BD1115E22ED0EC-001/tempDir-001/node2/./recoverytest_shard1_replica_n1/data/]
[junit4] 2> 1304178 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1304178 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1304180 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1304180 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1304180 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@700386e4[recoverytest_shard1_replica_n2] main]
[junit4] 2> 1304182 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1304182 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1304183 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1304183 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1588045773461782528
[junit4] 2> 1304183 INFO
(searcherExecutor-3890-thread-1-processing-n:127.0.0.1:62038_solr
x:recoverytest_shard1_replica_n2 s:shard1 c:recoverytest r:core_node4)
[n:127.0.0.1:62038_solr c:recoverytest s:shard1 r:core_node4
x:recoverytest_shard1_replica_n2] o.a.s.c.SolrCore
[recoverytest_shard1_replica_n2] Registered new searcher
Searcher@700386e4[recoverytest_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1304190 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 1304220 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1304220 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1304229 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1304229 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1304232 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@62617b61[recoverytest_shard1_replica_n1] main]
[junit4] 2> 1304233 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1304234 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1304234 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1304234 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1588045773515259904
[junit4] 2> 1304236 INFO
(searcherExecutor-3891-thread-1-processing-n:127.0.0.1:48912_solr
x:recoverytest_shard1_replica_n1 s:shard1 c:recoverytest r:core_node3)
[n:127.0.0.1:48912_solr c:recoverytest s:shard1 r:core_node3
x:recoverytest_shard1_replica_n1] o.a.s.c.SolrCore
[recoverytest_shard1_replica_n1] Registered new searcher
Searcher@62617b61[recoverytest_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1304291 INFO
(zkCallback-2249-thread-2-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1304291 INFO
(zkCallback-2249-thread-1-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1304292 INFO
(zkCallback-2247-thread-1-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1304292 INFO
(zkCallback-2247-thread-2-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1304692 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1304692 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1304692 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/
[junit4] 2> 1304692 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.PeerSync PeerSync: core=recoverytest_shard1_replica_n2
url=https://127.0.0.1:62038/solr START
replicas=[https://127.0.0.1:48912/solr/recoverytest_shard1_replica_n1/]
nUpdates=100
[junit4] 2> 1304698 INFO (qtp1303609321-10748) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.S.Request [recoverytest_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1304994 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.PeerSync PeerSync: core=recoverytest_shard1_replica_n2
url=https://127.0.0.1:62038/solr DONE. We have no versions. sync failed.
[junit4] 2> 1304994 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 1304994 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1304994 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1304999 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/ shard1
[junit4] 2> 1305100 INFO
(zkCallback-2247-thread-2-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1305100 INFO
(zkCallback-2249-thread-1-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1305100 INFO
(zkCallback-2247-thread-1-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1305101 INFO
(zkCallback-2249-thread-3-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1305150 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1305152 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica_n2&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2075
[junit4] 2> 1305240 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica_n1&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2153
[junit4] 2> 1305244 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1305341 INFO
(zkCallback-2247-thread-1-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1305341 INFO
(zkCallback-2249-thread-1-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1305341 INFO
(zkCallback-2247-thread-2-processing-n:127.0.0.1:48912_solr)
[n:127.0.0.1:48912_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1305341 INFO
(zkCallback-2249-thread-3-processing-n:127.0.0.1:62038_solr)
[n:127.0.0.1:62038_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1306245 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf&maxShardsPerNode=1&name=recoverytest&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=3496
[junit4] 2> 1306246 INFO
(TEST-RecoveryZkTest.test-seed#[15BD1115E22ED0EC]) [ ]
o.a.s.c.RecoveryZkTest Indexing 1350 documents
[junit4] 2> 1306257 INFO (qtp1303609321-10751) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-0
(1588045775629189120)]} 0 2
[junit4] 2> 1306257 INFO (qtp1020676361-10761) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-0
(1588045775629189120)]} 0 7
[junit4] 2> 1306259 INFO (qtp1303609321-10751) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-1
(1588045775637577728)]} 0 0
[junit4] 2> 1306259 INFO (qtp1020676361-10764) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-1
(1588045775637577728)]} 0 1
[junit4] 2> 1306260 INFO (qtp1303609321-10755) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-2
(1588045775639674880)]} 0 0
[junit4] 2> 1306261 INFO (qtp1020676361-10764) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-2
(1588045775639674880)]} 0 0
[junit4] 2> 1306262 INFO (qtp1303609321-10755) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-3
(1588045775640723456)]} 0 0
[junit4] 2> 1306262 INFO (qtp1020676361-10765) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-3
(1588045775640723456)]} 0 0
[junit4] 2> 1306263 INFO (qtp1303609321-10755) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-4
(1588045775642820608)]} 0 0
[junit4] 2> 1306263 INFO (qtp1020676361-10765) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-4
(1588045775642820608)]} 0 0
[junit4] 2> 1306266 INFO (qtp1303609321-10755) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-2
(-1588045775643869184)]} 0 1
[junit4] 2> 1306267 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-2
(-1588045775643869184)]} 0 2
[junit4] 2> 1306272 INFO (qtp1303609321-10749) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-5
(1588045775651209216)]} 0 0
[junit4] 2> 1306273 INFO (qtp1020676361-10759) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-5
(1588045775651209216)]} 0 2
[junit4] 2> 1306278 INFO (qtp1303609321-10749) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-0
(1588045775645966336)]} 0 0
[junit4] 2> 1306280 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-0
(1588045775645966336)]} 0 14
[junit4] 2> 1306280 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-6
(1588045775657500672)]} 0 0
[junit4] 2> 1306281 INFO (qtp1020676361-10759) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-6
(1588045775657500672)]} 0 3
[junit4] 2> 1306282 INFO (qtp1303609321-10752) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-1
(1588045775661694976)]} 0 0
[junit4] 2> 1306282 INFO (qtp1020676361-10761) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-1
(1588045775661694976)]} 0 0
[junit4] 2> 1306283 INFO (qtp1303609321-10752) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-2
(1588045775663792128)]} 0 0
[junit4] 2> 1306283 INFO (qtp1303609321-10748) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-7
(1588045775662743552)]} 0 0
[junit4] 2> 1306290 INFO (qtp1020676361-10765) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-2
(1588045775663792128)]} 0 7
[junit4] 2> 1306291 INFO (qtp1020676361-10759) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-7
(1588045775662743552)]} 0 8
[junit4] 2> 1306293 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-7
(-1588045775673229313)]} 0 0
[junit4] 2> 1306293 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-3
(1588045775673229312)]} 0 0
[junit4] 2> 1306293 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-7
(-1588045775673229313)]} 0 1
[junit4] 2> 1306293 INFO (qtp1020676361-10762) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-3
(1588045775673229312)]} 0 1
[junit4] 2> 1306296 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-8
(1588045775675326464)]} 0 1
[junit4] 2> 1306296 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-8
(1588045775675326464)]} 0 2
[junit4] 2> 1306296 INFO (qtp1303609321-10749) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-4
(1588045775676375040)]} 0 0
[junit4] 2> 1306297 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-4
(1588045775676375040)]} 0 1
[junit4] 2> 1306297 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-9
(1588045775678472192)]} 0 0
[junit4] 2> 1306298 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-9
(1588045775678472192)]} 0 0
[junit4] 2> 1306299 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-2
(-1588045775678472193)]} 0 0
[junit4] 2> 1306299 INFO (qtp1303609321-10755) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-8
(-1588045775679520768)]} 0 0
[junit4] 2> 1306300 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-8
(-1588045775679520768)]} 0 1
[junit4] 2> 1306300 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-2
(-1588045775678472193)]} 0 2
[junit4] 2> 1306301 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-5
(1588045775681617920)]} 0 0
[junit4] 2> 1306301 INFO (qtp1020676361-10761) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-5
(1588045775681617920)]} 0 0
[junit4] 2> 1306302 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-10
(1588045775682666496)]} 0 0
[junit4] 2> 1306302 INFO (qtp1020676361-10761) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-10
(1588045775682666496)]} 0 0
[junit4] 2> 1306303 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-6
(1588045775683715072)]} 0 0
[junit4] 2> 1306303 INFO (qtp1020676361-10761) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-6
(1588045775683715072)]} 0 0
[junit4] 2> 1306304 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-9
(-1588045775684763648)]} 0 0
[junit4] 2> 1306304 INFO (qtp1020676361-10761) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-9
(-1588045775684763648)]} 0 0
[junit4] 2> 1306305 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-7
(1588045775685812224)]} 0 0
[junit4] 2> 1306305 INFO (qtp1020676361-10761) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-7
(1588045775685812224)]} 0 0
[junit4] 2> 1306309 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-11
(1588045775686860800)]} 0 4
[junit4] 2> 1306309 INFO (qtp1303609321-10752) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-7
(-1588045775687909376)]} 0 0
[junit4] 2> 1306310 INFO (qtp1020676361-10759) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-7
(-1588045775687909376)]} 0 3
[junit4] 2> 1306310 INFO (qtp1020676361-10765) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-11
(1588045775686860800)]} 0 4
[junit4] 2> 1306311 INFO (qtp1303609321-10748) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-8
(1588045775692103680)]} 0 0
[junit4] 2> 1306311 INFO (qtp1020676361-10762) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-8
(1588045775692103680)]} 0 1
[junit4] 2> 1306312 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-9
(1588045775694200832)]} 0 0
[junit4] 2> 1306313 INFO (qtp1303609321-10751) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-12
(1588045775693152256)]} 0 0
[junit4] 2> 1306313 INFO (qtp1020676361-10766) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-9
(1588045775694200832)]} 0 1
[junit4] 2> 1306313 INFO (qtp1020676361-10764) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-12
(1588045775693152256)]} 0 1
[junit4] 2> 1306314 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-8
(-1588045775696297984)]} 0 0
[junit4] 2> 1306314 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-8
(-1588045775696297984)]} 0 0
[junit4] 2> 1306316 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-10
(1588045775697346560)]} 0 0
[junit4] 2> 1306316 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-10
(1588045775697346560)]} 0 0
[junit4] 2> 1306317 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-9
(-1588045775698395136)]} 0 0
[junit4] 2> 1306317 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-9
(-1588045775698395136)]} 0 0
[junit4] 2> 1306318 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-11
(1588045775700492288)]} 0 0
[junit4] 2> 1306318 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-11
(1588045775700492288)]} 0 0
[junit4] 2> 1306320 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-12
(1588045775701540864)]} 0 0
[junit4] 2> 1306320 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-12
(1588045775701540864)]} 0 0
[junit4] 2> 1306321 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-13
(1588045775702589440)]} 0 0
[junit4] 2> 1306321 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-13
(1588045775702589440)]} 0 0
[junit4] 2> 1306322 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-11
(-1588045775704686592)]} 0 0
[junit4] 2> 1306323 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-11
(-1588045775704686592)]} 0 0
[junit4] 2> 1306324 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-14
(1588045775705735168)]} 0 0
[junit4] 2> 1306324 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-14
(1588045775705735168)]} 0 0
[junit4] 2> 1306325 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-15
(1588045775706783744)]} 0 0
[junit4] 2> 1306325 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-15
(1588045775706783744)]} 0 0
[junit4] 2> 1306326 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-13
(-1588045775708880896)]} 0 0
[junit4] 2> 1306327 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-13
(-1588045775708880896)]} 0 0
[junit4] 2> 1306328 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-16
(1588045775709929472)]} 0 0
[junit4] 2> 1306328 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-16
(1588045775709929472)]} 0 0
[junit4] 2> 1306329 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-14
(-1588045775712026624)]} 0 0
[junit4] 2> 1306329 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-14
(-1588045775712026624)]} 0 0
[junit4] 2> 1306330 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-17
(1588045775713075200)]} 0 0
[junit4] 2> 1306331 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-17
(1588045775713075200)]} 0 0
[junit4] 2> 1306332 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-17
(-1588045775714123776)]} 0 0
[junit4] 2> 1306332 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-17
(-1588045775714123776)]} 0 0
[junit4] 2> 1306333 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-18
(1588045775716220928)]} 0 0
[junit4] 2> 1306333 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-18
(1588045775716220928)]} 0 0
[junit4] 2> 1306335 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-19
(1588045775717269504)]} 0 0
[junit4] 2> 1306335 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-19
(1588045775717269504)]} 0 0
[junit4] 2> 1306342 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-13
(1588045775722512384)]} 0 0
[junit4] 2> 1306343 INFO (qtp1020676361-10761) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-13
(1588045775722512384)]} 0 3
[junit4] 2> 1306345 INFO (qtp1303609321-10752) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-11
(-1588045775726706688)]} 0 1
[junit4] 2> 1306345 INFO (qtp1303609321-10749) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-18
(-1588045775726706689)]} 0 0
[junit4] 2> 1306346 INFO (qtp1020676361-10759) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-11
(-1588045775726706688)]} 0 2
[junit4] 2> 1306347 INFO (qtp1303609321-10748) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-14
(1588045775729852416)]} 0 0
[junit4] 2> 1306347 INFO (qtp1020676361-10765) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-14
(1588045775729852416)]} 0 1
[junit4] 2> 1306348 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-18
(-1588045775726706689)]} 0 4
[junit4] 2> 1306349 INFO (qtp1303609321-10751) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-15
(1588045775731949568)]} 0 0
[junit4] 2> 1306349 INFO (qtp1020676361-10762) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-15
(1588045775731949568)]} 0 0
[junit4] 2> 1306350 INFO (qtp1303609321-10755) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-20
(1588045775732998144)]} 0 0
[junit4] 2> 1306350 INFO (qtp1303609321-10754) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:62038/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-13
(-1588045775732998145)]} 0 0
[junit4] 2> 1306350 INFO (qtp1020676361-10764) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-13
(-1588045775732998145)]} 0 1
[junit4] 2> 1306351 INFO (qtp1020676361-10763) [n:127.0.0.1:62038_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-20
(1588045775732998144)]} 0 2
[junit4] 2> 1306352 INFO (qtp1303609321-10753) [n:127.0.0.1:48912_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replic
[...truncated too long message...]
= null, agent id = null] for registry solr.core.collection1.shard1.replica_n1
/ com.codahale.metrics.MetricRegistry@5827d0b6
[junit4] 2> 129129 INFO (jetty-closer-4-thread-2) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:44384_solr
[junit4] 2> 129136 INFO (coreCloseExecutor-232-thread-1)
[n:127.0.0.1:60157_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard2.leader, tag=1258415419
[junit4] 2> 129148 INFO (coreCloseExecutor-233-thread-1)
[n:127.0.0.1:47204_solr c:collection1 s:shard1 r:core_node3
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard1.leader, tag=536937719
[junit4] 2> 129157 INFO
(OverseerStateUpdate-99253058546237452-127.0.0.1:52108_solr-n_0000000000)
[n:127.0.0.1:52108_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:52108_solr
[junit4] 2> 129162 INFO (jetty-closer-4-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7423bac7{/solr,null,UNAVAILABLE}
[junit4] 2> 129164 WARN
(OverseerAutoScalingTriggerThread-99253058546237452-127.0.0.1:52108_solr-n_0000000000)
[n:127.0.0.1:52108_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 129174 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1609e218185000b, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 129175 INFO
(zkCallback-37-thread-2-processing-n:127.0.0.1:52108_solr)
[n:127.0.0.1:52108_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (0)
[junit4] 2> 129175 INFO (jetty-closer-4-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 129176 INFO
(zkCallback-33-thread-2-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (0)
[junit4] 2> 129176 INFO (jetty-closer-4-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@750faaa3{/solr,null,UNAVAILABLE}
[junit4] 2> 129186 INFO (jetty-closer-4-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@50ea632e{/solr,null,UNAVAILABLE}
[junit4] 2> 129201 INFO
(zkCallback-33-thread-2-processing-n:127.0.0.1:44384_solr)
[n:127.0.0.1:44384_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:44384_solr
[junit4] 2> 129279 INFO (jetty-closer-4-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@53f418ce{/solr,null,UNAVAILABLE}
[junit4] 2> 129301 ERROR
(SUITE-StreamExpressionTest-seed#[41CB951D2F9039BA]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 129302 INFO
(SUITE-StreamExpressionTest-seed#[41CB951D2F9039BA]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:35114 35114
[junit4] 2> 129532 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxnFactory Ignoring unexpected runtime exception
[junit4] 2> java.nio.channels.CancelledKeyException
[junit4] 2> at
sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:73)
[junit4] 2> at
sun.nio.ch.SelectionKeyImpl.readyOps(SelectionKeyImpl.java:87)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:182)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 129533 INFO (Thread-11) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:35114 35114
[junit4] 2> 129535 WARN (Thread-11) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 98 /solr/aliases.json
[junit4] 2> 98 /solr/clusterprops.json
[junit4] 2> 10 /solr/configs/conf
[junit4] 2> 8 /solr/configs/ml
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 98 /solr/clusterstate.json
[junit4] 2> 40
/solr/collections/destinationCollection/state.json
[junit4] 2> 28
/solr/collections/parallelDestinationCollection1/state.json
[junit4] 2> 22
/solr/collections/parallelDestinationCollection/state.json
[junit4] 2> 12 /solr/collections/collection1/state.json
[junit4] 2> 10 /solr/collections/mainCorpus1/state.json
[junit4] 2> 10 /solr/collections/destination/state.json
[junit4] 2> 10 /solr/collections/destination1/state.json
[junit4] 2> 10 /solr/collections/workQueue1/state.json
[junit4] 2> 10 /solr/collections/workQueue/state.json
[junit4] 2> 10 /solr/collections/uknownCollection/state.json
[junit4] 2> 10 /solr/collections/modelCollection/state.json
[junit4] 2> 10
/solr/collections/checkpointCollection/state.json
[junit4] 2> 10 /solr/collections/mainCorpus/state.json
[junit4] 2> 2
/solr/overseer_elect/election/99253058546237450-127.0.0.1:44384_solr-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 98 /solr/live_nodes
[junit4] 2> 98 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_41CB951D2F9039BA-001
[junit4] 2> Dec 28, 2017 5:20:04 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{name_s=Lucene50(blocksize=128),
expr_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
terms_ss=PostingsFormat(name=MockRandom),
join2_s=PostingsFormat(name=MockRandom), field_s=PostingsFormat(name=Memory),
multiDefault=PostingsFormat(name=MockRandom),
subject=PostingsFormat(name=MockRandom), a1_s=PostingsFormat(name=MockRandom),
a2_s=Lucene50(blocksize=128),
level1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
body_t=Lucene50(blocksize=128), s_multi=Lucene50(blocksize=128),
col_s=PostingsFormat(name=MockRandom), level2_s=PostingsFormat(name=Memory),
a_ss=PostingsFormat(name=Memory), a_s=Lucene50(blocksize=128),
tv_text=PostingsFormat(name=Memory), term_s=PostingsFormat(name=MockRandom),
a_t=PostingsFormat(name=Memory),
text_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
text=Lucene50(blocksize=128), featureSet_s=PostingsFormat(name=MockRandom),
checkpoint_ss=Lucene50(blocksize=128), test_t=Lucene50(blocksize=128),
ident_s=PostingsFormat(name=MockRandom), whitetok=Lucene50(blocksize=128),
side_s=Lucene50(blocksize=128)},
docValues:{name_s=DocValuesFormat(name=Memory),
expr_s=DocValuesFormat(name=Direct), iteration_i=DocValuesFormat(name=Direct),
terms_ss=DocValuesFormat(name=Asserting),
join2_s=DocValuesFormat(name=Asserting),
field_s=DocValuesFormat(name=Lucene70),
multiDefault=DocValuesFormat(name=Asserting),
price_f=DocValuesFormat(name=Asserting), a1_s=DocValuesFormat(name=Asserting),
a_f=DocValuesFormat(name=Asserting), intDefault=DocValuesFormat(name=Lucene70),
join1_i=DocValuesFormat(name=Direct),
falseNegative_i=DocValuesFormat(name=Lucene70),
a2_s=DocValuesFormat(name=Memory), a_i=DocValuesFormat(name=Direct),
join3_i=DocValuesFormat(name=Memory), test_i=DocValuesFormat(name=Asserting),
falsePositive_i=DocValuesFormat(name=Lucene70),
field_i=DocValuesFormat(name=Asserting), level1_s=DocValuesFormat(name=Direct),
s_multi=DocValuesFormat(name=Memory), col_s=DocValuesFormat(name=Asserting),
level2_s=DocValuesFormat(name=Lucene70), a_ss=DocValuesFormat(name=Lucene70),
a_s=DocValuesFormat(name=Memory), score_f=DocValuesFormat(name=Memory),
term_s=DocValuesFormat(name=Asserting), text_s=DocValuesFormat(name=Direct),
id=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Lucene70),
i_multi=DocValuesFormat(name=Direct),
featureSet_s=DocValuesFormat(name=Asserting),
trueNegative_i=DocValuesFormat(name=Memory),
index_i=DocValuesFormat(name=Asserting), b_ls=DocValuesFormat(name=Asserting),
test_dt=DocValuesFormat(name=Direct), out_i=DocValuesFormat(name=Asserting),
checkpoint_ss=DocValuesFormat(name=Memory),
ident_s=DocValuesFormat(name=Asserting),
order_i=DocValuesFormat(name=Asserting),
_version_=DocValuesFormat(name=Lucene70), side_s=DocValuesFormat(name=Memory),
truePositive_i=DocValuesFormat(name=Direct),
miles_i=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=583,
maxMBSortInHeap=7.741831311723057, sim=RandomSimilarity(queryNorm=false): {},
locale=ar-MA, timezone=Etc/GMT-4
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_152
(64-bit)/cpus=3,threads=1,free=65670168,total=143826944
[junit4] 2> NOTE: All tests run in this JVM: [AndEvaluatorTest,
ArcCosineEvaluatorTest, SolrQueryTest, TestFastInputStream,
SolrSchemalessExampleTest, CommonParamsTest, NormalizeEvaluatorTest,
StreamExpressionTest]
[junit4] Completed [70/146 (1!)] on J1 in 121.14s, 142 tests, 1 failure <<<
FAILURES!
[...truncated 47451 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]