Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/370/
1 tests failed.
FAILED:
org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testSelectedCollectionsByPolicy
Error Message:
Stack Trace:
java.util.ConcurrentModificationException
at
__randomizedtesting.SeedInfo.seed([956FAA7E3E148B4D:39A6D466B3225F84]:0)
at java.util.ArrayList$Itr.checkForComodification(ArrayList.java:909)
at java.util.ArrayList$Itr.next(ArrayList.java:859)
at java.util.AbstractCollection.toString(AbstractCollection.java:461)
at java.lang.String.valueOf(String.java:2994)
at java.lang.StringBuilder.append(StringBuilder.java:131)
at java.util.AbstractMap.toString(AbstractMap.java:559)
at java.lang.String.valueOf(String.java:2994)
at java.lang.StringBuilder.append(StringBuilder.java:131)
at
org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testCollectionsPredicate(ComputePlanActionTest.java:566)
at
org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testSelectedCollectionsByPolicy(ComputePlanActionTest.java:476)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 15106 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.ComputePlanActionTest
[junit4] 2> 1673559 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1673561 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001/data-dir-135-001
[junit4] 2> 1673561 WARN
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=24 numCloses=24
[junit4] 2> 1673561 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1673563 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1673563 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1673563 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001/tempDir-001
[junit4] 2> 1673563 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1673564 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1673564 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1673565 WARN (ZkTestServer Run Thread) [ ]
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 1673664 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port: 44389
[junit4] 2> 1673664 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:44389
[junit4] 2> 1673664 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44389
[junit4] 2> 1673664 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 44389
[junit4] 2> 1673665 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1673668 INFO (zkConnectionManagerCallback-16683-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1673668 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1673670 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1673671 INFO (zkConnectionManagerCallback-16685-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1673671 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1673672 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1673673 INFO (zkConnectionManagerCallback-16687-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1673673 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1673775 WARN (jetty-launcher-16688-thread-1) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 1673775 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1673775 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1673775 INFO (jetty-launcher-16688-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 1.8.0_252-b09
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@334a031d{/solr,null,AVAILABLE}
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@79515469{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:36277}
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.e.j.s.Server Started @1673808ms
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36277}
[junit4] 2> 1673779 ERROR (jetty-launcher-16688-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.7.0
[junit4] 2> 1673779 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1673780 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 1673780 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-09-23T10:10:14.178Z
[junit4] 2> 1673781 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1673781 INFO (zkConnectionManagerCallback-16690-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1673781 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1673781 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1673786 WARN
(jetty-launcher-16688-thread-1-SendThread(127.0.0.1:44389)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x100715e587a0003.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x100715e587a0003, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x100715e587a0003, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1674462 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1674463 WARN (jetty-launcher-16688-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@4244b355[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1674463 WARN (jetty-launcher-16688-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@4244b355[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1674467 WARN (jetty-launcher-16688-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@1ac90788[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1674467 WARN (jetty-launcher-16688-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@1ac90788[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1674468 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44389/solr
[junit4] 2> 1674469 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1674471 INFO (zkConnectionManagerCallback-16700-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1674471 INFO (jetty-launcher-16688-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1674573 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1674574 INFO (zkConnectionManagerCallback-16702-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1674574 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1674688 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:36277_solr
[junit4] 2> 1674694 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer Overseer
(id=72182244063182853-127.0.0.1:36277_solr-n_0000000000) starting
[junit4] 2> 1674707 INFO
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:36277_solr
[junit4] 2> 1674712 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36277_solr
[junit4] 2> 1674723 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1674726 INFO (zkCallback-16701-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1674729 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1674729 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1674729 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1674732 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1674732 WARN (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 1674748 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:36277_solr]
[junit4] 2> 1674749 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1674750 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1674750 DEBUG (ScheduledTrigger-16707-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 1 and last live nodes: 1
[junit4] 2> 1674752 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1674782 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36277.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4d71fd72
[junit4] 2> 1674803 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36277.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4d71fd72
[junit4] 2> 1674803 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36277.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4d71fd72
[junit4] 2> 1674804 INFO (jetty-launcher-16688-thread-1)
[n:127.0.0.1:36277_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001/tempDir-001/node1
[junit4] 2> 1674816 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 1674817 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1674818 INFO (zkConnectionManagerCallback-16719-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1674818 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1674819 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1674820 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44389/solr ready
[junit4] 2> 1674836 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testNodeAdded
[junit4] 2> 1674837 DEBUG (zkCallback-16701-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1674837 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1674838 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1674840 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1674841 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1674844 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1674844 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1674844 DEBUG (qtp2006365419-26288) [n:127.0.0.1:36277_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1674845 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 1674845 DEBUG (zkCallback-16701-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1674846 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1674846 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1674847 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1674849 INFO (qtp2006365419-26287) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1674849 DEBUG (qtp2006365419-26291) [n:127.0.0.1:36277_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1674849 INFO (qtp2006365419-26291) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 1674850 DEBUG (zkCallback-16701-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
4
[junit4] 2> 1674850 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 4
[junit4] 2> 1674850 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1674850 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4,
lastZnodeVersion 4
[junit4] 2> 1674854 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1674854 DEBUG (qtp2006365419-26289) [n:127.0.0.1:36277_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1674855 INFO (qtp2006365419-26289) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 1674855 DEBUG (zkCallback-16701-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
5
[junit4] 2> 1674856 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 5
[junit4] 2> 1674857 INFO (qtp2006365419-26287) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1674857 DEBUG (qtp2006365419-26288) [n:127.0.0.1:36277_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1674857 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger -
Initial livenodes: [127.0.0.1:36277_solr]
[junit4] 2> 1674857 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger
instantiated with properties: {event=nodeAdded, waitFor=1,
actions=[{name=compute_plan, class=solr.ComputePlanAction}, {name=test,
class=org.apache.solr.cloud.autoscaling.ComputePlanActionTest$AssertingTriggerAction}],
enabled=true}
[junit4] 2> 1674858 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 1674858 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1674858 DEBUG (zkCallback-16701-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
6
[junit4] 2> 1674858 INFO (qtp2006365419-26291) [n:127.0.0.1:36277_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf&maxShardsPerNode=2&name=testNodeAdded&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1674859 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1674859 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6,
lastZnodeVersion 5
[junit4] 2> 1674859 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 6
[junit4] 2> 1674859 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 1674859 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1674860 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6,
lastZnodeVersion 6
[junit4] 2> 1674865 INFO
(OverseerThreadFactory-16709-thread-1-processing-n:127.0.0.1:36277_solr)
[n:127.0.0.1:36277_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testNodeAdded
[junit4] 2> 1674869 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "name":"testNodeAdded",
[junit4] 2> "fromApi":"true",
[junit4] 2> "collection.configName":"conf",
[junit4] 2> "numShards":"1",
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 1674869 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ClusterStateMutator building a new
cName: testNodeAdded
[junit4] 2> 1674869 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ZkStateWriter going to
create_collection /collections/testNodeAdded/state.json
[junit4] 2> 1674980 WARN
(OverseerThreadFactory-16709-thread-1-processing-n:127.0.0.1:36277_solr)
[n:127.0.0.1:36277_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number
of replicas of 2 on collection testNodeAdded is higher than the number of Solr
instances currently live or live and part of your createNodeSet(1). It's
unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 1674984 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1674997 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1674997 INFO
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1675002 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 1675002 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1675003 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 2,
message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1675003 INFO
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1675006 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1675006 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1675107 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ZkStateWriter going to
update_collection /collections/testNodeAdded/state.json version: 0
[junit4] 2> 1675214 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
x:testNodeAdded_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n1&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1675214 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
x:testNodeAdded_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n2&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1675220 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1675220 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 1675220 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Will update state for
replica: core_node3:{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 1675220 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Collection is now:
DocCollection(testNodeAdded//collections/testNodeAdded/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 1675225 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 2,
message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1675225 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 1675225 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Will update state for
replica: core_node4:{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 1675225 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Collection is now:
DocCollection(testNodeAdded//collections/testNodeAdded/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 1675233 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
[junit4] 2> 1675234 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
[junit4] 2> 1675244 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 1675245 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 1675248 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1675248 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.CoreContainer Creating SolrCore 'testNodeAdded_shard1_replica_n1' using
configuration from configset conf, trusted=true
[junit4] 2> 1675258 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36277.solr.core.testNodeAdded.shard1.replica_n1' (registry
'solr.core.testNodeAdded.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4d71fd72
[junit4] 2> 1675258 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.SolrCore [[testNodeAdded_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001/tempDir-001/node1/testNodeAdded_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001/tempDir-001/node1/testNodeAdded_shard1_replica_n1/data/]
[junit4] 2> 1675258 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1675258 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.c.CoreContainer Creating SolrCore 'testNodeAdded_shard1_replica_n2' using
configuration from configset conf, trusted=true
[junit4] 2> 1675259 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36277.solr.core.testNodeAdded.shard1.replica_n2' (registry
'solr.core.testNodeAdded.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4d71fd72
[junit4] 2> 1675259 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.c.SolrCore [[testNodeAdded_shard1_replica_n2] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001/tempDir-001/node1/testNodeAdded_shard1_replica_n2],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001/tempDir-001/node1/testNodeAdded_shard1_replica_n2/data/]
[junit4] 2> 1675321 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1675321 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1675323 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1675323 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1675326 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ZkStateWriter going to
update_collection /collections/testNodeAdded/state.json version: 1
[junit4] 2> 1675327 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1675328 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1675330 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1675330 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1678618987832803328
[junit4] 2> 1675339 INFO
(searcherExecutor-16723-thread-1-processing-n:127.0.0.1:36277_solr
x:testNodeAdded_shard1_replica_n1 c:testNodeAdded s:shard1 r:core_node3)
[n:127.0.0.1:36277_solr c:testNodeAdded s:shard1 r:core_node3
x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.SolrCore
[testNodeAdded_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1675356 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/testNodeAdded/terms/shard1 to Terms{values={core_node3=0},
version=0}
[junit4] 2> 1675356 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/testNodeAdded/leaders/shard1
[junit4] 2> 1675366 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded"} current state version: 0
[junit4] 2> 1675366 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoute in=9998ms
[junit4] 2> 1675367 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1675367 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1675368 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1675368 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1675372 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1675372 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1675372 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1675373 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1678618987877892096
[junit4] 2> 1675376 INFO
(searcherExecutor-16725-thread-1-processing-n:127.0.0.1:36277_solr
x:testNodeAdded_shard1_replica_n2 c:testNodeAdded s:shard1 r:core_node4)
[n:127.0.0.1:36277_solr c:testNodeAdded s:shard1 r:core_node4
x:testNodeAdded_shard1_replica_n2 ] o.a.s.c.SolrCore
[testNodeAdded_shard1_replica_n2] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1675378 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/testNodeAdded/terms/shard1 to Terms{values={core_node3=0,
core_node4=0}, version=1}
[junit4] 2> 1675378 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/testNodeAdded/leaders/shard1
[junit4] 2> 1675471 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ZkStateWriter going to
update_collection /collections/testNodeAdded/state.json version: 2
[junit4] 2> 1675860 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1675860 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 1675867 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1675867 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1675867 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:36277/solr/testNodeAdded_shard1_replica_n1/
[junit4] 2> 1675868 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.u.PeerSync PeerSync: core=testNodeAdded_shard1_replica_n1
url=http://127.0.0.1:36277/solr START
replicas=[http://127.0.0.1:36277/solr/testNodeAdded_shard1_replica_n2/]
nUpdates=100
[junit4] 2> 1675869 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.u.PeerSync PeerSync: core=testNodeAdded_shard1_replica_n1
url=http://127.0.0.1:36277/solr DONE. We have no versions. sync failed.
[junit4] 2> 1675869 INFO (qtp2006365419-26289) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ]
o.a.s.c.S.Request [testNodeAdded_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> 1675870 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 1675870 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_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> 1675870 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/testNodeAdded/leaders/shard1/leader after winning as
/collections/testNodeAdded/leader_elect/shard1/election/72182244063182853-core_node3-n_0000000000
[junit4] 2> 1675872 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:36277/solr/testNodeAdded_shard1_replica_n1/ shard1
[junit4] 2> 1675872 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "state":"active"} current state version: 0
[junit4] 2> 1675973 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ZkStateWriter going to
update_collection /collections/testNodeAdded/state.json version: 3
[junit4] 2> 1675973 INFO (zkCallback-16701-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 1675974 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1675975 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1675975 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 1675975 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Will update state for
replica: core_node3:{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"}
[junit4] 2> 1675975 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Collection is now:
DocCollection(testNodeAdded//collections/testNodeAdded/state.json/4)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 1675976 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n1&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=761
[junit4] 2> 1676076 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ZkStateWriter going to
update_collection /collections/testNodeAdded/state.json version: 4
[junit4] 2> 1676077 INFO (zkCallback-16701-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 1676077 INFO (zkCallback-16701-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 1676384 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n2&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1170
[junit4] 2> 1676385 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1676385 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 1676385 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Will update state for
replica: core_node4:{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 1676385 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ReplicaMutator Collection is now:
DocCollection(testNodeAdded//collections/testNodeAdded/state.json/5)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr";,
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 1676387 INFO (qtp2006365419-26291) [n:127.0.0.1:36277_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 45 seconds. Check all shard replicas
[junit4] 2> 1676486 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.ZkStateWriter going to
update_collection /collections/testNodeAdded/state.json version: 5
[junit4] 2> 1676487 INFO (zkCallback-16701-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 1676487 INFO (zkCallback-16701-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 1676487 INFO (qtp2006365419-26291) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf&maxShardsPerNode=2&name=testNodeAdded&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=1628
[junit4] 2> 1676488 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.SolrCloudTestCase waitForState (testNodeAdded): Timed out waiting for
replicas of new collection to be active
[junit4] 2> 1676492 INFO (qtp2006365419-26289) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.testNodeAdded.shard1.replica_n1:INDEX.sizeInBytes&key=solr.core.testNodeAdded.shard1.replica_n2:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1676493 INFO (qtp2006365419-26288) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1676494 DEBUG (qtp2006365419-26287) [n:127.0.0.1:36277_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1676494 INFO (qtp2006365419-26287) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=4
[junit4] 2> 1676495 WARN
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 1676495 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1676495 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1676495 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 1.8.0_252-b09
[junit4] 2> 1676495 DEBUG (zkCallback-16701-thread-3) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
7
[junit4] 2> 1676495 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 7
[junit4] 2> 1676496 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1676496 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1676496 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1676496 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1676496 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1c88983f{/solr,null,AVAILABLE}
[junit4] 2> 1676497 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@36bce7cd{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:40293}
[junit4] 2> 1676497 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.s.Server Started @1676526ms
[junit4] 2> 1676497 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=40293}
[junit4] 2> 1676497 DEBUG
(OverseerAutoScalingTriggerThread-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 7,
lastZnodeVersion 7
[junit4] 2> 1676497 ERROR
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1676497 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1676497 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.7.0
[junit4] 2> 1676497 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1676497 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 1676497 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-09-23T10:10:16.895Z
[junit4] 2> 1676502 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1676503 INFO (zkConnectionManagerCallback-16735-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1676503 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1676503 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1676509 WARN
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]-SendThread(127.0.0.1:44389))
[ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for
session 0x100715e587a0007.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x100715e587a0007, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x100715e587a0007, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1676860 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1676860 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 1676866 INFO
(OverseerCollectionConfigSetProcessor-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_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> 1677104 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1677105 WARN
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@61d2ea79[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1677105 WARN
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@61d2ea79[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1677108 WARN
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@320cc5f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1677108 WARN
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@320cc5f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1677109 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44389/solr
[junit4] 2> 1677110 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1677115 INFO (zkConnectionManagerCallback-16745-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1677115 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1677226 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1677231 INFO (zkConnectionManagerCallback-16747-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1677231 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1677238 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1677241 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:40293_solr as DOWN
[junit4] 2> 1677242 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1677242 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40293_solr
[junit4] 2> 1677242 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:40293_solr"} current state version: 0
[junit4] 2> 1677242 DEBUG
(OverseerStateUpdate-72182244063182853-127.0.0.1:36277_solr-n_0000000000)
[n:127.0.0.1:36277_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for
node: 127.0.0.1:40293_solr
[junit4] 2> 1677244 INFO (zkCallback-16718-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1677244 INFO (zkCallback-16701-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1677244 INFO (zkCallback-16718-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1677245 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1677246 WARN
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 1677255 INFO (zkCallback-16746-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1677267 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1677287 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40293.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4d71fd72
[junit4] 2> 1677297 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40293.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4d71fd72
[junit4] 2> 1677297 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40293.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4d71fd72
[junit4] 2> 1677298 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D])
[n:127.0.0.1:40293_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001/tempDir-001/node2
[junit4] 2> 1677860 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1677861 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1677861 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:40293_solr at time
1902012736840142
[junit4] 2> 1678862 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1678862 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1678862 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger firing
registered processor for nodes: [127.0.0.1:40293_solr] added at times
[1902012736840142], now=1902013737930097
[junit4] 2> 1678862 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"6c1ded989a1ceT121z5qiqw96yaz2y1wf0wlouu",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1902012736840142,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1902012736840142],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "nodeNames":["127.0.0.1:40293_solr"],
[junit4] 2> "replicaType":"NRT"}}
[junit4] 2> 1678862 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [node_added_trigger]
[junit4] 2> 1678863 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
[junit4] 2> "id":"6c1ded989a1ceT121z5qiqw96yaz2y1wf0wlouu",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1902012736840142,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1902012736840142],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueue_time_":1902013738623916,
[junit4] 2> "nodeNames":["127.0.0.1:40293_solr"],
[junit4] 2> "replicaType":"NRT"}}
[junit4] 2> 1678863 DEBUG (ScheduledTrigger-16707-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Removing new node from tracking: 127.0.0.1:40293_solr
[junit4] 2> 1678863 DEBUG (AutoscalingActionExecutor-16708-thread-1) [
] o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"6c1ded989a1ceT121z5qiqw96yaz2y1wf0wlouu",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1902012736840142,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1902012736840142],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueue_time_":1902013738623916,
[junit4] 2> "nodeNames":["127.0.0.1:40293_solr"],
[junit4] 2> "replicaType":"NRT"}}
[junit4] 2> 1678864 DEBUG (AutoscalingActionExecutor-16708-thread-1) [
] o.a.s.c.a.ComputePlanAction -- processing event: {
[junit4] 2> "id":"6c1ded989a1ceT121z5qiqw96yaz2y1wf0wlouu",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1902012736840142,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1902012736840142],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueue_time_":1902013738623916,
[junit4] 2> "nodeNames":["127.0.0.1:40293_solr"],
[junit4] 2> "replicaType":"NRT"}} with context properties:
{BEFORE_ACTION=[compute_plan]}
[junit4] 2> 1678865 INFO (qtp2006365419-26290) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.testNodeAdded.shard1.replica_n1:INDEX.sizeInBytes&key=solr.core.testNodeAdded.shard1.replica_n2:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1678867 INFO (qtp2006365419-26291) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1678868 INFO (qtp616175040-26342) [n:127.0.0.1:40293_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1678869 DEBUG (AutoscalingActionExecutor-16708-thread-1) [
] o.a.s.c.a.ComputePlanAction Computed Plan:
action=MOVEREPLICA&collection=testNodeAdded&targetNode=127.0.0.1:40293_solr&inPlaceMove=true&replica=core_node3
[junit4] 2> 1678869 DEBUG (AutoscalingActionExecutor-16708-thread-1) [
] o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
[junit4] 2> "id":"6c1ded989a1ceT121z5qiqw96yaz2y1wf0wlouu",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1902012736840142,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1902012736840142],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueue_time_":1902013738623916,
[junit4] 2> "nodeNames":["127.0.0.1:40293_solr"],
[junit4] 2> "replicaType":"NRT"}}
[junit4] 2> 1678869 DEBUG (AutoscalingActionExecutor-16708-thread-1) [
] o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
[junit4] 2> "id":"6c1ded989a1ceT121z5qiqw96yaz2y1wf0wlouu",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1902012736840142,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1902012736840142],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueue_time_":1902013738623916,
[junit4] 2> "nodeNames":["127.0.0.1:40293_solr"],
[junit4] 2> "replicaType":"NRT"}}
[junit4] 2> 1678869 DEBUG
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.a.ComputePlanActionTest -------------_ FINAL STATE --------------
[junit4] 2> 1678870 INFO (qtp2006365419-26289) [n:127.0.0.1:36277_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 1678871 DEBUG
(TEST-ComputePlanActionTest.testNodeAdded-seed#[956FAA7E3E148B4D]) [ ]
o.a.s.c.a.ComputePlanActionTest * Node values: 127.0.0.1:36277_solr
[junit4] 2> {
[junit4] 2> "node":"127.0.0.1:36277_solr",
[junit4] 2> "cores":2,
[junit4] 2> "port":"36277",
[junit4] 2> "host":"127.0.0.1",
[junit4] 2> "ip_1":"1",
[junit4] 2> "ip_3":"0",
[junit4] 2> "ip_2":"0",
[junit4] 2> "ip_4":"127",
[junit4] 2> "freedisk":150.05686950683594}
[junit4] 2> 1678871 DEBUG (AutoscalingActionExecutor-16708-thread-1) [
] o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
[junit4] 2> "id":"6c1ded989a1ceT121z5qiqw96yaz2y1wf0wlouu",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1902012736840142,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1902012736840142],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueu
[...truncated too long message...]
licaType_1Shard_0/state.json
[junit4] 2> 3
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_0/terms/shard1
[junit4] 2> 3
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_2/state.json
[junit4] 2> 3 /solr/collections/testNodeAdded/terms/shard1
[junit4] 2> 3
/solr/collections/testNodeLostTriggerWithDeleteNodePreferredOp_0/state.json
[junit4] 2> 2
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_4/state.json
[junit4] 2> 2
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_1/state.json
[junit4] 2> 2
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_0/terms/shard2
[junit4] 2> 2
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_3/state.json
[junit4] 2> 2
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_4/state.json
[junit4] 2> 2
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_0/terms/shard1
[junit4] 2> 2
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_0/terms/shard1
[junit4] 2> 2
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_3/state.json
[junit4] 2> 2
/solr/collections/testNodeWithMultipleReplicasLost/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 119 /solr/collections/testSelected1/state.json
[junit4] 2> 114 /solr/collections/testSelected3/state.json
[junit4] 2> 106 /solr/collections/testSelected2/state.json
[junit4] 2> 52 /solr/aliases.json
[junit4] 2> 49
/solr/collections/testNodeWithMultipleReplicasLost/state.json
[junit4] 2> 48
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_2/state.json
[junit4] 2> 45
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_1/state.json
[junit4] 2> 43 /solr/autoscaling.json
[junit4] 2> 38
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_3/state.json
[junit4] 2> 30
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_1/state.json
[junit4] 2> 30
/solr/collections/testNodeLostTriggerWithDeleteNodePreferredOp_0/state.json
[junit4] 2> 28
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_4/state.json
[junit4] 2> 28
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_2/state.json
[junit4] 2> 28
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_1/state.json
[junit4] 2> 27
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_4/state.json
[junit4] 2> 27 /solr/clusterstate.json
[junit4] 2> 24
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_2/state.json
[junit4] 2> 22
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_4/state.json
[junit4] 2> 20
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_3/state.json
[junit4] 2> 20
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_3/state.json
[junit4] 2> 17
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_0/state.json
[junit4] 2> 16
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_0/state.json
[junit4] 2> 15 /solr/collections/testNodeAdded/state.json
[junit4] 2> 12
/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_0/state.json
[junit4] 2> 8
/solr/overseer_elect/election/72182244063182860-127.0.0.1:35479_solr-n_0000000002
[junit4] 2> 3
/solr/overseer_elect/election/72182244063182887-127.0.0.1:38413_solr-n_0000000011
[junit4] 2> 2
/solr/collections/testSelected2/leader_elect/shard1/election/72182244063182860-core_node5-n_0000000000
[junit4] 2> 2
/solr/collections/testSelected3/leader_elect/shard1/election/72182244063182860-core_node5-n_0000000000
[junit4] 2> 2
/solr/collections/testNodeWithMultipleReplicasLost/leader_elect/shard2/election/72182244063182887-core_node9-n_0000000000
[junit4] 2> 2
/solr/overseer_elect/election/72182244063182893-127.0.0.1:36031_solr-n_0000000013
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 546 /solr/overseer/queue
[junit4] 2> 283 /solr/live_nodes
[junit4] 2> 166 /solr/collections
[junit4] 2> 158 /solr/overseer/collection-queue-work
[junit4] 2> 11 /solr/autoscaling/events/node_added_trigger
[junit4] 2> 9 /solr/autoscaling/events/node_lost_trigger
[junit4] 2> 4 /solr/autoscaling/events/.scheduled_maintenance
[junit4] 2> 4 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 4 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> 1768193 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:44389
[junit4] 2> 1768193 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44389
[junit4] 2> 1768193 INFO
(SUITE-ComputePlanActionTest-seed#[956FAA7E3E148B4D]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 44389
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_956FAA7E3E148B4D-001
[junit4] 2> Sep 23, 2020 10:11:48 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are:
codec=FastDecompressionCompressingStoredFieldsData(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=9, maxDocsPerChunk=960, blockShift=8),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=9, blockSize=8)), sim=Asserting(RandomSimilarity(queryNorm=true):
{}), locale=es-UY, timezone=Europe/Tallinn
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation
1.8.0_252 (64-bit)/cpus=4,threads=1,free=140616832,total=520093696
[junit4] 2> NOTE: All tests run in this JVM: [BasicAuthIntegrationTest,
TestBlendedInfixSuggestions, TestSegmentSorting, DateFieldTest,
OutputWriterTest, TestNumericRangeQuery64, SliceStateTest,
MultiSolrCloudTestCaseTest, SplitByPrefixTest, TestObjectReleaseTracker,
TestCollationField, TestMinHashQParser, NestedAtomicUpdateTest,
ChaosMonkeySafeLeaderWithPullReplicasTest,
PeerSyncWithIndexFingerprintCachingTest, TestBinaryResponseWriter,
JWTAuthPluginTest, TestJoin, ForceLeaderWithTlogReplicasTest,
TestFieldSortValues, SaslZkACLProviderTest, CoreAdminOperationTest,
Tagger2Test, TestWithCollection, TestSolrConfigHandler, DistanceUnitsTest,
MetricsConfigTest, TestLFUCache, SpatialFilterTest,
BigEndianAscendingWordSerializerTest, TimeZoneUtilsTest,
CollectionsAPIAsyncDistributedZkTest, ReturnFieldsTest,
DisMaxRequestHandlerTest, RollingRestartTest, PrimitiveFieldTypeTest,
DistributedMLTComponentTest, BufferStoreTest, DistributedQueueTest,
TestSimClusterStateProvider, TestLuceneIndexBackCompat,
TestSchemaVersionResource, TestSubQueryTransformerCrossCore,
DistanceFunctionTest, TestTolerantUpdateProcessorCloud,
TestIBSimilarityFactory, CoreSorterTest, SchemaVersionSpecificBehaviorTest,
SearchRateTriggerIntegrationTest, HdfsBasicDistributedZk2Test, SuggesterTest,
ZkFailoverTest, UUIDUpdateProcessorFallbackTest, SolrSlf4jReporterTest,
CdcrRequestHandlerTest, TestStressInPlaceUpdates,
TestSolrCloudWithDelegationTokens, TestManagedSchemaAPI,
FastVectorHighlighterTest, PingRequestHandlerTest, SolrMetricsIntegrationTest,
SplitShardTest, TestSolr4Spatial2, IndexSchemaTest, SpellCheckComponentTest,
TestNonDefinedSimilarityFactory, SolrIndexSplitterTest, TestStressVersions,
DeleteLastCustomShardedReplicaTest, AdminHandlersProxyTest, TestDistributedMap,
TestLegacyNumericUtils, SolrPluginUtilsTest, AssignTest, TestConfig,
HealthCheckHandlerTest, TestSolrJacksonAnnotation, TestSimExecutePlanAction,
ConnectionManagerTest, UnloadDistributedZkTest,
TermVectorComponentDistributedTest, TestComplexPhraseLeadingWildcard,
TestRestManager, PathHierarchyTokenizerFactoryTest,
TestRandomRequestDistribution, SoftAutoCommitTest, TestConfigSets,
UpdateLogTest, TestSuggestSpellingConverter, TestSimNodeAddedTrigger,
TestPartialUpdateDeduplication, V2ApiIntegrationTest,
SubstringBytesRefFilterTest, DistributedSpellCheckComponentTest,
ConjunctionSolrSpellCheckerTest, AliasIntegrationTest,
TestSlowCompositeReaderWrapper, LukeRequestHandlerTest, HLLSerializationTest,
RestoreTriggerStateTest, TestApiFramework, HdfsNNFailoverTest,
LegacyCloudClusterPropTest, RulesTest, TestGraphTermsQParserPlugin,
MetricUtilsTest, TestJettySolrRunner, TestChildDocTransformer,
TestCloudPivotFacet, OutOfBoxZkACLAndCredentialsProvidersTest, TestQueryTypes,
FieldMutatingUpdateProcessorTest, TestBooleanSimilarityFactory,
CollectionsAPISolrJTest, DistribJoinFromCollectionTest, ForceLeaderTest,
HttpPartitionWithTlogReplicasTest, LeaderElectionTest, MigrateRouteKeyTest,
MissingSegmentRecoveryTest, NodeMutatorTest, OverseerModifyCollectionTest,
OverseerRolesTest, OverseerTest, RecoveryZkTest, ReplicationFactorTest,
TestCloudDeleteByQuery, TestCloudInspectUtil, TestCloudRecovery2,
TestClusterProperties, TestConfigSetsAPI, TestConfigSetsAPIZkFailure,
TestCryptoKeys, TestLeaderElectionWithEmptyReplica,
TestQueryingOnDownCollection, ConcurrentDeleteAndCreateCollectionTest,
CustomCollectionTest, TestReplicaProperties, AutoAddReplicasPlanActionTest,
ComputePlanActionTest]
[junit4] Completed [567/919 (1!)] on J0 in 95.71s, 9 tests, 1 error, 1
skipped <<< FAILURES!
[...truncated 53562 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
