[JENKINS-EA] Lucene-Solr-7.x-Linux (64bit/jdk-13-ea+8) - Build # 3573 - Failure!

Policeman Jenkins Server Fri, 22 Feb 2019 18:45:07 -0800

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/3573/
Java: 64bit/jdk-13-ea+8 -XX:+UseCompressedOops -XX:+UseSerialGC


3 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.OverseerTest

Error Message:
SOLR-11606: ByteBuddy used by Mockito is not working with this JVM version.

Stack Trace:
org.junit.AssumptionViolatedException: SOLR-11606: ByteBuddy used by Mockito is 
not working with this JVM version.
        at __randomizedtesting.SeedInfo.seed([302C55A0BD689CA2]:0)
        at 
com.carrotsearch.randomizedtesting.RandomizedTest.assumeNoException(RandomizedTest.java:742)
        at 
org.apache.solr.SolrTestCaseJ4.assumeWorkingMockito(SolrTestCaseJ4.java:362)
        at org.apache.solr.cloud.OverseerTest.beforeClass(OverseerTest.java:284)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:835)
Caused by: java.lang.IllegalArgumentException: Unknown Java version: 13
        at 
net.bytebuddy.ClassFileVersion.ofJavaVersion(ClassFileVersion.java:210)
        at 
net.bytebuddy.ClassFileVersion$VersionLocator$ForJava9CapableVm.locate(ClassFileVersion.java:462)
        at net.bytebuddy.ClassFileVersion.ofThisVm(ClassFileVersion.java:223)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at 
org.apache.solr.SolrTestCaseJ4.assumeWorkingMockito(SolrTestCaseJ4.java:360)
        ... 24 more


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.OverseerTest

Error Message:


Stack Trace:
java.lang.NullPointerException
        at __randomizedtesting.SeedInfo.seed([302C55A0BD689CA2]:0)
        at org.apache.solr.cloud.OverseerTest.afterClass(OverseerTest.java:307)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:901)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:835)


FAILED:  org.apache.solr.cloud.LeaderTragicEventTest.test

Error Message:
Failed while waiting for active collection Timeout waiting to see state for 
collection=collection1 :null Live Nodes: [127.0.0.1:36995_solr, 
127.0.0.1:38945_solr] Last available state: null

Stack Trace:
java.lang.RuntimeException: Failed while waiting for active collection
Timeout waiting to see state for collection=collection1 :null
Live Nodes: [127.0.0.1:36995_solr, 127.0.0.1:38945_solr]
Last available state: null
        at 
__randomizedtesting.SeedInfo.seed([302C55A0BD689CA2:B8786A7A1394F15A]:0)
        at 
org.apache.solr.cloud.MiniSolrCloudCluster.waitForActiveCollection(MiniSolrCloudCluster.java:728)
        at 
org.apache.solr.cloud.MiniSolrCloudCluster.waitForActiveCollection(MiniSolrCloudCluster.java:734)
        at 
org.apache.solr.cloud.LeaderTragicEventTest.test(LeaderTragicEventTest.java:79)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:835)




Build Log:
[...truncated 14170 lines...]
   [junit4] Suite: org.apache.solr.cloud.LeaderTragicEventTest
   [junit4]   2> 1201392 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderTragicEventTest_302C55A0BD689CA2-001/init-core-data-001
   [junit4]   2> 1201392 WARN  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=17 numCloses=17
   [junit4]   2> 1201392 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1201393 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1201393 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderTragicEventTest_302C55A0BD689CA2-001/tempDir-001
   [junit4]   2> 1201393 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1201393 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1201393 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1201493 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:40599
   [junit4]   2> 1201494 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:40599
   [junit4]   2> 1201494 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 40599
   [junit4]   2> 1201497 INFO  (zkConnectionManagerCallback-8021-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201499 INFO  (zkConnectionManagerCallback-8023-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201500 INFO  (zkConnectionManagerCallback-8025-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201502 WARN  (jetty-launcher-8026-thread-2) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1201502 WARN  (jetty-launcher-8026-thread-1) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1201502 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 1201502 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 1201502 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1201502 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1201502 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+8
   [junit4]   2> 1201502 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+8
   [junit4]   2> 1201510 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1201510 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1201510 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1201513 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1201513 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1201513 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1201513 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@746af20a{/solr,null,AVAILABLE}
   [junit4]   2> 1201513 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@14b81175{/solr,null,AVAILABLE}
   [junit4]   2> 1201514 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@4c6b9e47{HTTP/1.1,[http/1.1]}{127.0.0.1:38945}
   [junit4]   2> 1201514 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@29da2c9e{HTTP/1.1,[http/1.1]}{127.0.0.1:36995}
   [junit4]   2> 1201514 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.e.j.s.Server Started @1201528ms
   [junit4]   2> 1201514 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.e.j.s.Server Started @1201528ms
   [junit4]   2> 1201514 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38945}
   [junit4]   2> 1201514 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36995}
   [junit4]   2> 1201515 ERROR (jetty-launcher-8026-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1201515 ERROR (jetty-launcher-8026-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.8.0
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.8.0
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-02-23T02:32:04.740243Z
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1201515 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-02-23T02:32:04.740317Z
   [junit4]   2> 1201516 INFO  (zkConnectionManagerCallback-8028-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201516 INFO  (zkConnectionManagerCallback-8030-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201516 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1201516 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1201563 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1201565 INFO  (jetty-launcher-8026-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40599/solr
   [junit4]   2> 1201566 INFO  (zkConnectionManagerCallback-8034-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201567 INFO  (zkConnectionManagerCallback-8036-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201574 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1201576 INFO  (jetty-launcher-8026-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40599/solr
   [junit4]   2> 1201576 INFO  (zkConnectionManagerCallback-8042-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201577 INFO  (zkConnectionManagerCallback-8044-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201580 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:36995_solr
   [junit4]   2> 1201581 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.Overseer Overseer 
(id=72087983216394248-127.0.0.1:36995_solr-n_0000000000) starting
   [junit4]   2> 1201587 INFO  (zkConnectionManagerCallback-8051-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201588 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:40599/solr ready
   [junit4]   2> 1201588 INFO  
(OverseerStateUpdate-72087983216394248-127.0.0.1:36995_solr-n_0000000000) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:36995_solr
   [junit4]   2> 1201588 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36995_solr
   [junit4]   2> 1201589 INFO  
(OverseerStateUpdate-72087983216394248-127.0.0.1:36995_solr-n_0000000000) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1201589 INFO  (zkCallback-8050-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1201599 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1201599 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1201600 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:38945_solr as DOWN
   [junit4]   2> 1201600 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1201600 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38945_solr
   [junit4]   2> 1201600 INFO  (zkCallback-8043-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1201600 INFO  (zkCallback-8035-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1201602 INFO  (zkCallback-8050-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1201609 INFO  (zkConnectionManagerCallback-8057-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201610 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1201610 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:40599/solr ready
   [junit4]   2> 1201610 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1201612 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36995.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1538dae6
   [junit4]   2> 1201619 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36995.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1538dae6
   [junit4]   2> 1201619 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36995.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1538dae6
   [junit4]   2> 1201620 INFO  (jetty-launcher-8026-thread-2) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderTragicEventTest_302C55A0BD689CA2-001/tempDir-001/node2/.
   [junit4]   2> 1201622 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38945.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1538dae6
   [junit4]   2> 1201629 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38945.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1538dae6
   [junit4]   2> 1201629 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38945.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1538dae6
   [junit4]   2> 1201630 INFO  (jetty-launcher-8026-thread-1) 
[n:127.0.0.1:38945_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderTragicEventTest_302C55A0BD689CA2-001/tempDir-001/node1/.
   [junit4]   2> 1201651 INFO  (zkConnectionManagerCallback-8063-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201652 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1201653 INFO  
(SUITE-LeaderTragicEventTest-seed#[302C55A0BD689CA2]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40599/solr ready
   [junit4]   2> 1201661 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testOtherReplicasAreNotActive
   [junit4]   2> 1201662 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=config&name=collection2&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1201671 INFO  
(OverseerThreadFactory-9061-thread-1-processing-n:127.0.0.1:36995_solr) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
collection2
   [junit4]   2> 1201775 INFO  
(OverseerStateUpdate-72087983216394248-127.0.0.1:36995_solr-n_0000000000) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection2_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:36995/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1201775 INFO  
(OverseerStateUpdate-72087983216394248-127.0.0.1:36995_solr-n_0000000000) 
[n:127.0.0.1:36995_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection2_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:38945/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1201978 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr    
x:collection2_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=collection2_shard1_replica_n1&action=CREATE&numShards=1&collection=collection2&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1201978 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr    
x:collection2_shard1_replica_n2] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=collection2_shard1_replica_n2&action=CREATE&numShards=1&collection=collection2&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1201978 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr    
x:collection2_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1202985 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.8.0
   [junit4]   2> 1202985 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.8.0
   [junit4]   2> 1202990 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.s.IndexSchema [collection2_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 1202990 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.IndexSchema [collection2_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1202991 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1202991 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1202991 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'collection2_shard1_replica_n2' using 
configuration from collection collection2, trusted=true
   [junit4]   2> 1202991 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection2_shard1_replica_n1' using 
configuration from collection collection2, trusted=true
   [junit4]   2> 1202991 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36995.solr.core.collection2.shard1.replica_n1' (registry 
'solr.core.collection2.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1538dae6
   [junit4]   2> 1202991 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38945.solr.core.collection2.shard1.replica_n2' (registry 
'solr.core.collection2.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1538dae6
   [junit4]   2> 1202991 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.SolrCore [[collection2_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderTragicEventTest_302C55A0BD689CA2-001/tempDir-001/node2/collection2_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderTragicEventTest_302C55A0BD689CA2-001/tempDir-001/node2/./collection2_shard1_replica_n1/data/]
   [junit4]   2> 1202991 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.c.SolrCore [[collection2_shard1_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderTragicEventTest_302C55A0BD689CA2-001/tempDir-001/node1/collection2_shard1_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderTragicEventTest_302C55A0BD689CA2-001/tempDir-001/node1/./collection2_shard1_replica_n2/data/]
   [junit4]   2> 1203023 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1203023 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1203023 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1203023 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1203025 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1203025 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1203026 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1203026 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1203026 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3769b247[collection2_shard1_replica_n2] main]
   [junit4]   2> 1203026 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@9d2e5c5[collection2_shard1_replica_n1] main]
   [junit4]   2> 1203027 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/config
   [junit4]   2> 1203027 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/config
   [junit4]   2> 1203027 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 1203027 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 1203028 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1203028 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1203028 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1626225116449865728
   [junit4]   2> 1203028 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1626225116449865728
   [junit4]   2> 1203030 INFO  
(searcherExecutor-9070-thread-1-processing-n:127.0.0.1:38945_solr 
x:collection2_shard1_replica_n2 c:collection2 s:shard1 r:core_node4) 
[n:127.0.0.1:38945_solr c:collection2 s:shard1 r:core_node4 
x:collection2_shard1_replica_n2] o.a.s.c.SolrCore 
[collection2_shard1_replica_n2] Registered new searcher 
Searcher@3769b247[collection2_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1203030 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@9d2e5c5[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1203052 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/collection2/terms/shard1 to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 1203052 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.c.ZkShardTerms Failed to save terms, version is not a match, retrying
   [junit4]   2> 1203052 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/collection2/leaders/shard1
   [junit4]   2> 1203053 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/collection2/terms/shard1 to Terms{values={core_node3=0, 
core_node4=0}, version=1}
   [junit4]   2> 1203053 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/collection2/leaders/shard1
   [junit4]   2> 1203054 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1203054 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1203054 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:36995/solr/collection2_shard1_replica_n1/
   [junit4]   2> 1203055 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.PeerSync PeerSync: core=collection2_shard1_replica_n1 
url=http://127.0.0.1:36995/solr START 
replicas=[http://127.0.0.1:38945/solr/collection2_shard1_replica_n2/] 
nUpdates=100
   [junit4]   2> 1203055 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.PeerSync PeerSync: core=collection2_shard1_replica_n1 
url=http://127.0.0.1:36995/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 1203056 INFO  (qtp1223391657-24788) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.c.S.Request [collection2_shard1_replica_n2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1203056 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 1203056 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 1203056 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1203056 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/collection2/leaders/shard1/leader after winning as 
/collections/collection2/leader_elect/shard1/election/72087983216394248-core_node3-n_0000000000
   [junit4]   2> 1203057 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:36995/solr/collection2_shard1_replica_n1/ shard1
   [junit4]   2> 1203158 INFO  (zkCallback-8043-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1203158 INFO  (zkCallback-8043-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1203158 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1203185 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=collection2_shard1_replica_n1&action=CREATE&numShards=1&collection=collection2&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1207
   [junit4]   2> 1203260 INFO  (zkCallback-8043-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1203260 INFO  (zkCallback-8043-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1203260 INFO  (zkCallback-8043-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1204062 INFO  (qtp1223391657-24791) [n:127.0.0.1:38945_solr 
c:collection2 s:shard1 r:core_node4 x:collection2_shard1_replica_n2] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=collection2_shard1_replica_n2&action=CREATE&numShards=1&collection=collection2&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2083
   [junit4]   2> 1204064 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
45 seconds. Check all shard replicas
   [junit4]   2> 1204156 INFO  (zkCallback-8035-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1204156 INFO  (zkCallback-8043-thread-4) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1204156 INFO  (zkCallback-8043-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1204156 INFO  (zkCallback-8043-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1204157 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=config&name=collection2&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=2494
   [junit4]   2> 1204175 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.c.LeaderTragicEventTest Stop jetty node : 
http://127.0.0.1:38945/solr 
state:DocCollection(collection2//collections/collection2/state.json/5)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"collection2_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:36995/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:36995_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false",
   [junit4]   2>           "leader":"true"},
   [junit4]   2>         "core_node4":{
   [junit4]   2>           "core":"collection2_shard1_replica_n2",
   [junit4]   2>           "base_url":"http://127.0.0.1:38945/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:38945_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}}},
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0"}
   [junit4]   2> 1204176 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1505591842
   [junit4]   2> 1204176 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38945_solr
   [junit4]   2> 1204176 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 1204177 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.c.ZkController Publish node=127.0.0.1:38945_solr as DOWN
   [junit4]   2> 1204178 INFO  (coreCloseExecutor-9080-thread-1) 
[n:127.0.0.1:38945_solr c:collection2 s:shard1 r:core_node4 
x:collection2_shard1_replica_n2] o.a.s.c.SolrCore 
[collection2_shard1_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7597077c
   [junit4]   2> 1204178 INFO  (coreCloseExecutor-9080-thread-1) 
[n:127.0.0.1:38945_solr c:collection2 s:shard1 r:core_node4 
x:collection2_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.collection2.shard1.replica_n2, tag=7597077c
   [junit4]   2> 1204178 INFO  (coreCloseExecutor-9080-thread-1) 
[n:127.0.0.1:38945_solr c:collection2 s:shard1 r:core_node4 
x:collection2_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7db241f9: rootName = 
solr_38945, domain = solr.core.collection2.shard1.replica_n2, service url = 
null, agent id = null] for registry solr.core.collection2.shard1.replica_n2 / 
com.codahale.metrics.MetricRegistry@23dbde58
   [junit4]   2> 1204181 INFO  (zkCallback-8035-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1204187 INFO  (coreCloseExecutor-9080-thread-1) 
[n:127.0.0.1:38945_solr c:collection2 s:shard1 r:core_node4 
x:collection2_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.collection2.shard1.leader, tag=7597077c
   [junit4]   2> 1204190 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 1204190 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@700e7029: rootName = 
solr_38945, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@77324ea7
   [junit4]   2> 1204195 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 1204195 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@462527ed: rootName = 
solr_38945, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@3280295f
   [junit4]   2> 1204198 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 1204199 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@276df643: rootName = 
solr_38945, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@10e3b2d5
   [junit4]   2> 1204199 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.cluster, tag=null
   [junit4]   2> 1204213 INFO  (zkCallback-8050-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1204213 INFO  (zkCallback-8043-thread-3) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1204214 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@4c6b9e47{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1204214 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@14b81175{/solr,null,UNAVAILABLE}
   [junit4]   2> 1204214 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1204214 INFO  (zkCallback-8062-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1204279 INFO  (zkCallback-8043-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1204279 INFO  (zkCallback-8062-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1204279 INFO  (zkCallback-8043-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1204279 INFO  (zkCallback-8043-thread-4) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1204279 INFO  (zkCallback-8062-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection2/state.json] for collection [collection2] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1204279 INFO  
(TEST-LeaderTragicEventTest.testOtherReplicasAreNotActive-seed#[302C55A0BD689CA2])
 [    ] o.a.s.c.LeaderTragicEventTest Corrupt leader : 
core_node3:{"core":"collection2_shard1_replica_n1","base_url":"http://127.0.0.1:36995/solr","node_name":"127.0.0.1:36995_solr","state":"active","type":"NRT","force_set_state":"false","leader":"true"}
   [junit4]   2> 1204282 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/collection2/terms/shard1 to Terms{values={core_node3=1, 
core_node4=0}, version=2}
   [junit4]   2> 1204282 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[0 
(1626225117763731456)]} 0 1
   [junit4]   2> 1204283 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117765828608,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204284 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117765828608
   [junit4]   2> 1204286 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@cb26a49[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204286 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204287 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@cb26a49[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204288 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 1204289 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 
(1626225117771071488)]} 0 1
   [junit4]   2> 1204290 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117773168640,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204290 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117773168640
   [junit4]   2> 1204291 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7d349b9[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204291 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204292 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@7d349b9[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_1(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127516}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204293 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 2
   [junit4]   2> 1204294 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2 
(1626225117776314368)]} 0 0
   [junit4]   2> 1204294 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117777362944,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204294 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117777362944
   [junit4]   2> 1204296 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@29edf594[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204296 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204297 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@29edf594[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_1(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127516}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_2(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127520}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204297 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 3
   [junit4]   2> 1204299 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[3 
(1626225117781557248)]} 0 0
   [junit4]   2> 1204299 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117782605824,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204299 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117782605824
   [junit4]   2> 1204300 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@39bab325[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204301 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204301 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@39bab325[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_1(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127516}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_2(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127520}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_3(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127525}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204302 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 2
   [junit4]   2> 1204303 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[4 
(1626225117786800128)]} 0 0
   [junit4]   2> 1204304 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117787848704,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204304 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117787848704
   [junit4]   2> 1204307 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@17b12690[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204307 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204308 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@17b12690[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_1(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127516}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_2(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127520}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_3(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127525}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_4(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127529}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204308 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 4
   [junit4]   2> 1204309 INFO  (qtp1367626503-24789) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[5 
(1626225117793091584)]} 0 0
   [junit4]   2> 1204310 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117794140160,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204310 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117794140160
   [junit4]   2> 1204311 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@449c974b[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204311 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204312 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@449c974b[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_1(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127516}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_2(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127520}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_3(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127525}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_4(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127529}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_5(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127535}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204313 INFO  (qtp1367626503-24790) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 3
   [junit4]   2> 1204314 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[6 
(1626225117797285888)]} 0 0
   [junit4]   2> 1204315 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117799383040,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204315 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117799383040
   [junit4]   2> 1204317 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@13c606f0[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204318 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204319 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@13c606f0[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_1(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127516}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_2(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127520}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_3(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127525}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_4(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127529}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_5(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127535}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_6(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127540}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204319 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 1204321 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[7 
(1626225117804625920)]} 0 0
   [junit4]   2> 1204321 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117805674496,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204321 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117805674496
   [junit4]   2> 1204323 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3d804ad3[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204324 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@3d804ad3[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_1(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127516}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_2(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127520}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_3(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127525}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_4(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127529}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_5(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127535}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_6(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127540}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_7(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127547}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204325 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204325 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 3
   [junit4]   2> 1204328 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[8 
(1626225117810917376)]} 0 1
   [junit4]   2> 1204328 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117813014528,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204328 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117813014528
   [junit4]   2> 1204330 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@d78d73f[collection2_shard1_replica_n1] main]
   [junit4]   2> 1204332 INFO  
(searcherExecutor-9071-thread-1-processing-n:127.0.0.1:36995_solr 
x:collection2_shard1_replica_n1 c:collection2 s:shard1 r:core_node3) 
[n:127.0.0.1:36995_solr c:collection2 s:shard1 r:core_node3 
x:collection2_shard1_replica_n1] o.a.s.c.SolrCore 
[collection2_shard1_replica_n1] Registered new searcher 
Searcher@d78d73f[collection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.8.0):C1:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=13-ea, java.vm.version=13-ea+8, 
lucene.version=7.8.0, os.arch=amd64, java.runtime.version=13-ea+8, 
source=flush, os.version=4.18.0-15-generic, 
timestamp=1550889127509}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_1(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127516}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_2(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127520}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_3(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127525}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_4(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127529}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_5(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127535}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_6(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127540}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_7(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127547}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])
 Uninverting(_8(7.8.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=13-ea, java.vm.version=13-ea+8, lucene.version=7.8.0, 
os.arch=amd64, java.runtime.version=13-ea+8, source=flush, 
os.version=4.18.0-15-generic, 
timestamp=1550889127554}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 1204332 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1204332 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 4
   [junit4]   2> 1204334 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[9 
(1626225117818257408)]} 0 0
   [junit4]   2> 1204334 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1626225117819305984,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1204334 INFO  (qtp1367626503-24787) [n:127.0.0.1:36995_solr 
c:collection2 s:shard1 r:core_node3 x:collection2_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6bbd9a94 
commitCommandVersion:1626225117819305984
   [junit4]   2> 1204

[...truncated too long message...]

enkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptor-kerberos-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-admin-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-authn-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-authz-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-changelog-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/api-all-1.0.0-M20.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/bcprov-jdk15on-1.60.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/byte-buddy-1.9.3.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/commons-collections-3.2.2.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/ehcache-core-2.4.4.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/hadoop-common-2.7.4-tests.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/hadoop-hdfs-2.7.4-tests.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/hadoop-minikdc-2.7.4.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/htrace-core-3.2.0-incubating.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/jersey-core-1.9.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/jersey-server-1.9.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/jetty-6.1.26.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/jetty-sslengine-6.1.26.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/jetty-util-6.1.26.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/mina-core-2.0.0-M5.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/mockito-core-2.23.4.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/netty-all-4.0.36.Final.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/test-lib/objenesis-2.6.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/build/analysis/icu/lucene-analyzers-icu-7.8.0-SNAPSHOT.jar:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-analysis-extras/classes/java:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/build/queryparser/classes/test:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/build/backward-codecs/classes/test:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/contrib/analysis-extras/lib/icu4j-62.1.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-launcher.jar:/home/jenkins/.ant/lib/ivy-2.4.0.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-netrexx.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-javamail.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-net.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-oro.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jmf.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-log4j.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jsch.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jai.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit4.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jdepend.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-testutil.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-antlr.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-swing.jar:/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-logging.jar:/home/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.7.2.jar
 com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/temp/junit4-J2-20190223_021203_18615950706897204048988.events
 
@/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/temp/junit4-J2-20190223_021203_1861983638521571117455.suites
 -stdin
   [junit4] ERROR: JVM J2 ended with an exception: Forked process returned with 
error code: 134. Very likely a JVM crash.  See process stdout at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/temp/junit4-J2-20190223_021203_1866554852313135315818.sysout
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1542)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:123)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:997)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:994)
   [junit4]     at 
java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
   [junit4]     at 
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   [junit4]     at 
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   [junit4]     at java.base/java.lang.Thread.run(Thread.java:835)

BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:633: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:577: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:59: The following error 
occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build.xml:267: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/common-build.xml:558: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1572: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1099: At 
least one slave process threw an exception, first: Forked process returned with 
error code: 134. Very likely a JVM crash.  See process stdout at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/temp/junit4-J2-20190223_021203_1866554852313135315818.sysout

Total time: 58 minutes 32 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

[JENKINS-EA] Lucene-Solr-7.x-Linux (64bit/jdk-13-ea+8) - Build # 3573 - Failure!

Reply via email to