Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-MacOSX/543/
Java: 64bit/jdk-9 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaOnIndexing
Error Message:
Time out waiting for LIR state get removed
Stack Trace:
java.util.concurrent.TimeoutException: Time out waiting for LIR state get
removed
at
__randomizedtesting.SeedInfo.seed([14A6D70693F0B86B:6DDDFB89306D7248]:0)
at org.apache.solr.util.TimeOut.waitFor(TimeOut.java:66)
at
org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaOnIndexing(DeleteReplicaTest.java:331)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
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
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaOnIndexing
Error Message:
Time out waiting for LIR state get removed
Stack Trace:
java.util.concurrent.TimeoutException: Time out waiting for LIR state get
removed
at
__randomizedtesting.SeedInfo.seed([14A6D70693F0B86B:6DDDFB89306D7248]:0)
at org.apache.solr.util.TimeOut.waitFor(TimeOut.java:66)
at
org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaOnIndexing(DeleteReplicaTest.java:331)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
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
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 1802 lines...]
[junit4] JVM J0: stdout was not empty, see:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/lucene/build/core/test/temp/junit4-J0-20180329_012749_85812200028506670383522.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] codec: SimpleText, pf: BlockTreeOrds, dvf: Lucene70
[junit4] <<< JVM J0: EOF ----
[...truncated 12103 lines...]
[junit4] Suite: org.apache.solr.cloud.DeleteReplicaTest
[junit4] 2> 1867145 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/init-core-data-001
[junit4] 2> 1867145 WARN
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 1867145 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1867146 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 1867146 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001
[junit4] 2> 1867146 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1867147 INFO (Thread-4048) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1867147 INFO (Thread-4048) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1867150 ERROR (Thread-4048) [ ] 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> 1867257 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:50278
[junit4] 2> 1867271 INFO (zkConnectionManagerCallback-5577-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867276 INFO (jetty-launcher-5574-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1867276 INFO (jetty-launcher-5574-thread-3) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1867276 INFO (jetty-launcher-5574-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1867276 INFO (jetty-launcher-5574-thread-4) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1867277 INFO (jetty-launcher-5574-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1867277 INFO (jetty-launcher-5574-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1867277 INFO (jetty-launcher-5574-thread-2) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1867277 INFO (jetty-launcher-5574-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@703d28c0{/solr,null,AVAILABLE}
[junit4] 2> 1867278 INFO (jetty-launcher-5574-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1867278 INFO (jetty-launcher-5574-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1867278 INFO (jetty-launcher-5574-thread-3) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1867279 INFO (jetty-launcher-5574-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1867279 INFO (jetty-launcher-5574-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1867279 INFO (jetty-launcher-5574-thread-1) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1867279 INFO (jetty-launcher-5574-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6c52a654{/solr,null,AVAILABLE}
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@394c303e{/solr,null,AVAILABLE}
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@389b0808{HTTP/1.1,[http/1.1]}{127.0.0.1:50281}
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@2050fd9a{HTTP/1.1,[http/1.1]}{127.0.0.1:50280}
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-3) [ ]
o.e.j.s.Server Started @1867366ms
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-2) [ ]
o.e.j.s.Server Started @1867366ms
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=50281}
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=50280}
[junit4] 2> 1867280 ERROR (jetty-launcher-5574-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@61ff46f2{HTTP/1.1,[http/1.1]}{127.0.0.1:50282}
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.e.j.s.Server Started @1867367ms
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=50282}
[junit4] 2> 1867280 ERROR (jetty-launcher-5574-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1867280 ERROR (jetty-launcher-5574-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-29T02:25:17.153770Z
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-29T02:25:17.153800Z
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1867280 INFO (jetty-launcher-5574-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-29T02:25:17.153867Z
[junit4] 2> 1867282 INFO (jetty-launcher-5574-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1867282 INFO (jetty-launcher-5574-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1867282 INFO (jetty-launcher-5574-thread-4) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1867283 INFO (jetty-launcher-5574-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3e9a4746{/solr,null,AVAILABLE}
[junit4] 2> 1867283 INFO (jetty-launcher-5574-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@a1cc7fe{HTTP/1.1,[http/1.1]}{127.0.0.1:50285}
[junit4] 2> 1867283 INFO (jetty-launcher-5574-thread-4) [ ]
o.e.j.s.Server Started @1867370ms
[junit4] 2> 1867283 INFO (jetty-launcher-5574-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=50285}
[junit4] 2> 1867283 ERROR (jetty-launcher-5574-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1867283 INFO (jetty-launcher-5574-thread-4) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1867283 INFO (jetty-launcher-5574-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 1867283 INFO (jetty-launcher-5574-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1867283 INFO (zkConnectionManagerCallback-5579-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867283 INFO (jetty-launcher-5574-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1867284 INFO (jetty-launcher-5574-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-29T02:25:17.157031Z
[junit4] 2> 1867284 INFO (zkConnectionManagerCallback-5581-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867284 INFO (zkConnectionManagerCallback-5583-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867284 INFO (jetty-launcher-5574-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1867285 INFO (jetty-launcher-5574-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1867285 INFO (jetty-launcher-5574-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1867286 INFO (zkConnectionManagerCallback-5585-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867289 INFO (jetty-launcher-5574-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1867292 INFO (jetty-launcher-5574-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50278/solr
[junit4] 2> 1867292 INFO (jetty-launcher-5574-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50278/solr
[junit4] 2> 1867294 INFO (jetty-launcher-5574-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50278/solr
[junit4] 2> 1867294 INFO (zkConnectionManagerCallback-5591-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867295 INFO (zkConnectionManagerCallback-5593-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867296 INFO (zkConnectionManagerCallback-5597-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867297 INFO (jetty-launcher-5574-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50278/solr
[junit4] 2> 1867299 INFO (zkConnectionManagerCallback-5602-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867299 INFO (zkConnectionManagerCallback-5601-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867299 INFO (zkConnectionManagerCallback-5605-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867300 INFO (zkConnectionManagerCallback-5607-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867303 INFO (zkConnectionManagerCallback-5609-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867483 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1867484 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:50280_solr
[junit4] 2> 1867486 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.c.Overseer Overseer
(id=72140644418781192-127.0.0.1:50280_solr-n_0000000000) starting
[junit4] 2> 1867498 INFO (jetty-launcher-5574-thread-3)
[n:127.0.0.1:50281_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1867500 INFO (jetty-launcher-5574-thread-3)
[n:127.0.0.1:50281_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50281_solr
[junit4] 2> 1867502 INFO (zkCallback-5599-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1867503 INFO (zkCallback-5600-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1867515 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1867519 INFO (zkConnectionManagerCallback-5617-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867521 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1867522 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1867523 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1867523 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:50278/solr ready
[junit4] 2> 1867529 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1867529 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50285_solr
[junit4] 2> 1867530 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1867533 INFO (zkCallback-5608-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1867533 INFO (zkCallback-5616-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1867533 INFO (zkCallback-5599-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1867534 INFO (zkCallback-5606-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1867535 INFO (zkCallback-5600-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1867536 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1867536 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50280_solr
[junit4] 2> 1867591 INFO (zkCallback-5599-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1867608 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50285.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867615 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50285.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867615 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50285.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867616 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001/node4/.
[junit4] 2> 1867617 INFO (zkCallback-5616-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1867617 INFO (zkCallback-5608-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1867618 INFO (zkCallback-5606-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1867618 INFO (zkCallback-5600-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1867621 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1867621 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50282_solr
[junit4] 2> 1867622 INFO (zkConnectionManagerCallback-5621-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867635 INFO (zkCallback-5616-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1867635 INFO (zkCallback-5599-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1867636 INFO (zkCallback-5600-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1867636 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 1867636 INFO (zkCallback-5608-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1867636 INFO (zkCallback-5606-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1867637 INFO (jetty-launcher-5574-thread-4)
[n:127.0.0.1:50285_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:50278/solr ready
[junit4] 2> 1867685 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50282.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867690 INFO (jetty-launcher-5574-thread-3)
[n:127.0.0.1:50281_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50281.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867692 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50282.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867692 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50282.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867693 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001/node1/.
[junit4] 2> 1867695 INFO (zkConnectionManagerCallback-5625-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867697 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 1867698 INFO (jetty-launcher-5574-thread-3)
[n:127.0.0.1:50281_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50281.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867698 INFO (jetty-launcher-5574-thread-3)
[n:127.0.0.1:50281_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50281.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867698 INFO (jetty-launcher-5574-thread-1)
[n:127.0.0.1:50282_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:50278/solr ready
[junit4] 2> 1867699 INFO (jetty-launcher-5574-thread-3)
[n:127.0.0.1:50281_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001/node3/.
[junit4] 2> 1867702 INFO (zkConnectionManagerCallback-5629-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867704 INFO (jetty-launcher-5574-thread-3)
[n:127.0.0.1:50281_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 1867705 INFO (jetty-launcher-5574-thread-3)
[n:127.0.0.1:50281_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:50278/solr ready
[junit4] 2> 1867839 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50280.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867846 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50280.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867846 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50280.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1867846 INFO (jetty-launcher-5574-thread-2)
[n:127.0.0.1:50280_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001/node2/.
[junit4] 2> 1867875 INFO (zkConnectionManagerCallback-5631-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867879 INFO (zkConnectionManagerCallback-5635-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1867881 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1867883 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50278/solr ready
[junit4] 2> 1867913 INFO
(TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[14A6D70693F0B86B]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting deleteReplicaOnIndexing
[junit4] 2> 1867916 INFO (qtp420366668-22067) [n:127.0.0.1:50281_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&name=deleteReplicaOnIndexing&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1867919 INFO (OverseerThreadFactory-9446-thread-1) [ ]
o.a.s.c.a.c.CreateCollectionCmd Create collection deleteReplicaOnIndexing
[junit4] 2> 1868034 INFO
(OverseerStateUpdate-72140644418781192-127.0.0.1:50280_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"deleteReplicaOnIndexing",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"deleteReplicaOnIndexing_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50280/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1868038 INFO
(OverseerStateUpdate-72140644418781192-127.0.0.1:50280_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"deleteReplicaOnIndexing",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"deleteReplicaOnIndexing_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50282/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1868255 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=deleteReplicaOnIndexing_shard1_replica_n2&action=CREATE&numShards=1&collection=deleteReplicaOnIndexing&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1868257 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=deleteReplicaOnIndexing_shard1_replica_n1&action=CREATE&numShards=1&collection=deleteReplicaOnIndexing&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1868382 INFO (zkCallback-5600-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1868382 INFO (zkCallback-5606-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1868382 INFO (zkCallback-5600-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1868382 INFO (zkCallback-5606-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1869288 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.4.0
[junit4] 2> 1869292 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.4.0
[junit4] 2> 1869309 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.s.IndexSchema
[deleteReplicaOnIndexing_shard1_replica_n2] Schema name=minimal
[junit4] 2> 1869310 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 1869310 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.c.CoreContainer Creating
SolrCore 'deleteReplicaOnIndexing_shard1_replica_n2' using configuration from
collection deleteReplicaOnIndexing, trusted=true
[junit4] 2> 1869311 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_50282.solr.core.deleteReplicaOnIndexing.shard1.replica_n2'
(registry 'solr.core.deleteReplicaOnIndexing.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1869311 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1869311 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.c.SolrCore
[[deleteReplicaOnIndexing_shard1_replica_n2] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001/node1/deleteReplicaOnIndexing_shard1_replica_n2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001/node1/./deleteReplicaOnIndexing_shard1_replica_n2/data/]
[junit4] 2> 1869311 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.s.IndexSchema
[deleteReplicaOnIndexing_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1869312 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 1869312 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.CoreContainer Creating
SolrCore 'deleteReplicaOnIndexing_shard1_replica_n1' using configuration from
collection deleteReplicaOnIndexing, trusted=true
[junit4] 2> 1869313 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_50280.solr.core.deleteReplicaOnIndexing.shard1.replica_n1'
(registry 'solr.core.deleteReplicaOnIndexing.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e78c40a
[junit4] 2> 1869313 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1869313 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.SolrCore
[[deleteReplicaOnIndexing_shard1_replica_n1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001/node2/deleteReplicaOnIndexing_shard1_replica_n1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001/tempDir-001/node2/./deleteReplicaOnIndexing_shard1_replica_n1/data/]
[junit4] 2> 1869491 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1869491 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1869493 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 1869493 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1869511 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1869511 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1869513 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 1869513 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1869517 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@58b2b249[deleteReplicaOnIndexing_shard1_replica_n1] main]
[junit4] 2> 1869519 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1869519 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1869530 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 1869530 INFO
(searcherExecutor-9456-thread-1-processing-n:127.0.0.1:50280_solr
x:deleteReplicaOnIndexing_shard1_replica_n1 c:deleteReplicaOnIndexing s:shard1
r:core_node3) [n:127.0.0.1:50280_solr c:deleteReplicaOnIndexing s:shard1
r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.SolrCore
[deleteReplicaOnIndexing_shard1_replica_n1] Registered new searcher
Searcher@58b2b249[deleteReplicaOnIndexing_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1869530 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.u.UpdateLog Could not find
max version in index or recent updates, using new clock 1596237093958320128
[junit4] 2> 1869543 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/deleteReplicaOnIndexing/terms/shard1 to
Terms{values={core_node3=0}, version=0}
[junit4] 2> 1869549 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6c7958cf[deleteReplicaOnIndexing_shard1_replica_n2] main]
[junit4] 2> 1869551 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Waiting until we see more replicas up for shard shard1: total=2 found=1
timeoutin=9999ms
[junit4] 2> 1869551 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1869551 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1869552 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 1869552 INFO
(searcherExecutor-9455-thread-1-processing-n:127.0.0.1:50282_solr
x:deleteReplicaOnIndexing_shard1_replica_n2 c:deleteReplicaOnIndexing s:shard1
r:core_node4) [n:127.0.0.1:50282_solr c:deleteReplicaOnIndexing s:shard1
r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.c.SolrCore
[deleteReplicaOnIndexing_shard1_replica_n2] Registered new searcher
Searcher@6c7958cf[deleteReplicaOnIndexing_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1869553 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.u.UpdateLog Could not find
max version in index or recent updates, using new clock 1596237093982437376
[junit4] 2> 1869557 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/deleteReplicaOnIndexing/terms/shard1 to
Terms{values={core_node3=0, core_node4=0}, version=1}
[junit4] 2> 1869657 INFO (zkCallback-5600-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1869657 INFO (zkCallback-5600-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1869657 INFO (zkCallback-5606-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1869657 INFO (zkCallback-5606-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1870057 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 1870057 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
I may be the new leader - try and sync
[junit4] 2> 1870057 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas
to http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/
[junit4] 2> 1870058 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.u.PeerSync PeerSync:
core=deleteReplicaOnIndexing_shard1_replica_n1 url=http://127.0.0.1:50280/solr
START
replicas=[http://127.0.0.1:50282/solr/deleteReplicaOnIndexing_shard1_replica_n2/]
nUpdates=100
[junit4] 2> 1870060 INFO (qtp613050149-22078) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.c.S.Request
[deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1870360 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.u.PeerSync PeerSync:
core=deleteReplicaOnIndexing_shard1_replica_n1 url=http://127.0.0.1:50280/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1870360 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.SyncStrategy Leader's
attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1870360 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] 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> 1870360 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 1870366 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
I am the new leader:
http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/ shard1
[junit4] 2> 1870475 INFO (zkCallback-5606-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1870475 INFO (zkCallback-5600-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1870475 INFO (zkCallback-5606-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1870475 INFO (zkCallback-5600-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1870488 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ZkController I am the
leader, no recovery necessary
[junit4] 2> 1870490 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_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=deleteReplicaOnIndexing_shard1_replica_n1&action=CREATE&numShards=1&collection=deleteReplicaOnIndexing&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2233
[junit4] 2> 1870564 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_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=deleteReplicaOnIndexing_shard1_replica_n2&action=CREATE&numShards=1&collection=deleteReplicaOnIndexing&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2309
[junit4] 2> 1870567 INFO (qtp420366668-22067) [n:127.0.0.1:50281_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> 1870672 INFO (zkCallback-5600-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1870672 INFO (zkCallback-5600-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1870672 INFO (zkCallback-5606-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1870672 INFO (zkCallback-5606-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/deleteReplicaOnIndexing/state.json] for collection
[deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1871578 INFO (qtp420366668-22067) [n:127.0.0.1:50281_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf&name=deleteReplicaOnIndexing&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=3662
[junit4] 2> 1871596 INFO (qtp368193063-22063) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/deleteReplicaOnIndexing/terms/shard1 to
Terms{values={core_node3=1, core_node4=1}, version=2}
[junit4] 2> 1871597 INFO (qtp368193063-22064) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1] o.a.s.c.ZkShardTerms Failed to
save terms, version is not a match, retrying
[junit4] 2> 1871612 INFO (qtp613050149-22080) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[10000
(1596237096119435264)]} 0 0
[junit4] 2> 1871613 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[10000
(1596237096119435264)]} 0 22
[junit4] 2> 1871629 INFO (qtp613050149-22081) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[160000
(1596237096121532416)]} 0 32
[junit4] 2> 1871630 INFO (qtp368193063-22064) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[160000
(1596237096121532416)]} 0 37
[junit4] 2> 1871631 INFO (qtp613050149-22076) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[190000
(1596237096122580992)]} 0 35
[junit4] 2> 1871631 INFO (qtp368193063-22063) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[190000
(1596237096122580992)]} 0 37
[junit4] 2> 1871633 INFO (qtp613050149-22080) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[60000
(1596237096117338113)]} 0 0
[junit4] 2> 1871633 INFO (qtp368193063-22062) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[60000
(1596237096117338113)]} 0 44
[junit4] 2> 1871634 INFO (qtp613050149-22078) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[80000
(1596237096118386688)]} 0 1
[junit4] 2> 1871635 INFO (qtp368193063-22060) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[80000
(1596237096118386688)]} 0 44
[junit4] 2> 1871635 INFO (qtp613050149-22081) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[40000
(1596237096161378304)]} 0 3
[junit4] 2> 1871635 INFO (qtp613050149-22082) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[0
(1596237096161378305)]} 0 3
[junit4] 2> 1871636 INFO (qtp368193063-22059) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[40000
(1596237096161378304)]} 0 4
[junit4] 2> 1871636 INFO (qtp368193063-22231) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[0
(1596237096161378305)]} 0 4
[junit4] 2> 1871638 INFO (qtp613050149-22080) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[70000
(1596237096162426880)]} 0 0
[junit4] 2> 1871638 INFO (qtp368193063-22064) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[70000
(1596237096162426880)]} 0 6
[junit4] 2> 1871639 INFO (qtp613050149-22078) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[20000
(1596237096117338112)]} 0 4
[junit4] 2> 1871640 INFO (qtp368193063-22061) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[20000
(1596237096117338112)]} 0 50
[junit4] 2> 1871642 INFO (qtp613050149-22081) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[40001
(1596237096168718336)]} 0 3
[junit4] 2> 1871642 INFO (qtp368193063-22243) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[40001
(1596237096168718336)]} 0 4
[junit4] 2> 1871643 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[110000
(1596237096171864065)]} 0 0
[junit4] 2> 1871643 INFO (qtp613050149-22082) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[30000
(1596237096167669760)]} 0 6
[junit4] 2> 1871644 INFO (qtp368193063-22062) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[110000
(1596237096171864065)]} 0 2
[junit4] 2> 1871644 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[30000
(1596237096167669760)]} 0 6
[junit4] 2> 1871645 INFO (qtp613050149-22082) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[140000
(1596237096173961216)]} 0 0
[junit4] 2> 1871646 INFO (qtp368193063-22063) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[140000
(1596237096173961216)]} 0 2
[junit4] 2> 1871646 INFO (qtp613050149-22077) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[640000
(1596237096172912641)]} 0 2
[junit4] 2> 1871646 INFO (qtp368193063-22064) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[640000
(1596237096172912641)]} 0 4
[junit4] 2> 1871655 INFO (qtp613050149-22077) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[100000
(1596237096173961217)]} 0 0
[junit4] 2> 1871655 INFO (qtp613050149-22080) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[520000
(1596237096168718337)]} 0 13
[junit4] 2> 1871655 INFO (qtp613050149-22081) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[120000
(1596237096171864064)]} 0 13
[junit4] 2> 1871656 INFO (qtp368193063-22060) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[100000
(1596237096173961217)]} 0 12
[junit4] 2> 1871656 INFO (qtp368193063-22231) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[520000
(1596237096168718337)]} 0 18
[junit4] 2> 1871656 INFO (qtp368193063-22059) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[120000
(1596237096171864064)]} 0 15
[junit4] 2> 1871657 INFO (qtp613050149-22077) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[480000
(1596237096171864066)]} 0 0
[junit4] 2> 1871657 INFO (qtp613050149-22081) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[570000
(1596237096178155520)]} 0 0
[junit4] 2> 1871658 INFO (qtp368193063-22316) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[480000
(1596237096171864066)]} 0 16
[junit4] 2> 1871658 INFO (qtp368193063-22315) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[570000
(1596237096178155520)]} 0 11
[junit4] 2> 1871658 INFO (qtp613050149-22081) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[150000
(1596237096172912640)]} 0 0
[junit4] 2> 1871659 INFO (qtp368193063-22061) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[150000
(1596237096172912640)]} 0 17
[junit4] 2> 1871659 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[110001
(1596237096177106944)]} 0 12
[junit4] 2> 1871659 INFO (qtp368193063-22057) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[110001
(1596237096177106944)]} 0 12
[junit4] 2> 1871659 INFO (qtp613050149-22076) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[1
(1596237096176058368)]} 0 12
[junit4] 2> 1871659 INFO (qtp368193063-22062) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1
(1596237096176058368)]} 0 14
[junit4] 2> 1871659 INFO (qtp613050149-22078) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[40002
(1596237096175009792)]} 0 14
[junit4] 2> 1871663 INFO (qtp368193063-22243) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[40002
(1596237096175009792)]} 0 19
[junit4] 2> 1871664 INFO (qtp613050149-22376) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[160001
(1596237096189689857)]} 0 5
[junit4] 2> 1871664 INFO (qtp613050149-22377) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[30001
(1596237096189689856)]} 0 5
[junit4] 2> 1871664 INFO (qtp613050149-22081) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[560000
(1596237096188641281)]} 0 5
[junit4] 2> 1871664 INFO (qtp368193063-22316) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[160001
(1596237096189689857)]} 0 6
[junit4] 2> 1871664 INFO (qtp368193063-22373) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[30001
(1596237096189689856)]} 0 6
[junit4] 2> 1871665 INFO (qtp613050149-22378) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[90000
(1596237096188641280)]} 0 1
[junit4] 2> 1871665 INFO (qtp368193063-22372) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[560000
(1596237096188641281)]} 0 8
[junit4] 2> 1871666 INFO (qtp368193063-22231) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[90000
(1596237096188641280)]} 0 9
[junit4] 2> 1871666 INFO (qtp613050149-22077) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[590000
(1596237096184446976)]} 0 8
[junit4] 2> 1871667 INFO (qtp613050149-22344) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[690000
(1596237096184446977)]} 0 7
[junit4] 2> 1871667 INFO (qtp613050149-22065) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[320000
(1596237096198078465)]} 0 0
[junit4] 2> 1871667 INFO (qtp368193063-22063) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[590000
(1596237096184446976)]} 0 14
[junit4] 2> 1871667 INFO (qtp368193063-22347) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[690000
(1596237096184446977)]} 0 14
[junit4] 2> 1871667 INFO (qtp368193063-22059) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[320000
(1596237096198078465)]} 0 1
[junit4] 2> 1871674 INFO (qtp613050149-22082) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[310000
(1596237096198078464)]} 0 7
[junit4] 2> 1871675 INFO (qtp368193063-22348) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[310000
(1596237096198078464)]} 0 9
[junit4] 2> 1871676 INFO (qtp613050149-22076) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[420000
(1596237096197029888)]} 0 9
[junit4] 2> 1871677 INFO (qtp368193063-22064) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[420000
(1596237096197029888)]} 0 11
[junit4] 2> 1871677 INFO (qtp613050149-22344) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[460000
(1596237096206467072)]} 0 1
[junit4] 2> 1871677 INFO (qtp613050149-22080) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[250000
(1596237096205418496)]} 0 2
[junit4] 2> 1871678 INFO (qtp613050149-22078) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[350000
(1596237096206467073)]} 0 2
[junit4] 2> 1871679 INFO (qtp368193063-22060) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[460000
(1596237096206467072)]} 0 4
[junit4] 2> 1871679 INFO (qtp368193063-22371) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[250000
(1596237096205418496)]} 0 5
[junit4] 2> 1871679 INFO (qtp613050149-22076) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[330000
(1596237096207515648)]} 0 2
[junit4] 2> 1871680 INFO (qtp368193063-22059) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[350000
(1596237096206467073)]} 0 5
[junit4] 2> 1871680 INFO (qtp613050149-22078) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[280000
(1596237096209612800)]} 0 0
[junit4] 2> 1871680 INFO (qtp368193063-22347) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[330000
(1596237096207515648)]} 0 5
[junit4] 2> 1871680 INFO (qtp368193063-22061) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[280000
(1596237096209612800)]} 0 3
[junit4] 2> 1871684 INFO (qtp613050149-22375) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[530000
(1596237096213807104)]} 0 0
[junit4] 2> 1871684 INFO (qtp613050149-22081) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[240000
(1596237096213807105)]} 0 0
[junit4] 2> 1871684 INFO (qtp613050149-22380) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[230000
(1596237096214855682)]} 0 0
[junit4] 2> 1871684 INFO (qtp368193063-22347) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[530000
(1596237096213807104)]} 0 4
[junit4] 2> 1871685 INFO (qtp613050149-22380) [n:127.0.0.1:50282_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50280/solr/deleteReplicaOnIndexing_shard1_replica_n1/&wt=javabin&version=2}{add=[440000
(1596237096214855680)]} 0 0
[junit4] 2> 1871685 INFO (qtp368193063-22060) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[240000
(1596237096213807105)]} 0 4
[junit4] 2> 1871685 INFO (qtp368193063-22374) [n:127.0.0.1:50280_solr
c:deleteReplicaOnIndexing s:shard1 r:core_node3
x:deleteReplicaOnIndexing_shard1_replica_n1]
[...truncated too long message...]
.replica_t1 / com.codahale.metrics.MetricRegistry@3861a1c8
[junit4] 2> 110010 INFO (coreCloseExecutor-323-thread-1)
[n:127.0.0.1:62531_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.deleteReplicaOnIndexing.shard1.leader, tag=1986478682
[junit4] 2> 110010 INFO (coreCloseExecutor-323-thread-2)
[n:127.0.0.1:62531_solr c:delLiveColl s:shard2 r:core_node7
x:delLiveColl_shard2_replica_n4] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.delLiveColl.shard2.replica_n4, tag=850345470
[junit4] 2> 110010 INFO (coreCloseExecutor-323-thread-2)
[n:127.0.0.1:62531_solr c:delLiveColl s:shard2 r:core_node7
x:delLiveColl_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@14d6e153: rootName =
solr_62531, domain = solr.core.delLiveColl.shard2.replica_n4, service url =
null, agent id = null] for registry solr.core.delLiveColl.shard2.replica_n4 /
com.codahale.metrics.MetricRegistry@433f039c
[junit4] 2> 110011 INFO (coreCloseExecutor-323-thread-1)
[n:127.0.0.1:62531_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.u.DirectUpdateHandler2
Committing on IndexWriter close.
[junit4] 2> 110011 INFO (coreCloseExecutor-323-thread-1)
[n:127.0.0.1:62531_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4
x:deleteReplicaOnIndexing_shard1_replica_n2] o.a.s.u.SolrIndexWriter Calling
setCommitData with IW:org.apache.solr.update.SolrIndexWriter@31fe1d3b
commitCommandVersion:0
[junit4] 2> 110085 INFO (coreCloseExecutor-320-thread-2)
[n:127.0.0.1:62528_solr c:delLiveColl s:shard1 r:core_node5
x:delLiveColl_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.delLiveColl.shard1.leader, tag=519897955
[junit4] 2> 110085 INFO (coreCloseExecutor-320-thread-1)
[n:127.0.0.1:62528_solr c:deleteByCountNew s:shard1 r:core_node5
x:deleteByCountNew_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.deleteByCountNew.shard1.leader,
tag=94242044
[junit4] 2> 110099 INFO (jetty-closer-92-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3165497d{/solr,null,UNAVAILABLE}
[junit4] 2> 110100 INFO (jetty-closer-92-thread-4) [ ] o.e.j.s.session
Stopped scavenging
[junit4] 2> 110136 INFO (coreCloseExecutor-321-thread-2)
[n:127.0.0.1:62530_solr c:delLiveColl s:shard1 r:core_node3
x:delLiveColl_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.delLiveColl.shard1.leader, tag=984113333
[junit4] 2> 110139 INFO (coreCloseExecutor-322-thread-2)
[n:127.0.0.1:62529_solr c:deleteByCount s:shard1 r:core_node3
x:deleteByCount_shard1_replica_t1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.deleteByCount.shard1.leader,
tag=2065620857
[junit4] 2> 110144 INFO (coreCloseExecutor-323-thread-2)
[n:127.0.0.1:62531_solr c:delLiveColl s:shard2 r:core_node7
x:delLiveColl_shard2_replica_n4] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.delLiveColl.shard2.leader, tag=850345470
[junit4] 2> 110149 INFO (jetty-closer-92-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3e42bc8{/solr,null,UNAVAILABLE}
[junit4] 2> 110151 INFO (jetty-closer-92-thread-1) [ ] o.e.j.s.session
Stopped scavenging
[junit4] 2> 110151 INFO (jetty-closer-92-thread-3) [ ]
o.a.s.c.Overseer Overseer
(id=72140803471179786-127.0.0.1:62529_solr-n_0000000000) closing
[junit4] 2> 110151 INFO
(OverseerStateUpdate-72140803471179786-127.0.0.1:62529_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:62529_solr
[junit4] 2> 110152 WARN
(OverseerAutoScalingTriggerThread-72140803471179786-127.0.0.1:62529_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 110157 INFO (jetty-closer-92-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@37e82628{/solr,null,UNAVAILABLE}
[junit4] 2> 110158 INFO (jetty-closer-92-thread-3) [ ] o.e.j.s.session
Stopped scavenging
[junit4] 2> 110158 INFO (zkCallback-123-thread-3) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:62531_solr
[junit4] 2> 110211 INFO (jetty-closer-92-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@be2e8fe{/solr,null,UNAVAILABLE}
[junit4] 2> 110212 INFO (jetty-closer-92-thread-2) [ ] o.e.j.s.session
Stopped scavenging
[junit4] 2> 110219 ERROR
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-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> 110220 INFO
(SUITE-DeleteReplicaTest-seed#[14A6D70693F0B86B]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:62526 62526
[junit4] 2> 110227 INFO (Thread-325) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:62526 62526
[junit4] 2> 112113 WARN (Thread-325) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 28
/solr/collections/deleteReplicaOnIndexing/terms/shard1
[junit4] 2> 23 /solr/collections/raceDeleteReplica/terms/shard1
[junit4] 2> 13 /solr/aliases.json
[junit4] 2> 13 /solr/clusterprops.json
[junit4] 2> 9 /solr/configs/conf
[junit4] 2> 8 /solr/collections/deleteByCountNew/terms/shard1
[junit4] 2> 8 /solr/collections/deleteByCountNew/terms/shard2
[junit4] 2> 8
/solr/collections/deletereplica_test/terms/shard1
[junit4] 2> 7 /solr/collections/delLiveColl/terms/shard2
[junit4] 2> 6 /solr/collections/deleteByCount/terms/shard1
[junit4] 2> 6 /solr/security.json
[junit4] 2> 5 /solr/collections/delLiveColl/terms/shard1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 43 /solr/collections/deleteByCountNew/state.json
[junit4] 2> 41 /solr/collections/raceDeleteReplica/state.json
[junit4] 2> 40 /solr/collections/delLiveColl/state.json
[junit4] 2> 21 /solr/collections/deleteByCount/state.json
[junit4] 2> 16 /solr/collections/deletereplica_test/state.json
[junit4] 2> 16
/solr/collections/deleteReplicaOnIndexing/state.json
[junit4] 2> 13 /solr/clusterstate.json
[junit4] 2> 3
/solr/collections/raceDeleteReplica/leader_elect/shard1/election/72140803471179785-core_node3-n_0000000000
[junit4] 2> 3
/solr/overseer_elect/election/72140803471179787-127.0.0.1:62531_solr-n_0000000001
[junit4] 2> 2
/solr/overseer_elect/election/72140803471179785-127.0.0.1:62530_solr-n_0000000002
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/live_nodes
[junit4] 2> 13 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest_14A6D70693F0B86B-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{id=PostingsFormat(name=Direct)},
docValues:{_version_=DocValuesFormat(name=Asserting),
id=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1010,
maxMBSortInHeap=6.7589958786367035, sim=RandomSimilarity(queryNorm=true): {},
locale=khq, timezone=America/Nome
[junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 9
(64-bit)/cpus=3,threads=1,free=91768048,total=329777152
[junit4] 2> NOTE: All tests run in this JVM: [DeleteReplicaTest,
DeleteReplicaTest]
[junit4] Completed [4/5 (1!)] on J0 in 61.73s, 6 tests, 1 error <<< FAILURES!
[...truncated 19 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/lucene/common-build.xml:1568:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/lucene/common-build.xml:1092:
There were test failures: 5 suites, 30 tests, 1 error [seed: 14A6D70693F0B86B]
Total time: 2 minutes 18 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 1/5 failed: org.apache.solr.cloud.DeleteReplicaTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all
warnings.
<Git Blamer> GIT_COMMIT=70b88068e82de2d90690513b14e55ae3e3ea43ec,
workspace=/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX
[WARNINGS] Computing warning deltas based on reference build #542
Recording test results
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
