Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2145/
1 tests failed. FAILED: org.apache.solr.cloud.TestSegmentSorting.testSegmentTerminateEarly Error Message: KeeperErrorCode = Session expired for /clusterstate.json Stack Trace: org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /clusterstate.json at __randomizedtesting.SeedInfo.seed([BB4B15E709F42CB:DB1276F3ACCDD6A1]:0) at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) at org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1102) at org.apache.solr.common.cloud.SolrZkClient.lambda$exists$3(SolrZkClient.java:308) at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) at org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:308) at org.apache.solr.common.cloud.ZkStateReader.createClusterStateWatchersAndUpdate(ZkStateReader.java:428) at org.apache.solr.cloud.MiniSolrCloudCluster.deleteAllCollections(MiniSolrCloudCluster.java:442) at org.apache.solr.cloud.TestSegmentSorting.ensureClusterEmpty(TestSegmentSorting.java:63) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992) at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:47) 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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 13591 lines...] [junit4] Suite: org.apache.solr.cloud.TestSegmentSorting [junit4] 2> 5628343 INFO (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-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/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/init-core-data-001 [junit4] 2> 5628376 WARN (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=6 numCloses=6 [junit4] 2> 5628376 INFO (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 5628377 INFO (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 5628378 INFO (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001 [junit4] 2> 5628378 INFO (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 5628421 INFO (Thread-5168) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 5628421 INFO (Thread-5168) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 5628510 ERROR (Thread-5168) [ ] 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> 5628559 INFO (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:43802 [junit4] 2> 5628643 INFO (jetty-launcher-3874-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 5628643 INFO (jetty-launcher-3874-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 5628644 INFO (jetty-launcher-3874-thread-3) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 5628644 INFO (jetty-launcher-3874-thread-4) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 5628678 INFO (jetty-launcher-3874-thread-5) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 5628679 INFO (jetty-launcher-3874-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2edc59d2{/solr,null,AVAILABLE} [junit4] 2> 5628679 INFO (jetty-launcher-3874-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@31bda700{HTTP/1.1,[http/1.1]}{127.0.0.1:37896} [junit4] 2> 5628679 INFO (jetty-launcher-3874-thread-3) [ ] o.e.j.s.Server Started @5641143ms [junit4] 2> 5628679 INFO (jetty-launcher-3874-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37896} [junit4] 2> 5628679 ERROR (jetty-launcher-3874-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 5628679 INFO (jetty-launcher-3874-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 5628679 INFO (jetty-launcher-3874-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 5628679 INFO (jetty-launcher-3874-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 5628680 INFO (jetty-launcher-3874-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-01T23:46:48.831Z [junit4] 2> 5628681 INFO (jetty-launcher-3874-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@457d0d82{/solr,null,AVAILABLE} [junit4] 2> 5628705 INFO (jetty-launcher-3874-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6bddb53a{/solr,null,AVAILABLE} [junit4] 2> 5628706 INFO (jetty-launcher-3874-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5ae3d11d{HTTP/1.1,[http/1.1]}{127.0.0.1:34588} [junit4] 2> 5628706 INFO (jetty-launcher-3874-thread-1) [ ] o.e.j.s.Server Started @5641169ms [junit4] 2> 5628706 INFO (jetty-launcher-3874-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34588} [junit4] 2> 5628706 ERROR (jetty-launcher-3874-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 5628706 INFO (jetty-launcher-3874-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 5628706 INFO (jetty-launcher-3874-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 5628706 INFO (jetty-launcher-3874-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 5628706 INFO (jetty-launcher-3874-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-01T23:46:48.857Z [junit4] 2> 5628787 INFO (jetty-launcher-3874-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2e1e4bcc{/solr,null,AVAILABLE} [junit4] 2> 5628788 INFO (jetty-launcher-3874-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@49c1d310{HTTP/1.1,[http/1.1]}{127.0.0.1:41011} [junit4] 2> 5628788 INFO (jetty-launcher-3874-thread-4) [ ] o.e.j.s.Server Started @5641251ms [junit4] 2> 5628788 INFO (jetty-launcher-3874-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41011} [junit4] 2> 5628788 ERROR (jetty-launcher-3874-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 5628788 INFO (jetty-launcher-3874-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 5628788 INFO (jetty-launcher-3874-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 5628788 INFO (jetty-launcher-3874-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 5628788 INFO (jetty-launcher-3874-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-01T23:46:48.939Z [junit4] 2> 5628805 INFO (jetty-launcher-3874-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 5628856 INFO (jetty-launcher-3874-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2fd75cc6{/solr,null,AVAILABLE} [junit4] 2> 5628857 INFO (jetty-launcher-3874-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4f5eca7f{HTTP/1.1,[http/1.1]}{127.0.0.1:35083} [junit4] 2> 5628857 INFO (jetty-launcher-3874-thread-5) [ ] o.e.j.s.Server Started @5641320ms [junit4] 2> 5628857 INFO (jetty-launcher-3874-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35083} [junit4] 2> 5628857 ERROR (jetty-launcher-3874-thread-5) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 5628857 INFO (jetty-launcher-3874-thread-5) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 5628857 INFO (jetty-launcher-3874-thread-5) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 5628857 INFO (jetty-launcher-3874-thread-5) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 5628857 INFO (jetty-launcher-3874-thread-5) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-01T23:46:49.008Z [junit4] 2> 5628937 INFO (jetty-launcher-3874-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@708a2708{HTTP/1.1,[http/1.1]}{127.0.0.1:33736} [junit4] 2> 5628937 INFO (jetty-launcher-3874-thread-2) [ ] o.e.j.s.Server Started @5641401ms [junit4] 2> 5628937 INFO (jetty-launcher-3874-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33736} [junit4] 2> 5628938 ERROR (jetty-launcher-3874-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 5628938 INFO (jetty-launcher-3874-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 5628938 INFO (jetty-launcher-3874-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 5628938 INFO (jetty-launcher-3874-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 5628938 INFO (jetty-launcher-3874-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-01T23:46:49.089Z [junit4] 2> 5628939 INFO (jetty-launcher-3874-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 5629064 INFO (jetty-launcher-3874-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 5629084 INFO (jetty-launcher-3874-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 5629088 INFO (jetty-launcher-3874-thread-5) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 5629198 INFO (jetty-launcher-3874-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43802/solr [junit4] 2> 5629308 INFO (jetty-launcher-3874-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43802/solr [junit4] 2> 5629344 INFO (jetty-launcher-3874-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43802/solr [junit4] 2> 5629402 INFO (jetty-launcher-3874-thread-5) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43802/solr [junit4] 2> 5629454 INFO (jetty-launcher-3874-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43802/solr [junit4] 2> 5629681 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 0x15f79faeca00009, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 5629768 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 0x15f79faeca0000a, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 5629768 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 0x15f79faeca00008, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 5630048 INFO (jetty-launcher-3874-thread-5) [n:127.0.0.1:35083_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 5630048 INFO (jetty-launcher-3874-thread-3) [n:127.0.0.1:37896_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 5630051 INFO (jetty-launcher-3874-thread-3) [n:127.0.0.1:37896_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37896_solr [junit4] 2> 5630051 INFO (jetty-launcher-3874-thread-5) [n:127.0.0.1:35083_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35083_solr [junit4] 2> 5630084 INFO (jetty-launcher-3874-thread-2) [n:127.0.0.1:33736_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 5630100 INFO (jetty-launcher-3874-thread-3) [n:127.0.0.1:37896_solr ] o.a.s.c.Overseer Overseer (id=98931835444133901-127.0.0.1:37896_solr-n_0000000000) starting [junit4] 2> 5630157 INFO (zkCallback-3900-thread-1-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 5630158 INFO (zkCallback-3901-thread-1-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 5630158 INFO (zkCallback-3902-thread-1-processing-n:127.0.0.1:35083_solr) [n:127.0.0.1:35083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 5630159 INFO (jetty-launcher-3874-thread-1) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 5630159 INFO (jetty-launcher-3874-thread-2) [n:127.0.0.1:33736_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33736_solr [junit4] 2> 5630174 INFO (zkCallback-3902-thread-1-processing-n:127.0.0.1:35083_solr) [n:127.0.0.1:35083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 5630407 INFO (zkCallback-3885-thread-1-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 5630414 INFO (zkCallback-3900-thread-1-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 5630414 INFO (zkCallback-3901-thread-1-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 5630588 INFO (jetty-launcher-3874-thread-1) [n:127.0.0.1:34588_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 5630825 INFO (jetty-launcher-3874-thread-1) [n:127.0.0.1:34588_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34588_solr [junit4] 2> 5630896 INFO (jetty-launcher-3874-thread-4) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 5630909 INFO (jetty-launcher-3874-thread-2) [n:127.0.0.1:33736_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33736.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5630934 INFO (jetty-launcher-3874-thread-4) [n:127.0.0.1:41011_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 5631040 INFO (zkCallback-3899-thread-1-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 5631093 INFO (zkCallback-3902-thread-1-processing-n:127.0.0.1:35083_solr) [n:127.0.0.1:35083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 5631093 INFO (zkCallback-3900-thread-1-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 5631093 INFO (zkCallback-3901-thread-1-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 5631094 INFO (zkCallback-3885-thread-1-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 5631094 INFO (jetty-launcher-3874-thread-4) [n:127.0.0.1:41011_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41011_solr [junit4] 2> 5631095 INFO (zkCallback-3900-thread-1-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 5631095 INFO (zkCallback-3902-thread-1-processing-n:127.0.0.1:35083_solr) [n:127.0.0.1:35083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 5631113 INFO (zkCallback-3901-thread-1-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 5631113 INFO (zkCallback-3885-thread-1-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 5631113 INFO (zkCallback-3899-thread-1-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 5631211 INFO (jetty-launcher-3874-thread-2) [n:127.0.0.1:33736_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33736.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631211 INFO (jetty-launcher-3874-thread-2) [n:127.0.0.1:33736_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33736.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631212 INFO (jetty-launcher-3874-thread-2) [n:127.0.0.1:33736_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node2/. [junit4] 2> 5631223 INFO (jetty-launcher-3874-thread-3) [n:127.0.0.1:37896_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37896_solr [junit4] 2> 5631224 INFO (zkCallback-3902-thread-1-processing-n:127.0.0.1:35083_solr) [n:127.0.0.1:35083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 5631224 INFO (zkCallback-3900-thread-1-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 5631224 INFO (zkCallback-3899-thread-1-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 5631235 INFO (jetty-launcher-3874-thread-5) [n:127.0.0.1:35083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35083.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631348 INFO (jetty-launcher-3874-thread-5) [n:127.0.0.1:35083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35083.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631348 INFO (jetty-launcher-3874-thread-5) [n:127.0.0.1:35083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35083.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631349 INFO (zkCallback-3885-thread-1-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 5631366 INFO (jetty-launcher-3874-thread-5) [n:127.0.0.1:35083_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node5/. [junit4] 2> 5631422 INFO (OverseerStateUpdate-98931835444133901-127.0.0.1:37896_solr-n_0000000000) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 5631624 INFO (jetty-launcher-3874-thread-1) [n:127.0.0.1:34588_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34588.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631676 INFO (jetty-launcher-3874-thread-1) [n:127.0.0.1:34588_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34588.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631676 INFO (jetty-launcher-3874-thread-1) [n:127.0.0.1:34588_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34588.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631678 INFO (jetty-launcher-3874-thread-1) [n:127.0.0.1:34588_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node1/. [junit4] 2> 5631749 INFO (jetty-launcher-3874-thread-3) [n:127.0.0.1:37896_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37896.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631770 INFO (jetty-launcher-3874-thread-4) [n:127.0.0.1:41011_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41011.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631806 INFO (jetty-launcher-3874-thread-4) [n:127.0.0.1:41011_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41011.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631806 INFO (jetty-launcher-3874-thread-4) [n:127.0.0.1:41011_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41011.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631807 INFO (jetty-launcher-3874-thread-4) [n:127.0.0.1:41011_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node4/. [junit4] 2> 5631823 INFO (jetty-launcher-3874-thread-3) [n:127.0.0.1:37896_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37896.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631823 INFO (jetty-launcher-3874-thread-3) [n:127.0.0.1:37896_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37896.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5631878 INFO (jetty-launcher-3874-thread-3) [n:127.0.0.1:37896_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node3/. [junit4] 2> 5633341 INFO (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5) [junit4] 2> 5633342 INFO (SUITE-TestSegmentSorting-seed#[BB4B15E709F42CB]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43802/solr ready [junit4] 2> 5636262 INFO (TEST-TestSegmentSorting.testSegmentTerminateEarly-seed#[BB4B15E709F42CB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSegmentTerminateEarly [junit4] 2> 5636307 INFO (qtp1535893367-21457) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params async=be61b0d5-b680-4f81-bfe4-84d14a17117a&replicationFactor=2&property.config=solrconfig-sortingmergepolicyfactory.xml&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&name=testSegmentTerminateEarly&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 5636326 INFO (qtp1535893367-21457) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=be61b0d5-b680-4f81-bfe4-84d14a17117a&replicationFactor=2&property.config=solrconfig-sortingmergepolicyfactory.xml&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&name=testSegmentTerminateEarly&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=18 [junit4] 2> 5636350 INFO (qtp1535893367-21458) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 5636362 INFO (OverseerThreadFactory-6716-thread-1-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.CreateCollectionCmd Create collection testSegmentTerminateEarly [junit4] 2> 5636496 INFO (qtp1535893367-21458) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=146 [junit4] 2> 5637318 INFO (OverseerStateUpdate-98931835444133901-127.0.0.1:37896_solr-n_0000000000) [n:127.0.0.1:37896_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testSegmentTerminateEarly", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testSegmentTerminateEarly_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:34588/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 5637356 INFO (OverseerStateUpdate-98931835444133901-127.0.0.1:37896_solr-n_0000000000) [n:127.0.0.1:37896_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testSegmentTerminateEarly", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testSegmentTerminateEarly_shard1_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:33736/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 5637358 INFO (OverseerStateUpdate-98931835444133901-127.0.0.1:37896_solr-n_0000000000) [n:127.0.0.1:37896_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testSegmentTerminateEarly", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testSegmentTerminateEarly_shard2_replica_n4", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:37896/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 5637372 INFO (OverseerStateUpdate-98931835444133901-127.0.0.1:37896_solr-n_0000000000) [n:127.0.0.1:37896_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testSegmentTerminateEarly", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testSegmentTerminateEarly_shard2_replica_n6", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:41011/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 5637522 INFO (qtp1535893367-21459) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 5637558 INFO (qtp1535893367-21459) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=35 [junit4] 2> 5637644 INFO (qtp1535893367-21455) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&newCollection=true&collection=testSegmentTerminateEarly&version=2&replicaType=NRT&async=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143&property.config=solrconfig-sortingmergepolicyfactory.xml&coreNodeName=core_node3&name=testSegmentTerminateEarly_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin} status=0 QTime=0 [junit4] 2> 5637644 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&newCollection=true&collection=testSegmentTerminateEarly&version=2&replicaType=NRT&async=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143&property.config=solrconfig-sortingmergepolicyfactory.xml&coreNodeName=core_node3&name=testSegmentTerminateEarly_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin [junit4] 2> 5637644 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 5637790 INFO (qtp687951000-21465) [n:127.0.0.1:37896_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&newCollection=true&collection=testSegmentTerminateEarly&version=2&replicaType=NRT&async=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974&property.config=solrconfig-sortingmergepolicyfactory.xml&coreNodeName=core_node7&name=testSegmentTerminateEarly_shard2_replica_n4&action=CREATE&numShards=2&shard=shard2&wt=javabin} status=0 QTime=0 [junit4] 2> 5637791 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&newCollection=true&collection=testSegmentTerminateEarly&version=2&replicaType=NRT&async=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974&property.config=solrconfig-sortingmergepolicyfactory.xml&coreNodeName=core_node7&name=testSegmentTerminateEarly_shard2_replica_n4&action=CREATE&numShards=2&shard=shard2&wt=javabin [junit4] 2> 5637791 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 5637791 INFO (qtp2051209292-21488) [n:127.0.0.1:41011_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&newCollection=true&collection=testSegmentTerminateEarly&version=2&replicaType=NRT&async=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023&property.config=solrconfig-sortingmergepolicyfactory.xml&coreNodeName=core_node8&name=testSegmentTerminateEarly_shard2_replica_n6&action=CREATE&numShards=2&shard=shard2&wt=javabin} status=0 QTime=1 [junit4] 2> 5637792 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&newCollection=true&collection=testSegmentTerminateEarly&version=2&replicaType=NRT&async=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023&property.config=solrconfig-sortingmergepolicyfactory.xml&coreNodeName=core_node8&name=testSegmentTerminateEarly_shard2_replica_n6&action=CREATE&numShards=2&shard=shard2&wt=javabin [junit4] 2> 5637792 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 5637792 INFO (qtp297229159-21476) [n:127.0.0.1:33736_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&newCollection=true&collection=testSegmentTerminateEarly&version=2&replicaType=NRT&async=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065&property.config=solrconfig-sortingmergepolicyfactory.xml&coreNodeName=core_node5&name=testSegmentTerminateEarly_shard1_replica_n2&action=CREATE&numShards=2&shard=shard1&wt=javabin} status=0 QTime=0 [junit4] 2> 5637793 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=class+org.apache.solr.cloud.TestSegmentSorting_configSet&newCollection=true&collection=testSegmentTerminateEarly&version=2&replicaType=NRT&async=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065&property.config=solrconfig-sortingmergepolicyfactory.xml&coreNodeName=core_node5&name=testSegmentTerminateEarly_shard1_replica_n2&action=CREATE&numShards=2&shard=shard1&wt=javabin [junit4] 2> 5637793 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 5637793 INFO (qtp1535893367-21461) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 [junit4] 2> 5637793 INFO (qtp1535893367-21461) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 5638010 INFO (zkCallback-3899-thread-1-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5638010 INFO (zkCallback-3901-thread-1-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5638017 INFO (zkCallback-3900-thread-1-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5638018 INFO (zkCallback-3885-thread-1-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5638029 INFO (zkCallback-3900-thread-2-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5638042 INFO (zkCallback-3885-thread-2-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5638046 INFO (zkCallback-3901-thread-2-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5638070 INFO (zkCallback-3899-thread-2-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5638591 INFO (qtp1535893367-21460) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 5638595 INFO (qtp1535893367-21460) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=20 [junit4] 2> 5638771 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 5638939 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 [junit4] 2> 5638939 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 5638939 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.s.IndexSchema [testSegmentTerminateEarly_shard1_replica_n1] Schema name=test [junit4] 2> 5638982 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 5639225 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.s.IndexSchema [testSegmentTerminateEarly_shard2_replica_n6] Schema name=test [junit4] 2> 5639555 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 5639624 INFO (qtp1535893367-21457) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 5639625 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 5639939 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 [junit4] 2> 5639940 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 5639942 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.s.IndexSchema [testSegmentTerminateEarly_shard2_replica_n4] Schema name=test [junit4] 2> 5639953 INFO (qtp1535893367-21457) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=329 [junit4] 2> 5640017 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.s.IndexSchema [testSegmentTerminateEarly_shard1_replica_n2] Schema name=test [junit4] 2> 5640907 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 5640941 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 [junit4] 2> 5640941 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 5640956 INFO (qtp1535893367-21459) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 5640957 INFO (qtp1535893367-21459) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 5640959 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.c.CoreContainer Creating SolrCore 'testSegmentTerminateEarly_shard2_replica_n6' using configuration from collection testSegmentTerminateEarly, trusted=true [junit4] 2> 5640960 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41011.solr.core.testSegmentTerminateEarly.shard2.replica_n6' (registry 'solr.core.testSegmentTerminateEarly.shard2.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5640960 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 5640960 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.c.SolrCore [[testSegmentTerminateEarly_shard2_replica_n6] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node4/testSegmentTerminateEarly_shard2_replica_n6], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node4/./testSegmentTerminateEarly_shard2_replica_n6/data/] [junit4] 2> 5640974 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.ForceMergePolicy: ForceMergePolicy([LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6754180152912086]) [junit4] 2> 5641235 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 5641780 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testSegmentTerminateEarly_shard1_replica_n1' using configuration from collection testSegmentTerminateEarly, trusted=true [junit4] 2> 5641800 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34588.solr.core.testSegmentTerminateEarly.shard1.replica_n1' (registry 'solr.core.testSegmentTerminateEarly.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5641800 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 5641800 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.c.SolrCore [[testSegmentTerminateEarly_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node1/testSegmentTerminateEarly_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node1/./testSegmentTerminateEarly_shard1_replica_n1/data/] [junit4] 2> 5641820 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 5641826 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 5641827 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 5641827 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 5641828 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 5641829 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.ForceMergePolicy: ForceMergePolicy([TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=84.2705078125, floorSegmentMB=1.3984375, forceMergeDeletesPctAllowed=3.8205300798560216, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48571855381479734) [junit4] 2> 5641829 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.s.SolrIndexSearcher Opening [Searcher@5cda2e5c[testSegmentTerminateEarly_shard2_replica_n6] main] [junit4] 2> 5641843 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/class org.apache.solr.cloud.TestSegmentSorting_configSet [junit4] 2> 5641843 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/class org.apache.solr.cloud.TestSegmentSorting_configSet [junit4] 2> 5641844 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 5641844 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1582909381143429120 [junit4] 2> 5641846 INFO (searcherExecutor-6725-thread-1-processing-x:testSegmentTerminateEarly_shard2_replica_n6 r:core_node8 be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE n:127.0.0.1:41011_solr s:shard2 c:testSegmentTerminateEarly) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.c.SolrCore [testSegmentTerminateEarly_shard2_replica_n6] Registered new searcher Searcher@5cda2e5c[testSegmentTerminateEarly_shard2_replica_n6] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 5641949 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 [junit4] 2> 5641949 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 5641953 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.ForceMergePolicy: ForceMergePolicy([LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6754180152912086]) [junit4] 2> 5641965 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'testSegmentTerminateEarly_shard1_replica_n2' using configuration from collection testSegmentTerminateEarly, trusted=true [junit4] 2> 5641973 INFO (qtp1535893367-21460) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 5641985 INFO (qtp1535893367-21460) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=12 [junit4] 2> 5642017 INFO (parallelCoreAdminExecutor-6721-thread-1-processing-n:127.0.0.1:41011_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326800927023 CREATE) [n:127.0.0.1:41011_solr c:testSegmentTerminateEarly s:shard2 r:core_node8 x:testSegmentTerminateEarly_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms [junit4] 2> 5642019 INFO (zkCallback-3899-thread-2-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642019 INFO (zkCallback-3899-thread-1-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642019 INFO (zkCallback-3901-thread-2-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642019 INFO (zkCallback-3901-thread-1-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642021 INFO (zkCallback-3900-thread-2-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642021 INFO (zkCallback-3900-thread-1-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642034 INFO (zkCallback-3885-thread-2-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642034 INFO (zkCallback-3885-thread-1-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642076 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33736.solr.core.testSegmentTerminateEarly.shard1.replica_n2' (registry 'solr.core.testSegmentTerminateEarly.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5642076 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 5642076 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.c.SolrCore [[testSegmentTerminateEarly_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node2/testSegmentTerminateEarly_shard1_replica_n2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node2/./testSegmentTerminateEarly_shard1_replica_n2/data/] [junit4] 2> 5642078 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.ForceMergePolicy: ForceMergePolicy([LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6754180152912086]) [junit4] 2> 5642143 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 5642203 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.c.CoreContainer Creating SolrCore 'testSegmentTerminateEarly_shard2_replica_n4' using configuration from collection testSegmentTerminateEarly, trusted=true [junit4] 2> 5642204 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37896.solr.core.testSegmentTerminateEarly.shard2.replica_n4' (registry 'solr.core.testSegmentTerminateEarly.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7255456f [junit4] 2> 5642204 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 5642216 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.c.SolrCore [[testSegmentTerminateEarly_shard2_replica_n4] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node3/testSegmentTerminateEarly_shard2_replica_n4], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestSegmentSorting_BB4B15E709F42CB-001/tempDir-001/node3/./testSegmentTerminateEarly_shard2_replica_n4/data/] [junit4] 2> 5642218 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.ForceMergePolicy: ForceMergePolicy([LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6754180152912086]) [junit4] 2> 5642472 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 5642473 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 5642473 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 5642474 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 5642474 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.ForceMergePolicy: ForceMergePolicy([TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=84.2705078125, floorSegmentMB=1.3984375, forceMergeDeletesPctAllowed=3.8205300798560216, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48571855381479734) [junit4] 2> 5642475 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@420ad416[testSegmentTerminateEarly_shard1_replica_n1] main] [junit4] 2> 5642475 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/class org.apache.solr.cloud.TestSegmentSorting_configSet [junit4] 2> 5642476 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/class org.apache.solr.cloud.TestSegmentSorting_configSet [junit4] 2> 5642509 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 5642526 INFO (searcherExecutor-6727-thread-1-processing-x:testSegmentTerminateEarly_shard1_replica_n1 r:core_node3 be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE n:127.0.0.1:34588_solr s:shard1 c:testSegmentTerminateEarly) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.c.SolrCore [testSegmentTerminateEarly_shard1_replica_n1] Registered new searcher Searcher@420ad416[testSegmentTerminateEarly_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 5642526 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1582909381858557952 [junit4] 2> 5642548 INFO (parallelCoreAdminExecutor-6719-thread-1-processing-n:127.0.0.1:34588_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 CREATE) [n:127.0.0.1:34588_solr c:testSegmentTerminateEarly s:shard1 r:core_node3 x:testSegmentTerminateEarly_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoutin=9999ms [junit4] 2> 5642550 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 5642550 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 5642551 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 5642551 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 5642552 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.ForceMergePolicy: ForceMergePolicy([TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=84.2705078125, floorSegmentMB=1.3984375, forceMergeDeletesPctAllowed=3.8205300798560216, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48571855381479734) [junit4] 2> 5642552 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@69f47f5a[testSegmentTerminateEarly_shard1_replica_n2] main] [junit4] 2> 5642553 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/class org.apache.solr.cloud.TestSegmentSorting_configSet [junit4] 2> 5642553 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/class org.apache.solr.cloud.TestSegmentSorting_configSet [junit4] 2> 5642553 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 5642553 INFO (parallelCoreAdminExecutor-6712-thread-1-processing-n:127.0.0.1:33736_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1582909381886869504 [junit4] 2> 5642599 INFO (searcherExecutor-6731-thread-1-processing-x:testSegmentTerminateEarly_shard1_replica_n2 r:core_node5 be61b0d5-b680-4f81-bfe4-84d14a17117a9689326785683065 CREATE n:127.0.0.1:33736_solr s:shard1 c:testSegmentTerminateEarly) [n:127.0.0.1:33736_solr c:testSegmentTerminateEarly s:shard1 r:core_node5 x:testSegmentTerminateEarly_shard1_replica_n2] o.a.s.c.SolrCore [testSegmentTerminateEarly_shard1_replica_n2] Registered new searcher Searcher@69f47f5a[testSegmentTerminateEarly_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 5642656 INFO (zkCallback-3885-thread-1-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642656 INFO (zkCallback-3885-thread-2-processing-n:127.0.0.1:34588_solr) [n:127.0.0.1:34588_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642656 INFO (zkCallback-3899-thread-2-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642656 INFO (zkCallback-3899-thread-1-processing-n:127.0.0.1:41011_solr) [n:127.0.0.1:41011_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642657 INFO (zkCallback-3901-thread-1-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642657 INFO (zkCallback-3901-thread-2-processing-n:127.0.0.1:37896_solr) [n:127.0.0.1:37896_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642659 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 5642659 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 5642660 INFO (zkCallback-3900-thread-2-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642660 INFO (zkCallback-3900-thread-1-processing-n:127.0.0.1:33736_solr) [n:127.0.0.1:33736_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSegmentTerminateEarly/state.json] for collection [testSegmentTerminateEarly] has occurred - updating... (live nodes size: [5]) [junit4] 2> 5642692 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 5642692 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 5642693 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.ForceMergePolicy: ForceMergePolicy([TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=84.2705078125, floorSegmentMB=1.3984375, forceMergeDeletesPctAllowed=3.8205300798560216, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48571855381479734) [junit4] 2> 5642694 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening [Searcher@78a7d35e[testSegmentTerminateEarly_shard2_replica_n4] main] [junit4] 2> 5642694 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/class org.apache.solr.cloud.TestSegmentSorting_configSet [junit4] 2> 5642695 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/class org.apache.solr.cloud.TestSegmentSorting_configSet [junit4] 2> 5642695 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 5642696 INFO (searcherExecutor-6732-thread-1-processing-x:testSegmentTerminateEarly_shard2_replica_n4 r:core_node7 be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE n:127.0.0.1:37896_solr s:shard2 c:testSegmentTerminateEarly) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.c.SolrCore [testSegmentTerminateEarly_shard2_replica_n4] Registered new searcher Searcher@78a7d35e[testSegmentTerminateEarly_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 5642696 INFO (parallelCoreAdminExecutor-6720-thread-1-processing-n:127.0.0.1:37896_solr be61b0d5-b680-4f81-bfe4-84d14a17117a9689326787189974 CREATE) [n:127.0.0.1:37896_solr c:testSegmentTerminateEarly s:shard2 r:core_node7 x:testSegmentTerminateEarly_shard2_replica_n4] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1582909382036815872 [junit4] 2> 5642953 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143 [junit4] 2> 5642953 INFO (qtp1535893367-21454) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a9689326694910143&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 5642989 INFO (qtp1535893367-21455) [n:127.0.0.1:34588_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 5643002 INFO (qtp1535893367-21455) [n:127.0.0.1:34588_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=be61b0d5-b680-4f81-bfe4-84d14a17117a&action=REQUESTSTATUS&wt=javabin&version=2} [...truncated too long message...] domSet' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 10. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/response/SmileResponseWriter.java (at line 33) [ecj-lint] new SmileWriter(out, request, response).writeResponse(); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 11. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/schema/OpenExchangeRatesOrgProvider.java (at line 146) [ecj-lint] ratesJsonStream = resourceLoader.openResource(ratesFileLocation); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: 'ratesJsonStream' is not closed at this location [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 12. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/search/CollapsingQParserPlugin.java (at line 1315) [ecj-lint] UninvertingReader uninvertingReader = new UninvertingReader(new ReaderWrapper(searcher.getSlowAtomicReader(), collapseField), mapping); [ecj-lint] ^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: 'uninvertingReader' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 13. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/search/DocSlice.java (at line 145) [ecj-lint] HashDocSet h = new HashDocSet(docs,offset,len); [ecj-lint] ^ [ecj-lint] Resource leak: 'h' is never closed [ecj-lint] ---------- [ecj-lint] 14. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/search/DocSlice.java (at line 154) [ecj-lint] HashDocSet h = new HashDocSet(docs,offset,len); [ecj-lint] ^ [ecj-lint] Resource leak: 'h' is never closed [ecj-lint] ---------- [ecj-lint] 15. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/search/DocSlice.java (at line 163) [ecj-lint] HashDocSet h = new HashDocSet(docs,offset,len); [ecj-lint] ^ [ecj-lint] Resource leak: 'h' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 16. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/search/function/OrdFieldSource.java (at line 79) [ecj-lint] SolrIndexSearcher is = (SolrIndexSearcher) o; [ecj-lint] ^^ [ecj-lint] Resource leak: 'is' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 17. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/search/function/ReverseOrdFieldSource.java (at line 79) [ecj-lint] SolrIndexSearcher is = (SolrIndexSearcher) o; [ecj-lint] ^^ [ecj-lint] Resource leak: 'is' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 18. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/servlet/SolrDispatchFilter.java (at line 291) [ecj-lint] throw new SolrException(ErrorCode.SERVER_ERROR, "Error occurred while loading solr.xml from zookeeper", e); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: 'loader' is not closed at this location [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 19. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/CdcrTransactionLog.java (at line 98) [ecj-lint] ChannelFastInputStream is = new ChannelFastInputStream(channel, pos); [ecj-lint] ^^ [ecj-lint] Resource leak: 'is' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 20. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/HdfsTransactionLog.java (at line 191) [ecj-lint] LogCodec codec = new LogCodec(resolver); [ecj-lint] ^^^^^ [ecj-lint] Resource leak: 'codec' is never closed [ecj-lint] ---------- [ecj-lint] 21. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/HdfsTransactionLog.java (at line 261) [ecj-lint] LogCodec codec = new LogCodec(resolver); [ecj-lint] ^^^^^ [ecj-lint] Resource leak: 'codec' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 22. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/TransactionLog.java (at line 228) [ecj-lint] ChannelFastInputStream is = new ChannelFastInputStream(channel, pos); [ecj-lint] ^^ [ecj-lint] Resource leak: 'is' is never closed [ecj-lint] ---------- [ecj-lint] 23. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/TransactionLog.java (at line 228) [ecj-lint] ChannelFastInputStream is = new ChannelFastInputStream(channel, pos); [ecj-lint] ^^ [ecj-lint] Resource leak: 'is' is never closed [ecj-lint] ---------- [ecj-lint] 24. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/TransactionLog.java (at line 260) [ecj-lint] LogCodec codec = new LogCodec(resolver); [ecj-lint] ^^^^^ [ecj-lint] Resource leak: 'codec' is never closed [ecj-lint] ---------- [ecj-lint] 25. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/TransactionLog.java (at line 275) [ecj-lint] LogCodec codec = new LogCodec(resolver); [ecj-lint] ^^^^^ [ecj-lint] Resource leak: 'codec' is never closed [ecj-lint] ---------- [ecj-lint] 26. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/TransactionLog.java (at line 529) [ecj-lint] LogCodec codec = new LogCodec(resolver); [ecj-lint] ^^^^^ [ecj-lint] Resource leak: 'codec' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 27. ERROR in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/processor/DistributedUpdateProcessor.java (at line 372) [ecj-lint] /** For {@link CollectionParams.CollectionAction#SPLITSHARD} */ [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Javadoc: Invalid member type qualification [ecj-lint] ---------- [ecj-lint] 28. ERROR in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/processor/DistributedUpdateProcessor.java (at line 381) [ecj-lint] /** For {@link CollectionParams.CollectionAction#SPLITSHARD} */ [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Javadoc: Invalid member type qualification [ecj-lint] ---------- [ecj-lint] 29. ERROR in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/processor/DistributedUpdateProcessor.java (at line 406) [ecj-lint] /** For {@link CollectionParams.CollectionAction#SPLITSHARD} */ [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Javadoc: Invalid member type qualification [ecj-lint] ---------- [ecj-lint] 30. ERROR in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/update/processor/DistributedUpdateProcessor.java (at line 432) [ecj-lint] /** For {@link CollectionParams.CollectionAction#MIGRATE} */ [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Javadoc: Invalid member type qualification [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 31. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/util/SimplePostTool.java (at line 655) [ecj-lint] BAOS bos = new BAOS(); [ecj-lint] ^^^ [ecj-lint] Resource leak: 'bos' is never closed [ecj-lint] ---------- [ecj-lint] 32. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/util/SimplePostTool.java (at line 655) [ecj-lint] BAOS bos = new BAOS(); [ecj-lint] ^^^ [ecj-lint] Resource leak: 'bos' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 33. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/java/org/apache/solr/util/SolrLogLayout.java (at line 149) [ecj-lint] SolrQueryRequest req = requestInfo == null ? null : requestInfo.getReq(); [ecj-lint] ^^^ [ecj-lint] Resource leak: 'req' is never closed [ecj-lint] ---------- [ecj-lint] 33 problems (4 errors, 29 warnings) BUILD FAILED /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:826: The following error occurred while executing this line: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:101: The following error occurred while executing this line: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:684: The following error occurred while executing this line: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2087: The following error occurred while executing this line: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2126: Compile failed; see the compiler error output for details. Total time: 278 minutes 47 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org