Build: https://jenkins.thetaphi.de/job/Lucene-Solr-BadApples-8.x-Linux/68/
Java: 64bit/jdk-12 -XX:-UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED:
org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation
Error Message:
took over 10 seconds after collection creation to update aliases
Stack Trace:
java.lang.AssertionError: took over 10 seconds after collection creation to
update aliases
at
__randomizedtesting.SeedInfo.seed([2AC45BA942732531:47AEDE027A11C805]:0)
at org.junit.Assert.fail(Assert.java:88)
at
org.apache.solr.update.processor.RoutedAliasUpdateProcessorTest.waitColAndAlias(RoutedAliasUpdateProcessorTest.java:77)
at
org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation(TimeRoutedAliasUpdateProcessorTest.java:326)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:567)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:835)
Build Log:
[...truncated 13905 lines...]
[junit4] Suite:
org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/init-core-data-001
[junit4] 2> 785363 WARN
(SUITE-TimeRoutedAliasUpdateProcessorTest-seed#[2AC45BA942732531]-worker) [
] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=35 numCloses=35
[junit4] 2> 785363 INFO
(SUITE-TimeRoutedAliasUpdateProcessorTest-seed#[2AC45BA942732531]-worker) [
] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 785364 INFO
(SUITE-TimeRoutedAliasUpdateProcessorTest-seed#[2AC45BA942732531]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 785364 INFO
(SUITE-TimeRoutedAliasUpdateProcessorTest-seed#[2AC45BA942732531]-worker) [
] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 785378 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testPreemptiveCreation
[junit4] 2> 785378 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001
[junit4] 2> 785378 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 785380 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 785380 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 785480 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.ZkTestServer start zk server on port:38571
[junit4] 2> 785480 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:38571
[junit4] 2> 785480 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 38571
[junit4] 2> 785482 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 785482 WARN (NIOWorkerThread-2) [ ] o.a.z.s.NIOServerCnxn
Exception causing close of session 0x0: ZooKeeperServer not running
[junit4] 2> 786785 INFO (zkConnectionManagerCallback-5421-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 786785 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 786786 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 786787 INFO (zkConnectionManagerCallback-5423-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 786787 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 786788 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 786789 INFO (zkConnectionManagerCallback-5425-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 786789 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 786891 WARN (jetty-launcher-5426-thread-1) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 786891 WARN (jetty-launcher-5426-thread-3) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 786891 WARN (jetty-launcher-5426-thread-4) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 786891 WARN (jetty-launcher-5426-thread-2) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 786891 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 786891 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 786891 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 786891 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 786891 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 786891 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 786891 INFO (jetty-launcher-5426-thread-4) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 12+33
[junit4] 2> 786891 INFO (jetty-launcher-5426-thread-1) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 12+33
[junit4] 2> 786892 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 786892 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 786892 INFO (jetty-launcher-5426-thread-2) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 12+33
[junit4] 2> 786892 INFO (jetty-launcher-5426-thread-3) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 12+33
[junit4] 2> 786893 INFO (jetty-launcher-5426-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 786893 INFO (jetty-launcher-5426-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 786893 INFO (jetty-launcher-5426-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 786893 INFO (jetty-launcher-5426-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 786893 INFO (jetty-launcher-5426-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 786893 INFO (jetty-launcher-5426-thread-3) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 786894 INFO (jetty-launcher-5426-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@691ae14d{/solr,null,AVAILABLE}
[junit4] 2> 786894 INFO (jetty-launcher-5426-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5a73f6b3{/solr,null,AVAILABLE}
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7534b79a{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:37605}
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-3) [ ]
o.e.j.s.Server Started @786930ms
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-4) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37605}
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@3c6a0baa{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:46727}
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-2) [ ]
o.e.j.s.Server Started @786930ms
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=46727}
[junit4] 2> 786897 ERROR (jetty-launcher-5426-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 786897 ERROR (jetty-launcher-5426-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.2.0
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.2.0
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-06-06T06:38:27.680599Z
[junit4] 2> 786897 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-06-06T06:38:27.680600Z
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@69f7e16{/solr,null,AVAILABLE}
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2c185b80{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:37023}
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.e.j.s.Server Started @786931ms
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37023}
[junit4] 2> 786898 ERROR (jetty-launcher-5426-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.2.0
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 786898 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-06-06T06:38:27.681909Z
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 786899 INFO (zkConnectionManagerCallback-5430-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@52d369e{/solr,null,AVAILABLE}
[junit4] 2> 786899 INFO (zkConnectionManagerCallback-5428-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@d8d0c0f{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:38829}
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-4) [ ]
o.e.j.s.Server Started @786932ms
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=38829}
[junit4] 2> 786899 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 786900 ERROR (jetty-launcher-5426-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 786900 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 786900 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.2.0
[junit4] 2> 786900 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 786900 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 786900 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-06-06T06:38:27.683152Z
[junit4] 2> 786900 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 786900 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 786901 INFO (zkConnectionManagerCallback-5432-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 786901 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 786903 INFO (zkConnectionManagerCallback-5434-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 786903 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 786903 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 786904 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 787036 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 787036 WARN (jetty-launcher-5426-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@4f8964d9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 787038 WARN (jetty-launcher-5426-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@64807a59[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 787039 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 787039 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38571/solr
[junit4] 2> 787039 WARN (jetty-launcher-5426-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@748527fd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 787039 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 787040 INFO (zkConnectionManagerCallback-5443-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787040 INFO (jetty-launcher-5426-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 787041 WARN (jetty-launcher-5426-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@46b6ad11[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 787042 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38571/solr
[junit4] 2> 787043 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 787043 INFO (zkConnectionManagerCallback-5448-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787044 INFO (jetty-launcher-5426-thread-3) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 787129 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 787130 WARN (jetty-launcher-5426-thread-4) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@2f9cbc9f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 787132 WARN (jetty-launcher-5426-thread-4) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@4246d2e8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 787133 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38571/solr
[junit4] 2> 787133 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 787134 INFO (zkConnectionManagerCallback-5455-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787134 INFO (jetty-launcher-5426-thread-4) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 787207 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 787208 INFO (zkConnectionManagerCallback-5457-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787208 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 787237 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37605_solr
[junit4] 2> 787238 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.Overseer Overseer
(id=72378618322812938-127.0.0.1:37605_solr-n_0000000000) starting
[junit4] 2> 787240 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 787240 INFO (zkConnectionManagerCallback-5464-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787240 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 787242 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:38571/solr ready
[junit4] 2> 787242 INFO
(OverseerStateUpdate-72378618322812938-127.0.0.1:37605_solr-n_0000000000)
[n:127.0.0.1:37605_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:37605_solr
[junit4] 2> 787242 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37605_solr
[junit4] 2> 787243 INFO (zkCallback-5463-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 787244 INFO (zkCallback-5456-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 787251 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 787265 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37605.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787270 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37605.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787270 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37605.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787271 INFO (jetty-launcher-5426-thread-3)
[n:127.0.0.1:37605_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/.
[junit4] 2> 787307 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 787308 INFO (zkConnectionManagerCallback-5467-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787308 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 787311 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 787313 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:46727_solr as DOWN
[junit4] 2> 787313 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 787313 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:46727_solr
[junit4] 2> 787313 INFO (zkCallback-5463-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 787313 INFO (zkCallback-5456-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 787314 INFO (zkCallback-5466-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 787316 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 787316 INFO (zkConnectionManagerCallback-5474-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787316 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 787318 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 787319 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:38571/solr ready
[junit4] 2> 787326 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 787336 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_46727.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787341 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_46727.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787341 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_46727.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787342 INFO (jetty-launcher-5426-thread-2)
[n:127.0.0.1:46727_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node2/.
[junit4] 2> 787462 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 787463 WARN (jetty-launcher-5426-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@4ced9869[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 787466 WARN (jetty-launcher-5426-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@2f5d43dc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 787467 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38571/solr
[junit4] 2> 787468 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 787468 INFO (zkConnectionManagerCallback-5482-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787468 INFO (jetty-launcher-5426-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 787508 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 787508 INFO (zkConnectionManagerCallback-5484-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787508 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 787513 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 787515 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:38829_solr as DOWN
[junit4] 2> 787515 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 787515 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:38829_solr
[junit4] 2> 787520 INFO (zkCallback-5456-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 787520 INFO (zkCallback-5483-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 787520 INFO (zkCallback-5466-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 787520 INFO (zkCallback-5463-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 787520 INFO (zkCallback-5473-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 787522 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 787528 INFO (zkConnectionManagerCallback-5491-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787528 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 787531 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 787532 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:38571/solr ready
[junit4] 2> 787548 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 787559 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38829.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787565 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38829.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787565 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38829.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787566 INFO (jetty-launcher-5426-thread-4)
[n:127.0.0.1:38829_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node4/.
[junit4] 2> 787609 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 787610 INFO (zkConnectionManagerCallback-5494-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787610 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 787615 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 787617 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:37023_solr as DOWN
[junit4] 2> 787618 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 787618 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37023_solr
[junit4] 2> 787618 INFO (zkCallback-5483-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 787619 INFO (zkCallback-5466-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 787619 INFO (zkCallback-5463-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 787619 INFO (zkCallback-5456-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 787620 INFO (zkCallback-5473-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 787625 INFO (zkCallback-5490-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 787626 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 787632 INFO (zkConnectionManagerCallback-5501-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787632 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 787633 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 787634 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:38571/solr ready
[junit4] 2> 787640 INFO (zkCallback-5493-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 787664 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 787678 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37023.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787687 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37023.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787687 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37023.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 787688 INFO (jetty-launcher-5426-thread-1)
[n:127.0.0.1:37023_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node1/.
[junit4] 2> 787736 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 787736 INFO (zkConnectionManagerCallback-5507-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787736 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 787740 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 787741 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:38571/solr ready
[junit4] 2> 787742 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.u.p.TimeRoutedAliasUpdateProcessorTest SolrClient:
org.apache.solr.client.solrj.impl.CloudSolrClient@228e4653
[junit4] 2> 787742 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.u.p.TimeRoutedAliasUpdateProcessorTest ClusterStateProvider
127.0.0.1:38571/solr
[junit4] 2> 787759 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 787759 INFO (zkConnectionManagerCallback-5512-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 787759 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 787760 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 787761 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testPreemptiveCreation-seed#[2AC45BA942732531])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:38571/solr ready
[junit4] 2> 787763 INFO (qtp524458623-13874) [n:127.0.0.1:46727_solr
] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params
baseConfigSet=_default&name=testPreemptiveCreation&action=CREATE&wt=javabin&version=2
[junit4] 2> 787768 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.OverseerConfigSetMessageHandler
OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"testPreemptiveCreation",
[junit4] 2> "baseConfigSet":"_default",
[junit4] 2> "immutable":"false",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 787769 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to /configs/testPreemptiveCreation/protwords.txt
[junit4] 2> 787770 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testPreemptiveCreation/managed-schema
[junit4] 2> 787770 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testPreemptiveCreation/solrconfig.xml
[junit4] 2> 787771 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to /configs/testPreemptiveCreation/synonyms.txt
[junit4] 2> 787773 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to /configs/testPreemptiveCreation/stopwords.txt
[junit4] 2> 787774 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_it.txt to
/configs/testPreemptiveCreation/lang/contractions_it.txt
[junit4] 2> 787775 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stemdict_nl.txt to
/configs/testPreemptiveCreation/lang/stemdict_nl.txt
[junit4] 2> 787777 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hy.txt to
/configs/testPreemptiveCreation/lang/stopwords_hy.txt
[junit4] 2> 787778 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_no.txt to
/configs/testPreemptiveCreation/lang/stopwords_no.txt
[junit4] 2> 787779 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ca.txt to
/configs/testPreemptiveCreation/lang/contractions_ca.txt
[junit4] 2> 787780 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_id.txt to
/configs/testPreemptiveCreation/lang/stopwords_id.txt
[junit4] 2> 787781 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ga.txt to
/configs/testPreemptiveCreation/lang/stopwords_ga.txt
[junit4] 2> 787782 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hi.txt to
/configs/testPreemptiveCreation/lang/stopwords_hi.txt
[junit4] 2> 787783 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_da.txt to
/configs/testPreemptiveCreation/lang/stopwords_da.txt
[junit4] 2> 787784 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ja.txt to
/configs/testPreemptiveCreation/lang/stopwords_ja.txt
[junit4] 2> 787785 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_pt.txt to
/configs/testPreemptiveCreation/lang/stopwords_pt.txt
[junit4] 2> 787786 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hu.txt to
/configs/testPreemptiveCreation/lang/stopwords_hu.txt
[junit4] 2> 787788 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_el.txt to
/configs/testPreemptiveCreation/lang/stopwords_el.txt
[junit4] 2> 787789 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ru.txt to
/configs/testPreemptiveCreation/lang/stopwords_ru.txt
[junit4] 2> 787790 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_tr.txt to
/configs/testPreemptiveCreation/lang/stopwords_tr.txt
[junit4] 2> 787793 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ar.txt to
/configs/testPreemptiveCreation/lang/stopwords_ar.txt
[junit4] 2> 787795 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/userdict_ja.txt to
/configs/testPreemptiveCreation/lang/userdict_ja.txt
[junit4] 2> 787796 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_eu.txt to
/configs/testPreemptiveCreation/lang/stopwords_eu.txt
[junit4] 2> 787797 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_it.txt to
/configs/testPreemptiveCreation/lang/stopwords_it.txt
[junit4] 2> 787798 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_cz.txt to
/configs/testPreemptiveCreation/lang/stopwords_cz.txt
[junit4] 2> 787799 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stoptags_ja.txt to
/configs/testPreemptiveCreation/lang/stoptags_ja.txt
[junit4] 2> 787800 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_fr.txt to
/configs/testPreemptiveCreation/lang/contractions_fr.txt
[junit4] 2> 787806 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_de.txt to
/configs/testPreemptiveCreation/lang/stopwords_de.txt
[junit4] 2> 787807 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fa.txt to
/configs/testPreemptiveCreation/lang/stopwords_fa.txt
[junit4] 2> 787808 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ga.txt to
/configs/testPreemptiveCreation/lang/contractions_ga.txt
[junit4] 2> 787809 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ca.txt to
/configs/testPreemptiveCreation/lang/stopwords_ca.txt
[junit4] 2> 787810 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_nl.txt to
/configs/testPreemptiveCreation/lang/stopwords_nl.txt
[junit4] 2> 787812 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_bg.txt to
/configs/testPreemptiveCreation/lang/stopwords_bg.txt
[junit4] 2> 787814 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_lv.txt to
/configs/testPreemptiveCreation/lang/stopwords_lv.txt
[junit4] 2> 787815 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_en.txt to
/configs/testPreemptiveCreation/lang/stopwords_en.txt
[junit4] 2> 787816 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_es.txt to
/configs/testPreemptiveCreation/lang/stopwords_es.txt
[junit4] 2> 787817 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_th.txt to
/configs/testPreemptiveCreation/lang/stopwords_th.txt
[junit4] 2> 787817 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ro.txt to
/configs/testPreemptiveCreation/lang/stopwords_ro.txt
[junit4] 2> 787818 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fr.txt to
/configs/testPreemptiveCreation/lang/stopwords_fr.txt
[junit4] 2> 787819 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_sv.txt to
/configs/testPreemptiveCreation/lang/stopwords_sv.txt
[junit4] 2> 787820 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fi.txt to
/configs/testPreemptiveCreation/lang/stopwords_fi.txt
[junit4] 2> 787821 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/hyphenations_ga.txt to
/configs/testPreemptiveCreation/lang/hyphenations_ga.txt
[junit4] 2> 787822 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_gl.txt to
/configs/testPreemptiveCreation/lang/stopwords_gl.txt
[junit4] 2> 787824 INFO
(OverseerThreadFactory-4117-thread-1-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/params.json to /configs/testPreemptiveCreation/params.json
[junit4] 2> 787826 INFO (qtp524458623-13874) [n:127.0.0.1:46727_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/configs
params={baseConfigSet=_default&name=testPreemptiveCreation&action=CREATE&wt=javabin&version=2}
status=0 QTime=63
[junit4] 2> 787827 INFO (qtp524458623-13878) [n:127.0.0.1:46727_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=testPreemptiveCreation&name=testPreemptiveCreation&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 787830 INFO
(OverseerCollectionConfigSetProcessor-72378618322812938-127.0.0.1:37605_solr-n_0000000000)
[n:127.0.0.1:37605_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 787830 INFO
(OverseerThreadFactory-4117-thread-2-processing-n:127.0.0.1:37605_solr)
[n:127.0.0.1:37605_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testPreemptiveCreation
[junit4] 2> 787944 INFO
(OverseerStateUpdate-72378618322812938-127.0.0.1:37605_solr-n_0000000000)
[n:127.0.0.1:37605_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testPreemptiveCreation",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testPreemptiveCreation_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37605/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 788153 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=testPreemptiveCreation&newCollection=true&name=testPreemptiveCreation_shard1_replica_n1&action=CREATE&numShards=1&collection=testPreemptiveCreation&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 788154 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 789194 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.RequestParams conf
resource params.json loaded . version : 0
[junit4] 2> 789194 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.RequestParams request
params refreshed to version 0
[junit4] 2> 789195 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/extraction/lib
filtered by .*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 789195 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-cell-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789195 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/clustering/lib
filtered by .*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 789195 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-clustering-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789195 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/langid/lib
filtered by .*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 789195 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-langid-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789195 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/velocity/lib
filtered by .*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 789196 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-velocity-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789196 WARN (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add
files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-ltr-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789196 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.2.0
[junit4] 2> 789247 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.s.IndexSchema
[testPreemptiveCreation_shard1_replica_n1] Schema name=default-config
[junit4] 2> 789400 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema
default-config/1.6 with uniqueid field id
[junit4] 2> 789425 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating
SolrCore 'testPreemptiveCreation_shard1_replica_n1' using configuration from
collection testPreemptiveCreation, trusted=true
[junit4] 2> 789426 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_37605.solr.core.testPreemptiveCreation.shard1.replica_n1'
(registry 'solr.core.testPreemptiveCreation.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@691939c9
[junit4] 2> 789426 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrCore
[[testPreemptiveCreation_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/./testPreemptiveCreation_shard1_replica_n1/data/]
[junit4] 2> 789429 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.r.XSLTResponseWriter
xsltCacheLifetimeSeconds=5
[junit4] 2> 789498 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 789498 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 789500 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 789500 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 789501 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening
[Searcher@68fb9bd5[testPreemptiveCreation_shard1_replica_n1] main]
[junit4] 2> 789502 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/testPreemptiveCreation
[junit4] 2> 789502 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/testPreemptiveCreation
[junit4] 2> 789502 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader
Creating ZooKeeper watch for the managed schema at
/configs/testPreemptiveCreation/managed-schema
[junit4] 2> 789503 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader
Current schema version 0 is already the latest
[junit4] 2> 789503 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 789503 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker
init:
{name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 789504 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 789504 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find
max version in index or recent updates, using new clock 1635572106172301312
[junit4] 2> 789506 INFO
(searcherExecutor-4139-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to
Searcher@68fb9bd5[testPreemptiveCreation_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 789506 INFO
(searcherExecutor-4139-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 789506 INFO
(searcherExecutor-4139-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 789507 INFO
(searcherExecutor-4139-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SolrCore
[testPreemptiveCreation_shard1_replica_n1] Registered new searcher
Searcher@68fb9bd5[testPreemptiveCreation_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 789509 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testPreemptiveCreation/terms/shard1 to
Terms{values={core_node2=0}, version=0}
[junit4] 2> 789509 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/testPreemptiveCreation/leaders/shard1
[junit4] 2> 789511 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 789511 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
I may be the new leader - try and sync
[junit4] 2> 789511 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas
to http://127.0.0.1:37605/solr/testPreemptiveCreation_shard1_replica_n1/
[junit4] 2> 789511 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success
- now sync replicas to me
[junit4] 2> 789511 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.SyncStrategy
http://127.0.0.1:37605/solr/testPreemptiveCreation_shard1_replica_n1/ has no
replicas
[junit4] 2> 789511 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/testPreemptiveCreation/leaders/shard1/leader after winning as
/collections/testPreemptiveCreation/leader_elect/shard1/election/72378618322812938-core_node2-n_0000000000
[junit4] 2> 789512 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
I am the new leader:
http://127.0.0.1:37605/solr/testPreemptiveCreation_shard1_replica_n1/ shard1
[junit4] 2> 789613 INFO (zkCallback-5456-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testPreemptiveCreation/state.json] for collection
[testPreemptiveCreation] has occurred - updating... (live nodes size: [4])
[junit4] 2> 789613 INFO (zkCallback-5456-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testPreemptiveCreation/state.json] for collection
[testPreemptiveCreation] has occurred - updating... (live nodes size: [4])
[junit4] 2> 789614 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.ZkController I am the
leader, no recovery necessary
[junit4] 2> 789681 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin]
webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=testPreemptiveCreation&newCollection=true&name=testPreemptiveCreation_shard1_replica_n1&action=CREATE&numShards=1&collection=testPreemptiveCreation&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1527
[junit4] 2> 789683 INFO (qtp524458623-13878) [n:127.0.0.1:46727_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
45 seconds. Check all shard replicas
[junit4] 2> 789716 INFO (zkCallback-5466-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testPreemptiveCreation/state.json] for collection
[testPreemptiveCreation] has occurred - updating... (live nodes size: [4])
[junit4] 2> 789716 INFO (zkCallback-5456-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testPreemptiveCreation/state.json] for collection
[testPreemptiveCreation] has occurred - updating... (live nodes size: [4])
[junit4] 2> 789716 INFO (zkCallback-5456-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testPreemptiveCreation/state.json] for collection
[testPreemptiveCreation] has occurred - updating... (live nodes size: [4])
[junit4] 2> 789716 INFO (zkCallback-5456-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testPreemptiveCreation/state.json] for collection
[testPreemptiveCreation] has occurred - updating... (live nodes size: [4])
[junit4] 2> 789717 INFO (qtp524458623-13878) [n:127.0.0.1:46727_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=testPreemptiveCreation&name=testPreemptiveCreation&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=1890
[junit4] 2> 789728 INFO (qtp2003357983-13871) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Executed
config commands successfully and persisted to ZK
[{"set-user-property":{"update.autoCreateFields":false}},
{"add-updateprocessor":{
[junit4] 2> "name":"tolerant",
[junit4] 2> "class":"solr.TolerantUpdateProcessorFactory"}},
{"add-updateprocessor":{
[junit4] 2> "name":"tracking-testSliceRouting",
[junit4] 2> "class":"solr.TrackingUpdateProcessorFactory",
[junit4] 2> "group":"testPreemptiveCreation"}},
{"add-updateprocessor":{
[junit4] 2> "name":"inc",
[junit4] 2>
"class":"org.apache.solr.update.processor.RoutedAliasUpdateProcessorTest$IncrementURPFactory",
[junit4] 2> "fieldName":"integer_i"}}]
[junit4] 2> 789729 INFO (qtp2003357983-13871) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Waiting
up to 30 secs for 1 replicas to set the property overlay to be of version 0 for
collection testPreemptiveCreation
[junit4] 2> 789732 INFO (Thread-2182) [ ] o.a.s.c.SolrCore config
update listener called for core testPreemptiveCreation_shard1_replica_n1
[junit4] 2> 789733 INFO (Thread-2182) [ ] o.a.s.c.SolrCore core
reload testPreemptiveCreation_shard1_replica_n1
[junit4] 2> 789740 INFO (Thread-2182) [ ] o.a.s.c.RequestParams conf
resource params.json loaded . version : 0
[junit4] 2> 789740 INFO (Thread-2182) [ ] o.a.s.c.RequestParams
request params refreshed to version 0
[junit4] 2> 789740 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/extraction/lib
filtered by .*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 789740 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-cell-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789740 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/clustering/lib
filtered by .*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 789740 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-clustering-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789740 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/langid/lib
filtered by .*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 789740 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-langid-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789741 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/velocity/lib
filtered by .*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 789741 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-velocity-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789741 WARN (Thread-2182) [ ] o.a.s.c.SolrConfig Couldn't
add files from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
filtered by solr-ltr-\d.*\.jar to classpath:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001/tempDir-001/node3/testPreemptiveCreation_shard1_replica_n1/../../../../dist
[junit4] 2> 789741 INFO (Thread-2182) [ ] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 8.2.0
[junit4] 2> 789749 INFO
(solrHandlerExecutor-4144-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 789766 INFO (Thread-2182) [ ] o.a.s.s.IndexSchema
[testPreemptiveCreation_shard1_replica_n1] Schema name=default-config
[junit4] 2> 789838 INFO
(OverseerCollectionConfigSetProcessor-72378618322812938-127.0.0.1:37605_solr-n_0000000000)
[n:127.0.0.1:37605_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 789851 INFO (qtp2003357983-13877) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler
expecting overlay version 0 but my version is -1
[junit4] 2> 789851 INFO (qtp2003357983-13877) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.S.Request
[testPreemptiveCreation_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 789851 INFO (SolrConfigHandler-refreshconf) [ ]
o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 789852 INFO
(solrHandlerExecutor-4144-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from
http://127.0.0.1:37605/solr/testPreemptiveCreation_shard1_replica_n1/ for prop
overlay after 1 attempts
[junit4] 2> 789852 INFO
(solrHandlerExecutor-4144-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 789967 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler
expecting overlay version 0 but my version is -1
[junit4] 2> 789971 INFO (qtp2003357983-13875) [n:127.0.0.1:37605_solr
c:testPreemptiveCreation s:shard1 r:core_node2
x:testPreemptiveCreation_shard1_replica_n1 ] o.a.s.c.S.Request
[testPreemptiveCreation_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=4
[junit4] 2> 789971 INFO
(solrHandlerExecutor-4144-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from
http://127.0.0.1:37605/solr/testPreemptiveCreation_shard1_replica_n1/ for prop
overlay after 2 attempts
[junit4] 2> 789971 INFO (SolrConfigHandler-refreshconf) [ ]
o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 789971 INFO
(solrHandlerExecutor-4144-thread-1-processing-n:127.0.0.1:37605_solr
x:testPreemptiveCreation_shard1_replica_n1 c:testPreemptiveCreation s:shard1
r:core_node2) [n:127.0.0.1:37605_solr c:testPreemptiveCreation s:shard1
r:core_node2 x:testPreemptiveCreation_shard1_replica_n1 ]
o.a.s.h.SolrConfigHandler
[...truncated too long message...]
2)
[junit4] 2> 1011392 INFO (closeThreadPool-5902-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=72378632471445515-127.0.0.1:34319_solr-n_0000000000) closing
[junit4] 2> 1011392 INFO
(OverseerAutoScalingTriggerThread-72378632471445515-127.0.0.1:34319_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 1011422 INFO (zkCallback-5856-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/myalias_2017-10-25/state.json] for collection
[myalias_2017-10-25] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1011480 INFO
(OverseerStateUpdate-72378632471445515-127.0.0.1:34319_solr-n_0000000000)
[n:127.0.0.1:34319_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:34319_solr
[junit4] 2> 1011481 INFO (zkCallback-5826-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1011481 INFO (closeThreadPool-5902-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72378632471445515-127.0.0.1:34319_solr-n_0000000000) closing
[junit4] 2> 1011482 INFO (jetty-closer-5886-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@1cf3e81d{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:0}
[junit4] 2> 1011482 INFO (jetty-closer-5886-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4fda81ca{/solr,null,UNAVAILABLE}
[junit4] 2> 1011482 INFO (jetty-closer-5886-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1011681 INFO (jetty-closer-5886-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@791eddcc{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:0}
[junit4] 2> 1011682 INFO (jetty-closer-5886-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5fe02cfe{/solr,null,UNAVAILABLE}
[junit4] 2> 1011682 INFO (jetty-closer-5886-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1011781 INFO (jetty-closer-5886-thread-4) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@7078e1b0{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:0}
[junit4] 2> 1011782 INFO (jetty-closer-5886-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3205a7d1{/solr,null,UNAVAILABLE}
[junit4] 2> 1011782 INFO (jetty-closer-5886-thread-4) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1011881 INFO (jetty-closer-5886-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72378632471445515-127.0.0.1:34319_solr-n_0000000000) closing
[junit4] 2> 1011882 INFO (jetty-closer-5886-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@13b4135{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:0}
[junit4] 2> 1011883 INFO (jetty-closer-5886-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2a76162b{/solr,null,UNAVAILABLE}
[junit4] 2> 1011883 INFO (jetty-closer-5886-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1011883 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[2AC45BA942732531])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1012085 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> 10 /solr/clusterprops.json
[junit4] 2> 10 /solr/aliases.json
[junit4] 2> 6 /solr/configs/testSliceRouting
[junit4] 2> 5 /solr/collections/testSliceRouting/state.json
[junit4] 2> 5 /solr/configs/testSliceRouting/managed-schema
[junit4] 2> 4 /solr/security.json
[junit4] 2> 3
/solr/collections/myalias_2017-10-24/terms/shard1
[junit4] 2> 3
/solr/collections/myalias_2017-10-23/terms/shard1
[junit4] 2> 3
/solr/collections/myalias_2017-10-25/terms/shard1
[junit4] 2> 2 /solr/collections/testSliceRouting/terms/shard1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 27 /solr/aliases.json
[junit4] 2> 14 /solr/collections/myalias_2017-10-25/state.json
[junit4] 2> 13 /solr/collections/testSliceRouting/state.json
[junit4] 2> 12 /solr/collections/myalias_2017-10-24/state.json
[junit4] 2> 10 /solr/clusterstate.json
[junit4] 2> 10 /solr/collections/myalias_2017-10-23/state.json
[junit4] 2> 2
/solr/overseer_elect/election/72378632471445517-127.0.0.1:42101_solr-n_0000000001
[junit4] 2> 2
/solr/overseer_elect/election/72378632471445515-127.0.0.1:34319_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 55 /solr/collections
[junit4] 2> 50 /solr/overseer/queue
[junit4] 2> 38 /solr/live_nodes
[junit4] 2> 23 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1012087 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[2AC45BA942732531])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44837
[junit4] 2> 1012087 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[2AC45BA942732531])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 44837
[junit4] 2> 1012087 INFO
(TEST-TimeRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[2AC45BA942732531])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testSliceRouting
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.TimeRoutedAliasUpdateProcessorTest_2AC45BA942732531-001
[junit4] 2> Jun 06, 2019 6:42:13 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene80): {},
docValues:{}, maxPointsInLeafNode=70, maxMBSortInHeap=7.4802272683106885,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@69a84899),
locale=bs-Latn-BA, timezone=America/Coral_Harbour
[junit4] 2> NOTE: Linux 4.18.0-17-generic amd64/Oracle Corporation 12
(64-bit)/cpus=8,threads=1,free=58321608,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestSolr4Spatial,
CollectionsAPIDistributedZkTest, ExplicitHLLTest, TestRandomFaceting,
SliceStateTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestLockTree,
TestLMJelinekMercerSimilarityFactory, TestManagedStopFilterFactory,
AtomicUpdateProcessorFactoryTest, SolrInfoBeanTest,
DistribJoinFromCollectionTest, TestValueSourceCache,
HdfsUnloadDistributedZkTest, TestFreeTextSuggestions,
MetricsHistoryHandlerTest, TestInPlaceUpdateWithRouteField,
TestHighlightDedupGrouping, WrapperMergePolicyFactoryTest,
SystemCollectionCompatTest, TestRealTimeGet, TestMaxScoreQueryParser,
TestSolrCloudWithDelegationTokens, ConjunctionSolrSpellCheckerTest,
JWTAuthPluginTest, TestDistributedStatsComponentCardinality,
SystemLogListenerTest, TestSchemaVersionResource, HttpTriggerListenerTest,
TestNumericTerms32, ManagedSchemaRoundRobinCloudTest, TestRequestForwarding,
TestLuceneMatchVersion, CacheHeaderTest, SearchHandlerTest,
ShardsWhitelistTest, TestPayloadCheckQParserPlugin, DataDrivenBlockJoinTest,
TestTlogReplica, SystemInfoHandlerTest, FullSolrCloudDistribCmdsTest,
TestSimClusterStateProvider, NodeLostTriggerIntegrationTest,
TestCSVResponseWriter, DocValuesNotIndexedTest, AutoscalingHistoryHandlerTest,
RestoreTriggerStateTest, TestInPlaceUpdatesStandalone, SchemaApiFailureTest,
TestNestedDocsSort, NoCacheHeaderTest, LeaderFailureAfterFreshStartTest,
HDFSCollectionsAPITest, TestFiltering, TlogReplayBufferedWhileIndexingTest,
BinaryUpdateRequestHandlerTest, TestStressRecovery,
HdfsCollectionsAPIDistributedZkTest, TestConfigsApi,
ProtectedTermFilterFactoryTest, CdcrBootstrapTest, XmlInterpolationTest,
TestImpersonationWithHadoopAuth, IndexBasedSpellCheckerTest, ClusterStateTest,
TestReload, TestConfigSetProperties, BigEndianAscendingWordDeserializerTest,
UUIDUpdateProcessorFallbackTest, TestSnapshotCloudManager,
SpatialRPTFieldTypeTest, ConfigSetsAPITest, SOLR749Test,
DistributedQueryElevationComponentTest, BJQParserTest, TestRandomFlRTGCloud,
PeerSyncWithIndexFingerprintCachingTest, TestSafeXMLParsing,
TestChildDocTransformerHierarchy, TestRuleBasedAuthorizationPlugin,
ChangedSchemaMergeTest, SolrJmxReporterCloudTest, TestUnifiedSolrHighlighter,
TestDocTermOrds, TimeRoutedAliasUpdateProcessorTest]
[junit4] Completed [269/861 (1!)] on J1 in 227.63s, 4 tests, 1 failure <<<
FAILURES!
[...truncated 46599 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-BadApples-8.x-Linux/68/consoleText
[repro] Revision: 43a7ec87a2c4dbaaa521ec219d2a267ee823d9b8
[repro] Repro line: ant test -Dtestcase=TimeRoutedAliasUpdateProcessorTest
-Dtests.method=testPreemptiveCreation -Dtests.seed=2AC45BA942732531
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true
-Dtests.locale=bs-Latn-BA -Dtests.timezone=America/Coral_Harbour
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] TimeRoutedAliasUpdateProcessorTest
[repro] ant compile-test
[...truncated 3583 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.TimeRoutedAliasUpdateProcessorTest" -Dtests.showOutput=onerror
-Dtests.seed=2AC45BA942732531 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.badapples=true -Dtests.locale=bs-Latn-BA
-Dtests.timezone=America/Coral_Harbour -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[...truncated 99 lines...]
[repro] Failures:
[repro] 0/5 failed:
org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest
[repro] Exiting with code 0
[...truncated 43 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
