Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/672/ Java: 64bit/jdk-9 -XX:+UseCompressedOops -XX:+UseSerialGC --illegal-access=deny
2 tests failed. FAILED: org.apache.solr.cloud.AssignBackwardCompatibilityTest.test Error Message: Error from server at https://127.0.0.1:34377/solr: addreplica the collection time out:180s Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:34377/solr: addreplica the collection time out:180s at __randomizedtesting.SeedInfo.seed([7937B8D583010A79:F163870F2DFD6781]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:626) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:253) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:242) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:867) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:195) at org.apache.solr.cloud.AssignBackwardCompatibilityTest.test(AssignBackwardCompatibilityTest.java:83) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) 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:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) 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 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.TestCryptoKeys.test Error Message: Error from server at https://127.0.0.1:45855: create the collection time out:180s Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:45855: create the collection time out:180s at __randomizedtesting.SeedInfo.seed([7937B8D583010A79:F163870F2DFD6781]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:626) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:253) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:242) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:195) at org.apache.solr.handler.TestBlobHandler.createSystemCollection(TestBlobHandler.java:120) at org.apache.solr.cloud.TestCryptoKeys.test(TestCryptoKeys.java:116) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968) 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:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) 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 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.base/java.lang.Thread.run(Thread.java:844) Build Log: [...truncated 11851 lines...] [junit4] Suite: org.apache.solr.cloud.AssignBackwardCompatibilityTest [junit4] 2> 110585 INFO (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/init-core-data-001 [junit4] 2> 110585 WARN (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=955 numCloses=955 [junit4] 2> 110586 INFO (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 110586 INFO (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 110588 INFO (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001 [junit4] 2> 110588 INFO (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 110589 INFO (Thread-237) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 110589 INFO (Thread-237) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 110597 ERROR (Thread-237) [ ] 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> 110689 INFO (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:41433 [junit4] 2> 110694 INFO (jetty-launcher-132-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 110694 INFO (jetty-launcher-132-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 110697 INFO (jetty-launcher-132-thread-3) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 110707 INFO (jetty-launcher-132-thread-4) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 110711 INFO (jetty-launcher-132-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@68fbe2b0{/solr,null,AVAILABLE} [junit4] 2> 110731 INFO (jetty-launcher-132-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3f8cc81{/solr,null,AVAILABLE} [junit4] 2> 110731 INFO (jetty-launcher-132-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@67f78d08{SSL,[ssl, http/1.1]}{127.0.0.1:34377} [junit4] 2> 110731 INFO (jetty-launcher-132-thread-1) [ ] o.e.j.s.Server Started @112079ms [junit4] 2> 110731 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34377} [junit4] 2> 110731 ERROR (jetty-launcher-132-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 110731 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.0 [junit4] 2> 110731 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 110731 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 110731 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-26T06:14:00.888928Z [junit4] 2> 110737 INFO (jetty-launcher-132-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@34dad417{/solr,null,AVAILABLE} [junit4] 2> 110738 INFO (jetty-launcher-132-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@54d22bb4{SSL,[ssl, http/1.1]}{127.0.0.1:32877} [junit4] 2> 110738 INFO (jetty-launcher-132-thread-3) [ ] o.e.j.s.Server Started @112086ms [junit4] 2> 110738 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=32877} [junit4] 2> 110738 ERROR (jetty-launcher-132-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 110738 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.0 [junit4] 2> 110738 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 110738 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 110738 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-26T06:14:00.895582Z [junit4] 2> 110745 INFO (jetty-launcher-132-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@58e1926f{/solr,null,AVAILABLE} [junit4] 2> 110754 INFO (jetty-launcher-132-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7e48abd4{SSL,[ssl, http/1.1]}{127.0.0.1:45149} [junit4] 2> 110754 INFO (jetty-launcher-132-thread-4) [ ] o.e.j.s.Server Started @112103ms [junit4] 2> 110754 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45149} [junit4] 2> 110754 ERROR (jetty-launcher-132-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 110754 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.0 [junit4] 2> 110754 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 110754 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 110755 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-26T06:14:00.911997Z [junit4] 2> 110759 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 110765 INFO (jetty-launcher-132-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4e791e8a{SSL,[ssl, http/1.1]}{127.0.0.1:38983} [junit4] 2> 110765 INFO (jetty-launcher-132-thread-2) [ ] o.e.j.s.Server Started @112114ms [junit4] 2> 110765 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38983} [junit4] 2> 110766 ERROR (jetty-launcher-132-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 110766 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.0 [junit4] 2> 110766 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 110766 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 110766 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-26T06:14:00.923521Z [junit4] 2> 110774 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 110774 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 110777 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41433/solr [junit4] 2> 110782 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41433/solr [junit4] 2> 110783 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 110787 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41433/solr [junit4] 2> 110796 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15f5750e72e0004, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 110797 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15f5750e72e0005, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 110830 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41433/solr [junit4] 2> 110836 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 110839 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:45149_solr [junit4] 2> 110846 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.c.Overseer Overseer (id=98893721812992009-127.0.0.1:45149_solr-n_0000000000) starting [junit4] 2> 110846 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 110847 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34377_solr [junit4] 2> 110847 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 110848 INFO (zkCallback-156-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 110848 INFO (zkCallback-149-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 110848 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 110852 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38983_solr [junit4] 2> 110853 INFO (zkCallback-156-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 110853 INFO (zkCallback-149-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 110854 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 110861 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45149_solr [junit4] 2> 110866 INFO (zkCallback-156-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 110866 INFO (zkCallback-149-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 110866 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 110893 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 110894 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 110895 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32877_solr [junit4] 2> 110895 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 110895 INFO (zkCallback-149-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 110895 INFO (zkCallback-156-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 110897 INFO (zkCallback-148-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 110915 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45149.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110920 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45149.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110920 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45149.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110921 INFO (jetty-launcher-132-thread-4) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/. [junit4] 2> 110927 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38983.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110929 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34377.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110938 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38983.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110938 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38983.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110939 INFO (jetty-launcher-132-thread-2) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/. [junit4] 2> 110941 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34377.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110941 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34377.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110942 INFO (jetty-launcher-132-thread-1) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/. [junit4] 2> 110943 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32877.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110950 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32877.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110950 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32877.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 110951 INFO (jetty-launcher-132-thread-3) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/. [junit4] 2> 111070 INFO (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 111071 INFO (SUITE-AssignBackwardCompatibilityTest-seed#[7937B8D583010A79]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41433/solr ready [junit4] 2> 111095 INFO (qtp44478268-1046) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=0&replicationFactor=4&maxShardsPerNode=1000&name=collection1&nrtReplicas=4&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 111097 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.CreateCollectionCmd Create collection collection1 [junit4] 2> 111097 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.CreateCollectionCmd Only _default config set found, using it. [junit4] 2> 111097 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/collection1/protwords.txt [junit4] 2> 111098 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/collection1/managed-schema [junit4] 2> 111099 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/collection1/solrconfig.xml [junit4] 2> 111100 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/collection1/synonyms.txt [junit4] 2> 111100 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/collection1/stopwords.txt [junit4] 2> 111102 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/collection1/lang/contractions_it.txt [junit4] 2> 111103 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/collection1/lang/stemdict_nl.txt [junit4] 2> 111104 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/collection1/lang/stopwords_hy.txt [junit4] 2> 111105 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/collection1/lang/stopwords_no.txt [junit4] 2> 111106 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/collection1/lang/contractions_ca.txt [junit4] 2> 111106 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/collection1/lang/stopwords_id.txt [junit4] 2> 111107 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/collection1/lang/stopwords_ga.txt [junit4] 2> 111110 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/collection1/lang/stopwords_hi.txt [junit4] 2> 111111 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/collection1/lang/stopwords_da.txt [junit4] 2> 111111 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/collection1/lang/stopwords_ja.txt [junit4] 2> 111112 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/collection1/lang/stopwords_pt.txt [junit4] 2> 111113 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/collection1/lang/stopwords_hu.txt [junit4] 2> 111114 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/collection1/lang/stopwords_el.txt [junit4] 2> 111115 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/collection1/lang/stopwords_ru.txt [junit4] 2> 111118 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/collection1/lang/stopwords_tr.txt [junit4] 2> 111118 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/collection1/lang/stopwords_ar.txt [junit4] 2> 111119 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/collection1/lang/userdict_ja.txt [junit4] 2> 111120 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/collection1/lang/stopwords_eu.txt [junit4] 2> 111120 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/collection1/lang/stopwords_it.txt [junit4] 2> 111121 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/collection1/lang/stopwords_cz.txt [junit4] 2> 111122 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/collection1/lang/stoptags_ja.txt [junit4] 2> 111125 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/collection1/lang/contractions_fr.txt [junit4] 2> 111126 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/collection1/lang/stopwords_de.txt [junit4] 2> 111129 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/collection1/lang/stopwords_fa.txt [junit4] 2> 111129 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/collection1/lang/contractions_ga.txt [junit4] 2> 111130 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/collection1/lang/stopwords_ca.txt [junit4] 2> 111131 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/collection1/lang/stopwords_nl.txt [junit4] 2> 111131 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/collection1/lang/stopwords_bg.txt [junit4] 2> 111132 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/collection1/lang/stopwords_lv.txt [junit4] 2> 111133 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/collection1/lang/stopwords_en.txt [junit4] 2> 111134 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/collection1/lang/stopwords_es.txt [junit4] 2> 111136 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/collection1/lang/stopwords_th.txt [junit4] 2> 111137 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/collection1/lang/stopwords_ro.txt [junit4] 2> 111138 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/collection1/lang/stopwords_fr.txt [junit4] 2> 111139 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/collection1/lang/stopwords_sv.txt [junit4] 2> 111139 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/collection1/lang/stopwords_fi.txt [junit4] 2> 111140 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/collection1/lang/hyphenations_ga.txt [junit4] 2> 111140 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/collection1/lang/stopwords_gl.txt [junit4] 2> 111141 INFO (OverseerThreadFactory-496-thread-1) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/collection1/params.json [junit4] 2> 111246 INFO (OverseerStateUpdate-98893721812992009-127.0.0.1:45149_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"collection1_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:32877/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 111248 INFO (OverseerStateUpdate-98893721812992009-127.0.0.1:45149_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"collection1_shard1_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:38983/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 111250 INFO (OverseerStateUpdate-98893721812992009-127.0.0.1:45149_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"collection1_shard1_replica_n4", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:34377/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 111251 INFO (OverseerStateUpdate-98893721812992009-127.0.0.1:45149_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"collection1_shard1_replica_n6", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:45149/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 111481 INFO (qtp44478268-1053) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n4&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 111482 INFO (qtp44478268-1053) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 111490 INFO (qtp668885517-1074) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 111490 INFO (qtp668885517-1074) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 111498 INFO (qtp1252266337-1067) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n2&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 111498 INFO (qtp1252266337-1067) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 111503 INFO (qtp1195435593-1080) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n6&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 111503 INFO (qtp1195435593-1080) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 111607 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 111607 INFO (zkCallback-156-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 111607 INFO (zkCallback-148-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 111608 INFO (zkCallback-149-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 111608 INFO (zkCallback-148-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 111608 INFO (zkCallback-151-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 111614 INFO (zkCallback-156-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 111614 INFO (zkCallback-149-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 112502 INFO (qtp44478268-1053) [ ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 [junit4] 2> 112503 INFO (qtp44478268-1053) [ ] o.a.s.c.RequestParams request params refreshed to version 0 [junit4] 2> 112504 WARN (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../contrib/extraction/lib [junit4] 2> 112507 INFO (qtp668885517-1074) [ ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 [junit4] 2> 112507 INFO (qtp668885517-1074) [ ] o.a.s.c.RequestParams request params refreshed to version 0 [junit4] 2> 112507 WARN (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../contrib/extraction/lib [junit4] 2> 112520 WARN (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../dist [junit4] 2> 112520 WARN (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../contrib/clustering/lib [junit4] 2> 112520 WARN (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../dist [junit4] 2> 112529 INFO (qtp1252266337-1067) [ ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 [junit4] 2> 112529 INFO (qtp1252266337-1067) [ ] o.a.s.c.RequestParams request params refreshed to version 0 [junit4] 2> 112529 WARN (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../contrib/extraction/lib [junit4] 2> 112518 WARN (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../dist [junit4] 2> 112530 WARN (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../dist [junit4] 2> 112530 WARN (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../contrib/clustering/lib [junit4] 2> 112530 WARN (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../contrib/clustering/lib [junit4] 2> 112530 WARN (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../dist [junit4] 2> 112530 WARN (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../dist [junit4] 2> 112530 WARN (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../contrib/langid/lib [junit4] 2> 112530 WARN (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../contrib/langid/lib [junit4] 2> 112530 WARN (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../dist [junit4] 2> 112530 WARN (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../dist [junit4] 2> 112530 WARN (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../contrib/velocity/lib [junit4] 2> 112530 WARN (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../contrib/velocity/lib [junit4] 2> 112531 WARN (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4/../../../../dist [junit4] 2> 112531 WARN (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2/../../../../dist [junit4] 2> 112531 WARN (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../contrib/langid/lib [junit4] 2> 112531 WARN (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../dist [junit4] 2> 112531 WARN (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../contrib/velocity/lib [junit4] 2> 112532 WARN (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1/../../../../dist [junit4] 2> 112537 INFO (qtp668885517-1074) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 112538 INFO (qtp1195435593-1080) [ ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 [junit4] 2> 112538 INFO (qtp1252266337-1067) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 112538 INFO (qtp1195435593-1080) [ ] o.a.s.c.RequestParams request params refreshed to version 0 [junit4] 2> 112539 WARN (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../contrib/extraction/lib [junit4] 2> 112539 WARN (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../dist [junit4] 2> 112540 WARN (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../contrib/clustering/lib [junit4] 2> 112540 WARN (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../dist [junit4] 2> 112540 WARN (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../contrib/langid/lib [junit4] 2> 112540 WARN (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../dist [junit4] 2> 112540 WARN (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../contrib/velocity/lib [junit4] 2> 112542 WARN (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6/../../../../dist [junit4] 2> 112546 INFO (qtp44478268-1053) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 112554 INFO (qtp1195435593-1080) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 112579 INFO (qtp668885517-1074) [ ] o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=default-config [junit4] 2> 112586 INFO (qtp44478268-1053) [ ] o.a.s.s.IndexSchema [collection1_shard1_replica_n4] Schema name=default-config [junit4] 2> 112601 INFO (qtp1252266337-1067) [ ] o.a.s.s.IndexSchema [collection1_shard1_replica_n2] Schema name=default-config [junit4] 2> 112627 INFO (qtp1195435593-1080) [ ] o.a.s.s.IndexSchema [collection1_shard1_replica_n6] Schema name=default-config [junit4] 2> 112847 INFO (qtp44478268-1053) [ ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id [junit4] 2> 112847 INFO (qtp1195435593-1080) [ ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id [junit4] 2> 112847 INFO (qtp1252266337-1067) [ ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id [junit4] 2> 112852 INFO (qtp668885517-1074) [ ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id [junit4] 2> 112877 INFO (qtp1195435593-1080) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n6' using configuration from collection collection1, trusted=true [junit4] 2> 112878 INFO (qtp1195435593-1080) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45149.solr.core.collection1.shard1.replica_n6' (registry 'solr.core.collection1.shard1.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 112878 INFO (qtp1195435593-1080) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 112878 INFO (qtp1195435593-1080) [ ] o.a.s.c.SolrCore [[collection1_shard1_replica_n6] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/collection1_shard1_replica_n6], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node4/./collection1_shard1_replica_n6/data/] [junit4] 2> 112895 INFO (qtp668885517-1074) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from collection collection1, trusted=true [junit4] 2> 112896 INFO (qtp668885517-1074) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32877.solr.core.collection1.shard1.replica_n1' (registry 'solr.core.collection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 112896 INFO (qtp668885517-1074) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 112896 INFO (qtp668885517-1074) [ ] o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/collection1_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node3/./collection1_shard1_replica_n1/data/] [junit4] 2> 112897 INFO (qtp1252266337-1067) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n2' using configuration from collection collection1, trusted=true [junit4] 2> 112897 INFO (qtp1252266337-1067) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38983.solr.core.collection1.shard1.replica_n2' (registry 'solr.core.collection1.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 112897 INFO (qtp1252266337-1067) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 112898 INFO (qtp1252266337-1067) [ ] o.a.s.c.SolrCore [[collection1_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/collection1_shard1_replica_n2], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node2/./collection1_shard1_replica_n2/data/] [junit4] 2> 112901 INFO (qtp44478268-1053) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n4' using configuration from collection collection1, trusted=true [junit4] 2> 112902 INFO (qtp44478268-1053) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34377.solr.core.collection1.shard1.replica_n4' (registry 'solr.core.collection1.shard1.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@31415b6e [junit4] 2> 112902 INFO (qtp44478268-1053) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 112902 INFO (qtp44478268-1053) [ ] o.a.s.c.SolrCore [[collection1_shard1_replica_n4] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/collection1_shard1_replica_n4], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.AssignBackwardCompatibilityTest_7937B8D583010A79-001/tempDir-001/node1/./collection1_shard1_replica_n4/data/] [junit4] 2> 112907 INFO (qtp1195435593-1080) [ ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5 [junit4] 2> 112907 INFO (qtp1252266337-1067) [ ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5 [junit4] 2> 112922 INFO (qtp44478268-1053) [ ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5 [junit4] 2> 112917 INFO (qtp668885517-1074) [ ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5 [junit4] 2> 113021 INFO (qtp1195435593-1080) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 113021 INFO (qtp1195435593-1080) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 113024 INFO (qtp1195435593-1080) [ ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; [junit4] 2> 113025 INFO (qtp1195435593-1080) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 113029 INFO (qtp1252266337-1067) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 113029 INFO (qtp1252266337-1067) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 113029 INFO (qtp1195435593-1080) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ec4bdbb[collection1_shard1_replica_n6] main] [junit4] 2> 113030 INFO (qtp1252266337-1067) [ ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; [junit4] 2> 113031 INFO (qtp1252266337-1067) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 113031 INFO (qtp1195435593-1080) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/collection1 [junit4] 2> 113032 INFO (qtp1195435593-1080) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/collection1 [junit4] 2> 113032 INFO (qtp1195435593-1080) [ ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/collection1/managed-schema [junit4] 2> 113032 INFO (qtp1195435593-1080) [ ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest [junit4] 2> 113033 INFO (qtp1195435593-1080) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 113033 INFO (qtp1252266337-1067) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@99398d8[collection1_shard1_replica_n2] main] [junit4] 2> 113034 INFO (qtp1252266337-1067) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/collection1 [junit4] 2> 113034 INFO (qtp1252266337-1067) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/collection1 [junit4] 2> 113034 INFO (qtp1252266337-1067) [ ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/collection1/managed-schema [junit4] 2> 113035 INFO (qtp1252266337-1067) [ ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest [junit4] 2> 113035 INFO (qtp1252266337-1067) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 113035 INFO (qtp1195435593-1080) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01} [junit4] 2> 113035 INFO (qtp1252266337-1067) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01} [junit4] 2> 113040 INFO (qtp1195435593-1080) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 113042 INFO (qtp1252266337-1067) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 113045 INFO (qtp1252266337-1067) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1582299551578980352 [junit4] 2> 113045 INFO (qtp668885517-1074) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 113045 INFO (qtp668885517-1074) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 113046 INFO (searcherExecutor-507-thread-1) [ ] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@99398d8[collection1_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 113046 INFO (searcherExecutor-507-thread-1) [ ] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 113046 INFO (searcherExecutor-507-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 113047 INFO (searcherExecutor-505-thread-1) [ ] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@1ec4bdbb[collection1_shard1_replica_n6] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 113048 INFO (searcherExecutor-505-thread-1) [ ] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 113048 INFO (searcherExecutor-505-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 113049 INFO (qtp668885517-1074) [ ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; [junit4] 2> 113049 INFO (qtp668885517-1074) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 113049 INFO (searcherExecutor-505-thread-1) [ ] o.a.s.c.SolrCore [collection1_shard1_replica_n6] Registered new searcher Searcher@1ec4bdbb[collection1_shard1_replica_n6] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 113049 INFO (searcherExecutor-507-thread-1) [ ] o.a.s.c.SolrCore [collection1_shard1_replica_n2] Registered new searcher Searcher@99398d8[collection1_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 113049 INFO (qtp1195435593-1080) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1582299551583174656 [junit4] 2> 113051 INFO (qtp668885517-1074) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6fee393b[collection1_shard1_replica_n1] main] [junit4] 2> 113053 INFO (qtp668885517-1074) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/collection1 [junit4] 2> 113054 INFO (qtp668885517-1074) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/collection1 [junit4] 2> 113054 INFO (qtp668885517-1074) [ ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/collection1/managed-schema [junit4] 2> 113055 INFO (qtp668885517-1074) [ ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest [junit4] 2> 113055 INFO (qtp1252266337-1067) [ ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=4 found=2 timeoutin=9999ms [junit4] 2> 113056 INFO (qtp668885517-1074) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 113063 INFO (qtp668885517-1074) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01} [junit4] 2> 113068 INFO (qtp668885517-1074) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 113070 INFO (searcherExecutor-506-thread-1) [ ] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@6fee393b[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 113070 INFO (searcherExecutor-506-thread-1) [ ] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 113070 INFO (searcherExecutor-506-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 113070 INFO (qtp668885517-1074) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1582299551605194752 [junit4] 2> 113070 INFO (qtp44478268-1053) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 113070 INFO (qtp44478268-1053) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 113071 INFO (searcherExecutor-506-thread-1) [ ] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@6fee393b[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 113072 INFO (qtp44478268-1053) [ ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; [junit4] 2> 113072 INFO (qtp44478268-1053) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 113078 INFO (qtp44478268-1053) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4944b8de[collection1_shard1_replica_n4] main] [junit4] 2> 113079 INFO (qtp44478268-1053) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/collection1 [junit4] 2> 113079 INFO (qtp44478268-1053) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/collection1 [junit4] 2> 113079 INFO (qtp44478268-1053) [ ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/collection1/managed-schema [junit4] 2> 113080 INFO (qtp44478268-1053) [ ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest [junit4] 2> 113080 INFO (qtp44478268-1053) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 113080 INFO (qtp44478268-1053) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01} [junit4] 2> 113082 INFO (qtp44478268-1053) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 113082 INFO (searcherExecutor-508-thread-1) [ ] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@4944b8de[collection1_shard1_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 113082 INFO (searcherExecutor-508-thread-1) [ ] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 113082 INFO (searcherExecutor-508-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 113083 INFO (qtp44478268-1053) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1582299551618826240 [junit4] 2> 113084 INFO (searcherExecutor-508-thread-1) [ ] o.a.s.c.SolrCore [collection1_shard1_replica_n4] Registered new searcher Searcher@4944b8de[collection1_shard1_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 113158 INFO (zkCallback-156-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113158 INFO (zkCallback-148-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113158 INFO (zkCallback-156-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113158 INFO (zkCallback-151-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113158 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113158 INFO (zkCallback-149-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113158 INFO (zkCallback-148-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113158 INFO (zkCallback-149-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113557 INFO (qtp1252266337-1067) [ ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 113557 INFO (qtp1252266337-1067) [ ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 113557 INFO (qtp1252266337-1067) [ ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:38983/solr/collection1_shard1_replica_n2/ [junit4] 2> 113558 INFO (qtp1252266337-1067) [ ] o.a.s.u.PeerSync PeerSync: core=collection1_shard1_replica_n2 url=https://127.0.0.1:38983/solr START replicas=[https://127.0.0.1:32877/solr/collection1_shard1_replica_n1/, https://127.0.0.1:34377/solr/collection1_shard1_replica_n4/, https://127.0.0.1:45149/solr/collection1_shard1_replica_n6/] nUpdates=100 [junit4] 2> 113596 INFO (qtp668885517-1073) [ ] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 113601 INFO (qtp44478268-1179) [ ] o.a.s.c.S.Request [collection1_shard1_replica_n4] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 113610 INFO (qtp1195435593-1079) [ ] o.a.s.c.S.Request [collection1_shard1_replica_n6] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 113865 INFO (qtp1252266337-1067) [ ] o.a.s.u.PeerSync PeerSync: core=collection1_shard1_replica_n2 url=https://127.0.0.1:38983/solr DONE. We have no versions. sync failed. [junit4] 2> 113865 INFO (qtp1252266337-1067) [ ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate [junit4] 2> 113865 INFO (qtp1252266337-1067) [ ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway [junit4] 2> 113865 INFO (qtp1252266337-1067) [ ] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 113875 INFO (qtp1252266337-1067) [ ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:38983/solr/collection1_shard1_replica_n2/ shard1 [junit4] 2> 113977 INFO (zkCallback-151-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113977 INFO (zkCallback-156-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113977 INFO (zkCallback-148-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113977 INFO (zkCallback-148-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113977 INFO (zkCallback-156-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113977 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113977 INFO (zkCallback-149-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 113977 INFO (zkCallback-149-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 114026 INFO (qtp1252266337-1067) [ ] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 114027 INFO (qtp1252266337-1067) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n2&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2528 [junit4] 2> 114056 INFO (qtp1195435593-1080) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n6&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2553 [junit4] 2> 114077 INFO (qtp668885517-1074) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2587 [junit4] 2> 114087 INFO (qtp44478268-1053) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n4&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2606 [junit4] 2> 114091 INFO (qtp44478268-1046) [ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas [junit4] 2> 114190 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 114190 INFO (zkCallback-149-thread- [...truncated too long message...] ceConsume(ExecuteProduceConsume.java:148) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> Caused by: org.apache.solr.common.SolrException: No registered leader was found after waiting for 1220000ms , collection: .system slice: shard1 saw state=null with live_nodes=[] [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:816) [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.getLeaderUrl(ZkStateReader.java:781) [junit4] 2> at org.apache.solr.cloud.ZkController.getLeader(ZkController.java:1178) [junit4] 2> ... 44 more [junit4] 2> [junit4] 2> 1446371 INFO (qtp28249736-12158) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=603059 [junit4] 2> 1448540 WARN (zkCallback-1165-thread-4) [ ] o.a.s.c.SyncStrategy Closed, skipping sync up. [junit4] 2> 1448540 INFO (zkCallback-1165-thread-4) [ ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway [junit4] 2> 1448540 INFO (zkCallback-1165-thread-4) [ ] o.a.s.c.SolrCore [collection1_shard1_replica_n27] CLOSING SolrCore org.apache.solr.core.SolrCore@1bd604da [junit4] 2> 1448540 INFO (zkCallback-1165-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard1.replica_n27, tag=467010778 [junit4] 2> 1448541 INFO (zkCallback-1165-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2ad915c1: rootName = null, domain = solr.core.collection1.shard1.replica_n27, service url = null, agent id = null] for registry solr.core.collection1.shard1.replica_n27 / com.codahale.metrics.MetricRegistry@517c4a8e [junit4] 2> 1448557 INFO (zkCallback-1165-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard1.leader, tag=467010778 [junit4] 2> 1448559 INFO (TEST-TestCryptoKeys.test-seed#[7937B8D583010A79]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5b57cd56{SSL,[ssl, http/1.1]}{127.0.0.1:༠} [junit4] 2> 1448559 INFO (TEST-TestCryptoKeys.test-seed#[7937B8D583010A79]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@724325b6{/,null,UNAVAILABLE} [junit4] 2> 1448559 ERROR (TEST-TestCryptoKeys.test-seed#[7937B8D583010A79]) [ ] 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> 1448560 INFO (TEST-TestCryptoKeys.test-seed#[7937B8D583010A79]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39135 39135 [junit4] 2> 1453591 INFO (Thread-6791) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39135 39135 [junit4] 2> 1453592 WARN (Thread-6791) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 8 /solr/aliases.json [junit4] 2> 5 /solr/security.json [junit4] 2> 5 /solr/configs/conf1 [junit4] 2> 4 /solr/collections/collection1/state.json [junit4] 2> 2 /solr/configs/.system [junit4] 2> 2 /solr/configs/.system/managed-schema [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 8 /solr/clusterprops.json [junit4] 2> 8 /solr/clusterstate.json [junit4] 2> 5 /solr/autoscaling.json [junit4] 2> 2 /solr/collections/.system/state.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 8 /solr/live_nodes [junit4] 2> 8 /solr/collections [junit4] 2> 5 /solr/overseer/queue-work [junit4] 2> 5 /solr/overseer/collection-queue-work [junit4] 2> 4 /solr/overseer/queue [junit4] 2> 4 /solr/autoscaling/events/.auto_add_replicas [junit4] 2> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestCryptoKeys -Dtests.method=test -Dtests.seed=7937B8D583010A79 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=dz-BT -Dtests.timezone=America/Porto_Acre -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 619s J2 | TestCryptoKeys.test <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:45855: create the collection time out:180s [junit4] > at __randomizedtesting.SeedInfo.seed([7937B8D583010A79:F163870F2DFD6781]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:626) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:253) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:242) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:195) [junit4] > at org.apache.solr.handler.TestBlobHandler.createSystemCollection(TestBlobHandler.java:120) [junit4] > at org.apache.solr.cloud.TestCryptoKeys.test(TestCryptoKeys.java:116) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968) [junit4] > at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestCryptoKeys_7937B8D583010A79-001 [junit4] 2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=9, maxDocsPerChunk=3, blockSize=663), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=9, blockSize=663)), sim=RandomSimilarity(queryNorm=true): {}, locale=dz-BT, timezone=America/Porto_Acre [junit4] 2> NOTE: Linux 4.10.0-33-generic amd64/Oracle Corporation 9 (64-bit)/cpus=8,threads=1,free=89092776,total=518979584 [junit4] 2> NOTE: All tests run in this JVM: [SimplePostToolTest, SuggestComponentContextFilterQueryTest, AlternateDirectoryTest, TestQueryTypes, BigEndianAscendingWordSerializerTest, TestPullReplicaErrorHandling, HdfsWriteToMultipleCollectionsTest, TestCollationFieldDocValues, ReturnFieldsTest, TestNestedDocsSort, NodeLostTriggerTest, DistanceFunctionTest, RankQueryTest, TestConfigsApi, TestConfigSets, CoreSorterTest, TestReqParamsAPI, ConfigSetsAPITest, LeaderElectionContextKeyTest, TestUseDocValuesAsStored2, ZkFailoverTest, TestOnReconnectListenerSupport, TestDownShardTolerantSearch, BadComponentTest, TestCharFilters, TestSolrCoreParser, CdcrVersionReplicationTest, DirectSolrConnectionTest, UpdateLogTest, TestManagedSynonymGraphFilterFactory, UnloadDistributedZkTest, SaslZkACLProviderTest, TestLRUStatsCache, BlockJoinFacetSimpleTest, AtomicUpdateProcessorFactoryTest, ZkNodePropsTest, CursorMarkTest, TestRebalanceLeaders, TlogReplayBufferedWhileIndexingTest, TestZkChroot, TestLRUCache, ZkStateReaderTest, PKIAuthenticationIntegrationTest, TestLegacyFieldReuse, TestCollapseQParserPlugin, DisMaxRequestHandlerTest, TestImpersonationWithHadoopAuth, TestElisionMultitermQuery, XsltUpdateRequestHandlerTest, ChangedSchemaMergeTest, FieldMutatingUpdateProcessorTest, LoggingHandlerTest, TestMultiValuedNumericRangeQuery, TestQuerySenderListener, SimpleCollectionCreateDeleteTest, IndexBasedSpellCheckerTest, TestRawResponseWriter, TestShortCircuitedRequests, HdfsRecoveryZkTest, ChaosMonkeyNothingIsSafeTest, TestHdfsUpdateLog, TestExpandComponent, SuggesterWFSTTest, TestLMDirichletSimilarityFactory, SolrMetricReporterTest, FieldAnalysisRequestHandlerTest, StatsReloadRaceTest, SubstringBytesRefFilterTest, TestLegacyFieldCache, SolrIndexMetricsTest, TestFieldTypeResource, SolrGraphiteReporterTest, TestCloudInspectUtil, TestSearchPerf, TestManagedSchemaAPI, TestSolrCoreProperties, TestSystemIdResolver, CdcrUpdateLogTest, AutoscalingHistoryHandlerTest, PluginInfoTest, TestFieldCollectionResource, TestTolerantSearch, WrapperMergePolicyFactoryTest, TestMinMaxOnMultiValuedField, AliasIntegrationTest, LeaderElectionTest, TestSchemaManager, DocExpirationUpdateProcessorFactoryTest, TestRequestStatusCollectionAPI, HdfsDirectoryFactoryTest, HttpSolrCallGetCoreTest, TestCustomSort, SolrTestCaseJ4Test, UUIDFieldTest, TestRTimerTree, TestSolrXml, TestFunctionQuery, DocValuesNotIndexedTest, TestFieldCacheSortRandom, SortByFunctionTest, TestRecoveryHdfs, TestSQLHandlerNonCloud, TestInitParams, TestCryptoKeys] [junit4] Completed [343/744 (2!)] on J2 in 619.22s, 1 test, 1 error <<< FAILURES! [...truncated 41414 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
