Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21264/
Java: 32bit/jdk1.8.0_144 -server -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED:
org.apache.solr.cloud.autoscaling.sim.TestClusterStateProvider.testAutoScalingConfig
Error Message:
expected: org.apache.solr.client.solrj.cloud.autoscaling.AutoScalingConfig<{
"cluster-preferences":[{"maximize":"freedisk"}],
"triggers":{".auto_add_replicas":{ "name":".auto_add_replicas",
"event":"nodeLost", "waitFor":30, "actions":[ {
"name":"auto_add_replicas_plan",
"class":"solr.AutoAddReplicasPlanAction"}, {
"name":"execute_plan", "class":"solr.ExecutePlanAction"}],
"enabled":true}}, "listeners":{".auto_add_replicas.system":{
"trigger":".auto_add_replicas", "afterAction":[], "stage":[
"STARTED", "ABORTED", "SUCCEEDED", "FAILED",
"BEFORE_ACTION", "AFTER_ACTION", "IGNORED"],
"class":"org.apache.solr.cloud.autoscaling.SystemLogListener",
"beforeAction":[]}}, "properties":{}}> but was:
org.apache.solr.client.solrj.cloud.autoscaling.AutoScalingConfig<{
"cluster-preferences":[{"maximize":"freedisk"}],
"triggers":{".auto_add_replicas":{ "name":".auto_add_replicas",
"event":"nodeLost", "waitFor":30, "actions":[ {
"name":"auto_add_replicas_plan",
"class":"solr.AutoAddReplicasPlanAction"}, {
"name":"execute_plan", "class":"solr.ExecutePlanAction"}],
"enabled":true}}, "listeners":{".auto_add_replicas.system":{
"trigger":".auto_add_replicas", "afterAction":[], "stage":[
"STARTED", "ABORTED", "SUCCEEDED", "FAILED",
"BEFORE_ACTION", "AFTER_ACTION", "IGNORED"],
"class":"org.apache.solr.cloud.autoscaling.SystemLogListener",
"beforeAction":[]}}, "properties":{}}>
Stack Trace:
java.lang.AssertionError: expected:
org.apache.solr.client.solrj.cloud.autoscaling.AutoScalingConfig<{
"cluster-preferences":[{"maximize":"freedisk"}],
"triggers":{".auto_add_replicas":{
"name":".auto_add_replicas",
"event":"nodeLost",
"waitFor":30,
"actions":[
{
"name":"auto_add_replicas_plan",
"class":"solr.AutoAddReplicasPlanAction"},
{
"name":"execute_plan",
"class":"solr.ExecutePlanAction"}],
"enabled":true}},
"listeners":{".auto_add_replicas.system":{
"trigger":".auto_add_replicas",
"afterAction":[],
"stage":[
"STARTED",
"ABORTED",
"SUCCEEDED",
"FAILED",
"BEFORE_ACTION",
"AFTER_ACTION",
"IGNORED"],
"class":"org.apache.solr.cloud.autoscaling.SystemLogListener",
"beforeAction":[]}},
"properties":{}}> but was:
org.apache.solr.client.solrj.cloud.autoscaling.AutoScalingConfig<{
"cluster-preferences":[{"maximize":"freedisk"}],
"triggers":{".auto_add_replicas":{
"name":".auto_add_replicas",
"event":"nodeLost",
"waitFor":30,
"actions":[
{
"name":"auto_add_replicas_plan",
"class":"solr.AutoAddReplicasPlanAction"},
{
"name":"execute_plan",
"class":"solr.ExecutePlanAction"}],
"enabled":true}},
"listeners":{".auto_add_replicas.system":{
"trigger":".auto_add_replicas",
"afterAction":[],
"stage":[
"STARTED",
"ABORTED",
"SUCCEEDED",
"FAILED",
"BEFORE_ACTION",
"AFTER_ACTION",
"IGNORED"],
"class":"org.apache.solr.cloud.autoscaling.SystemLogListener",
"beforeAction":[]}},
"properties":{}}>
at
__randomizedtesting.SeedInfo.seed([E10BB4F5A3CD3B52:DE83B75DB49BCBB5]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:147)
at
org.apache.solr.cloud.autoscaling.sim.TestClusterStateProvider.testAutoScalingConfig(TestClusterStateProvider.java:214)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13540 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.sim.TestClusterStateProvider
[junit4] 2> 2480039 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/init-core-data-001
[junit4] 2> 2480040 WARN
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=21 numCloses=21
[junit4] 2> 2480040 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2480041 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2480041 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.c.a.s.TestClusterStateProvider ####### Using simulated components? false
[junit4] 2> 2480042 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001
[junit4] 2> 2480042 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2480042 INFO (Thread-7528) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2480042 INFO (Thread-7528) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2480043 ERROR (Thread-7528) [ ] 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> 2480142 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:37471
[junit4] 2> 2480144 INFO (zkConnectionManagerCallback-9517-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480145 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x160ebe68e1a0000, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2480147 INFO (jetty-launcher-9514-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2480147 INFO (jetty-launcher-9514-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2480147 INFO (jetty-launcher-9514-thread-3) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2480157 INFO (jetty-launcher-9514-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@18c5e3b{/solr,null,AVAILABLE}
[junit4] 2> 2480157 INFO (jetty-launcher-9514-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1565af1{/solr,null,AVAILABLE}
[junit4] 2> 2480157 INFO (jetty-launcher-9514-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@174da62{/solr,null,AVAILABLE}
[junit4] 2> 2480158 INFO (jetty-launcher-9514-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1554a35{SSL,[ssl,
http/1.1]}{127.0.0.1:45157}
[junit4] 2> 2480158 INFO (jetty-launcher-9514-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@79a247{SSL,[ssl,
http/1.1]}{127.0.0.1:45633}
[junit4] 2> 2480158 INFO (jetty-launcher-9514-thread-1) [ ]
o.e.j.s.Server Started @2481687ms
[junit4] 2> 2480158 INFO (jetty-launcher-9514-thread-3) [ ]
o.e.j.s.Server Started @2481687ms
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45157}
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45633}
[junit4] 2> 2480158 INFO (jetty-launcher-9514-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@17b03c5{SSL,[ssl,
http/1.1]}{127.0.0.1:42995}
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-2) [ ]
o.e.j.s.Server Started @2481687ms
[junit4] 2> 2480159 ERROR (jetty-launcher-9514-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2480159 ERROR (jetty-launcher-9514-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-12T19:44:03.726Z
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-12T19:44:03.726Z
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=42995}
[junit4] 2> 2480159 ERROR (jetty-launcher-9514-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 2480159 INFO (jetty-launcher-9514-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2480160 INFO (jetty-launcher-9514-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2480160 INFO (jetty-launcher-9514-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-12T19:44:03.727Z
[junit4] 2> 2480160 INFO (zkConnectionManagerCallback-9519-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480160 INFO (zkConnectionManagerCallback-9521-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480160 INFO (zkConnectionManagerCallback-9523-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480161 INFO (jetty-launcher-9514-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2480161 INFO (jetty-launcher-9514-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2480161 INFO (jetty-launcher-9514-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2480166 INFO (jetty-launcher-9514-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37471/solr
[junit4] 2> 2480166 INFO (jetty-launcher-9514-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37471/solr
[junit4] 2> 2480167 INFO (jetty-launcher-9514-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37471/solr
[junit4] 2> 2480167 INFO (zkConnectionManagerCallback-9531-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480167 INFO (zkConnectionManagerCallback-9533-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480167 INFO (zkConnectionManagerCallback-9535-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480168 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x160ebe68e1a0005, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2480168 INFO
(zkConnectionManagerCallback-9538-thread-1-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480168 INFO
(zkConnectionManagerCallback-9539-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480168 INFO
(zkConnectionManagerCallback-9541-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480198 INFO (jetty-launcher-9514-thread-3)
[n:127.0.0.1:45633_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2480198 INFO (jetty-launcher-9514-thread-1)
[n:127.0.0.1:45157_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2480198 INFO (jetty-launcher-9514-thread-2)
[n:127.0.0.1:42995_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2480199 INFO (jetty-launcher-9514-thread-3)
[n:127.0.0.1:45633_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:45633_solr
[junit4] 2> 2480199 INFO (jetty-launcher-9514-thread-1)
[n:127.0.0.1:45157_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45157_solr
[junit4] 2> 2480199 INFO (jetty-launcher-9514-thread-2)
[n:127.0.0.1:42995_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42995_solr
[junit4] 2> 2480199 INFO (jetty-launcher-9514-thread-3)
[n:127.0.0.1:45633_solr ] o.a.s.c.Overseer Overseer
(id=99338567261224967-127.0.0.1:45633_solr-n_0000000000) starting
[junit4] 2> 2480204 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2480204 INFO
(zkCallback-9537-thread-1-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2480204 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2480212 INFO (jetty-launcher-9514-thread-3)
[n:127.0.0.1:45633_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45633_solr
[junit4] 2> 2480212 INFO
(zkCallback-9537-thread-1-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2480212 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2480212 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2480290 INFO (jetty-launcher-9514-thread-1)
[n:127.0.0.1:45157_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45157.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480292 INFO (jetty-launcher-9514-thread-3)
[n:127.0.0.1:45633_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45633.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480295 INFO (jetty-launcher-9514-thread-1)
[n:127.0.0.1:45157_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45157.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480296 INFO (jetty-launcher-9514-thread-1)
[n:127.0.0.1:45157_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45157.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480297 INFO (jetty-launcher-9514-thread-1)
[n:127.0.0.1:45157_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node1/.
[junit4] 2> 2480300 INFO (jetty-launcher-9514-thread-3)
[n:127.0.0.1:45633_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45633.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480300 INFO (jetty-launcher-9514-thread-3)
[n:127.0.0.1:45633_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45633.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480301 INFO (jetty-launcher-9514-thread-3)
[n:127.0.0.1:45633_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node3/.
[junit4] 2> 2480350 INFO (jetty-launcher-9514-thread-2)
[n:127.0.0.1:42995_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42995.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480356 INFO (jetty-launcher-9514-thread-2)
[n:127.0.0.1:42995_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42995.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480356 INFO (jetty-launcher-9514-thread-2)
[n:127.0.0.1:42995_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42995.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2480357 INFO (jetty-launcher-9514-thread-2)
[n:127.0.0.1:42995_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node2/.
[junit4] 2> 2480391 INFO (zkConnectionManagerCallback-9549-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480393 INFO (zkConnectionManagerCallback-9553-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2480393 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 2480393 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37471/solr ready
[junit4] 2> 2480432 INFO (qtp28735931-30788) [n:127.0.0.1:42995_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
pullReplicas=1&replicationFactor=2&name=.system&nrtReplicas=2&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2480435 INFO
(OverseerThreadFactory-8317-thread-1-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.CreateCollectionCmd Create collection
.system
[junit4] 2> 2480538 INFO
(OverseerStateUpdate-99338567261224967-127.0.0.1:45633_solr-n_0000000000)
[n:127.0.0.1:45633_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45633/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2480539 INFO
(OverseerStateUpdate-99338567261224967-127.0.0.1:45633_solr-n_0000000000)
[n:127.0.0.1:45633_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45157/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2480540 INFO
(OverseerStateUpdate-99338567261224967-127.0.0.1:45633_solr-n_0000000000)
[n:127.0.0.1:45633_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_p4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:42995/solr";,
[junit4] 2> "type":"PULL",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2480743 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node6&collection.configName=.system&newCollection=true&name=.system_shard1_replica_p4&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=PULL
[junit4] 2> 2480743 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2480777 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node5&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n2&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2480777 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2480777 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2480778 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2480880 INFO
(zkCallback-9537-thread-1-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2480880 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2480880 INFO
(zkCallback-9540-thread-2-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2480880 INFO
(zkCallback-9536-thread-2-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2480880 INFO
(zkCallback-9537-thread-2-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2480880 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2481752 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2481755 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but
managed schema resource managed-schema not found - loading non-managed schema
schema.xml instead
[junit4] 2> 2481756 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.IndexSchema [.system_shard1_replica_p4] Schema name=_system collection
or core
[junit4] 2> 2481759 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid
field id
[junit4] 2> 2481759 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at
/configs/.system/managed-schema
[junit4] 2> 2481760 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in
ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to
/configs/.system/schema.xml.bak
[junit4] 2> 2481760 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_p4' using
configuration from collection .system, trusted=true
[junit4] 2> 2481761 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42995.solr.core..system.shard1.replica_p4' (registry
'solr.core..system.shard1.replica_p4') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2481761 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 2481761 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4] o.a.s.c.SolrCore
[[.system_shard1_replica_p4] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node2/.system_shard1_replica_p4],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node2/./.system_shard1_replica_p4/data/]
[junit4] 2> 2481783 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2481783 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2481788 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection
or core
[junit4] 2> 2481789 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection
or core
[junit4] 2> 2481799 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid
field id
[junit4] 2> 2481799 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n2' using
configuration from collection .system, trusted=true
[junit4] 2> 2481799 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid
field id
[junit4] 2> 2481799 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using
configuration from collection .system, trusted=true
[junit4] 2> 2481799 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45157.solr.core..system.shard1.replica_n2' (registry
'solr.core..system.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2481799 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 2481799 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2] o.a.s.c.SolrCore
[[.system_shard1_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node1/.system_shard1_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node1/./.system_shard1_replica_n2/data/]
[junit4] 2> 2481800 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45633.solr.core..system.shard1.replica_n1' (registry
'solr.core..system.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2481800 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 2481800 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.c.SolrCore
[[.system_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node3/.system_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node3/./.system_shard1_replica_n1/data/]
[junit4] 2> 2481803 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommited docs
[junit4] 2> 2481803 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2481804 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.SolrIndexSearcher Opening [Searcher@10b36a9[.system_shard1_replica_p4]
main]
[junit4] 2> 2481805 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/.system
[junit4] 2> 2481805 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 2481805 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/.system/managed-schema
[junit4] 2> 2481806 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 2481806 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2481807 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.c.ZkController .system_shard1_replica_p4 starting background replication
from leader
[junit4] 2> 2481807 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll
interval: 00:00:03
[junit4] 2> 2481807 INFO
(searcherExecutor-8324-thread-1-processing-n:127.0.0.1:42995_solr
x:.system_shard1_replica_p4 s:shard1 c:.system r:core_node6)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.c.SolrCore [.system_shard1_replica_p4]
Registered new searcher Searcher@10b36a9[.system_shard1_replica_p4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2481808 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms
[junit4] 2> 2481808 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2481829 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2481829 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2481830 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2481830 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2481830 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommited docs
[junit4] 2> 2481830 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2481831 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommited docs
[junit4] 2> 2481831 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2481831 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@16cb30f[.system_shard1_replica_n1]
main]
[junit4] 2> 2481832 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1adfc20[.system_shard1_replica_n2]
main]
[junit4] 2> 2481832 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/.system
[junit4] 2> 2481832 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 2481832 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/.system/managed-schema
[junit4] 2> 2481832 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 2481832 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/.system
[junit4] 2> 2481833 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 2481833 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/.system/managed-schema
[junit4] 2> 2481833 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 2481833 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2481833 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2481833 INFO
(searcherExecutor-8327-thread-1-processing-n:127.0.0.1:45633_solr
x:.system_shard1_replica_n1 s:shard1 c:.system r:core_node3)
[n:127.0.0.1:45633_solr c:.system s:shard1 r:core_node3
x:.system_shard1_replica_n1] o.a.s.c.SolrCore [.system_shard1_replica_n1]
Registered new searcher Searcher@16cb30f[.system_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2481833 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1589417078056550400
[junit4] 2> 2481834 INFO
(searcherExecutor-8326-thread-1-processing-n:127.0.0.1:45157_solr
x:.system_shard1_replica_n2 s:shard1 c:.system r:core_node5)
[n:127.0.0.1:45157_solr c:.system s:shard1 r:core_node5
x:.system_shard1_replica_n2] o.a.s.c.SolrCore [.system_shard1_replica_n2]
Registered new searcher Searcher@1adfc20[.system_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2481834 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1589417078057598976
[junit4] 2> 2481836 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2481836 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2481836 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:45633/solr/.system_shard1_replica_n1/
[junit4] 2> 2481836 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.u.PeerSync
PeerSync: core=.system_shard1_replica_n1 url=https://127.0.0.1:45633/solr START
replicas=[https://127.0.0.1:45157/solr/.system_shard1_replica_n2/] nUpdates=100
[junit4] 2> 2481838 INFO (qtp7633713-30790) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2] o.a.s.c.S.Request
[.system_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> 2481937 INFO
(zkCallback-9536-thread-2-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2481937 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2481937 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2481937 INFO
(zkCallback-9537-thread-3-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2481937 INFO
(zkCallback-9540-thread-2-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2481937 INFO
(zkCallback-9537-thread-2-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482137 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.u.PeerSync
PeerSync: core=.system_shard1_replica_n1 url=https://127.0.0.1:45633/solr DONE.
We have no versions. sync failed.
[junit4] 2> 2482137 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 2482137 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_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> 2482137 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 2482142 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:45633/solr/.system_shard1_replica_n1/ shard1
[junit4] 2> 2482243 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482243 INFO
(zkCallback-9536-thread-2-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482243 INFO
(zkCallback-9537-thread-3-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482243 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482243 INFO
(zkCallback-9537-thread-2-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482243 INFO
(zkCallback-9540-thread-2-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482259 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Replica core_node3 is leader
but it's state is down, skipping replication
[junit4] 2> 2482292 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2482326 INFO (qtp20959511-30789) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1548
[junit4] 2> 2482395 INFO
(zkCallback-9536-thread-2-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482395 INFO
(zkCallback-9537-thread-2-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482395 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482395 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482395 INFO
(zkCallback-9537-thread-3-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482395 INFO
(zkCallback-9540-thread-2-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482854 INFO (qtp7633713-30787) [n:127.0.0.1:45157_solr
c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n2&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2077
[junit4] 2> 2482859 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr
c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=.system&newCollection=true&name=.system_shard1_replica_p4&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=PULL}
status=0 QTime=2116
[junit4] 2> 2482862 INFO (qtp28735931-30788) [n:127.0.0.1:42995_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> 2482939 INFO
(zkCallback-9540-thread-2-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482939 INFO
(zkCallback-9536-thread-2-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482939 INFO
(zkCallback-9537-thread-3-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482939 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482939 INFO
(zkCallback-9537-thread-2-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2482939 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2483862 INFO (qtp28735931-30788) [n:127.0.0.1:42995_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={pullReplicas=1&replicationFactor=2&name=.system&nrtReplicas=2&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2}
status=0 QTime=3429
[junit4] 2> 2483867 INFO (qtp28735931-30791) [n:127.0.0.1:42995_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 2483870 INFO (qtp7633713-30790) [n:127.0.0.1:45157_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 2483874 INFO (qtp20959511-30806) [n:127.0.0.1:45633_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 2483906 INFO
(TEST-TestClusterStateProvider.testAutoScalingConfig-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.SolrTestCaseJ4 ###Starting testAutoScalingConfig
[junit4] 2> 2483909 INFO
(TEST-TestClusterStateProvider.testAutoScalingConfig-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.SolrTestCaseJ4 ###Ending testAutoScalingConfig
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestClusterStateProvider -Dtests.method=testAutoScalingConfig
-Dtests.seed=E10BB4F5A3CD3B52 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=es-ES -Dtests.timezone=Europe/Andorra -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 0.04s J0 | TestClusterStateProvider.testAutoScalingConfig
<<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:
org.apache.solr.client.solrj.cloud.autoscaling.AutoScalingConfig<{
[junit4] > "cluster-preferences":[{"maximize":"freedisk"}],
[junit4] > "triggers":{".auto_add_replicas":{
[junit4] > "name":".auto_add_replicas",
[junit4] > "event":"nodeLost",
[junit4] > "waitFor":30,
[junit4] > "actions":[
[junit4] > {
[junit4] > "name":"auto_add_replicas_plan",
[junit4] > "class":"solr.AutoAddReplicasPlanAction"},
[junit4] > {
[junit4] > "name":"execute_plan",
[junit4] > "class":"solr.ExecutePlanAction"}],
[junit4] > "enabled":true}},
[junit4] > "listeners":{".auto_add_replicas.system":{
[junit4] > "trigger":".auto_add_replicas",
[junit4] > "afterAction":[],
[junit4] > "stage":[
[junit4] > "STARTED",
[junit4] > "ABORTED",
[junit4] > "SUCCEEDED",
[junit4] > "FAILED",
[junit4] > "BEFORE_ACTION",
[junit4] > "AFTER_ACTION",
[junit4] > "IGNORED"],
[junit4] >
"class":"org.apache.solr.cloud.autoscaling.SystemLogListener",
[junit4] > "beforeAction":[]}},
[junit4] > "properties":{}}> but was:
org.apache.solr.client.solrj.cloud.autoscaling.AutoScalingConfig<{
[junit4] > "cluster-preferences":[{"maximize":"freedisk"}],
[junit4] > "triggers":{".auto_add_replicas":{
[junit4] > "name":".auto_add_replicas",
[junit4] > "event":"nodeLost",
[junit4] > "waitFor":30,
[junit4] > "actions":[
[junit4] > {
[junit4] > "name":"auto_add_replicas_plan",
[junit4] > "class":"solr.AutoAddReplicasPlanAction"},
[junit4] > {
[junit4] > "name":"execute_plan",
[junit4] > "class":"solr.ExecutePlanAction"}],
[junit4] > "enabled":true}},
[junit4] > "listeners":{".auto_add_replicas.system":{
[junit4] > "trigger":".auto_add_replicas",
[junit4] > "afterAction":[],
[junit4] > "stage":[
[junit4] > "STARTED",
[junit4] > "ABORTED",
[junit4] > "SUCCEEDED",
[junit4] > "FAILED",
[junit4] > "BEFORE_ACTION",
[junit4] > "AFTER_ACTION",
[junit4] > "IGNORED"],
[junit4] >
"class":"org.apache.solr.cloud.autoscaling.SystemLogListener",
[junit4] > "beforeAction":[]}},
[junit4] > "properties":{}}>
[junit4] > at
__randomizedtesting.SeedInfo.seed([E10BB4F5A3CD3B52:DE83B75DB49BCBB5]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.sim.TestClusterStateProvider.testAutoScalingConfig(TestClusterStateProvider.java:214)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2483926 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.SolrTestCaseJ4 ###Starting testAddRemoveNode
[junit4] 2> 2483927 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2483928 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@706c54{/solr,null,AVAILABLE}
[junit4] 2> 2483928 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.e.j.s.AbstractConnector Started ServerConnector@6b677e{SSL,[ssl,
http/1.1]}{127.0.0.1:43739}
[junit4] 2> 2483929 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.e.j.s.Server Started @2485457ms
[junit4] 2> 2483929 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=43739}
[junit4] 2> 2483929 ERROR
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2483929 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 2483929 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port
null
[junit4] 2> 2483929 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2483929 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-12T19:44:07.496Z
[junit4] 2> 2483930 INFO (zkConnectionManagerCallback-9555-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2483931 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2483937 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37471/solr
[junit4] 2> 2483937 INFO (zkConnectionManagerCallback-9559-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2483939 INFO
(zkConnectionManagerCallback-9561-thread-1-processing-n:127.0.0.1:43739_solr)
[n:127.0.0.1:43739_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2483941 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52])
[n:127.0.0.1:43739_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2483942 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52])
[n:127.0.0.1:43739_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2483942 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52])
[n:127.0.0.1:43739_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:43739_solr
[junit4] 2> 2483943 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2483943 INFO (zkCallback-9552-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2483943 INFO
(zkCallback-9560-thread-1-processing-n:127.0.0.1:43739_solr)
[n:127.0.0.1:43739_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2483943 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2483943 INFO
(zkCallback-9537-thread-2-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2484008 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52])
[n:127.0.0.1:43739_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43739.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2484015 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52])
[n:127.0.0.1:43739_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43739.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2484015 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52])
[n:127.0.0.1:43739_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43739.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@14a59d
[junit4] 2> 2484016 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52])
[n:127.0.0.1:43739_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001/tempDir-001/node4/.
[junit4] 2> 2484438 INFO
(OverseerCollectionConfigSetProcessor-99338567261224967-127.0.0.1:45633_solr-n_0000000000)
[n:127.0.0.1:45633_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2484808 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Last replication failed, so
I'll force replication
[junit4] 2> 2484808 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Updated masterUrl to
https://127.0.0.1:45633/solr/.system_shard1_replica_n1/
[junit4] 2> 2484810 INFO (qtp20959511-30802) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.c.S.Request
[.system_shard1_replica_n1] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 2484810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 2484810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 2484810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 2484810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 2484810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher New index in Master. Deleting
mine...
[junit4] 2> 2484810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2484810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16b7b35 commitCommandVersion:0
[junit4] 2> 2484811 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.s.SolrIndexSearcher Opening
[Searcher@13be061[.system_shard1_replica_p4] main]
[junit4] 2> 2484811 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2484812 INFO
(searcherExecutor-8324-thread-1-processing-n:127.0.0.1:42995_solr
x:.system_shard1_replica_p4 s:shard1 c:.system r:core_node6)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.c.SolrCore [.system_shard1_replica_p4]
Registered new searcher Searcher@13be061[.system_shard1_replica_p4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2486050 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.e.j.s.AbstractConnector Stopped ServerConnector@1554a35{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2486050 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.c.CoreContainer Shutting down CoreContainer instance=16100618
[junit4] 2> 2486050 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2486050 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@42a50b: rootName =
solr_45157, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@11c9f81
[junit4] 2> 2486060 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2486060 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@8486fe: rootName =
solr_45157, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@146b5c9
[junit4] 2> 2486065 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2486065 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e71424: rootName =
solr_45157, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@114f55d
[junit4] 2> 2486066 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:45157_solr
[junit4] 2> 2486067 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2486067 INFO
(zkCallback-9536-thread-1-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2486067 INFO
(zkCallback-9560-thread-1-processing-n:127.0.0.1:43739_solr)
[n:127.0.0.1:43739_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2486067 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2486067 INFO
(zkCallback-9540-thread-2-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2486067 INFO
(zkCallback-9537-thread-3-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2486067 INFO
(zkCallback-9536-thread-2-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2486067 INFO (zkCallback-9552-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2486067 INFO
(zkCallback-9537-thread-1-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2486067 INFO
(zkCallback-9540-thread-3-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2486067 INFO
(zkCallback-9537-thread-2-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2486067 INFO
(zkCallback-9536-thread-3-processing-n:127.0.0.1:45157_solr)
[n:127.0.0.1:45157_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/.system/state.json] for collection [.system] has occurred -
updating... (live nodes size: [3])
[junit4] 2> 2486067 INFO (coreCloseExecutor-8346-thread-1)
[n:127.0.0.1:45157_solr c:.system s:shard1 r:core_node5
x:.system_shard1_replica_n2] o.a.s.c.SolrCore [.system_shard1_replica_n2]
CLOSING SolrCore org.apache.solr.core.SolrCore@b334
[junit4] 2> 2486067 INFO (coreCloseExecutor-8346-thread-1)
[n:127.0.0.1:45157_solr c:.system s:shard1 r:core_node5
x:.system_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters
for registry=solr.core..system.shard1.replica_n2, tag=45876
[junit4] 2> 2486067 INFO (coreCloseExecutor-8346-thread-1)
[n:127.0.0.1:45157_solr c:.system s:shard1 r:core_node5
x:.system_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1892caa: rootName =
solr_45157, domain = solr.core..system.shard1.replica_n2, service url = null,
agent id = null] for registry solr.core..system.shard1.replica_n2 /
com.codahale.metrics.MetricRegistry@14bded5
[junit4] 2> 2486074 INFO (coreCloseExecutor-8346-thread-1)
[n:127.0.0.1:45157_solr c:.system s:shard1 r:core_node5
x:.system_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters
for registry=solr.collection..system.shard1.leader, tag=45876
[junit4] 2> 2486075 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@18c5e3b{/solr,null,UNAVAILABLE}
[junit4] 2> 2487809 INFO (qtp20959511-30806) [n:127.0.0.1:45633_solr
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1] o.a.s.c.S.Request
[.system_shard1_replica_n1] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 2487809 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 2487809 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 2487809 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 2487809 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher Slave's version: 1515786248377
[junit4] 2> 2487809 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.h.IndexFetcher New index in Master. Deleting
mine...
[junit4] 2> 2487810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2487810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16b7b35 commitCommandVersion:0
[junit4] 2> 2487810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.s.SolrIndexSearcher Opening
[Searcher@172eb2d[.system_shard1_replica_p4] main]
[junit4] 2> 2487810 INFO (indexFetcher-8331-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2487812 INFO
(searcherExecutor-8324-thread-1-processing-n:127.0.0.1:42995_solr
x:.system_shard1_replica_p4 s:shard1 c:.system r:core_node6)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.c.SolrCore [.system_shard1_replica_p4]
Registered new searcher Searcher@172eb2d[.system_shard1_replica_p4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2488076 INFO
(TEST-TestClusterStateProvider.testAddRemoveNode-seed#[E10BB4F5A3CD3B52]) [
] o.a.s.SolrTestCaseJ4 ###Ending testAddRemoveNode
[junit4] 2> 2488077 INFO (jetty-closer-9515-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@17b03c5{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2488077 INFO (jetty-closer-9515-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@79a247{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2488077 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=20541873
[junit4] 2> 2488078 INFO (jetty-closer-9515-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=28226354
[junit4] 2> 2488077 INFO (jetty-closer-9515-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@6b677e{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2488078 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2488078 INFO (jetty-closer-9515-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2488078 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@39f904: rootName =
solr_42995, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@1f6e964
[junit4] 2> 2488078 INFO (jetty-closer-9515-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@ee5068: rootName =
solr_45633, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@15047d
[junit4] 2> 2488078 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=4396622
[junit4] 2> 2488078 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2488078 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f39c9e: rootName =
solr_43739, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@1dc1c17
[junit4] 2> 2488083 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2488083 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@268de9: rootName =
solr_43739, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@146b5c9
[junit4] 2> 2488083 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2488083 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b6063a: rootName =
solr_42995, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@146b5c9
[junit4] 2> 2488083 INFO (jetty-closer-9515-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2488083 INFO (jetty-closer-9515-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1adc73a: rootName =
solr_45633, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@146b5c9
[junit4] 2> 2488086 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2488086 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e6305b: rootName =
solr_43739, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@114f55d
[junit4] 2> 2488087 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:43739_solr
[junit4] 2> 2488087 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2488087 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@16f8256: rootName =
solr_42995, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@114f55d
[junit4] 2> 2488087 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2488087 INFO
(zkCallback-9560-thread-1-processing-n:127.0.0.1:43739_solr)
[n:127.0.0.1:43739_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2488087 INFO
(zkCallback-9540-thread-3-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2488088 INFO (jetty-closer-9515-thread-3) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2488088 INFO
(zkCallback-9537-thread-2-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2488088 INFO (jetty-closer-9515-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2488088 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:42995_solr
[junit4] 2> 2488088 INFO (jetty-closer-9515-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1234349: rootName =
solr_45633, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@114f55d
[junit4] 2> 2488088 INFO (jetty-closer-9515-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@706c54{/solr,null,UNAVAILABLE}
[junit4] 2> 2488088 INFO (jetty-closer-9515-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2488088 INFO
(zkCallback-9540-thread-3-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 2488088 INFO
(zkCallback-9537-thread-1-processing-n:127.0.0.1:45633_solr)
[n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 2488089 INFO (coreCloseExecutor-8349-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.c.SolrCore [.system_shard1_replica_p4]
CLOSING SolrCore org.apache.solr.core.SolrCore@3ecb88
[junit4] 2> 2488089 INFO (coreCloseExecutor-8349-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.m.SolrMetricManager Closing metric reporters
for registry=solr.core..system.shard1.replica_p4, tag=4115336
[junit4] 2> 2488089 INFO (coreCloseExecutor-8349-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e1fa08: rootName =
solr_42995, domain = solr.core..system.shard1.replica_p4, service url = null,
agent id = null] for registry solr.core..system.shard1.replica_p4 /
com.codahale.metrics.MetricRegistry@1ef25bd
[junit4] 2> 2488089 INFO
(zkCallback-9540-thread-1-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEve
[...truncated too long message...]
ad-1) [n:127.0.0.1:45633_solr c:.system s:shard1 r:core_node3
x:.system_shard1_replica_n1] o.a.s.c.SolrCore [.system_shard1_replica_n1]
CLOSING SolrCore org.apache.solr.core.SolrCore@1b9812
[junit4] 2> 2488089 INFO (coreCloseExecutor-8350-thread-1)
[n:127.0.0.1:45633_solr c:.system s:shard1 r:core_node3
x:.system_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters
for registry=solr.core..system.shard1.replica_n1, tag=1808402
[junit4] 2> 2488089 INFO (coreCloseExecutor-8350-thread-1)
[n:127.0.0.1:45633_solr c:.system s:shard1 r:core_node3
x:.system_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e1a55e: rootName =
solr_45633, domain = solr.core..system.shard1.replica_n1, service url = null,
agent id = null] for registry solr.core..system.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@19c402f
[junit4] 2> 2488096 INFO (coreCloseExecutor-8350-thread-1)
[n:127.0.0.1:45633_solr c:.system s:shard1 r:core_node3
x:.system_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters
for registry=solr.collection..system.shard1.leader, tag=1808402
[junit4] 2> 2488097 INFO (jetty-closer-9515-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=99338567261224967-127.0.0.1:45633_solr-n_0000000000) closing
[junit4] 2> 2488097 INFO
(OverseerStateUpdate-99338567261224967-127.0.0.1:45633_solr-n_0000000000)
[n:127.0.0.1:45633_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:45633_solr
[junit4] 2> 2488097 WARN
(OverseerAutoScalingTriggerThread-99338567261224967-127.0.0.1:45633_solr-n_0000000000)
[n:127.0.0.1:45633_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2488097 INFO (coreCloseExecutor-8349-thread-1)
[n:127.0.0.1:42995_solr c:.system s:shard1 r:core_node6
x:.system_shard1_replica_p4] o.a.s.m.SolrMetricManager Closing metric reporters
for registry=solr.collection..system.shard1.leader, tag=4115336
[junit4] 2> 2488098 INFO
(zkCallback-9540-thread-2-processing-n:127.0.0.1:42995_solr)
[n:127.0.0.1:42995_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:42995_solr
[junit4] 2> 2488098 INFO (jetty-closer-9515-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@174da62{/solr,null,UNAVAILABLE}
[junit4] 2> 2489599 INFO (jetty-closer-9515-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1565af1{/solr,null,UNAVAILABLE}
[junit4] 2> 2489600 ERROR
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-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> 2489600 INFO
(SUITE-TestClusterStateProvider-seed#[E10BB4F5A3CD3B52]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:37471 37471
[junit4] 2> 2494633 INFO (Thread-7528) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:37471 37471
[junit4] 2> 2494634 WARN (Thread-7528) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 4 /solr/security.json
[junit4] 2> 3 /solr/configs/.system
[junit4] 2> 3 /solr/configs/.system/managed-schema
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 26 /solr/collections/.system/state.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 2
/solr/overseer_elect/election/99338567261224967-127.0.0.1:45633_solr-n_0000000000
[junit4] 2> 2 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 5 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestClusterStateProvider_E10BB4F5A3CD3B52-001
[junit4] 2> NOTE: test params are:
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
chunkSize=1, maxDocsPerChunk=504, blockSize=10),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
chunkSize=1, blockSize=10)),
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@14a003d),
locale=es-ES, timezone=Europe/Andorra
[junit4] 2> NOTE: Linux 4.13.0-26-generic i386/Oracle Corporation
1.8.0_144 (32-bit)/cpus=8,threads=1,free=105811960,total=518979584
[junit4] 2> NOTE: All tests run in this JVM:
[TestSha256AuthenticationProvider, TestRandomFaceting,
ResponseLogComponentTest, TestSearcherReuse, CoreAdminRequestStatusTest,
CustomHighlightComponentTest, TestGraphMLResponseWriter,
DistributedMLTComponentTest, PrimitiveFieldTypeTest, TestShardHandlerFactory,
RAMDirectoryFactoryTest, TestFreeTextSuggestions, TestReplicationHandlerBackup,
URLClassifyProcessorTest, TestReversedWildcardFilterFactory, SolrInfoBeanTest,
ExternalFileFieldSortTest, TestFieldCacheVsDocValues, DocValuesTest,
TestConfigReload, TestIndexingPerformance, TestReRankQParserPlugin,
TestFastOutputStream, TestGenericDistributedQueue, TestComputePlanAction,
TestHdfsCloudBackupRestore, MultiTermTest, NodeLostTriggerTest,
BasicDistributedZkTest, TestSQLHandler, CloudMLTQParserTest,
TestSuggestSpellingConverter, TestPolicyCloud, CdcrBootstrapTest,
TestSolrCloudWithSecureImpersonation, TestDFRSimilarityFactory,
DistributedQueueTest, ResourceLoaderTest, BasicAuthIntegrationTest, TestUtils,
TestInPlaceUpdatesDistrib, TestSort, TestStreamBody, TestConfigOverlay,
SimpleFacetsTest, HdfsDirectoryFactoryTest, HLLUtilTest,
TestManagedSynonymGraphFilterFactory, SolrPluginUtilsTest,
AssignBackwardCompatibilityTest, TestMiniSolrCloudClusterSSL,
SuggestComponentTest, DeleteReplicaTest,
PreAnalyzedFieldManagedSchemaCloudTest, FastVectorHighlighterTest,
NoCacheHeaderTest, SpatialRPTFieldTypeTest, TestBinaryField,
TestCloudDeleteByQuery, DocumentBuilderTest, AnalysisAfterCoreReloadTest,
JsonLoaderTest, UpdateParamsTest, TestPHPSerializedResponseWriter,
TestSolr4Spatial2, IgnoreCommitOptimizeUpdateProcessorFactoryTest,
TestInitParams, MergeStrategyTest, HdfsLockFactoryTest, TestLegacyNumericUtils,
TestPointFields, TestEmbeddedSolrServerSchemaAPI, SpellCheckComponentTest,
TestTestInjection, TestUniqueKeyFieldResource, TestSolrDeletionPolicy1,
CollectionStateFormat2Test, TestFoldingMultitermQuery, TestConfigSets,
TestNodeLostTrigger, ResponseHeaderTest, FileUtilsTest, TestScoreJoinQPNoScore,
DistributedFacetPivotSmallAdvancedTest, SliceStateTest, SSLMigrationTest,
ActionThrottleTest, TestDocBasedVersionConstraints, TestFilteredDocIdSet,
DeleteInactiveReplicaTest, CheckHdfsIndexTest, TestSolrQueryResponse,
TestSegmentSorting, TestHttpShardHandlerFactory, TestPostingsSolrHighlighter,
RequestLoggingTest, MoveReplicaHDFSTest, TestPhraseSuggestions,
TestPullReplica, MinimalSchemaTest, LeaderElectionContextKeyTest,
TestLeaderInitiatedRecoveryThread, TestCrossCoreJoin, TestUseDocValuesAsStored,
TestSweetSpotSimilarityFactory, SegmentsInfoRequestHandlerTest, TestConfig,
SolrCloudReportersTest, HttpTriggerListenerTest, GraphQueryTest,
TestHighlightDedupGrouping, TestOverriddenPrefixQueryForCustomFieldType,
QueryParsingTest, TestSolrXml, CdcrRequestHandlerTest, BasicFunctionalityTest,
TestSolrCloudWithHadoopAuthPlugin, TestQueryUtils, CollectionsAPISolrJTest,
DocValuesMissingTest, TestJoin, TestQueryWrapperFilter,
TestExactSharedStatsCache, SolrMetricsIntegrationTest, ZkSolrClientTest,
ShardRoutingCustomTest, TestDistributedSearch, TestStressVersions,
TestCoreContainer, SolrCoreTest, PeerSyncTest, TestIndexSearcher,
DistributedQueryElevationComponentTest, SolrIndexSplitterTest,
TestExtendedDismaxParser, SpellCheckCollatorTest, CoreAdminHandlerTest,
SuggesterTSTTest, SuggesterTest, TestStressLucene, SpatialFilterTest,
TestCSVLoader, PolyFieldTest, WordBreakSolrSpellCheckerTest,
SolrCoreCheckLockOnStartupTest, TestUpdate, FieldMutatingUpdateProcessorTest,
TestWordDelimiterFilterFactory, QueryEqualityTest,
DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest,
StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest,
DocValuesMultiTest, DebugComponentTest, CacheHeaderTest,
DisMaxRequestHandlerTest, TermsComponentTest, RequestHandlersTest,
TermVectorComponentTest, RequiredFieldsTest, FieldAnalysisRequestHandlerTest,
TestSolrQueryParser, IndexSchemaRuntimeFieldTest, LoggingHandlerTest,
RegexBoostProcessorTest, TestJmxIntegration, TestCollationField,
UpdateRequestProcessorFactoryTest, MBeansHandlerTest,
BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication,
PingRequestHandlerTest, TestComponentsName, SearchHandlerTest, TestLFUCache,
TestMergePolicyConfig, OutputWriterTest, TestSolrCoreProperties,
TestXIncludeConfig, TestPerFieldSimilarity, TestLMDirichletSimilarityFactory,
TestFastWriter, PluginInfoTest, ChaosMonkeyNothingIsSafeTest,
CleanupOldIndexTest, CollectionsAPIAsyncDistributedZkTest,
DistribDocExpirationUpdateProcessorTest, HttpPartitionTest,
LeaderInitiatedRecoveryOnCommitTest, MultiThreadedOCPTest,
PeerSyncReplicationTest, SolrCLIZkUtilsTest, TestCloudInspectUtil,
TestCloudPivotFacet, TestCollectionsAPIViaSolrCloudCluster,
TestConfigSetsAPIZkFailure, TestDeleteCollectionOnDownNodes,
TestDownShardTolerantSearch, TestLeaderElectionZkExpiry,
TestLocalFSCloudBackupRestore, TestPrepRecovery, TestRandomRequestDistribution,
TestSolrCloudWithKerberosAlt, TestStressLiveNodes,
TriLevelCompositeIdRoutingTest, AutoAddReplicasIntegrationTest,
TestClusterStateProvider]
[junit4] Completed [578/767 (1!)] on J0 in 14.63s, 2 tests, 1 failure <<<
FAILURES!
[...truncated 44498 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
