Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/83/ Java: 32bit/jdk1.8.0_141 -server -XX:+UseParallelGC
2 tests failed. FAILED: org.apache.solr.cloud.LeaderElectionContextKeyTest.test Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([7D8C290DDECCD596:F5D816D77030B86E]:0) at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88) 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) FAILED: org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([7D8C290DDECCD596:51BE5E805208A312]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886) at org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads(AtomicUpdateProcessorFactoryTest.java:264) 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) Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] xml response was: <?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> </response> request was:q=int_i:19&wt=xml at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879) ... 40 more Build Log: [...truncated 11315 lines...] [junit4] Suite: org.apache.solr.cloud.LeaderElectionContextKeyTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\init-core-data-001 [junit4] 2> 653402 WARN (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 653403 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 653409 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-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> 653409 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 653412 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001 [junit4] 2> 653412 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 653412 INFO (Thread-1484) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 653412 INFO (Thread-1484) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 653418 ERROR (Thread-1484) [ ] 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> 653519 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:51886 [junit4] 2> 653580 INFO (jetty-launcher-1023-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 653580 INFO (jetty-launcher-1023-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1fe2365{/solr,null,AVAILABLE} [junit4] 2> 653583 INFO (jetty-launcher-1023-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@14eb41c{HTTP/1.1,[http/1.1]}{127.0.0.1:51890} [junit4] 2> 653583 INFO (jetty-launcher-1023-thread-1) [ ] o.e.j.s.Server Started @661348ms [junit4] 2> 653583 INFO (jetty-launcher-1023-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=51890} [junit4] 2> 653583 ERROR (jetty-launcher-1023-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 653583 INFO (jetty-launcher-1023-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.1.0 [junit4] 2> 653583 INFO (jetty-launcher-1023-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 653583 INFO (jetty-launcher-1023-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 653583 INFO (jetty-launcher-1023-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-07-28T06:49:14.637Z [junit4] 2> 653607 INFO (jetty-launcher-1023-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 653620 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 0x15d87f4cfe80001, 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> 653626 INFO (jetty-launcher-1023-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51886/solr [junit4] 2> 653630 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 0x15d87f4cfe80002, 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> 654045 INFO (jetty-launcher-1023-thread-1) [n:127.0.0.1:51890_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 654046 INFO (jetty-launcher-1023-thread-1) [n:127.0.0.1:51890_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51890_solr [junit4] 2> 654047 INFO (jetty-launcher-1023-thread-1) [n:127.0.0.1:51890_solr ] o.a.s.c.Overseer Overseer (id=98384252401876995-127.0.0.1:51890_solr-n_0000000000) starting [junit4] 2> 654055 INFO (jetty-launcher-1023-thread-1) [n:127.0.0.1:51890_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51890_solr [junit4] 2> 654058 INFO (zkCallback-1030-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 654307 INFO (jetty-launcher-1023-thread-1) [n:127.0.0.1:51890_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51890.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e13d4 [junit4] 2> 654310 INFO (jetty-launcher-1023-thread-1) [n:127.0.0.1:51890_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51890.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e13d4 [junit4] 2> 654310 INFO (jetty-launcher-1023-thread-1) [n:127.0.0.1:51890_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51890.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e13d4 [junit4] 2> 654311 INFO (jetty-launcher-1023-thread-1) [n:127.0.0.1:51890_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\. [junit4] 2> 654351 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 654352 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51886/solr ready [junit4] 2> 654367 INFO (qtp31977623-6098) [n:127.0.0.1:51890_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 654370 INFO (OverseerThreadFactory-2722-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.CreateCollectionCmd Create collection testCollection1 [junit4] 2> 654488 INFO (OverseerStateUpdate-98384252401876995-127.0.0.1:51890_solr-n_0000000000) [n:127.0.0.1:51890_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testCollection1", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testCollection1_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:51890/solr", [junit4] 2> "type":"NRT"} [junit4] 2> 654512 INFO (OverseerStateUpdate-98384252401876995-127.0.0.1:51890_solr-n_0000000000) [n:127.0.0.1:51890_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testCollection1", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testCollection1_shard2_replica_n3", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:51890/solr", [junit4] 2> "type":"NRT"} [junit4] 2> 654719 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=config&newCollection=true&name=testCollection1_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 654719 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection1_shard2_replica_n3&action=CREATE&numShards=2&collection=testCollection1&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 654721 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 654884 INFO (zkCallback-1030-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection1/state.json] for collection [testCollection1] has occurred - updating... (live nodes size: [1]) [junit4] 2> 654886 INFO (zkCallback-1030-thread-2-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection1/state.json] for collection [testCollection1] has occurred - updating... (live nodes size: [1]) [junit4] 2> 655778 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 655778 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 655792 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.s.IndexSchema [testCollection1_shard2_replica_n3] Schema name=minimal [junit4] 2> 655793 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.s.IndexSchema [testCollection1_shard1_replica_n1] Schema name=minimal [junit4] 2> 655798 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 655798 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 655798 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testCollection1_shard1_replica_n1' using configuration from collection testCollection1, trusted=true [junit4] 2> 655798 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.CoreContainer Creating SolrCore 'testCollection1_shard2_replica_n3' using configuration from collection testCollection1, trusted=true [junit4] 2> 655799 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51890.solr.core.testCollection1.shard2.replica_n3' (registry 'solr.core.testCollection1.shard2.replica_n3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e13d4 [junit4] 2> 655799 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 655799 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SolrCore [[testCollection1_shard2_replica_n3] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\testCollection1_shard2_replica_n3], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\.\testCollection1_shard2_replica_n3\data\] [junit4] 2> 655800 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51890.solr.core.testCollection1.shard1.replica_n1' (registry 'solr.core.testCollection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e13d4 [junit4] 2> 655801 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 655801 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore [[testCollection1_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\testCollection1_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\.\testCollection1_shard1_replica_n1\data\] [junit4] 2> 655903 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 655903 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 655905 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 655905 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 655906 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 655906 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 655908 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 655908 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 655908 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.s.SolrIndexSearcher Opening [Searcher@12757c8[testCollection1_shard2_replica_n3] main] [junit4] 2> 655910 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config [junit4] 2> 655911 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config [junit4] 2> 655911 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1dceb9d[testCollection1_shard1_replica_n1] main] [junit4] 2> 655911 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 655911 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574148041044131840 [junit4] 2> 655911 INFO (searcherExecutor-2725-thread-1-processing-n:127.0.0.1:51890_solr x:testCollection1_shard2_replica_n3 s:shard2 c:testCollection1 r:core_node4) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SolrCore [testCollection1_shard2_replica_n3] Registered new searcher Searcher@12757c8[testCollection1_shard2_replica_n3] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 655916 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config [junit4] 2> 655917 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config [junit4] 2> 655918 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 655918 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574148041051471872 [junit4] 2> 655918 INFO (searcherExecutor-2726-thread-1-processing-n:127.0.0.1:51890_solr x:testCollection1_shard1_replica_n1 s:shard1 c:testCollection1 r:core_node2) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore [testCollection1_shard1_replica_n1] Registered new searcher Searcher@1dceb9d[testCollection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 655918 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 655918 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 655918 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:51890/solr/testCollection1_shard2_replica_n3/ [junit4] 2> 655918 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 655918 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SyncStrategy http://127.0.0.1:51890/solr/testCollection1_shard2_replica_n3/ has no replicas [junit4] 2> 655918 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 655918 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 655918 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 655918 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:51890/solr/testCollection1_shard1_replica_n1/ [junit4] 2> 655918 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 655918 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:51890/solr/testCollection1_shard1_replica_n1/ has no replicas [junit4] 2> 655918 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 655933 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:51890/solr/testCollection1_shard2_replica_n3/ shard2 [junit4] 2> 655937 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:51890/solr/testCollection1_shard1_replica_n1/ shard1 [junit4] 2> 656049 INFO (zkCallback-1030-thread-2-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection1/state.json] for collection [testCollection1] has occurred - updating... (live nodes size: [1]) [junit4] 2> 656049 INFO (zkCallback-1030-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection1/state.json] for collection [testCollection1] has occurred - updating... (live nodes size: [1]) [junit4] 2> 656087 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 656090 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 656092 INFO (qtp31977623-6102) [n:127.0.0.1:51890_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection1_shard2_replica_n3&action=CREATE&numShards=2&collection=testCollection1&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1373 [junit4] 2> 656095 INFO (qtp31977623-6103) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=config&newCollection=true&name=testCollection1_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1376 [junit4] 2> 656102 INFO (qtp31977623-6098) [n:127.0.0.1:51890_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> 656203 INFO (zkCallback-1030-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection1/state.json] for collection [testCollection1] has occurred - updating... (live nodes size: [1]) [junit4] 2> 656203 INFO (zkCallback-1030-thread-2-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection1/state.json] for collection [testCollection1] has occurred - updating... (live nodes size: [1]) [junit4] 2> 656375 INFO (OverseerCollectionConfigSetProcessor-98384252401876995-127.0.0.1:51890_solr-n_0000000000) [n:127.0.0.1:51890_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 657104 INFO (qtp31977623-6098) [n:127.0.0.1:51890_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=2737 [junit4] 2> 657105 INFO (qtp31977623-6098) [n:127.0.0.1:51890_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection2&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 657109 INFO (OverseerThreadFactory-2722-thread-2-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.CreateCollectionCmd Create collection testCollection2 [junit4] 2> 657318 INFO (OverseerStateUpdate-98384252401876995-127.0.0.1:51890_solr-n_0000000000) [n:127.0.0.1:51890_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testCollection2", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testCollection2_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:51890/solr", [junit4] 2> "type":"NRT"} [junit4] 2> 657321 INFO (OverseerStateUpdate-98384252401876995-127.0.0.1:51890_solr-n_0000000000) [n:127.0.0.1:51890_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testCollection2", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testCollection2_shard2_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:51890/solr", [junit4] 2> "type":"NRT"} [junit4] 2> 657528 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=testCollection2_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection2&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 657528 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection2_shard2_replica_n2&action=CREATE&numShards=2&collection=testCollection2&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 657661 INFO (zkCallback-1030-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 657661 INFO (zkCallback-1030-thread-2-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 657661 INFO (zkCallback-1030-thread-3-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 658606 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 658610 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 658638 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.s.IndexSchema [testCollection2_shard1_replica_n1] Schema name=minimal [junit4] 2> 658638 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.s.IndexSchema [testCollection2_shard2_replica_n2] Schema name=minimal [junit4] 2> 658641 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 658641 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testCollection2_shard1_replica_n1' using configuration from collection testCollection2, trusted=true [junit4] 2> 658643 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 658643 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'testCollection2_shard2_replica_n2' using configuration from collection testCollection2, trusted=true [junit4] 2> 658643 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51890.solr.core.testCollection2.shard1.replica_n1' (registry 'solr.core.testCollection2.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e13d4 [junit4] 2> 658643 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 658643 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51890.solr.core.testCollection2.shard2.replica_n2' (registry 'solr.core.testCollection2.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e13d4 [junit4] 2> 658643 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SolrCore [[testCollection2_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\testCollection2_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\.\testCollection2_shard1_replica_n1\data\] [junit4] 2> 658643 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 658643 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SolrCore [[testCollection2_shard2_replica_n2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\testCollection2_shard2_replica_n2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001\tempDir-001\node1\.\testCollection2_shard2_replica_n2\data\] [junit4] 2> 658830 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 658830 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 658839 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 658839 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 658839 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@76fc4f[testCollection2_shard2_replica_n2] main] [junit4] 2> 658848 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config [junit4] 2> 658848 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config [junit4] 2> 658848 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 658848 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574148044123799552 [junit4] 2> 658848 INFO (searcherExecutor-2736-thread-1-processing-n:127.0.0.1:51890_solr x:testCollection2_shard2_replica_n2 s:shard2 c:testCollection2 r:core_node4) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SolrCore [testCollection2_shard2_replica_n2] Registered new searcher Searcher@76fc4f[testCollection2_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 658852 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 658852 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 658852 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 658852 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 658862 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1cb727f[testCollection2_shard1_replica_n1] main] [junit4] 2> 658863 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config [junit4] 2> 658864 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config [junit4] 2> 658864 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 658864 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 658864 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:51890/solr/testCollection2_shard2_replica_n2/ [junit4] 2> 658864 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 658864 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:51890/solr/testCollection2_shard2_replica_n2/ has no replicas [junit4] 2> 658864 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 658864 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 658865 INFO (searcherExecutor-2735-thread-1-processing-n:127.0.0.1:51890_solr x:testCollection2_shard1_replica_n1 s:shard1 c:testCollection2 r:core_node3) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SolrCore [testCollection2_shard1_replica_n1] Registered new searcher Searcher@1cb727f[testCollection2_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 658865 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574148044141625344 [junit4] 2> 658868 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:51890/solr/testCollection2_shard2_replica_n2/ shard2 [junit4] 2> 658871 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 658871 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 658872 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:51890/solr/testCollection2_shard1_replica_n1/ [junit4] 2> 658872 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 658872 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:51890/solr/testCollection2_shard1_replica_n1/ has no replicas [junit4] 2> 658872 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 658889 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:51890/solr/testCollection2_shard1_replica_n1/ shard1 [junit4] 2> 658996 INFO (zkCallback-1030-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 658996 INFO (zkCallback-1030-thread-2-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 658996 INFO (zkCallback-1030-thread-3-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 659029 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 659037 INFO (qtp31977623-6097) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection2_shard2_replica_n2&action=CREATE&numShards=2&collection=testCollection2&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1507 [junit4] 2> 659046 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 659052 INFO (qtp31977623-6099) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=testCollection2_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection2&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1523 [junit4] 2> 659055 INFO (qtp31977623-6098) [n:127.0.0.1:51890_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> 659135 INFO (OverseerCollectionConfigSetProcessor-98384252401876995-127.0.0.1:51890_solr-n_0000000000) [n:127.0.0.1:51890_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 659169 INFO (zkCallback-1030-thread-2-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 659169 INFO (zkCallback-1030-thread-3-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 659169 INFO (zkCallback-1030-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection2/state.json] for collection [testCollection2] has occurred - updating... (live nodes size: [1]) [junit4] 2> 660058 INFO (qtp31977623-6098) [n:127.0.0.1:51890_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection2&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=2953 [junit4] 2> 660059 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: testCollection1 failOnTimeout:true timeout (sec):30 [junit4] 2> 660059 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: testCollection1 [junit4] 2> 660059 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: testCollection2 failOnTimeout:true timeout (sec):30 [junit4] 2> 660067 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: testCollection2 [junit4] 2> 660091 INFO (TEST-LeaderElectionContextKeyTest.test-seed#[7D8C290DDECCD596]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 660110 INFO (qtp31977623-6101) [n:127.0.0.1:51890_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCollection1.shard2.replica_n3, tag=null [junit4] 2> 660113 INFO (qtp31977623-6101) [n:127.0.0.1:51890_solr ] o.a.s.c.SolrCore [testCollection1_shard2_replica_n3] CLOSING SolrCore org.apache.solr.core.SolrCore@15c0586 [junit4] 2> 660131 INFO (qtp31977623-6101) [n:127.0.0.1:51890_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCollection1.shard2.replica_n3, tag=22807942 [junit4] 2> 660131 INFO (qtp31977623-6101) [n:127.0.0.1:51890_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.testCollection1.shard2.leader, tag=22807942 [junit4] 2> 660161 INFO (qtp31977623-6101) [n:127.0.0.1:51890_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=false&core=testCollection1_shard2_replica_n3&deleteDataDir=false&action=UNLOAD&indexInfo=true&wt=javabin&version=2&deleteIndex=false} status=0 QTime=51 [junit4] 2> 660167 INFO (TEST-LeaderElectionContextKeyTest.test-seed#[7D8C290DDECCD596]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=LeaderElectionContextKeyTest -Dtests.method=test -Dtests.seed=7D8C290DDECCD596 -Dtests.slow=true -Dtests.locale=lv-LV -Dtests.timezone=America/Edmonton -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] FAILURE 0.10s J1 | LeaderElectionContextKeyTest.test <<< [junit4] > Throwable #1: java.lang.AssertionError [junit4] > at __randomizedtesting.SeedInfo.seed([7D8C290DDECCD596:F5D816D77030B86E]:0) [junit4] > at org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] 2> 660170 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 0x15d87f4cfe80005, 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> 660172 INFO (jetty-closer-1024-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@14eb41c{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 660172 INFO (jetty-closer-1024-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=16138478 [junit4] 2> 660172 INFO (jetty-closer-1024-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 660174 INFO (jetty-closer-1024-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 660175 INFO (jetty-closer-1024-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 660176 INFO (jetty-closer-1024-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 660184 INFO (coreCloseExecutor-2745-thread-1) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore [testCollection1_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@53342b [junit4] 2> 660184 INFO (coreCloseExecutor-2745-thread-3) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SolrCore [testCollection2_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@12b6468 [junit4] 2> 660184 INFO (coreCloseExecutor-2745-thread-2) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SolrCore [testCollection2_shard2_replica_n2] CLOSING SolrCore org.apache.solr.core.SolrCore@342bea [junit4] 2> 660200 INFO (coreCloseExecutor-2745-thread-2) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCollection2.shard2.replica_n2, tag=3419114 [junit4] 2> 660203 INFO (coreCloseExecutor-2745-thread-2) [n:127.0.0.1:51890_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.testCollection2.shard2.leader, tag=3419114 [junit4] 2> 660207 INFO (coreCloseExecutor-2745-thread-1) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCollection1.shard1.replica_n1, tag=5452843 [junit4] 2> 660210 INFO (coreCloseExecutor-2745-thread-1) [n:127.0.0.1:51890_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.testCollection1.shard1.leader, tag=5452843 [junit4] 2> 660210 INFO (coreCloseExecutor-2745-thread-3) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCollection2.shard1.replica_n1, tag=19620968 [junit4] 2> 660211 INFO (coreCloseExecutor-2745-thread-3) [n:127.0.0.1:51890_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.testCollection2.shard1.leader, tag=19620968 [junit4] 2> 660213 INFO (jetty-closer-1024-thread-1) [ ] o.a.s.c.Overseer Overseer (id=98384252401876995-127.0.0.1:51890_solr-n_0000000000) closing [junit4] 2> 660213 INFO (OverseerStateUpdate-98384252401876995-127.0.0.1:51890_solr-n_0000000000) [n:127.0.0.1:51890_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:51890_solr [junit4] 2> 660214 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 0x15d87f4cfe80003, 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> 660214 WARN (zkCallback-1030-thread-1-processing-n:127.0.0.1:51890_solr) [n:127.0.0.1:51890_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 660215 INFO (jetty-closer-1024-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1fe2365{/solr,null,UNAVAILABLE} [junit4] 2> 660215 ERROR (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 660216 INFO (SUITE-LeaderElectionContextKeyTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51886 51886 [junit4] 2> 660217 INFO (Thread-1484) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51886 51886 [junit4] 2> 660218 WARN (Thread-1484) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 2 /solr/aliases.json [junit4] 2> 2 /solr/clusterprops.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 9 /solr/collections/testCollection2/state.json [junit4] 2> 5 /solr/collections/testCollection1/state.json [junit4] 2> 2 /solr/clusterstate.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 2 /solr/live_nodes [junit4] 2> 2 /solr/collections [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderElectionContextKeyTest_7D8C290DDECCD596-001 [junit4] 2> Jul 28, 2017 6:49:21 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1936, maxMBSortInHeap=5.093267019144168, sim=RandomSimilarity(queryNorm=true): {}, locale=lv-LV, timezone=America/Edmonton [junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_141 (32-bit)/cpus=3,threads=1,free=155045320,total=410255360 [junit4] 2> NOTE: All tests run in this JVM: [SpellCheckCollatorWithCollapseTest, TestLMJelinekMercerSimilarityFactory, TestStressInPlaceUpdates, SuggestComponentTest, UninvertDocValuesMergePolicyTest, TestSolrCoreSnapshots, StatelessScriptUpdateProcessorFactoryTest, ExternalFileFieldSortTest, ZkStateReaderTest, TestSearchPerf, TestFieldCacheVsDocValues, LeaderFailureAfterFreshStartTest, BigEndianAscendingWordSerializerTest, TestCharFilters, TestRestoreCore, TestLeaderInitiatedRecoveryThread, TestReplicationHandlerBackup, LeaderInitiatedRecoveryOnShardRestartTest, BlockJoinFacetDistribTest, TestFieldResource, MBeansHandlerTest, DistributedQueryComponentOptimizationTest, DistributedFacetPivotSmallAdvancedTest, TestFastWriter, TestCloudPseudoReturnFields, RulesTest, TestSolrCloudWithSecureImpersonation, SchemaVersionSpecificBehaviorTest, DistributedFacetPivotWhiteBoxTest, TestSimpleTextCodec, TestSolrDeletionPolicy1, TestStressLucene, TestDFISimilarityFactory, TestRandomCollapseQParserPlugin, SharedFSAutoReplicaFailoverUtilsTest, TestBadConfig, CleanupOldIndexTest, ChangedSchemaMergeTest, CdcrVersionReplicationTest, TestAuthorizationFramework, DebugComponentTest, BlockJoinFacetSimpleTest, TestRuleBasedAuthorizationPlugin, JSONWriterTest, SSLMigrationTest, StressHdfsTest, TestFiltering, TestRTGBase, TestSimpleTrackingShardHandler, CollectionReloadTest, PreAnalyzedFieldManagedSchemaCloudTest, TestCrossCoreJoin, TestCollationFieldDocValues, TestSchemaManager, TestMergePolicyConfig, TestCloudJSONFacetJoinDomain, StatsComponentTest, TestMacroExpander, TestDocumentBuilder, CollectionsAPISolrJTest, TestCollectionAPIs, V2ApiIntegrationTest, TestStressUserVersions, DeleteNodeTest, SOLR749Test, TestExpandComponent, TestPayloadScoreQParserPlugin, TestManagedSynonymFilterFactory, CoreMergeIndexesAdminHandlerTest, TestRestManager, TestRandomFaceting, MultiThreadedOCPTest, TestBackupRepositoryFactory, TestSolrJ, TermVectorComponentTest, LeaderElectionIntegrationTest, SolrIndexConfigTest, TestSolrConfigHandlerConcurrent, TestInitQParser, LeaderElectionContextKeyTest] [junit4] Completed [157/726 (1!)] on J1 in 7.59s, 1 test, 1 failure <<< FAILURES! [...truncated 1909 lines...] [junit4] Suite: org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.processor.AtomicUpdateProcessorFactoryTest_7D8C290DDECCD596-001\init-core-data-001 [junit4] 2> 2814358 WARN (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=17 numCloses=17 [junit4] 2> 2814358 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 2814363 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-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> 2814363 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 2814365 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2814366 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2814407 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 2814420 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 2814485 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2814557 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1dc218c [junit4] 2> 2814561 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1dc218c [junit4] 2> 2814561 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1dc218c [junit4] 2> 2814563 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2814610 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 2814625 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2814693 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2814700 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true [junit4] 2> 2814701 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1dc218c [junit4] 2> 2814701 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2814701 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.processor.AtomicUpdateProcessorFactoryTest_7D8C290DDECCD596-001\init-core-data-001\] [junit4] 2> 2814702 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=30, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=54.8857421875, floorSegmentMB=0.216796875, forceMergeDeletesPctAllowed=7.992555531341651, segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 2814780 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2814780 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2814781 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2814781 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2814782 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=56.3291015625, floorSegmentMB=0.677734375, forceMergeDeletesPctAllowed=20.542594345860063, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6070176241920714 [junit4] 2> 2814782 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5865fd[collection1] main] [junit4] 2> 2814783 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2814789 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2814815 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2814816 INFO (coreLoadExecutor-11177-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574150304741457920 [junit4] 2> 2814817 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2814818 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2814818 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2814818 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2814818 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2814818 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2814818 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[7D8C290DDECCD596]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 2814818 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2814819 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2814819 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2814822 INFO (searcherExecutor-11178-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5865fd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2814827 INFO (TEST-AtomicUpdateProcessorFactoryTest.testWrongAtomicOpPassed-seed#[7D8C290DDECCD596]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWrongAtomicOpPassed [junit4] 2> 2814832 INFO (TEST-AtomicUpdateProcessorFactoryTest.testWrongAtomicOpPassed-seed#[7D8C290DDECCD596]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWrongAtomicOpPassed [junit4] 2> 2814840 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMultipleThreads [junit4] 2> 2814840 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 2814840 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1bb7f6a[collection1] realtime] [junit4] 2> 2814841 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 0 [junit4] 2> 2814848 WARN (Thread-5739) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574150304769769472 actual=1574150304772915200Retrying with new version .... (1) [junit4] 2> 2814853 WARN (Thread-5739) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574150304775012352 actual=1574150304780255232Retrying with new version .... (2) [junit4] 2> 2814855 WARN (Thread-5738) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574150304769769472 actual=1574150304780255233Retrying with new version .... (1) [junit4] 2> 2814857 WARN (Thread-5737) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574150304769769472 actual=1574150304782352384Retrying with new version .... (1) [junit4] 2> 2814859 WARN (Thread-5736) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574150304769769472 actual=1574150304784449536Retrying with new version .... (1) [junit4] 2> 2814859 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1574150304786546689,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2814860 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@6ce464 commitCommandVersion:1574150304786546689 [junit4] 2> 2814894 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@990481[collection1] main] [junit4] 2> 2814895 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2814896 INFO (searcherExecutor-11178-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@990481[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):c10/9:delGen=1)))} [junit4] 2> 2814896 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 36 [junit4] 2> 2814901 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:10&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2814903 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:wg8a0rfmra4edmmcwmsj+svvknyv0flyjxolmcvfd+bu4k6mwq2vcvnjc3z5y3+lg5jbjrwvqtj94h7q4sj+e6f0ze08ueipf68v0xsb&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2814904 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=int_i:19&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 2814904 ERROR (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] 2> </response> [junit4] 2> [junit4] 2> request was:q=int_i:19&wt=xml [junit4] 2> 2814904 ERROR (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=int_i:19&wt=xml:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] 2> </response> [junit4] 2> [junit4] 2> request was:q=int_i:19&wt=xml [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879) [junit4] 2> at org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads(AtomicUpdateProcessorFactoryTest.java:264) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> [junit4] 2> 2814905 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[7D8C290DDECCD596]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMultipleThreads [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AtomicUpdateProcessorFactoryTest -Dtests.method=testMultipleThreads -Dtests.seed=7D8C290DDECCD596 -Dtests.slow=true -Dtests.locale=en-IE -Dtests.timezone=SystemV/PST8PDT -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.08s J0 | AtomicUpdateProcessorFactoryTest.testMultipleThreads <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([7D8C290DDECCD596:51BE5E805208A312]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886) [junit4] > at org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads(AtomicUpdateProcessorFactoryTest.java:264) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numF [...truncated too long message...] NG SolrCore org.apache.solr.core.SolrCore@942f83 [junit4] 2> 2814984 INFO (coreCloseExecutor-11183-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=9711491 [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.processor.AtomicUpdateProcessorFactoryTest_7D8C290DDECCD596-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {name_s=PostingsFormat(name=LuceneFixedGap), int_i=FSTOrd50, range_facet_l_dv=PostingsFormat(name=LuceneFixedGap), multiDefault=PostingsFormat(name=Asserting), intDefault=FST50, title=FST50, title_lettertok=PostingsFormat(name=LuceneFixedGap), count_i=FSTOrd50, range_facet_l=PostingsFormat(name=Asserting), title_stringNoNorms=PostingsFormat(name=Asserting), title_stemmed=FST50, cat=PostingsFormat(name=Asserting), id_i1=FST50, id=PostingsFormat(name=LuceneFixedGap), range_facet_i_dv=PostingsFormat(name=Asserting), text=FSTOrd50, timestamp=PostingsFormat(name=Asserting)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), _version_=DocValuesFormat(name=Lucene70), range_facet_i_dv=DocValuesFormat(name=Lucene70), intDvoDefault=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=414, maxMBSortInHeap=5.862702561001928, sim=RandomSimilarity(queryNorm=true): {}, locale=en-IE, timezone=SystemV/PST8PDT [junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_141 (32-bit)/cpus=3,threads=1,free=222959512,total=520617984 [junit4] 2> NOTE: All tests run in this JVM: [TestAnalyzeInfixSuggestions, TestSweetSpotSimilarityFactory, TestSegmentSorting, TestHttpShardHandlerFactory, TestQuerySenderListener, TemplateUpdateProcessorTest, DocValuesMissingTest, HdfsSyncSliceTest, TestStressRecovery, DataDrivenBlockJoinTest, MigrateRouteKeyTest, BitVectorTest, TestTolerantSearch, FieldAnalysisRequestHandlerTest, TestDownShardTolerantSearch, CSVRequestHandlerTest, MoveReplicaHDFSTest, TestNestedDocsSort, TestManagedResourceStorage, TestSystemCollAutoCreate, DistributedQueryComponentCustomSortTest, DistributedFacetExistsSmallTest, TestObjectReleaseTracker, TestAuthenticationFramework, HdfsWriteToMultipleCollectionsTest, TestRequestStatusCollectionAPI, NumericFieldsTest, DistributedFacetPivotLongTailTest, TestInfoStreamLogging, TestJmxIntegration, SortByFunctionTest, TestNonDefinedSimilarityFactory, SharedFSAutoReplicaFailoverTest, RAMDirectoryFactoryTest, ClusterStateTest, TestManagedStopFilterFactory, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestSha256AuthenticationProvider, TestApiFramework, TestScoreJoinQPScore, TestImpersonationWithHadoopAuth, TestWriterPerf, RollingRestartTest, HdfsRecoveryZkTest, TestCustomSort, TestQueryWrapperFilter, TestRandomDVFaceting, ClusterStateUpdateTest, MultiTermTest, SolrInfoBeanTest, TestBulkSchemaConcurrent, TestManagedSchemaAPI, TestCorePropertiesReload, SyncSliceTest, TestDistributedStatsComponentCardinality, TestStreamBody, TestDistributedSearch, ConcurrentDeleteAndCreateCollectionTest, InfoHandlerTest, TestHdfsBackupRestoreCore, TestFunctionQuery, DeleteReplicaTest, CoreSorterTest, HighlighterMaxOffsetTest, TestNoOpRegenerator, TestSchemaNameResource, TestReqParamsAPI, TestSolrQueryResponse, TestHighlightDedupGrouping, OverriddenZkACLAndCredentialsProvidersTest, QueryResultKeyTest, TestXmlQParserPlugin, FastVectorHighlighterTest, LeaderInitiatedRecoveryOnCommitTest, TestExceedMaxTermLength, TestBlobHandler, TestFoldingMultitermQuery, LeaderFailoverAfterPartitionTest, LeaderElectionTest, SimpleCollectionCreateDeleteTest, DistanceUnitsTest, TestFaceting, TestLeaderElectionZkExpiry, HdfsDirectoryTest, DistributedQueueTest, CollectionStateFormat2Test, TestMiniSolrCloudClusterSSL, HdfsChaosMonkeySafeLeaderTest, TestBinaryField, TestClusterStateMutator, TestLegacyNumericUtils, TestJavabinTupleStreamParser, DateMathParserTest, TestUseDocValuesAsStored2, RequestHandlersTest, UtilsToolTest, ResourceLoaderTest, TestExtendedDismaxParser, PeerSyncTest, TestTrieFacet, TestReversedWildcardFilterFactory, BooleanFieldTest, SimpleFacetsTest, TestGroupingSearch, TestFuzzyAnalyzedSuggestions, RequestLoggingTest, SolrSlf4jReporterTest, DocValuesNotIndexedTest, V2StandaloneTest, TestConfigsApi, TestRawResponseWriter, TestCursorMarkWithoutUniqueKey, TestSearcherReuse, DocValuesTest, TestNRTOpen, TestSerializedLuceneMatchVersion, TestInPlaceUpdatesDistrib, HdfsBasicDistributedZkTest, BlobRepositoryCloudTest, TestClassicSimilarityFactory, SolrMetricsIntegrationTest, BigEndianAscendingWordDeserializerTest, HighlighterConfigTest, TestRandomRequestDistribution, TestSolrCoreParser, TestXIncludeConfig, NodeMutatorTest, TestStressVersions, SaslZkACLProviderTest, ConnectionManagerTest, TestHashPartitioner, ZkCLITest, TestQuerySenderNoQuery, TestEmbeddedSolrServerSchemaAPI, NoCacheHeaderTest, TestIndexingPerformance, DistributedSpellCheckComponentTest, SolrIndexMetricsTest, PrimUtilsTest, FullHLLTest, HLLUtilTest, TestIBSimilarityFactory, PreAnalyzedUpdateProcessorTest, WrapperMergePolicyFactoryTest, TestSolrCLIRunExample, CursorPagingTest, InfixSuggestersTest, RemoteQueryErrorTest, TestStressReorder, TestLazyCores, LargeFieldTest, HdfsTlogReplayBufferedWhileIndexingTest, BlockDirectoryTest, RuleEngineTest, TestMultiValuedNumericRangeQuery, SolrShardReporterTest, TestCloudSchemaless, TestSolrCloudWithKerberosAlt, UUIDFieldTest, SolrCloudExampleTest, SuggesterWFSTTest, ZkStateWriterTest, TestSQLHandler, TestNumericTerms32, AnalysisAfterCoreReloadTest, RegexBoostProcessorTest, ShardRoutingTest, DistribDocExpirationUpdateProcessorTest, PKIAuthenticationIntegrationTest, TestFileDictionaryLookup, AliasIntegrationTest, XmlUpdateRequestHandlerTest, TestLegacyNumericRangeQueryBuilder, HttpSolrCallGetCoreTest, TestAtomicUpdateErrorCases, BasicDistributedZkTest, UnloadDistributedZkTest, OverseerTest, BasicZkTest, RecoveryZkTest, TestReplicationHandler, TestCoreContainer, SolrCoreTest, TestSort, DirectUpdateHandlerTest, HighlighterTest, SolrIndexSplitterTest, SuggesterFSTTest, CoreAdminHandlerTest, SolrRequestParserTest, TestTrie, TestCSVLoader, WordBreakSolrSpellCheckerTest, TestPseudoReturnFields, FieldMutatingUpdateProcessorTest, DefaultValueUpdateProcessorTest, DistanceFunctionTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, TestQueryTypes, TestOmitPositions, TestValueSourceCache, MoreLikeThisHandlerTest, TestSolrQueryParser, UpdateRequestProcessorFactoryTest, QueryParsingTest, JsonLoaderTest, TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, TestComponentsName, SearchHandlerTest, UpdateParamsTest, AlternateDirectoryTest, CopyFieldTest, ResponseLogComponentTest, BadComponentTest, TestSolrDeletionPolicy2, SampleTest, TestDocSet, MinimalSchemaTest, TestElisionMultitermQuery, OutputWriterTest, TestSolrCoreProperties, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestCodecSupport, TestPerFieldSimilarity, TestBM25SimilarityFactory, TimeZoneUtilsTest, ScriptEngineTest, PluginInfoTest, ChaosMonkeyNothingIsSafeTest, AssignTest, CdcrReplicationDistributedZkTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, ChaosMonkeySafeLeaderWithPullReplicasTest, CloudExitableDirectoryReaderTest, CreateCollectionCleanupTest, CustomCollectionTest, DeleteLastCustomShardedReplicaTest, DeleteShardTest, ForceLeaderTest, MissingSegmentRecoveryTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, OverseerTaskQueueTest, ReplicationFactorTest, RestartWhileUpdatingTest, SolrXmlInZkTest, TestCloudInspectUtil, TestCloudPivotFacet, TestClusterProperties, TestCollectionAPI, TestConfigSetsAPI, TestLocalFSCloudBackupRestore, TestPrepRecovery, TestRequestForwarding, TestSSLRandomization, TestSolrCloudWithDelegationTokens, TestStressCloudBlindAtomicUpdates, TestTlogReplica, TestImplicitCoreProperties, TestInitParams, TestReloadAndDeleteDocs, TestShardHandlerFactory, TestSolrConfigHandler, TestSolrCloudSnapshots, TestSolrConfigHandlerCloud, DistributedSuggestComponentTest, SuggestComponentContextFilterQueryTest, TestPivotHelperCode, TestTrackingShardHandlerFactory, JavabinLoaderTest, TestUnifiedSolrHighlighter, TestSlowCompositeReaderWrapper, TestLegacyField, TestNumericRangeQuery32, TestNumericRangeQuery64, TestNumericTokenStream, JvmMetricsTest, MetricsConfigTest, SolrCoreMetricManagerTest, SolrMetricManagerTest, SolrGangliaReporterTest, SolrGraphiteReporterTest, TestGeoJSONResponseWriter, TestGraphMLResponseWriter, TestSubQueryTransformer, TestSubQueryTransformerDistrib, TestCopyFieldCollectionResource, TestDynamicFieldCollectionResource, TestDynamicFieldResource, TestFieldCollectionResource, TestSchemaResource, TestSchemaVersionResource, TestManagedSynonymGraphFilterFactory, SpatialRPTFieldTypeTest, TestHalfAndHalfDocValues, TestManagedSchemaThreadSafety, TestPointFields, AnalyticsQueryTest, CursorMarkTest, RankQueryTest, SortSpecParsingTest, TestAddFieldRealTimeGet, TestComplexPhraseLeadingWildcard, TestComplexPhraseQParserPlugin, TestFieldSortValues, TestFilteredDocIdSet, TestHashQParserPlugin, TestMaxScoreQueryParser, TestMissingGroups, TestOverriddenPrefixQueryForCustomFieldType, TestPayloadCheckQParserPlugin, TestRecoveryHdfs, TestReloadDeadlock, TestSmileRequest, TestSolr4Spatial2, TestStandardQParsers, TestXmlQParser, TestJsonFacetRefinement, TestJsonFacets, TestDistribIDF, BasicAuthIntegrationTest, BlockCacheTest, TestFieldCache, TestFieldCacheSortRandom, TestFieldCacheWithThreads, TestLegacyFieldCache, TestUninvertingReader, AddBlockUpdateTest, AnalysisErrorHandlingTest, CdcrUpdateLogTest, PeerSyncWithIndexFingerprintCachingTest, UpdateLogTest, VersionInfoTest, AddSchemaFieldsUpdateProcessorFactoryTest, AtomicUpdateProcessorFactoryTest] [junit4] Completed [711/726 (2!)] on J0 in 0.66s, 4 tests, 1 error <<< FAILURES! [...truncated 39379 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org