Build: https://builds.apache.org/job/Lucene-Solr-BadApples-Tests-7.x/231/
2 tests failed. FAILED: org.apache.solr.cloud.TestCloudConsistency.testOutOfSyncReplicasCannotBecomeLeader Error Message: Doc with id=4 not found in http://127.0.0.1:40704/solr/outOfSyncReplicasCannotBecomeLeader-false due to: Path not found: /id; rsp={doc=null} Stack Trace: java.lang.AssertionError: Doc with id=4 not found in http://127.0.0.1:40704/solr/outOfSyncReplicasCannotBecomeLeader-false due to: Path not found: /id; rsp={doc=null} at __randomizedtesting.SeedInfo.seed([B72E2FF953D47986:C9C50FE990B376BC]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.TestCloudConsistency.assertDocExists(TestCloudConsistency.java:282) at org.apache.solr.cloud.TestCloudConsistency.assertDocsExistInAllReplicas(TestCloudConsistency.java:266) at org.apache.solr.cloud.TestCloudConsistency.testOutOfSyncReplicasCannotBecomeLeader(TestCloudConsistency.java:139) at org.apache.solr.cloud.TestCloudConsistency.testOutOfSyncReplicasCannotBecomeLeader(TestCloudConsistency.java:98) 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:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.test Error Message: Error from server at http://127.0.0.1:40660/solr: no core retrieved for test Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException: Error from server at http://127.0.0.1:40660/solr: no core retrieved for test at __randomizedtesting.SeedInfo.seed([B72E2FF953D47986:3F7A1023FD28147E]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException.create(HttpSolrClient.java:829) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:620) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:484) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:414) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1110) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:884) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:817) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1260) at org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.createConfigSet(TimeRoutedAliasUpdateProcessorTest.java:229) at org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.test(TimeRoutedAliasUpdateProcessorTest.java:116) 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:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 13582 lines...] [junit4] Suite: org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/init-core-data-001 [junit4] 2> 1845444 WARN (SUITE-TimeRoutedAliasUpdateProcessorTest-seed#[B72E2FF953D47986]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4 [junit4] 2> 1845444 INFO (SUITE-TimeRoutedAliasUpdateProcessorTest-seed#[B72E2FF953D47986]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 1845446 INFO (SUITE-TimeRoutedAliasUpdateProcessorTest-seed#[B72E2FF953D47986]-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> 1845446 INFO (SUITE-TimeRoutedAliasUpdateProcessorTest-seed#[B72E2FF953D47986]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 1845461 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testParse [junit4] 2> 1845462 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-001 [junit4] 2> 1845462 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1845480 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1845480 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1845483 ERROR (ZkTestServer Run Thread) [ ] 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> 1845569 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer start zk server on port:42944 [junit4] 2> 1845569 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:42944 [junit4] 2> 1845569 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 42944 [junit4] 2> 1845678 INFO (zkConnectionManagerCallback-5848-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1845771 INFO (zkConnectionManagerCallback-5850-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1845810 INFO (zkConnectionManagerCallback-5852-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1845845 WARN (jetty-launcher-5845-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1845845 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1845845 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1845845 INFO (jetty-launcher-5845-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1845861 WARN (jetty-launcher-5845-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1845861 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1845861 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1845861 INFO (jetty-launcher-5845-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1845862 WARN (jetty-launcher-5845-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1845862 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1845862 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1845862 INFO (jetty-launcher-5845-thread-4) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1845869 WARN (jetty-launcher-5845-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1845869 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1845869 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1845869 INFO (jetty-launcher-5845-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1845897 INFO (jetty-launcher-5845-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1845897 INFO (jetty-launcher-5845-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1845897 INFO (jetty-launcher-5845-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1845914 INFO (jetty-launcher-5845-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2e7b4b0c{/solr,null,AVAILABLE} [junit4] 2> 1845990 INFO (jetty-launcher-5845-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1845990 INFO (jetty-launcher-5845-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1845990 INFO (jetty-launcher-5845-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1846009 INFO (jetty-launcher-5845-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4af803fd{/solr,null,AVAILABLE} [junit4] 2> 1846034 INFO (jetty-launcher-5845-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1846034 INFO (jetty-launcher-5845-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1846034 INFO (jetty-launcher-5845-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1846051 INFO (jetty-launcher-5845-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5820b591{/solr,null,AVAILABLE} [junit4] 2> 1846168 INFO (jetty-launcher-5845-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1846168 INFO (jetty-launcher-5845-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1846169 INFO (jetty-launcher-5845-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1846169 INFO (jetty-launcher-5845-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7eba0fb1{/solr,null,AVAILABLE} [junit4] 2> 1846173 INFO (jetty-launcher-5845-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@47b72beb{HTTP/1.1,[http/1.1]}{127.0.0.1:44746} [junit4] 2> 1846173 INFO (jetty-launcher-5845-thread-4) [ ] o.e.j.s.Server Started @1846208ms [junit4] 2> 1846174 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44746} [junit4] 2> 1846174 ERROR (jetty-launcher-5845-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1846174 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1846174 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.7.0 [junit4] 2> 1846174 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1846174 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1846174 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-03T14:41:29.914Z [junit4] 2> 1846189 INFO (jetty-launcher-5845-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@695d84e6{HTTP/1.1,[http/1.1]}{127.0.0.1:41002} [junit4] 2> 1846189 INFO (jetty-launcher-5845-thread-1) [ ] o.e.j.s.Server Started @1846224ms [junit4] 2> 1846189 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41002} [junit4] 2> 1846190 ERROR (jetty-launcher-5845-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1846190 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1846190 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.7.0 [junit4] 2> 1846190 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1846190 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1846190 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-03T14:41:29.930Z [junit4] 2> 1846209 INFO (jetty-launcher-5845-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@558b37bc{HTTP/1.1,[http/1.1]}{127.0.0.1:39949} [junit4] 2> 1846209 INFO (jetty-launcher-5845-thread-3) [ ] o.e.j.s.Server Started @1846244ms [junit4] 2> 1846209 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39949} [junit4] 2> 1846209 ERROR (jetty-launcher-5845-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1846209 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1846209 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.7.0 [junit4] 2> 1846209 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1846209 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1846209 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-03T14:41:29.949Z [junit4] 2> 1846371 INFO (zkConnectionManagerCallback-5856-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1846371 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1846392 INFO (jetty-launcher-5845-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@30526c7{HTTP/1.1,[http/1.1]}{127.0.0.1:41660} [junit4] 2> 1846393 INFO (jetty-launcher-5845-thread-2) [ ] o.e.j.s.Server Started @1846428ms [junit4] 2> 1846393 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41660} [junit4] 2> 1846393 ERROR (jetty-launcher-5845-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1846393 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1846393 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.7.0 [junit4] 2> 1846393 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1846393 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1846393 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-03T14:41:30.133Z [junit4] 2> 1846407 INFO (zkConnectionManagerCallback-5854-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1846411 INFO (zkConnectionManagerCallback-5860-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1846428 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1846428 INFO (zkConnectionManagerCallback-5858-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1846428 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1846444 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1846541 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 0x10618c6deee0005, likely client has closed socket [junit4] 2> 1847412 INFO (jetty-launcher-5845-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42944/solr [junit4] 2> 1847501 INFO (zkConnectionManagerCallback-5864-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1847583 INFO (zkConnectionManagerCallback-5866-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1847664 INFO (jetty-launcher-5845-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42944/solr [junit4] 2> 1847699 INFO (zkConnectionManagerCallback-5872-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1847769 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 0x10618c6deee0009, likely client has closed socket [junit4] 2> 1847825 INFO (zkConnectionManagerCallback-5874-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1847863 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:41002_solr [junit4] 2> 1847864 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.c.Overseer Overseer (id=73773686320922634-127.0.0.1:41002_solr-n_0000000000) starting [junit4] 2> 1847974 INFO (jetty-launcher-5845-thread-3) [n:127.0.0.1:39949_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39949_solr [junit4] 2> 1848011 INFO (zkCallback-5873-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1848031 INFO (zkCallback-5865-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1848045 INFO (zkConnectionManagerCallback-5881-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1848047 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1848047 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42944/solr ready [junit4] 2> 1848081 INFO (OverseerStateUpdate-73773686320922634-127.0.0.1:41002_solr-n_0000000000) [n:127.0.0.1:41002_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:41002_solr [junit4] 2> 1848081 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41002_solr as DOWN [junit4] 2> 1848083 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1848083 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41002_solr [junit4] 2> 1848117 INFO (zkCallback-5880-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1848136 INFO (OverseerAutoScalingTriggerThread-73773686320922634-127.0.0.1:41002_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:39949_solr, 127.0.0.1:41002_solr] [junit4] 2> 1848173 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1848190 INFO (zkCallback-5865-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1848194 INFO (zkCallback-5873-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1848210 INFO (zkConnectionManagerCallback-5887-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1848251 INFO (ScheduledTrigger-3582-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2 [junit4] 2> 1848263 INFO (jetty-launcher-5845-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42944/solr [junit4] 2> 1848265 INFO (zkConnectionManagerCallback-5891-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1848299 INFO (zkConnectionManagerCallback-5893-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1848302 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 1848317 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:44746_solr as DOWN [junit4] 2> 1848317 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1848317 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44746_solr [junit4] 2> 1848318 INFO (zkCallback-5865-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 1848331 INFO (jetty-launcher-5845-thread-3) [n:127.0.0.1:39949_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 1848353 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41002.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1848373 INFO (jetty-launcher-5845-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42944/solr [junit4] 2> 1848374 INFO (zkConnectionManagerCallback-5899-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1848375 INFO (zkCallback-5880-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 1848404 INFO (jetty-launcher-5845-thread-3) [n:127.0.0.1:39949_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42944/solr ready [junit4] 2> 1848411 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41002.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1848411 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41002.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1848556 INFO (jetty-launcher-5845-thread-1) [n:127.0.0.1:41002_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-001/node1/. [junit4] 2> 1848592 INFO (zkCallback-5886-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 1848592 INFO (jetty-launcher-5845-thread-3) [n:127.0.0.1:39949_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1848611 INFO (zkCallback-5873-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 1848665 INFO (zkConnectionManagerCallback-5901-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1848773 INFO (zkCallback-5892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 1848803 INFO (jetty-launcher-5845-thread-3) [n:127.0.0.1:39949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39949.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1848809 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 1848812 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41660_solr as DOWN [junit4] 2> 1848862 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1848862 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41660_solr [junit4] 2> 1848876 INFO (jetty-launcher-5845-thread-3) [n:127.0.0.1:39949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39949.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1848876 INFO (jetty-launcher-5845-thread-3) [n:127.0.0.1:39949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39949.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1848877 INFO (jetty-launcher-5845-thread-3) [n:127.0.0.1:39949_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-001/node2/. [junit4] 2> 1848883 INFO (zkCallback-5873-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1848883 INFO (zkCallback-5880-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1848883 INFO (zkCallback-5865-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1848904 INFO (zkConnectionManagerCallback-5909-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1848923 INFO (zkCallback-5892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1848923 INFO (zkCallback-5900-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1848947 INFO (zkCallback-5886-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1848959 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 1848972 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42944/solr ready [junit4] 2> 1848984 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1849096 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44746.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1849101 INFO (zkConnectionManagerCallback-5915-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1849122 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 1849123 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42944/solr ready [junit4] 2> 1849123 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1849181 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41660.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1849234 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41660.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1849235 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41660.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1849252 INFO (jetty-launcher-5845-thread-2) [n:127.0.0.1:41660_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-001/node4/. [junit4] 2> 1849253 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44746.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1849253 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44746.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1849254 INFO (jetty-launcher-5845-thread-4) [n:127.0.0.1:44746_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-001/node3/. [junit4] 2> 1849483 INFO (ScheduledTrigger-3582-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 4 and last live nodes: 2 [junit4] 2> 1850150 INFO (zkConnectionManagerCallback-5921-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1850151 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 1850152 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42944/solr ready [junit4] 2> 1850217 INFO (qtp1004817445-14041) [n:127.0.0.1:41002_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1850218 INFO (qtp1004817445-14041) [n:127.0.0.1:41002_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1850252 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.u.p.TimeRoutedAliasUpdateProcessorTest SolrClient: org.apache.solr.client.solrj.impl.CloudSolrClient@764aff5c [junit4] 2> 1850252 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.u.p.TimeRoutedAliasUpdateProcessorTest ClusterStateProvider org.apache.solr.client.solrj.impl.HttpClusterStateProvider@132c6b91 [junit4] 2> 1850345 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1439456096 [junit4] 2> 1850345 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41002_solr [junit4] 2> 1850345 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=480354730 [junit4] 2> 1850345 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:39949_solr [junit4] 2> 1850349 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 1850349 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:41002_solr as DOWN [junit4] 2> 1850350 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 1850350 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:39949_solr as DOWN [junit4] 2> 1850365 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2083594947 [junit4] 2> 1850365 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41660_solr [junit4] 2> 1850377 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2138656556 [junit4] 2> 1850377 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:44746_solr [junit4] 2> 1850528 INFO (ScheduledTrigger-3582-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 4 and last live nodes: 4 [junit4] 2> 1850528 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1850572 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1850572 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6cde6a88: rootName = solr_39949, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@30a4f616 [junit4] 2> 1850575 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1850575 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3c3177db: rootName = solr_39949, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@108693d1 [junit4] 2> 1850579 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 1850579 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:41660_solr as DOWN [junit4] 2> 1850608 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 1850608 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:44746_solr as DOWN [junit4] 2> 1850631 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1850631 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4ac1946d: rootName = solr_39949, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@18431061 [junit4] 2> 1850632 INFO (jetty-closer-5846-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1850645 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1850645 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4df45a44: rootName = solr_41002, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@7546db70 [junit4] 2> 1850648 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1850648 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@79f795c3: rootName = solr_41002, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@108693d1 [junit4] 2> 1850663 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1850663 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4017fd7: rootName = solr_41002, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@18431061 [junit4] 2> 1850663 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1850787 INFO (closeThreadPool-5932-thread-2) [ ] o.a.s.c.Overseer Overseer (id=73773686320922634-127.0.0.1:41002_solr-n_0000000000) closing [junit4] 2> 1850806 INFO (OverseerStateUpdate-73773686320922634-127.0.0.1:41002_solr-n_0000000000) [n:127.0.0.1:41002_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:41002_solr [junit4] 2> 1850851 INFO (OverseerAutoScalingTriggerThread-73773686320922634-127.0.0.1:41002_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 1850860 INFO (zkCallback-5892-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 1850901 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1850901 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5b8a5d10: rootName = solr_41660, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@106d14b5 [junit4] 2> 1850916 INFO (jetty-closer-5846-thread-1) [ ] o.a.s.c.Overseer Overseer (id=73773686320922634-127.0.0.1:41002_solr-n_0000000000) closing [junit4] 2> 1850916 INFO (closeThreadPool-5932-thread-1) [ ] o.a.s.c.Overseer Overseer (id=73773686320922634-127.0.0.1:41002_solr-n_0000000000) closing [junit4] 2> 1850924 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1850924 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@64909f86: rootName = solr_44746, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@16ef7c24 [junit4] 2> 1850927 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1850928 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5a8cd88e: rootName = solr_44746, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@108693d1 [junit4] 2> 1850933 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 0x10618c6deee0008, likely client has closed socket [junit4] 2> 1850933 INFO (zkCallback-5892-thread-1) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:44746_solr [junit4] 2> 1850934 INFO (zkCallback-5892-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 1850936 INFO (zkCallback-5908-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2) [junit4] 2> 1850936 INFO (zkCallback-5900-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2) [junit4] 2> 1850937 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1850937 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d53e72d: rootName = solr_41660, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@108693d1 [junit4] 2> 1850939 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1850939 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6d0bcf40: rootName = solr_41660, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@18431061 [junit4] 2> 1850939 INFO (jetty-closer-5846-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1850940 INFO (zkCallback-5914-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2) [junit4] 2> 1850942 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1850960 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@782dab7e: rootName = solr_44746, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@18431061 [junit4] 2> 1850960 INFO (jetty-closer-5846-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1850944 INFO (zkCallback-5880-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2) [junit4] 2> 1851171 INFO (jetty-closer-5846-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@695d84e6{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1851260 INFO (jetty-closer-5846-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2e7b4b0c{/solr,null,UNAVAILABLE} [junit4] 2> 1851296 INFO (jetty-closer-5846-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@558b37bc{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1851296 INFO (jetty-closer-5846-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@47b72beb{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1851297 INFO (jetty-closer-5846-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4af803fd{/solr,null,UNAVAILABLE} [junit4] 2> 1851297 INFO (jetty-closer-5846-thread-4) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 1851300 INFO (jetty-closer-5846-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@30526c7{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1851317 INFO (jetty-closer-5846-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 1851317 INFO (jetty-closer-5846-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5820b591{/solr,null,UNAVAILABLE} [junit4] 2> 1851321 INFO (jetty-closer-5846-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7eba0fb1{/solr,null,UNAVAILABLE} [junit4] 2> 1851321 INFO (jetty-closer-5846-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 1851373 INFO (jetty-closer-5846-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 1851434 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer. [junit4] 2> 1851443 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 9 /solr/aliases.json [junit4] 2> 9 /solr/clusterprops.json [junit4] 2> 4 /solr/security.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 9 /solr/clusterstate.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 9 /solr/live_nodes [junit4] 2> 9 /solr/collections [junit4] 2> [junit4] 2> 1851443 ERROR (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] 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> 1851444 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:42944 [junit4] 2> 1851444 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 42944 [junit4] 2> 1851445 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testParse-seed#[B72E2FF953D47986]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testParse [junit4] 2> 1851479 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSliceRouting [junit4] 2> 1851480 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-002 [junit4] 2> 1851480 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1851481 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1851481 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1851499 ERROR (ZkTestServer Run Thread) [ ] 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> 1851588 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer start zk server on port:34404 [junit4] 2> 1851588 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34404 [junit4] 2> 1851588 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34404 [junit4] 2> 1851714 INFO (zkConnectionManagerCallback-5938-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1851736 INFO (zkConnectionManagerCallback-5940-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1851791 INFO (zkConnectionManagerCallback-5942-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1851807 WARN (jetty-launcher-5935-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1851808 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1851808 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1851808 INFO (jetty-launcher-5935-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1851827 WARN (jetty-launcher-5935-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1851828 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1851828 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1851828 INFO (jetty-launcher-5935-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1851844 WARN (jetty-launcher-5935-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1851844 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1851844 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1851844 INFO (jetty-launcher-5935-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1851860 WARN (jetty-launcher-5935-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1851860 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1851860 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1851860 INFO (jetty-launcher-5935-thread-4) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1851949 INFO (jetty-launcher-5935-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1851949 INFO (jetty-launcher-5935-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1851949 INFO (jetty-launcher-5935-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1851949 INFO (jetty-launcher-5935-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@13e2abb3{/solr,null,AVAILABLE} [junit4] 2> 1852038 INFO (jetty-launcher-5935-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1852038 INFO (jetty-launcher-5935-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1852038 INFO (jetty-launcher-5935-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1852038 INFO (jetty-launcher-5935-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@23055f7e{/solr,null,AVAILABLE} [junit4] 2> 1852058 INFO (jetty-launcher-5935-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1852058 INFO (jetty-launcher-5935-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1852058 INFO (jetty-launcher-5935-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1852080 INFO (jetty-launcher-5935-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1991e712{/solr,null,AVAILABLE} [junit4] 2> 1852127 INFO (jetty-launcher-5935-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1852127 INFO (jetty-launcher-5935-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1852127 INFO (jetty-launcher-5935-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1852147 INFO (jetty-launcher-5935-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@90cfeda{HTTP/1.1,[http/1.1]}{127.0.0.1:45939} [junit4] 2> 1852147 INFO (jetty-launcher-5935-thread-2) [ ] o.e.j.s.Server Started @1852182ms [junit4] 2> 1852148 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45939} [junit4] 2> 1852148 ERROR (jetty-launcher-5935-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1852148 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1852148 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.7.0 [junit4] 2> 1852148 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1852148 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1852148 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-03T14:41:35.888Z [junit4] 2> 1852163 INFO (jetty-launcher-5935-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1581dd5b{/solr,null,AVAILABLE} [junit4] 2> 1852171 INFO (jetty-launcher-5935-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1d9c35f9{HTTP/1.1,[http/1.1]}{127.0.0.1:45097} [junit4] 2> 1852172 INFO (jetty-launcher-5935-thread-3) [ ] o.e.j.s.Server Started @1852207ms [junit4] 2> 1852172 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45097} [junit4] 2> 1852172 ERROR (jetty-launcher-5935-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1852172 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1852172 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.7.0 [junit4] 2> 1852172 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1852172 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1852172 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-03T14:41:35.912Z [junit4] 2> 1852192 INFO (zkConnectionManagerCallback-5946-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1852208 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1852220 INFO (zkConnectionManagerCallback-5944-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1852362 INFO (jetty-launcher-5935-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1696343d{HTTP/1.1,[http/1.1]}{127.0.0.1:39571} [junit4] 2> 1852362 INFO (jetty-launcher-5935-thread-1) [ ] o.e.j.s.Server Started @1852397ms [junit4] 2> 1852362 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39571} [junit4] 2> 1852362 ERROR (jetty-launcher-5935-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1852362 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1852363 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.7.0 [junit4] 2> 1852363 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1852363 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1852363 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-03T14:41:36.103Z [junit4] 2> 1852398 INFO (jetty-launcher-5935-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@176dba11{HTTP/1.1,[http/1.1]}{127.0.0.1:33451} [junit4] 2> 1852398 INFO (jetty-launcher-5935-thread-4) [ ] o.e.j.s.Server Started @1852433ms [junit4] 2> 1852398 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33451} [junit4] 2> 1852399 ERROR (jetty-launcher-5935-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1852399 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1852399 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.7.0 [junit4] 2> 1852399 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1852399 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1852399 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-03T14:41:36.139Z [junit4] 2> 1852443 INFO (zkConnectionManagerCallback-5950-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1852443 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1852455 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1852463 INFO (zkConnectionManagerCallback-5948-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1852496 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1852572 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 0x10618c6f65f0004, likely client has closed socket [junit4] 2> 1853980 INFO (jetty-launcher-5935-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34404/solr [junit4] 2> 1854035 INFO (zkConnectionManagerCallback-5954-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1854138 INFO (jetty-launcher-5935-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34404/solr [junit4] 2> 1854197 INFO (zkConnectionManagerCallback-5956-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1854217 INFO (zkConnectionManagerCallback-5960-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1854238 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 0x10618c6f65f0009, likely client has closed socket [junit4] 2> 1854290 INFO (zkConnectionManagerCallback-5964-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1854575 INFO (jetty-launcher-5935-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34404/solr [junit4] 2> 1854635 INFO (zkConnectionManagerCallback-5970-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1854656 INFO (jetty-launcher-5935-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34404/solr [junit4] 2> 1854708 INFO (zkConnectionManagerCallback-5974-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1854777 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 0x10618c6f65f000c, likely client has closed socket [junit4] 2> 1854781 INFO (zkConnectionManagerCallback-5976-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1854837 INFO (zkConnectionManagerCallback-5978-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1854999 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39571_solr [junit4] 2> 1855032 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.c.Overseer Overseer (id=73773686714204173-127.0.0.1:39571_solr-n_0000000000) starting [junit4] 2> 1855086 INFO (jetty-launcher-5935-thread-4) [n:127.0.0.1:33451_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33451_solr [junit4] 2> 1855141 INFO (zkCallback-5977-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1855153 INFO (zkCallback-5975-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1855166 INFO (zkConnectionManagerCallback-5987-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1855179 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1855180 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34404/solr ready [junit4] 2> 1855192 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1855212 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:45939_solr as DOWN [junit4] 2> 1855213 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1855213 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45939_solr [junit4] 2> 1855263 INFO (zkCallback-5977-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1855263 INFO (zkCallback-5975-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1855271 INFO (OverseerStateUpdate-73773686714204173-127.0.0.1:39571_solr-n_0000000000) [n:127.0.0.1:39571_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:39571_solr [junit4] 2> 1855271 INFO (zkCallback-5955-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1855283 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:39571_solr as DOWN [junit4] 2> 1855285 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1855285 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39571_solr [junit4] 2> 1855286 INFO (zkCallback-5977-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 1855286 INFO (zkCallback-5975-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 1855307 INFO (zkCallback-5986-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3) [junit4] 2> 1855328 INFO (zkCallback-5955-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 1855453 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1855538 INFO (zkConnectionManagerCallback-5998-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1855540 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 1855540 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34404/solr ready [junit4] 2> 1855547 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1855555 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 1855575 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:45097_solr as DOWN [junit4] 2> 1855576 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1855576 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45097_solr [junit4] 2> 1855579 INFO (zkConnectionManagerCallback-5992-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1855754 INFO (zkCallback-5977-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1855766 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39571.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1855774 INFO (zkCallback-5975-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1855789 INFO (OverseerAutoScalingTriggerThread-73773686714204173-127.0.0.1:39571_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:45939_solr, 127.0.0.1:39571_solr, 127.0.0.1:33451_solr] [junit4] 2> 1855802 INFO (jetty-launcher-5935-thread-4) [n:127.0.0.1:33451_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 1855818 INFO (zkCallback-5963-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1855818 INFO (zkCallback-5955-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1855818 INFO (zkCallback-5997-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1855830 INFO (zkCallback-5986-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 1855839 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45939.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1855856 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39571.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1855856 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39571.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1855857 INFO (jetty-launcher-5935-thread-1) [n:127.0.0.1:39571_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-002/node1/. [junit4] 2> 1855891 INFO (jetty-launcher-5935-thread-4) [n:127.0.0.1:33451_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34404/solr ready [junit4] 2> 1855903 INFO (ScheduledTrigger-3628-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 4 and last live nodes: 3 [junit4] 2> 1855919 INFO (jetty-launcher-5935-thread-4) [n:127.0.0.1:33451_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1855948 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45939.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1855948 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45939.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1855949 INFO (jetty-launcher-5935-thread-2) [n:127.0.0.1:45939_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-002/node2/. [junit4] 2> 1856057 INFO (zkConnectionManagerCallback-6005-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1856132 INFO (jetty-launcher-5935-thread-4) [n:127.0.0.1:33451_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33451.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1856183 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 1856189 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34404/solr ready [junit4] 2> 1856208 INFO (jetty-launcher-5935-thread-4) [n:127.0.0.1:33451_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33451.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1856208 INFO (jetty-launcher-5935-thread-4) [n:127.0.0.1:33451_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33451.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1856209 INFO (jetty-launcher-5935-thread-4) [n:127.0.0.1:33451_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-002/node4/. [junit4] 2> 1856239 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1856365 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45097.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1856439 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45097.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1856439 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45097.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3bf6e9e4 [junit4] 2> 1856440 INFO (jetty-launcher-5935-thread-3) [n:127.0.0.1:45097_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_B72E2FF953D47986-001/tempDir-002/node3/. [junit4] 2> 1857097 INFO (ScheduledTrigger-3628-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 4 and last live nodes: 4 [junit4] 2> 1857167 INFO (zkConnectionManagerCallback-6011-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1857313 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 1857314 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34404/solr ready [junit4] 2> 1857358 INFO (qtp2072592236-14243) [n:127.0.0.1:45939_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1857374 INFO (qtp2072592236-14243) [n:127.0.0.1:45939_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=16 [junit4] 2> 1857390 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.u.p.TimeRoutedAliasUpdateProcessorTest SolrClient: org.apache.solr.client.solrj.impl.CloudSolrClient@b17d32c [junit4] 2> 1857390 INFO (TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[B72E2FF953D47986]) [ ] o.a.s.u.p.TimeRoutedAliasUpdateProcessorTest ClusterStateProvider org.apache.solr.client.solrj.impl.HttpClusterStateProvider@17b9a19d [junit4] 2> 1857449 INFO (qtp2072592236-14242) [n:127.0.0.1:45939_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1857450 INFO (qtp2072592236-14242) [n:127.0.0.1:45939_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1857450 INFO (qtp2072592236-14243) [n:127.0.0.1:45939_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1857469 INFO (qtp2072592236-14243) [n:127.0.0.1:45939_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=19 [junit4] 2> 1857470 INFO (qtp2072592236-14253) [n:127.0.0.1:45939_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1857470 INFO (qtp2072592236-14253) [n:127.0.0.1:45939_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1857471 INFO (qtp2072592236-14254) [n:127.0.0.1:45939_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1857484 INFO (qtp2072592236-14254) [n:127.0.0.1:45939_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=12 [junit4] 2> 1857485 INFO (qtp2072592236-14242) [n:127.0.0.1:45939_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=_default&name=testSliceRouting&action=CREATE&wt=javabin&version=2 [junit4] 2> 1857524 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"testSliceRouting", [junit4] 2> "baseConfigSet":"_default", [junit4] 2> "immutable":"false", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 1857541 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/testSliceRouting/protwords.txt [junit4] 2> 1857542 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/testSliceRouting/managed-schema [junit4] 2> 1857580 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/testSliceRouting/solrconfig.xml [junit4] 2> 1857614 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/testSliceRouting/synonyms.txt [junit4] 2> 1857615 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/testSliceRouting/stopwords.txt [junit4] 2> 1857615 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/testSliceRouting/params.json [junit4] 2> 1857617 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/testSliceRouting/lang/contractions_it.txt [junit4] 2> 1857630 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/testSliceRouting/lang/stopwords_no.txt [junit4] 2> 1857631 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/testSliceRouting/lang/stopwords_hy.txt [junit4] 2> 1857632 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/testSliceRouting/lang/stemdict_nl.txt [junit4] 2> 1857665 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/testSliceRouting/lang/contractions_ca.txt [junit4] 2> 1857667 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/testSliceRouting/lang/stopwords_id.txt [junit4] 2> 1857668 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/testSliceRouting/lang/stopwords_ga.txt [junit4] 2> 1857686 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/testSliceRouting/lang/stopwords_da.txt [junit4] 2> 1857687 INFO (OverseerThreadFactory-3631-thread-1-processing-n:127.0.0.1:39571_solr) [n:127.0.0.1:39571_solr ] o.a.s.c.c.ZkConfigManager Copying zk n [...truncated too long message...] ome/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/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 = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/null2126498383 [copy] Copying 241 files to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/null2126498383 [delete] Deleting directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-7.x/solr/null2126498383 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 71ms :: artifacts dl 2ms --------------------------------------------------------------------- | | 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: 206 minutes 59 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 lucene2 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