Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2174/
2 tests failed.
FAILED:
org.apache.solr.cloud.TestCloudRecovery.leaderRecoverFromLogOnStartupTest
Error Message:
expected:<2> but was:<4>
Stack Trace:
java.lang.AssertionError: expected:<2> but was:<4>
at
__randomizedtesting.SeedInfo.seed([549E0CC4396A0039:206EED817D4E47B6]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.TestCloudRecovery.leaderRecoverFromLogOnStartupTest(TestCloudRecovery.java:132)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at
__randomizedtesting.SeedInfo.seed([549E0CC4396A0039:3B7F771E298E222]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi(AutoScalingHandlerTest.java:709)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 11768 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/init-core-data-001
[junit4] 2> 528921 WARN
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 528972 INFO
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 528973 INFO
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 528974 INFO
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 528974 INFO
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001
[junit4] 2> 528974 INFO
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 528994 INFO (Thread-241) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 528994 INFO (Thread-241) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 529042 ERROR (Thread-241) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 529110 INFO
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:34614
[junit4] 2> 529320 INFO (jetty-launcher-146-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 529354 INFO (jetty-launcher-146-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 529578 INFO (jetty-launcher-146-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4c382134{/solr,null,AVAILABLE}
[junit4] 2> 529594 INFO (jetty-launcher-146-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6c041692{/solr,null,AVAILABLE}
[junit4] 2> 529611 INFO (jetty-launcher-146-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6accbe7a{SSL,[ssl,
http/1.1]}{127.0.0.1:41753}
[junit4] 2> 529611 INFO (jetty-launcher-146-thread-2) [ ]
o.e.j.s.Server Started @545763ms
[junit4] 2> 529611 INFO (jetty-launcher-146-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41753}
[junit4] 2> 529611 ERROR (jetty-launcher-146-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 529611 INFO (jetty-launcher-146-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 529611 INFO (jetty-launcher-146-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 529611 INFO (jetty-launcher-146-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 529612 INFO (jetty-launcher-146-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-14T17:31:44.821Z
[junit4] 2> 529631 INFO (jetty-launcher-146-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@56a11ae0{SSL,[ssl,
http/1.1]}{127.0.0.1:42549}
[junit4] 2> 529631 INFO (jetty-launcher-146-thread-1) [ ]
o.e.j.s.Server Started @545783ms
[junit4] 2> 529631 INFO (jetty-launcher-146-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=42549}
[junit4] 2> 529631 ERROR (jetty-launcher-146-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 529631 INFO (jetty-launcher-146-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 529631 INFO (jetty-launcher-146-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 529631 INFO (jetty-launcher-146-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 529631 INFO (jetty-launcher-146-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-14T17:31:44.840Z
[junit4] 2> 529778 INFO (jetty-launcher-146-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 529810 INFO (jetty-launcher-146-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 529845 INFO (jetty-launcher-146-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34614/solr
[junit4] 2> 529863 INFO (jetty-launcher-146-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34614/solr
[junit4] 2> 530035 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15fbb9634da0003, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 530333 INFO (jetty-launcher-146-thread-2)
[n:127.0.0.1:41753_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 530333 INFO (jetty-launcher-146-thread-2)
[n:127.0.0.1:41753_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:41753_solr
[junit4] 2> 530387 INFO (jetty-launcher-146-thread-2)
[n:127.0.0.1:41753_solr ] o.a.s.c.Overseer Overseer
(id=99003970631630854-127.0.0.1:41753_solr-n_0000000000) starting
[junit4] 2> 530515 INFO (jetty-launcher-146-thread-2)
[n:127.0.0.1:41753_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41753_solr
[junit4] 2> 530697 INFO
(OverseerStateUpdate-99003970631630854-127.0.0.1:41753_solr-n_0000000000)
[n:127.0.0.1:41753_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 531212 INFO (jetty-launcher-146-thread-1)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 531302 INFO (jetty-launcher-146-thread-1)
[n:127.0.0.1:42549_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 531465 INFO (jetty-launcher-146-thread-1)
[n:127.0.0.1:42549_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42549_solr
[junit4] 2> 531554 INFO
(zkCallback-158-thread-1-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 531594 INFO
(zkCallback-157-thread-1-processing-n:127.0.0.1:42549_solr)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 531666 INFO (jetty-launcher-146-thread-2)
[n:127.0.0.1:41753_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41753.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 531666 INFO (jetty-launcher-146-thread-2)
[n:127.0.0.1:41753_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41753.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 531666 INFO (jetty-launcher-146-thread-2)
[n:127.0.0.1:41753_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41753.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 531667 INFO (jetty-launcher-146-thread-2)
[n:127.0.0.1:41753_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node2/.
[junit4] 2> 531866 INFO (jetty-launcher-146-thread-1)
[n:127.0.0.1:42549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42549.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 531866 INFO (jetty-launcher-146-thread-1)
[n:127.0.0.1:42549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42549.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 531866 INFO (jetty-launcher-146-thread-1)
[n:127.0.0.1:42549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42549.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 531920 INFO (jetty-launcher-146-thread-1)
[n:127.0.0.1:42549_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node1/.
[junit4] 2> 532599 INFO
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 532620 INFO
(SUITE-AutoScalingHandlerTest-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 532710 INFO
(TEST-AutoScalingHandlerTest.testErrorHandling-seed#[549E0CC4396A0039]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testErrorHandling
[junit4] 2> 533295 ERROR (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.h.RequestHandlerBase org.apache.solr.api.ApiBag$ExceptionWithErrObject:
Error in command payload, errors: [{set-cluster-policy=[{cores=<10, node=#ANY},
{shard=#EACH, node=#ANY}, {nodeRole=overseer, replica=0}],
errorMessages=[replica is required in {
[junit4] 2> "shard":"#EACH",
[junit4] 2> "node":"#ANY"}]}],
[junit4] 2> at
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:211)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:145)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:737)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:718)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:499)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 533295 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=400 QTime=218
[junit4] 2> 533296 INFO
(TEST-AutoScalingHandlerTest.testErrorHandling-seed#[549E0CC4396A0039]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testErrorHandling
[junit4] 2> 533355 INFO
(TEST-AutoScalingHandlerTest.testPolicyAndPreferences-seed#[549E0CC4396A0039])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testPolicyAndPreferences
[junit4] 2> 533477 ERROR (qtp2089025075-906) [n:127.0.0.1:41753_solr ]
o.a.s.h.RequestHandlerBase org.apache.solr.api.ApiBag$ExceptionWithErrObject:
Error in command payload, errors: [{set-policy={xyz=[{replica=<2, shard=#EACH,
node=#ANY}, {nodeRole=!overseer, replica=0}], policy1=[{cores=<2, node=#ANY},
{replica=<2, shard=#EACH, node=#ANY}]}, errorMessages=[cores is only allowed in
'cluster-policy']}],
[junit4] 2> at
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:211)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:145)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:737)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:718)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:499)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 533478 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=400 QTime=53
[junit4] 2> 533698 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 533698 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 533948 INFO (qtp2089025075-912) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=82
[junit4] 2> 534416 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 534597 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=1118
[junit4] 2> 534782 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 534782 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 534799 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 534833 INFO (qtp1777903686-903) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 534884 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=271
[junit4] 2> 535153 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 535154 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 535165 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 535239 INFO (qtp1777903686-904) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 535328 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=371
[junit4] 2> 535458 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 535458 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 535714 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=240
[junit4] 2> 535717 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=1
[junit4] 2> 535788 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=458
[junit4] 2> 536118 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 536118 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 536135 INFO (qtp2089025075-908) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=os.systemLoadAverage&wt=javabin&version=2&group=solr.jvm}
status=0 QTime=0
[junit4] 2> 536191 INFO (qtp1777903686-903) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=os.systemLoadAverage&wt=javabin&version=2&group=solr.jvm}
status=0 QTime=0
[junit4] 2> 536207 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=292
[junit4] 2> 536522 INFO (qtp2089025075-912) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 536559 INFO (qtp2089025075-912) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 536775 INFO (qtp2089025075-908) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName,os.systemLoadAverage&wt=javabin&version=2&group=solr.jvm,solr.core}
status=0 QTime=0
[junit4] 2> 536800 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName,os.systemLoadAverage&wt=javabin&version=2&group=solr.jvm,solr.core}
status=0 QTime=0
[junit4] 2> 536975 INFO (qtp2089025075-912) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=766
[junit4] 2> 536976 INFO
(TEST-AutoScalingHandlerTest.testPolicyAndPreferences-seed#[549E0CC4396A0039])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testPolicyAndPreferences
[junit4] 2> 537210 INFO
(TEST-AutoScalingHandlerTest.testReadApi-seed#[549E0CC4396A0039]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testReadApi
[junit4] 2> 537742 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 537743 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 537744 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 537750 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 537781 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=564
[junit4] 2> 537890 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 537891 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 537909 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=17
[junit4] 2> 537933 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 537999 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=217
[junit4] 2> 538219 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 538220 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 538312 INFO (qtp2089025075-908) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=90
[junit4] 2> 538316 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 538349 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=347
[junit4] 2> 538617 INFO (qtp2089025075-912) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 538618 INFO (qtp2089025075-912) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 538620 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 538658 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 538694 INFO (qtp2089025075-912) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=344
[junit4] 2> 538732 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=16
[junit4] 2> 538874 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 538875 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 538876 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 538913 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 538970 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling/diagnostics
params={wt=javabin&version=2} status=0 QTime=236
[junit4] 2> 538971 INFO (qtp2089025075-908) [n:127.0.0.1:41753_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=6&collection.configName=conf&maxShardsPerNode=10&name=readApiTestViolations&nrtReplicas=6&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 539077 INFO
(OverseerThreadFactory-430-thread-1-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.CreateCollectionCmd Create collection
readApiTestViolations
[junit4] 2> 539078 ERROR
(OverseerThreadFactory-430-thread-1-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.OverseerCollectionMessageHandler
Collection: readApiTestViolations operation: create
failed:org.apache.solr.common.SolrException: 'maxShardsPerNode>0' is not
supported when autoScaling policies are used
[junit4] 2> at
org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:136)
[junit4] 2> at
org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:232)
[junit4] 2> at
org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 539204 INFO (qtp2089025075-908) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=6&collection.configName=conf&maxShardsPerNode=10&name=readApiTestViolations&nrtReplicas=6&action=CREATE&numShards=1&wt=javabin&version=2}
status=400 QTime=233
[junit4] 2> 539387 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 539388 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34614/solr ready
[junit4] 2> 539389 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 539444 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 539481 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=168
[junit4] 2> 539482 INFO (qtp2089025075-912) [n:127.0.0.1:41753_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=6&collection.configName=conf&name=readApiTestViolations&nrtReplicas=6&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 539517 INFO
(OverseerCollectionConfigSetProcessor-99003970631630854-127.0.0.1:41753_solr-n_0000000000)
[n:127.0.0.1:41753_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> 539517 INFO
(OverseerThreadFactory-430-thread-2-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.CreateCollectionCmd Create collection
readApiTestViolations
[junit4] 2> 539518 WARN
(OverseerThreadFactory-430-thread-2-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.CreateCollectionCmd Specified number of
replicas of 6 on collection readApiTestViolations is higher than the number of
Solr instances currently live or live and part of your createNodeSet(2). It's
unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 539592 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 539642 INFO (qtp1777903686-903) [n:127.0.0.1:42549_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName,os.systemLoadAverage,memory.heap.usage&wt=javabin&version=2&group=solr.jvm,solr.node,solr.core}
status=0 QTime=12
[junit4] 2> 539992 INFO
(OverseerStateUpdate-99003970631630854-127.0.0.1:41753_solr-n_0000000000)
[n:127.0.0.1:41753_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"readApiTestViolations",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"readApiTestViolations_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41753/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 539993 INFO
(OverseerStateUpdate-99003970631630854-127.0.0.1:41753_solr-n_0000000000)
[n:127.0.0.1:41753_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"readApiTestViolations",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"readApiTestViolations_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:42549/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 539995 INFO
(OverseerStateUpdate-99003970631630854-127.0.0.1:41753_solr-n_0000000000)
[n:127.0.0.1:41753_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"readApiTestViolations",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"readApiTestViolations_shard1_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41753/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 540030 INFO
(OverseerStateUpdate-99003970631630854-127.0.0.1:41753_solr-n_0000000000)
[n:127.0.0.1:41753_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"readApiTestViolations",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"readApiTestViolations_shard1_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:42549/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 540046 INFO
(OverseerStateUpdate-99003970631630854-127.0.0.1:41753_solr-n_0000000000)
[n:127.0.0.1:41753_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"readApiTestViolations",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"readApiTestViolations_shard1_replica_n8",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41753/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 540082 INFO
(OverseerStateUpdate-99003970631630854-127.0.0.1:41753_solr-n_0000000000)
[n:127.0.0.1:41753_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"readApiTestViolations",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"readApiTestViolations_shard1_replica_n10",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:42549/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 540338 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=readApiTestViolations_shard1_replica_n1&action=CREATE&numShards=1&collection=readApiTestViolations&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 540338 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 540541 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=readApiTestViolations_shard1_replica_n3&action=CREATE&numShards=1&collection=readApiTestViolations&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 540596 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node9&collection.configName=conf&newCollection=true&name=readApiTestViolations_shard1_replica_n6&action=CREATE&numShards=1&collection=readApiTestViolations&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 540596 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 540614 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=readApiTestViolations_shard1_replica_n2&action=CREATE&numShards=1&collection=readApiTestViolations&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 540614 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node12&collection.configName=conf&newCollection=true&name=readApiTestViolations_shard1_replica_n10&action=CREATE&numShards=1&collection=readApiTestViolations&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 540724 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node11&collection.configName=conf&newCollection=true&name=readApiTestViolations_shard1_replica_n8&action=CREATE&numShards=1&collection=readApiTestViolations&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 540834 INFO
(zkCallback-158-thread-1-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 540849 INFO
(zkCallback-157-thread-1-processing-n:127.0.0.1:42549_solr)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 540850 INFO
(zkCallback-158-thread-2-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 540850 INFO
(zkCallback-157-thread-2-processing-n:127.0.0.1:42549_solr)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 540850 INFO
(zkCallback-157-thread-3-processing-n:127.0.0.1:42549_solr)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 541709 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 541917 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.s.IndexSchema
[readApiTestViolations_shard1_replica_n1] Schema name=minimal
[junit4] 2> 542009 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 542009 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.c.CoreContainer Creating
SolrCore 'readApiTestViolations_shard1_replica_n1' using configuration from
collection readApiTestViolations, trusted=true
[junit4] 2> 542024 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_41753.solr.core.readApiTestViolations.shard1.replica_n1'
(registry 'solr.core.readApiTestViolations.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 542025 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 542025 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.c.SolrCore
[[readApiTestViolations_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node2/readApiTestViolations_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node2/./readApiTestViolations_shard1_replica_n1/data/]
[junit4] 2> 542113 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 542148 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 542150 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 542181 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 542245 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 542291 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.s.IndexSchema
[readApiTestViolations_shard1_replica_n8] Schema name=minimal
[junit4] 2> 542383 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 542383 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.c.CoreContainer Creating
SolrCore 'readApiTestViolations_shard1_replica_n8' using configuration from
collection readApiTestViolations, trusted=true
[junit4] 2> 542384 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_41753.solr.core.readApiTestViolations.shard1.replica_n8'
(registry 'solr.core.readApiTestViolations.shard1.replica_n8') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 542384 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 542384 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.c.SolrCore
[[readApiTestViolations_shard1_replica_n8] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node2/readApiTestViolations_shard1_replica_n8],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node2/./readApiTestViolations_shard1_replica_n8/data/]
[junit4] 2> 542392 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.s.IndexSchema
[readApiTestViolations_shard1_replica_n6] Schema name=minimal
[junit4] 2> 542537 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 542537 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.c.CoreContainer Creating
SolrCore 'readApiTestViolations_shard1_replica_n6' using configuration from
collection readApiTestViolations, trusted=true
[junit4] 2> 542537 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_42549.solr.core.readApiTestViolations.shard1.replica_n6'
(registry 'solr.core.readApiTestViolations.shard1.replica_n6') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 542538 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 542538 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.c.SolrCore
[[readApiTestViolations_shard1_replica_n6] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node1/readApiTestViolations_shard1_replica_n6],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node1/./readApiTestViolations_shard1_replica_n6/data/]
[junit4] 2> 542560 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.s.IndexSchema
[readApiTestViolations_shard1_replica_n2] Schema name=minimal
[junit4] 2> 542573 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.s.IndexSchema
[readApiTestViolations_shard1_replica_n3] Schema name=minimal
[junit4] 2> 542583 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.s.IndexSchema
[readApiTestViolations_shard1_replica_n10] Schema name=minimal
[junit4] 2> 542595 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 542595 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.c.CoreContainer Creating
SolrCore 'readApiTestViolations_shard1_replica_n3' using configuration from
collection readApiTestViolations, trusted=true
[junit4] 2> 542596 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_41753.solr.core.readApiTestViolations.shard1.replica_n3'
(registry 'solr.core.readApiTestViolations.shard1.replica_n3') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 542596 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 542596 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.c.SolrCore
[[readApiTestViolations_shard1_replica_n3] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node2/readApiTestViolations_shard1_replica_n3],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node2/./readApiTestViolations_shard1_replica_n3/data/]
[junit4] 2> 542604 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 542604 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.c.CoreContainer Creating
SolrCore 'readApiTestViolations_shard1_replica_n10' using configuration from
collection readApiTestViolations, trusted=true
[junit4] 2> 542605 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_42549.solr.core.readApiTestViolations.shard1.replica_n10'
(registry 'solr.core.readApiTestViolations.shard1.replica_n10') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 542605 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 542605 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.c.SolrCore
[[readApiTestViolations_shard1_replica_n10] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node1/readApiTestViolations_shard1_replica_n10],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node1/./readApiTestViolations_shard1_replica_n10/data/]
[junit4] 2> 542611 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 542611 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.CoreContainer Creating
SolrCore 'readApiTestViolations_shard1_replica_n2' using configuration from
collection readApiTestViolations, trusted=true
[junit4] 2> 542732 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_42549.solr.core.readApiTestViolations.shard1.replica_n2'
(registry 'solr.core.readApiTestViolations.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac189db
[junit4] 2> 542765 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 542765 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.SolrCore
[[readApiTestViolations_shard1_replica_n2] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node1/readApiTestViolations_shard1_replica_n2],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_549E0CC4396A0039-001/tempDir-001/node1/./readApiTestViolations_shard1_replica_n2/data/]
[junit4] 2> 543127 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 543127 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 543128 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 543128 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 543130 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@e6799a1[readApiTestViolations_shard1_replica_n2] main]
[junit4] 2> 543151 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 543152 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 543204 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 543205 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1584063544991678464
[junit4] 2> 543408 INFO
(searcherExecutor-440-thread-1-processing-n:127.0.0.1:42549_solr
x:readApiTestViolations_shard1_replica_n2 s:shard1 c:readApiTestViolations
r:core_node5) [n:127.0.0.1:42549_solr c:readApiTestViolations s:shard1
r:core_node5 x:readApiTestViolations_shard1_replica_n2] o.a.s.c.SolrCore
[readApiTestViolations_shard1_replica_n2] Registered new searcher
Searcher@e6799a1[readApiTestViolations_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 543426 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext
Waiting until we see more replicas up for shard shard1: total=6 found=1
timeoutin=9999ms
[junit4] 2> 543427 INFO
(zkCallback-158-thread-2-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 543427 INFO
(zkCallback-158-thread-1-processing-n:127.0.0.1:41753_solr)
[n:127.0.0.1:41753_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 543444 INFO
(zkCallback-157-thread-3-processing-n:127.0.0.1:42549_solr)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 543444 INFO
(zkCallback-157-thread-2-processing-n:127.0.0.1:42549_solr)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 543445 INFO
(zkCallback-157-thread-1-processing-n:127.0.0.1:42549_solr)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTestViolations/state.json] for collection
[readApiTestViolations] has occurred - updating... (live nodes size: [2])
[junit4] 2> 543554 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 543554 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 543555 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 543555 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 543556 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6db2ab40[readApiTestViolations_shard1_replica_n6] main]
[junit4] 2> 543557 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 543590 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 543590 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 543591 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 543592 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 543593 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.s.SolrIndexSearcher Opening
[Searcher@77a79f7[readApiTestViolations_shard1_replica_n8] main]
[junit4] 2> 543594 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 543594 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 543607 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 543607 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 543608 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 543608 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 543609 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4a39f20f[readApiTestViolations_shard1_replica_n1] main]
[junit4] 2> 543610 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 543610 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 543627 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 543628 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 543658 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 543709 INFO
(searcherExecutor-437-thread-1-processing-n:127.0.0.1:42549_solr
x:readApiTestViolations_shard1_replica_n6 s:shard1 c:readApiTestViolations
r:core_node9) [n:127.0.0.1:42549_solr c:readApiTestViolations s:shard1
r:core_node9 x:readApiTestViolations_shard1_replica_n6] o.a.s.c.SolrCore
[readApiTestViolations_shard1_replica_n6] Registered new searcher
Searcher@6db2ab40[readApiTestViolations_shard1_replica_n6]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 543709 INFO
(searcherExecutor-435-thread-1-processing-n:127.0.0.1:41753_solr
x:readApiTestViolations_shard1_replica_n1 s:shard1 c:readApiTestViolations
r:core_node4) [n:127.0.0.1:41753_solr c:readApiTestViolations s:shard1
r:core_node4 x:readApiTestViolations_shard1_replica_n1] o.a.s.c.SolrCore
[readApiTestViolations_shard1_replica_n1] Registered new searcher
Searcher@4a39f20f[readApiTestViolations_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 543710 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 543710 INFO (qtp1777903686-897) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1584063545521209344
[junit4] 2> 543712 INFO (qtp2089025075-913) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1584063545523306496
[junit4] 2> 543714 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 543714 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 543715 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 543715 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 543765 INFO (qtp2089025075-906) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1584063545578881024
[junit4] 2> 543861 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 543861 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 543863 INFO
(searcherExecutor-436-thread-1-processing-n:127.0.0.1:41753_solr
x:readApiTestViolations_shard1_replica_n8 s:shard1 c:readApiTestViolations
r:core_node11) [n:127.0.0.1:41753_solr c:readApiTestViolations s:shard1
r:core_node11 x:readApiTestViolations_shard1_replica_n8] o.a.s.c.SolrCore
[readApiTestViolations_shard1_replica_n8] Registered new searcher
Searcher@77a79f7[readApiTestViolations_shard1_replica_n8]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 543875 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.s.SolrIndexSearcher Opening
[Searcher@5361c972[readApiTestViolations_shard1_replica_n3] main]
[junit4] 2> 543913 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 543913 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 543914 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.s.SolrIndexSearcher Opening
[Searcher@e7248e2[readApiTestViolations_shard1_replica_n10] main]
[junit4] 2> 543928 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 543948 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 543949 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 543985 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 544006 INFO
(searcherExecutor-438-thread-1-processing-n:127.0.0.1:41753_solr
x:readApiTestViolations_shard1_replica_n3 s:shard1 c:readApiTestViolations
r:core_node7) [n:127.0.0.1:41753_solr c:readApiTestViolations s:shard1
r:core_node7 x:readApiTestViolations_shard1_replica_n3] o.a.s.c.SolrCore
[readApiTestViolations_shard1_replica_n3] Registered new searcher
Searcher@5361c972[readApiTestViolations_shard1_replica_n3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 544006 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 544007 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 544007 INFO (qtp1777903686-898) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.u.UpdateLog Could not find
max version in index or recent updates, using new clock 1584063545832636416
[junit4] 2> 544022 INFO (qtp2089025075-907) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1584063545848365056
[junit4] 2> 544042 INFO
(searcherExecutor-439-thread-1-processing-n:127.0.0.1:42549_solr
x:readApiTestViolations_shard1_replica_n10 s:shard1 c:readApiTestViolations
r:core_node12) [n:127.0.0.1:42549_solr c:readApiTestViolations s:shard1
r:core_node12 x:readApiTestViolations_shard1_replica_n10] o.a.s.c.SolrCore
[readApiTestViolations_shard1_replica_n10] Registered new searcher
Searcher@e7248e2[readApiTestViolations_shard1_replica_n10]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 544526 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 544526 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 544526 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.SyncStrategy Sync replicas
to https://127.0.0.1:42549/solr/readApiTestViolations_shard1_replica_n2/
[junit4] 2> 544527 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.u.PeerSync PeerSync:
core=readApiTestViolations_shard1_replica_n2 url=https://127.0.0.1:42549/solr
START
replicas=[https://127.0.0.1:41753/solr/readApiTestViolations_shard1_replica_n1/,
https://127.0.0.1:41753/solr/readApiTestViolations_shard1_replica_n3/,
https://127.0.0.1:42549/solr/readApiTestViolations_shard1_replica_n6/,
https://127.0.0.1:41753/solr/readApiTestViolations_shard1_replica_n8/,
https://127.0.0.1:42549/solr/readApiTestViolations_shard1_replica_n10/]
nUpdates=100
[junit4] 2> 544894 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node11
x:readApiTestViolations_shard1_replica_n8] o.a.s.c.S.Request
[readApiTestViolations_shard1_replica_n8] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=99
[junit4] 2> 544932 INFO (qtp2089025075-909) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n3] o.a.s.c.S.Request
[readApiTestViolations_shard1_replica_n3] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 544961 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.u.PeerSync PeerSync:
core=readApiTestViolations_shard1_replica_n2 url=https://127.0.0.1:42549/solr
DONE. We have no versions. sync failed.
[junit4] 2> 545058 INFO (qtp1777903686-901) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.c.S.Request
[readApiTestViolations_shard1_replica_n6] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=107
[junit4] 2> 545059 INFO (qtp1777903686-903) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node12
x:readApiTestViolations_shard1_replica_n10] o.a.s.c.S.Request
[readApiTestViolations_shard1_replica_n10] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=107
[junit4] 2> 545367 INFO (qtp2089025075-910) [n:127.0.0.1:41753_solr
c:readApiTestViolations s:shard1 r:core_node4
x:readApiTestViolations_shard1_replica_n1] o.a.s.c.S.Request
[readApiTestViolations_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=307
[junit4] 2> 545383 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.SyncStrategy Leader's
attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 545383 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext
We failed sync, but we have no versions - we can't sync in that case - we were
active before, so become leader anyway
[junit4] 2> 545383 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 545385 INFO (qtp1777903686-902) [n:127.0.0.1:42549_solr
c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
https://127.0.0.1:42549/solr/readApiTestViolations_shard1_replica_n2/ shard1
[junit4] 2> 545495 INFO
(zkCallback-157-thread-1-processing-n:127.0.0.1:42549_solr)
[n:127.0.0.1:42549_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/readApiTe
[...truncated too long message...]
re.collection1.shard1.replica_n1, tag=867191750
[junit4] 2> 2271340 INFO (coreCloseExecutor-3162-thread-2)
[n:127.0.0.1:34305_solr c:collection1 s:shard1 r:core_node5
x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5475905d: rootName =
solr_34305, domain = solr.core.collection1.shard1.replica_n1, service url =
null, agent id = null] for registry solr.core.collection1.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@fddff7f
[junit4] 2> 2271354 INFO
(zkCallback-1573-thread-1-processing-n:127.0.0.1:34305_solr)
[n:127.0.0.1:34305_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [0])
[junit4] 2> 2271354 INFO
(zkCallback-1566-thread-1-processing-n:127.0.0.1:43952_solr)
[n:127.0.0.1:43952_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [0])
[junit4] 2> 2271355 INFO
(zkCallback-1566-thread-2-processing-n:127.0.0.1:43952_solr)
[n:127.0.0.1:43952_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [0])
[junit4] 2> 2271414 INFO (coreCloseExecutor-3162-thread-2)
[n:127.0.0.1:34305_solr c:collection1 s:shard1 r:core_node5
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard1.leader, tag=867191750
[junit4] 2> 2271449 INFO (coreCloseExecutor-3163-thread-1)
[n:127.0.0.1:43952_solr c:collection1 s:shard2 r:core_node8
x:collection1_shard2_replica_n4] o.a.s.c.SolrCore
[collection1_shard2_replica_n4] CLOSING SolrCore
org.apache.solr.core.SolrCore@1216c936
[junit4] 2> 2271449 INFO (coreCloseExecutor-3163-thread-1)
[n:127.0.0.1:43952_solr c:collection1 s:shard2 r:core_node8
x:collection1_shard2_replica_n4] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.collection1.shard2.replica_n4, tag=303483190
[junit4] 2> 2271449 INFO (coreCloseExecutor-3163-thread-1)
[n:127.0.0.1:43952_solr c:collection1 s:shard2 r:core_node8
x:collection1_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6d0de51f: rootName =
solr_43952, domain = solr.core.collection1.shard2.replica_n4, service url =
null, agent id = null] for registry solr.core.collection1.shard2.replica_n4 /
com.codahale.metrics.MetricRegistry@427fefc0
[junit4] 2> 2271557 INFO (coreCloseExecutor-3163-thread-2)
[n:127.0.0.1:43952_solr c:collection1 s:shard1 r:core_node6
x:collection1_shard1_replica_n2] o.a.s.c.SolrCore
[collection1_shard1_replica_n2] CLOSING SolrCore
org.apache.solr.core.SolrCore@55c3e9cc
[junit4] 2> 2271576 INFO (coreCloseExecutor-3163-thread-2)
[n:127.0.0.1:43952_solr c:collection1 s:shard1 r:core_node6
x:collection1_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.collection1.shard1.replica_n2, tag=1438902732
[junit4] 2> 2271576 INFO (coreCloseExecutor-3163-thread-2)
[n:127.0.0.1:43952_solr c:collection1 s:shard1 r:core_node6
x:collection1_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@85a2213: rootName =
solr_43952, domain = solr.core.collection1.shard1.replica_n2, service url =
null, agent id = null] for registry solr.core.collection1.shard1.replica_n2 /
com.codahale.metrics.MetricRegistry@a0f3d16
[junit4] 2> 2271633 INFO (coreCloseExecutor-3163-thread-1)
[n:127.0.0.1:43952_solr c:collection1 s:shard2 r:core_node8
x:collection1_shard2_replica_n4] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard2.leader, tag=303483190
[junit4] 2> 2271716 INFO (coreCloseExecutor-3163-thread-2)
[n:127.0.0.1:43952_solr c:collection1 s:shard1 r:core_node6
x:collection1_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard1.leader, tag=1438902732
[junit4] 2> 2271903 INFO (jetty-closer-1524-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=99004081461723153-127.0.0.1:43952_solr-n_0000000004) closing
[junit4] 2> 2271904 INFO
(OverseerStateUpdate-99004081461723153-127.0.0.1:43952_solr-n_0000000004)
[n:127.0.0.1:43952_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:43952_solr
[junit4] 2> 2271904 WARN
(OverseerAutoScalingTriggerThread-99004081461723153-127.0.0.1:43952_solr-n_0000000004)
[n:127.0.0.1:43952_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2272085 INFO (jetty-closer-1524-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6ede0f09{/solr,null,UNAVAILABLE}
[junit4] 2> 2272125 INFO (jetty-closer-1524-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2b165c7f{/solr,null,UNAVAILABLE}
[junit4] 2> 2272125 ERROR
(SUITE-TestCloudRecovery-seed#[549E0CC4396A0039]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2272125 INFO
(SUITE-TestCloudRecovery-seed#[549E0CC4396A0039]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:40225 40225
[junit4] 2> 2272125 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15fbbb002d70011, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2272205 INFO (Thread-1229) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:40225 40225
[junit4] 2> 2272205 WARN (Thread-1229) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/aliases.json
[junit4] 2> 6 /solr/security.json
[junit4] 2> 6 /solr/configs/config
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 39 /solr/collections/collection1/state.json
[junit4] 2> 7 /solr/clusterprops.json
[junit4] 2> 7 /solr/clusterstate.json
[junit4] 2> 4 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 4 /solr/overseer/queue
[junit4] 2> 4 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2> 4 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestCloudRecovery_549E0CC4396A0039-001
[junit4] 2> Nov 14, 2017 6:00:48 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
docValues:{_version_=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=426,
maxMBSortInHeap=5.965800294316802,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@76f170be),
locale=es-MX, timezone=America/Matamoros
[junit4] 2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation
1.8.0_152 (64-bit)/cpus=4,threads=1,free=166930568,total=524812288
[junit4] 2> NOTE: All tests run in this JVM:
[AsyncCallRequestStatusResponseTest, TestPrepRecovery,
TestConfigSetsAPIExclusivity, TestSQLHandlerNonCloud, TestUseDocValuesAsStored,
TestNumericTokenStream, TestCollectionAPI, SearchRateTriggerTest,
TestDynamicFieldResource, BooleanFieldTest, CopyFieldTest,
AliasIntegrationTest, DocValuesNotIndexedTest, TestTrie,
AlternateDirectoryTest, CollectionReloadTest, TestCloudSchemaless,
TestManagedSchema, RequestLoggingTest, TemplateUpdateProcessorTest,
ChaosMonkeyNothingIsSafeTest, TestPointFields, ComputePlanActionTest,
AnalysisErrorHandlingTest, ConnectionReuseTest,
TestTrackingShardHandlerFactory, TestCoreDiscovery, TestReplicaProperties,
TestDynamicLoading, ZkStateReaderTest, TestLeaderElectionZkExpiry,
TestPKIAuthenticationPlugin, RollingRestartTest, DistanceFunctionTest,
TestMissingGroups, WrapperMergePolicyFactoryTest, SortByFunctionTest,
TestCharFilters, TestOverriddenPrefixQueryForCustomFieldType,
ManagedSchemaRoundRobinCloudTest, HdfsBasicDistributedZkTest,
RegexBytesRefFilterTest, TestManagedResource, TestSystemCollAutoCreate,
DistribJoinFromCollectionTest, LeaderFailureAfterFreshStartTest,
TestZkAclsWithHadoopAuth, CdcrBootstrapTest, DistributedFacetPivotWhiteBoxTest,
TestReload, MetricUtilsTest, UUIDUpdateProcessorFallbackTest,
TestHashPartitioner, TestRetrieveFieldsOptimizer, TestFieldCacheSort,
TestDelegationWithHadoopAuth, TestQueryTypes, TestSolrDeletionPolicy2,
SuggestComponentContextFilterQueryTest, DistributedFacetPivotLongTailTest,
BasicAuthStandaloneTest, TestConfigsApi, TestCloudRecovery]
[junit4] Completed [198/749 (2!)] on J2 in 53.35s, 2 tests, 1 failure <<<
FAILURES!
[...truncated 49131 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
