Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19205/
Java: 32bit/jdk1.8.0_121 -client -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.cloud.OnlyLeaderIndexesTest.test
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([62BD3E2FB1FF1651:EAE901F51F037BA9]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at org.junit.Assert.assertNotNull(Assert.java:537)
at
org.apache.solr.cloud.OnlyLeaderIndexesTest.outOfOrderDBQWithInPlaceUpdatesTest(OnlyLeaderIndexesTest.java:295)
at
org.apache.solr.cloud.OnlyLeaderIndexesTest.test(OnlyLeaderIndexesTest.java:78)
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:745)
Build Log:
[...truncated 11050 lines...]
[junit4] Suite: org.apache.solr.cloud.OnlyLeaderIndexesTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/init-core-data-001
[junit4] 2> 43638 WARN
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=26 numCloses=26
[junit4] 2> 43638 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 43640 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-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> 43641 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001
[junit4] 2> 43641 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 43642 INFO (Thread-128) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 43642 INFO (Thread-128) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 43742 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:37557
[junit4] 2> 43786 INFO (jetty-launcher-134-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 43786 INFO (jetty-launcher-134-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 43786 INFO (jetty-launcher-134-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 43787 INFO (jetty-launcher-134-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@139ee48{/solr,null,AVAILABLE}
[junit4] 2> 43793 INFO (jetty-launcher-134-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@54c06a{/solr,null,AVAILABLE}
[junit4] 2> 43793 INFO (jetty-launcher-134-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@141c907{/solr,null,AVAILABLE}
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@86163{SSL,[ssl,
http/1.1]}{127.0.0.1:44230}
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@35b218{SSL,[ssl,
http/1.1]}{127.0.0.1:42813}
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-1) [ ]
o.e.j.s.Server Started @45055ms
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1848f91{SSL,[ssl,
http/1.1]}{127.0.0.1:44644}
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=44230}
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-2) [ ]
o.e.j.s.Server Started @45055ms
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-3) [ ]
o.e.j.s.Server Started @45055ms
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=42813}
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=44644}
[junit4] 2> 43795 ERROR (jetty-launcher-134-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 43795 ERROR (jetty-launcher-134-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 43795 ERROR (jetty-launcher-134-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 43796 INFO (jetty-launcher-134-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-03-19T05:01:12.419Z
[junit4] 2> 43796 INFO (jetty-launcher-134-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-03-19T05:01:12.420Z
[junit4] 2> 43795 INFO (jetty-launcher-134-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-03-19T05:01:12.419Z
[junit4] 2> 43798 INFO (jetty-launcher-134-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 43798 INFO (jetty-launcher-134-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 43799 INFO (jetty-launcher-134-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 43819 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 0x15ae4f0d2cb0002, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 43823 INFO (jetty-launcher-134-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37557/solr
[junit4] 2> 43824 INFO (jetty-launcher-134-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37557/solr
[junit4] 2> 43824 INFO (jetty-launcher-134-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37557/solr
[junit4] 2> 43827 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 0x15ae4f0d2cb0005, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 43828 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 0x15ae4f0d2cb0006, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 43847 INFO (jetty-launcher-134-thread-2)
[n:127.0.0.1:42813_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 43848 INFO (jetty-launcher-134-thread-2)
[n:127.0.0.1:42813_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:42813_solr
[junit4] 2> 43849 INFO (jetty-launcher-134-thread-2)
[n:127.0.0.1:42813_solr ] o.a.s.c.Overseer Overseer
(id=97642064921690120-127.0.0.1:42813_solr-n_0000000000) starting
[junit4] 2> 43849 INFO (jetty-launcher-134-thread-1)
[n:127.0.0.1:44230_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 43849 INFO (jetty-launcher-134-thread-3)
[n:127.0.0.1:44644_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 43850 INFO (jetty-launcher-134-thread-1)
[n:127.0.0.1:44230_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:44230_solr
[junit4] 2> 43850 INFO (jetty-launcher-134-thread-3)
[n:127.0.0.1:44644_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:44644_solr
[junit4] 2> 43853 INFO
(zkCallback-151-thread-1-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 43853 INFO
(zkCallback-149-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 43853 INFO
(zkCallback-150-thread-1-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 43858 INFO (jetty-launcher-134-thread-2)
[n:127.0.0.1:42813_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42813_solr
[junit4] 2> 43859 INFO
(zkCallback-151-thread-1-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 43859 INFO
(zkCallback-150-thread-1-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 43859 INFO
(zkCallback-149-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 44071 INFO (jetty-launcher-134-thread-1)
[n:127.0.0.1:44230_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node1/.
[junit4] 2> 44115 INFO (jetty-launcher-134-thread-3)
[n:127.0.0.1:44644_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node3/.
[junit4] 2> 44290 INFO (jetty-launcher-134-thread-2)
[n:127.0.0.1:42813_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node2/.
[junit4] 2> 44319 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 44320 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37557/solr ready
[junit4] 2> 44389 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=3&collection.configName=config&maxShardsPerNode=1&name=collection1&realtimeReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 44392 INFO
(OverseerThreadFactory-235-thread-1-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.CreateCollectionCmd Create collection
collection1
[junit4] 2> 44505 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=config&newCollection=true&name=collection1_shard1_replica3&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2
[junit4] 2> 44564 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=config&newCollection=true&name=collection1_shard1_replica2&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2
[junit4] 2> 44564 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=config&newCollection=true&name=collection1_shard1_replica1&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2
[junit4] 2> 44669 INFO
(zkCallback-150-thread-2-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 44669 INFO
(zkCallback-149-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 44669 INFO
(zkCallback-151-thread-1-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 45520 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 45542 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.s.IndexSchema
[collection1_shard1_replica3] Schema name=minimal
[junit4] 2> 45548 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 45549 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard1_replica3' using configuration from
collection collection1
[junit4] 2> 45556 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 45556 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.c.SolrCore
[[collection1_shard1_replica3] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node3/collection1_shard1_replica3],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node3/./collection1_shard1_replica3/data/]
[junit4] 2> 45586 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 45586 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 45608 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.s.IndexSchema
[collection1_shard1_replica2] Schema name=minimal
[junit4] 2> 45608 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema
[collection1_shard1_replica1] Schema name=minimal
[junit4] 2> 45617 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 45618 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 45619 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard1_replica2' using configuration from
collection collection1
[junit4] 2> 45619 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard1_replica1' using configuration from
collection collection1
[junit4] 2> 45620 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 45620 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 45620 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[[collection1_shard1_replica1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node2/collection1_shard1_replica1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node2/./collection1_shard1_replica1/data/]
[junit4] 2> 45620 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
[[collection1_shard1_replica2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node1/collection1_shard1_replica2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node1/./collection1_shard1_replica2/data/]
[junit4] 2> 45659 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 45659 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 45660 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 45660 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 45662 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@1ac5c32[collection1_shard1_replica3] main]
[junit4] 2> 45665 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/config
[junit4] 2> 45665 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 45665 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 45665 INFO
(searcherExecutor-242-thread-1-processing-n:127.0.0.1:44644_solr
x:collection1_shard1_replica3 s:shard1 c:collection1) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.c.SolrCore
[collection1_shard1_replica3] Registered new searcher
Searcher@1ac5c32[collection1_shard1_replica3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 45666 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1562273040868311040
[junit4] 2> 45684 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=3 found=1 timeoutin=9999ms
[junit4] 2> 45713 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 45713 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 45714 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 45714 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 45714 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 45714 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 45715 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 45715 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 45716 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@11e7ae0[collection1_shard1_replica1] main]
[junit4] 2> 45716 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening [Searcher@df9822[collection1_shard1_replica2]
main]
[junit4] 2> 45717 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/config
[junit4] 2> 45717 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/config
[junit4] 2> 45718 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 45718 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 45718 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 45718 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 45718 INFO
(searcherExecutor-243-thread-1-processing-n:127.0.0.1:44230_solr
x:collection1_shard1_replica2 s:shard1 c:collection1) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
[collection1_shard1_replica2] Registered new searcher
Searcher@df9822[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 45718 INFO
(searcherExecutor-244-thread-1-processing-n:127.0.0.1:42813_solr
x:collection1_shard1_replica1 s:shard1 c:collection1) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[collection1_shard1_replica1] Registered new searcher
Searcher@11e7ae0[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 45718 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1562273040922836992
[junit4] 2> 45718 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1562273040922836992
[junit4] 2> 45786 INFO
(zkCallback-151-thread-1-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 45786 INFO
(zkCallback-149-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 45787 INFO
(zkCallback-150-thread-3-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46185 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 46185 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 46185 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:44644/solr/collection1_shard1_replica3/
[junit4] 2> 46185 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.u.PeerSync
PeerSync: core=collection1_shard1_replica3 url=https://127.0.0.1:44644/solr
START replicas=[https://127.0.0.1:42813/solr/collection1_shard1_replica1/,
https://127.0.0.1:44230/solr/collection1_shard1_replica2/] nUpdates=100
[junit4] 2> 46185 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.u.PeerSync
PeerSync: core=collection1_shard1_replica3 url=https://127.0.0.1:44644/solr
DONE. We have no versions. sync failed.
[junit4] 2> 46196 INFO (qtp15328994-650) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 46196 INFO (qtp12225734-671) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 46197 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.c.SyncStrategy
Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 46197 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
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> 46197 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 46200 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:44644/solr/collection1_shard1_replica3/ shard1
[junit4] 2> 46304 INFO
(zkCallback-150-thread-1-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46304 INFO
(zkCallback-151-thread-1-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46304 INFO
(zkCallback-149-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46352 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.c.ZkController I
am the leader, no recovery necessary
[junit4] 2> 46354 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 x:collection1_shard1_replica3] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=config&newCollection=true&name=collection1_shard1_replica3&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2}
status=0 QTime=1849
[junit4] 2> 46456 INFO
(zkCallback-150-thread-1-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46456 INFO
(zkCallback-149-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46456 INFO
(zkCallback-151-thread-1-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46737 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms
[junit4] 2> 46737 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms
[junit4] 2> 46737 WARN (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.ReplicationHandler SolrCloud is enabled for core
collection1_shard1_replica2 but so is old-style replication. Make sure you
intend this behavior, it usually indicates a mis-configuration. Master setting
is false and slave setting is true
[junit4] 2> 46737 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Updated masterUrl to
https://127.0.0.1:44644/solr/collection1_shard1_replica3/
[junit4] 2> 46737 WARN (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.ReplicationHandler SolrCloud is enabled for core
collection1_shard1_replica1 but so is old-style replication. Make sure you
intend this behavior, it usually indicates a mis-configuration. Master setting
is false and slave setting is true
[junit4] 2> 46740 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=config&newCollection=true&name=collection1_shard1_replica2&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2}
status=0 QTime=2175
[junit4] 2> 46740 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=config&newCollection=true&name=collection1_shard1_replica1&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2}
status=0 QTime=2175
[junit4] 2> 46745 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 46746 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 46746 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 46746 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 46746 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 46747 INFO (qtp9976002-672) [n:127.0.0.1:44644_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> 46848 INFO
(zkCallback-150-thread-3-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46848 INFO
(zkCallback-149-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 46848 INFO
(zkCallback-151-thread-1-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 47060 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Updated masterUrl to
https://127.0.0.1:44644/solr/collection1_shard1_replica3/
[junit4] 2> 47086 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 47086 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 47086 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 47086 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 47086 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 47747 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=3&collection.configName=config&maxShardsPerNode=1&name=collection1&realtimeReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=3358
[junit4] 2> 47748 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection1 failOnTimeout:true timeout (sec):30
[junit4] 2> 47749 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
[junit4] 2> 47769 INFO
(TEST-OnlyLeaderIndexesTest.test-seed#[62BD3E2FB1FF1651]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 47781 INFO (qtp12225734-654) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[1
(1562273043076612096), 2 (1562273043080806400), 3 (1562273043081854976), 4
(1562273043082903552)]} 0 2
[junit4] 2> 47782 INFO (qtp15328994-653) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[1
(1562273043076612096), 2 (1562273043080806400), 3 (1562273043081854976), 4
(1562273043082903552)]} 0 2
[junit4] 2> 47783 INFO (qtp9976002-649) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[1 (1562273043076612096), 2
(1562273043080806400), 3 (1562273043081854976), 4 (1562273043082903552)]} 0 11
[junit4] 2> 47793 INFO (qtp15328994-665) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47795 INFO (qtp15328994-653) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47796 INFO (qtp15328994-655) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=3&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47798 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=4&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47807 INFO (qtp9976002-649) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47809 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47810 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=3&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47813 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=4&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47821 INFO (qtp12225734-654) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47823 INFO (qtp12225734-658) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47825 INFO (qtp12225734-671) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=3&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47828 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=4&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 47833 INFO (qtp12225734-668) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{delete=[1
(-1562273043137429504)]} 0 0
[junit4] 2> 47834 INFO (qtp15328994-650) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{delete=[1
(-1562273043137429504)]} 0 1
[junit4] 2> 47836 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{delete=[1 (-1562273043137429504)]} 0
6
[junit4] 2> 47851 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@1857e6c[collection1_shard1_replica3] realtime]
[junit4] 2> 47854 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4b4294[collection1_shard1_replica3]
realtime]
[junit4] 2> 47856 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&_version_=-1562273043144769536&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{deleteByQuery=id:2
(-1562273043144769536)} 0 0
[junit4] 2> 47857 INFO (qtp15328994-665) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&_version_=-1562273043144769536&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{deleteByQuery=id:2
(-1562273043144769536)} 0 1
[junit4] 2> 47858 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{deleteByQuery=id:2
(-1562273043144769536)} 0 20
[junit4] 2> 47873 INFO (qtp15328994-653) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47876 INFO (qtp15328994-665) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=3&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47877 INFO (qtp15328994-657) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=4&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47887 INFO (qtp12225734-668) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47888 INFO (qtp12225734-673) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=3&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47890 INFO (qtp12225734-662) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/get
params={q=*:*&distrib=false&qt=/get&id=4&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47899 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1562273043209781248,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 47899 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@f51845
commitCommandVersion:1562273043209781248
[junit4] 2> 47905 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 47905 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 48098 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@1463056[collection1_shard1_replica3] main]
[junit4] 2> 48100 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 48100 INFO
(searcherExecutor-242-thread-1-processing-n:127.0.0.1:44644_solr
x:collection1_shard1_replica3 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:44644_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica3] o.a.s.c.SolrCore [collection1_shard1_replica3]
Registered new searcher Searcher@1463056[collection1_shard1_replica3]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C4/2:delGen=2)))}
[junit4] 2> 48100 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 201
[junit4] 2> 48394 INFO
(OverseerCollectionConfigSetProcessor-97642064921690120-127.0.0.1:42813_solr-n_0000000000)
[n:127.0.0.1:42813_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> 48416 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 48416 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 48930 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 48931 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=2
[junit4] 2> 49440 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 49440 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 49737 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Updated masterUrl to
https://127.0.0.1:44644/solr/collection1_shard1_replica3/
[junit4] 2> 49738 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 49739 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 49739 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Master's version: 1489899676523
[junit4] 2> 49739 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 49739 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 49739 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 49742 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist}
status=0 QTime=2
[junit4] 2> 49744 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Number of files in latest index in master: 16
[junit4] 2> 49749 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
NIOFSDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node2/collection1_shard1_replica1/data/index.20170319050118369
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b24af8
[junit4] 2> 49761 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_2.liv&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=5
[junit4] 2> 49768 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49770 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_Direct_0.dvdd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49789 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.tiv&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49798 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49800 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.pos&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49804 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=1
[junit4] 2> 49806 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.doc&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49816 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=1
[junit4] 2> 49818 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_Asserting_0.dvd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49820 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.tib&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49822 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_Asserting_0.dvm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49824 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49833 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_Direct_0.dvdm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49835 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49958 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 49960 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.IndexFetcher Total time taken for download
(fullCopy=false,bytesDownloaded=2652) : 0 secs (null bytes/sec) to
NIOFSDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node2/collection1_shard1_replica1/data/index.20170319050118369
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b24af8
[junit4] 2> 49968 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 49968 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 50060 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Updated masterUrl to
https://127.0.0.1:44644/solr/collection1_shard1_replica3/
[junit4] 2> 50061 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 50062 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 50062 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Master's version: 1489899676523
[junit4] 2> 50062 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 50062 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 50062 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 50065 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist}
status=0 QTime=1
[junit4] 2> 50065 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Number of files in latest index in master: 16
[junit4] 2> 50071 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
NIOFSDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node1/collection1_shard1_replica2/data/index.20170319050118689
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b24af8
[junit4] 2> 50082 INFO (qtp9976002-760) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_2.liv&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50084 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50088 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_Direct_0.dvdd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50090 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.tiv&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50093 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50095 INFO (qtp9976002-760) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.pos&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50097 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50107 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.doc&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50109 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50120 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_Asserting_0.dvd&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50122 INFO (qtp9976002-760) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.tib&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50133 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_Asserting_0.dvm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50135 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50147 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0_Direct_0.dvdm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50167 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50170 INFO (qtp9976002-760) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 50170 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.IndexFetcher Total time taken for download
(fullCopy=false,bytesDownloaded=2652) : 0 secs (null bytes/sec) to
NIOFSDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001/tempDir-001/node1/collection1_shard1_replica2/data/index.20170319050118689
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b24af8
[junit4] 2> 50185 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 50188 INFO (indexFetcher-259-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@71326d[collection1_shard1_replica1]
main]
[junit4] 2> 50189 INFO
(searcherExecutor-244-thread-1-processing-n:127.0.0.1:42813_solr
x:collection1_shard1_replica1 s:shard1 c:collection1) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[collection1_shard1_replica1] Registered new searcher
Searcher@71326d[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C4/2:delGen=2)))}
[junit4] 2> 50317 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 50321 INFO (indexFetcher-260-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@1e659f3[collection1_shard1_replica2] main]
[junit4] 2> 50321 INFO
(searcherExecutor-243-thread-1-processing-n:127.0.0.1:44230_solr
x:collection1_shard1_replica2 s:shard1 c:collection1) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
[collection1_shard1_replica2] Registered new searcher
Searcher@1e659f3[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C4/2:delGen=2)))}
[junit4] 2> 50480 INFO (qtp9976002-760) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 50480 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 50481 INFO (qtp12225734-654) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 2587
[junit4] 2> 50481 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 2587
[junit4] 2> 50481 INFO (qtp9976002-649) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update
params={_stateVer_=collection1:5&commit=true&wt=javabin&version=2}{commit=} 0
2589
[junit4] 2> 50491 INFO (qtp15328994-653) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/select
params={q=*:*&distrib=false&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 50501 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/select
params={q=*:*&distrib=false&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 50508 INFO (qtp12225734-668) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr path=/select
params={q=*:*&distrib=false&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 50516 INFO (qtp12225734-671) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[15
(1562273045950758912)]} 0 0
[junit4] 2> 50517 INFO (qtp15328994-657) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[15
(1562273045950758912)]} 0 1
[junit4] 2> 50517 INFO (qtp9976002-672) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[15 (1562273045950758912)]} 0 5
[junit4] 2> 50521 INFO (qtp12225734-668) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[16
(1562273045957050368)]} 0 0
[junit4] 2> 50522 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[16
(1562273045957050368)]} 0 1
[junit4] 2> 50522 INFO (qtp9976002-656) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[16 (1562273045957050368)]} 0 3
[junit4] 2> 50527 INFO (qtp12225734-654) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[17
(1562273045963341824)]} 0 0
[junit4] 2> 50527 INFO (qtp15328994-653) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[17
(1562273045963341824)]} 0 1
[junit4] 2> 50528 INFO (qtp9976002-760) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[17 (1562273045963341824)]} 0 3
[junit4] 2> 50530 INFO (qtp12225734-662) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[18
(1562273045967536128)]} 0 0
[junit4] 2> 50531 INFO (qtp15328994-657) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[18
(1562273045967536128)]} 0 1
[junit4] 2> 50532 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[18 (1562273045967536128)]} 0 2
[junit4] 2> 50537 INFO (qtp12225734-671) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[19
(1562273045971730432)]} 0 0
[junit4] 2> 50537 INFO (qtp15328994-661) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[19
(1562273045971730432)]} 0 1
[junit4] 2> 50538 INFO (qtp9976002-669) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[19 (1562273045971730432)]} 0 5
[junit4] 2> 50541 INFO (qtp12225734-668) [n:127.0.0.1:42813_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[20
(1562273045979070464)]} 0 0
[junit4] 2> 50542 INFO (qtp15328994-665) [n:127.0.0.1:44230_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&wt=javabin&version=2}{add=[20
(1562273045979070464)]} 0 1
[junit4] 2> 50542 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[20 (1562273045979070464)]} 0 2
[junit4] 2> 50545 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1562273045984313344,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 50545 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@f51845
commitCommandVersion:1562273045984313344
[junit4] 2> 50560 INFO (qtp9976002-660) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=3
[junit4] 2> 50560 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=2
[junit4] 2> 50804 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@191b0ca[collection1_shard1_replica3] main]
[junit4] 2> 50805 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 50805 INFO
(searcherExecutor-242-thread-1-processing-n:127.0.0.1:44644_solr
x:collection1_shard1_replica3 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:44644_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica3] o.a.s.c.SolrCore [collection1_shard1_replica3]
Registered new searcher Searcher@191b0ca[collection1_shard1_replica3]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C4/2:delGen=2)
Uninverting(_1(7.0.0):C6)))}
[junit4] 2> 50805 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica3] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:44644/solr/collection1_shard1_replica3/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 259
[junit4] 2> 51069 INFO (qtp9976002-667) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 51069 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 51575 INFO (qtp9976002-652) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 51575 INFO (qtp9976002-759) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica3]
o.a.s.c.S.Request [collection1_shard1_replica3] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 52081 INFO (qtp9976002-649) [n:127.0.0.1:44644_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_rep
[...truncated too long message...]
2> 168686 INFO (jetty-closer-135-thread-1) [ ] o.a.s.c.CoreContainer
Shutting down CoreContainer instance=8828001
[junit4] 2> 168688 INFO (jetty-closer-135-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 168688 INFO (jetty-closer-135-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@883395{SSL,[ssl,
http/1.1]}{127.0.0.1:42813}
[junit4] 2> 168688 INFO (jetty-closer-135-thread-3) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=21921161
[junit4] 2> 168688 INFO (jetty-closer-135-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@1486484{SSL,[ssl,
http/1.1]}{127.0.0.1:44644}
[junit4] 2> 168688 INFO (jetty-closer-135-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 168688 INFO (jetty-closer-135-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=27722930
[junit4] 2> 168688 INFO (jetty-closer-135-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 168689 INFO (jetty-closer-135-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 168689 INFO (coreCloseExecutor-408-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 r:core_node3
x:collection1_shard1_replica2] o.a.s.c.SolrCore [collection1_shard1_replica2]
CLOSING SolrCore org.apache.solr.core.SolrCore@1e2b0dd
[junit4] 2> 168689 INFO (jetty-closer-135-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 168689 INFO (jetty-closer-135-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 168689 INFO (coreCloseExecutor-409-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
CLOSING SolrCore org.apache.solr.core.SolrCore@10ade6e
[junit4] 2> 168690 INFO (coreCloseExecutor-410-thread-1)
[n:127.0.0.1:44644_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica3] o.a.s.c.SolrCore [collection1_shard1_replica3]
CLOSING SolrCore org.apache.solr.core.SolrCore@1866817
[junit4] 2> 168691 INFO (coreCloseExecutor-410-thread-1)
[n:127.0.0.1:44644_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica3] o.a.s.u.DirectUpdateHandler2 Committing on
IndexWriter close.
[junit4] 2> 168691 INFO (coreCloseExecutor-410-thread-1)
[n:127.0.0.1:44644_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica3] o.a.s.u.SolrIndexWriter Calling setCommitData
with IW:org.apache.solr.update.SolrIndexWriter@140c6fb commitCommandVersion:0
[junit4] 2> 168692 INFO (coreCloseExecutor-408-thread-1)
[n:127.0.0.1:44230_solr c:collection1 s:shard1 r:core_node3
x:collection1_shard1_replica2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.collection1.shard1.replica2, tag=31633629
[junit4] 2> 168692 INFO
(zkCallback-177-thread-2-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 168692 INFO
(zkCallback-185-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 168692 INFO
(zkCallback-192-thread-1-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 168693 INFO (jetty-closer-135-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=97642064921690132-127.0.0.1:44230_solr-n_0000000005) closing
[junit4] 2> 168693 INFO
(OverseerStateUpdate-97642064921690132-127.0.0.1:44230_solr-n_0000000005)
[n:127.0.0.1:44230_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:44230_solr
[junit4] 2> 168695 INFO
(zkCallback-192-thread-1-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 168695 INFO
(zkCallback-185-thread-1-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:44644_solr
[junit4] 2> 168695 INFO
(zkCallback-185-thread-2-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 168695 INFO (coreCloseExecutor-409-thread-1)
[n:127.0.0.1:42813_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.collection1.shard1.replica1, tag=17489518
[junit4] 2> 168696 WARN
(zkCallback-192-thread-1-processing-n:127.0.0.1:42813_solr)
[n:127.0.0.1:42813_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 168696 INFO
(zkCallback-185-thread-3-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 168697 INFO (jetty-closer-135-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@14626b4{/solr,null,UNAVAILABLE}
[junit4] 2> 168724 INFO (coreCloseExecutor-410-thread-1)
[n:127.0.0.1:44644_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica3] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.collection1.shard1.replica3, tag=25585687
[junit4] 2> 168726 WARN
(zkCallback-185-thread-3-processing-n:127.0.0.1:44644_solr)
[n:127.0.0.1:44644_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 168726 INFO (jetty-closer-135-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@b0a7db{/solr,null,UNAVAILABLE}
[junit4] 2> 170195 WARN
(zkCallback-177-thread-2-processing-n:127.0.0.1:44230_solr)
[n:127.0.0.1:44230_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 170195 INFO (jetty-closer-135-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1495d03{/solr,null,UNAVAILABLE}
[junit4] 2> 170196 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:37557 37557
[junit4] 2> 170213 INFO (Thread-128) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:37557 37557
[junit4] 2> 170213 WARN (Thread-128) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/aliases.json
[junit4] 2> 8 /solr/security.json
[junit4] 2> 8 /solr/configs/config
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/clusterprops.json
[junit4] 2> 9 /solr/clusterstate.json
[junit4] 2> 8 /solr/collections/collection1/state.json
[junit4] 2> 4
/solr/collections/collection1/leader_elect/shard1/election/97642064921690120-core_node2-n_0000000001
[junit4] 2> 3
/solr/overseer_elect/election/97642064921690120-127.0.0.1:42813_solr-n_0000000000
[junit4] 2> 3
/solr/overseer_elect/election/97642064921690119-127.0.0.1:44644_solr-n_0000000002
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 122 /solr/overseer/collection-queue-work
[junit4] 2> 40 /solr/overseer/queue
[junit4] 2> 15 /solr/overseer/queue-work
[junit4] 2> 9 /solr/collections
[junit4] 2> 4 /solr/live_nodes
[junit4] 2>
[junit4] 2> 170213 INFO
(SUITE-OnlyLeaderIndexesTest-seed#[62BD3E2FB1FF1651]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OnlyLeaderIndexesTest_62BD3E2FB1FF1651-001
[junit4] 2> Mar 19, 2017 5:03:18 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{title_s=BlockTreeOrds(blocksize=128),
id=PostingsFormat(name=LuceneVarGapFixedInterval)},
docValues:{_version_=DocValuesFormat(name=Direct),
id=DocValuesFormat(name=Asserting),
inplace_updatable_int=DocValuesFormat(name=Lucene70)},
maxPointsInLeafNode=1121, maxMBSortInHeap=5.588907757134076,
sim=RandomSimilarity(queryNorm=true): {}, locale=fr, timezone=Europe/Belfast
[junit4] 2> NOTE: Linux 4.4.0-66-generic i386/Oracle Corporation 1.8.0_121
(32-bit)/cpus=12,threads=1,free=76208320,total=182444032
[junit4] 2> NOTE: All tests run in this JVM:
[TestSubQueryTransformerDistrib, DebugComponentTest, TestSolrDeletionPolicy1,
CloudExitableDirectoryReaderTest, URLClassifyProcessorTest,
CdcrVersionReplicationTest, OnlyLeaderIndexesTest]
[junit4] Completed [62/701 (1!)] on J2 in 126.85s, 1 test, 1 failure <<<
FAILURES!
[...truncated 56965 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
