Build: https://builds.apache.org/job/Lucene-Solr-BadApples-Tests-master/93/
11 tests failed. FAILED: org.apache.solr.cloud.BasicDistributedZkTest.test Error Message: distrib-dup-test-chain-explicit: doc#3 has wrong value for regex_dup_A_s expected:<x_x> but was:<null> Stack Trace: java.lang.AssertionError: distrib-dup-test-chain-explicit: doc#3 has wrong value for regex_dup_A_s expected:<x_x> but was:<null> at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15:CE550B644D67E3ED]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.apache.solr.cloud.BasicDistributedZkTest.testUpdateProcessorsRunOnlyOnce(BasicDistributedZkTest.java:704) at org.apache.solr.cloud.BasicDistributedZkTest.test(BasicDistributedZkTest.java:381) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1008) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:983) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeWithPullReplicasTest.test Error Message: Test abandoned because suite timeout was reached. Stack Trace: java.lang.Exception: Test abandoned because suite timeout was reached. at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15]:0) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeWithPullReplicasTest Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15]:0) FAILED: org.apache.solr.cloud.TestPullReplica.testKillLeader Error Message: Replica core_node4 not up to date after 10 seconds expected:<1> but was:<0> Stack Trace: java.lang.AssertionError: Replica core_node4 not up to date after 10 seconds expected:<1> but was:<0> at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15:F17C00A81201A43]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.apache.solr.cloud.TestPullReplica.waitForNumDocsInAllReplicas(TestPullReplica.java:542) at org.apache.solr.cloud.TestPullReplica.doTestNoLeader(TestPullReplica.java:490) at org.apache.solr.cloud.TestPullReplica.testKillLeader(TestPullReplica.java:309) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.TestPullReplica.testRemoveAllWriterReplicas Error Message: Replica core_node4 not up to date after 10 seconds expected:<1> but was:<0> Stack Trace: java.lang.AssertionError: Replica core_node4 not up to date after 10 seconds expected:<1> but was:<0> at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15:D50FA885F76567BC]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.apache.solr.cloud.TestPullReplica.waitForNumDocsInAllReplicas(TestPullReplica.java:542) at org.apache.solr.cloud.TestPullReplica.doTestNoLeader(TestPullReplica.java:490) at org.apache.solr.cloud.TestPullReplica.testRemoveAllWriterReplicas(TestPullReplica.java:303) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.handler.component.InfixSuggestersTest.testBlendedInfixSuggesterBuildThenReload Error Message: Test abandoned because suite timeout was reached. Stack Trace: java.lang.Exception: Test abandoned because suite timeout was reached. at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15]:0) FAILED: junit.framework.TestSuite.org.apache.solr.handler.component.InfixSuggestersTest Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15]:0) FAILED: org.apache.solr.client.solrj.embedded.TestSolrProperties.testProperties Error Message: Test abandoned because suite timeout was reached. Stack Trace: java.lang.Exception: Test abandoned because suite timeout was reached. at __randomizedtesting.SeedInfo.seed([38EAB06EC44A11A7]:0) FAILED: junit.framework.TestSuite.org.apache.solr.client.solrj.embedded.TestSolrProperties Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([38EAB06EC44A11A7]:0) FAILED: org.apache.solr.cloud.autoscaling.sim.TestGenericDistributedQueue.testDistributedQueue Error Message: Test abandoned because suite timeout was reached. Stack Trace: java.lang.Exception: Test abandoned because suite timeout was reached. at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15]:0) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.autoscaling.sim.TestGenericDistributedQueue Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([460134BEE39B8E15]:0) Build Log: [...truncated 12217 lines...] [junit4] Suite: org.apache.solr.cloud.TestPullReplica [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/init-core-data-001 [junit4] 2> 29184 WARN (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3 [junit4] 2> 29184 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 29186 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 29186 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 29190 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001 [junit4] 2> 29234 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 29236 INFO (Thread-2) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 29237 INFO (Thread-2) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 29536 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:46364 [junit4] 2> 29617 ERROR (Thread-2) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 29847 INFO (zkConnectionManagerCallback-6-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 30007 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1074e029a930000, likely client has closed socket [junit4] 2> 30782 INFO (jetty-launcher-3-thread-1) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11 [junit4] 2> 30796 INFO (jetty-launcher-3-thread-2) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11 [junit4] 2> 30904 INFO (jetty-launcher-3-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 30904 INFO (jetty-launcher-3-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 30909 INFO (jetty-launcher-3-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 31045 INFO (jetty-launcher-3-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 31045 INFO (jetty-launcher-3-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 31045 INFO (jetty-launcher-3-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 31054 INFO (jetty-launcher-3-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@25244da4{/solr,null,AVAILABLE} [junit4] 2> 31067 INFO (jetty-launcher-3-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5e5ef0d3{/solr,null,AVAILABLE} [junit4] 2> 31139 INFO (jetty-launcher-3-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@51d53c93{HTTP/1.1,[http/1.1]}{127.0.0.1:50507} [junit4] 2> 31140 INFO (jetty-launcher-3-thread-1) [ ] o.e.j.s.Server Started @31315ms [junit4] 2> 31142 INFO (jetty-launcher-3-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@17c4e64d{HTTP/1.1,[http/1.1]}{127.0.0.1:45633} [junit4] 2> 31142 INFO (jetty-launcher-3-thread-2) [ ] o.e.j.s.Server Started @31318ms [junit4] 2> 31143 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45633} [junit4] 2> 31148 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=50507} [junit4] 2> 31241 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.u.c.SSLCredentialProviderFactory Processing SSL Credential Provider chain: env;sysprop [junit4] 2> 31252 ERROR (jetty-launcher-3-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 31252 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 31252 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 31253 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 31254 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 31255 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-07-09T07:34:29.907Z [junit4] 2> 31253 ERROR (jetty-launcher-3-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 31256 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 31256 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 31256 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 31256 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 31257 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 31257 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-07-09T07:34:29.909Z [junit4] 2> 31353 INFO (zkConnectionManagerCallback-8-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 31396 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 31408 INFO (zkConnectionManagerCallback-10-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 31422 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 32364 INFO (jetty-launcher-3-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46364/solr [junit4] 2> 32556 INFO (zkConnectionManagerCallback-14-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 32650 INFO (zkConnectionManagerCallback-16-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 33716 INFO (jetty-launcher-3-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46364/solr [junit4] 2> 33765 INFO (zkConnectionManagerCallback-22-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 33809 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 33814 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:45633_solr [junit4] 2> 33815 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.c.Overseer Overseer (id=74113691965128708-127.0.0.1:45633_solr-n_0000000000) starting [junit4] 2> 33859 INFO (zkConnectionManagerCallback-24-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 33879 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 33882 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:50507_solr [junit4] 2> 34028 INFO (zkCallback-15-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 34029 INFO (zkCallback-23-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 34133 INFO (zkConnectionManagerCallback-31-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 34135 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 34172 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46364/solr ready [junit4] 2> 34452 INFO (zkConnectionManagerCallback-36-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 34465 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 34473 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46364/solr ready [junit4] 2> 34492 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 34886 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 34886 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45633_solr [junit4] 2> 34897 INFO (zkCallback-15-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 34930 INFO (zkCallback-23-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 34946 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50507.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 34947 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50507.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 34947 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50507.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 34970 INFO (zkCallback-30-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 34975 INFO (jetty-launcher-3-thread-1) [n:127.0.0.1:50507_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node1/. [junit4] 2> 35013 INFO (zkCallback-35-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 35106 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 35498 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45633.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 35576 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45633.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 35605 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45633.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 35607 INFO (jetty-launcher-3-thread-2) [n:127.0.0.1:45633_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node2/. [junit4] 2> 35992 INFO (zkConnectionManagerCallback-40-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 36060 INFO (zkConnectionManagerCallback-45-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 36071 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 36073 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46364/solr ready [junit4] 2> 36082 INFO (SUITE-TestPullReplica-seed#[460134BEE39B8E15]-worker) [ ] o.a.s.c.TestPullReplica Using legacyCloud?: false [junit4] 2> 37024 INFO (qtp1795463531-43) [n:127.0.0.1:50507_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 37057 INFO (qtp1795463531-43) [n:127.0.0.1:50507_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} status=0 QTime=47 [junit4] 2> 37226 INFO (TEST-TestPullReplica.testAddDocs-seed#[460134BEE39B8E15]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAddDocs [junit4] 2> 37259 INFO (qtp1795463531-41) [n:127.0.0.1:50507_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=3&collection.configName=conf&maxShardsPerNode=100&name=pull_replica_test_add_docs&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 37300 INFO (OverseerThreadFactory-32-thread-1) [ ] o.a.s.c.a.c.CreateCollectionCmd Create collection pull_replica_test_add_docs [junit4] 2> 37324 WARN (OverseerThreadFactory-32-thread-1) [ ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 4 on collection pull_replica_test_add_docs is higher than the number of Solr instances currently live or live and part of your createNodeSet(2). It's unusual to run two replica of the same slice on the same Solr-instance. [junit4] 2> 37537 INFO (OverseerStateUpdate-74113691965128708-127.0.0.1:45633_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"pull_replica_test_add_docs", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"pull_replica_test_add_docs_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:45633/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 37559 INFO (OverseerStateUpdate-74113691965128708-127.0.0.1:45633_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"pull_replica_test_add_docs", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"pull_replica_test_add_docs_shard1_replica_p2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:50507/solr", [junit4] 2> "type":"PULL", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 37563 INFO (OverseerStateUpdate-74113691965128708-127.0.0.1:45633_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"pull_replica_test_add_docs", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"pull_replica_test_add_docs_shard1_replica_p4", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:45633/solr", [junit4] 2> "type":"PULL", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 37566 INFO (OverseerStateUpdate-74113691965128708-127.0.0.1:45633_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"pull_replica_test_add_docs", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"pull_replica_test_add_docs_shard1_replica_p5", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:50507/solr", [junit4] 2> "type":"PULL", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 37825 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p2&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL [junit4] 2> 37826 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p5&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL [junit4] 2> 37835 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 37846 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_n1&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 37848 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p4&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL [junit4] 2> 38921 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 38921 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 38957 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 39017 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 39043 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.s.IndexSchema [pull_replica_test_add_docs_shard1_replica_p5] Schema name=minimal [junit4] 2> 39051 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.s.IndexSchema [pull_replica_test_add_docs_shard1_replica_p4] Schema name=minimal [junit4] 2> 39053 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.IndexSchema [pull_replica_test_add_docs_shard1_replica_p2] Schema name=minimal [junit4] 2> 39087 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 39088 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.c.CoreContainer Creating SolrCore 'pull_replica_test_add_docs_shard1_replica_p4' using configuration from collection pull_replica_test_add_docs, trusted=true [junit4] 2> 39088 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.IndexSchema [pull_replica_test_add_docs_shard1_replica_n1] Schema name=minimal [junit4] 2> 39096 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 39101 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.CoreContainer Creating SolrCore 'pull_replica_test_add_docs_shard1_replica_p2' using configuration from collection pull_replica_test_add_docs, trusted=true [junit4] 2> 39120 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 39121 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'pull_replica_test_add_docs_shard1_replica_n1' using configuration from collection pull_replica_test_add_docs, trusted=true [junit4] 2> 39123 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45633.solr.core.pull_replica_test_add_docs.shard1.replica_n1' (registry 'solr.core.pull_replica_test_add_docs.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 39123 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 39123 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrCore [[pull_replica_test_add_docs_shard1_replica_n1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node2/pull_replica_test_add_docs_shard1_replica_n1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node2/./pull_replica_test_add_docs_shard1_replica_n1/data/] [junit4] 2> 39124 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45633.solr.core.pull_replica_test_add_docs.shard1.replica_p4' (registry 'solr.core.pull_replica_test_add_docs.shard1.replica_p4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 39124 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 39125 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.c.SolrCore [[pull_replica_test_add_docs_shard1_replica_p4] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node2/pull_replica_test_add_docs_shard1_replica_p4], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node2/./pull_replica_test_add_docs_shard1_replica_p4/data/] [junit4] 2> 39126 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50507.solr.core.pull_replica_test_add_docs.shard1.replica_p2' (registry 'solr.core.pull_replica_test_add_docs.shard1.replica_p2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 39133 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 39133 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.c.CoreContainer Creating SolrCore 'pull_replica_test_add_docs_shard1_replica_p5' using configuration from collection pull_replica_test_add_docs, trusted=true [junit4] 2> 39134 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50507.solr.core.pull_replica_test_add_docs.shard1.replica_p5' (registry 'solr.core.pull_replica_test_add_docs.shard1.replica_p5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6356814b [junit4] 2> 39134 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 39134 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.c.SolrCore [[pull_replica_test_add_docs_shard1_replica_p5] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node1/pull_replica_test_add_docs_shard1_replica_p5], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node1/./pull_replica_test_add_docs_shard1_replica_p5/data/] [junit4] 2> 39149 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 39149 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrCore [[pull_replica_test_add_docs_shard1_replica_p2] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node1/pull_replica_test_add_docs_shard1_replica_p2], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplica_460134BEE39B8E15-001/tempDir-001/node1/./pull_replica_test_add_docs_shard1_replica_p2/data/] [junit4] 2> 39656 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 39657 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 39673 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.SolrIndexSearcher Opening [Searcher@7adaa573[pull_replica_test_add_docs_shard1_replica_p2] main] [junit4] 2> 39682 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 39683 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 39684 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 39738 INFO (searcherExecutor-39-thread-1-processing-n:127.0.0.1:50507_solr x:pull_replica_test_add_docs_shard1_replica_p2 c:pull_replica_test_add_docs s:shard1 r:core_node6) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_p2] Registered new searcher Searcher@7adaa573[pull_replica_test_add_docs_shard1_replica_p2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 39817 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.ZkController pull_replica_test_add_docs_shard1_replica_p2 starting background replication from leader [junit4] 2> 39819 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:03 [junit4] 2> 39883 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms [junit4] 2> 39883 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 39988 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 39989 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 39997 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.s.SolrIndexSearcher Opening [Searcher@4a32c0a3[pull_replica_test_add_docs_shard1_replica_p4] main] [junit4] 2> 40000 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 40000 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 40003 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 40010 INFO (searcherExecutor-38-thread-1-processing-n:127.0.0.1:45633_solr x:pull_replica_test_add_docs_shard1_replica_p4 c:pull_replica_test_add_docs s:shard1 r:core_node7) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_p4] Registered new searcher Searcher@4a32c0a3[pull_replica_test_add_docs_shard1_replica_p4] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 40015 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.c.ZkController pull_replica_test_add_docs_shard1_replica_p4 starting background replication from leader [junit4] 2> 40016 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:03 [junit4] 2> 40020 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms [junit4] 2> 40021 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 40036 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 40036 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 40046 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.s.SolrIndexSearcher Opening [Searcher@fa17bde[pull_replica_test_add_docs_shard1_replica_p5] main] [junit4] 2> 40061 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 40062 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 40063 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 40071 INFO (searcherExecutor-41-thread-1-processing-n:127.0.0.1:50507_solr x:pull_replica_test_add_docs_shard1_replica_p5 c:pull_replica_test_add_docs s:shard1 r:core_node8) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_p5] Registered new searcher Searcher@fa17bde[pull_replica_test_add_docs_shard1_replica_p5] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 40098 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.c.ZkController pull_replica_test_add_docs_shard1_replica_p5 starting background replication from leader [junit4] 2> 40098 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:03 [junit4] 2> 40101 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms [junit4] 2> 40101 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 40184 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 40184 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 40258 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 40258 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 40281 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@505c97cd[pull_replica_test_add_docs_shard1_replica_n1] main] [junit4] 2> 40283 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 40283 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 40284 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 40286 INFO (searcherExecutor-40-thread-1-processing-n:127.0.0.1:45633_solr x:pull_replica_test_add_docs_shard1_replica_n1 c:pull_replica_test_add_docs s:shard1 r:core_node3) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_n1] Registered new searcher Searcher@505c97cd[pull_replica_test_add_docs_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 40287 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1605497445615140864 [junit4] 2> 40307 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/pull_replica_test_add_docs/terms/shard1 to Terms{values={core_node3=0}, version=0} [junit4] 2> 40360 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 40360 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 40360 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:45633/solr/pull_replica_test_add_docs_shard1_replica_n1/ [junit4] 2> 40362 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 40362 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:45633/solr/pull_replica_test_add_docs_shard1_replica_n1/ has no replicas [junit4] 2> 40362 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 40565 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:45633/solr/pull_replica_test_add_docs_shard1_replica_n1/ shard1 [junit4] 2> 40676 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 40682 INFO (indexFetcher-53-thread-1) [ ] o.a.s.h.IndexFetcher Replica core_node3 is leader but it's state is down, skipping replication [junit4] 2> 40683 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Replica core_node3 is leader but it's state is down, skipping replication [junit4] 2> 40688 INFO (qtp1225175455-53) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_n1&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2842 [junit4] 2> 40781 INFO (zkCallback-15-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_test_add_docs/state.json] for collection [pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2]) [junit4] 2> 40889 INFO (qtp1795463531-39) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p2&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL} status=0 QTime=3068 [junit4] 2> 41010 INFO (zkCallback-23-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_test_add_docs/state.json] for collection [pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2]) [junit4] 2> 41011 INFO (zkCallback-15-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_test_add_docs/state.json] for collection [pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2]) [junit4] 2> 41040 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node7 x:pull_replica_test_add_docs_shard1_replica_p4] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p4&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL} status=0 QTime=3191 [junit4] 2> 41106 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node8 x:pull_replica_test_add_docs_shard1_replica_p5] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p5&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL} status=0 QTime=3282 [junit4] 2> 41125 INFO (OverseerCollectionConfigSetProcessor-74113691965128708-127.0.0.1:45633_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 41128 INFO (qtp1795463531-41) [n:127.0.0.1:50507_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas [junit4] 2> 41206 INFO (zkCallback-23-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_test_add_docs/state.json] for collection [pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2]) [junit4] 2> 41208 INFO (zkCallback-15-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_test_add_docs/state.json] for collection [pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2]) [junit4] 2> 42129 INFO (qtp1795463531-41) [n:127.0.0.1:50507_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=3&collection.configName=conf&maxShardsPerNode=100&name=pull_replica_test_add_docs&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2} status=0 QTime=4869 [junit4] 2> 42433 INFO (qtp1225175455-49) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/pull_replica_test_add_docs/terms/shard1 to Terms{values={core_node3=1}, version=1} [junit4] 2> 42434 INFO (qtp1225175455-49) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 (1605497447714390016)]} 0 208 [junit4] 2> 42438 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Updated masterUrl to http://127.0.0.1:45633/solr/pull_replica_test_add_docs_shard1_replica_n1/ [junit4] 2> 42458 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1605497447891599360,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 42458 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@15e0d8f1 commitCommandVersion:1605497447891599360 [junit4] 2> 42480 INFO (qtp1225175455-52) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=39 [junit4] 2> 42481 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 1 [junit4] 2> 42481 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 0 [junit4] 2> 42481 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 42481 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 0 [junit4] 2> 42481 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher New index in Master. Deleting mine... [junit4] 2> 42485 INFO (indexFetcher-57-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 42485 INFO (indexFetcher-57-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@53e1aae9 commitCommandVersion:0 [junit4] 2> 42933 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Last replication failed, so I'll force replication [junit4] 2> 42933 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Updated masterUrl to http://127.0.0.1:45633/solr/pull_replica_test_add_docs_shard1_replica_n1/ [junit4] 2> 42942 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 42945 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 1 [junit4] 2> 42945 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 0 [junit4] 2> 42945 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 42945 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 0 [junit4] 2> 42945 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher New index in Master. Deleting mine... [junit4] 2> 42948 INFO (indexFetcher-57-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7d6cda03[pull_replica_test_add_docs_shard1_replica_p5] main] [junit4] 2> 42949 INFO (indexFetcher-57-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 42951 INFO (searcherExecutor-41-thread-1) [ ] o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_p5] Registered new searcher Searcher@7d6cda03[pull_replica_test_add_docs_shard1_replica_p5] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 42957 INFO (indexFetcher-48-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 42957 INFO (indexFetcher-48-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@76932e16 commitCommandVersion:0 [junit4] 2> 42965 INFO (indexFetcher-48-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3969d48f[pull_replica_test_add_docs_shard1_replica_p2] main] [junit4] 2> 42968 INFO (searcherExecutor-39-thread-1) [ ] o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_p2] Registered new searcher Searcher@3969d48f[pull_replica_test_add_docs_shard1_replica_p2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 42968 INFO (indexFetcher-48-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 43017 INFO (indexFetcher-53-thread-1) [ ] o.a.s.h.IndexFetcher Last replication failed, so I'll force replication [junit4] 2> 43017 INFO (indexFetcher-53-thread-1) [ ] o.a.s.h.IndexFetcher Updated masterUrl to http://127.0.0.1:45633/solr/pull_replica_test_add_docs_shard1_replica_n1/ [junit4] 2> 43029 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 43031 INFO (indexFetcher-53-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 1 [junit4] 2> 43031 INFO (indexFetcher-53-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 0 [junit4] 2> 43031 INFO (indexFetcher-53-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 43031 INFO (indexFetcher-53-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 0 [junit4] 2> 43031 INFO (indexFetcher-53-thread-1) [ ] o.a.s.h.IndexFetcher New index in Master. Deleting mine... [junit4] 2> 43032 INFO (indexFetcher-53-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 43032 INFO (indexFetcher-53-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@6ba5856b commitCommandVersion:0 [junit4] 2> 43035 INFO (indexFetcher-53-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5c310a6b[pull_replica_test_add_docs_shard1_replica_p4] main] [junit4] 2> 43036 INFO (indexFetcher-53-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 43038 INFO (searcherExecutor-38-thread-1) [ ] o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_p4] Registered new searcher Searcher@5c310a6b[pull_replica_test_add_docs_shard1_replica_p4] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 43112 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@ae8fd56[pull_replica_test_add_docs_shard1_replica_n1] main] [junit4] 2> 43115 INFO (searcherExecutor-40-thread-1-processing-n:127.0.0.1:45633_solr x:pull_replica_test_add_docs_shard1_replica_n1 c:pull_replica_test_add_docs s:shard1 r:core_node3) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_n1] Registered new searcher Searcher@ae8fd56[pull_replica_test_add_docs_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))} [junit4] 2> 43119 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 43119 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=pull_replica_test_add_docs:7&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 662 [junit4] 2> 43143 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=3 [junit4] 2> 43175 INFO (qtp1795463531-42) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=15 [junit4] 2> 43279 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 43384 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 43498 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 43602 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 43705 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 43809 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 43919 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 44085 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 44188 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 44296 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 44399 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 44530 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 44635 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 44747 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 44852 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 45046 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 45149 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 45254 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 45357 INFO (qtp1795463531-46) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 45440 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 45445 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 2 [junit4] 2> 45445 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 1531121681111 [junit4] 2> 45445 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 2 [junit4] 2> 45445 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 1531121681258 [junit4] 2> 45445 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Starting replication process [junit4] 2> 45574 INFO (qtp1795463531-42) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 45687 INFO (qtp1795463531-42) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 45457 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist} status=0 QTime=10 [junit4] 2> 45730 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Number of files in latest index in master: 18 [junit4] 2> 45732 INFO (indexFetcher-57-thread-1) [ ] o.a.s.h.IndexFetcher Starting download (fullCopy=true) to MockDirectoryWrapper(RAMDirectory@76bd41cf lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3e59cc25) [junit4] 2> 45760 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=5 [junit4] 2> 45796 INFO (qtp1795463531-42) [n:127.0.0.1:50507_solr c:pull_replica_test_add_docs s:shard1 r:core_node6 x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_p2] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 45828 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.tiv&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45839 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45846 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_MockRandom_0.tib&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45850 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.pos&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45852 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45857 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45860 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45863 INFO (qtp1225175455-52) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 45864 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 2 [junit4] 2> 45864 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 1531121681111 [junit4] 2> 45864 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 2 [junit4] 2> 45864 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 1531121681609 [junit4] 2> 45864 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Starting replication process [junit4] 2> 45866 INFO (qtp1225175455-52) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist} status=0 QTime=1 [junit4] 2> 45867 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Number of files in latest index in master: 18 [junit4] 2> 45867 INFO (indexFetcher-48-thread-1) [ ] o.a.s.h.IndexFetcher Starting download (fullCopy=true) to MockDirectoryWrapper(RAMDirectory@3578337b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d08163f) [junit4] 2> 45869 INFO (qtp1225175455-48) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45886 INFO (qtp1225175455-55) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_LuceneVarGapFixedInterval_0.tiv&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45889 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.dii&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45892 INFO (qtp1225175455-52) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_docs_shard1_replica_n1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 45894 INFO (qtp1225175455-54) [n:127.0.0.1:45633_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request [pull_replica_test_add_d [...truncated too long message...] jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null23856135 [copy] Copying 241 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null23856135 [delete] Deleting directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null23856135 check-working-copy: [ivy:cachepath] :: resolving dependencies :: org.eclipse.jgit#org.eclipse.jgit-caller;working [ivy:cachepath] confs: [default] [ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public [ivy:cachepath] found com.jcraft#jsch;0.1.53 in public [ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public [ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in public [ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public [ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public [ivy:cachepath] found commons-codec#commons-codec;1.6 in public [ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public [ivy:cachepath] :: resolution report :: resolve 97ms :: artifacts dl 6ms --------------------------------------------------------------------- | | modules || artifacts | | conf | number| search|dwnlded|evicted|| number|dwnlded| --------------------------------------------------------------------- | default | 8 | 0 | 0 | 0 || 8 | 0 | --------------------------------------------------------------------- [wc-checker] Initializing working copy... [wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". [wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation [wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. [wc-checker] Checking working copy status... -jenkins-base: BUILD SUCCESSFUL Total time: 407 minutes 20 seconds Archiving artifacts java.lang.InterruptedException: no matches found within 10000 at hudson.FilePath$34.hasMatch(FilePath.java:2678) at hudson.FilePath$34.invoke(FilePath.java:2557) at hudson.FilePath$34.invoke(FilePath.java:2547) at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2918) Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741) at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357) at hudson.remoting.Channel.call(Channel.java:955) at hudson.FilePath.act(FilePath.java:1036) at hudson.FilePath.act(FilePath.java:1025) at hudson.FilePath.validateAntFileMask(FilePath.java:2547) at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243) at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81) at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744) at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690) at hudson.model.Build$BuildExecution.post2(Build.java:186) at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635) at hudson.model.Run.execute(Run.java:1819) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) at hudson.model.ResourceController.execute(ResourceController.java:97) at hudson.model.Executor.run(Executor.java:429) Caused: hudson.FilePath$TunneledInterruptedException at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2920) at hudson.remoting.UserRequest.perform(UserRequest.java:212) at hudson.remoting.UserRequest.perform(UserRequest.java:54) at hudson.remoting.Request$2.run(Request.java:369) at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748) Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000 at hudson.FilePath.act(FilePath.java:1038) at hudson.FilePath.act(FilePath.java:1025) at hudson.FilePath.validateAntFileMask(FilePath.java:2547) at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243) at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81) at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744) at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690) at hudson.model.Build$BuildExecution.post2(Build.java:186) at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635) at hudson.model.Run.execute(Run.java:1819) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) at hudson.model.ResourceController.execute(ResourceController.java:97) at hudson.model.Executor.run(Executor.java:429) No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error? Recording test results Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures)
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org