Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/109/
2 tests failed. FAILED: org.apache.solr.cloud.LeaderElectionContextKeyTest.test Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([BC3F9998ADD9A8F1:346BA6420325C509]: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([BC3F9998ADD9A8F1:900DEE15211DDE75]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886) at org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads(AtomicUpdateProcessorFactoryTest.java:260) 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=cat:za92uumx5ebsafgax3b5+5igrctj6yi4i2chkuls7+6ynkb9mvtcquc34scqv4+n7m2uf8bsftqkhsfd9nm+ryy9sva4leo7iecz3s8p&wt=xml at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879) ... 40 more Build Log: [...truncated 11571 lines...] [junit4] Suite: org.apache.solr.cloud.LeaderElectionContextKeyTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/init-core-data-001 [junit4] 2> 670183 WARN (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1 [junit4] 2> 670183 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 670184 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 670185 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 670186 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001 [junit4] 2> 670186 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 670186 INFO (Thread-1526) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 670186 INFO (Thread-1526) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 670198 ERROR (Thread-1526) [ ] 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> 670286 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:51805 [junit4] 2> 670304 INFO (jetty-launcher-999-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 670305 INFO (jetty-launcher-999-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5aacd47{/solr,null,AVAILABLE} [junit4] 2> 670311 INFO (jetty-launcher-999-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@12b833f0{SSL,[ssl, http/1.1]}{127.0.0.1:42733} [junit4] 2> 670311 INFO (jetty-launcher-999-thread-1) [ ] o.e.j.s.Server Started @674974ms [junit4] 2> 670311 INFO (jetty-launcher-999-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42733} [junit4] 2> 670311 ERROR (jetty-launcher-999-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 670311 INFO (jetty-launcher-999-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.1.0 [junit4] 2> 670311 INFO (jetty-launcher-999-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 670311 INFO (jetty-launcher-999-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 670311 INFO (jetty-launcher-999-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-07-28T03:25:10.364Z [junit4] 2> 670314 INFO (jetty-launcher-999-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 670324 INFO (jetty-launcher-999-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51805/solr [junit4] 2> 670432 INFO (jetty-launcher-999-thread-1) [n:127.0.0.1:42733_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 670434 INFO (jetty-launcher-999-thread-1) [n:127.0.0.1:42733_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:42733_solr [junit4] 2> 670436 INFO (jetty-launcher-999-thread-1) [n:127.0.0.1:42733_solr ] o.a.s.c.Overseer Overseer (id=98383449964085251-127.0.0.1:42733_solr-n_0000000000) starting [junit4] 2> 670463 INFO (jetty-launcher-999-thread-1) [n:127.0.0.1:42733_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42733_solr [junit4] 2> 670466 INFO (zkCallback-1006-thread-1-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 670576 INFO (jetty-launcher-999-thread-1) [n:127.0.0.1:42733_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42733.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@636ad2cc [junit4] 2> 670582 INFO (jetty-launcher-999-thread-1) [n:127.0.0.1:42733_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42733.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@636ad2cc [junit4] 2> 670583 INFO (jetty-launcher-999-thread-1) [n:127.0.0.1:42733_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42733.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@636ad2cc [junit4] 2> 670584 INFO (jetty-launcher-999-thread-1) [n:127.0.0.1:42733_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/. [junit4] 2> 670628 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 670630 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51805/solr ready [junit4] 2> 670683 INFO (qtp1503037063-5924) [n:127.0.0.1:42733_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> 670686 INFO (OverseerThreadFactory-2278-thread-1-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_solr ] o.a.s.c.CreateCollectionCmd Create collection testCollection1 [junit4] 2> 670808 INFO (OverseerStateUpdate-98383449964085251-127.0.0.1:42733_solr-n_0000000000) [n:127.0.0.1:42733_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":"https://127.0.0.1:42733/solr", [junit4] 2> "type":"NRT"} [junit4] 2> 670815 INFO (OverseerStateUpdate-98383449964085251-127.0.0.1:42733_solr-n_0000000000) [n:127.0.0.1:42733_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":"https://127.0.0.1:42733/solr", [junit4] 2> "type":"NRT"} [junit4] 2> 671029 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 671030 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 671040 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 671151 INFO (zkCallback-1006-thread-1-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 671152 INFO (zkCallback-1006-thread-2-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 671162 INFO (zkCallback-1006-thread-3-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 672055 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672055 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672063 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672063 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672067 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672067 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672067 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672067 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672067 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42733.solr.core.testCollection1.shard1.replica_n1' (registry 'solr.core.testCollection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@636ad2cc [junit4] 2> 672067 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42733.solr.core.testCollection1.shard2.replica_n3' (registry 'solr.core.testCollection1.shard2.replica_n3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@636ad2cc [junit4] 2> 672067 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 672068 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 672068 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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 [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/testCollection1_shard1_replica_n1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/./testCollection1_shard1_replica_n1/data/] [junit4] 2> 672068 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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 [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/testCollection1_shard2_replica_n3], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/./testCollection1_shard2_replica_n3/data/] [junit4] 2> 672124 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672124 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672124 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672124 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672126 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 672126 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 672126 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 672126 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 672127 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.s.SolrIndexSearcher Opening [Searcher@33b913de[testCollection1_shard2_replica_n3] main] [junit4] 2> 672127 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7ed81b5c[testCollection1_shard1_replica_n1] main] [junit4] 2> 672129 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672129 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672130 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672130 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672130 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672131 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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 1574135201460649984 [junit4] 2> 672131 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672133 INFO (searcherExecutor-2282-thread-1-processing-n:127.0.0.1:42733_solr x:testCollection1_shard1_replica_n1 s:shard1 c:testCollection1 r:core_node2) [n:127.0.0.1:42733_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@7ed81b5c[testCollection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 672133 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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 1574135201462747136 [junit4] 2> 672142 INFO (searcherExecutor-2281-thread-1-processing-n:127.0.0.1:42733_solr x:testCollection1_shard2_replica_n3 s:shard2 c:testCollection1 r:core_node4) [n:127.0.0.1:42733_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@33b913de[testCollection1_shard2_replica_n3] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 672146 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672146 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672146 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42733/solr/testCollection1_shard1_replica_n1/ [junit4] 2> 672146 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672146 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:42733/solr/testCollection1_shard1_replica_n1/ has no replicas [junit4] 2> 672146 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672147 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672147 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672147 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42733/solr/testCollection1_shard2_replica_n3/ [junit4] 2> 672147 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672147 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.SyncStrategy https://127.0.0.1:42733/solr/testCollection1_shard2_replica_n3/ has no replicas [junit4] 2> 672148 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672151 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_solr c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42733/solr/testCollection1_shard1_replica_n1/ shard1 [junit4] 2> 672152 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42733/solr/testCollection1_shard2_replica_n3/ shard2 [junit4] 2> 672255 INFO (zkCallback-1006-thread-3-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 672255 INFO (zkCallback-1006-thread-2-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 672255 INFO (zkCallback-1006-thread-1-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 672302 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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> 672303 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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> 672304 INFO (qtp1503037063-5925) [n:127.0.0.1:42733_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=1263 [junit4] 2> 672306 INFO (qtp1503037063-5929) [n:127.0.0.1:42733_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=1276 [junit4] 2> 672309 INFO (qtp1503037063-5924) [n:127.0.0.1:42733_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> 672411 INFO (zkCallback-1006-thread-2-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 672411 INFO (zkCallback-1006-thread-1-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 672411 INFO (zkCallback-1006-thread-3-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 672689 INFO (OverseerCollectionConfigSetProcessor-98383449964085251-127.0.0.1:42733_solr-n_0000000000) [n:127.0.0.1:42733_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> 673310 INFO (qtp1503037063-5924) [n:127.0.0.1:42733_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=2626 [junit4] 2> 673311 INFO (qtp1503037063-5927) [n:127.0.0.1:42733_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> 673313 INFO (OverseerThreadFactory-2278-thread-2-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_solr ] o.a.s.c.CreateCollectionCmd Create collection testCollection2 [junit4] 2> 673522 INFO (OverseerStateUpdate-98383449964085251-127.0.0.1:42733_solr-n_0000000000) [n:127.0.0.1:42733_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":"https://127.0.0.1:42733/solr", [junit4] 2> "type":"NRT"} [junit4] 2> 673525 INFO (OverseerStateUpdate-98383449964085251-127.0.0.1:42733_solr-n_0000000000) [n:127.0.0.1:42733_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":"https://127.0.0.1:42733/solr", [junit4] 2> "type":"NRT"} [junit4] 2> 673726 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 673727 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 673834 INFO (zkCallback-1006-thread-1-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 673834 INFO (zkCallback-1006-thread-3-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 674747 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674784 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674792 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674796 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674796 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674796 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674797 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42733.solr.core.testCollection2.shard2.replica_n2' (registry 'solr.core.testCollection2.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@636ad2cc [junit4] 2> 674797 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 674797 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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 [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/testCollection2_shard2_replica_n2], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/./testCollection2_shard2_replica_n2/data/] [junit4] 2> 674800 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674800 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674802 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42733.solr.core.testCollection2.shard1.replica_n1' (registry 'solr.core.testCollection2.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@636ad2cc [junit4] 2> 674802 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 674803 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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 [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/testCollection2_shard1_replica_n1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001/tempDir-001/node1/./testCollection2_shard1_replica_n1/data/] [junit4] 2> 674898 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674898 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674900 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 674900 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 674901 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@7446bb77[testCollection2_shard2_replica_n2] main] [junit4] 2> 674910 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674911 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674911 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674912 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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 1574135204376739840 [junit4] 2> 674922 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674922 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674922 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42733/solr/testCollection2_shard2_replica_n2/ [junit4] 2> 674922 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674922 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.SyncStrategy https://127.0.0.1:42733/solr/testCollection2_shard2_replica_n2/ has no replicas [junit4] 2> 674922 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 674927 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_solr c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42733/solr/testCollection2_shard2_replica_n2/ shard2 [junit4] 2> 674930 INFO (searcherExecutor-2291-thread-1-processing-n:127.0.0.1:42733_solr x:testCollection2_shard2_replica_n2 s:shard2 c:testCollection2 r:core_node4) [n:127.0.0.1:42733_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@7446bb77[testCollection2_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 674950 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674950 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674951 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 674951 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 674953 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@674e0107[testCollection2_shard1_replica_n1] main] [junit4] 2> 674963 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674963 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674964 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674964 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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 1574135204431265792 [junit4] 2> 674968 INFO (searcherExecutor-2292-thread-1-processing-n:127.0.0.1:42733_solr x:testCollection2_shard1_replica_n1 s:shard1 c:testCollection2 r:core_node3) [n:127.0.0.1:42733_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@674e0107[testCollection2_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 674973 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674973 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674973 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42733/solr/testCollection2_shard1_replica_n1/ [junit4] 2> 674973 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674973 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:42733/solr/testCollection2_shard1_replica_n1/ has no replicas [junit4] 2> 674973 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 674977 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_solr c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42733/solr/testCollection2_shard1_replica_n1/ shard1 [junit4] 2> 675079 INFO (zkCallback-1006-thread-1-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 675080 INFO (zkCallback-1006-thread-3-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 675127 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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> 675128 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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> 675129 INFO (qtp1503037063-5928) [n:127.0.0.1:42733_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=1402 [junit4] 2> 675130 INFO (qtp1503037063-5930) [n:127.0.0.1:42733_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=1403 [junit4] 2> 675133 INFO (qtp1503037063-5927) [n:127.0.0.1:42733_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> 675237 INFO (zkCallback-1006-thread-1-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 675237 INFO (zkCallback-1006-thread-3-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_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> 675316 INFO (OverseerCollectionConfigSetProcessor-98383449964085251-127.0.0.1:42733_solr-n_0000000000) [n:127.0.0.1:42733_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> 676133 INFO (qtp1503037063-5927) [n:127.0.0.1:42733_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=2822 [junit4] 2> 676134 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: testCollection1 failOnTimeout:true timeout (sec):30 [junit4] 2> 676135 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: testCollection1 [junit4] 2> 676135 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: testCollection2 failOnTimeout:true timeout (sec):30 [junit4] 2> 676135 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: testCollection2 [junit4] 2> 676148 INFO (TEST-LeaderElectionContextKeyTest.test-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 676154 INFO (qtp1503037063-5924) [n:127.0.0.1:42733_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCollection1.shard2.replica_n3, tag=null [junit4] 2> 676158 INFO (qtp1503037063-5924) [n:127.0.0.1:42733_solr ] o.a.s.c.SolrCore [testCollection1_shard2_replica_n3] CLOSING SolrCore org.apache.solr.core.SolrCore@397b2e1e [junit4] 2> 676161 INFO (qtp1503037063-5924) [n:127.0.0.1:42733_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCollection1.shard2.replica_n3, tag=964374046 [junit4] 2> 676161 INFO (qtp1503037063-5924) [n:127.0.0.1:42733_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.testCollection1.shard2.leader, tag=964374046 [junit4] 2> 676162 INFO (qtp1503037063-5924) [n:127.0.0.1:42733_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=8 [junit4] 2> 676163 INFO (TEST-LeaderElectionContextKeyTest.test-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=LeaderElectionContextKeyTest -Dtests.method=test -Dtests.seed=BC3F9998ADD9A8F1 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ms-MY -Dtests.timezone=Etc/UTC -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 0.03s J2 | LeaderElectionContextKeyTest.test <<< [junit4] > Throwable #1: java.lang.AssertionError [junit4] > at __randomizedtesting.SeedInfo.seed([BC3F9998ADD9A8F1:346BA6420325C509]:0) [junit4] > at org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] 2> 676168 INFO (jetty-closer-1000-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@12b833f0{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 676168 INFO (jetty-closer-1000-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1095873714 [junit4] 2> 676169 INFO (jetty-closer-1000-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 676170 INFO (jetty-closer-1000-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 676172 INFO (jetty-closer-1000-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 676173 INFO (jetty-closer-1000-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 676174 INFO (coreCloseExecutor-2301-thread-1) [n:127.0.0.1:42733_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@4ab98057 [junit4] 2> 676174 INFO (coreCloseExecutor-2301-thread-2) [n:127.0.0.1:42733_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@2c982482 [junit4] 2> 676175 INFO (coreCloseExecutor-2301-thread-3) [n:127.0.0.1:42733_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@7867a273 [junit4] 2> 676178 INFO (coreCloseExecutor-2301-thread-1) [n:127.0.0.1:42733_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=1253670999 [junit4] 2> 676185 INFO (coreCloseExecutor-2301-thread-1) [n:127.0.0.1:42733_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=1253670999 [junit4] 2> 676185 INFO (coreCloseExecutor-2301-thread-2) [n:127.0.0.1:42733_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=748168322 [junit4] 2> 676188 INFO (coreCloseExecutor-2301-thread-2) [n:127.0.0.1:42733_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=748168322 [junit4] 2> 676188 INFO (coreCloseExecutor-2301-thread-3) [n:127.0.0.1:42733_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=2020057715 [junit4] 2> 676192 INFO (coreCloseExecutor-2301-thread-3) [n:127.0.0.1:42733_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=2020057715 [junit4] 2> 676192 INFO (jetty-closer-1000-thread-1) [ ] o.a.s.c.Overseer Overseer (id=98383449964085251-127.0.0.1:42733_solr-n_0000000000) closing [junit4] 2> 676193 INFO (OverseerStateUpdate-98383449964085251-127.0.0.1:42733_solr-n_0000000000) [n:127.0.0.1:42733_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:42733_solr [junit4] 2> 677694 WARN (zkCallback-1006-thread-3-processing-n:127.0.0.1:42733_solr) [n:127.0.0.1:42733_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 677694 INFO (jetty-closer-1000-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5aacd47{/solr,null,UNAVAILABLE} [junit4] 2> 677695 ERROR (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-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> 677696 INFO (SUITE-LeaderElectionContextKeyTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51805 51805 [junit4] 2> 678190 INFO (Thread-1526) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51805 51805 [junit4] 2> 678191 WARN (Thread-1526) [ ] 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> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 9 /solr/collections/testCollection1/state.json [junit4] 2> 5 /solr/collections/testCollection2/state.json [junit4] 2> 2 /solr/clusterstate.json [junit4] 2> 2 /solr/clusterprops.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: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_BC3F9998ADD9A8F1-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1307, maxMBSortInHeap=5.05627032837331, sim=RandomSimilarity(queryNorm=true): {}, locale=ms-MY, timezone=Etc/UTC [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=4,threads=1,free=158427200,total=526385152 [junit4] 2> NOTE: All tests run in this JVM: [TestLegacyTerms, TestCloudPivotFacet, TestZkChroot, XsltUpdateRequestHandlerTest, SpellPossibilityIteratorTest, UniqFieldsUpdateProcessorFactoryTest, CoreAdminRequestStatusTest, DistributedDebugComponentTest, DirectoryFactoryTest, TestSmileRequest, ZkStateWriterTest, TestScoreJoinQPNoScore, MoveReplicaTest, HdfsRestartWhileUpdatingTest, SignatureUpdateProcessorFactoryTest, NumericFieldsTest, TestGroupingSearch, TestRawResponseWriter, BlockJoinFacetDistribTest, JSONWriterTest, CircularListTest, BigEndianAscendingWordDeserializerTest, CachingDirectoryFactoryTest, HighlighterMaxOffsetTest, SearchHandlerTest, TestSuggestSpellingConverter, TestSchemaVersionResource, ConfigSetsAPITest, SharedFSAutoReplicaFailoverUtilsTest, TestTestInjection, SolrCloudExampleTest, CurrencyFieldTypeTest, TestPayloadScoreQParserPlugin, TestDocTermOrds, TestSolrCloudWithHadoopAuthPlugin, SuggesterTest, TestReversedWildcardFilterFactory, TestHdfsBackupRestoreCore, TestTolerantSearch, TestExactSharedStatsCache, TestPivotHelperCode, HdfsNNFailoverTest, TestManagedStopFilterFactory, TestHighFrequencyDictionaryFactory, TestRequestStatusCollectionAPI, CdcrReplicationDistributedZkTest, AutoCommitTest, TestRestoreCore, CdcrVersionReplicationTest, RequiredFieldsTest, SortSpecParsingTest, SimplePostToolTest, TestObjectReleaseTracker, TestSolrCloudWithKerberosAlt, DistributedQueryComponentOptimizationTest, TestOnReconnectListenerSupport, RulesTest, BufferStoreTest, TestLMJelinekMercerSimilarityFactory, RemoteQueryErrorTest, AliasIntegrationTest, TestSolrFieldCacheBean, MinimalSchemaTest, DirectUpdateHandlerTest, CollectionReloadTest, TestStressInPlaceUpdates, V2ApiIntegrationTest, TestSimpleTextCodec, SuggesterFSTTest, TestShortCircuitedRequests, OverseerModifyCollectionTest, ShowFileRequestHandlerTest, BasicAuthIntegrationTest, TestSha256AuthenticationProvider, SearchHandlerTest, CloudMLTQParserTest, CustomCollectionTest, SimpleFacetsTest, PolyFieldTest, BadIndexSchemaTest, LeaderElectionContextKeyTest] [junit4] Completed [209/726 (1!)] on J2 in 8.02s, 1 test, 1 failure <<< FAILURES! [...truncated 1627 lines...] [junit4] Suite: org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.AtomicUpdateProcessorFactoryTest_BC3F9998ADD9A8F1-001/init-core-data-001 [junit4] 2> 2450512 WARN (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=17 numCloses=17 [junit4] 2> 2450512 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 2450513 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 2450514 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 2450514 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2450514 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2450546 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 2450577 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 2450711 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2450756 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b73bce6 [junit4] 2> 2450762 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b73bce6 [junit4] 2> 2450762 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b73bce6 [junit4] 2> 2450773 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2450810 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 2450838 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2450981 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2450994 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2450994 INFO (coreLoadExecutor-6457-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@b73bce6 [junit4] 2> 2450995 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2450995 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.AtomicUpdateProcessorFactoryTest_BC3F9998ADD9A8F1-001/init-core-data-001/] [junit4] 2> 2450998 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7843335318143118] [junit4] 2> 2451074 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2451074 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2451075 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2451075 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2451076 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=69.3583984375, floorSegmentMB=0.8173828125, forceMergeDeletesPctAllowed=4.661645847058243, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5303341861835681 [junit4] 2> 2451077 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4220e21d[collection1] main] [junit4] 2> 2451077 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2451086 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2451115 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2451115 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2451115 INFO (coreLoadExecutor-6457-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574137064877719552 [junit4] 2> 2451115 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2451115 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2451115 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2451115 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2451116 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2451116 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2451116 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2451116 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2451117 INFO (searcherExecutor-6458-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4220e21d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2451119 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 2451122 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBasics [junit4] 2> 2451126 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1574137064889253888,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2451126 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2a6a1a45 commitCommandVersion:1574137064889253888 [junit4] 2> 2451130 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@c3bd50[collection1] main] [junit4] 2> 2451131 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2451133 INFO (searcherExecutor-6458-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@c3bd50[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):C1)))} [junit4] 2> 2451133 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 7 [junit4] 2> 2451136 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451137 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:human&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451137 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=title:Mr&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451138 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=count_i:20&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451138 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name_s:Virat&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451139 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=multiDefault:Delhi&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451141 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1574137064904982528,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2451141 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2a6a1a45 commitCommandVersion:1574137064904982528 [junit4] 2> 2451145 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2394e586[collection1] main] [junit4] 2> 2451145 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2451147 INFO (searcherExecutor-6458-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2394e586[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C1)))} [junit4] 2> 2451148 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6 [junit4] 2> 2451148 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451149 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:human&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451149 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:animal&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451150 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=title:Mr&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 2451150 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=title:Dr&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451150 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=count_i:20&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 2451151 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=count_i:40&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 2451151 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name_s:Virat&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 2451151 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=multiDefault:Delhi&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 2451151 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBasics [junit4] 2> 2451154 INFO (TEST-AtomicUpdateProcessorFactoryTest.testNoUniqueIdPassed-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNoUniqueIdPassed [junit4] 2> 2451154 INFO (TEST-AtomicUpdateProcessorFactoryTest.testNoUniqueIdPassed-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testNoUniqueIdPassed [junit4] 2> 2451157 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMultipleThreads [junit4] 2> 2451157 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 2451157 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@368266e5[collection1] realtime] [junit4] 2> 2451158 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] 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> 2451161 WARN (Thread-5889) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574137064923856896 actual=1574137064924905472Retrying with new version .... (1) [junit4] 2> 2451177 WARN (Thread-5891) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574137064933294080 actual=1574137064941682688Retrying with new version .... (1) [junit4] 2> 2451177 WARN (Thread-5892) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574137064925954050 actual=1574137064941682688Retrying with new version .... (1) [junit4] 2> 2451178 WARN (Thread-5893) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574137064933294080 actual=1574137064941682688Retrying with new version .... (1) [junit4] 2> 2451179 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1574137064944828416,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2451179 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2a6a1a45 commitCommandVersion:1574137064944828416 [junit4] 2> 2451183 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@22488d68[collection1] main] [junit4] 2> 2451185 INFO (searcherExecutor-6458-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@22488d68[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.1.0):C10/9:delGen=1)))} [junit4] 2> 2451185 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2451186 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6 [junit4] 2> 2451186 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] 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> 2451187 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:za92uumx5ebsafgax3b5+5igrctj6yi4i2chkuls7+6ynkb9mvtcquc34scqv4+n7m2uf8bsftqkhsfd9nm+ryy9sva4leo7iecz3s8p&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 2451188 ERROR (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] 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=cat:za92uumx5ebsafgax3b5+5igrctj6yi4i2chkuls7+6ynkb9mvtcquc34scqv4+n7m2uf8bsftqkhsfd9nm+ryy9sva4leo7iecz3s8p&wt=xml [junit4] 2> 2451188 ERROR (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=cat:za92uumx5ebsafgax3b5+5igrctj6yi4i2chkuls7+6ynkb9mvtcquc34scqv4+n7m2uf8bsftqkhsfd9nm+ryy9sva4leo7iecz3s8p&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=cat:za92uumx5ebsafgax3b5+5igrctj6yi4i2chkuls7+6ynkb9mvtcquc34scqv4+n7m2uf8bsftqkhsfd9nm+ryy9sva4leo7iecz3s8p&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:260) [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$Statement [...truncated too long message...] ules.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> 2451189 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMultipleThreads [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AtomicUpdateProcessorFactoryTest -Dtests.method=testMultipleThreads -Dtests.seed=BC3F9998ADD9A8F1 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-GB -Dtests.timezone=Australia/Queensland -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] ERROR 0.04s J0 | AtomicUpdateProcessorFactoryTest.testMultipleThreads <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([BC3F9998ADD9A8F1:900DEE15211DDE75]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886) [junit4] > at org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads(AtomicUpdateProcessorFactoryTest.java:260) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] [junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] > <response> [junit4] > <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] > </response> [junit4] > request was:q=cat:za92uumx5ebsafgax3b5+5igrctj6yi4i2chkuls7+6ynkb9mvtcquc34scqv4+n7m2uf8bsftqkhsfd9nm+ryy9sva4leo7iecz3s8p&wt=xml [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879) [junit4] > ... 40 more [junit4] 2> 2451197 INFO (TEST-AtomicUpdateProcessorFactoryTest.testWrongAtomicOpPassed-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWrongAtomicOpPassed [junit4] 2> 2451197 INFO (TEST-AtomicUpdateProcessorFactoryTest.testWrongAtomicOpPassed-seed#[BC3F9998ADD9A8F1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWrongAtomicOpPassed [junit4] 2> 2451197 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 2451197 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1786732673 [junit4] 2> 2451197 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2451199 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2451200 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2451200 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[BC3F9998ADD9A8F1]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2451200 INFO (coreCloseExecutor-6463-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@542a5dc1 [junit4] 2> 2451202 INFO (coreCloseExecutor-6463-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1412062657 [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.AtomicUpdateProcessorFactoryTest_BC3F9998ADD9A8F1-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {name_s=FST50, title_stringNoNorms=PostingsFormat(name=LuceneFixedGap), title_stemmed=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), cat=PostingsFormat(name=LuceneFixedGap), id=PostingsFormat(name=LuceneVarGapDocFreqInterval), text=FST50, title=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), title_lettertok=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), _version_=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Direct), intDvoDefault=DocValuesFormat(name=Lucene70), timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1338, maxMBSortInHeap=5.016175830271302, sim=RandomSimilarity(queryNorm=false): {}, locale=en-GB, timezone=Australia/Queensland [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=4,threads=1,free=306237056,total=529530880 [junit4] 2> NOTE: All tests run in this JVM: [TestLMDirichletSimilarityFactory, DeleteReplicaTest, DistributedSuggestComponentTest, SolrPluginUtilsTest, TestDocumentBuilder, SmileWriterTest, CdcrUpdateLogTest, PeerSyncTest, TestBadConfig, ConfigureRecoveryStrategyTest, TestLeaderElectionZkExpiry, LeaderInitiatedRecoveryOnShardRestartTest, OutputWriterTest, TestAddFieldRealTimeGet, WordBreakSolrSpellCheckerTest, TestFieldTypeCollectionResource, SuggestComponentContextFilterQueryTest, SolrCoreTest, LeaderFailoverAfterPartitionTest, SolrMetricReporterTest, TestRandomDVFaceting, TestSolr4Spatial2, TestStandardQParsers, FullHLLTest, ConnectionReuseTest, TestTolerantUpdateProcessorRandomCloud, ReplaceNodeTest, TestSSLRandomization, TestMultiValuedNumericRangeQuery, BasicZkTest, TestUninvertingReader, SparseHLLTest, HdfsChaosMonkeySafeLeaderTest, CollectionsAPISolrJTest, TestSQLHandler, TestCloudPseudoReturnFields, TestDeleteCollectionOnDownNodes, PeerSyncReplicationTest, TestHighlightDedupGrouping, TestExactStatsCache, TestMacroExpander, TestRTimerTree, DistributedQueueTest, ForceLeaderTest, DistributedSpellCheckComponentTest, HdfsRecoverLeaseTest, TestJavabinTupleStreamParser, TestSolrQueryParser, TestManagedSynonymFilterFactory, ConnectionManagerTest, CdcrReplicationHandlerTest, TestManagedResource, OverseerRolesTest, VMParamsZkACLAndCredentialsProvidersTest, TestRandomFlRTGCloud, ZkNodePropsTest, SolrIndexSplitterTest, MultiThreadedOCPTest, TestStressLiveNodes, HttpSolrCallGetCoreTest, DistributedExpandComponentTest, TestPointFields, TestCloudInspectUtil, TestStressLucene, UUIDFieldTest, TestInfoStreamLogging, TestConfigSetsAPIExclusivity, BlobRepositoryCloudTest, TestBlobHandler, RAMDirectoryFactoryTest, TestSchemaResource, HighlighterConfigTest, RollingRestartTest, TestSerializedLuceneMatchVersion, FieldMutatingUpdateProcessorTest, LeaderElectionIntegrationTest, OpenExchangeRatesOrgProviderTest, TestFaceting, TestSolrDeletionPolicy1, TestUseDocValuesAsStored, TestRangeQuery, TestFilteredDocIdSet, ClassificationUpdateProcessorIntegrationTest, TestPhraseSuggestions, TestRawTransformer, TestIBSimilarityFactory, TestWordDelimiterFilterFactory, TestNamedUpdateProcessors, ChaosMonkeyNothingIsSafeTest, TestComplexPhraseQParserPlugin, CoreMergeIndexesAdminHandlerTest, DistribCursorPagingTest, EchoParamsTest, TestNonDefinedSimilarityFactory, CleanupOldIndexTest, SpellCheckCollatorWithCollapseTest, CollectionStateFormat2Test, BooleanFieldTest, MetricsConfigTest, BasicDistributedZkTest, SpatialRPTFieldTypeTest, TestConfigsApi, TestCollationField, TestExpandComponent, DistributedFacetPivotWhiteBoxTest, TestPrepRecovery, TestUnifiedSolrHighlighter, TestFileDictionaryLookup, ExitableDirectoryReaderTest, TestExclusionRuleCollectionAccess, TestSearcherReuse, DistanceUnitsTest, TestDynamicFieldResource, TestSolrConfigHandler, TestRealTimeGet, TestOverriddenPrefixQueryForCustomFieldType, CursorPagingTest, SolrCloudReportersTest, TestSolrCloudSnapshots, TestSystemCollAutoCreate, DistributedFacetPivotLargeTest, ReplicaListTransformerTest, ShufflingReplicaListTransformerTest, SpatialHeatmapFacetsTest, TestNumericRangeQuery64, SolrMetricManagerTest, SolrMetricsIntegrationTest, SolrGangliaReporterTest, SolrSlf4jReporterTest, TestGraphMLResponseWriter, TestPushWriter, TestSolrQueryResponse, TestChildDocTransformer, TestSubQueryTransformerDistrib, TestCloudManagedSchema, TestSchemaManager, AnalyticsQueryTest, LargeFieldTest, RankQueryTest, TestCollapseQParserPlugin, TestCustomSort, TestFieldSortValues, TestHashQParserPlugin, TestLegacyNumericRangeQueryBuilder, TestMaxScoreQueryParser, TestNoOpRegenerator, TestPayloadCheckQParserPlugin, TestRecoveryHdfs, BasicAuthStandaloneTest, PKIAuthenticationIntegrationTest, TestImpersonationWithHadoopAuth, BlockCacheTest, HdfsDirectoryTest, UpdateLogTest, VersionInfoTest, AddSchemaFieldsUpdateProcessorFactoryTest, AtomicUpdateProcessorFactoryTest] [junit4] Completed [708/726 (2!)] on J0 in 0.71s, 4 tests, 1 error <<< FAILURES! [...truncated 43349 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org