Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.0-Windows/176/ Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.cloud.TestTlogReplica.testRecovery Error Message: Can not find doc 3 in http://127.0.0.1:64258/solr Stack Trace: java.lang.AssertionError: Can not find doc 3 in http://127.0.0.1:64258/solr at __randomizedtesting.SeedInfo.seed([9CA1B1C7C0D24EAA:5D51C86BED82840D]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNotNull(Assert.java:526) at org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:868) at org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:559) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 12873 lines...] [junit4] Suite: org.apache.solr.cloud.TestTlogReplica [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\init-core-data-001 [junit4] 2> 2929650 WARN (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9 [junit4] 2> 2929650 INFO (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 2929654 INFO (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 2929655 INFO (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001 [junit4] 2> 2929656 INFO (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2929656 INFO (Thread-5358) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2929656 INFO (Thread-5358) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2929659 ERROR (Thread-5358) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 2929757 INFO (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:64253 [junit4] 2> 2929764 INFO (jetty-launcher-3451-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 2929764 INFO (jetty-launcher-3451-thread-2) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 2929766 INFO (jetty-launcher-3451-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7f6245d9{/solr,null,AVAILABLE} [junit4] 2> 2929766 INFO (jetty-launcher-3451-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6a39acac{/solr,null,AVAILABLE} [junit4] 2> 2929768 INFO (jetty-launcher-3451-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@245ce654{HTTP/1.1,[http/1.1]}{127.0.0.1:64258} [junit4] 2> 2929768 INFO (jetty-launcher-3451-thread-2) [ ] o.e.j.s.Server Started @2936806ms [junit4] 2> 2929768 INFO (jetty-launcher-3451-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3f198be9{HTTP/1.1,[http/1.1]}{127.0.0.1:64257} [junit4] 2> 2929768 INFO (jetty-launcher-3451-thread-1) [ ] o.e.j.s.Server Started @2936806ms [junit4] 2> 2929768 INFO (jetty-launcher-3451-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=64257} [junit4] 2> 2929768 INFO (jetty-launcher-3451-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=64258} [junit4] 2> 2929768 ERROR (jetty-launcher-3451-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2929768 ERROR (jetty-launcher-3451-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2929768 INFO (jetty-launcher-3451-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 2929768 INFO (jetty-launcher-3451-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 2929769 INFO (jetty-launcher-3451-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2929769 INFO (jetty-launcher-3451-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2929769 INFO (jetty-launcher-3451-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 2929769 INFO (jetty-launcher-3451-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-09-30T11:04:54.365Z [junit4] 2> 2929769 INFO (jetty-launcher-3451-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 2929769 INFO (jetty-launcher-3451-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-09-30T11:04:54.365Z [junit4] 2> 2929772 INFO (jetty-launcher-3451-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2929773 INFO (jetty-launcher-3451-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2929784 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 0x15ed275e0ef0002, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2929790 INFO (jetty-launcher-3451-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64253/solr [junit4] 2> 2929790 INFO (jetty-launcher-3451-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64253/solr [junit4] 2> 2929877 INFO (jetty-launcher-3451-thread-1) [n:127.0.0.1:64257_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2929877 INFO (jetty-launcher-3451-thread-2) [n:127.0.0.1:64258_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2929878 INFO (jetty-launcher-3451-thread-1) [n:127.0.0.1:64257_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:64257_solr [junit4] 2> 2929878 INFO (jetty-launcher-3451-thread-2) [n:127.0.0.1:64258_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64258_solr [junit4] 2> 2929878 INFO (jetty-launcher-3451-thread-1) [n:127.0.0.1:64257_solr ] o.a.s.c.Overseer Overseer (id=98747645575495686-127.0.0.1:64257_solr-n_0000000000) starting [junit4] 2> 2929879 INFO (zkCallback-3462-thread-1-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2929879 INFO (zkCallback-3463-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2929883 INFO (jetty-launcher-3451-thread-1) [n:127.0.0.1:64257_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64257_solr [junit4] 2> 2929883 INFO (zkCallback-3462-thread-1-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2929884 INFO (zkCallback-3463-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2929985 INFO (jetty-launcher-3451-thread-2) [n:127.0.0.1:64258_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64258.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2929987 INFO (jetty-launcher-3451-thread-1) [n:127.0.0.1:64257_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64257.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2929992 INFO (jetty-launcher-3451-thread-2) [n:127.0.0.1:64258_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64258.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2929992 INFO (jetty-launcher-3451-thread-2) [n:127.0.0.1:64258_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64258.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2929992 INFO (jetty-launcher-3451-thread-1) [n:127.0.0.1:64257_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64257.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2929993 INFO (jetty-launcher-3451-thread-1) [n:127.0.0.1:64257_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64257.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2929994 INFO (jetty-launcher-3451-thread-1) [n:127.0.0.1:64257_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node2\. [junit4] 2> 2929994 INFO (jetty-launcher-3451-thread-2) [n:127.0.0.1:64258_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node1\. [junit4] 2> 2930042 INFO (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2930043 INFO (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64253/solr ready [junit4] 2> 2930047 INFO (SUITE-TestTlogReplica-seed#[9CA1B1C7C0D24EAA]-worker) [ ] o.a.s.c.TestTlogReplica Using legacyCloud?: false [junit4] 2> 2930049 INFO (qtp668912121-24076) [n:127.0.0.1:64257_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2930050 INFO (qtp668912121-24076) [n:127.0.0.1:64257_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2930062 INFO (TEST-TestTlogReplica.testRealTimeGet-seed#[9CA1B1C7C0D24EAA]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRealTimeGet [junit4] 2> 2930063 INFO (qtp668912121-24078) [n:127.0.0.1:64257_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=0&replicationFactor=2&collection.configName=conf&maxShardsPerNode=100&name=tlog_replica_test_real_time_get&nrtReplicas=2&action=CREATE&numShards=1&tlogReplicas=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2930065 INFO (OverseerThreadFactory-10349-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.CreateCollectionCmd Create collection tlog_replica_test_real_time_get [junit4] 2> 2930065 WARN (OverseerThreadFactory-10349-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.CreateCollectionCmd Specified number of replicas of 4 on collection tlog_replica_test_real_time_get is higher than the number of Solr instances currently live or live and part of your createNodeSet(2). It's unusual to run two replica of the same slice on the same Solr-instance. [junit4] 2> 2930170 INFO (OverseerStateUpdate-98747645575495686-127.0.0.1:64257_solr-n_0000000000) [n:127.0.0.1:64257_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"tlog_replica_test_real_time_get", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"tlog_replica_test_real_time_get_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:64257/solr";, [junit4] 2> "type":"NRT"} [junit4] 2> 2930172 INFO (OverseerStateUpdate-98747645575495686-127.0.0.1:64257_solr-n_0000000000) [n:127.0.0.1:64257_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"tlog_replica_test_real_time_get", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"tlog_replica_test_real_time_get_shard1_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:64258/solr";, [junit4] 2> "type":"NRT"} [junit4] 2> 2930173 INFO (OverseerStateUpdate-98747645575495686-127.0.0.1:64257_solr-n_0000000000) [n:127.0.0.1:64257_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"tlog_replica_test_real_time_get", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"tlog_replica_test_real_time_get_shard1_replica_t1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:64257/solr";, [junit4] 2> "type":"TLOG"} [junit4] 2> 2930174 INFO (OverseerStateUpdate-98747645575495686-127.0.0.1:64257_solr-n_0000000000) [n:127.0.0.1:64257_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"tlog_replica_test_real_time_get", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"tlog_replica_test_real_time_get_shard1_replica_t2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:64258/solr";, [junit4] 2> "type":"TLOG"} [junit4] 2> 2930377 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=tlog_replica_test_real_time_get_shard1_replica_n2&action=CREATE&numShards=1&collection=tlog_replica_test_real_time_get&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2930378 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf&newCollection=true&name=tlog_replica_test_real_time_get_shard1_replica_n1&action=CREATE&numShards=1&collection=tlog_replica_test_real_time_get&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2930378 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2930379 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2930379 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_real_time_get_shard1_replica_t2&action=CREATE&numShards=1&collection=tlog_replica_test_real_time_get&shard=shard1&wt=javabin&version=2&replicaType=TLOG [junit4] 2> 2930379 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=tlog_replica_test_real_time_get_shard1_replica_t1&action=CREATE&numShards=1&collection=tlog_replica_test_real_time_get&shard=shard1&wt=javabin&version=2&replicaType=TLOG [junit4] 2> 2930496 INFO (zkCallback-3462-thread-1-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2930496 INFO (zkCallback-3463-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2930498 INFO (zkCallback-3463-thread-2-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2930498 INFO (zkCallback-3462-thread-2-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2931412 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 2931413 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 2931413 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 2931419 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.s.IndexSchema [tlog_replica_test_real_time_get_shard1_replica_n2] Schema name=minimal [junit4] 2> 2931419 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.s.IndexSchema [tlog_replica_test_real_time_get_shard1_replica_t2] Schema name=minimal [junit4] 2> 2931419 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.s.IndexSchema [tlog_replica_test_real_time_get_shard1_replica_t1] Schema name=minimal [junit4] 2> 2931428 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2931428 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 2931428 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2931428 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.CoreContainer Creating SolrCore 'tlog_replica_test_real_time_get_shard1_replica_t1' using configuration from collection tlog_replica_test_real_time_get, trusted=true [junit4] 2> 2931429 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'tlog_replica_test_real_time_get_shard1_replica_n2' using configuration from collection tlog_replica_test_real_time_get, trusted=true [junit4] 2> 2931429 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64257.solr.core.tlog_replica_test_real_time_get.shard1.replica_t1' (registry 'solr.core.tlog_replica_test_real_time_get.shard1.replica_t1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2931429 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64258.solr.core.tlog_replica_test_real_time_get.shard1.replica_n2' (registry 'solr.core.tlog_replica_test_real_time_get.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2931429 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2931429 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2931429 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2931429 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.SolrCore [[tlog_replica_test_real_time_get_shard1_replica_t1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node2\tlog_replica_test_real_time_get_shard1_replica_t1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node2\.\tlog_replica_test_real_time_get_shard1_replica_t1\data\] [junit4] 2> 2931429 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.SolrCore [[tlog_replica_test_real_time_get_shard1_replica_n2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node1\tlog_replica_test_real_time_get_shard1_replica_n2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node1\.\tlog_replica_test_real_time_get_shard1_replica_n2\data\] [junit4] 2> 2931429 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.CoreContainer Creating SolrCore 'tlog_replica_test_real_time_get_shard1_replica_t2' using configuration from collection tlog_replica_test_real_time_get, trusted=true [junit4] 2> 2931429 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64258.solr.core.tlog_replica_test_real_time_get.shard1.replica_t2' (registry 'solr.core.tlog_replica_test_real_time_get.shard1.replica_t2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2931429 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2931429 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.SolrCore [[tlog_replica_test_real_time_get_shard1_replica_t2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node1\tlog_replica_test_real_time_get_shard1_replica_t2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node1\.\tlog_replica_test_real_time_get_shard1_replica_t2\data\] [junit4] 2> 2931439 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.s.IndexSchema [tlog_replica_test_real_time_get_shard1_replica_n1] Schema name=minimal [junit4] 2> 2931466 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2931466 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'tlog_replica_test_real_time_get_shard1_replica_n1' using configuration from collection tlog_replica_test_real_time_get, trusted=true [junit4] 2> 2931466 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64257.solr.core.tlog_replica_test_real_time_get.shard1.replica_n1' (registry 'solr.core.tlog_replica_test_real_time_get.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fba7785 [junit4] 2> 2931466 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2931466 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.SolrCore [[tlog_replica_test_real_time_get_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node2\tlog_replica_test_real_time_get_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001\tempDir-001\node2\.\tlog_replica_test_real_time_get_shard1_replica_n1\data\] [junit4] 2> 2931549 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2931550 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2931551 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2931551 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2931553 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2931553 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2931554 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2931554 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2931561 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@14812841[tlog_replica_test_real_time_get_shard1_replica_n2] main] [junit4] 2> 2931563 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 2931563 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 2931563 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.s.SolrIndexSearcher Opening [Searcher@25eab392[tlog_replica_test_real_time_get_shard1_replica_t2] main] [junit4] 2> 2931563 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2931565 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1579962331206516736 [junit4] 2> 2931565 INFO (searcherExecutor-10355-thread-1-processing-n:127.0.0.1:64258_solr x:tlog_replica_test_real_time_get_shard1_replica_n2 s:shard1 c:tlog_replica_test_real_time_get r:core_node2) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.SolrCore [tlog_replica_test_real_time_get_shard1_replica_n2] Registered new searcher Searcher@14812841[tlog_replica_test_real_time_get_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2931570 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=4 found=1 timeoutin=9999ms [junit4] 2> 2931575 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2931575 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2931575 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2931575 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2931576 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2931576 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2931576 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2931576 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2931579 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 2931579 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6f3d2237[tlog_replica_test_real_time_get_shard1_replica_t1] main] [junit4] 2> 2931579 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 2931579 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3dd9c373[tlog_replica_test_real_time_get_shard1_replica_n1] main] [junit4] 2> 2931580 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2931580 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1579962331222245376 [junit4] 2> 2931580 INFO (searcherExecutor-10356-thread-1-processing-n:127.0.0.1:64258_solr x:tlog_replica_test_real_time_get_shard1_replica_t2 s:shard1 c:tlog_replica_test_real_time_get r:core_node4) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.SolrCore [tlog_replica_test_real_time_get_shard1_replica_t2] Registered new searcher Searcher@25eab392[tlog_replica_test_real_time_get_shard1_replica_t2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2931580 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 2931581 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 2931581 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2931581 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1579962331223293952 [junit4] 2> 2931581 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 2931583 INFO (searcherExecutor-10357-thread-1-processing-n:127.0.0.1:64257_solr x:tlog_replica_test_real_time_get_shard1_replica_n1 s:shard1 c:tlog_replica_test_real_time_get r:core_node1) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.SolrCore [tlog_replica_test_real_time_get_shard1_replica_n1] Registered new searcher Searcher@3dd9c373[tlog_replica_test_real_time_get_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2931583 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 2931584 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2931584 INFO (searcherExecutor-10354-thread-1-processing-n:127.0.0.1:64257_solr x:tlog_replica_test_real_time_get_shard1_replica_t1 s:shard1 c:tlog_replica_test_real_time_get r:core_node3) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.SolrCore [tlog_replica_test_real_time_get_shard1_replica_t1] Registered new searcher Searcher@6f3d2237[tlog_replica_test_real_time_get_shard1_replica_t1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2931584 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1579962331226439680 [junit4] 2> 2931672 INFO (zkCallback-3463-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2931672 INFO (zkCallback-3462-thread-1-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2931672 INFO (zkCallback-3463-thread-2-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2931672 INFO (zkCallback-3462-thread-2-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932070 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 2932070 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 2932070 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/ [junit4] 2> 2932071 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.PeerSync PeerSync: core=tlog_replica_test_real_time_get_shard1_replica_n2 url=http://127.0.0.1:64258/solr START replicas=[http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/, http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_t1/, http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_t2/] nUpdates=100 [junit4] 2> 2932071 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.PeerSync PeerSync: core=tlog_replica_test_real_time_get_shard1_replica_n2 url=http://127.0.0.1:64258/solr DONE. We have no versions. sync failed. [junit4] 2> 2932074 INFO (qtp668912121-24073) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2932074 INFO (qtp234034230-24086) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2932074 INFO (qtp668912121-24085) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2932074 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate [junit4] 2> 2932074 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway [junit4] 2> 2932074 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 2932078 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/ shard1 [junit4] 2> 2932181 INFO (zkCallback-3463-thread-2-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932181 INFO (zkCallback-3463-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932181 INFO (zkCallback-3462-thread-2-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932181 INFO (zkCallback-3462-thread-1-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932230 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 2932231 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=tlog_replica_test_real_time_get_shard1_replica_n2&action=CREATE&numShards=1&collection=tlog_replica_test_real_time_get&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1854 [junit4] 2> 2932334 INFO (zkCallback-3463-thread-2-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932334 INFO (zkCallback-3462-thread-2-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932334 INFO (zkCallback-3462-thread-1-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932334 INFO (zkCallback-3463-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932583 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.ZkController tlog_replica_test_real_time_get_shard1_replica_t2 starting background replication from leader [junit4] 2> 2932583 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:03 [junit4] 2> 2932583 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms [junit4] 2> 2932587 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.ZkController tlog_replica_test_real_time_get_shard1_replica_t1 starting background replication from leader [junit4] 2> 2932587 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:03 [junit4] 2> 2932587 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_real_time_get_shard1_replica_t2&action=CREATE&numShards=1&collection=tlog_replica_test_real_time_get&shard=shard1&wt=javabin&version=2&replicaType=TLOG} status=0 QTime=2208 [junit4] 2> 2932588 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms [junit4] 2> 2932588 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf&newCollection=true&name=tlog_replica_test_real_time_get_shard1_replica_n1&action=CREATE&numShards=1&collection=tlog_replica_test_real_time_get&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2210 [junit4] 2> 2932589 INFO (indexFetcher-10377-thread-1) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.IndexFetcher Updated masterUrl to http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/ [junit4] 2> 2932589 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=tlog_replica_test_real_time_get_shard1_replica_t1&action=CREATE&numShards=1&collection=tlog_replica_test_real_time_get&shard=shard1&wt=javabin&version=2&replicaType=TLOG} status=0 QTime=2210 [junit4] 2> 2932590 INFO (qtp234034230-24077) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 2932590 INFO (indexFetcher-10377-thread-1) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.IndexFetcher Master's generation: 1 [junit4] 2> 2932590 INFO (indexFetcher-10377-thread-1) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.IndexFetcher Master's version: 0 [junit4] 2> 2932590 INFO (indexFetcher-10377-thread-1) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 2932590 INFO (indexFetcher-10377-thread-1) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.IndexFetcher Slave's version: 0 [junit4] 2> 2932591 INFO (qtp668912121-24078) [n:127.0.0.1:64257_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> 2932693 INFO (zkCallback-3463-thread-1-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932693 INFO (zkCallback-3462-thread-2-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932693 INFO (zkCallback-3462-thread-1-processing-n:127.0.0.1:64258_solr) [n:127.0.0.1:64258_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2932693 INFO (zkCallback-3463-thread-2-processing-n:127.0.0.1:64257_solr) [n:127.0.0.1:64257_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tlog_replica_test_real_time_get/state.json] for collection [tlog_replica_test_real_time_get] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2933542 INFO (indexFetcher-10375-thread-1) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.IndexFetcher Updated masterUrl to http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/ [junit4] 2> 2933542 INFO (qtp234034230-24088) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 2933542 INFO (indexFetcher-10375-thread-1) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.IndexFetcher Master's generation: 1 [junit4] 2> 2933542 INFO (indexFetcher-10375-thread-1) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.IndexFetcher Master's version: 0 [junit4] 2> 2933542 INFO (indexFetcher-10375-thread-1) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 2933542 INFO (indexFetcher-10375-thread-1) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.IndexFetcher Slave's version: 0 [junit4] 2> 2933593 INFO (qtp668912121-24078) [n:127.0.0.1:64257_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=0&replicationFactor=2&collection.configName=conf&maxShardsPerNode=100&name=tlog_replica_test_real_time_get&nrtReplicas=2&action=CREATE&numShards=1&tlogReplicas=2&wt=javabin&version=2} status=0 QTime=3530 [junit4] 2> 2933612 INFO (qtp234034230-24086) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[0 (1579962333342466048)]} 0 3 [junit4] 2> 2933614 INFO (qtp668912121-24073) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[0 (1579962333342466048)]} 0 6 [junit4] 2> 2933615 INFO (qtp668912121-24082) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[0 (1579962333342466048)]} 0 8 [junit4] 2> 2933615 INFO (qtp234034230-24084) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/update params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/&wt=javabin&version=2}{add=[0 (1579962333342466048)]} 0 13 [junit4] 2> 2933615 INFO (qtp668912121-24076) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 15 [junit4] 2> 2933621 INFO (qtp668912121-24085) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={qt=/get&_stateVer_=tlog_replica_test_real_time_get:6&ids=0&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933621 INFO (qtp668912121-24085) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={qt=/get&ids=0&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933624 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={qt=/get&ids=0&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933625 INFO (qtp668912121-24085) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/ [junit4] 2> 2933627 INFO (qtp234034230-24075) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498221&ids=0&isShard=true&shard.url=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933628 INFO (qtp668912121-24085) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/get params={qt=/get&ids=0&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 2933629 INFO (qtp234034230-24077) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/ [junit4] 2> 2933631 INFO (qtp234034230-24086) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498224&ids=0&isShard=true&shard.url=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933631 INFO (qtp234034230-24077) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/get params={qt=/get&ids=0&wt=javabin&version=2} status=0 QTime=3 [junit4] 2> 2933644 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[1 (1579962333373923328)]} 0 10 [junit4] 2> 2933646 INFO (qtp668912121-24078) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[1 (1579962333373923328)]} 0 11 [junit4] 2> 2933647 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[1 (1579962333373923328)]} 0 13 [junit4] 2> 2933647 INFO (qtp234034230-24084) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 (1579962333373923328)]} 0 15 [junit4] 2> 2933649 INFO (qtp668912121-24073) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={qt=/get&_stateVer_=tlog_replica_test_real_time_get:6&ids=1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933650 INFO (qtp668912121-24073) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={qt=/get&ids=1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933651 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={qt=/get&ids=1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933652 INFO (qtp668912121-24082) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/|http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/ [junit4] 2> 2933654 INFO (qtp668912121-24076) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498248&ids=1&isShard=true&shard.url=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/|http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933654 INFO (qtp668912121-24082) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/get params={qt=/get&ids=1&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 2933654 INFO (qtp234034230-24075) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/|http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/ [junit4] 2> 2933658 INFO (qtp668912121-24085) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498250&ids=1&isShard=true&shard.url=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/|http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933658 INFO (qtp234034230-24075) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/get params={qt=/get&ids=1&wt=javabin&version=2} status=0 QTime=3 [junit4] 2> 2933662 INFO (qtp234034230-24086) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[2 (1579962333402234880)]} 0 0 [junit4] 2> 2933662 INFO (qtp668912121-24073) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[2 (1579962333402234880)]} 0 1 [junit4] 2> 2933663 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[2 (1579962333402234880)]} 0 2 [junit4] 2> 2933663 INFO (qtp234034230-24088) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/update params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_t1/&wt=javabin&version=2}{add=[2 (1579962333402234880)]} 0 5 [junit4] 2> 2933663 INFO (qtp668912121-24078) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 7 [junit4] 2> 2933667 INFO (qtp234034230-24077) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/|http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/ [junit4] 2> 2933668 INFO (qtp668912121-24076) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&_stateVer_=tlog_replica_test_real_time_get:6&omitHeader=true&shards.purpose=1&NOW=1506769498259&ids=2&isShard=true&shard.url=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/|http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933668 INFO (qtp234034230-24077) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/get params={qt=/get&_stateVer_=tlog_replica_test_real_time_get:6&ids=2&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 2933669 INFO (qtp668912121-24082) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={qt=/get&ids=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933670 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={qt=/get&ids=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933672 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/|http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/ [junit4] 2> 2933673 INFO (qtp668912121-24085) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498268&ids=2&isShard=true&shard.url=http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/|http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933674 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/get params={qt=/get&ids=2&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 2933675 INFO (qtp234034230-24084) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/ [junit4] 2> 2933675 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498271&ids=2&isShard=true&shard.url=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933676 INFO (qtp234034230-24084) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/get params={qt=/get&ids=2&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 2933692 INFO (qtp234034230-24077) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[3 (1579962333422157824)]} 0 11 [junit4] 2> 2933694 INFO (qtp668912121-24073) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[3 (1579962333422157824)]} 0 14 [junit4] 2> 2933695 INFO (qtp668912121-24080) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/&wt=javabin&version=2}{add=[3 (1579962333422157824)]} 0 15 [junit4] 2> 2933695 INFO (qtp234034230-24086) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/update params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_t2/&wt=javabin&version=2}{add=[3 (1579962333422157824)]} 0 17 [junit4] 2> 2933696 INFO (qtp234034230-24075) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.u.p.LogUpdateProcessorFactory [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 18 [junit4] 2> 2933697 INFO (qtp668912121-24078) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={qt=/get&_stateVer_=tlog_replica_test_real_time_get:6&ids=3&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933697 INFO (qtp668912121-24076) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={qt=/get&ids=3&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933698 INFO (qtp234034230-24081) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={qt=/get&ids=3&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933699 INFO (qtp668912121-24082) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/ [junit4] 2> 2933700 INFO (qtp234034230-24083) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498295&ids=3&isShard=true&shard.url=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933700 INFO (qtp668912121-24082) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/get params={qt=/get&ids=3&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 2933701 INFO (qtp234034230-24084) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/ [junit4] 2> 2933702 INFO (qtp234034230-24088) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498297&ids=3&isShard=true&shard.url=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933702 INFO (qtp234034230-24084) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t2] webapp=/solr path=/get params={qt=/get&ids=3&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 2933703 INFO (qtp668912121-24085) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node1 x:tlog_replica_test_real_time_get_shard1_replica_n1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n1] webapp=/solr path=/get params={qt=/get&ids=0&ids=1&ids=2&ids=3&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933706 INFO (qtp234034230-24077) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={qt=/get&ids=0&ids=1&ids=2&ids=3&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2933707 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/ [junit4] 2> 2933707 INFO (qtp234034230-24086) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node2 x:tlog_replica_test_real_time_get_shard1_replica_n2] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_n2] webapp=/solr path=/get params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506769498302&ids=0,1,2,3&isShard=true&shard.url=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get} status=0 QTime=0 [junit4] 2> 2933708 INFO (qtp668912121-24079) [n:127.0.0.1:64257_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node3 x:tlog_replica_test_real_time_get_shard1_replica_t1] o.a.s.c.S.Request [tlog_replica_test_real_time_get_shard1_replica_t1] webapp=/solr path=/get params={qt=/get&ids=0&ids=1&ids=2&ids=3&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 2933708 INFO (qtp234034230-24075) [n:127.0.0.1:64258_solr c:tlog_replica_test_real_time_get s:shard1 r:core_node4 x:tlog_replica_test_real_time_get_shard1_replica_t2] o.a.s.h.c.RealTimeGetComponent LOOKUP_SLICE:shard1=http://127.0.0.1:64258/solr/tlog_replica_test_real_time_get_shard1_replica_n2/|http://127.0.0.1:64257/solr/tlog_replica_test_real_time_get_shard1_replica_n1/ [junit4] 2> 2933709 INFO (qtp234034230-24081) [n:1 [...truncated too long message...] plica/state.json [junit4] 2> 25 /solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/state.json [junit4] 2> 25 /solr/collections/tlog_replica_test_recovery/state.json [junit4] 2> 25 /solr/collections/tlog_replica_test_basic_leader_election/state.json [junit4] 2> 15 /solr/collections/tlog_replica_test_real_time_get/state.json [junit4] 2> 15 /solr/collections/tlog_replica_test_only_leader_indexes/state.json [junit4] 2> 15 /solr/collections/tlog_replica_test_delete_by_id/state.json [junit4] 2> 9 /solr/clusterprops.json [junit4] 2> 9 /solr/clusterstate.json [junit4] 2> 6 /solr/collections/tlog_replica_test_add_docs/state.json [junit4] 2> 4 /solr/overseer_elect/election/98747645575495691-127.0.0.1:64257_solr-n_0000000002 [junit4] 2> 3 /solr/collections/tlog_replica_test_recovery/leader_elect/shard1/election/98747645575495691-core_node2-n_0000000000 [junit4] 2> 2 /solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/98747645575495703-core_node3-n_0000000001 [junit4] 2> 2 /solr/collections/tlog_replica_test_create_delete/leader_elect/shard2/election/98747645575495703-core_node8-n_0000000001 [junit4] 2> 2 /solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/98747645575495691-core_node4-n_0000000000 [junit4] 2> 2 /solr/collections/tlog_replica_test_kill_tlog_replica/leader_elect/shard1/election/98747645575495691-core_node2-n_0000000000 [junit4] 2> 2 /solr/collections/tlog_replica_test_create_delete/leader_elect/shard2/election/98747645575495691-core_node8-n_0000000000 [junit4] 2> 2 /solr/collections/tlog_replica_test_real_time_get/leader_elect/shard1/election/98747645575495685-core_node2-n_0000000000 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 9 /solr/collections [junit4] 2> 4 /solr/overseer/queue [junit4] 2> 4 /solr/overseer/collection-queue-work [junit4] 2> 3 /solr/live_nodes [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_9CA1B1C7C0D24EAA-001 [junit4] 2> Sep 30, 2017 11:06:40 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): {foo=PostingsFormat(name=MockRandom), title_s=PostingsFormat(name=MockRandom), foo_s=PostingsFormat(name=MockRandom), id=PostingsFormat(name=Asserting)}, docValues:{_version_=DocValuesFormat(name=Lucene70), id=DocValuesFormat(name=Asserting), inplace_updatable_int=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=107, maxMBSortInHeap=7.126167347404904, sim=RandomSimilarity(queryNorm=false): {}, locale=uk, timezone=America/Recife [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=89245944,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [ClassificationUpdateProcessorIntegrationTest, TestMaxScoreQueryParser, RAMDirectoryFactoryTest, TestNumericTerms32, NumericFieldsTest, DateFieldTest, SoftAutoCommitTest, TestStressInPlaceUpdates, CheckHdfsIndexTest, SortByFunctionTest, TestComplexPhraseQParserPlugin, TestSolrCloudWithHadoopAuthPlugin, TestSweetSpotSimilarityFactory, TestSolrDeletionPolicy2, TestFieldCollectionResource, ShardRoutingTest, CursorMarkTest, TestCloudRecovery, SolrTestCaseJ4Test, DateMathParserTest, AutoScalingHandlerTest, TestDelegationWithHadoopAuth, TestBackupRepositoryFactory, TestBinaryField, TestFoldingMultitermQuery, TestRestManager, IndexSchemaTest, SolrIndexSplitterTest, TestOnReconnectListenerSupport, TestManagedSchema, TestRequestForwarding, ConcurrentDeleteAndCreateCollectionTest, SolrMetricReporterTest, TestManagedSynonymGraphFilterFactory, TestFieldCacheSortRandom, TestSort, TestLegacyFieldReuse, UnloadDistributedZkTest, TestSolrCloudWithSecureImpersonation, TestExportWriter, TestReplicationHandler, NoCacheHeaderTest, TestChildDocTransformer, SearchHandlerTest, PreAnalyzedUpdateProcessorTest, MultiTermTest, TestUseDocValuesAsStored, OverseerStatusTest, AlternateDirectoryTest, TestImplicitCoreProperties, TestSSLRandomization, TestAtomicUpdateErrorCases, TestConfigSetImmutable, BooleanFieldTest, TestTolerantSearch, SolrShardReporterTest, DirectSolrConnectionTest, TestQuerySenderListener, UninvertDocValuesMergePolicyTest, HdfsCollectionsAPIDistributedZkTest, ResponseLogComponentTest, ScriptEngineTest, DistributedFacetPivotLargeTest, TestFunctionQuery, XsltUpdateRequestHandlerTest, PrimUtilsTest, TestUnifiedSolrHighlighter, TestDistribDocBasedVersion, TestSolrConfigHandlerConcurrent, CloudExitableDirectoryReaderTest, TestCoreAdminApis, TestCoreContainer, SpatialHeatmapFacetsTest, StressHdfsTest, TestPushWriter, TestInitParams, TestSolrCloudWithDelegationTokens, BlockDirectoryTest, TestDynamicFieldCollectionResource, DeleteLastCustomShardedReplicaTest, TestLFUCache, TestMultiWordSynonyms, DirectUpdateHandlerOptimizeTest, TestCloudPivotFacet, TestSolrCoreSnapshots, TestCodecSupport, TemplateUpdateProcessorTest, HighlighterConfigTest, RequestHandlersTest, HdfsChaosMonkeyNothingIsSafeTest, TestIndexingPerformance, LeaderInitiatedRecoveryOnCommitTest, AssignTest, TestSchemaManager, TestFieldCacheReopen, SortSpecParsingTest, TestStressVersions, DistributedFacetPivotSmallAdvancedTest, CdcrReplicationDistributedZkTest, ClusterStateUpdateTest, TestReloadDeadlock, RecoveryZkTest, BasicAuthStandaloneTest, SolrCoreMetricManagerTest, TestFieldCacheWithThreads, TestRandomFlRTGCloud, UUIDFieldTest, TestLegacyTerms, TestInitQParser, RegexBoostProcessorTest, TestFuzzyAnalyzedSuggestions, MergeStrategyTest, MinimalSchemaTest, TestCollationFieldDocValues, AnalyticsMergeStrategyTest, CloneFieldUpdateProcessorFactoryTest, LeaderFailoverAfterPartitionTest, TestUpdate, TestCollapseQParserPlugin, DirectUpdateHandlerTest, TestStressReorder, TestPhraseSuggestions, TestJsonFacetRefinement, ManagedSchemaRoundRobinCloudTest, SecurityConfHandlerTest, DistanceUnitsTest, DistributedSpellCheckComponentTest, TestExceedMaxTermLength, RulesTest, HdfsDirectoryFactoryTest, HdfsDirectoryTest, QueryElevationComponentTest, TestSolr4Spatial2, TestDistributedSearch, TestShortCircuitedRequests, SpatialFilterTest, TestJsonRequest, DocValuesMissingTest, ResourceLoaderTest, HdfsBasicDistributedZk2Test, ClusterStateTest, TestCloudInspectUtil, TestSchemaNameResource, TestLockTree, TestAnalyzeInfixSuggestions, IndexBasedSpellCheckerTest, TestReplicationHandlerBackup, TestCSVResponseWriter, TestExclusionRuleCollectionAccess, ZkStateReaderTest, SimpleFacetsTest, TestWriterPerf, DocValuesNotIndexedTest, TestJmxIntegration, RemoteQueryErrorTest, DistribDocExpirationUpdateProcessorTest, TestDFRSimilarityFactory, HdfsUnloadDistributedZkTest, DataDrivenBlockJoinTest, TestRebalanceLeaders, AtomicUpdatesTest, TestExtendedDismaxParser, TestSolrFieldCacheBean, TestOmitPositions, HLLUtilTest, SolrInfoBeanTest, TestEmbeddedSolrServerConstructors, FacetPivotSmallTest, TestSerializedLuceneMatchVersion, HdfsThreadLeakTest, StatsReloadRaceTest, BlockJoinFacetSimpleTest, WordBreakSolrSpellCheckerTest, TestStressRecovery, UniqFieldsUpdateProcessorFactoryTest, BasicDistributedZkTest, SyncSliceTest, OverseerTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, LeaderElectionTest, TestRandomDVFaceting, AutoCommitTest, TermVectorComponentDistributedTest, HardAutoCommitTest, SolrCoreTest, StatsComponentTest, ConvertedLegacyTest, BasicFunctionalityTest, TestLazyCores, ShowFileRequestHandlerTest, SimplePostToolTest, AnalysisAfterCoreReloadTest, SpellCheckCollatorTest, CoreAdminHandlerTest, SuggesterTest, TestTrie, SuggesterWFSTTest, TestPseudoReturnFields, FieldMutatingUpdateProcessorTest, TestWordDelimiterFilterFactory, TestRemoteStreaming, TestSurroundQueryParser, DisMaxRequestHandlerTest, TestReversedWildcardFilterFactory, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, DocumentBuilderTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, MoreLikeThisHandlerTest, FieldAnalysisRequestHandlerTest, LoggingHandlerTest, ReturnFieldsTest, QueryParsingTest, JsonLoaderTest, TestPartialUpdateDeduplication, CSVRequestHandlerTest, SearchHandlerTest, TestLMDirichletSimilarityFactory, TestIBSimilarityFactory, TestFastWriter, TimeZoneUtilsTest, URLClassifyProcessorTest, PreAnalyzedFieldTest, TestSystemIdResolver, TestSuggestSpellingConverter, TestSolrJ, TestLRUCache, TestUtils, ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, CircularListTest, TestRTGBase, CursorPagingTest, DistributedIntervalFacetingTest, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, TestEmbeddedSolrServerSchemaAPI, TestJettySolrRunner, ConnectionReuseTest, AsyncCallRequestStatusResponseTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CdcrVersionReplicationTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, ConnectionManagerTest, CustomCollectionTest, DeleteShardTest, DistribJoinFromCollectionTest, ForceLeaderTest, LeaderInitiatedRecoveryOnShardRestartTest, MigrateRouteKeyTest, MoveReplicaHDFSTest, MultiThreadedOCPTest, SSLMigrationTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, SharedFSAutoReplicaFailoverUtilsTest, SimpleCollectionCreateDeleteTest, SolrXmlInZkTest, TestAuthenticationFramework, TestCloudDeleteByQuery, TestCloudJSONFacetJoinDomain, TestConfigSetsAPIExclusivity, TestCryptoKeys, TestDeleteCollectionOnDownNodes, TestLeaderInitiatedRecoveryThread, TestMiniSolrCloudClusterSSL, TestPullReplica, TestRandomRequestDistribution, TestTlogReplica] [junit4] Completed [583/730 (1!)] on J0 in 106.98s, 13 tests, 1 failure <<< FAILURES! [...truncated 44047 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
