Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.0-Linux/6/
Java: 64bit/jdk1.8.0_131 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED:
org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateWithDefaultConfigSet
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([EB933DF74ED7EB0D:A5389CB0116891FE]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateWithDefaultConfigSet(CollectionsAPISolrJTest.java:69)
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 12019 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPISolrJTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/init-core-data-001
[junit4] 2> 1002017 WARN
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1002017 INFO
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1002019 INFO
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-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> 1002019 INFO
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001
[junit4] 2> 1002019 INFO
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1002020 INFO (Thread-3790) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1002020 INFO (Thread-3790) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1002024 ERROR (Thread-3790) [ ] 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> 1002120 INFO
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:40459
[junit4] 2> 1002129 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 0x15d379b41cc0000, 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> 1002131 INFO (jetty-launcher-2038-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1002136 INFO (jetty-launcher-2038-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1002136 INFO (jetty-launcher-2038-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1002141 INFO (jetty-launcher-2038-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@29836c37{/solr,null,AVAILABLE}
[junit4] 2> 1002142 INFO (jetty-launcher-2038-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@77fbf90b{SSL,[ssl,
http/1.1]}{127.0.0.1:35975}
[junit4] 2> 1002144 INFO (jetty-launcher-2038-thread-4) [ ]
o.e.j.s.Server Started @1003501ms
[junit4] 2> 1002144 INFO (jetty-launcher-2038-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=35975}
[junit4] 2> 1002144 ERROR (jetty-launcher-2038-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1002144 INFO (jetty-launcher-2038-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 1002144 INFO (jetty-launcher-2038-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1002145 INFO (jetty-launcher-2038-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1002145 INFO (jetty-launcher-2038-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-12T16:21:48.233Z
[junit4] 2> 1002151 INFO (jetty-launcher-2038-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3ca12a05{/solr,null,AVAILABLE}
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1f13129f{/solr,null,AVAILABLE}
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6c4eed32{/solr,null,AVAILABLE}
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@65a5be63{SSL,[ssl,
http/1.1]}{127.0.0.1:39543}
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-1) [ ]
o.e.j.s.Server Started @1003531ms
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39543}
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6a3f18de{SSL,[ssl,
http/1.1]}{127.0.0.1:45479}
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-2) [ ]
o.e.j.s.Server Started @1003531ms
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45479}
[junit4] 2> 1002172 ERROR (jetty-launcher-2038-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1002172 INFO (jetty-launcher-2038-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@11b460c5{SSL,[ssl,
http/1.1]}{127.0.0.1:37933}
[junit4] 2> 1002173 INFO (jetty-launcher-2038-thread-3) [ ]
o.e.j.s.Server Started @1003531ms
[junit4] 2> 1002173 ERROR (jetty-launcher-2038-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1002173 INFO (jetty-launcher-2038-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37933}
[junit4] 2> 1002173 INFO (jetty-launcher-2038-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 1002173 INFO (jetty-launcher-2038-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1002173 INFO (jetty-launcher-2038-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1002173 ERROR (jetty-launcher-2038-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1002173 INFO (jetty-launcher-2038-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-12T16:21:48.261Z
[junit4] 2> 1002173 INFO (jetty-launcher-2038-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 1002173 INFO (jetty-launcher-2038-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 1002174 INFO (jetty-launcher-2038-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1002174 INFO (jetty-launcher-2038-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1002174 INFO (jetty-launcher-2038-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1002174 INFO (jetty-launcher-2038-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1002174 INFO (jetty-launcher-2038-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-12T16:21:48.262Z
[junit4] 2> 1002174 INFO (jetty-launcher-2038-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-12T16:21:48.262Z
[junit4] 2> 1002175 INFO (jetty-launcher-2038-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1002176 INFO (jetty-launcher-2038-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1002176 INFO (jetty-launcher-2038-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1002184 INFO (jetty-launcher-2038-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1002186 INFO (jetty-launcher-2038-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40459/solr
[junit4] 2> 1002188 INFO (jetty-launcher-2038-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40459/solr
[junit4] 2> 1002189 INFO (jetty-launcher-2038-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40459/solr
[junit4] 2> 1002189 INFO (jetty-launcher-2038-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40459/solr
[junit4] 2> 1002190 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 0x15d379b41cc0005, 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> 1002191 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 0x15d379b41cc0006, 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> 1002191 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 0x15d379b41cc0007, 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> 1002223 INFO (jetty-launcher-2038-thread-1)
[n:127.0.0.1:39543_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1002235 INFO (jetty-launcher-2038-thread-1)
[n:127.0.0.1:39543_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:39543_solr
[junit4] 2> 1002235 INFO (jetty-launcher-2038-thread-1)
[n:127.0.0.1:39543_solr ] o.a.s.c.Overseer Overseer
(id=98295906835365900-127.0.0.1:39543_solr-n_0000000000) starting
[junit4] 2> 1002243 INFO (jetty-launcher-2038-thread-1)
[n:127.0.0.1:39543_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39543_solr
[junit4] 2> 1002258 INFO
(zkCallback-2060-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1002269 INFO (jetty-launcher-2038-thread-4)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1002272 INFO (jetty-launcher-2038-thread-4)
[n:127.0.0.1:35975_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1002273 INFO (jetty-launcher-2038-thread-4)
[n:127.0.0.1:35975_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35975_solr
[junit4] 2> 1002274 INFO
(zkCallback-2060-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1002279 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1002290 INFO (jetty-launcher-2038-thread-2)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1002291 INFO (jetty-launcher-2038-thread-2)
[n:127.0.0.1:45479_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1002298 INFO (jetty-launcher-2038-thread-2)
[n:127.0.0.1:45479_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45479_solr
[junit4] 2> 1002299 INFO
(zkCallback-2058-thread-1-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1002299 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1002306 INFO (jetty-launcher-2038-thread-1)
[n:127.0.0.1:39543_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39543.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002306 INFO
(zkCallback-2060-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1002309 INFO (jetty-launcher-2038-thread-1)
[n:127.0.0.1:39543_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39543.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002310 INFO (jetty-launcher-2038-thread-1)
[n:127.0.0.1:39543_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39543.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002311 INFO (jetty-launcher-2038-thread-1)
[n:127.0.0.1:39543_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node1/.
[junit4] 2> 1002334 INFO (jetty-launcher-2038-thread-3)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 1002335 INFO (jetty-launcher-2038-thread-3)
[n:127.0.0.1:37933_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1002336 INFO (jetty-launcher-2038-thread-3)
[n:127.0.0.1:37933_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37933_solr
[junit4] 2> 1002336 INFO
(zkCallback-2060-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1002336 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1002342 INFO
(zkCallback-2058-thread-1-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1002369 INFO
(zkCallback-2059-thread-1-processing-n:127.0.0.1:37933_solr)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1002386 INFO (jetty-launcher-2038-thread-4)
[n:127.0.0.1:35975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35975.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002390 INFO (jetty-launcher-2038-thread-4)
[n:127.0.0.1:35975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35975.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002390 INFO (jetty-launcher-2038-thread-4)
[n:127.0.0.1:35975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35975.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002391 INFO (jetty-launcher-2038-thread-4)
[n:127.0.0.1:35975_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node4/.
[junit4] 2> 1002404 INFO (jetty-launcher-2038-thread-2)
[n:127.0.0.1:45479_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45479.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002408 INFO (jetty-launcher-2038-thread-2)
[n:127.0.0.1:45479_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45479.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002408 INFO (jetty-launcher-2038-thread-2)
[n:127.0.0.1:45479_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45479.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002409 INFO (jetty-launcher-2038-thread-2)
[n:127.0.0.1:45479_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node2/.
[junit4] 2> 1002409 INFO (jetty-launcher-2038-thread-3)
[n:127.0.0.1:37933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37933.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002411 INFO (jetty-launcher-2038-thread-3)
[n:127.0.0.1:37933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37933.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002411 INFO (jetty-launcher-2038-thread-3)
[n:127.0.0.1:37933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37933.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1002412 INFO (jetty-launcher-2038-thread-3)
[n:127.0.0.1:37933_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node3/.
[junit4] 2> 1002475 INFO
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1002476 INFO
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40459/solr ready
[junit4] 2> 1002496 INFO
(TEST-CollectionsAPISolrJTest.testCreateAndDeleteShard-seed#[EB933DF74ED7EB0D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateAndDeleteShard
[junit4] 2> 1002521 INFO (qtp1885287971-12368) [n:127.0.0.1:37933_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
pullReplicas=1&shards=shardA,shardB&replicationFactor=1&collection.configName=conf&maxShardsPerNode=3&name=solrj_implicit&router.name=implicit&nrtReplicas=1&action=CREATE&tlogReplicas=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1002522 INFO
(OverseerThreadFactory-4320-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.CreateCollectionCmd Create collection
solrj_implicit
[junit4] 2> 1002625 INFO
(OverseerStateUpdate-98295906835365900-127.0.0.1:39543_solr-n_0000000000)
[n:127.0.0.1:39543_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"solrj_implicit",
[junit4] 2> "shard":"shardA",
[junit4] 2> "core":"solrj_implicit_shardA_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:37933/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 1002626 INFO
(OverseerStateUpdate-98295906835365900-127.0.0.1:39543_solr-n_0000000000)
[n:127.0.0.1:39543_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"solrj_implicit",
[junit4] 2> "shard":"shardA",
[junit4] 2> "core":"solrj_implicit_shardA_replica_t1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45479/solr";,
[junit4] 2> "type":"TLOG"}
[junit4] 2> 1002627 INFO
(OverseerStateUpdate-98295906835365900-127.0.0.1:39543_solr-n_0000000000)
[n:127.0.0.1:39543_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"solrj_implicit",
[junit4] 2> "shard":"shardA",
[junit4] 2> "core":"solrj_implicit_shardA_replica_p1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:35975/solr";,
[junit4] 2> "type":"PULL"}
[junit4] 2> 1002628 INFO
(OverseerStateUpdate-98295906835365900-127.0.0.1:39543_solr-n_0000000000)
[n:127.0.0.1:39543_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"solrj_implicit",
[junit4] 2> "shard":"shardB",
[junit4] 2> "core":"solrj_implicit_shardB_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:39543/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 1002628 INFO
(OverseerStateUpdate-98295906835365900-127.0.0.1:39543_solr-n_0000000000)
[n:127.0.0.1:39543_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"solrj_implicit",
[junit4] 2> "shard":"shardB",
[junit4] 2> "core":"solrj_implicit_shardB_replica_t1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:37933/solr";,
[junit4] 2> "type":"TLOG"}
[junit4] 2> 1002629 INFO
(OverseerStateUpdate-98295906835365900-127.0.0.1:39543_solr-n_0000000000)
[n:127.0.0.1:39543_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"solrj_implicit",
[junit4] 2> "shard":"shardB",
[junit4] 2> "core":"solrj_implicit_shardB_replica_p1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45479/solr";,
[junit4] 2> "type":"PULL"}
[junit4] 2> 1002857 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_t1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 1002857 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1002858 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_n1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1002866 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_p1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=PULL
[junit4] 2> 1002867 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1002893 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_t1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 1002896 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_n1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1002896 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1002896 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1002914 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_p1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=PULL
[junit4] 2> 1003022 INFO
(zkCallback-2059-thread-1-processing-n:127.0.0.1:37933_solr)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003022 INFO
(zkCallback-2060-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003022 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003022 INFO
(zkCallback-2060-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003022 INFO
(zkCallback-2058-thread-1-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003025 INFO
(zkCallback-2057-thread-2-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003035 INFO
(zkCallback-2058-thread-2-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003863 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1003866 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.s.IndexSchema [solrj_implicit_shardA_replica_n1] Schema name=minimal
[junit4] 2> 1003868 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003868 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardA_replica_n1'
using configuration from collection solrj_implicit, trusted=true
[junit4] 2> 1003869 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37933.solr.core.solrj_implicit.shardA.replica_n1' (registry
'solr.core.solrj_implicit.shardA.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1003869 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003869 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1003869 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.SolrCore [[solrj_implicit_shardA_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node3/solrj_implicit_shardA_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node3/./solrj_implicit_shardA_replica_n1/data/]
[junit4] 2> 1003874 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.s.IndexSchema [solrj_implicit_shardB_replica_t1] Schema name=minimal
[junit4] 2> 1003875 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003875 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardB_replica_t1'
using configuration from collection solrj_implicit, trusted=true
[junit4] 2> 1003875 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37933.solr.core.solrj_implicit.shardB.replica_t1' (registry
'solr.core.solrj_implicit.shardB.replica_t1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1003875 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003875 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.SolrCore [[solrj_implicit_shardB_replica_t1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node3/solrj_implicit_shardB_replica_t1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node3/./solrj_implicit_shardB_replica_t1/data/]
[junit4] 2> 1003940 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1003944 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1003947 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.s.IndexSchema [solrj_implicit_shardA_replica_t1] Schema name=minimal
[junit4] 2> 1003948 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003948 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardA_replica_t1'
using configuration from collection solrj_implicit, trusted=true
[junit4] 2> 1003948 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45479.solr.core.solrj_implicit.shardA.replica_t1' (registry
'solr.core.solrj_implicit.shardA.replica_t1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1003949 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003949 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.c.SolrCore [[solrj_implicit_shardA_replica_t1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node2/solrj_implicit_shardA_replica_t1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node2/./solrj_implicit_shardA_replica_t1/data/]
[junit4] 2> 1003955 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1003955 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.s.IndexSchema [solrj_implicit_shardA_replica_p1] Schema name=minimal
[junit4] 2> 1003956 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1003957 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003957 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardA_replica_p1'
using configuration from collection solrj_implicit, trusted=true
[junit4] 2> 1003958 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35975.solr.core.solrj_implicit.shardA.replica_p1' (registry
'solr.core.solrj_implicit.shardA.replica_p1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1003958 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003958 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.c.SolrCore [[solrj_implicit_shardA_replica_p1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node4/solrj_implicit_shardA_replica_p1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node4/./solrj_implicit_shardA_replica_p1/data/]
[junit4] 2> 1003961 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.s.IndexSchema [solrj_implicit_shardB_replica_p1] Schema name=minimal
[junit4] 2> 1003962 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003962 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardB_replica_p1'
using configuration from collection solrj_implicit, trusted=true
[junit4] 2> 1003962 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45479.solr.core.solrj_implicit.shardB.replica_p1' (registry
'solr.core.solrj_implicit.shardB.replica_p1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1003963 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003963 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.c.SolrCore [[solrj_implicit_shardB_replica_p1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node2/solrj_implicit_shardB_replica_p1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node2/./solrj_implicit_shardB_replica_p1/data/]
[junit4] 2> 1003967 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.s.IndexSchema [solrj_implicit_shardB_replica_n1] Schema name=minimal
[junit4] 2> 1003968 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003968 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardB_replica_n1'
using configuration from collection solrj_implicit, trusted=true
[junit4] 2> 1003968 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39543.solr.core.solrj_implicit.shardB.replica_n1' (registry
'solr.core.solrj_implicit.shardB.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c1aa6c1
[junit4] 2> 1003968 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003968 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.c.SolrCore [[solrj_implicit_shardB_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node1/solrj_implicit_shardB_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001/tempDir-001/node1/./solrj_implicit_shardB_replica_n1/data/]
[junit4] 2> 1003977 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1003977 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1003978 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1003978 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1003980 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@736fcecd[solrj_implicit_shardA_replica_n1] main]
[junit4] 2> 1003981 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1003981 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1003982 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1003982 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1003986 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1003986 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1003986 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1003987 INFO
(searcherExecutor-4329-thread-1-processing-n:127.0.0.1:37933_solr
x:solrj_implicit_shardA_replica_n1 s:shardA c:solrj_implicit r:core_node1)
[n:127.0.0.1:37933_solr c:solrj_implicit s:shardA r:core_node1
x:solrj_implicit_shardA_replica_n1] o.a.s.c.SolrCore
[solrj_implicit_shardA_replica_n1] Registered new searcher
Searcher@736fcecd[solrj_implicit_shardA_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1003987 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1572734511428403200
[junit4] 2> 1003990 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@2033593a[solrj_implicit_shardB_replica_t1] main]
[junit4] 2> 1003991 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shardA: total=2 found=1 timeoutin=9999ms
[junit4] 2> 1003991 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1003991 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1003992 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1003992 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1572734511433646080
[junit4] 2> 1003995 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shardB: total=2 found=1 timeoutin=9999ms
[junit4] 2> 1003998 INFO
(searcherExecutor-4330-thread-1-processing-n:127.0.0.1:37933_solr
x:solrj_implicit_shardB_replica_t1 s:shardB c:solrj_implicit r:core_node5)
[n:127.0.0.1:37933_solr c:solrj_implicit s:shardB r:core_node5
x:solrj_implicit_shardB_replica_t1] o.a.s.c.SolrCore
[solrj_implicit_shardB_replica_t1] Registered new searcher
Searcher@2033593a[solrj_implicit_shardB_replica_t1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1004024 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1004024 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1004024 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1004024 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1004024 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1004024 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1004025 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1004025 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1004025 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1004025 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1004027 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@6c659c0e[solrj_implicit_shardA_replica_t1] main]
[junit4] 2> 1004027 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@4f293db2[solrj_implicit_shardB_replica_n1] main]
[junit4] 2> 1004027 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1004028 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1004028 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1004028 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1572734511471394816
[junit4] 2> 1004030 INFO
(searcherExecutor-4336-thread-1-processing-n:127.0.0.1:39543_solr
x:solrj_implicit_shardB_replica_n1 s:shardB c:solrj_implicit r:core_node4)
[n:127.0.0.1:39543_solr c:solrj_implicit s:shardB r:core_node4
x:solrj_implicit_shardB_replica_n1] o.a.s.c.SolrCore
[solrj_implicit_shardB_replica_n1] Registered new searcher
Searcher@4f293db2[solrj_implicit_shardB_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1004030 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@6d1dee56[solrj_implicit_shardB_replica_p1] main]
[junit4] 2> 1004031 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1004031 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1004032 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7837ecdb[solrj_implicit_shardA_replica_p1] main]
[junit4] 2> 1004033 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1004033 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1004034 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1004034 INFO
(searcherExecutor-4334-thread-1-processing-n:127.0.0.1:35975_solr
x:solrj_implicit_shardA_replica_p1 s:shardA c:solrj_implicit r:core_node3)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.c.SolrCore
[solrj_implicit_shardA_replica_p1] Registered new searcher
Searcher@7837ecdb[solrj_implicit_shardA_replica_p1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1004038 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.c.ZkController solrj_implicit_shardA_replica_p1 starting background
replication from leader
[junit4] 2> 1004038 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll
interval: 00:00:03
[junit4] 2> 1004040 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms
[junit4] 2> 1004040 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1004040 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1004040 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1004040 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1004041 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1004041 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1004041 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1572734511485026304
[junit4] 2> 1004041 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.c.ZkController solrj_implicit_shardB_replica_p1 starting background
replication from leader
[junit4] 2> 1004041 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll
interval: 00:00:03
[junit4] 2> 1004045 INFO
(searcherExecutor-4333-thread-1-processing-n:127.0.0.1:45479_solr
x:solrj_implicit_shardA_replica_t1 s:shardA c:solrj_implicit r:core_node2)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardA r:core_node2
x:solrj_implicit_shardA_replica_t1] o.a.s.c.SolrCore
[solrj_implicit_shardA_replica_t1] Registered new searcher
Searcher@6c659c0e[solrj_implicit_shardA_replica_t1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1004046 INFO
(searcherExecutor-4335-thread-1-processing-n:127.0.0.1:45479_solr
x:solrj_implicit_shardB_replica_p1 s:shardB c:solrj_implicit r:core_node6)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardB r:core_node6
x:solrj_implicit_shardB_replica_p1] o.a.s.c.SolrCore
[solrj_implicit_shardB_replica_p1] Registered new searcher
Searcher@6d1dee56[solrj_implicit_shardB_replica_p1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1004049 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms
[junit4] 2> 1004098 INFO
(zkCallback-2058-thread-2-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004098 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004098 INFO
(zkCallback-2058-thread-1-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004099 INFO
(zkCallback-2060-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004099 INFO
(zkCallback-2060-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004099 INFO
(zkCallback-2059-thread-1-processing-n:127.0.0.1:37933_solr)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004101 INFO
(zkCallback-2057-thread-2-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004491 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1004491 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1004491 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:37933/solr/solrj_implicit_shardA_replica_n1/
[junit4] 2> 1004492 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.u.PeerSync PeerSync: core=solrj_implicit_shardA_replica_n1
url=https://127.0.0.1:37933/solr START
replicas=[https://127.0.0.1:45479/solr/solrj_implicit_shardA_replica_t1/]
nUpdates=100
[junit4] 2> 1004492 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.u.PeerSync PeerSync: core=solrj_implicit_shardA_replica_n1
url=https://127.0.0.1:37933/solr DONE. We have no versions. sync failed.
[junit4] 2> 1004496 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1004500 INFO (qtp1348964544-12388) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.c.S.Request [solrj_implicit_shardA_replica_t1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=5
[junit4] 2> 1004500 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1004500 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:37933/solr/solrj_implicit_shardB_replica_t1/
[junit4] 2> 1004500 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 1004500 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1004500 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1004500 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.u.PeerSync PeerSync: core=solrj_implicit_shardB_replica_t1
url=https://127.0.0.1:37933/solr START
replicas=[https://127.0.0.1:39543/solr/solrj_implicit_shardB_replica_n1/]
nUpdates=100
[junit4] 2> 1004502 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:37933/solr/solrj_implicit_shardA_replica_n1/ shardA
[junit4] 2> 1004509 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.u.PeerSync PeerSync: core=solrj_implicit_shardB_replica_t1
url=https://127.0.0.1:37933/solr DONE. We have no versions. sync failed.
[junit4] 2> 1004514 INFO (qtp217898430-12386) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.c.S.Request [solrj_implicit_shardB_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1004514 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 1004514 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
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> 1004514 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1004514 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.ZkController solrj_implicit_shardB_replica_t1 stopping background
replication from leader
[junit4] 2> 1004516 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:37933/solr/solrj_implicit_shardB_replica_t1/ shardB
[junit4] 2> 1004617 INFO
(zkCallback-2059-thread-1-processing-n:127.0.0.1:37933_solr)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004617 INFO
(zkCallback-2058-thread-1-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004617 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004617 INFO
(zkCallback-2058-thread-2-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004617 INFO
(zkCallback-2060-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004617 INFO
(zkCallback-2057-thread-2-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004617 INFO
(zkCallback-2060-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004650 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.h.IndexFetcher Replica core_node1 is
leader but it's state is down, skipping replication
[junit4] 2> 1004650 INFO (indexFetcher-4360-thread-1)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardB r:core_node6
x:solrj_implicit_shardB_replica_p1] o.a.s.h.IndexFetcher Replica core_node5 is
leader but it's state is down, skipping replication
[junit4] 2> 1004653 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1004654 INFO (qtp1885287971-12404) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_n1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1796
[junit4] 2> 1004666 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1004668 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardB r:core_node5 x:solrj_implicit_shardB_replica_t1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_t1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=TLOG}
status=0 QTime=1810
[junit4] 2> 1004780 INFO
(zkCallback-2058-thread-1-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004780 INFO
(zkCallback-2060-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004780 INFO
(zkCallback-2058-thread-2-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004780 INFO
(zkCallback-2060-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004780 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004780 INFO
(zkCallback-2059-thread-1-processing-n:127.0.0.1:37933_solr)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004780 INFO
(zkCallback-2057-thread-2-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1005033 INFO (qtp217898430-12387) [n:127.0.0.1:39543_solr
c:solrj_implicit s:shardB r:core_node4 x:solrj_implicit_shardB_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_n1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2137
[junit4] 2> 1005041 INFO (qtp3289887-12372) [n:127.0.0.1:35975_solr
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_p1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_p1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=PULL}
status=0 QTime=2174
[junit4] 2> 1005049 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.c.ZkController solrj_implicit_shardA_replica_t1 starting background
replication from leader
[junit4] 2> 1005049 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll
interval: 00:00:03
[junit4] 2> 1005050 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms
[junit4] 2> 1005051 INFO (qtp1348964544-12401) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardB r:core_node6 x:solrj_implicit_shardB_replica_p1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_p1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=PULL}
status=0 QTime=2136
[junit4] 2> 1005052 INFO (qtp1348964544-12393) [n:127.0.0.1:45479_solr
c:solrj_implicit s:shardA r:core_node2 x:solrj_implicit_shardA_replica_t1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_t1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=TLOG}
status=0 QTime=2158
[junit4] 2> 1005055 INFO (qtp1885287971-12368) [n:127.0.0.1:37933_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1005153 INFO
(zkCallback-2059-thread-1-processing-n:127.0.0.1:37933_solr)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1005153 INFO
(zkCallback-2057-thread-2-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1005153 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1005153 INFO
(zkCallback-2058-thread-1-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1005153 INFO
(zkCallback-2060-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1005153 INFO
(zkCallback-2058-thread-2-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1005153 INFO
(zkCallback-2060-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1006055 INFO (qtp1885287971-12368) [n:127.0.0.1:37933_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={pullReplicas=1&shards=shardA,shardB&replicationFactor=1&collection.configName=conf&maxShardsPerNode=3&name=solrj_implicit&router.name=implicit&nrtReplicas=1&action=CREATE&tlogReplicas=1&wt=javabin&version=2}
status=0 QTime=3533
[junit4] 2> 1006055 INFO (qtp1885287971-12400) [n:127.0.0.1:37933_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createshard with
params
action=CREATESHARD&collection=solrj_implicit&shard=shardC&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1006056 INFO
(OverseerThreadFactory-4320-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.CreateShardCmd Create shard invoked: {
[junit4] 2> "collection":"solrj_implicit",
[junit4] 2> "shard":"shardC",
[junit4] 2> "operation":"createshard"}
[junit4] 2> 1006056 INFO
(OverseerCollectionConfigSetProcessor-98295906835365900-127.0.0.1:39543_solr-n_0000000000)
[n:127.0.0.1:39543_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> 1006158 INFO
(zkCallback-2057-thread-1-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1006158 INFO
(zkCallback-2058-thread-2-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1006158 INFO
(zkCallback-2057-thread-2-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1006158 INFO
(zkCallback-2058-thread-1-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1006158 INFO
(zkCallback-2059-thread-1-processing-n:127.0.0.1:37933_solr)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1006159 INFO
(zkCallback-2060-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1006159 INFO
(zkCallback-2060-thread-2-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 1006479 INFO (indexFetcher-4362-thread-1)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardA r:core_node2
x:solrj_implicit_shardA_replica_t1] o.a.s.h.IndexFetcher Updated masterUrl to
https://127.0.0.1:37933/solr/solrj_implicit_shardA_replica_n1/
[junit4] 2> 1006481 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.S.Request [solrj_implicit_shardA_replica_n1] webapp=/solr
path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 1006481 INFO (indexFetcher-4362-thread-1)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardA r:core_node2
x:solrj_implicit_shardA_replica_t1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 1006481 INFO (indexFetcher-4362-thread-1)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardA r:core_node2
x:solrj_implicit_shardA_replica_t1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 1006481 INFO (indexFetcher-4362-thread-1)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardA r:core_node2
x:solrj_implicit_shardA_replica_t1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1006481 INFO (indexFetcher-4362-thread-1)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardA r:core_node2
x:solrj_implicit_shardA_replica_t1] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 1007040 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.h.IndexFetcher Last replication
failed, so I'll force replication
[junit4] 2> 1007040 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.h.IndexFetcher Updated masterUrl to
https://127.0.0.1:37933/solr/solrj_implicit_shardA_replica_n1/
[junit4] 2> 1007041 INFO (qtp1885287971-12370) [n:127.0.0.1:37933_solr
c:solrj_implicit s:shardA r:core_node1 x:solrj_implicit_shardA_replica_n1]
o.a.s.c.S.Request [solrj_implicit_shardA_replica_n1] webapp=/solr
path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 1007041 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 1007041 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 1007041 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1007041 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 1007041 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.h.IndexFetcher New index in Master.
Deleting mine...
[junit4] 2> 1007041 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1007041 INFO (indexFetcher-4358-thread-1)
[n:127.0.0.1:35975_solr c:solrj_implicit s:shardA r:core_node3
x:solrj_implicit_shardA_replica_p1] o.a.s.u.SolrIndexWriter Calling
setCommitData with IW:org.apache.solr.update.SolrIndexWriter@7c0e8d63
commitCommandVersion:0
[junit4] 2> 1007042 INFO (indexFetcher-4360-thread-1)
[n:127.0.0.1:45479_solr c:solrj_implicit s:shardB r:core_node6
x:solrj_implicit_shardB_replica_p1] o.a.s.h.IndexFetcher Last replication
failed, so I'll force replication
[junit4] 2> 1007043 INFO (indexF
[...truncated too long message...]
4] 2> 1082235 INFO
(zkCallback-2058-thread-3-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 1082236 INFO (coreCloseExecutor-4541-thread-5)
[n:127.0.0.1:45479_solr c:aliasedCollection s:shard1 r:core_node1
x:aliasedCollection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.aliasedCollection.shard1.leader,
tag=2019800532
[junit4] 2> 1082236 INFO (coreCloseExecutor-4541-thread-6)
[n:127.0.0.1:45479_solr c:solrj_test_core_props s:shard1 r:core_node1
x:solrj_test_core_props_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.core.solrj_test_core_props.shard1.replica_n1, tag=1807572054
[junit4] 2> 1082239 INFO (coreCloseExecutor-4541-thread-6)
[n:127.0.0.1:45479_solr c:solrj_test_core_props s:shard1 r:core_node1
x:solrj_test_core_props_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.solrj_test_core_props.shard1.leader, tag=1807572054
[junit4] 2> 1082241 INFO (coreCloseExecutor-4541-thread-4)
[n:127.0.0.1:45479_solr c:solrj_replicatests s:shard1 r:core_node1
x:solrj_replicatests_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for registry=solr.core.solrj_replicatests.shard1.replica_n1,
tag=845522594
[junit4] 2> 1082244 INFO (coreCloseExecutor-4541-thread-4)
[n:127.0.0.1:45479_solr c:solrj_replicatests s:shard1 r:core_node1
x:solrj_replicatests_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for registry=solr.collection.solrj_replicatests.shard1.leader,
tag=845522594
[junit4] 2> 1082244 INFO (coreCloseExecutor-4541-thread-7)
[n:127.0.0.1:45479_solr c:corestatus_test s:shard2 r:core_node3
x:corestatus_test_shard2_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.corestatus_test.shard2.leader,
tag=1423256697
[junit4] 2> 1082244 INFO (coreCloseExecutor-4541-thread-9)
[n:127.0.0.1:45479_solr c:solrj_newstateformat s:shard1 r:core_node2
x:solrj_newstateformat_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing
metric reporters for registry=solr.core.solrj_newstateformat.shard1.replica_n2,
tag=1981395457
[junit4] 2> 1082247 INFO (coreCloseExecutor-4541-thread-9)
[n:127.0.0.1:45479_solr c:solrj_newstateformat s:shard1 r:core_node2
x:solrj_newstateformat_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.solrj_newstateformat.shard1.leader, tag=1981395457
[junit4] 2> 1082247 INFO (coreCloseExecutor-4541-thread-3)
[n:127.0.0.1:45479_solr c:replicaProperties s:shard2 r:core_node4
x:replicaProperties_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.replicaProperties.shard2.leader,
tag=267648672
[junit4] 2> 1082253 WARN
(zkCallback-2058-thread-3-processing-n:127.0.0.1:45479_solr)
[n:127.0.0.1:45479_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1082253 INFO (jetty-closer-2039-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1f13129f{/solr,null,UNAVAILABLE}
[junit4] 2> 1083728 WARN
(zkCallback-2059-thread-5-processing-n:127.0.0.1:37933_solr)
[n:127.0.0.1:37933_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1083728 INFO (jetty-closer-2039-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6c4eed32{/solr,null,UNAVAILABLE}
[junit4] 2> 1083731 WARN
(zkCallback-2057-thread-5-processing-n:127.0.0.1:35975_solr)
[n:127.0.0.1:35975_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1083731 INFO (jetty-closer-2039-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@29836c37{/solr,null,UNAVAILABLE}
[junit4] 2> 1083731 ERROR
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-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> 1083732 INFO
(SUITE-CollectionsAPISolrJTest-seed#[EB933DF74ED7EB0D]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:40459 40459
[junit4] 2> 1084537 INFO (Thread-3790) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:40459 40459
[junit4] 2> 1084538 WARN (Thread-3790) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/collections/solrj_test/state.json
[junit4] 2> 8 /solr/collections/corestatus_test/state.json
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 4 /solr/security.json
[junit4] 2> 4 /solr/configs/conf
[junit4] 2> 4
/solr/collections/solrj_default_configset/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 59 /solr/collections/replicaProperties/state.json
[junit4] 2> 56 /solr/collections/solrj_implicit/state.json
[junit4] 2> 55
/solr/collections/solrj_test_splitshard/state.json
[junit4] 2> 39 /solr/collections/balancedProperties/state.json
[junit4] 2> 35
/solr/collections/solrj_newstateformat/state.json
[junit4] 2> 23 /solr/collections/solrj_replicatests/state.json
[junit4] 2> 12
/solr/collections/solrj_default_configset/state.json
[junit4] 2> 6 /solr/collections/aliasedCollection/state.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 5
/solr/collections/solrj_test_core_props/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 5 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_EB933DF74ED7EB0D-001
[junit4] 2> NOTE: test params are:
codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
chunkSize=1, maxDocsPerChunk=344, blockSize=3),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY,
chunkSize=1, blockSize=3)), sim=RandomSimilarity(queryNorm=false): {},
locale=sl-SI, timezone=America/Danmarkshavn
[junit4] 2> NOTE: Linux 4.10.0-26-generic amd64/Oracle Corporation
1.8.0_131 (64-bit)/cpus=8,threads=1,free=216027616,total=536870912
[junit4] 2> NOTE: All tests run in this JVM:
[TestTolerantUpdateProcessorCloud, TestJettySolrRunner, TestSolrCLIRunExample,
TestRandomCollapseQParserPlugin, SignatureUpdateProcessorFactoryTest,
TestFreeTextSuggestions, TestRebalanceLeaders, TestRawTransformer,
AliasIntegrationTest, TestJavabinTupleStreamParser, TestSolrConfigHandlerCloud,
JvmMetricsTest, TermsComponentTest, QueryEqualityTest, TestZkChroot,
LeaderElectionTest, SegmentsInfoRequestHandlerTest,
TestLMJelinekMercerSimilarityFactory, MultiThreadedOCPTest, AutoCommitTest,
NumericFieldsTest, DateFieldTest, TimeZoneUtilsTest, TestSurroundQueryParser,
DirectUpdateHandlerTest, OverriddenZkACLAndCredentialsProvidersTest,
PreAnalyzedFieldTest, ConnectionManagerTest, BaseCdcrDistributedZkTest,
SmileWriterTest, TestJmxIntegration, HdfsRestartWhileUpdatingTest,
TestPullReplicaErrorHandling, TestStressInPlaceUpdates,
TestSubQueryTransformer, LeaderFailoverAfterPartitionTest,
TestCollapseQParserPlugin, TestPolicyCloud, TestSuggestSpellingConverter,
MetricsHandlerTest, AddBlockUpdateTest, ReplaceNodeTest, InfixSuggestersTest,
TestDocBasedVersionConstraints, SearchHandlerTest, RulesTest,
BlockDirectoryTest, TestInPlaceUpdatesDistrib, SolrSlf4jReporterTest,
BlockJoinFacetSimpleTest, TestRequestStatusCollectionAPI, TestCollectionAPI,
TestCollectionAPIs, DeleteInactiveReplicaTest, RankQueryTest,
SearchHandlerTest, EnumFieldTest, TestDFRSimilarityFactory,
TestCollationFieldDocValues, TestTrie, SolrGangliaReporterTest, SuggesterTest,
DeleteReplicaTest, TestDistributedMissingSort, SolrCoreCheckLockOnStartupTest,
DistributedFacetPivotSmallTest, ZkStateWriterTest, TestGraphTermsQParserPlugin,
DirectUpdateHandlerOptimizeTest, SubstringBytesRefFilterTest,
TolerantUpdateProcessorTest, TestQuerySenderListener,
TestReversedWildcardFilterFactory, TestMultiWordSynonyms, TestRecoveryHdfs,
PingRequestHandlerTest, TestManagedSchemaAPI,
LeaderInitiatedRecoveryOnShardRestartTest, TestCodecSupport,
TestSimpleQParserPlugin, CachingDirectoryFactoryTest, TestBulkSchemaAPI,
ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestMinMaxOnMultiValuedField,
IgnoreCommitOptimizeUpdateProcessorFactoryTest,
UninvertDocValuesMergePolicyTest, HdfsNNFailoverTest, OverseerTest,
ShowFileRequestHandlerTest, FastVectorHighlighterTest,
TestManagedStopFilterFactory, TestExportWriter,
ClassificationUpdateProcessorTest, HLLSerializationTest,
TestPseudoReturnFields, TestNumericTerms32, TestSolrCoreProperties,
XsltUpdateRequestHandlerTest, TestRuleBasedAuthorizationPlugin, PolyFieldTest,
VersionInfoTest, TestPerFieldSimilarityWithDefaultOverride, TestFastWriter,
PathHierarchyTokenizerFactoryTest, TestCorePropertiesReload,
SpellPossibilityIteratorTest, PKIAuthenticationIntegrationTest,
RequiredFieldsTest, NotRequiredUniqueKeyTest, CdcrReplicationHandlerTest,
TermVectorComponentDistributedTest, DistributedQueryComponentOptimizationTest,
SolrMetricManagerTest, CopyFieldTest, HdfsLockFactoryTest,
TestSchemaVersionResource, CollectionsAPISolrJTest]
[junit4] Completed [362/727 (1!)] on J2 in 82.54s, 13 tests, 1 failure <<<
FAILURES!
[...truncated 44542 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
