Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/30/
Java: 64bit/jdk1.8.0_131 -XX:-UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.cloud.OverseerRolesTest.testOverseerRole
Error Message:
Timed out waiting for overseer state change
Stack Trace:
java.lang.AssertionError: Timed out waiting for overseer state change
at
__randomizedtesting.SeedInfo.seed([121D6F1CECFA9990:F3D69288D749AF41]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:62)
at
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:140)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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 12550 lines...]
[junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_121D6F1CECFA9990-001\init-core-data-001
[junit4] 2> 2395178 INFO
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2395182 INFO
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2395184 INFO
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_121D6F1CECFA9990-001\tempDir-001
[junit4] 2> 2395184 INFO
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2395184 INFO (Thread-4371) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2395184 INFO (Thread-4371) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2395189 ERROR (Thread-4371) [ ] 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> 2395284 INFO
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:61341
[junit4] 2> 2395290 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 0x15d31931e900000, 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> 2395295 INFO (jetty-launcher-3950-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2395295 INFO (jetty-launcher-3950-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2395295 INFO (jetty-launcher-3950-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2395295 INFO (jetty-launcher-3950-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2395296 INFO (jetty-launcher-3950-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2173c4bf{/solr,null,AVAILABLE}
[junit4] 2> 2395296 INFO (jetty-launcher-3950-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@28833ee1{/solr,null,AVAILABLE}
[junit4] 2> 2395296 INFO (jetty-launcher-3950-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@10eedf1e{/solr,null,AVAILABLE}
[junit4] 2> 2395296 INFO (jetty-launcher-3950-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@38135902{HTTP/1.1,[http/1.1]}{127.0.0.1:61345}
[junit4] 2> 2395296 INFO (jetty-launcher-3950-thread-4) [ ]
o.e.j.s.Server Started @2400352ms
[junit4] 2> 2395296 INFO (jetty-launcher-3950-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=61345}
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@89fab14{HTTP/1.1,[http/1.1]}{127.0.0.1:61348}
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@d71d5c7{HTTP/1.1,[http/1.1]}{127.0.0.1:61349}
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-1) [ ]
o.e.j.s.Server Started @2400352ms
[junit4] 2> 2395297 ERROR (jetty-launcher-3950-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@610efed1{/solr,null,AVAILABLE}
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-11T12:15:11.612Z
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-2) [ ]
o.e.j.s.Server Started @2400352ms
[junit4] 2> 2395297 INFO (jetty-launcher-3950-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=61349}
[junit4] 2> 2395303 ERROR (jetty-launcher-3950-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@439240d2{HTTP/1.1,[http/1.1]}{127.0.0.1:61354}
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-3) [ ]
o.e.j.s.Server Started @2400359ms
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=61354}
[junit4] 2> 2395303 INFO (jetty-launcher-3950-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=61348}
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-11T12:15:11.619Z
[junit4] 2> 2395304 ERROR (jetty-launcher-3950-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2395304 INFO (jetty-launcher-3950-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2395304 ERROR (jetty-launcher-3950-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2395305 INFO (jetty-launcher-3950-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-11T12:15:11.620Z
[junit4] 2> 2395305 INFO (jetty-launcher-3950-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 2395305 INFO (jetty-launcher-3950-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2395305 INFO (jetty-launcher-3950-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2395305 INFO (jetty-launcher-3950-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-11T12:15:11.620Z
[junit4] 2> 2395307 INFO (jetty-launcher-3950-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2395308 INFO (jetty-launcher-3950-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2395308 INFO (jetty-launcher-3950-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2395310 INFO (jetty-launcher-3950-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2395344 INFO (jetty-launcher-3950-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61341/solr
[junit4] 2> 2395344 INFO (jetty-launcher-3950-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61341/solr
[junit4] 2> 2395345 INFO (jetty-launcher-3950-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61341/solr
[junit4] 2> 2395345 INFO (jetty-launcher-3950-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61341/solr
[junit4] 2> 2395348 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 0x15d31931e900006, 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> 2395502 INFO (jetty-launcher-3950-thread-4)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2395503 INFO (jetty-launcher-3950-thread-4)
[n:127.0.0.1:61345_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61345_solr
[junit4] 2> 2395504 INFO (jetty-launcher-3950-thread-4)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726153-127.0.0.1:61345_solr-n_0000000000) starting
[junit4] 2> 2395512 INFO (jetty-launcher-3950-thread-4)
[n:127.0.0.1:61345_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:61345_solr
[junit4] 2> 2395520 INFO
(zkCallback-3969-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2395552 INFO (jetty-launcher-3950-thread-1)
[n:127.0.0.1:61349_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2395552 INFO (jetty-launcher-3950-thread-2)
[n:127.0.0.1:61348_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2395552 INFO (jetty-launcher-3950-thread-3)
[n:127.0.0.1:61354_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2395556 INFO (jetty-launcher-3950-thread-1)
[n:127.0.0.1:61349_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2395556 INFO (jetty-launcher-3950-thread-2)
[n:127.0.0.1:61348_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2395557 INFO (jetty-launcher-3950-thread-3)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2395563 INFO (jetty-launcher-3950-thread-1)
[n:127.0.0.1:61349_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:61349_solr
[junit4] 2> 2395563 INFO (jetty-launcher-3950-thread-2)
[n:127.0.0.1:61348_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:61348_solr
[junit4] 2> 2395563 INFO (jetty-launcher-3950-thread-3)
[n:127.0.0.1:61354_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:61354_solr
[junit4] 2> 2395589 INFO
(zkCallback-3969-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (4)
[junit4] 2> 2395590 INFO
(zkCallback-3972-thread-1-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (4)
[junit4] 2> 2395590 INFO
(zkCallback-3971-thread-1-processing-n:127.0.0.1:61348_solr)
[n:127.0.0.1:61348_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (4)
[junit4] 2> 2395609 INFO
(zkCallback-3970-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (4)
[junit4] 2> 2395641 INFO (jetty-launcher-3950-thread-4)
[n:127.0.0.1:61345_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61345.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395643 INFO (jetty-launcher-3950-thread-4)
[n:127.0.0.1:61345_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61345.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395643 INFO (jetty-launcher-3950-thread-4)
[n:127.0.0.1:61345_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61345.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395644 INFO (jetty-launcher-3950-thread-4)
[n:127.0.0.1:61345_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_121D6F1CECFA9990-001\tempDir-001\node1\.
[junit4] 2> 2395651 INFO (jetty-launcher-3950-thread-1)
[n:127.0.0.1:61349_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61349.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395667 INFO (jetty-launcher-3950-thread-1)
[n:127.0.0.1:61349_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61349.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395667 INFO (jetty-launcher-3950-thread-1)
[n:127.0.0.1:61349_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61349.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395668 INFO (jetty-launcher-3950-thread-1)
[n:127.0.0.1:61349_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_121D6F1CECFA9990-001\tempDir-001\node3\.
[junit4] 2> 2395710 INFO (jetty-launcher-3950-thread-3)
[n:127.0.0.1:61354_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61354.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395710 INFO (jetty-launcher-3950-thread-2)
[n:127.0.0.1:61348_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61348.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395714 INFO (jetty-launcher-3950-thread-2)
[n:127.0.0.1:61348_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61348.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395714 INFO (jetty-launcher-3950-thread-2)
[n:127.0.0.1:61348_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61348.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395715 INFO (jetty-launcher-3950-thread-2)
[n:127.0.0.1:61348_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_121D6F1CECFA9990-001\tempDir-001\node2\.
[junit4] 2> 2395725 INFO (jetty-launcher-3950-thread-3)
[n:127.0.0.1:61354_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61354.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395726 INFO (jetty-launcher-3950-thread-3)
[n:127.0.0.1:61354_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_61354.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@63c76f7c
[junit4] 2> 2395727 INFO (jetty-launcher-3950-thread-3)
[n:127.0.0.1:61354_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_121D6F1CECFA9990-001\tempDir-001\node4\.
[junit4] 2> 2395758 INFO
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2395759 INFO
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:61341/solr ready
[junit4] 2> 2395780 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testOverseerRole
[junit4] 2> 2395781 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:61345_solr
[junit4] 2> 2395781 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest Election queue:
[junit4] 2> 2395782 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest ### Setting overseer designate 127.0.0.1:61348_solr
[junit4] 2> 2395789 INFO (qtp1478135284-21778) [n:127.0.0.1:61349_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params
node=127.0.0.1:61348_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 2395800 INFO
(OverseerThreadFactory-8678-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.OverseerRoleCmd Overseer role added to
127.0.0.1:61348_solr
[junit4] 2> 2395803 INFO (qtp1478135284-21778) [n:127.0.0.1:61349_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:61348_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
status=0 QTime=13
[junit4] 2> 2395805 INFO (Thread-4417) [n:127.0.0.1:61345_solr ]
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at
98289274814726153-127.0.0.1:61345_solr-n_0000000000 overseer designates are
[127.0.0.1:61348_solr]
[junit4] 2> 2395805 INFO (Thread-4417) [n:127.0.0.1:61345_solr ]
o.a.s.c.OverseerNodePrioritizer sorted nodes
[98289274814726153-127.0.0.1:61345_solr-n_0000000000,
98289274814726156-127.0.0.1:61349_solr-n_0000000001,
98289274814726154-127.0.0.1:61348_solr-n_0000000002,
98289274814726155-127.0.0.1:61354_solr-n_0000000003]
[junit4] 2> 2395806 INFO (Thread-4417) [n:127.0.0.1:61345_solr ]
o.a.s.c.OverseerNodePrioritizer asking node
98289274814726154-127.0.0.1:61348_solr-n_0000000002 to come join election at
head
[junit4] 2> 2395807 INFO (qtp1625128650-21770) [n:127.0.0.1:61348_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=98289274814726154-127.0.0.1:61348_solr-n_0000000002&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2395811 INFO (Thread-4417) [n:127.0.0.1:61345_solr ]
o.a.s.c.OverseerNodePrioritizer asking the old first in line
98289274814726156-127.0.0.1:61349_solr-n_0000000001 to rejoin election
[junit4] 2> 2395813 INFO (qtp1478135284-21779) [n:127.0.0.1:61349_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=98289274814726156-127.0.0.1:61349_solr-n_0000000001&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2395815 INFO
(OverseerStateUpdate-98289274814726153-127.0.0.1:61345_solr-n_0000000000)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"98289274814726153-127.0.0.1:61345_solr-n_0000000000"}
127.0.0.1:61345_solr
[junit4] 2> 2395815 INFO
(OverseerStateUpdate-98289274814726153-127.0.0.1:61345_solr-n_0000000000)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61345_solr
[junit4] 2> 2395816 WARN (OverseerExitThread) [n:127.0.0.1:61345_solr
] o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 2395817 INFO
(zkCallback-3972-thread-1-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61349_solr
[junit4] 2> 2395818 INFO
(zkCallback-3972-thread-1-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726156-127.0.0.1:61349_solr-n_0000000001) starting
[junit4] 2> 2395822 INFO (OverseerExitThread) [n:127.0.0.1:61345_solr
] o.a.s.c.Overseer Overseer
(id=98289274814726153-127.0.0.1:61345_solr-n_0000000000) closing
[junit4] 2> 2395852 INFO
(OverseerCollectionConfigSetProcessor-98289274814726156-127.0.0.1:61349_solr-n_0000000001)
[n:127.0.0.1:61349_solr ] o.a.s.c.OverseerNodePrioritizer prioritizing
overseer nodes at 98289274814726156-127.0.0.1:61349_solr-n_0000000001 overseer
designates are [127.0.0.1:61348_solr]
[junit4] 2> 2395856 INFO
(OverseerCollectionConfigSetProcessor-98289274814726156-127.0.0.1:61349_solr-n_0000000001)
[n:127.0.0.1:61349_solr ] o.a.s.c.OverseerNodePrioritizer sorted nodes
[98289274814726156-127.0.0.1:61349_solr-n_0000000001,
98289274814726154-127.0.0.1:61348_solr-n_0000000002,
98289274814726155-127.0.0.1:61354_solr-n_0000000003,
98289274814726153-127.0.0.1:61345_solr-n_0000000004]
[junit4] 2> 2395860 INFO
(OverseerStateUpdate-98289274814726156-127.0.0.1:61349_solr-n_0000000001)
[n:127.0.0.1:61349_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"98289274814726156-127.0.0.1:61349_solr-n_0000000001"}
127.0.0.1:61349_solr
[junit4] 2> 2395861 INFO
(OverseerStateUpdate-98289274814726156-127.0.0.1:61349_solr-n_0000000001)
[n:127.0.0.1:61349_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61349_solr
[junit4] 2> 2395900 WARN (OverseerExitThread) [n:127.0.0.1:61349_solr
] o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 2395903 INFO
(zkCallback-3971-thread-1-processing-n:127.0.0.1:61348_solr)
[n:127.0.0.1:61348_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61348_solr
[junit4] 2> 2395905 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest ### Adding another overseer designate
127.0.0.1:61349_solr
[junit4] 2> 2395905 INFO (qtp1478135284-21779) [n:127.0.0.1:61349_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params
node=127.0.0.1:61349_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 2395906 INFO
(zkCallback-3971-thread-1-processing-n:127.0.0.1:61348_solr)
[n:127.0.0.1:61348_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726154-127.0.0.1:61348_solr-n_0000000002) starting
[junit4] 2> 2395909 INFO (OverseerExitThread) [n:127.0.0.1:61349_solr
] o.a.s.c.Overseer Overseer
(id=98289274814726156-127.0.0.1:61349_solr-n_0000000001) closing
[junit4] 2> 2395924 INFO
(OverseerThreadFactory-8690-thread-1-processing-n:127.0.0.1:61348_solr)
[n:127.0.0.1:61348_solr ] o.a.s.c.OverseerRoleCmd Overseer role added to
127.0.0.1:61349_solr
[junit4] 2> 2395926 INFO (qtp1478135284-21779) [n:127.0.0.1:61349_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:61349_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
status=0 QTime=20
[junit4] 2> 2395927 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:61348_solr
[junit4] 2> 2395927 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest Election queue:
[junit4] 2> 2395927 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.ChaosMonkey monkey: stop jetty! 61348
[junit4] 2> 2395927 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=86504522
[junit4] 2> 2395928 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2395929 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2395930 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2395931 INFO
(OverseerCollectionConfigSetProcessor-98289274814726154-127.0.0.1:61348_solr-n_0000000002)
[n:127.0.0.1:61348_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2395931 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2395932 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2395932 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.Overseer Overseer
(id=98289274814726154-127.0.0.1:61348_solr-n_0000000002) closing
[junit4] 2> 2395932 INFO
(OverseerStateUpdate-98289274814726154-127.0.0.1:61348_solr-n_0000000002)
[n:127.0.0.1:61348_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61348_solr
[junit4] 2> 2395936 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 0x15d31931e90000a, 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> 2395938 INFO
(zkCallback-3970-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61354_solr
[junit4] 2> 2395938 INFO
(zkCallback-3969-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2395944 INFO (zkCallback-3980-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2395945 ERROR (Thread-4418) [n:127.0.0.1:61348_solr ]
o.a.s.c.OverseerRoleCmd Error in prioritizing Overseer
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /roles.json
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1102)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:323)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:320)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:320)
[junit4] 2> at
org.apache.solr.cloud.OverseerNodePrioritizer.prioritizeOverseerNodes(OverseerNodePrioritizer.java:61)
[junit4] 2> at
org.apache.solr.cloud.OverseerRoleCmd.lambda$call$0(OverseerRoleCmd.java:93)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2395946 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@89fab14{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2395949 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@28833ee1{/solr,null,UNAVAILABLE}
[junit4] 2> 2395949 INFO
(zkCallback-3972-thread-1-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2395950 INFO
(zkCallback-3970-thread-2-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2395951 INFO
(zkCallback-3970-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726155-127.0.0.1:61354_solr-n_0000000003) starting
[junit4] 2> 2395979 INFO
(OverseerCollectionConfigSetProcessor-98289274814726155-127.0.0.1:61354_solr-n_0000000003)
[n:127.0.0.1:61354_solr ] o.a.s.c.OverseerNodePrioritizer prioritizing
overseer nodes at 98289274814726155-127.0.0.1:61354_solr-n_0000000003 overseer
designates are [127.0.0.1:61348_solr, 127.0.0.1:61349_solr]
[junit4] 2> 2395980 INFO
(OverseerCollectionConfigSetProcessor-98289274814726155-127.0.0.1:61354_solr-n_0000000003)
[n:127.0.0.1:61354_solr ] o.a.s.c.OverseerNodePrioritizer sorted nodes
[98289274814726155-127.0.0.1:61354_solr-n_0000000003,
98289274814726153-127.0.0.1:61345_solr-n_0000000004,
98289274814726156-127.0.0.1:61349_solr-n_0000000005]
[junit4] 2> 2395980 INFO
(OverseerCollectionConfigSetProcessor-98289274814726155-127.0.0.1:61354_solr-n_0000000003)
[n:127.0.0.1:61354_solr ] o.a.s.c.OverseerNodePrioritizer asking node
98289274814726156-127.0.0.1:61349_solr-n_0000000005 to come join election at
head
[junit4] 2> 2395983 INFO (qtp1478135284-21767) [n:127.0.0.1:61349_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=98289274814726156-127.0.0.1:61349_solr-n_0000000005&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2395983 INFO
(OverseerCollectionConfigSetProcessor-98289274814726155-127.0.0.1:61354_solr-n_0000000003)
[n:127.0.0.1:61354_solr ] o.a.s.c.OverseerNodePrioritizer asking the old
first in line 98289274814726153-127.0.0.1:61345_solr-n_0000000004 to rejoin
election
[junit4] 2> 2395985 INFO (qtp1484823938-21783) [n:127.0.0.1:61345_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=98289274814726153-127.0.0.1:61345_solr-n_0000000004&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2395988 INFO
(OverseerStateUpdate-98289274814726155-127.0.0.1:61354_solr-n_0000000003)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"98289274814726155-127.0.0.1:61354_solr-n_0000000003"}
127.0.0.1:61354_solr
[junit4] 2> 2395997 INFO
(OverseerStateUpdate-98289274814726155-127.0.0.1:61354_solr-n_0000000003)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61354_solr
[junit4] 2> 2395998 WARN (OverseerExitThread) [n:127.0.0.1:61354_solr
] o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 2395999 INFO (OverseerExitThread) [n:127.0.0.1:61354_solr
] o.a.s.c.Overseer Overseer
(id=98289274814726155-127.0.0.1:61354_solr-n_0000000003) closing
[junit4] 2> 2396000 INFO
(zkCallback-3969-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61345_solr
[junit4] 2> 2396003 INFO
(zkCallback-3969-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726153-127.0.0.1:61345_solr-n_0000000004) starting
[junit4] 2> 2396018 INFO
(OverseerCollectionConfigSetProcessor-98289274814726153-127.0.0.1:61345_solr-n_0000000004)
[n:127.0.0.1:61345_solr ] o.a.s.c.OverseerNodePrioritizer prioritizing
overseer nodes at 98289274814726153-127.0.0.1:61345_solr-n_0000000004 overseer
designates are [127.0.0.1:61348_solr, 127.0.0.1:61349_solr]
[junit4] 2> 2396024 INFO
(OverseerCollectionConfigSetProcessor-98289274814726153-127.0.0.1:61345_solr-n_0000000004)
[n:127.0.0.1:61345_solr ] o.a.s.c.OverseerNodePrioritizer sorted nodes
[98289274814726153-127.0.0.1:61345_solr-n_0000000004,
98289274814726156-127.0.0.1:61349_solr-n_0000000005,
98289274814726155-127.0.0.1:61354_solr-n_0000000006]
[junit4] 2> 2396030 INFO
(OverseerStateUpdate-98289274814726153-127.0.0.1:61345_solr-n_0000000004)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"98289274814726153-127.0.0.1:61345_solr-n_0000000004"}
127.0.0.1:61345_solr
[junit4] 2> 2396031 INFO
(OverseerStateUpdate-98289274814726153-127.0.0.1:61345_solr-n_0000000004)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61345_solr
[junit4] 2> 2396058 WARN (OverseerExitThread) [n:127.0.0.1:61345_solr
] o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 2396059 INFO (OverseerExitThread) [n:127.0.0.1:61345_solr
] o.a.s.c.Overseer Overseer
(id=98289274814726153-127.0.0.1:61345_solr-n_0000000004) closing
[junit4] 2> 2396059 INFO
(zkCallback-3972-thread-1-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61349_solr
[junit4] 2> 2396061 INFO
(zkCallback-3972-thread-1-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726156-127.0.0.1:61349_solr-n_0000000005) starting
[junit4] 2> 2396154 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest ### Adding last overseer designate
127.0.0.1:61354_solr
[junit4] 2> 2396155 INFO (qtp1478135284-21767) [n:127.0.0.1:61349_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params
node=127.0.0.1:61354_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 2396161 INFO
(OverseerThreadFactory-8697-thread-1-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.OverseerRoleCmd Overseer role added to
127.0.0.1:61354_solr
[junit4] 2> 2396163 INFO (qtp1478135284-21767) [n:127.0.0.1:61349_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:61354_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
status=0 QTime=7
[junit4] 2> 2396163 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:61349_solr
[junit4] 2> 2396164 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest Election queue:
[junit4] 2> 2396166 INFO (qtp1478135284-21786) [n:127.0.0.1:61349_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :removerole with
params
node=127.0.0.1:61349_solr&role=overseer&action=REMOVEROLE&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2396168 INFO
(OverseerCollectionConfigSetProcessor-98289274814726156-127.0.0.1:61349_solr-n_0000000005)
[n:127.0.0.1:61349_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2396174 INFO
(OverseerThreadFactory-8697-thread-2-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.OverseerRoleCmd Overseer role removed from
127.0.0.1:61349_solr
[junit4] 2> 2396176 INFO (qtp1478135284-21786) [n:127.0.0.1:61349_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:61349_solr&role=overseer&action=REMOVEROLE&wt=javabin&version=2}
status=0 QTime=10
[junit4] 2> 2396178 INFO (Thread-4421) [n:127.0.0.1:61349_solr ]
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at
98289274814726156-127.0.0.1:61349_solr-n_0000000005 overseer designates are
[127.0.0.1:61348_solr, 127.0.0.1:61354_solr]
[junit4] 2> 2396179 INFO (Thread-4421) [n:127.0.0.1:61349_solr ]
o.a.s.c.OverseerNodePrioritizer sorted nodes
[98289274814726156-127.0.0.1:61349_solr-n_0000000005,
98289274814726155-127.0.0.1:61354_solr-n_0000000006,
98289274814726153-127.0.0.1:61345_solr-n_0000000007]
[junit4] 2> 2396180 INFO
(OverseerStateUpdate-98289274814726156-127.0.0.1:61349_solr-n_0000000005)
[n:127.0.0.1:61349_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"98289274814726156-127.0.0.1:61349_solr-n_0000000005"}
127.0.0.1:61349_solr
[junit4] 2> 2396181 INFO
(OverseerStateUpdate-98289274814726156-127.0.0.1:61349_solr-n_0000000005)
[n:127.0.0.1:61349_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61349_solr
[junit4] 2> 2396181 WARN (OverseerExitThread) [n:127.0.0.1:61349_solr
] o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 2396182 INFO (OverseerExitThread) [n:127.0.0.1:61349_solr
] o.a.s.c.Overseer Overseer
(id=98289274814726156-127.0.0.1:61349_solr-n_0000000005) closing
[junit4] 2> 2396183 INFO
(zkCallback-3970-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61354_solr
[junit4] 2> 2396185 INFO
(zkCallback-3970-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726155-127.0.0.1:61354_solr-n_0000000006) starting
[junit4] 2> 2396278 INFO (qtp1478135284-21785) [n:127.0.0.1:61349_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params
node=127.0.0.1:61349_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 2396281 INFO
(OverseerThreadFactory-8699-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.OverseerRoleCmd Overseer role added to
127.0.0.1:61349_solr
[junit4] 2> 2396283 INFO (qtp1478135284-21785) [n:127.0.0.1:61349_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:61349_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
status=0 QTime=5
[junit4] 2> 2396283 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.c.OverseerRolesTest ### Sending QUIT to overseer 127.0.0.1:61354_solr
[junit4] 2> 2396286 INFO
(OverseerStateUpdate-98289274814726155-127.0.0.1:61354_solr-n_0000000006)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"98289274814726155-127.0.0.1:61354_solr-n_0000000006"}
127.0.0.1:61354_solr
[junit4] 2> 2396287 INFO
(OverseerStateUpdate-98289274814726155-127.0.0.1:61354_solr-n_0000000006)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61354_solr
[junit4] 2> 2396289 WARN (OverseerExitThread) [n:127.0.0.1:61354_solr
] o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 2396292 INFO (Thread-4422) [n:127.0.0.1:61354_solr ]
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at
98289274814726155-127.0.0.1:61354_solr-n_0000000006 overseer designates are
[127.0.0.1:61348_solr, 127.0.0.1:61354_solr, 127.0.0.1:61349_solr]
[junit4] 2> 2396293 INFO (Thread-4422) [n:127.0.0.1:61354_solr ]
o.a.s.c.OverseerNodePrioritizer sorted nodes
[98289274814726155-127.0.0.1:61354_solr-n_0000000006,
98289274814726153-127.0.0.1:61345_solr-n_0000000007,
98289274814726156-127.0.0.1:61349_solr-n_0000000008]
[junit4] 2> 2396293 INFO (Thread-4422) [n:127.0.0.1:61354_solr ]
o.a.s.c.OverseerNodePrioritizer asking node
98289274814726155-127.0.0.1:61354_solr-n_0000000006 to come join election at
head
[junit4] 2> 2396293 INFO (OverseerExitThread) [n:127.0.0.1:61354_solr
] o.a.s.c.Overseer Overseer
(id=98289274814726155-127.0.0.1:61354_solr-n_0000000006) closing
[junit4] 2> 2396296 INFO
(zkCallback-3969-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61345_solr
[junit4] 2> 2396298 INFO
(zkCallback-3969-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726153-127.0.0.1:61345_solr-n_0000000007) starting
[junit4] 2> 2396299 INFO (qtp1735680157-21773) [n:127.0.0.1:61354_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=98289274814726155-127.0.0.1:61354_solr-n_0000000006&wt=javabin&version=2}
status=0 QTime=3
[junit4] 2> 2396299 INFO (Thread-4422) [n:127.0.0.1:61354_solr ]
o.a.s.c.OverseerNodePrioritizer asking the old first in line
98289274814726153-127.0.0.1:61345_solr-n_0000000007 to rejoin election
[junit4] 2> 2396299 INFO (qtp1484823938-21749) [n:127.0.0.1:61345_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=98289274814726153-127.0.0.1:61345_solr-n_0000000007&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2396308 INFO
(OverseerStateUpdate-98289274814726153-127.0.0.1:61345_solr-n_0000000007)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"98289274814726153-127.0.0.1:61345_solr-n_0000000007"}
127.0.0.1:61345_solr
[junit4] 2> 2396309 INFO
(OverseerCollectionConfigSetProcessor-98289274814726153-127.0.0.1:61345_solr-n_0000000007)
[n:127.0.0.1:61345_solr ] o.a.s.c.OverseerNodePrioritizer prioritizing
overseer nodes at 98289274814726153-127.0.0.1:61345_solr-n_0000000007 overseer
designates are [127.0.0.1:61348_solr, 127.0.0.1:61354_solr,
127.0.0.1:61349_solr]
[junit4] 2> 2396309 INFO
(OverseerCollectionConfigSetProcessor-98289274814726153-127.0.0.1:61345_solr-n_0000000007)
[n:127.0.0.1:61345_solr ] o.a.s.c.OverseerNodePrioritizer sorted nodes
[98289274814726153-127.0.0.1:61345_solr-n_0000000007,
98289274814726155-127.0.0.1:61354_solr-n_0000000008,
98289274814726156-127.0.0.1:61349_solr-n_0000000008]
[junit4] 2> 2396311 INFO
(OverseerStateUpdate-98289274814726153-127.0.0.1:61345_solr-n_0000000007)
[n:127.0.0.1:61345_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61345_solr
[junit4] 2> 2396313 WARN (OverseerExitThread) [n:127.0.0.1:61345_solr
] o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 2396314 INFO (OverseerExitThread) [n:127.0.0.1:61345_solr
] o.a.s.c.Overseer Overseer
(id=98289274814726153-127.0.0.1:61345_solr-n_0000000007) closing
[junit4] 2> 2396314 INFO
(zkCallback-3970-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61354_solr
[junit4] 2> 2396315 INFO
(zkCallback-3970-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Overseer
(id=98289274814726155-127.0.0.1:61354_solr-n_0000000008) starting
[junit4] 2> 2396321 WARN
(OverseerStateUpdate-98289274814726155-127.0.0.1:61354_solr-n_0000000008)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Overseer received wrong QUIT
message {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"98289274814726153-127.0.0.1:61345_solr-n_0000000007"}
[junit4] 2> 2411351 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[121D6F1CECFA9990]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testOverseerRole
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=OverseerRolesTest
-Dtests.method=testOverseerRole -Dtests.seed=121D6F1CECFA9990 -Dtests.slow=true
-Dtests.locale=ru -Dtests.timezone=Asia/Thimphu -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 15.6s J1 | OverseerRolesTest.testOverseerRole <<<
[junit4] > Throwable #1: java.lang.AssertionError: Timed out waiting for
overseer state change
[junit4] > at
__randomizedtesting.SeedInfo.seed([121D6F1CECFA9990:F3D69288D749AF41]:0)
[junit4] > at
org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:62)
[junit4] > at
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:140)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2411355 INFO (jetty-closer-3951-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@38135902{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2411356 INFO (jetty-closer-3951-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1631390612
[junit4] 2> 2411356 INFO (jetty-closer-3951-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@d71d5c7{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2411357 INFO (jetty-closer-3951-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=383045178
[junit4] 2> 2411357 INFO (jetty-closer-3951-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2411357 INFO (jetty-closer-3951-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2411357 INFO (jetty-closer-3951-thread-4) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@439240d2{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2411358 INFO (jetty-closer-3951-thread-4) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=998859054
[junit4] 2> 2411358 INFO (jetty-closer-3951-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2411368 INFO (jetty-closer-3951-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2411368 INFO (jetty-closer-3951-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2411369 INFO (jetty-closer-3951-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2411377 INFO (jetty-closer-3951-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2411377 INFO (jetty-closer-3951-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2411377 INFO (jetty-closer-3951-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2411378 INFO (jetty-closer-3951-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2411378 INFO (jetty-closer-3951-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2411378 INFO (jetty-closer-3951-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2411379 INFO (jetty-closer-3951-thread-4) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2411379 INFO (jetty-closer-3951-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2411379 INFO (jetty-closer-3951-thread-4) [ ]
o.a.s.c.Overseer Overseer
(id=98289274814726155-127.0.0.1:61354_solr-n_0000000008) closing
[junit4] 2> 2411379 INFO (jetty-closer-3951-thread-2) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2411380 INFO
(OverseerStateUpdate-98289274814726155-127.0.0.1:61354_solr-n_0000000008)
[n:127.0.0.1:61354_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:61354_solr
[junit4] 2> 2412882 WARN
(zkCallback-3970-thread-1-processing-n:127.0.0.1:61354_solr)
[n:127.0.0.1:61354_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2412882 WARN
(zkCallback-3972-thread-1-processing-n:127.0.0.1:61349_solr)
[n:127.0.0.1:61349_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2412882 INFO (jetty-closer-3951-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@610efed1{/solr,null,UNAVAILABLE}
[junit4] 2> 2412882 WARN
(zkCallback-3969-thread-1-processing-n:127.0.0.1:61345_solr)
[n:127.0.0.1:61345_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2412882 INFO (jetty-closer-3951-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@10eedf1e{/solr,null,UNAVAILABLE}
[junit4] 2> 2412883 INFO (jetty-closer-3951-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2173c4bf{/solr,null,UNAVAILABLE}
[junit4] 2> 2412885 ERROR
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-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> 2412885 INFO
(SUITE-OverseerRolesTest-seed#[121D6F1CECFA9990]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:61341 61341
[junit4] 2> 2412886 INFO (Thread-4371) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:61341 61341
[junit4] 2> 2412887 WARN (Thread-4371) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 2
/solr/overseer_elect/election/98289274814726153-127.0.0.1:61345_solr-n_0000000007
[junit4] 2> 2
/solr/overseer_elect/election/98289274814726156-127.0.0.1:61349_solr-n_0000000008
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/overseer/queue-work
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 5 /solr/collections
[junit4] 2> 3 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_121D6F1CECFA9990-001
[junit4] 2> Jul 11, 2017 12:15:29 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): {},
docValues:{}, maxPointsInLeafNode=1646, maxMBSortInHeap=7.740889159894866,
sim=RandomSimilarity(queryNorm=false): {}, locale=ru, timezone=Asia/Thimphu
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_131
(64-bit)/cpus=3,threads=1,free=173695400,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestDistributedMissingSort,
TestSmileRequest, QueryResultKeyTest, CachingDirectoryFactoryTest,
TestNumericTerms32, TestPayloadCheckQParserPlugin, TestDocumentBuilder,
TestBadConfig, HLLUtilTest, CollectionsAPIAsyncDistributedZkTest,
TestSolrQueryParser, TestFileDictionaryLookup, TestCloudManagedSchema,
TestSQLHandler, TestCoreDiscovery, OpenExchangeRatesOrgProviderTest,
TestConfig, AddSchemaFieldsUpdateProcessorFactoryTest,
TestAnalyzeInfixSuggestions, DistributedFacetPivotSmallTest,
BasicFunctionalityTest, HdfsWriteToMultipleCollectionsTest,
TestHdfsBackupRestoreCore, TestJettySolrRunner, SpatialRPTFieldTypeTest,
TestFieldCacheSortRandom, LeaderElectionIntegrationTest, TestNRTOpen,
SOLR749Test, SynonymTokenizerTest, DistributedMLTComponentTest,
TestPKIAuthenticationPlugin, CacheHeaderTest, TestSlowCompositeReaderWrapper,
TestSha256AuthenticationProvider, TestConfigSetsAPI, HttpSolrCallGetCoreTest,
DistributedFacetPivotLongTailTest, SolrShardReporterTest,
LukeRequestHandlerTest, TestLegacyNumericUtils, TestBlobHandler,
HighlighterMaxOffsetTest, UpdateLogTest, TestConfigSetsAPIZkFailure,
SuggestComponentContextFilterQueryTest, StatsComponentTest,
SpellingQueryConverterTest, TestCustomDocTransformer, TestExceedMaxTermLength,
LeaderFailoverAfterPartitionTest, SolrCoreCheckLockOnStartupTest,
TestQueryWrapperFilter, ZkStateWriterTest, TestReload,
TestMiniSolrCloudCluster, AnalysisErrorHandlingTest,
OutOfBoxZkACLAndCredentialsProvidersTest, TestMergePolicyConfig,
TestCloudSchemaless, HdfsRecoveryZkTest, SolrCmdDistributorTest, TestMacros,
SuggesterTSTTest, TestCorePropertiesReload, PluginInfoTest,
SignatureUpdateProcessorFactoryTest, TestManagedSchemaAPI,
TestImpersonationWithHadoopAuth, TestSolrCoreParser,
SharedFSAutoReplicaFailoverUtilsTest, TestFilteredDocIdSet,
TestRemoteStreaming, PreAnalyzedFieldTest, InfoHandlerTest,
CustomCollectionTest, BaseCdcrDistributedZkTest, TestObjectReleaseTracker,
RankQueryTest, TestDynamicFieldResource, CdcrRequestHandlerTest,
PreAnalyzedFieldManagedSchemaCloudTest, TestLMJelinekMercerSimilarityFactory,
FieldMutatingUpdateProcessorTest, UpdateRequestProcessorFactoryTest,
ShufflingReplicaListTransformerTest, OverseerTaskQueueTest,
TestFieldCacheWithThreads, BadCopyFieldTest, TestSchemaVersionResource,
PropertiesRequestHandlerTest, SolrMetricManagerTest, TestTrie,
DistributedIntervalFacetingTest, TestAnalyzedSuggestions,
TestLocalFSCloudBackupRestore, ChaosMonkeySafeLeaderTest,
CdcrReplicationDistributedZkTest, MoreLikeThisHandlerTest,
HdfsTlogReplayBufferedWhileIndexingTest, SpellPossibilityIteratorTest,
SolrMetricsIntegrationTest, UtilsToolTest, TestSolrIndexConfig,
ChangedSchemaMergeTest, DeleteReplicaTest, TestLegacyNumericRangeQueryBuilder,
MetricsConfigTest, ConnectionManagerTest, UpdateParamsTest,
CoreAdminRequestStatusTest, LeaderInitiatedRecoveryOnCommitTest,
TestMissingGroups, TestRealTimeGet, FileBasedSpellCheckerTest, SmileWriterTest,
TlogReplayBufferedWhileIndexingTest, TestFiltering,
TestManagedSynonymFilterFactory, RecoveryAfterSoftCommitTest,
TestPerFieldSimilarity, TestJoin, TestConfigSetProperties,
TestGeoJSONResponseWriter, TestDocTermOrds, GraphQueryTest,
TestXmlQParserPlugin, DirectSolrSpellCheckerTest,
DistributedFacetExistsSmallTest, TestFieldResource, SolrCLIZkUtilsTest,
QueryEqualityTest, ActionThrottleTest,
StatelessScriptUpdateProcessorFactoryTest, BlockJoinFacetRandomTest,
TestFieldTypeResource, FullSolrCloudDistribCmdsTest,
CollectionsAPIDistributedZkTest, TestZkChroot, CollectionStateFormat2Test,
OpenCloseCoreStressTest, TestSolrDeletionPolicy1, RestartWhileUpdatingTest,
TestMiniSolrCloudClusterSSL, TestSolrJ, DocValuesMultiTest,
TestUninvertingReader, TestClassicSimilarityFactory, SolrGraphiteReporterTest,
TestSolrCloudWithKerberosAlt, TestRecoveryHdfs, TestSolr4Spatial,
LargeFieldTest, TestInfoStreamLogging, HdfsNNFailoverTest, TestPrepRecovery,
TestInPlaceUpdatesDistrib, TestSubQueryTransformerDistrib,
TolerantUpdateProcessorTest, TestClusterStateMutator, TermVectorComponentTest,
MetricUtilsTest, TestFastWriter, IndexSchemaRuntimeFieldTest,
TestUniqueKeyFieldResource, CopyFieldTest, TestCSVLoader, TestDynamicLoading,
ZkNodePropsTest, TestMultiValuedNumericRangeQuery, DateRangeFieldTest,
DistributedQueryComponentCustomSortTest, ExitableDirectoryReaderTest,
ConvertedLegacyTest, HttpPartitionTest, TestCopyFieldCollectionResource,
TestNumericRangeQuery64, BasicDistributedZk2Test, SyncSliceTest,
ShardRoutingTest, ClusterStateUpdateTest, TestRandomFaceting,
LeaderElectionTest, ZkSolrClientTest, ZkCLITest, ShardRoutingCustomTest,
TestDistributedSearch, TestRecovery, TermVectorComponentDistributedTest,
DistributedTermsComponentTest, SpellCheckComponentTest, TestSort,
DirectUpdateHandlerTest, TestIndexSearcher, SoftAutoCommitTest,
DistributedQueryElevationComponentTest, TestStressLucene, SuggesterWFSTTest,
NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest,
DirectUpdateHandlerOptimizeTest, DistanceFunctionTest,
IndexBasedSpellCheckerTest, TestQueryUtils, TestQueryTypes,
PrimitiveFieldTypeTest, XmlUpdateRequestHandlerTest, DocumentBuilderTest,
PathHierarchyTokenizerFactoryTest, RequiredFieldsTest, LoggingHandlerTest,
TestCollationField, ReturnFieldsTest, JsonLoaderTest, TestComponentsName,
SearchHandlerTest, HighlighterConfigTest, TestQuerySenderNoQuery,
ResponseLogComponentTest, SolrIndexConfigTest, BadComponentTest,
TestStressRecovery, TestSolrDeletionPolicy2, SampleTest, TestDocSet,
TestSearchPerf, NumericFieldsTest, TestElisionMultitermQuery, OutputWriterTest,
ExternalFileFieldSortTest, TestSolrCoreProperties, NotRequiredUniqueKeyTest,
TestLuceneMatchVersion, TestXIncludeConfig, TestDFRSimilarityFactory,
TestIBSimilarityFactory, TimeZoneUtilsTest, ResourceLoaderTest,
TestFastLRUCache, TestSuggestSpellingConverter, DateFieldTest,
RAMDirectoryFactoryTest, SliceStateTest, FileUtilsTest, TestRTGBase,
TestCrossCoreJoin, TestSimpleTrackingShardHandler, AssignTest,
CdcrBootstrapTest, ChaosMonkeySafeLeaderWithPullReplicasTest,
CleanupOldIndexTest, CloudExitableDirectoryReaderTest, CollectionsAPISolrJTest,
DistribDocExpirationUpdateProcessorTest, DistributedVersionInfoTest,
MissingSegmentRecoveryTest, MoveReplicaHDFSTest, MoveReplicaTest,
NodeMutatorTest, OverriddenZkACLAndCredentialsProvidersTest,
OverseerCollectionConfigSetProcessorTest, OverseerRolesTest]
[junit4] Completed [526/727 (1!)] on J1 in 18.73s, 1 test, 1 failure <<<
FAILURES!
[...truncated 44072 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
